builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0043 starttime: 1448355987.08 results: success (0) buildid: 20151124000634 builduid: 5a06975fc23548e095ca48c4c67bada6 revision: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.091514) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.092107) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.092417) ========= 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.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005637 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.168908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.169239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.319234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.319482) ========= 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.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005546 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.375370) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.375665) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.379025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.379326) ========= 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.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False --2015-11-24 01:06:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.13M=0.001s 2015-11-24 01:06:27 (8.13 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.233982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.626903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.627203) ========= 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.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027034 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:27.675632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 01:06:27.675959) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False 2015-11-24 01:06:27,759 truncating revision to first 12 chars 2015-11-24 01:06:27,759 Setting DEBUG logging. 2015-11-24 01:06:27,759 attempt 1/10 2015-11-24 01:06:27,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9a99168d92d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 01:06:28,783 unpacking tar archive at: fx-team-b9a99168d92d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 01:06:28.957787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:28.958095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:28.971471) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:28.971753) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 01:06:28.972146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2015-11-24 01:06:28.972424) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False 01:06:29 INFO - MultiFileLogger online at 20151124 01:06:29 in /builds/slave/test 01:06:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:06:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:06:29 INFO - {'append_to_log': False, 01:06:29 INFO - 'base_work_dir': '/builds/slave/test', 01:06:29 INFO - 'blob_upload_branch': 'Fx-Team', 01:06:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:06:29 INFO - 'branch': 'Fx-Team', 01:06:29 INFO - 'buildbot_json_path': 'buildprops.json', 01:06:29 INFO - 'config_files': ('talos/mac_config.py',), 01:06:29 INFO - 'default_actions': ('clobber', 01:06:29 INFO - 'read-buildbot-config', 01:06:29 INFO - 'download-and-extract', 01:06:29 INFO - 'populate-webroot', 01:06:29 INFO - 'create-virtualenv', 01:06:29 INFO - 'install', 01:06:29 INFO - 'run-tests'), 01:06:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:06:29 INFO - 'download_minidump_stackwalk': True, 01:06:29 INFO - 'download_symbols': 'ondemand', 01:06:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:06:29 INFO - 'tooltool.py': '/tools/tooltool.py', 01:06:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:06:29 INFO - '/tools/misc-python/virtualenv.py')}, 01:06:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:06:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:06:29 INFO - 'installer_path': 'installer.exe', 01:06:29 INFO - 'log_level': 'info', 01:06:29 INFO - 'log_name': 'talos', 01:06:29 INFO - 'log_to_console': True, 01:06:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:06:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:06:29 INFO - 'opt_config_files': (), 01:06:29 INFO - 'pip_index': False, 01:06:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:06:29 INFO - 'cmd': ('bash', 01:06:29 INFO - '-c', 01:06:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:06:29 INFO - 'enabled': True, 01:06:29 INFO - 'halt_on_failure': False, 01:06:29 INFO - 'name': 'check_screen_resolution'},), 01:06:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:06:29 INFO - 'cmd': ('bash', 01:06:29 INFO - '-c', 01:06:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:06:29 INFO - 'enabled': True, 01:06:29 INFO - 'halt_on_failure': False, 01:06:29 INFO - 'name': 'check_screen_resolution'},), 01:06:29 INFO - 'run_cmd_checks_enabled': True, 01:06:29 INFO - 'sps_profile': False, 01:06:29 INFO - 'sps_profile_interval': 0, 01:06:29 INFO - 'suite': 'dromaeojs', 01:06:29 INFO - 'system_bits': '64', 01:06:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:06:29 INFO - 'title': 't-yosemite-r7-0043', 01:06:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:06:29 INFO - 'use_talos_json': True, 01:06:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:06:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:06:29 INFO - 'work_dir': 'build'} 01:06:29 INFO - ##### 01:06:29 INFO - ##### Running clobber step. 01:06:29 INFO - ##### 01:06:29 INFO - Running pre-action listener: _resource_record_pre_action 01:06:29 INFO - Running main action method: clobber 01:06:29 INFO - rmtree: /builds/slave/test/build 01:06:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:06:30 INFO - Running post-action listener: _resource_record_post_action 01:06:30 INFO - ##### 01:06:30 INFO - ##### Running read-buildbot-config step. 01:06:30 INFO - ##### 01:06:30 INFO - Running pre-action listener: _resource_record_pre_action 01:06:30 INFO - Running main action method: read_buildbot_config 01:06:30 INFO - Using buildbot properties: 01:06:30 INFO - { 01:06:30 INFO - "properties": { 01:06:30 INFO - "buildnumber": 24, 01:06:30 INFO - "product": "firefox", 01:06:30 INFO - "script_repo_revision": "production", 01:06:30 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:06:30 INFO - "repository": "", 01:06:30 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:06:30 INFO - "buildid": "20151124000634", 01:06:30 INFO - "slavename": "t-yosemite-r7-0043", 01:06:30 INFO - "pgo_build": "False", 01:06:30 INFO - "basedir": "/builds/slave/test", 01:06:30 INFO - "project": "", 01:06:30 INFO - "platform": "yosemite_r7", 01:06:30 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:06:30 INFO - "slavebuilddir": "test", 01:06:30 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:06:30 INFO - "branch": "fx-team", 01:06:30 INFO - "repo_path": "integration/fx-team", 01:06:30 INFO - "stage_platform": "macosx64", 01:06:30 INFO - "builduid": "5a06975fc23548e095ca48c4c67bada6", 01:06:30 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 01:06:30 INFO - }, 01:06:30 INFO - "sourcestamp": { 01:06:30 INFO - "repository": "", 01:06:30 INFO - "hasPatch": false, 01:06:30 INFO - "project": "", 01:06:30 INFO - "branch": "fx-team-macosx64-talos", 01:06:30 INFO - "changes": [ 01:06:30 INFO - { 01:06:30 INFO - "category": null, 01:06:30 INFO - "files": [ 01:06:30 INFO - { 01:06:30 INFO - "url": null, 01:06:30 INFO - "name": "https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 01:06:30 INFO - } 01:06:30 INFO - ], 01:06:30 INFO - "repository": "", 01:06:30 INFO - "rev": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55", 01:06:30 INFO - "who": "cbook@mozilla.com", 01:06:30 INFO - "when": 1448355910, 01:06:30 INFO - "number": 6699409, 01:06:30 INFO - "comments": "Bug 1216791 - Change the tooltip of the Hello icon in the toolbar. r=mikedeboer", 01:06:30 INFO - "project": "", 01:06:30 INFO - "at": "Tue 24 Nov 2015 01:05:10", 01:06:30 INFO - "branch": "fx-team-macosx64-talos", 01:06:30 INFO - "revlink": "", 01:06:30 INFO - "properties": [ 01:06:30 INFO - [ 01:06:30 INFO - "buildid", 01:06:30 INFO - "20151124000634", 01:06:30 INFO - "Change" 01:06:30 INFO - ], 01:06:30 INFO - [ 01:06:30 INFO - "builduid", 01:06:30 INFO - "5a06975fc23548e095ca48c4c67bada6", 01:06:30 INFO - "Change" 01:06:30 INFO - ], 01:06:30 INFO - [ 01:06:30 INFO - "pgo_build", 01:06:30 INFO - "False", 01:06:30 INFO - "Change" 01:06:30 INFO - ] 01:06:30 INFO - ], 01:06:30 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 01:06:30 INFO - } 01:06:30 INFO - ], 01:06:30 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 01:06:30 INFO - } 01:06:30 INFO - } 01:06:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 01:06:30 INFO - Running post-action listener: _resource_record_post_action 01:06:30 INFO - ##### 01:06:30 INFO - ##### Running download-and-extract step. 01:06:30 INFO - ##### 01:06:30 INFO - Running pre-action listener: _resource_record_pre_action 01:06:30 INFO - Running main action method: download_and_extract 01:06:30 INFO - mkdir: /builds/slave/test/build/tests 01:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:30 INFO - https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/test_packages.json 01:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/test_packages.json 01:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:06:45 INFO - Downloaded 1149 bytes. 01:06:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:06:45 INFO - Using the following test package requirements: 01:06:45 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:06:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:06:45 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 01:06:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:06:45 INFO - u'jsshell-mac.zip'], 01:06:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:06:45 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 01:06:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:06:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:06:45 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 01:06:45 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:06:45 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 01:06:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:06:45 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 01:06:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:06:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:06:45 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 01:06:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:45 INFO - https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:06:54 INFO - Downloaded 17526955 bytes. 01:06: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 01:06:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:06:57 INFO - Return code: 0 01:06:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:57 INFO - https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:06:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:06:58 INFO - Downloaded 17526955 bytes. 01:06:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 01:06:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:06:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:07:02 INFO - Return code: 0 01:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:02 INFO - https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:07:02 INFO - Downloaded 11130997 bytes. 01:07:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 01:07:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:07:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 01:07:03 INFO - Return code: 0 01:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:03 INFO - https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 01:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 01:07:06 INFO - Downloaded 109912332 bytes. 01:07:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:07:06 INFO - mkdir: /builds/slave/test/properties 01:07:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:07:06 INFO - Writing to file /builds/slave/test/properties/build_url 01:07:06 INFO - Contents: 01:07:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:07:06 INFO - Running post-action listener: _resource_record_post_action 01:07:06 INFO - Running post-action listener: set_extra_try_arguments 01:07:06 INFO - ##### 01:07:06 INFO - ##### Running populate-webroot step. 01:07:06 INFO - ##### 01:07:06 INFO - Running pre-action listener: _resource_record_pre_action 01:07:06 INFO - Running main action method: populate_webroot 01:07:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:07:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:07:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:07:06 INFO - '../fennec_ids.txt'], 01:07:06 INFO - 'tests': ['tcheck2']}, 01:07:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:07:06 INFO - '--tppagecycles', 01:07:06 INFO - '7'], 01:07:06 INFO - 'tests': ['tsvgm']}}, 01:07:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:07:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:07:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:07:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:07:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'tests': ['damp', 'tps']}, 01:07:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['damp', 'tps']}, 01:07:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:07:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:07:06 INFO - 'other': {'tests': ['a11yr', 01:07:06 INFO - 'ts_paint', 01:07:06 INFO - 'tpaint', 01:07:06 INFO - 'sessionrestore', 01:07:06 INFO - 'sessionrestore_no_auto_restore']}, 01:07:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['a11yr', 01:07:06 INFO - 'ts_paint', 01:07:06 INFO - 'tpaint', 01:07:06 INFO - 'sessionrestore', 01:07:06 INFO - 'sessionrestore_no_auto_restore']}, 01:07:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['a11yr', 01:07:06 INFO - 'ts_paint', 01:07:06 INFO - 'tpaint', 01:07:06 INFO - 'sessionrestore', 01:07:06 INFO - 'sessionrestore_no_auto_restore']}, 01:07:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['a11yr', 01:07:06 INFO - 'ts_paint', 01:07:06 INFO - 'tpaint', 01:07:06 INFO - 'sessionrestore', 01:07:06 INFO - 'sessionrestore_no_auto_restore']}, 01:07:06 INFO - 'other_l64': {'tests': ['a11yr', 01:07:06 INFO - 'ts_paint', 01:07:06 INFO - 'tpaint', 01:07:06 INFO - 'sessionrestore', 01:07:06 INFO - 'sessionrestore_no_auto_restore']}, 01:07:06 INFO - 'other_nol64': {'tests': ['a11yr', 01:07:06 INFO - 'ts_paint', 01:07:06 INFO - 'tpaint', 01:07:06 INFO - 'sessionrestore', 01:07:06 INFO - 'sessionrestore_no_auto_restore']}, 01:07:06 INFO - 'svgr': {'tests': ['tsvgx', 01:07:06 INFO - 'tsvgr_opacity', 01:07:06 INFO - 'tart', 01:07:06 INFO - 'tscrollx', 01:07:06 INFO - 'cart']}, 01:07:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['tsvgx', 01:07:06 INFO - 'tsvgr_opacity', 01:07:06 INFO - 'tart', 01:07:06 INFO - 'tscrollx', 01:07:06 INFO - 'cart']}, 01:07:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'tests': ['tp5o']}, 01:07:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'talos_options': ['--e10s'], 01:07:06 INFO - 'tests': ['tp5o']}, 01:07:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'talos_options': ['--xperf_path', 01:07:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:06 INFO - 'tests': ['tp5n']}, 01:07:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:06 INFO - 'talos_options': ['--e10s', 01:07:06 INFO - '--xperf_path', 01:07:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:06 INFO - 'tests': ['tp5n']}}, 01:07:06 INFO - 'talos.zip': {'path': '', 01:07:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:07:06 INFO - Running post-action listener: _resource_record_post_action 01:07:06 INFO - ##### 01:07:06 INFO - ##### Running create-virtualenv step. 01:07:06 INFO - ##### 01:07:06 INFO - Running pre-action listener: _resource_record_pre_action 01:07:06 INFO - Running main action method: create_virtualenv 01:07:06 INFO - Creating virtualenv /builds/slave/test/build/venv 01:07:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:07:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:07:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:07:06 INFO - Using real prefix '/tools/python27' 01:07:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:07:07 INFO - Installing distribute.............................................................................................................................................................................................done. 01:07:10 INFO - Installing pip.................done. 01:07:10 INFO - Return code: 0 01:07:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:10 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 0x10caf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cad0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade34cd5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:07:10 INFO - 'HOME': '/Users/cltbld', 01:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:07:10 INFO - 'LOGNAME': 'cltbld', 01:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:10 INFO - 'MOZ_NO_REMOTE': '1', 01:07:10 INFO - 'NO_EM_RESTART': '1', 01:07:10 INFO - 'PAGER': '/bin/cat', 01:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:10 INFO - 'PWD': '/builds/slave/test', 01:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:07:10 INFO - 'SHELL': '/bin/bash', 01:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:07:10 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:07:10 INFO - 'USER': 'cltbld', 01:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:10 INFO - 'XPC_FLAGS': '0x0', 01:07:10 INFO - 'XPC_SERVICE_NAME': '0', 01:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:07:10 INFO - Cleaning up... 01:07:10 INFO - Return code: 0 01:07:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:10 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 0x10caf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cad0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade34cd5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:07:10 INFO - 'HOME': '/Users/cltbld', 01:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:07:10 INFO - 'LOGNAME': 'cltbld', 01:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:10 INFO - 'MOZ_NO_REMOTE': '1', 01:07:10 INFO - 'NO_EM_RESTART': '1', 01:07:10 INFO - 'PAGER': '/bin/cat', 01:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:10 INFO - 'PWD': '/builds/slave/test', 01:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:07:10 INFO - 'SHELL': '/bin/bash', 01:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:07:10 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:07:10 INFO - 'USER': 'cltbld', 01:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:10 INFO - 'XPC_FLAGS': '0x0', 01:07:10 INFO - 'XPC_SERVICE_NAME': '0', 01:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:11 INFO - Downloading/unpacking psutil>=0.7.1 01:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:13 INFO - Installing collected packages: psutil 01:07:13 INFO - Running setup.py install for psutil 01:07:13 INFO - building 'psutil._psutil_osx' extension 01:07:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:07:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:07:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:07:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:07:14 INFO - building 'psutil._psutil_posix' extension 01:07:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:07:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:07:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:07:14 INFO - ^ 01:07:14 INFO - 1 warning generated. 01:07:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:14 INFO - Successfully installed psutil 01:07:14 INFO - Cleaning up... 01:07:15 INFO - Return code: 0 01:07:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:15 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 0x10caf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cad0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade34cd5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:07:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:07:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:07:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:07:15 INFO - 'HOME': '/Users/cltbld', 01:07:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:07:15 INFO - 'LOGNAME': 'cltbld', 01:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:15 INFO - 'MOZ_NO_REMOTE': '1', 01:07:15 INFO - 'NO_EM_RESTART': '1', 01:07:15 INFO - 'PAGER': '/bin/cat', 01:07:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:15 INFO - 'PWD': '/builds/slave/test', 01:07:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:07:15 INFO - 'SHELL': '/bin/bash', 01:07:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:07:15 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:07:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:07:15 INFO - 'USER': 'cltbld', 01:07:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:07:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:15 INFO - 'XPC_FLAGS': '0x0', 01:07:15 INFO - 'XPC_SERVICE_NAME': '0', 01:07:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:07:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:07:17 INFO - Installing collected packages: mozsystemmonitor 01:07:17 INFO - Running setup.py install for mozsystemmonitor 01:07:17 INFO - Successfully installed mozsystemmonitor 01:07:17 INFO - Cleaning up... 01:07:17 INFO - Return code: 0 01:07:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10caf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cad0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade34cd5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:07:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:07:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:07:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:07:17 INFO - 'HOME': '/Users/cltbld', 01:07:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:07:17 INFO - 'LOGNAME': 'cltbld', 01:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:17 INFO - 'MOZ_NO_REMOTE': '1', 01:07:17 INFO - 'NO_EM_RESTART': '1', 01:07:17 INFO - 'PAGER': '/bin/cat', 01:07:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:17 INFO - 'PWD': '/builds/slave/test', 01:07:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:07:17 INFO - 'SHELL': '/bin/bash', 01:07:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:07:17 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:07:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:07:17 INFO - 'USER': 'cltbld', 01:07:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:07:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:17 INFO - 'XPC_FLAGS': '0x0', 01:07:17 INFO - 'XPC_SERVICE_NAME': '0', 01:07:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:17 INFO - Downloading/unpacking blobuploader==1.2.4 01:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:20 INFO - Downloading blobuploader-1.2.4.tar.gz 01:07:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:07:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:07:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07:21 INFO - Downloading docopt-0.6.1.tar.gz 01:07:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:07:21 INFO - Installing collected packages: blobuploader, requests, docopt 01:07:21 INFO - Running setup.py install for blobuploader 01:07:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:07:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:07:21 INFO - Running setup.py install for requests 01:07:21 INFO - Running setup.py install for docopt 01:07:22 INFO - Successfully installed blobuploader requests docopt 01:07:22 INFO - Cleaning up... 01:07:22 INFO - Return code: 0 01:07:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:22 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 0x10caf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cad0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade34cd5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:07:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:07:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:07:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:07:22 INFO - 'HOME': '/Users/cltbld', 01:07:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:07:22 INFO - 'LOGNAME': 'cltbld', 01:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:22 INFO - 'MOZ_NO_REMOTE': '1', 01:07:22 INFO - 'NO_EM_RESTART': '1', 01:07:22 INFO - 'PAGER': '/bin/cat', 01:07:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:22 INFO - 'PWD': '/builds/slave/test', 01:07:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:07:22 INFO - 'SHELL': '/bin/bash', 01:07:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:07:22 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:07:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:07:22 INFO - 'USER': 'cltbld', 01:07:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:07:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:22 INFO - 'XPC_FLAGS': '0x0', 01:07:22 INFO - 'XPC_SERVICE_NAME': '0', 01:07:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:22 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-rvRgFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:22 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-It6eTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:22 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-cLgKPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:22 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-LSE6vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:22 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-tFTdn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:22 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-bAt5dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-RpSE8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-OGa2Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-y3FBmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-CFY1u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-YJmQri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-hIlpU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-d07kPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-lDAi1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-znN6Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-NG2yUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-T0ff4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:07:24 INFO - Running setup.py install for manifestparser 01:07:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:07:24 INFO - Running setup.py install for mozcrash 01:07:24 INFO - Running setup.py install for mozdebug 01:07:24 INFO - Running setup.py install for mozdevice 01:07:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:07:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:07:24 INFO - Running setup.py install for mozfile 01:07:24 INFO - Running setup.py install for mozhttpd 01:07:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Running setup.py install for mozinfo 01:07:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Running setup.py install for mozInstall 01:07:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Running setup.py install for mozleak 01:07:25 INFO - Running setup.py install for mozlog 01:07:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Running setup.py install for moznetwork 01:07:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:07:25 INFO - Running setup.py install for mozprocess 01:07:26 INFO - Running setup.py install for mozprofile 01:07:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:07:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:07:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:07:26 INFO - Running setup.py install for mozrunner 01:07:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:07:26 INFO - Running setup.py install for mozscreenshot 01:07:26 INFO - Running setup.py install for moztest 01:07:26 INFO - Running setup.py install for mozversion 01:07:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:07:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:07:26 INFO - Cleaning up... 01:07:26 INFO - Return code: 0 01:07:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:26 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 0x10caf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cad0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade34cd5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:07:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:07:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:07:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:07:26 INFO - 'HOME': '/Users/cltbld', 01:07:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:07:26 INFO - 'LOGNAME': 'cltbld', 01:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:26 INFO - 'MOZ_NO_REMOTE': '1', 01:07:26 INFO - 'NO_EM_RESTART': '1', 01:07:26 INFO - 'PAGER': '/bin/cat', 01:07:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:26 INFO - 'PWD': '/builds/slave/test', 01:07:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:07:26 INFO - 'SHELL': '/bin/bash', 01:07:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:07:26 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:07:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:07:26 INFO - 'USER': 'cltbld', 01:07:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:07:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:26 INFO - 'XPC_FLAGS': '0x0', 01:07:26 INFO - 'XPC_SERVICE_NAME': '0', 01:07:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-sMnwwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-jKfnbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-IQ2xPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Owhze_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-xZF5kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-a_ZWPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-HW4Hdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-IiXA5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:27 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-OncXhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Om0x37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-PSzwTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-KJgJ8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-6sQDA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-NNOKmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-BvKfTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-NgpiJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:07:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:28 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Ur_ynZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:31 INFO - Downloading blessings-1.5.1.tar.gz 01:07:31 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:07:31 INFO - Installing collected packages: blessings 01:07:31 INFO - Running setup.py install for blessings 01:07:31 INFO - Successfully installed blessings 01:07:31 INFO - Cleaning up... 01:07:31 INFO - Return code: 0 01:07:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:31 INFO - Reading from file tmpfile_stdout 01:07:31 INFO - Current package versions: 01:07:31 INFO - blessings == 1.5.1 01:07:31 INFO - blobuploader == 1.2.4 01:07:31 INFO - docopt == 0.6.1 01:07:31 INFO - manifestparser == 1.1 01:07:31 INFO - mozInstall == 1.12 01:07:31 INFO - mozcrash == 0.16 01:07:31 INFO - mozdebug == 0.1 01:07:31 INFO - mozdevice == 0.47 01:07:31 INFO - mozfile == 1.2 01:07:31 INFO - mozhttpd == 0.7 01:07:31 INFO - mozinfo == 0.9 01:07:31 INFO - mozleak == 0.1 01:07:31 INFO - mozlog == 3.1 01:07:31 INFO - moznetwork == 0.27 01:07:31 INFO - mozprocess == 0.22 01:07:31 INFO - mozprofile == 0.27 01:07:31 INFO - mozrunner == 6.11 01:07:31 INFO - mozscreenshot == 0.1 01:07:31 INFO - mozsystemmonitor == 0.0 01:07:31 INFO - moztest == 0.7 01:07:31 INFO - mozversion == 1.4 01:07:31 INFO - psutil == 3.1.1 01:07:31 INFO - requests == 1.2.3 01:07:31 INFO - wsgiref == 0.1.2 01:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:31 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 0x10caf3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cad0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade34cd5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/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.wwkHaEoX9H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:07:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:07:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:07:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:07:31 INFO - 'HOME': '/Users/cltbld', 01:07:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:07:31 INFO - 'LOGNAME': 'cltbld', 01:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:31 INFO - 'MOZ_NO_REMOTE': '1', 01:07:31 INFO - 'NO_EM_RESTART': '1', 01:07:31 INFO - 'PAGER': '/bin/cat', 01:07:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:31 INFO - 'PWD': '/builds/slave/test', 01:07:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:07:31 INFO - 'SHELL': '/bin/bash', 01:07:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:07:31 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:07:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:07:31 INFO - 'USER': 'cltbld', 01:07:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:07:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:31 INFO - 'XPC_FLAGS': '0x0', 01:07:31 INFO - 'XPC_SERVICE_NAME': '0', 01:07:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:07:31 INFO - Cleaning up... 01:07:31 INFO - Return code: 0 01:07:31 INFO - Running post-action listener: _resource_record_post_action 01:07:31 INFO - Running post-action listener: _start_resource_monitoring 01:07:31 INFO - Starting resource monitoring. 01:07:31 INFO - ##### 01:07:31 INFO - ##### Running install step. 01:07:31 INFO - ##### 01:07:31 INFO - Running pre-action listener: _resource_record_pre_action 01:07:31 INFO - Running main action method: install 01:07:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:32 INFO - Reading from file tmpfile_stdout 01:07:32 INFO - Detecting whether we're running mozinstall >=1.0... 01:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:07:32 INFO - Reading from file tmpfile_stdout 01:07:32 INFO - Output received: 01:07:32 INFO - Usage: mozinstall [options] installer 01:07:32 INFO - Options: 01:07:32 INFO - -h, --help show this help message and exit 01:07:32 INFO - -d DEST, --destination=DEST 01:07:32 INFO - Directory to install application into. [default: 01:07:32 INFO - "/builds/slave/test"] 01:07:32 INFO - --app=APP Application being installed. [default: firefox] 01:07:32 INFO - mkdir: /builds/slave/test/build/application 01:07:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:08:02 INFO - Reading from file tmpfile_stdout 01:08:02 INFO - Output received: 01:08:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:08:02 INFO - Running post-action listener: _resource_record_post_action 01:08:02 INFO - ##### 01:08:02 INFO - ##### Running run-tests step. 01:08:02 INFO - ##### 01:08:02 INFO - Running pre-action listener: _resource_record_pre_action 01:08:02 INFO - Running main action method: run_tests 01:08:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:08:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:08:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:08:02 INFO - 2015-11-24 01:08:02.956 screenresolution[1649:8243] starting screenresolution argv=screenresolution get 01:08:02 INFO - 2015-11-24 01:08:02.959 screenresolution[1649:8243] Display 0: 1600x1200x32@60 01:08:02 INFO - 2015-11-24 01:08:02.964 screenresolution[1650:8246] starting screenresolution argv=screenresolution list 01:08:02 INFO - Available Modes on Display 0 01:08:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:08:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:08:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:08:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:08:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:08:03 INFO - Intel Iris: 01:08:03 INFO - Chipset Model: Intel Iris 01:08:03 INFO - Type: GPU 01:08:03 INFO - Bus: Built-In 01:08:03 INFO - VRAM (Dynamic, Max): 1536 MB 01:08:03 INFO - Vendor: Intel (0x8086) 01:08:03 INFO - Device ID: 0x0a2e 01:08:03 INFO - Revision ID: 0x0009 01:08:03 INFO - Displays: 01:08:03 INFO - Display: 01:08:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:08:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:08:03 INFO - Display Serial Number: 1600x1200 60 01:08:03 INFO - Main Display: Yes 01:08:03 INFO - Mirror: Off 01:08:03 INFO - Online: Yes 01:08:03 INFO - Rotation: Supported 01:08:03 INFO - Return code: 0 01:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:08:03 INFO - Python 2.7.3 01:08:03 INFO - Return code: 0 01:08:03 INFO - grabbing minidump binary from tooltool 01:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:03 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 0x10ca179f0>, '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 0x10c776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0a8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:08:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:08:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:08:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:08:03 INFO - Return code: 0 01:08:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:08:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:08:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:08:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:08:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--webServer', 'localhost'] in /builds/slave/test/build 01:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0043 --webServer localhost 01:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yj9K201HEj/Render', 01:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:03 INFO - 'HOME': '/Users/cltbld', 01:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:03 INFO - 'LOGNAME': 'cltbld', 01:08:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:08:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:03 INFO - 'MOZ_NO_REMOTE': '1', 01:08:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:08:03 INFO - 'NO_EM_RESTART': '1', 01:08:03 INFO - 'PAGER': '/bin/cat', 01:08:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:03 INFO - 'PWD': '/builds/slave/test', 01:08:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:03 INFO - 'SHELL': '/bin/bash', 01:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wwkHaEoX9H/Listeners', 01:08:03 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 01:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:03 INFO - 'USER': 'cltbld', 01:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:03 INFO - 'XPC_FLAGS': '0x0', 01:08:03 INFO - 'XPC_SERVICE_NAME': '0', 01:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--webServer', 'localhost'] with output_timeout 3600 01:08:03 INFO - mozversion INFO | application_buildid: 20151124000634 01:08:03 INFO - mozversion INFO | application_changeset: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 01:08:03 INFO - mozversion INFO | application_display_name: Nightly 01:08:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:08:03 INFO - mozversion INFO | application_name: Firefox 01:08:03 INFO - mozversion INFO | application_remotingname: firefox 01:08:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:08:03 INFO - mozversion INFO | application_vendor: Mozilla 01:08:03 INFO - mozversion INFO | application_version: 45.0a1 01:08:03 INFO - mozversion INFO | platform_buildid: 20151124000634 01:08:03 INFO - mozversion INFO | platform_changeset: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 01:08:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:08:03 INFO - mozversion INFO | platform_version: 45.0a1 01:08:03 INFO - 2015-11-24 01:08:03,510 DEBUG : using testdate: 1448356083 01:08:03 INFO - 2015-11-24 01:08:03,510 DEBUG : actual date: 1448356083 01:08:03 INFO - 2015-11-24 01:08:03,911 INFO : starting webserver on 'localhost:49266' 01:08:03 INFO - 2015-11-24 01:08:03,912 INFO : Starting test suite t-yosemite-r7-0043 01:08:03 INFO - 2015-11-24 01:08:03,912 INFO : Starting test dromaeo_css 01:08:03 INFO - 2015-11-24 01:08:03,912 DEBUG : operating with platform_type : mac_ 01:08:03 INFO - 2015-11-24 01:08:03,914 INFO : Initialising browser for dromaeo_css test... 01:08:03 INFO - 2015-11-24 01:08:03,926 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpX6xx6J/profile http://localhost:49266/getInfo.html 01:08:06 INFO - 2015-11-24 01:08:06,179 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:08:06 INFO - 2015-11-24 01:08:06,180 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:08:06 INFO - 2015-11-24 01:08:06,180 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:08:06 INFO - 2015-11-24 01:08:06,180 DEBUG : BROWSER_OUTPUT: __metrics 01:08:06 INFO - 2015-11-24 01:08:06,195 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:06 INFO - 2015-11-24 01:08:06,454 DEBUG : BROWSER_OUTPUT: console.error: 01:08:06 INFO - 2015-11-24 01:08:06,454 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 01:08:06 INFO - 2015-11-24 01:08:06,454 DEBUG : BROWSER_OUTPUT: Stack: 01:08:06 INFO - 2015-11-24 01:08:06,454 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 01:08:06 INFO - 2015-11-24 01:08:06,454 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 01:08:06 INFO - 2015-11-24 01:08:06,454 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 01:08:06 INFO - 2015-11-24 01:08:06,455 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 01:08:06 INFO - 2015-11-24 01:08:06,455 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 01:08:06 INFO - 2015-11-24 01:08:06,455 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 01:08:06 INFO - 2015-11-24 01:08:06,455 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 01:08:06 INFO - 2015-11-24 01:08:06,455 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 01:08:06 INFO - 2015-11-24 01:08:06,455 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 01:08:06 INFO - 2015-11-24 01:08:06,455 DEBUG : BROWSER_OUTPUT: 01:08:06 INFO - 2015-11-24 01:08:06,858 INFO : Browser initialized. 01:08:06 INFO - 2015-11-24 01:08:06,859 INFO : Running cycle 1/1 for dromaeo_css test... 01:08:06 INFO - 2015-11-24 01:08:06,859 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpX6xx6J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:08:18 INFO - 2015-11-24 01:08:18,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 225742848 01:08:18 INFO - 2015-11-24 01:08:18,707 DEBUG : BROWSER_OUTPUT: 01:09:10 INFO - 2015-11-24 01:09:10,593 DEBUG : BROWSER_OUTPUT: 1448356150592 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] 01:11:20 INFO - 2015-11-24 01:11:20,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 01:11:22 INFO - 2015-11-24 01:11:22,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 341794816 01:11:22 INFO - 2015-11-24 01:11:22,156 DEBUG : BROWSER_OUTPUT: 01:14:24 INFO - 2015-11-24 01:14:24,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 01:14:25 INFO - 2015-11-24 01:14:25,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 359321600 01:14:25 INFO - 2015-11-24 01:14:25,312 DEBUG : BROWSER_OUTPUT: 01:17:27 INFO - 2015-11-24 01:17:27,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 01:17:28 INFO - 2015-11-24 01:17:28,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 327254016 01:17:28 INFO - 2015-11-24 01:17:28,068 DEBUG : BROWSER_OUTPUT: 01:20:30 INFO - 2015-11-24 01:20:30,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 01:20:30 INFO - 2015-11-24 01:20:30,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 317415424 01:20:30 INFO - 2015-11-24 01:20:30,661 DEBUG : BROWSER_OUTPUT: 01:23:33 INFO - 2015-11-24 01:23:33,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 01:23:34 INFO - 2015-11-24 01:23:34,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 320651264 01:23:34 INFO - 2015-11-24 01:23:34,298 DEBUG : BROWSER_OUTPUT: 01:26:36 INFO - 2015-11-24 01:26:36,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 01:26:37 INFO - 2015-11-24 01:26:37,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 362999808 01:26:37 INFO - 2015-11-24 01:26:37,104 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,104 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:26:37 INFO - 2015-11-24 01:26:37,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:26:37 INFO - 2015-11-24 01:26:37,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:26:37 INFO - 2015-11-24 01:26:37,104 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:26:37 INFO - 2015-11-24 01:26:37,106 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3372.949405758913;3437.8109203993786;3461.757676962612;3463.35927853347;3502.194495266089;5568.749406276717;5662.405447428023;5735.1110577860445;5801.448862358075;5808.622439541432;5639.238702775124;5699.772009119641;5775.047117225663;5868.17845501629;5911.408859114086;5110.591152707774;5141.228815677659;5173.689578625294;5190.299309593194;5256.553192978601;5276.2085687146855;5306;5316.946830531684;5327.307450031491;5353.357597088355;5084.77118529667;5166.870828229286;5207.4792520748;5234.92147617786;5253.185756207794;5184.792608295664;5213.4004589472315;5220.29526013987;5221.06020916235;5229.816956406507;5103.413107492649;5194.71429071401;5198.766055527511;5199.4800519948085;5210.609204309654;5568.136938774456;5707.714614269312;5746.626469279525;5768.2501274834;5776.306843178803;6264.9686751566405;6288.119663247149;6302.590331628476;6309.936900630981;6313.273973493061;6068.089786532011;6284.622922624657;6292.087647291163;6297.811065668037;6302.432781049682;5827.184194212814;5863.618864773819;5873.676947767871;5929.110633405024;5953.285605727254;6243.157173781572;6302.590331628429;6305.779297724649;6311.621302721851;6318.494520438354;5902.6458412495385;6152.753889844356;6173.59871608344;6178;6198.659073750987;6105.511559075263;6177.135201071854;6187.102870083812;6189.84525386869;6221.906671399933;6202.2867370253;6203.348648391944;6238.469730072995;6238.500919926395;6261.8747625047245;6120.7551697931585;6229.626222426669;6232.594881332699;6238.1266622672865;6250.218722659668;4819.734914579662;4901.705897646153;4919.163742163841;4933.210686290176;4966.205407134841;4405.977970110129;4423.933640995388;4461.308497182942;4477.462704475419;4486.977565112219;5531.640443371168;5751.683657398883;5767.077267637242;5769.85575360611;5777.566682498829;6098.619994938517;6222.315545290015;6239.563230573907;6255.061740738925;6270.15352927349;5072.492750724898;5604.907043126633;5735;5766.221560089334;5769.1634712967225;5259.395169555473;5439.646422982493;5440.401555828856;5445.891082178414;5463.371712253142;6174.135621013062;6263.154474146023;6266.49868010558;6281.089242059968;6281.12064311006;6112.786052488142;6125.850951268649;6138.79981218981;6142.805741014737;6148.661823599745;6241.251049874044;6282.654454005074;6322.810315690536;6348.650824204713;6360.522960778053;6129.908051379144;6142.692865356625;6147.323794382525;6154.046122850965;6157.32269450369;6021.397860214119;6116.548817443993;6127.414320899048;6183;6202.28673702512;5172.7413629319135;6008.519318454426;6028.306744724413;6044.667543285162;6053.727582258721;6081.452669259788;6082.756689732361;6083.66539840313;6097.695115244309;6150.7847225346895;5817.447342502455;5950.404959504015;5956.344802071855;5984.730687119003;6025.397460253939;6006.819795406145;6087.107581585805;6109.033772226435;6114.054067497291;6127.958561426818;6032.90950635732;6056;6063.545234107548;6067.878642427038;6069.787557435468 01:26:37 INFO - 2015-11-24 01:26:37,107 DEBUG : BROWSER_OUTPUT: |1;ext.html;517.0995416617699;565.3018522125177;606.8968275393182;633.9968300158498;636.7134789344796;25098.874505627467;32373.543190556422;40662.796686016525;41024.5641402551;41032.79483602578;43284.783576082154;43587.564124358745;43700;43818.56181438185;43819.342709859375;8781.42920710155;9729.124378805924;9923.851142232872;9931.354461959985;9940.751481212992;8785.472871627722;8863.955680221623;11847.881521184807;11969;12017.158798884082;11702.707432314175;11809.291442513477;11821.231619944676;11825.822612660773;11827.40862956853;8837.690680826141;11719.414029298501;11807.350595717233;11841;11868.703282417922;8763.16749908764;8882.644694212288;8888.955555222183;8928.866067009;11765.294082355085;40995.795021025006;41399.379009314885;41409.75770726883;41655.375169372484;41665;3232.9676703233135;3280.16355829262;3325;3511.3855075361707;3589.4795254688183;27867.581986270223;28718.85640571805;29181.124566263046;29225.853870730723;29299.560506592417;2535.4168541235435;2569.6530968319225;2793.776497880185;2833.4758069757163;2892.3781387001686;485535;492193.53903230256;493455;495661;497114;65134.674326629014;65458.34541654618;65628;65648.67175664187;65693;69224.6538767303;69411.65294173599;69508.65245673739;69549.95675064878;69603.65198173976;15898.205089745697;16044.75932861008;16079.196040197943;16092.356305747639;16101.95337303095;12240.632781016584;12318.260904345769;12326.50693972231;12326.81509777354;12329.630111096682;18893.33873314455;19774.90112549457;19846.801531984784;19870;19870.907100109343;9014.053524379977;9035.960864500667;9170.633174673072;9184.90815091854;9197.126273004054;815.3925325632442;973.6300205921705;1092.7650555130685;1097.9011888930036;1143.1312202725987;29016.564751528746;29229.415411691647;29232;29834;29857.701422985927;1038.9116925061303;1115.1691989467736;1120.798256313855;1135.7274254179104;1185.199990006742;15794.447194348142;15867.285972131282;16011.09996456384;16223;16246.431374901822;433126;519838;525151;525177;527586;51573.48426515687;52149;58539.82920341569;59063.11405328924;59336.703316484;1437.6549628089392;1457.8469260727684;1466.5600319903986;1477.8152730908637;1480.504031149577;26273;27947.58078628863;28453.146405607866;28993.42013159767;29006.56490152607;53195;53640.463595363544;53715.46284537261;53730.46269537411;53745.73127134339;354423;359152;361168;361458;361775.19112404267;31536.684633153374;31583.842080789447;31903;31906.52140217852;31993.840030799696;45193.32210016918;45511.77244113758;46298;46543.767281163375;46594;35480.290394191456;36209.27581448409;37515.62484375121;38469.23061538809;38569;36666.63333366739;37436.625633743315;37636.81181594184;37661.435078473296;37719.81140094282;36569.63430365769;37530.437043443824;37668.43497347597;37692;37845;30960.845195773876;31085.222869428446;32769.18077047997;33514;33520.83239583787;23221.651675224548;24526.14158504444;24650.383740405916;25193.748062519142;25217 01:26:37 INFO - 2015-11-24 01:26:37,109 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.458450447572;359.6349705049375;362.3116079449047;362.8149643681721;363.13935971746963;16160.191990400492;17046.659066818655;20130.396088117344;20169;21012.264570740026;11154.498047587858;11345.43272836359;11346.71633209168;19629.90185049073;20009.699854502192;5253.4221235664045;5401.945980540203;5406.648567843077;5407.945920540803;5408.756605952722;4017.919641607166;4119.423280740683;4133.049398638315;5349.144136938091;5838.182654428383;5926.703664816763;5962.0162673158875;5989.191459153002;5990.910136347937;5996.760129594811;6111.511079113682;6452.935470645304;6453.2256129264315;6461.6123032617725;6461.6446095464735;5309.3894202166475;5659;5665.773369065232;5670.432956704338;5674.375818659944;23368.94839732216;23829.642555361683;23989.52020959571;24173;24563.877180614163;2036.1448191759348;2070.234013415031;2090.3833369156137;2118.152738904435;2121.0137286161853;7800.609969501502;9663.371880827724;9840.557174927146;11595.420228988516;14005.789913151311;1712.101146897876;1715.2967283413866;1759.2347328911965;1808.114024128181;1869.5045812859603;85607;87355.25289494175;87511.56244218738;93408;97525.51237243839;10511.474426278808;10866.61966831157;11027.503762330714;11062.834057489144;11123.944380278046;13365.26491043002;13373.66565835862;13375.197488150741;13379.397927093305;13404.798928015893;8282.50304981703;8361.707340243183;8368;8387.916120838836;8427.95786021066;6183.1450564830375;8327.00075990885;8370.497770133812;8378.622961966727;8428.199321064489;4387.990762124666;4391.451068616423;4399.560043995639;4400.603945644843;4413.845515406945;1535.6237721758241;1760.5862622283753;1819.3905041810876;1819.5178277756406;1842.4656849513758;393.2155350076616;846.4624963148445;850.5279569838799;988.3378136648463;1094.3433939636313;11298;11480.655580332603;11688.883111168949;11702.122340824471;11749.4712737927;417.4635593262643;426.098801035807;437.23265668751776;439.43093693666776;446.9307257375112;5166.095933211673;5943.3462319144855;5948.583599148018;6016.849578760479;6032.336442991267;592947;660206;753396;761445;771340;119625.40187299007;122852.38573807073;124287;125951.3702431482;126692;1163.313644949484;1189.262657152571;1202.1524824998355;1204.933728644933;1207.7524107557929;18394.540136496693;18698;18761.718574221126;18981.905090474458;19356.32252871143;41922.95192620209;50747.47757567279;50953.98092038064;51230.23154652608;52516.47483525116;64680.0297995521;67207;68340.31659683339;68384;69128;9864.112229899343;9892.208623309974;10010.44942528168;10052.547635356574;10081.042300981395;18815.90592047031;19252.90373548123;19346.8065319345;19943.800561994194;20052.09765560524;15462.304196310968;15557.688846222785;15716.764248536052;16283.837161628706;16414.850960432654;13384.464621415034;15104.622384440478;15599.986000910358;15711.371545138067;15894.761578576099;15819.288132033857;16018.519444416686;16213.59466013312;16413.91793041075;16482.83517164813;9092.545372731205;9830.4101753895;9937.850932235877;9947.701568952943;10285.74285642865;12142.75714485723;16302.184890755652;16305.836941630907;16339.019658820509;16344.264508096927 01:26:37 INFO - 2015-11-24 01:26:37,112 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1587.2143289071912;1592.2834724374034;1691.450278659436;1887.886147173168;1910.5128192310958;7825.178356272595;8076.232757888006;8519.233269005788;8628.007779105405;8647.567621618926;8467.195616416431;8515.105913879032;8542;8561.486310821356;8577.44246623969;2382.1781485387555;2406.9037238510437;2408.1451084864884;2410.8794560272004;2412.589859723851;2314.409825494505;2412.1316326122583;2432.4770174412497;2450.9387265318333;2452.3256104571205;2369.95260094798;2399.4601214726636;2403.6875206223167;2404.230646193219;2410.7348191698898;2352.1649814316015;2372.7034120734907;2385.7494963028894;2394.2697477269426;2397.6283676030157;2382.6902502674716;2393.5930891748444;2404.843685160459;2412.7587241275905;2413.662087307778;7623;8482.957585212096;8524.786880328042;8530.445521041112;8551.914480855174;4816.253480710496;4872.293517439952;5030.0694371541385;5139.948600514022;5142.460041695643;3466.843992020365;3539.203679172191;3583.1937813991904;3622.9094272643133;3631.0014745944814;914.9634014639473;1049.4280617063641;1090.6673464593296;1456.9728341519203;1656.7349224124202;11328.490217940212;11381.918717721803;11394.25937314072;11394.373309467976;11447.484863181176;4547.681662283675;4556.544345565417;4635.119327327797;4638.095571363552;4664.953350466452;9261.444313341086;9270.90729092714;9271.629134834666;9278.304127190488;9286.257099432029;5158.200478925697;5177.430482646982;5187.610929180327;5190.961807638412;5191.766370513336;4783.928241076386;4795.20879054952;4798.448178459522;4799.352087468217;4809;3591.6049234584175;3624.9637503625154;3674.3569875272256;3701.0747313171705;3739.607341229186;979.4123525884555;1135.5117299561268;1139.732162941708;1141.4292853573213;1147.6614398752388;1245.2155142260317;1334.873187047229;1349.352310890778;1403.3193900958026;1405.8945579081405;8100.878486822702;8152.796180095545;8167.836643267101;8240.258376746122;8365.916340836635;1189.2448295332526;1193.373478923572;1207.7342984543386;1224.4999875153044;1232.7103130764262;6145.4161854623735;6235.563510554309;6355.491560675135;6411.166548348778;6422.518311126684;10196.082352588302;10354.741131471774;10391.584336626602;10427.270091093702;10456.947715261374;10023.448710321003;10288.588456461808;10306.587736490606;10318.896811031944;10492.737681558023;8058.717944871902;8094.919050809652;8112.148224436467;8159.877601835978;8170.7957301067945;7859;8056.83886322282;8077.434579579608;8083.878741818759;8090.555019473985;9239.815203695754;9327.720168394959;9360.719178424659;9370.062993700576;9372.812543749224;9330.393524420891;9599.856002160113;9599.904000960181;9678.661246856327;9715.125638692269;7082.929170708227;7174.928250717635;7537.811554710956;7545;7561.886571701539;8165.265126138676;8269.00771907375;8273.46222495536;8279.668813247403;8290.253877151084;7548.773536793905;7662.655180517002;7689.3848492121615;7735.883961740691;7793.10379306387;7442.367398771165;7499.88750168737;7505.399568034653;7644.426667999811;7659.272369124924;7701.383889288732;7736.342410895137;7740.109887363025;7748.263914928073;7759.030121234846;6903.0680858083515;7005.859882802213;7009.088818453569;7012.614306213207;7030;7077.5753454792875;7102.254263302279;7104.573725576482;7109.8578028438105;7125.75059872902 01:26:37 INFO - 2015-11-24 01:26:37,113 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.6246498319692;314.04843324726073;319.9394008860627;322.07564290486306;333.9315440334732;6082.45257926786;6574.605523668577;6662.933370666292;6712.160979877515;6796.25241223465;6624.701888415033;6644.172852465575;6739.157605299338;6787.694553745081;6797.0144329072255;4855.684380515273;4871.293662418947;4891.584215341701;4891.951080489203;4900.142475066867;4004.7196696231276;4723.17344464719;4803.3515475410895;4822.614190864722;4886.926696099561;4844.878878028042;4858.174110401223;4906.582940450066;4933.7286449245275;4935.901281974358;4898.069366820293;4898.412190537123;4905.994271174419;4914.582260507861;4920.655554111214;4153.1486045360625;4154.709170358076;4155.771432571208;4162.521310049353;4163.604457576525;6383.2978372379;6586.967065164644;6618.569792963442;6628.3371662833815;6670.3329667033395;5836.358000619928;5874.383189765056;5879.941200588025;5888.263967004124;5904.5571582131515;6915.308469153045;7201.387882030033;7379.1145062592295;7382.852342953111;7398.149212840538;4436.55634436557;4616.630669546462;4633.193054708667;4636.582707556302;4637.281221410687;7609.162992070867;7739.264769846855;7758.573278469738;7760.185180556016;7768.145503994556;4621.329907163443;4695.718256904596;4726.676530571445;4736.147493451212;4736.73947932867;4823.855284341475;4829.323894654751;4836.177849765549;4837.564619184291;4843.878903027453;5814.720761432478;5821.330546987151;5828.329742079631;5837.387074357216;5842.766289348463;7369.81575460607;7377.520461170114;7378.520396174339;7398;7399.408047356199;1506.9698606028037;1610.6617610301732;1621.1326940087233;1678.8992660440413;1684.3515246630136;1045.247561255098;1055.8363453664695;1058.3596923861107;1063.292910214714;1065.1053115383115;6837.521373503906;6859.588424694534;6878.449724022066;6881.931180688229;6901.930980690229;6728.663566821737;7735.574543400167;7737.071551413754;7739.993800805859;7752.612369381621;5414.83755487336;6836.829079272959;6837.794866154023;6849.1780986281965;6875.3812156906115;4050.311447054008;4100.5899410059355;4104.322786740214;4107.240160570304;4111.9177616447505;8011.1588283230585;8026.197380262044;8027.036755589366;8027.719029833927;8030.23712747288;7658.195889431641;7988.600569971478;8004.199580041949;8011.198880111942;8012.759617211493;7683.769486915401;7994.200579942076;7995.7601271960775;7996.64015119321;8001.479903806234;7086.539374940819;7633.809154771176;7648.196939321291;7650.387968962358;7781.182975787688;7575.166731659623;7604.277593628596;7606.733764318223;7608.353289970414;7621.12357078943;7766.534007959541;8009.559474228973;8011.038675358995;8023.277904988579;8040.236177563356;4731.84069902876;4769.165396055607;4775;4777.784999675093;4795.112904112751;7675.963744894368;7695.92304076952;7700.19147989453;7704.075510938723;7706.075270967295;6459.257185423548;7160.10498687664;7377.926220737724;7386;7401.259874012771;7375.041244638162;7391.815204619712;7397.445191610543;7400.925990740239;7405.9629701851145;6935.445164386938;7216.221754624403;7229.710811567478;7232.240614735377;7235.565866048054;7410.777676669709;7427.8143046424275;7429.4799364044;7433.628318584158;7435.888461672971;6036.607620504653;7250.637468126467;7270.418366530559;7272.818179545554;7299.087614048244 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: |5;yui.html;678.5148618737603;774.1600363605488;786.6656670914862;789.992100078999;828.7679449754067;15031.699366012686;15291.235438228072;15322.310496027678;15324.61688457789;15336.46322378717;12257.693557661063;14171.291435428238;14214.573562793134;14315.568443155678;14359.64100897478;650.8568115014689;756.0549313358302;758.8216769059294;806.822499050208;978.1441238915949;958.324381311174;971.4996776660025;974.7027156717198;974.9714051675479;975.8682577852005;975.1467465967279;1004.3271008424337;1004.5379125602232;1004.5780772075709;1008.5814387029374;780.6955287437904;796.4345314826451;807.04365327087;994.328828041073;997.0527998401511;752.8306131120454;759.1270039454671;759.5063208914195;759.6657470712869;762.3253420722644;14812.185329806856;15019.549413517612;15051;15055.774163387558;15069.09585424878;12680.68298292541;12967.286799226038;12974.740505189844;13399.531016414476;13443.193408395528;10270.794584108276;10300.27898047137;10302.536385862653;10327.638532651321;10367;3535.7112783146645;3625.1299688074937;3625.5830579483168;3626.9637303627155;3635.6727894489622;76759.23240767576;77509.61245193794;80148.59925700392;80165;80294;9934.950325248472;9972.80054398908;10010.599576016877;10013.048760367754;10349.586016559404;21537.892310538347;21749.456263593536;21763.891180543997;21774.564508710053;21798.56402871934;7311.049563556704;7411.6664750086375;7425.294597013275;7619.580923049175;7867.842643147105;3992.2215168041953;4041.777702226347;4047.9392809107885;4048.959510404917;4109.0959988802415;3639.5996440391536;3678.33789917812;3681.5950245472977;3683.226522430266;3695.150115473456;635.1330433957614;639.3223183425583;645.1580687203151;645.8191706322237;647.7057111351708;478.4187212536784;516.1251678405142;545.6180673528546;569.313976658126;603.387561624951;8710.172533609297;8725.869111963326;8757.080506546848;8825.911740882637;8888.511131887679;557.8369100425658;576.2623841482908;615.8583525789004;636.7484843486797;662.102850637389;4099.159672267178;4140.855070072533;4167.5832416758085;4177.10192308649;4283.871483855427;99069;101059;102038.95922081517;106123;107326.46336768266;82621;84630.57684711537;85091;86851;88034.55982720046;71971.6401418;73747.63126184442;75119;76244.61877690686;79007;7797.493162944391;9029.729108126767;9070.365074444726;9147.725568232963;9278.489683067495;48401.305954291434;49703.75148124236;53344;53447.46552534425;53742.73128634332;71793;73339.63330183529;76634;76685;76888.2311176881;10757.623483178051;10927.289726167774;11185.552577897119;11289.322640641587;11525.827112593486;11996.940015299868;11998.58004969822;12006.699832503908;12010.33943133136;12410.317432540936;11438.084953203557;11459.885401145882;11474.598389056677;11477.827832582685;11490.540378385105;11053.613123540637;11406.714832129263;11496.137789665641;11503.884961150281;11507.194496385173;9063.274938005075;9288.72133835986;11261.71845703864;11292.60475883373;11318.830217546909;9954.55204515784;10294.433806140734;10338.328008679411;10391.84412233802;10476.580936762444;7628.46600737943;9566.13904748576;9607.759806004906;9623;9665.468399238109 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1025 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: __startTimestamp1448357197102__endTimestamp 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,117 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5743.20 Median:6008.52 stddev:625.23 (10.4%) stddev-sans-first:598.86 01:26:37 INFO - 2015-11-24 01:26:37,118 DEBUG : BROWSER_OUTPUT: Values: 3372.9 3437.8 3461.8 3463.4 3502.2 5568.7 5662.4 5735.1 5801.4 5808.6 5639.2 5699.8 5775.0 5868.2 5911.4 5110.6 5141.2 5173.7 5190.3 5256.6 5276.2 5306.0 5316.9 5327.3 5353.4 5084.8 5166.9 5207.5 5234.9 5253.2 5184.8 5213.4 5220.3 5221.1 5229.8 5103.4 5194.7 5198.8 5199.5 5210.6 5568.1 5707.7 5746.6 5768.3 5776.3 6265.0 6288.1 6302.6 6309.9 6313.3 6068.1 6284.6 6292.1 6297.8 6302.4 5827.2 5863.6 5873.7 5929.1 5953.3 6243.2 6302.6 6305.8 6311.6 6318.5 5902.6 6152.8 6173.6 6178.0 6198.7 6105.5 6177.1 6187.1 6189.8 6221.9 6202.3 6203.3 6238.5 6238.5 6261.9 6120.8 6229.6 6232.6 6238.1 6250.2 4819.7 4901.7 4919.2 4933.2 4966.2 4406.0 4423.9 4461.3 4477.5 4487.0 5531.6 5751.7 5767.1 5769.9 5777.6 6098.6 6222.3 6239.6 6255.1 6270.2 5072.5 5604.9 5735.0 5766.2 5769.2 5259.4 5439.6 5440.4 5445.9 5463.4 6174.1 6263.2 6266.5 6281.1 6281.1 6112.8 6125.9 6138.8 6142.8 6148.7 6241.3 6282.7 6322.8 6348.7 6360.5 6129.9 6142.7 6147.3 6154.0 6157.3 6021.4 6116.5 6127.4 6183.0 6202.3 5172.7 6008.5 6028.3 6044.7 6053.7 6081.5 6082.8 6083.7 6097.7 6150.8 5817.4 5950.4 5956.3 5984.7 6025.4 6006.8 6087.1 6109.0 6114.1 6128.0 6032.9 6056.0 6063.5 6067.9 6069.8 01:26:37 INFO - 2015-11-24 01:26:37,118 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,118 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60943.46 Median:360160.00 stddev:121596.69 (33.8%) stddev-sans-first:121853.16 01:26:37 INFO - 2015-11-24 01:26:37,118 DEBUG : BROWSER_OUTPUT: Values: 517.1 565.3 606.9 634.0 636.7 25098.9 32373.5 40662.8 41024.6 41032.8 43284.8 43587.6 43700.0 43818.6 43819.3 8781.4 9729.1 9923.9 9931.4 9940.8 8785.5 8864.0 11847.9 11969.0 12017.2 11702.7 11809.3 11821.2 11825.8 11827.4 8837.7 11719.4 11807.4 11841.0 11868.7 8763.2 8882.6 8889.0 8928.9 11765.3 40995.8 41399.4 41409.8 41655.4 41665.0 3233.0 3280.2 3325.0 3511.4 3589.5 27867.6 28718.9 29181.1 29225.9 29299.6 2535.4 2569.7 2793.8 2833.5 2892.4 485535.0 492193.5 493455.0 495661.0 497114.0 65134.7 65458.3 65628.0 65648.7 65693.0 69224.7 69411.7 69508.7 69550.0 69603.7 15898.2 16044.8 16079.2 16092.4 16102.0 12240.6 12318.3 12326.5 12326.8 12329.6 18893.3 19774.9 19846.8 19870.0 19870.9 9014.1 9036.0 9170.6 9184.9 9197.1 815.4 973.6 1092.8 1097.9 1143.1 29016.6 29229.4 29232.0 29834.0 29857.7 1038.9 1115.2 1120.8 1135.7 1185.2 15794.4 15867.3 16011.1 16223.0 16246.4 433126.0 519838.0 525151.0 525177.0 527586.0 51573.5 52149.0 58539.8 59063.1 59336.7 1437.7 1457.8 1466.6 1477.8 1480.5 26273.0 27947.6 28453.1 28993.4 29006.6 53195.0 53640.5 53715.5 53730.5 53745.7 354423.0 359152.0 361168.0 361458.0 361775.2 31536.7 31583.8 31903.0 31906.5 31993.8 45193.3 45511.8 46298.0 46543.8 46594.0 35480.3 36209.3 37515.6 38469.2 38569.0 36666.6 37436.6 37636.8 37661.4 37719.8 36569.6 37530.4 37668.4 37692.0 37845.0 30960.8 31085.2 32769.2 33514.0 33520.8 23221.7 24526.1 24650.4 25193.7 25217.0 01:26:37 INFO - 2015-11-24 01:26:37,118 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,119 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36858.59 Median:24368.44 stddev:117183.60 (480.9%) stddev-sans-first:117480.27 01:26:37 INFO - 2015-11-24 01:26:37,120 DEBUG : BROWSER_OUTPUT: Values: 357.5 359.6 362.3 362.8 363.1 16160.2 17046.7 20130.4 20169.0 21012.3 11154.5 11345.4 11346.7 19629.9 20009.7 5253.4 5401.9 5406.6 5407.9 5408.8 4017.9 4119.4 4133.0 5349.1 5838.2 5926.7 5962.0 5989.2 5990.9 5996.8 6111.5 6452.9 6453.2 6461.6 6461.6 5309.4 5659.0 5665.8 5670.4 5674.4 23368.9 23829.6 23989.5 24173.0 24563.9 2036.1 2070.2 2090.4 2118.2 2121.0 7800.6 9663.4 9840.6 11595.4 14005.8 1712.1 1715.3 1759.2 1808.1 1869.5 85607.0 87355.3 87511.6 93408.0 97525.5 10511.5 10866.6 11027.5 11062.8 11123.9 13365.3 13373.7 13375.2 13379.4 13404.8 8282.5 8361.7 8368.0 8387.9 8428.0 6183.1 8327.0 8370.5 8378.6 8428.2 4388.0 4391.5 4399.6 4400.6 4413.8 1535.6 1760.6 1819.4 1819.5 1842.5 393.2 846.5 850.5 988.3 1094.3 11298.0 11480.7 11688.9 11702.1 11749.5 417.5 426.1 437.2 439.4 446.9 5166.1 5943.3 5948.6 6016.8 6032.3 592947.0 660206.0 753396.0 761445.0 771340.0 119625.4 122852.4 124287.0 125951.4 126692.0 1163.3 1189.3 1202.2 1204.9 1207.8 18394.5 18698.0 18761.7 18981.9 19356.3 41923.0 50747.5 50954.0 51230.2 52516.5 64680.0 67207.0 68340.3 68384.0 69128.0 9864.1 9892.2 10010.4 10052.5 10081.0 18815.9 19252.9 19346.8 19943.8 20052.1 15462.3 15557.7 15716.8 16283.8 16414.9 13384.5 15104.6 15600.0 15711.4 15894.8 15819.3 16018.5 16213.6 16413.9 16482.8 9092.5 9830.4 9937.9 9947.7 10285.7 12142.8 16302.2 16305.8 16339.0 16344.3 01:26:37 INFO - 2015-11-24 01:26:37,120 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,120 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5952.16 Median:5189.29 stddev:3084.87 (59.4%) stddev-sans-first:3076.08 01:26:37 INFO - 2015-11-24 01:26:37,121 DEBUG : BROWSER_OUTPUT: Values: 1587.2 1592.3 1691.5 1887.9 1910.5 7825.2 8076.2 8519.2 8628.0 8647.6 8467.2 8515.1 8542.0 8561.5 8577.4 2382.2 2406.9 2408.1 2410.9 2412.6 2314.4 2412.1 2432.5 2450.9 2452.3 2370.0 2399.5 2403.7 2404.2 2410.7 2352.2 2372.7 2385.7 2394.3 2397.6 2382.7 2393.6 2404.8 2412.8 2413.7 7623.0 8483.0 8524.8 8530.4 8551.9 4816.3 4872.3 5030.1 5139.9 5142.5 3466.8 3539.2 3583.2 3622.9 3631.0 915.0 1049.4 1090.7 1457.0 1656.7 11328.5 11381.9 11394.3 11394.4 11447.5 4547.7 4556.5 4635.1 4638.1 4665.0 9261.4 9270.9 9271.6 9278.3 9286.3 5158.2 5177.4 5187.6 5191.0 5191.8 4783.9 4795.2 4798.4 4799.4 4809.0 3591.6 3625.0 3674.4 3701.1 3739.6 979.4 1135.5 1139.7 1141.4 1147.7 1245.2 1334.9 1349.4 1403.3 1405.9 8100.9 8152.8 8167.8 8240.3 8365.9 1189.2 1193.4 1207.7 1224.5 1232.7 6145.4 6235.6 6355.5 6411.2 6422.5 10196.1 10354.7 10391.6 10427.3 10456.9 10023.4 10288.6 10306.6 10318.9 10492.7 8058.7 8094.9 8112.1 8159.9 8170.8 7859.0 8056.8 8077.4 8083.9 8090.6 9239.8 9327.7 9360.7 9370.1 9372.8 9330.4 9599.9 9599.9 9678.7 9715.1 7082.9 7174.9 7537.8 7545.0 7561.9 8165.3 8269.0 8273.5 8279.7 8290.3 7548.8 7662.7 7689.4 7735.9 7793.1 7442.4 7499.9 7505.4 7644.4 7659.3 7701.4 7736.3 7740.1 7748.3 7759.0 6903.1 7005.9 7009.1 7012.6 7030.0 7077.6 7102.3 7104.6 7109.9 7125.8 01:26:37 INFO - 2015-11-24 01:26:37,121 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,121 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5980.14 Median:6763.43 stddev:1966.24 (29.1%) stddev-sans-first:1924.77 01:26:37 INFO - 2015-11-24 01:26:37,122 DEBUG : BROWSER_OUTPUT: Values: 287.6 314.0 319.9 322.1 333.9 6082.5 6574.6 6662.9 6712.2 6796.3 6624.7 6644.2 6739.2 6787.7 6797.0 4855.7 4871.3 4891.6 4892.0 4900.1 4004.7 4723.2 4803.4 4822.6 4886.9 4844.9 4858.2 4906.6 4933.7 4935.9 4898.1 4898.4 4906.0 4914.6 4920.7 4153.1 4154.7 4155.8 4162.5 4163.6 6383.3 6587.0 6618.6 6628.3 6670.3 5836.4 5874.4 5879.9 5888.3 5904.6 6915.3 7201.4 7379.1 7382.9 7398.1 4436.6 4616.6 4633.2 4636.6 4637.3 7609.2 7739.3 7758.6 7760.2 7768.1 4621.3 4695.7 4726.7 4736.1 4736.7 4823.9 4829.3 4836.2 4837.6 4843.9 5814.7 5821.3 5828.3 5837.4 5842.8 7369.8 7377.5 7378.5 7398.0 7399.4 1507.0 1610.7 1621.1 1678.9 1684.4 1045.2 1055.8 1058.4 1063.3 1065.1 6837.5 6859.6 6878.4 6881.9 6901.9 6728.7 7735.6 7737.1 7740.0 7752.6 5414.8 6836.8 6837.8 6849.2 6875.4 4050.3 4100.6 4104.3 4107.2 4111.9 8011.2 8026.2 8027.0 8027.7 8030.2 7658.2 7988.6 8004.2 8011.2 8012.8 7683.8 7994.2 7995.8 7996.6 8001.5 7086.5 7633.8 7648.2 7650.4 7781.2 7575.2 7604.3 7606.7 7608.4 7621.1 7766.5 8009.6 8011.0 8023.3 8040.2 4731.8 4769.2 4775.0 4777.8 4795.1 7676.0 7695.9 7700.2 7704.1 7706.1 6459.3 7160.1 7377.9 7386.0 7401.3 7375.0 7391.8 7397.4 7400.9 7406.0 6935.4 7216.2 7229.7 7232.2 7235.6 7410.8 7427.8 7429.5 7433.6 7435.9 6036.6 7250.6 7270.4 7272.8 7299.1 01:26:37 INFO - 2015-11-24 01:26:37,123 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,123 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19237.54 Median:25109.94 stddev:27696.71 (110.3%) stddev-sans-first:27739.35 01:26:37 INFO - 2015-11-24 01:26:37,124 DEBUG : BROWSER_OUTPUT: Values: 678.5 774.2 786.7 790.0 828.8 15031.7 15291.2 15322.3 15324.6 15336.5 12257.7 14171.3 14214.6 14315.6 14359.6 650.9 756.1 758.8 806.8 978.1 958.3 971.5 974.7 975.0 975.9 975.1 1004.3 1004.5 1004.6 1008.6 780.7 796.4 807.0 994.3 997.1 752.8 759.1 759.5 759.7 762.3 14812.2 15019.5 15051.0 15055.8 15069.1 12680.7 12967.3 12974.7 13399.5 13443.2 10270.8 10300.3 10302.5 10327.6 10367.0 3535.7 3625.1 3625.6 3627.0 3635.7 76759.2 77509.6 80148.6 80165.0 80294.0 9935.0 9972.8 10010.6 10013.0 10349.6 21537.9 21749.5 21763.9 21774.6 21798.6 7311.0 7411.7 7425.3 7619.6 7867.8 3992.2 4041.8 4047.9 4049.0 4109.1 3639.6 3678.3 3681.6 3683.2 3695.2 635.1 639.3 645.2 645.8 647.7 478.4 516.1 545.6 569.3 603.4 8710.2 8725.9 8757.1 8825.9 8888.5 557.8 576.3 615.9 636.7 662.1 4099.2 4140.9 4167.6 4177.1 4283.9 99069.0 101059.0 102039.0 106123.0 107326.5 82621.0 84630.6 85091.0 86851.0 88034.6 71971.6 73747.6 75119.0 76244.6 79007.0 7797.5 9029.7 9070.4 9147.7 9278.5 48401.3 49703.8 53344.0 53447.5 53742.7 71793.0 73339.6 76634.0 76685.0 76888.2 10757.6 10927.3 11185.6 11289.3 11525.8 11996.9 11998.6 12006.7 12010.3 12410.3 11438.1 11459.9 11474.6 11477.8 11490.5 11053.6 11406.7 11496.1 11503.9 11507.2 9063.3 9288.7 11261.7 11292.6 11318.8 9954.6 10294.4 10338.3 10391.8 10476.6 7628.5 9566.1 9607.8 9623.0 9665.5 01:26:37 INFO - 2015-11-24 01:26:37,124 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:26:37 INFO - 2015-11-24 01:26:37,124 DEBUG : BROWSER_OUTPUT: 01:26:37 INFO - 2015-11-24 01:26:37,555 INFO : Browser exited with error code: 0 01:26:37 INFO - 2015-11-24 01:26:37,581 INFO : Completed test dromaeo_css (00:18:33) 01:26:37 INFO - 2015-11-24 01:26:37,581 INFO : Starting test kraken 01:26:37 INFO - 2015-11-24 01:26:37,581 DEBUG : operating with platform_type : mac_ 01:26:37 INFO - 2015-11-24 01:26:37,582 INFO : Initialising browser for kraken test... 01:26:37 INFO - 2015-11-24 01:26:37,594 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmppx4GJw/profile http://localhost:49266/getInfo.html 01:26:39 INFO - 2015-11-24 01:26:39,568 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:26:39 INFO - 2015-11-24 01:26:39,569 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:26:39 INFO - 2015-11-24 01:26:39,569 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:26:39 INFO - 2015-11-24 01:26:39,569 DEBUG : BROWSER_OUTPUT: __metrics 01:26:39 INFO - 2015-11-24 01:26:39,584 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:40 INFO - 2015-11-24 01:26:40,345 INFO : Browser initialized. 01:26:40 INFO - 2015-11-24 01:26:40,346 INFO : Running cycle 1/1 for kraken test... 01:26:40 INFO - 2015-11-24 01:26:40,346 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmppx4GJw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:26:52 INFO - 2015-11-24 01:26:52,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 226480128 01:26:52 INFO - 2015-11-24 01:26:52,260 DEBUG : BROWSER_OUTPUT: 01:26:54 INFO - 2015-11-24 01:26:54,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 01:26:55 INFO - 2015-11-24 01:26:55,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 277663744 01:26:55 INFO - 2015-11-24 01:26:55,540 DEBUG : BROWSER_OUTPUT: 01:26:58 INFO - 2015-11-24 01:26:58,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 01:26:58 INFO - 2015-11-24 01:26:58,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 291868672 01:26:58 INFO - 2015-11-24 01:26:58,675 DEBUG : BROWSER_OUTPUT: 01:27:01 INFO - 2015-11-24 01:27:01,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 01:27:02 INFO - 2015-11-24 01:27:02,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 279531520 01:27:02 INFO - 2015-11-24 01:27:02,458 DEBUG : BROWSER_OUTPUT: 01:27:04 INFO - 2015-11-24 01:27:04,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 01:27:04 INFO - 2015-11-24 01:27:04,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 279261184 01:27:04 INFO - 2015-11-24 01:27:04,896 DEBUG : BROWSER_OUTPUT: 01:27:06 INFO - 2015-11-24 01:27:06,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:27:07 INFO - 2015-11-24 01:27:07,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 280813568 01:27:07 INFO - 2015-11-24 01:27:07,485 DEBUG : BROWSER_OUTPUT: 01:27:10 INFO - 2015-11-24 01:27:10,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 01:27:10 INFO - 2015-11-24 01:27:10,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 281767936 01:27:10 INFO - 2015-11-24 01:27:10,809 DEBUG : BROWSER_OUTPUT: 01:27:13 INFO - 2015-11-24 01:27:13,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 01:27:14 INFO - 2015-11-24 01:27:14,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 282087424 01:27:14 INFO - 2015-11-24 01:27:14,157 DEBUG : BROWSER_OUTPUT: 01:27:16 INFO - 2015-11-24 01:27:16,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 01:27:17 INFO - 2015-11-24 01:27:17,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 283316224 01:27:17 INFO - 2015-11-24 01:27:17,386 DEBUG : BROWSER_OUTPUT: 01:27:18 INFO - 2015-11-24 01:27:18,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:27:19 INFO - 2015-11-24 01:27:19,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 315650048 01:27:19 INFO - 2015-11-24 01:27:19,477 DEBUG : BROWSER_OUTPUT: 01:27:21 INFO - 2015-11-24 01:27:21,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:27:22 INFO - 2015-11-24 01:27:22,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 316461056 01:27:22 INFO - 2015-11-24 01:27:22,074 DEBUG : BROWSER_OUTPUT: 01:27:24 INFO - 2015-11-24 01:27:24,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:27:24 INFO - 2015-11-24 01:27:24,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 324141056 01:27:24 INFO - 2015-11-24 01:27:24,707 DEBUG : BROWSER_OUTPUT: 01:27:27 INFO - 2015-11-24 01:27:27,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:27:27 INFO - 2015-11-24 01:27:27,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 325988352 01:27:27 INFO - 2015-11-24 01:27:27,856 DEBUG : BROWSER_OUTPUT: 01:27:30 INFO - 2015-11-24 01:27:30,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:27:30 INFO - 2015-11-24 01:27:30,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 324698112 01:27:30 INFO - 2015-11-24 01:27:30,827 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 01:27:32 INFO - 2015-11-24 01:27:32,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 385552384 01:27:32 INFO - 2015-11-24 01:27:32,718 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,718 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:27:32 INFO - 2015-11-24 01:27:32,718 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |0;ai-astar;102;108;112;90;145;154;153;136;110;118 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;119;141;152;120;142;138;117;155;116 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |2;audio-dft;181;182;185;182;184;184;184;185;185;180 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |3;audio-fft;60;71;78;73;54;56;59;69;73;53 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;79;86;119;75;75;74;113;77;74;109 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;87;88;87;86;86;86;128;93;88 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;94;94;94;94;94;95;95;95;94 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;84;87;84;84;84;84;85;84;85 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;53;56;56;54;55;54;54;62;52;52 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;66;90;91;93;55;84;90;93 01:27:32 INFO - 2015-11-24 01:27:32,719 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;82;80;82;81;81;80;97 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;118;120;127;116;109;119;115;122;125 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;129;121;129;133;134;151;128;133;132;121 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;63;64;64;63;63;66;64;63 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1033 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: __startTimestamp1448357252712__endTimestamp 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.80 Median:140.50 stddev:22.57 (16.1%) stddev-sans-first:22.65 01:27:32 INFO - 2015-11-24 01:27:32,720 DEBUG : BROWSER_OUTPUT: Values: 102.0 108.0 112.0 90.0 145.0 154.0 153.0 136.0 110.0 118.0 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:134.60 Median:141.50 stddev:15.16 (10.7%) stddev-sans-first:15.51 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: Values: 146.0 119.0 141.0 152.0 120.0 142.0 138.0 117.0 155.0 116.0 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.81 (1.0%) stddev-sans-first:1.74 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: Values: 181.0 182.0 185.0 182.0 184.0 184.0 184.0 185.0 185.0 180.0 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.60 Median:70.00 stddev:9.16 (13.1%) stddev-sans-first:9.56 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: Values: 60.0 71.0 78.0 73.0 54.0 56.0 59.0 69.0 73.0 53.0 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.10 Median:75.00 stddev:18.14 (24.2%) stddev-sans-first:18.94 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: Values: 79.0 86.0 119.0 75.0 75.0 74.0 113.0 77.0 74.0 109.0 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:87.00 stddev:13.00 (14.9%) stddev-sans-first:13.63 01:27:32 INFO - 2015-11-24 01:27:32,721 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 88.0 87.0 86.0 86.0 86.0 128.0 93.0 88.0 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 87.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:2.90 (5.3%) stddev-sans-first:3.00 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: Values: 53.0 56.0 56.0 54.0 55.0 54.0 54.0 62.0 52.0 52.0 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.70 Median:90.00 stddev:15.25 (16.9%) stddev-sans-first:14.93 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 66.0 90.0 91.0 93.0 55.0 84.0 90.0 93.0 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,722 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:5.05 (6.2%) stddev-sans-first:5.32 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 82.0 80.0 82.0 81.0 81.0 80.0 97.0 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.00 stddev:6.98 (5.8%) stddev-sans-first:5.43 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: Values: 134.0 118.0 120.0 127.0 116.0 109.0 119.0 115.0 122.0 125.0 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.10 Median:132.50 stddev:8.40 (6.3%) stddev-sans-first:8.87 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: Values: 129.0 121.0 129.0 133.0 134.0 151.0 128.0 133.0 132.0 121.0 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 63.0 64.0 64.0 63.0 63.0 66.0 64.0 63.0 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:27:32 INFO - 2015-11-24 01:27:32,723 DEBUG : BROWSER_OUTPUT: 01:27:33 INFO - 2015-11-24 01:27:33,327 INFO : Browser exited with error code: 0 01:27:33 INFO - 2015-11-24 01:27:33,372 INFO : Completed test kraken (00:00:55) 01:27:33 INFO - 2015-11-24 01:27:33,372 INFO : Starting test v8_7 01:27:33 INFO - 2015-11-24 01:27:33,372 DEBUG : operating with platform_type : mac_ 01:27:33 INFO - 2015-11-24 01:27:33,372 INFO : Initialising browser for v8_7 test... 01:27:33 INFO - 2015-11-24 01:27:33,384 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmppDaK7Z/profile http://localhost:49266/getInfo.html 01:27:35 INFO - 2015-11-24 01:27:35,395 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:27:35 INFO - 2015-11-24 01:27:35,395 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:27:35 INFO - 2015-11-24 01:27:35,395 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:27:35 INFO - 2015-11-24 01:27:35,395 DEBUG : BROWSER_OUTPUT: __metrics 01:27:35 INFO - 2015-11-24 01:27:35,417 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:27:36 INFO - 2015-11-24 01:27:36,197 INFO : Browser initialized. 01:27:36 INFO - 2015-11-24 01:27:36,197 INFO : Running cycle 1/1 for v8_7 test... 01:27:36 INFO - 2015-11-24 01:27:36,198 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmppDaK7Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:27:48 INFO - 2015-11-24 01:27:48,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 226668544 01:27:48 INFO - 2015-11-24 01:27:48,175 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 628436992 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: |0;Richards;174.82517482517483 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.72002571520412 01:28:09 INFO - 2015-11-24 01:28:09,893 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4704.225352112676 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1706.4846416382252 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: |6;Boyer;14838.235294117647 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: |7;RegExp;26947.36842105263 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: |8;Splay;658.1196581196581 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4926.108374384236 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: __startTimestamp1448357289888__endTimestamp 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:28:09 INFO - 2015-11-24 01:28:09,894 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.83 Median:174.83 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: Values: 174.8 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.72 Median:160.72 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: Values: 160.7 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: Values: 279.1 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4704.23 Median:4704.23 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: Values: 4704.2 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,895 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1706.48 Median:1706.48 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: Values: 1706.5 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: Values: 786.8 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14838.24 Median:14838.24 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: Values: 14838.2 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: Values: 26947.4 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:658.12 Median:658.12 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,896 DEBUG : BROWSER_OUTPUT: Values: 658.1 01:28:09 INFO - 2015-11-24 01:28:09,897 DEBUG : BROWSER_OUTPUT: 01:28:09 INFO - 2015-11-24 01:28:09,897 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4926.11 Median:4926.11 stddev:0.00 (0.0%) 01:28:09 INFO - 2015-11-24 01:28:09,897 DEBUG : BROWSER_OUTPUT: Values: 4926.1 01:28:09 INFO - 2015-11-24 01:28:09,897 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:28:09 INFO - 2015-11-24 01:28:09,897 DEBUG : BROWSER_OUTPUT: 01:28:10 INFO - 2015-11-24 01:28:10,521 INFO : Browser exited with error code: 0 01:28:10 INFO - 2015-11-24 01:28:10,539 INFO : Completed test v8_7 (00:00:37) 01:28:10 INFO - 2015-11-24 01:28:10,889 INFO : Completed test suite (00:20:06) 01:28:10 INFO - 2015-11-24 01:28:10,889 DEBUG : Working with test: dromaeo_css 01:28:10 INFO - 2015-11-24 01:28:10,889 DEBUG : Generating results file: dromaeo_css 01:28:10 INFO - 2015-11-24 01:28:10,890 DEBUG : Working with test: kraken 01:28:10 INFO - 2015-11-24 01:28:10,890 DEBUG : Generating results file: kraken 01:28:10 INFO - 2015-11-24 01:28:10,890 INFO : javascript benchmark 01:28:10 INFO - 2015-11-24 01:28:10,890 DEBUG : Working with test: v8_7 01:28:10 INFO - 2015-11-24 01:28:10,890 DEBUG : Generating results file: v8_7 01:28:10 INFO - 2015-11-24 01:28:10,891 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:28:11 INFO - 2015-11-24 01:28:11,315 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 01:28:11 INFO - 2015-11-24 01:28:11,315 DEBUG : process_Request line: dromaeo_css 7610.42 graph.html#tests=[[72,64,59]] 01:28:11 INFO - 2015-11-24 01:28:11,315 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:28:11 INFO - 2015-11-24 01:28:11,342 DEBUG : process_Request line: kraken 1395.40 graph.html#tests=[[232,64,59]] 01:28:11 INFO - 2015-11-24 01:28:11,342 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:28:11 INFO - 2015-11-24 01:28:11,368 DEBUG : process_Request line: v8_7 19897.04 graph.html#tests=[[230,64,59]] 01:28:11 INFO - 2015-11-24 01:28:11,369 INFO : javascript benchmark 01:28:11 INFO - 2015-11-24 01:28:11,370 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3372.949405758913, 3437.8109203993786, 3461.757676962612, 3463.35927853347, 3502.194495266089, 5568.749406276717, 5662.405447428023, 5735.1110577860445, 5801.448862358075, 5808.622439541432, 5639.238702775124, 5699.772009119641, 5775.047117225663, 5868.17845501629, 5911.408859114086, 5110.591152707774, 5141.228815677659, 5173.689578625294, 5190.299309593194, 5256.553192978601, 5276.2085687146855, 5306.0, 5316.946830531684, 5327.307450031491, 5353.357597088355, 5084.77118529667, 5166.870828229286, 5207.4792520748, 5234.92147617786, 5253.185756207794, 5184.792608295664, 5213.4004589472315, 5220.29526013987, 5221.06020916235, 5229.816956406507, 5103.413107492649, 5194.71429071401, 5198.766055527511, 5199.4800519948085, 5210.609204309654, 5568.136938774456, 5707.714614269312, 5746.626469279525, 5768.2501274834, 5776.306843178803, 6264.9686751566405, 6288.119663247149, 6302.590331628476, 6309.936900630981, 6313.273973493061, 6068.089786532011, 6284.622922624657, 6292.087647291163, 6297.811065668037, 6302.432781049682, 5827.184194212814, 5863.618864773819, 5873.676947767871, 5929.110633405024, 5953.285605727254, 6243.157173781572, 6302.590331628429, 6305.779297724649, 6311.621302721851, 6318.494520438354, 5902.6458412495385, 6152.753889844356, 6173.59871608344, 6178.0, 6198.659073750987, 6105.511559075263, 6177.135201071854, 6187.102870083812, 6189.84525386869, 6221.906671399933, 6202.2867370253, 6203.348648391944, 6238.469730072995, 6238.500919926395, 6261.8747625047245, 6120.7551697931585, 6229.626222426669, 6232.594881332699, 6238.1266622672865, 6250.218722659668, 4819.734914579662, 4901.705897646153, 4919.163742163841, 4933.210686290176, 4966.205407134841, 4405.977970110129, 4423.933640995388, 4461.308497182942, 4477.462704475419, 4486.977565112219, 5531.640443371168, 5751.683657398883, 5767.077267637242, 5769.85575360611, 5777.566682498829, 6098.619994938517, 6222.315545290015, 6239.563230573907, 6255.061740738925, 6270.15352927349, 5072.492750724898, 5604.907043126633, 5735.0, 5766.221560089334, 5769.1634712967225, 5259.395169555473, 5439.646422982493, 5440.401555828856, 5445.891082178414, 5463.371712253142, 6174.135621013062, 6263.154474146023, 6266.49868010558, 6281.089242059968, 6281.12064311006, 6112.786052488142, 6125.850951268649, 6138.79981218981, 6142.805741014737, 6148.661823599745, 6241.251049874044, 6282.654454005074, 6322.810315690536, 6348.650824204713, 6360.522960778053, 6129.908051379144, 6142.692865356625, 6147.323794382525, 6154.046122850965, 6157.32269450369, 6021.397860214119, 6116.548817443993, 6127.414320899048, 6183.0, 6202.28673702512, 5172.7413629319135, 6008.519318454426, 6028.306744724413, 6044.667543285162, 6053.727582258721, 6081.452669259788, 6082.756689732361, 6083.66539840313, 6097.695115244309, 6150.7847225346895, 5817.447342502455, 5950.404959504015, 5956.344802071855, 5984.730687119003, 6025.397460253939, 6006.819795406145, 6087.107581585805, 6109.033772226435, 6114.054067497291, 6127.958561426818, 6032.90950635732, 6056.0, 6063.545234107548, 6067.878642427038, 6069.787557435468], "unit": "ms", "name": "dojo.html", "value": 5704.118110419235}, {"lowerIsBetter": false, "replicates": [517.0995416617699, 565.3018522125177, 606.8968275393182, 633.9968300158498, 636.7134789344796, 25098.874505627467, 32373.543190556422, 40662.796686016525, 41024.5641402551, 41032.79483602578, 43284.783576082154, 43587.564124358745, 43700.0, 43818.56181438185, 43819.342709859375, 8781.42920710155, 9729.124378805924, 9923.851142232872, 9931.354461959985, 9940.751481212992, 8785.472871627722, 8863.955680221623, 11847.881521184807, 11969.0, 12017.158798884082, 11702.707432314175, 11809.291442513477, 11821.231619944676, 11825.822612660773, 11827.40862956853, 8837.690680826141, 11719.414029298501, 11807.350595717233, 11841.0, 11868.703282417922, 8763.16749908764, 8882.644694212288, 8888.955555222183, 8928.866067009, 11765.294082355085, 40995.795021025006, 41399.379009314885, 41409.75770726883, 41655.375169372484, 41665.0, 3232.9676703233135, 3280.16355829262, 3325.0, 3511.3855075361707, 3589.4795254688183, 27867.581986270223, 28718.85640571805, 29181.124566263046, 29225.853870730723, 29299.560506592417, 2535.4168541235435, 2569.6530968319225, 2793.776497880185, 2833.4758069757163, 2892.3781387001686, 485535.0, 492193.53903230256, 493455.0, 495661.0, 497114.0, 65134.674326629014, 65458.34541654618, 65628.0, 65648.67175664187, 65693.0, 69224.6538767303, 69411.65294173599, 69508.65245673739, 69549.95675064878, 69603.65198173976, 15898.205089745697, 16044.75932861008, 16079.196040197943, 16092.356305747639, 16101.95337303095, 12240.632781016584, 12318.260904345769, 12326.50693972231, 12326.81509777354, 12329.630111096682, 18893.33873314455, 19774.90112549457, 19846.801531984784, 19870.0, 19870.907100109343, 9014.053524379977, 9035.960864500667, 9170.633174673072, 9184.90815091854, 9197.126273004054, 815.3925325632442, 973.6300205921705, 1092.7650555130685, 1097.9011888930036, 1143.1312202725987, 29016.564751528746, 29229.415411691647, 29232.0, 29834.0, 29857.701422985927, 1038.9116925061303, 1115.1691989467736, 1120.798256313855, 1135.7274254179104, 1185.199990006742, 15794.447194348142, 15867.285972131282, 16011.09996456384, 16223.0, 16246.431374901822, 433126.0, 519838.0, 525151.0, 525177.0, 527586.0, 51573.48426515687, 52149.0, 58539.82920341569, 59063.11405328924, 59336.703316484, 1437.6549628089392, 1457.8469260727684, 1466.5600319903986, 1477.8152730908637, 1480.504031149577, 26273.0, 27947.58078628863, 28453.146405607866, 28993.42013159767, 29006.56490152607, 53195.0, 53640.463595363544, 53715.46284537261, 53730.46269537411, 53745.73127134339, 354423.0, 359152.0, 361168.0, 361458.0, 361775.19112404267, 31536.684633153374, 31583.842080789447, 31903.0, 31906.52140217852, 31993.840030799696, 45193.32210016918, 45511.77244113758, 46298.0, 46543.767281163375, 46594.0, 35480.290394191456, 36209.27581448409, 37515.62484375121, 38469.23061538809, 38569.0, 36666.63333366739, 37436.625633743315, 37636.81181594184, 37661.435078473296, 37719.81140094282, 36569.63430365769, 37530.437043443824, 37668.43497347597, 37692.0, 37845.0, 30960.845195773876, 31085.222869428446, 32769.18077047997, 33514.0, 33520.83239583787, 23221.651675224548, 24526.14158504444, 24650.383740405916, 25193.748062519142, 25217.0], "unit": "ms", "name": "ext.html", "value": 20073.525355257203}, {"lowerIsBetter": false, "replicates": [357.458450447572, 359.6349705049375, 362.3116079449047, 362.8149643681721, 363.13935971746963, 16160.191990400492, 17046.659066818655, 20130.396088117344, 20169.0, 21012.264570740026, 11154.498047587858, 11345.43272836359, 11346.71633209168, 19629.90185049073, 20009.699854502192, 5253.4221235664045, 5401.945980540203, 5406.648567843077, 5407.945920540803, 5408.756605952722, 4017.919641607166, 4119.423280740683, 4133.049398638315, 5349.144136938091, 5838.182654428383, 5926.703664816763, 5962.0162673158875, 5989.191459153002, 5990.910136347937, 5996.760129594811, 6111.511079113682, 6452.935470645304, 6453.2256129264315, 6461.6123032617725, 6461.6446095464735, 5309.3894202166475, 5659.0, 5665.773369065232, 5670.432956704338, 5674.375818659944, 23368.94839732216, 23829.642555361683, 23989.52020959571, 24173.0, 24563.877180614163, 2036.1448191759348, 2070.234013415031, 2090.3833369156137, 2118.152738904435, 2121.0137286161853, 7800.609969501502, 9663.371880827724, 9840.557174927146, 11595.420228988516, 14005.789913151311, 1712.101146897876, 1715.2967283413866, 1759.2347328911965, 1808.114024128181, 1869.5045812859603, 85607.0, 87355.25289494175, 87511.56244218738, 93408.0, 97525.51237243839, 10511.474426278808, 10866.61966831157, 11027.503762330714, 11062.834057489144, 11123.944380278046, 13365.26491043002, 13373.66565835862, 13375.197488150741, 13379.397927093305, 13404.798928015893, 8282.50304981703, 8361.707340243183, 8368.0, 8387.916120838836, 8427.95786021066, 6183.1450564830375, 8327.00075990885, 8370.497770133812, 8378.622961966727, 8428.199321064489, 4387.990762124666, 4391.451068616423, 4399.560043995639, 4400.603945644843, 4413.845515406945, 1535.6237721758241, 1760.5862622283753, 1819.3905041810876, 1819.5178277756406, 1842.4656849513758, 393.2155350076616, 846.4624963148445, 850.5279569838799, 988.3378136648463, 1094.3433939636313, 11298.0, 11480.655580332603, 11688.883111168949, 11702.122340824471, 11749.4712737927, 417.4635593262643, 426.098801035807, 437.23265668751776, 439.43093693666776, 446.9307257375112, 5166.095933211673, 5943.3462319144855, 5948.583599148018, 6016.849578760479, 6032.336442991267, 592947.0, 660206.0, 753396.0, 761445.0, 771340.0, 119625.40187299007, 122852.38573807073, 124287.0, 125951.3702431482, 126692.0, 1163.313644949484, 1189.262657152571, 1202.1524824998355, 1204.933728644933, 1207.7524107557929, 18394.540136496693, 18698.0, 18761.718574221126, 18981.905090474458, 19356.32252871143, 41922.95192620209, 50747.47757567279, 50953.98092038064, 51230.23154652608, 52516.47483525116, 64680.0297995521, 67207.0, 68340.31659683339, 68384.0, 69128.0, 9864.112229899343, 9892.208623309974, 10010.44942528168, 10052.547635356574, 10081.042300981395, 18815.90592047031, 19252.90373548123, 19346.8065319345, 19943.800561994194, 20052.09765560524, 15462.304196310968, 15557.688846222785, 15716.764248536052, 16283.837161628706, 16414.850960432654, 13384.464621415034, 15104.622384440478, 15599.986000910358, 15711.371545138067, 15894.761578576099, 15819.288132033857, 16018.519444416686, 16213.59466013312, 16413.91793041075, 16482.83517164813, 9092.545372731205, 9830.4101753895, 9937.850932235877, 9947.701568952943, 10285.74285642865, 12142.75714485723, 16302.184890755652, 16305.836941630907, 16339.019658820509, 16344.264508096927], "unit": "ms", "name": "jquery.html", "value": 9264.68847121669}, {"lowerIsBetter": false, "replicates": [1587.2143289071912, 1592.2834724374034, 1691.450278659436, 1887.886147173168, 1910.5128192310958, 7825.178356272595, 8076.232757888006, 8519.233269005788, 8628.007779105405, 8647.567621618926, 8467.195616416431, 8515.105913879032, 8542.0, 8561.486310821356, 8577.44246623969, 2382.1781485387555, 2406.9037238510437, 2408.1451084864884, 2410.8794560272004, 2412.589859723851, 2314.409825494505, 2412.1316326122583, 2432.4770174412497, 2450.9387265318333, 2452.3256104571205, 2369.95260094798, 2399.4601214726636, 2403.6875206223167, 2404.230646193219, 2410.7348191698898, 2352.1649814316015, 2372.7034120734907, 2385.7494963028894, 2394.2697477269426, 2397.6283676030157, 2382.6902502674716, 2393.5930891748444, 2404.843685160459, 2412.7587241275905, 2413.662087307778, 7623.0, 8482.957585212096, 8524.786880328042, 8530.445521041112, 8551.914480855174, 4816.253480710496, 4872.293517439952, 5030.0694371541385, 5139.948600514022, 5142.460041695643, 3466.843992020365, 3539.203679172191, 3583.1937813991904, 3622.9094272643133, 3631.0014745944814, 914.9634014639473, 1049.4280617063641, 1090.6673464593296, 1456.9728341519203, 1656.7349224124202, 11328.490217940212, 11381.918717721803, 11394.25937314072, 11394.373309467976, 11447.484863181176, 4547.681662283675, 4556.544345565417, 4635.119327327797, 4638.095571363552, 4664.953350466452, 9261.444313341086, 9270.90729092714, 9271.629134834666, 9278.304127190488, 9286.257099432029, 5158.200478925697, 5177.430482646982, 5187.610929180327, 5190.961807638412, 5191.766370513336, 4783.928241076386, 4795.20879054952, 4798.448178459522, 4799.352087468217, 4809.0, 3591.6049234584175, 3624.9637503625154, 3674.3569875272256, 3701.0747313171705, 3739.607341229186, 979.4123525884555, 1135.5117299561268, 1139.732162941708, 1141.4292853573213, 1147.6614398752388, 1245.2155142260317, 1334.873187047229, 1349.352310890778, 1403.3193900958026, 1405.8945579081405, 8100.878486822702, 8152.796180095545, 8167.836643267101, 8240.258376746122, 8365.916340836635, 1189.2448295332526, 1193.373478923572, 1207.7342984543386, 1224.4999875153044, 1232.7103130764262, 6145.4161854623735, 6235.563510554309, 6355.491560675135, 6411.166548348778, 6422.518311126684, 10196.082352588302, 10354.741131471774, 10391.584336626602, 10427.270091093702, 10456.947715261374, 10023.448710321003, 10288.588456461808, 10306.587736490606, 10318.896811031944, 10492.737681558023, 8058.717944871902, 8094.919050809652, 8112.148224436467, 8159.877601835978, 8170.7957301067945, 7859.0, 8056.83886322282, 8077.434579579608, 8083.878741818759, 8090.555019473985, 9239.815203695754, 9327.720168394959, 9360.719178424659, 9370.062993700576, 9372.812543749224, 9330.393524420891, 9599.856002160113, 9599.904000960181, 9678.661246856327, 9715.125638692269, 7082.929170708227, 7174.928250717635, 7537.811554710956, 7545.0, 7561.886571701539, 8165.265126138676, 8269.00771907375, 8273.46222495536, 8279.668813247403, 8290.253877151084, 7548.773536793905, 7662.655180517002, 7689.3848492121615, 7735.883961740691, 7793.10379306387, 7442.367398771165, 7499.88750168737, 7505.399568034653, 7644.426667999811, 7659.272369124924, 7701.383889288732, 7736.342410895137, 7740.109887363025, 7748.263914928073, 7759.030121234846, 6903.0680858083515, 7005.859882802213, 7009.088818453569, 7012.614306213207, 7030.0, 7077.5753454792875, 7102.254263302279, 7104.573725576482, 7109.8578028438105, 7125.75059872902], "unit": "ms", "name": "mootools.html", "value": 4885.941147365922}, {"lowerIsBetter": false, "replicates": [287.6246498319692, 314.04843324726073, 319.9394008860627, 322.07564290486306, 333.9315440334732, 6082.45257926786, 6574.605523668577, 6662.933370666292, 6712.160979877515, 6796.25241223465, 6624.701888415033, 6644.172852465575, 6739.157605299338, 6787.694553745081, 6797.0144329072255, 4855.684380515273, 4871.293662418947, 4891.584215341701, 4891.951080489203, 4900.142475066867, 4004.7196696231276, 4723.17344464719, 4803.3515475410895, 4822.614190864722, 4886.926696099561, 4844.878878028042, 4858.174110401223, 4906.582940450066, 4933.7286449245275, 4935.901281974358, 4898.069366820293, 4898.412190537123, 4905.994271174419, 4914.582260507861, 4920.655554111214, 4153.1486045360625, 4154.709170358076, 4155.771432571208, 4162.521310049353, 4163.604457576525, 6383.2978372379, 6586.967065164644, 6618.569792963442, 6628.3371662833815, 6670.3329667033395, 5836.358000619928, 5874.383189765056, 5879.941200588025, 5888.263967004124, 5904.5571582131515, 6915.308469153045, 7201.387882030033, 7379.1145062592295, 7382.852342953111, 7398.149212840538, 4436.55634436557, 4616.630669546462, 4633.193054708667, 4636.582707556302, 4637.281221410687, 7609.162992070867, 7739.264769846855, 7758.573278469738, 7760.185180556016, 7768.145503994556, 4621.329907163443, 4695.718256904596, 4726.676530571445, 4736.147493451212, 4736.73947932867, 4823.855284341475, 4829.323894654751, 4836.177849765549, 4837.564619184291, 4843.878903027453, 5814.720761432478, 5821.330546987151, 5828.329742079631, 5837.387074357216, 5842.766289348463, 7369.81575460607, 7377.520461170114, 7378.520396174339, 7398.0, 7399.408047356199, 1506.9698606028037, 1610.6617610301732, 1621.1326940087233, 1678.8992660440413, 1684.3515246630136, 1045.247561255098, 1055.8363453664695, 1058.3596923861107, 1063.292910214714, 1065.1053115383115, 6837.521373503906, 6859.588424694534, 6878.449724022066, 6881.931180688229, 6901.930980690229, 6728.663566821737, 7735.574543400167, 7737.071551413754, 7739.993800805859, 7752.612369381621, 5414.83755487336, 6836.829079272959, 6837.794866154023, 6849.1780986281965, 6875.3812156906115, 4050.311447054008, 4100.5899410059355, 4104.322786740214, 4107.240160570304, 4111.9177616447505, 8011.1588283230585, 8026.197380262044, 8027.036755589366, 8027.719029833927, 8030.23712747288, 7658.195889431641, 7988.600569971478, 8004.199580041949, 8011.198880111942, 8012.759617211493, 7683.769486915401, 7994.200579942076, 7995.7601271960775, 7996.64015119321, 8001.479903806234, 7086.539374940819, 7633.809154771176, 7648.196939321291, 7650.387968962358, 7781.182975787688, 7575.166731659623, 7604.277593628596, 7606.733764318223, 7608.353289970414, 7621.12357078943, 7766.534007959541, 8009.559474228973, 8011.038675358995, 8023.277904988579, 8040.236177563356, 4731.84069902876, 4769.165396055607, 4775.0, 4777.784999675093, 4795.112904112751, 7675.963744894368, 7695.92304076952, 7700.19147989453, 7704.075510938723, 7706.075270967295, 6459.257185423548, 7160.10498687664, 7377.926220737724, 7386.0, 7401.259874012771, 7375.041244638162, 7391.815204619712, 7397.445191610543, 7400.925990740239, 7405.9629701851145, 6935.445164386938, 7216.221754624403, 7229.710811567478, 7232.240614735377, 7235.565866048054, 7410.777676669709, 7427.8143046424275, 7429.4799364044, 7433.628318584158, 7435.888461672971, 6036.607620504653, 7250.637468126467, 7270.418366530559, 7272.818179545554, 7299.087614048244], "unit": "ms", "name": "prototype.html", "value": 5306.320907433293}, {"lowerIsBetter": false, "replicates": [678.5148618737603, 774.1600363605488, 786.6656670914862, 789.992100078999, 828.7679449754067, 15031.699366012686, 15291.235438228072, 15322.310496027678, 15324.61688457789, 15336.46322378717, 12257.693557661063, 14171.291435428238, 14214.573562793134, 14315.568443155678, 14359.64100897478, 650.8568115014689, 756.0549313358302, 758.8216769059294, 806.822499050208, 978.1441238915949, 958.324381311174, 971.4996776660025, 974.7027156717198, 974.9714051675479, 975.8682577852005, 975.1467465967279, 1004.3271008424337, 1004.5379125602232, 1004.5780772075709, 1008.5814387029374, 780.6955287437904, 796.4345314826451, 807.04365327087, 994.328828041073, 997.0527998401511, 752.8306131120454, 759.1270039454671, 759.5063208914195, 759.6657470712869, 762.3253420722644, 14812.185329806856, 15019.549413517612, 15051.0, 15055.774163387558, 15069.09585424878, 12680.68298292541, 12967.286799226038, 12974.740505189844, 13399.531016414476, 13443.193408395528, 10270.794584108276, 10300.27898047137, 10302.536385862653, 10327.638532651321, 10367.0, 3535.7112783146645, 3625.1299688074937, 3625.5830579483168, 3626.9637303627155, 3635.6727894489622, 76759.23240767576, 77509.61245193794, 80148.59925700392, 80165.0, 80294.0, 9934.950325248472, 9972.80054398908, 10010.599576016877, 10013.048760367754, 10349.586016559404, 21537.892310538347, 21749.456263593536, 21763.891180543997, 21774.564508710053, 21798.56402871934, 7311.049563556704, 7411.6664750086375, 7425.294597013275, 7619.580923049175, 7867.842643147105, 3992.2215168041953, 4041.777702226347, 4047.9392809107885, 4048.959510404917, 4109.0959988802415, 3639.5996440391536, 3678.33789917812, 3681.5950245472977, 3683.226522430266, 3695.150115473456, 635.1330433957614, 639.3223183425583, 645.1580687203151, 645.8191706322237, 647.7057111351708, 478.4187212536784, 516.1251678405142, 545.6180673528546, 569.313976658126, 603.387561624951, 8710.172533609297, 8725.869111963326, 8757.080506546848, 8825.911740882637, 8888.511131887679, 557.8369100425658, 576.2623841482908, 615.8583525789004, 636.7484843486797, 662.102850637389, 4099.159672267178, 4140.855070072533, 4167.5832416758085, 4177.10192308649, 4283.871483855427, 99069.0, 101059.0, 102038.95922081517, 106123.0, 107326.46336768266, 82621.0, 84630.57684711537, 85091.0, 86851.0, 88034.55982720046, 71971.6401418, 73747.63126184442, 75119.0, 76244.61877690686, 79007.0, 7797.493162944391, 9029.729108126767, 9070.365074444726, 9147.725568232963, 9278.489683067495, 48401.305954291434, 49703.75148124236, 53344.0, 53447.46552534425, 53742.73128634332, 71793.0, 73339.63330183529, 76634.0, 76685.0, 76888.2311176881, 10757.623483178051, 10927.289726167774, 11185.552577897119, 11289.322640641587, 11525.827112593486, 11996.940015299868, 11998.58004969822, 12006.699832503908, 12010.33943133136, 12410.317432540936, 11438.084953203557, 11459.885401145882, 11474.598389056677, 11477.827832582685, 11490.540378385105, 11053.613123540637, 11406.714832129263, 11496.137789665641, 11503.884961150281, 11507.194496385173, 9063.274938005075, 9288.72133835986, 11261.71845703864, 11292.60475883373, 11318.830217546909, 9954.55204515784, 10294.433806140734, 10338.328008679411, 10391.84412233802, 10476.580936762444, 7628.46600737943, 9566.13904748576, 9607.759806004906, 9623.0, 9665.468399238109], "unit": "ms", "name": "yui.html", "value": 7063.675213488228}], "name": "dromaeo_css", "value": 7610.414610701277}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [102.0, 108.0, 112.0, 90.0, 145.0, 154.0, 153.0, 136.0, 110.0, 118.0], "unit": "ms", "name": "ai-astar", "value": 122.8}, {"lowerIsBetter": true, "replicates": [146.0, 119.0, 141.0, 152.0, 120.0, 142.0, 138.0, 117.0, 155.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 134.6}, {"lowerIsBetter": true, "replicates": [181.0, 182.0, 185.0, 182.0, 184.0, 184.0, 184.0, 185.0, 185.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [60.0, 71.0, 78.0, 73.0, 54.0, 56.0, 59.0, 69.0, 73.0, 53.0], "unit": "ms", "name": "audio-fft", "value": 64.6}, {"lowerIsBetter": true, "replicates": [79.0, 86.0, 119.0, 75.0, 75.0, 74.0, 113.0, 77.0, 74.0, 109.0], "unit": "ms", "name": "audio-oscillator", "value": 88.1}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 88.0, 87.0, 86.0, 86.0, 86.0, 128.0, 93.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 91.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 87.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 84.5}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 56.0, 54.0, 55.0, 54.0, 54.0, 62.0, 52.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 66.0, 90.0, 91.0, 93.0, 55.0, 84.0, 90.0, 93.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 78.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 80.0, 82.0, 81.0, 81.0, 80.0, 97.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [134.0, 118.0, 120.0, 127.0, 116.0, 109.0, 119.0, 115.0, 122.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 129.0, 133.0, 134.0, 151.0, 128.0, 133.0, 132.0, 121.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 131.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 63.0, 64.0, 64.0, 63.0, 63.0, 66.0, 64.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1395.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [174.82517482517483], "unit": "score", "name": "Richards", "value": 201.9274400000001}, {"lowerIsBetter": false, "replicates": [160.72002571520412], "unit": "score", "name": "DeltaBlue", "value": 411.38619600000015}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [4704.225352112676], "unit": "score", "name": "Decrypt", "value": 56.58338622754488}, {"lowerIsBetter": false, "replicates": [1706.4846416382252], "unit": "score", "name": "RayTrace", "value": 433.633554}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [14838.235294117647], "unit": "score", "name": "Boyer", "value": 44.915246778989115}, {"lowerIsBetter": false, "replicates": [26947.36842105263], "unit": "score", "name": "RegExp", "value": 33.80608398437501}, {"lowerIsBetter": false, "replicates": [658.1196581196581], "unit": "score", "name": "Splay", "value": 123.82398701298706}, {"lowerIsBetter": false, "replicates": [4926.108374384236], "unit": "score", "name": "NavierStokes", "value": 301.25200000000024}], "name": "v8_7", "value": 19897.042271648712}]} 01:28:11 INFO - RETURN: dromaeo_css: 7610.42 01:28:11 INFO - RETURN: kraken: 1395.40 01:28:11 INFO - RETURN: v8_7: 19897.04 01:28:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "19897.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1395.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7610.42"}}} 01:28:11 INFO - Return code: 0 01:28:11 INFO - # TBPL SUCCESS # 01:28:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:28:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:28:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:28:11 INFO - 2015-11-24 01:28:11.446 screenresolution[1678:10653] starting screenresolution argv=screenresolution get 01:28:11 INFO - 2015-11-24 01:28:11.449 screenresolution[1678:10653] Display 0: 1600x1200x32@60 01:28:11 INFO - 2015-11-24 01:28:11.454 screenresolution[1679:10656] starting screenresolution argv=screenresolution list 01:28:11 INFO - Available Modes on Display 0 01:28:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:28:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:28:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:28:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:28:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:28:11 INFO - Intel Iris: 01:28:11 INFO - Chipset Model: Intel Iris 01:28:11 INFO - Type: GPU 01:28:11 INFO - Bus: Built-In 01:28:11 INFO - VRAM (Dynamic, Max): 1536 MB 01:28:11 INFO - Vendor: Intel (0x8086) 01:28:11 INFO - Device ID: 0x0a2e 01:28:11 INFO - Revision ID: 0x0009 01:28:11 INFO - Displays: 01:28:11 INFO - Display: 01:28:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:28:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:28:11 INFO - Display Serial Number: 1600x1200 60 01:28:11 INFO - Main Display: Yes 01:28:11 INFO - Mirror: Off 01:28:11 INFO - Online: Yes 01:28:11 INFO - Rotation: Supported 01:28:11 INFO - Return code: 0 01:28:11 INFO - Running post-action listener: _resource_record_post_action 01:28:11 INFO - Running post-run listener: _resource_record_post_run 01:28:12 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 33734144; Write bytes: 695163904; Read time: 354; Write time: 2088 01:28:12 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334221824; Write bytes: 338663424; Read time: 26048; Write time: 665 01:28:12 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 32812544; Write bytes: 344953856; Read time: 340; Write time: 1389 01:28:12 INFO - Running post-run listener: _upload_blobber_files 01:28:12 INFO - Blob upload gear active. 01:28:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:28:12 INFO - Copying logs to upload dir... 01:28:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1303.795270 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2015-11-24 01:28:12.801176) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:28:12.804451) ========= 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.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009440 build_url: 'https://queue.taskcluster.net/v1/task/Py3SXGgDSPGAHRvAV7fxuQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:28:12.827801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:28:12.828167) ========= 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.yj9K201HEj/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.wwkHaEoX9H/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005039 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:28:12.878472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:28:12.878815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:28:12.879231) ========= ========= Total master_lag: 0.27 =========