builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0034 starttime: 1448111366.73 results: success (0) buildid: 20151121030232 builduid: 19fe30bfdb0a4633ad6952d5b4ce1f41 revision: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.729783) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.730236) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.730597) ========= 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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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.005855 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.778716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.779022) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.836271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.836575) ========= 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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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.005451 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.896247) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.896560) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.896919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:26.897201) ========= 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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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-21 05:09:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-21 05:09:27 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:27.101337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:27.101661) ========= 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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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.018844 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:27.152651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 05:09:27.153045) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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-21 05:09:27,224 truncating revision to first 12 chars 2015-11-21 05:09:27,224 Setting DEBUG logging. 2015-11-21 05:09:27,224 attempt 1/10 2015-11-21 05:09:27,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f5afaf4e6b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 05:09:28,326 unpacking tar archive at: mozilla-central-3f5afaf4e6b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.340488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 05:09:28.517395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:28.517911) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:28.534182) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:28.534611) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 05:09:28.535083) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2015-11-21 05:09:28.535403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:09:28 INFO - MultiFileLogger online at 20151121 05:09:28 in /builds/slave/test 05:09:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:09:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:28 INFO - {'append_to_log': False, 05:09:28 INFO - 'base_work_dir': '/builds/slave/test', 05:09:28 INFO - 'blob_upload_branch': 'Firefox', 05:09:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:28 INFO - 'branch': 'Firefox', 05:09:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:28 INFO - 'config_files': ('talos/mac_config.py',), 05:09:28 INFO - 'default_actions': ('clobber', 05:09:28 INFO - 'read-buildbot-config', 05:09:28 INFO - 'download-and-extract', 05:09:28 INFO - 'populate-webroot', 05:09:28 INFO - 'create-virtualenv', 05:09:28 INFO - 'install', 05:09:28 INFO - 'run-tests'), 05:09:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:28 INFO - 'download_minidump_stackwalk': True, 05:09:28 INFO - 'download_symbols': 'ondemand', 05:09:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:28 INFO - 'installer_path': 'installer.exe', 05:09:28 INFO - 'log_level': 'info', 05:09:28 INFO - 'log_name': 'talos', 05:09:28 INFO - 'log_to_console': True, 05:09:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:09:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:09:28 INFO - 'opt_config_files': (), 05:09:28 INFO - 'pip_index': False, 05:09:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:28 INFO - 'cmd': ('bash', 05:09:28 INFO - '-c', 05:09:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:28 INFO - 'enabled': True, 05:09:28 INFO - 'halt_on_failure': False, 05:09:28 INFO - 'name': 'check_screen_resolution'},), 05:09:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:28 INFO - 'cmd': ('bash', 05:09:28 INFO - '-c', 05:09:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:28 INFO - 'enabled': True, 05:09:28 INFO - 'halt_on_failure': False, 05:09:28 INFO - 'name': 'check_screen_resolution'},), 05:09:28 INFO - 'run_cmd_checks_enabled': True, 05:09:28 INFO - 'sps_profile': False, 05:09:28 INFO - 'sps_profile_interval': 0, 05:09:28 INFO - 'suite': 'dromaeojs', 05:09:28 INFO - 'system_bits': '64', 05:09:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:28 INFO - 'title': 't-yosemite-r7-0034', 05:09:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:28 INFO - 'use_talos_json': True, 05:09:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:28 INFO - 'work_dir': 'build'} 05:09:28 INFO - ##### 05:09:28 INFO - ##### Running clobber step. 05:09:28 INFO - ##### 05:09:28 INFO - Running pre-action listener: _resource_record_pre_action 05:09:28 INFO - Running main action method: clobber 05:09:28 INFO - rmtree: /builds/slave/test/build 05:09:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:29 INFO - Running post-action listener: _resource_record_post_action 05:09:29 INFO - ##### 05:09:29 INFO - ##### Running read-buildbot-config step. 05:09:29 INFO - ##### 05:09:29 INFO - Running pre-action listener: _resource_record_pre_action 05:09:29 INFO - Running main action method: read_buildbot_config 05:09:29 INFO - Using buildbot properties: 05:09:29 INFO - { 05:09:29 INFO - "properties": { 05:09:29 INFO - "buildnumber": 3, 05:09:29 INFO - "product": "firefox", 05:09:29 INFO - "script_repo_revision": "production", 05:09:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:09:29 INFO - "repository": "", 05:09:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:09:29 INFO - "buildid": "20151121030232", 05:09:29 INFO - "slavename": "t-yosemite-r7-0034", 05:09:29 INFO - "stage_platform": "macosx64", 05:09:29 INFO - "basedir": "/builds/slave/test", 05:09:29 INFO - "nightly_build": "True", 05:09:29 INFO - "project": "", 05:09:29 INFO - "platform": "yosemite_r7", 05:09:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:09:29 INFO - "slavebuilddir": "test", 05:09:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:09:29 INFO - "branch": "mozilla-central", 05:09:29 INFO - "repo_path": "mozilla-central", 05:09:29 INFO - "pgo_build": "False", 05:09:29 INFO - "builduid": "19fe30bfdb0a4633ad6952d5b4ce1f41", 05:09:29 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 05:09:29 INFO - }, 05:09:29 INFO - "sourcestamp": { 05:09:29 INFO - "repository": "", 05:09:29 INFO - "hasPatch": false, 05:09:29 INFO - "project": "", 05:09:29 INFO - "branch": "mozilla-central-macosx64-talos", 05:09:29 INFO - "changes": [ 05:09:29 INFO - { 05:09:29 INFO - "category": null, 05:09:29 INFO - "files": [ 05:09:29 INFO - { 05:09:29 INFO - "url": null, 05:09:29 INFO - "name": "https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:09:29 INFO - } 05:09:29 INFO - ], 05:09:29 INFO - "repository": "", 05:09:29 INFO - "rev": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f", 05:09:29 INFO - "who": "sendchange", 05:09:29 INFO - "when": 1448111339, 05:09:29 INFO - "number": 6692360, 05:09:29 INFO - "comments": "", 05:09:29 INFO - "project": "", 05:09:29 INFO - "at": "Sat 21 Nov 2015 05:08:59", 05:09:29 INFO - "branch": "mozilla-central-macosx64-talos", 05:09:29 INFO - "revlink": "", 05:09:29 INFO - "properties": [ 05:09:29 INFO - [ 05:09:29 INFO - "buildid", 05:09:29 INFO - "20151121030232", 05:09:29 INFO - "Change" 05:09:29 INFO - ], 05:09:29 INFO - [ 05:09:29 INFO - "builduid", 05:09:29 INFO - "19fe30bfdb0a4633ad6952d5b4ce1f41", 05:09:29 INFO - "Change" 05:09:29 INFO - ], 05:09:29 INFO - [ 05:09:29 INFO - "nightly_build", 05:09:29 INFO - "True", 05:09:29 INFO - "Change" 05:09:29 INFO - ], 05:09:29 INFO - [ 05:09:29 INFO - "pgo_build", 05:09:29 INFO - "False", 05:09:29 INFO - "Change" 05:09:29 INFO - ] 05:09:29 INFO - ], 05:09:29 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 05:09:29 INFO - } 05:09:29 INFO - ], 05:09:29 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 05:09:29 INFO - } 05:09:29 INFO - } 05:09:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:09:29 INFO - Running post-action listener: _resource_record_post_action 05:09:29 INFO - ##### 05:09:29 INFO - ##### Running download-and-extract step. 05:09:29 INFO - ##### 05:09:29 INFO - Running pre-action listener: _resource_record_pre_action 05:09:29 INFO - Running main action method: download_and_extract 05:09:29 INFO - mkdir: /builds/slave/test/build/tests 05:09:29 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')]} 05:09:29 INFO - https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/test_packages.json 05:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/test_packages.json 05:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:09:59 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/test_packages.json: timed out 05:09:59 INFO - retry: attempt #1 caught exception: timed out 05:09:59 INFO - retry: Failed, sleeping 30 seconds before retrying 05:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 05:10:31 INFO - Downloaded 1149 bytes. 05:10:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:10:31 INFO - Using the following test package requirements: 05:10:31 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:10:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:10:31 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:10:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:10:31 INFO - u'jsshell-mac.zip'], 05:10:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:10:31 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:10:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:10:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:10:31 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:10:31 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:10:31 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:10:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:10:31 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:10:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:10:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:10:31 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:10:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:10: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')]} 05:10:31 INFO - https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/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 05:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/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 05:10:35 INFO - Downloaded 17524670 bytes. 05:10:35 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 05:10:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:10:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:10:37 INFO - Return code: 0 05:10:37 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 05:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:37 INFO - https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/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 05:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/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 05:10:39 INFO - Downloaded 17524670 bytes. 05:10:39 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 05:10:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:10:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:10:43 INFO - Return code: 0 05:10:43 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')]} 05:10:43 INFO - https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/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 05:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/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 05:10:43 INFO - Downloaded 11130997 bytes. 05:10:43 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 05:10:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:10:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:10:44 INFO - Return code: 0 05:10:44 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')]} 05:10:44 INFO - https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pQHj_Wb0RhuGKCza2Skljg/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 05:10:47 INFO - Downloaded 109758571 bytes. 05:10:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:47 INFO - mkdir: /builds/slave/test/properties 05:10:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:47 INFO - Contents: 05:10:47 INFO - build_url:https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:47 INFO - Running post-action listener: _resource_record_post_action 05:10:47 INFO - Running post-action listener: set_extra_try_arguments 05:10:47 INFO - ##### 05:10:47 INFO - ##### Running populate-webroot step. 05:10:47 INFO - ##### 05:10:47 INFO - Running pre-action listener: _resource_record_pre_action 05:10:47 INFO - Running main action method: populate_webroot 05:10:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:10:47 INFO - '../fennec_ids.txt'], 05:10:47 INFO - 'tests': ['tcheck2']}, 05:10:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:47 INFO - '--tppagecycles', 05:10:47 INFO - '7'], 05:10:47 INFO - 'tests': ['tsvgm']}}, 05:10:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:10:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'tests': ['damp', 'tps']}, 05:10:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['damp', 'tps']}, 05:10:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:10:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:47 INFO - 'other': {'tests': ['a11yr', 05:10:47 INFO - 'ts_paint', 05:10:47 INFO - 'tpaint', 05:10:47 INFO - 'sessionrestore', 05:10:47 INFO - 'sessionrestore_no_auto_restore']}, 05:10:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['a11yr', 05:10:47 INFO - 'ts_paint', 05:10:47 INFO - 'tpaint', 05:10:47 INFO - 'sessionrestore', 05:10:47 INFO - 'sessionrestore_no_auto_restore']}, 05:10:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['a11yr', 05:10:47 INFO - 'ts_paint', 05:10:47 INFO - 'tpaint', 05:10:47 INFO - 'sessionrestore', 05:10:47 INFO - 'sessionrestore_no_auto_restore']}, 05:10:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['a11yr', 05:10:47 INFO - 'ts_paint', 05:10:47 INFO - 'tpaint', 05:10:47 INFO - 'sessionrestore', 05:10:47 INFO - 'sessionrestore_no_auto_restore']}, 05:10:47 INFO - 'other_l64': {'tests': ['a11yr', 05:10:47 INFO - 'ts_paint', 05:10:47 INFO - 'tpaint', 05:10:47 INFO - 'sessionrestore', 05:10:47 INFO - 'sessionrestore_no_auto_restore']}, 05:10:47 INFO - 'other_nol64': {'tests': ['a11yr', 05:10:47 INFO - 'ts_paint', 05:10:47 INFO - 'tpaint', 05:10:47 INFO - 'sessionrestore', 05:10:47 INFO - 'sessionrestore_no_auto_restore']}, 05:10:47 INFO - 'svgr': {'tests': ['tsvgx', 05:10:47 INFO - 'tsvgr_opacity', 05:10:47 INFO - 'tart', 05:10:47 INFO - 'tscrollx', 05:10:47 INFO - 'cart']}, 05:10:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['tsvgx', 05:10:47 INFO - 'tsvgr_opacity', 05:10:47 INFO - 'tart', 05:10:47 INFO - 'tscrollx', 05:10:47 INFO - 'cart']}, 05:10:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'tests': ['tp5o']}, 05:10:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'talos_options': ['--e10s'], 05:10:47 INFO - 'tests': ['tp5o']}, 05:10:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'talos_options': ['--xperf_path', 05:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:47 INFO - 'tests': ['tp5n']}, 05:10:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:47 INFO - 'talos_options': ['--e10s', 05:10:47 INFO - '--xperf_path', 05:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:47 INFO - 'tests': ['tp5n']}}, 05:10:47 INFO - 'talos.zip': {'path': '', 05:10:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:47 INFO - Running post-action listener: _resource_record_post_action 05:10:47 INFO - ##### 05:10:47 INFO - ##### Running create-virtualenv step. 05:10:47 INFO - ##### 05:10:47 INFO - Running pre-action listener: _resource_record_pre_action 05:10:47 INFO - Running main action method: create_virtualenv 05:10:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:47 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 05:10:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:47 INFO - Using real prefix '/tools/python27' 05:10:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:51 INFO - Installing pip.................done. 05:10:51 INFO - Return code: 0 05:10:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:51 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')]} 05:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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')]} 05:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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 0x10f5fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00a492270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, '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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:10:51 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 05:10:51 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 05:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:51 INFO - 'HOME': '/Users/cltbld', 05:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:51 INFO - 'LOGNAME': 'cltbld', 05:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:51 INFO - 'MOZ_NO_REMOTE': '1', 05:10:51 INFO - 'NO_EM_RESTART': '1', 05:10:51 INFO - 'PAGER': '/bin/cat', 05:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:51 INFO - 'PWD': '/builds/slave/test', 05:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:51 INFO - 'SHELL': '/bin/bash', 05:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:10:51 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:51 INFO - 'USER': 'cltbld', 05:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:51 INFO - 'XPC_FLAGS': '0x0', 05:10:51 INFO - 'XPC_SERVICE_NAME': '0', 05:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:51 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 05:10:51 INFO - Cleaning up... 05:10:51 INFO - Return code: 0 05:10:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:10:51 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')]} 05:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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')]} 05:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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 0x10f5fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00a492270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, '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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:10:51 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 05:10:51 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 05:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:51 INFO - 'HOME': '/Users/cltbld', 05:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:51 INFO - 'LOGNAME': 'cltbld', 05:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:51 INFO - 'MOZ_NO_REMOTE': '1', 05:10:51 INFO - 'NO_EM_RESTART': '1', 05:10:51 INFO - 'PAGER': '/bin/cat', 05:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:51 INFO - 'PWD': '/builds/slave/test', 05:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:51 INFO - 'SHELL': '/bin/bash', 05:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:10:51 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:51 INFO - 'USER': 'cltbld', 05:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:51 INFO - 'XPC_FLAGS': '0x0', 05:10:51 INFO - 'XPC_SERVICE_NAME': '0', 05:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:51 INFO - Downloading/unpacking psutil>=0.7.1 05:10:51 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 05:10:51 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 05:10:51 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 05:10:51 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 05:10:51 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 05:10:51 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 05:10:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:10:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:54 INFO - Installing collected packages: psutil 05:10:54 INFO - Running setup.py install for psutil 05:10:54 INFO - building 'psutil._psutil_osx' extension 05:10:54 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 05:10:54 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 05:10:54 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 05:10:55 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 05:10:55 INFO - building 'psutil._psutil_posix' extension 05:10:55 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 05:10:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:10:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:10:55 INFO - ^ 05:10:55 INFO - 1 warning generated. 05:10:55 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 05:10:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:55 INFO - Successfully installed psutil 05:10:55 INFO - Cleaning up... 05:10:55 INFO - Return code: 0 05:10:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:10:55 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')]} 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:55 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')]} 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:55 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 0x10f5fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00a492270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, '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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:10:55 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 05:10:55 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 05:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:55 INFO - 'HOME': '/Users/cltbld', 05:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:55 INFO - 'LOGNAME': 'cltbld', 05:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:55 INFO - 'MOZ_NO_REMOTE': '1', 05:10:55 INFO - 'NO_EM_RESTART': '1', 05:10:55 INFO - 'PAGER': '/bin/cat', 05:10:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:55 INFO - 'PWD': '/builds/slave/test', 05:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:55 INFO - 'SHELL': '/bin/bash', 05:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:10:55 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:55 INFO - 'USER': 'cltbld', 05:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:55 INFO - 'XPC_FLAGS': '0x0', 05:10:55 INFO - 'XPC_SERVICE_NAME': '0', 05:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:10:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:10:57 INFO - Installing collected packages: mozsystemmonitor 05:10:57 INFO - Running setup.py install for mozsystemmonitor 05:10:58 INFO - Successfully installed mozsystemmonitor 05:10:58 INFO - Cleaning up... 05:10:58 INFO - Return code: 0 05:10:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10f5fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00a492270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, '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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:10:58 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 05:10:58 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 05:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:58 INFO - 'HOME': '/Users/cltbld', 05:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:58 INFO - 'LOGNAME': 'cltbld', 05:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:58 INFO - 'MOZ_NO_REMOTE': '1', 05:10:58 INFO - 'NO_EM_RESTART': '1', 05:10:58 INFO - 'PAGER': '/bin/cat', 05:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:58 INFO - 'PWD': '/builds/slave/test', 05:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:58 INFO - 'SHELL': '/bin/bash', 05:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:10:58 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:58 INFO - 'USER': 'cltbld', 05:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:58 INFO - 'XPC_FLAGS': '0x0', 05:10:58 INFO - 'XPC_SERVICE_NAME': '0', 05:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 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 05:11:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:01 INFO - Downloading docopt-0.6.1.tar.gz 05:11:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:01 INFO - Running setup.py install for blobuploader 05:11:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:01 INFO - Running setup.py install for requests 05:11:02 INFO - Running setup.py install for docopt 05:11:02 INFO - Successfully installed blobuploader requests docopt 05:11:02 INFO - Cleaning up... 05:11:02 INFO - Return code: 0 05:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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 0x10f5fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00a492270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, '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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:11:02 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 05:11:02 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 05:11:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:11:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:02 INFO - 'HOME': '/Users/cltbld', 05:11:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:02 INFO - 'LOGNAME': 'cltbld', 05:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:02 INFO - 'MOZ_NO_REMOTE': '1', 05:11:02 INFO - 'NO_EM_RESTART': '1', 05:11:02 INFO - 'PAGER': '/bin/cat', 05:11:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:02 INFO - 'PWD': '/builds/slave/test', 05:11:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:02 INFO - 'SHELL': '/bin/bash', 05:11:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:11:02 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:11:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:02 INFO - 'USER': 'cltbld', 05:11:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:02 INFO - 'XPC_FLAGS': '0x0', 05:11:02 INFO - 'XPC_SERVICE_NAME': '0', 05:11:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:02 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-eHeZ1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:02 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-H8ypEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Y8yz75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-RGOADH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-obyPjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-AUeyEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-ANH7Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-5Or2cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-DNTAix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-QhCRid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-mfGLz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-GjVxqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-9lTtXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-NmSbIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-AnMgzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-zGHICR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-LJazTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:04 INFO - Running setup.py install for manifestparser 05:11:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:04 INFO - Running setup.py install for mozcrash 05:11:04 INFO - Running setup.py install for mozdebug 05:11:04 INFO - Running setup.py install for mozdevice 05:11:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for mozfile 05:11:05 INFO - Running setup.py install for mozhttpd 05:11:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for mozinfo 05:11:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for mozInstall 05:11:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:05 INFO - Running setup.py install for mozleak 05:11:05 INFO - Running setup.py install for mozlog 05:11:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:06 INFO - Running setup.py install for moznetwork 05:11:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:06 INFO - Running setup.py install for mozprocess 05:11:06 INFO - Running setup.py install for mozprofile 05:11:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:06 INFO - Running setup.py install for mozrunner 05:11:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:06 INFO - Running setup.py install for mozscreenshot 05:11:06 INFO - Running setup.py install for moztest 05:11:06 INFO - Running setup.py install for mozversion 05:11:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:07 INFO - Cleaning up... 05:11:07 INFO - Return code: 0 05:11:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10f5fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00a492270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, '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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:11:07 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 05:11:07 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 05:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:07 INFO - 'HOME': '/Users/cltbld', 05:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:07 INFO - 'LOGNAME': 'cltbld', 05:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:07 INFO - 'MOZ_NO_REMOTE': '1', 05:11:07 INFO - 'NO_EM_RESTART': '1', 05:11:07 INFO - 'PAGER': '/bin/cat', 05:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:07 INFO - 'PWD': '/builds/slave/test', 05:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:07 INFO - 'SHELL': '/bin/bash', 05:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:11:07 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:07 INFO - 'USER': 'cltbld', 05:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:07 INFO - 'XPC_FLAGS': '0x0', 05:11:07 INFO - 'XPC_SERVICE_NAME': '0', 05:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:07 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-JgWpCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:07 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)) 05:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:07 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-KgPO25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:07 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)) 05:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:07 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-vSRTX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:07 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)) 05:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:07 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-UBf442-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:07 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)) 05:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:07 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Vu_vhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:07 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)) 05:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:07 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-2zxAPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-7sisfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-brb01a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Dt3kte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-gQxbu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-P7JCZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-7ndB4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-kPNTlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-T9eHdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-_wa607-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:08 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)) 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:08 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-6MpgfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:09 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)) 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:09 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-HCZ4UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:09 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)) 05:11:09 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)) 05:11:09 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)) 05:11:09 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)) 05:11:09 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)) 05:11:09 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)) 05:11:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:09 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 05:11:09 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 05:11:09 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 05:11:09 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 05:11:09 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 05:11:09 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 05:11:11 INFO - Downloading blessings-1.5.1.tar.gz 05:11:11 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 05:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:11 INFO - Installing collected packages: blessings 05:11:11 INFO - Running setup.py install for blessings 05:11:11 INFO - Successfully installed blessings 05:11:11 INFO - Cleaning up... 05:11:11 INFO - Return code: 0 05:11:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:11 INFO - Reading from file tmpfile_stdout 05:11:11 INFO - Current package versions: 05:11:11 INFO - blessings == 1.5.1 05:11:11 INFO - blobuploader == 1.2.4 05:11:11 INFO - docopt == 0.6.1 05:11:11 INFO - manifestparser == 1.1 05:11:11 INFO - mozInstall == 1.12 05:11:11 INFO - mozcrash == 0.16 05:11:11 INFO - mozdebug == 0.1 05:11:11 INFO - mozdevice == 0.47 05:11:11 INFO - mozfile == 1.2 05:11:11 INFO - mozhttpd == 0.7 05:11:11 INFO - mozinfo == 0.9 05:11:11 INFO - mozleak == 0.1 05:11:11 INFO - mozlog == 3.0 05:11:11 INFO - moznetwork == 0.27 05:11:11 INFO - mozprocess == 0.22 05:11:11 INFO - mozprofile == 0.27 05:11:11 INFO - mozrunner == 6.11 05:11:11 INFO - mozscreenshot == 0.1 05:11:11 INFO - mozsystemmonitor == 0.0 05:11:11 INFO - moztest == 0.7 05:11:11 INFO - mozversion == 1.4 05:11:11 INFO - psutil == 3.1.1 05:11:11 INFO - requests == 1.2.3 05:11:11 INFO - wsgiref == 0.1.2 05:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:11 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')]} 05:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:11 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')]} 05:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:11 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 0x10f5fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5da228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00a492270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, '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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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 05:11:11 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 05:11:11 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 05:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:11 INFO - 'HOME': '/Users/cltbld', 05:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:11 INFO - 'LOGNAME': 'cltbld', 05:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:11 INFO - 'MOZ_NO_REMOTE': '1', 05:11:11 INFO - 'NO_EM_RESTART': '1', 05:11:11 INFO - 'PAGER': '/bin/cat', 05:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:11 INFO - 'PWD': '/builds/slave/test', 05:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:11 INFO - 'SHELL': '/bin/bash', 05:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:11:11 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:11 INFO - 'USER': 'cltbld', 05:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:11 INFO - 'XPC_FLAGS': '0x0', 05:11:11 INFO - 'XPC_SERVICE_NAME': '0', 05:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 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)) 05:11:12 INFO - Cleaning up... 05:11:12 INFO - Return code: 0 05:11:12 INFO - Running post-action listener: _resource_record_post_action 05:11:12 INFO - Running post-action listener: _start_resource_monitoring 05:11:12 INFO - Starting resource monitoring. 05:11:12 INFO - ##### 05:11:12 INFO - ##### Running install step. 05:11:12 INFO - ##### 05:11:12 INFO - Running pre-action listener: _resource_record_pre_action 05:11:12 INFO - Running main action method: install 05:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:12 INFO - Reading from file tmpfile_stdout 05:11:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:12 INFO - Reading from file tmpfile_stdout 05:11:12 INFO - Output received: 05:11:12 INFO - Usage: mozinstall [options] installer 05:11:12 INFO - Options: 05:11:12 INFO - -h, --help show this help message and exit 05:11:12 INFO - -d DEST, --destination=DEST 05:11:12 INFO - Directory to install application into. [default: 05:11:12 INFO - "/builds/slave/test"] 05:11:12 INFO - --app=APP Application being installed. [default: firefox] 05:11:12 INFO - mkdir: /builds/slave/test/build/application 05:11:12 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'] 05:11:12 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 05:11:43 INFO - Reading from file tmpfile_stdout 05:11:43 INFO - Output received: 05:11:43 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:11:43 INFO - Running post-action listener: _resource_record_post_action 05:11:43 INFO - ##### 05:11:43 INFO - ##### Running run-tests step. 05:11:43 INFO - ##### 05:11:43 INFO - Running pre-action listener: _resource_record_pre_action 05:11:43 INFO - Running main action method: run_tests 05:11:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:43 INFO - 2015-11-21 05:11:43.143 screenresolution[1978:16818] starting screenresolution argv=screenresolution get 05:11:43 INFO - 2015-11-21 05:11:43.146 screenresolution[1978:16818] Display 0: 1600x1200x32@60 05:11:43 INFO - 2015-11-21 05:11:43.152 screenresolution[1979:16820] starting screenresolution argv=screenresolution list 05:11:43 INFO - Available Modes on Display 0 05:11:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:43 INFO - Intel Iris: 05:11:43 INFO - Chipset Model: Intel Iris 05:11:43 INFO - Type: GPU 05:11:43 INFO - Bus: Built-In 05:11:43 INFO - VRAM (Dynamic, Max): 1536 MB 05:11:43 INFO - Vendor: Intel (0x8086) 05:11:43 INFO - Device ID: 0x0a2e 05:11:43 INFO - Revision ID: 0x0009 05:11:43 INFO - Displays: 05:11:43 INFO - Display: 05:11:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:43 INFO - Display Serial Number: 1600x1200 60 05:11:43 INFO - Main Display: Yes 05:11:43 INFO - Mirror: Off 05:11:43 INFO - Online: Yes 05:11:43 INFO - Rotation: Supported 05:11:43 INFO - Return code: 0 05:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:43 INFO - Python 2.7.3 05:11:43 INFO - Return code: 0 05:11:43 INFO - grabbing minidump binary from tooltool 05:11:43 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')]} 05:11:43 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 0x10f5219f0>, '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 0x10f280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5148c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:43 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 05:11:43 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 05:11:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:43 INFO - Return code: 0 05:11:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:11:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:11:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--webServer', 'localhost'] in /builds/slave/test/build 05:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --webServer localhost 05:11:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7z7m0jmVX/Render', 05:11:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:43 INFO - 'HOME': '/Users/cltbld', 05:11:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:43 INFO - 'LOGNAME': 'cltbld', 05:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:43 INFO - 'MOZ_NO_REMOTE': '1', 05:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:43 INFO - 'NO_EM_RESTART': '1', 05:11:43 INFO - 'PAGER': '/bin/cat', 05:11:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:43 INFO - 'PWD': '/builds/slave/test', 05:11:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:43 INFO - 'SHELL': '/bin/bash', 05:11:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NBgeRpbrXI/Listeners', 05:11:43 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 05:11:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:43 INFO - 'USER': 'cltbld', 05:11:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:43 INFO - 'XPC_FLAGS': '0x0', 05:11:43 INFO - 'XPC_SERVICE_NAME': '0', 05:11:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--webServer', 'localhost'] with output_timeout 3600 05:11:43 INFO - mozversion INFO | application_buildid: 20151121030232 05:11:43 INFO - mozversion INFO | application_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 05:11:43 INFO - mozversion INFO | application_display_name: Nightly 05:11:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:43 INFO - mozversion INFO | application_name: Firefox 05:11:43 INFO - mozversion INFO | application_remotingname: firefox 05:11:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:11:43 INFO - mozversion INFO | application_vendor: Mozilla 05:11:43 INFO - mozversion INFO | application_version: 45.0a1 05:11:43 INFO - mozversion INFO | platform_buildid: 20151121030232 05:11:43 INFO - mozversion INFO | platform_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 05:11:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:11:43 INFO - mozversion INFO | platform_version: 45.0a1 05:11:43 INFO - 2015-11-21 05:11:43,696 DEBUG : using testdate: 1448111503 05:11:43 INFO - 2015-11-21 05:11:43,696 DEBUG : actual date: 1448111503 05:11:44 INFO - 2015-11-21 05:11:44,039 INFO : starting webserver on 'localhost:49675' 05:11:44 INFO - 2015-11-21 05:11:44,040 INFO : Starting test suite t-yosemite-r7-0034 05:11:44 INFO - 2015-11-21 05:11:44,040 INFO : Starting test dromaeo_css 05:11:44 INFO - 2015-11-21 05:11:44,040 DEBUG : operating with platform_type : mac_ 05:11:44 INFO - 2015-11-21 05:11:44,041 INFO : Initialising browser for dromaeo_css test... 05:11:44 INFO - 2015-11-21 05:11:44,054 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmprczh6I/profile http://localhost:49675/getInfo.html 05:11:46 INFO - 2015-11-21 05:11:46,354 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:46 INFO - 2015-11-21 05:11:46,354 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:46 INFO - 2015-11-21 05:11:46,355 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:11:46 INFO - 2015-11-21 05:11:46,355 DEBUG : BROWSER_OUTPUT: __metrics 05:11:46 INFO - 2015-11-21 05:11:46,372 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:46 INFO - 2015-11-21 05:11:46,996 INFO : Browser initialized. 05:11:46 INFO - 2015-11-21 05:11:46,997 INFO : Running cycle 1/1 for dromaeo_css test... 05:11:46 INFO - 2015-11-21 05:11:46,997 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmprczh6I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:58 INFO - 2015-11-21 05:11:58,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 226263040 05:11:58 INFO - 2015-11-21 05:11:58,893 DEBUG : BROWSER_OUTPUT: 05:12:51 INFO - 2015-11-21 05:12:51,365 DEBUG : BROWSER_OUTPUT: 1448111571360 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] 05:15:01 INFO - 2015-11-21 05:15:01,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49675/tests/dromaeo/cssquery-ext.html) 05:15:03 INFO - 2015-11-21 05:15:03,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 370761728 05:15:03 INFO - 2015-11-21 05:15:03,203 DEBUG : BROWSER_OUTPUT: 05:18:05 INFO - 2015-11-21 05:18:05,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-ext.html (next: http://localhost:49675/tests/dromaeo/cssquery-jquery.html) 05:18:06 INFO - 2015-11-21 05:18:06,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 364949504 05:18:06 INFO - 2015-11-21 05:18:06,491 DEBUG : BROWSER_OUTPUT: 05:21:08 INFO - 2015-11-21 05:21:08,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49675/tests/dromaeo/cssquery-mootools.html) 05:21:09 INFO - 2015-11-21 05:21:09,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 334516224 05:21:09 INFO - 2015-11-21 05:21:09,117 DEBUG : BROWSER_OUTPUT: 05:24:11 INFO - 2015-11-21 05:24:11,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49675/tests/dromaeo/cssquery-prototype.html) 05:24:11 INFO - 2015-11-21 05:24:11,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 323981312 05:24:11 INFO - 2015-11-21 05:24:11,733 DEBUG : BROWSER_OUTPUT: 05:27:14 INFO - 2015-11-21 05:27:14,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49675/tests/dromaeo/cssquery-yui.html) 05:27:15 INFO - 2015-11-21 05:27:15,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 321884160 05:27:15 INFO - 2015-11-21 05:27:15,449 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/dromaeo/cssquery-yui.html (next: http://localhost:49675/tests/dromaeo/cssquery-dojo.html) 05:30:18 INFO - 2015-11-21 05:30:18,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 380833792 05:30:18 INFO - 2015-11-21 05:30:18,339 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,339 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:18 INFO - 2015-11-21 05:30:18,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:18 INFO - 2015-11-21 05:30:18,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:18 INFO - 2015-11-21 05:30:18,339 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:18 INFO - 2015-11-21 05:30:18,339 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3415.7267418606516;3496.2133519957997;3516.753827232093;3517.9120521986947;3556.6443355664437;5698.886022279552;5828.825135245939;5995.520358371331;5997.730102145403;6039.18471006414;5847.970760146204;5892.440218179277;5895.734691938862;5898.941010589893;5901.940980590193;4966.826161084363;5139.0749665060275;5331.867253098762;5381.354237491507;5443.863903402427;5486.1222204447295;5486.61593688442;5489.258950041753;5491.983982963145;5498.752556134964;5477.972610136943;5479;5482.780688772445;5483.122700367942;5484.890302193954;5310.734463276859;5415.6479828811;5434.755436005389;5451.427600101992;5473.0969390050595;5398.595105367074;5402.486763757437;5482.945170548283;5483.835484935458;5500.7524661390335;5935;6033.637981721067;6069.666168360738;6102.481289090389;6113.358097399753;6195.28754193269;6217.68911554425;6332.461740752042;6345.682715864188;6392.232932048138;6349.428551430394;6358.58669186506;6383.265924418705;6389.520785941073;6400.775972840928;5078.9238161427975;6113.694315284218;6117.96941015292;6129.38706129388;6132.264128304588;6206.162168107247;6291.748330066746;6318.589291696025;6346.936530634634;6402.519811014193;6364.809055728336;6370.267419246753;6389.233292004989;6389.393007664265;6394.0408938659575;6355.046742988588;6375.203099612549;6380.042993551005;6384.808455746335;6399.392057754506;5258.526732594085;6261.592996455307;6301.653409062454;6323.968380158161;6366.872662546816;6203.2245969253845;6285.308616052231;6325.240971083499;6332.968335158294;6333.968330158412;5094.4141423736;5104.872378190501;5110.71891045996;5112.693238405707;5139.537441630271;4472.642188624902;4565;4590.67865249436;4597.632189424905;4617.861464156081;5896.941030589639;5903.321118071391;5908.822735317947;5918.644881307136;5931.881362372815;6220.129181914535;6307.96846015767;6327.462165715873;6343.397377249154;6349.079383489368;5801.158831969341;5893.116032595145;5914.319853216849;5951.256092988377;5953.880922381528;5520.089185284463;5530.364008139035;5551.666899986014;5560.638558493685;5570.61005729595;5396.730163491889;6204.906926396107;6258.43674069336;6309.179806625109;6336.6831658416895;6354.459870911024;6359.395857393541;6360.332165122781;6367.267764207176;6380.202474690664;6295.338989406229;6351.428371446592;6354.173957385695;6372.0760489729655;6512.772052978123;6145.631262124287;6184.350643182401;6287.717052732546;6289.905651415141;6321.557490975588;6335.746570137143;6358.523110766803;6360.236771587439;6366.586171898812;6371.203599550056;6283.591566548343;6343.714532845941;6355.682215889279;6356.872862542816;6360.809175724736;6137.877242455215;6168.9691551541955;6221.502279817513;6230.7507699693315;6234.251889773075;5199.48005199477;5954.225950626391;6198.504119670506;6229.813105606839;6243.37566243372;6301.054841773771;6324.083007963727;6338.176037115146;6343.0485427186295;6349.523785715997;5388;5970.223870896755;6098.146259523582;6176.474999624902;6226.283977342664 05:30:18 INFO - 2015-11-21 05:30:18,339 DEBUG : BROWSER_OUTPUT: |1;ext.html;529.8516415403687;577.4918072096556;590.8109404990402;594.8608414885495;636.8535236895514;31195.844020779892;31533.36933261336;31586.368272634532;40975;41782;44068.77965610167;44426.55573444265;44572.554274457245;44623.77688111555;44631.330530042076;8660.566971651408;9517.286203534728;9864.654737084204;9880.654177103803;9922.702318930407;8835.514046727427;8963;8973.057828927966;8976.192142707156;8996;11817;12010.778006068862;12012.339321337324;12023.338716370596;12039.699007524838;11784.823227651592;11854.822177667256;11862.584809531625;11875.049996000342;11922.463489143009;8786.692465763668;8932.062133476022;8985.640574377017;11697.3566453845;11830.704232394173;32244.355112897847;32485.187870303194;41098.589014110075;41595.7920210397;41671.374929376085;3399.5240666306736;3426.9143271418166;3618.7285953553587;3793.677537409296;3900.180961997984;28892.699828507557;29046.709532904613;29138.549820552016;29183.41633167325;30037.39925201484;2656.907008254702;2694.0840114361213;2701.648785657852;2761.1716485054403;2769.252301878502;454529;455163;455257.72371138266;455464;638667;55416.445835541934;70088.59822803516;71039.28960710327;71147;71160.93258601124;68417.65791171113;69091;69258.65370673114;69362;69437;13939.581812545639;17039.14804259782;17052.14739263032;17056.48830535086;17083.572910677332;12924.353782310847;13119.737605248032;13120.868791312156;13122.34388280582;13126.540571079966;20508.487287817625;20778.896105519376;20781.376558703265;20781.58436831255;20792.688109678365;8302.54336011525;8501.14988501145;8521.147885211429;8534.231919127309;8590.355723320776;916.5875356089787;928.3455164109287;1022.2549273085308;1022.703416009349;1065.477915821242;29901.551476727866;30090.12873395808;30172.94394696219;30260.54609180864;31083.222919427197;1082.3127314155568;1137.5279259107542;1182.9940850295693;1230.655416483386;1290.9806352904714;15309.00491468051;15439.459618913284;15704.764428533581;15747;15844.128572928368;539842;544099;544546;544641;546807;61351;61419.38580614226;61645.691771540856;61651.691741541006;61834.0724889127;1441.6972435788603;1454.2946670864833;1474.727175472541;1478.7560052591416;1481.3704175725275;30072.3985520284;30211.69788302089;30303;30725.692743072283;30765.69234307718;49158.50841491539;49879;50208.99582008412;52777;56574.71712641411;389298;395432;398289;398311;398804;30247.69752302449;30372.39255214839;30581.694183057883;30586.08241752751;30632.84683576568;35091;44159;44777;45044.54955450535;45364.54635453603;36922.44616330811;36996.260074797814;37680.24639507139;37826;37970.43044354281;28968.855155724086;36117;36582.08544786402;36909;37061.629383706895;37196;37582.8120859394;38065.23869522649;38074.61925380822;38392.6160738389;30447.543286850272;32923.34153316968;32949.341013179124;34237.486437703956;34280.65719342874;20766.58466830625;24865.378365541008;25184.622230666922;25693.486130277663;25814.741852581985 05:30:18 INFO - 2015-11-21 05:30:18,342 DEBUG : BROWSER_OUTPUT: |2;jquery.html;307.3606897652882;360.83762306961876;362.1543695471075;362.69171204476197;362.95281613390256;16183.514494565152;16591.585210369747;19970.800291997075;20580.588388232227;21377.14491420345;16923.830761692378;16981.91509042453;17001.319947202097;18015.82897111687;20760.792392076073;5664.971675141618;5669.546436285108;5806.651600903938;5810.128480727883;5814.651120932736;4073.8370465181356;4278.550752171009;5003.774830132635;5776.104703770901;5827.825165245049;4220.008298049956;6103.877922441548;6290.559660823744;6292.276388215368;6294.276158241815;6153.138560601519;6291.716872740715;6323.494120470397;6324.3043265240785;6330.461910737593;5444.754986025599;5447.4824891635235;5454.400015998237;5457.181422786574;5460.126379779256;25987.74012259872;26274.86862565675;26576.804043818076;26616.802243898877;26826.7927943243;2128.2231985325243;2170.489934865321;2243.1924507177405;2306.630939049744;2377.405648587853;14533.636659083502;14706.411743530245;14740.705185896222;14892.62768430787;15108.471203507934;1676.7233406487915;1723.9741403878952;1726.9120454113827;1755.4207111653125;1779.0659903550738;94097.05902940952;98106;98219;99229.5115573267;99422.50866237085;10353.482325883826;10721.142308615292;10737.83893241602;10754.784904302027;10847.186461015455;12529.498820047278;12682.239065656091;12769.808452873214;12789.168704034208;12803.231806091664;7157.928420715831;8278.172182781673;8331.416800824005;8342.332613391036;8347.916520834835;8388.748337549883;8400;8407.2433480987;8473.449225800303;8622.655093796178;4230.873073807791;4263.786810659454;4264.509581398117;4279.550647182001;4323.956760432418;1316.6774140335679;1599.7600359945868;1741.3556983916033;1747.9213435395438;1828.1499102917207;696.4324075878143;878.6178012564554;907.6233363154217;1000.5397517142196;1017.7710015246511;19593.118309676098;20413.89793051025;20569.074391652113;20573.485662858548;20729.378118656463;836.7573403712977;917.7889085510236;926.8795056642593;934.1919239857474;963.8843338799389;10310.587576497006;10562;10605.893941060645;10612.734681632866;10641.680749577525;779156;780078;788381;800074;801805;98824.66752103013;114780;116552;118471.40764296123;123485.38257308835;1147.701597584634;1153.5212886652114;1161.4192903548226;1210.5883999440232;1210.7336385995068;12949.287789171685;18049;18460.35388761387;18705.158267877705;18862.52843678919;51443.19948801774;51485;51745.7412712934;51779;53901.19148212702;70836.64581677059;72225;72519.91220131596;73033.6348318255;75381.62309188639;9632.036796320312;9675.854862177213;9793.020697930435;9984.051515106054;10007.949960250153;11749.823752643888;11848.52605895789;17120.828791711923;20151.69772453444;20223.089960952086;15208.46770363032;15811.841881581497;15924.442644507386;16342.346306147621;16378.017318960425;15453.613659658598;15792.526224213292;15805.446809361618;16009.67980640404;16411.507654770376;16418;16752.1623918806;16787.66424671524;16793.664126717642;16797.664046718754;9433.858492122761;9765.511724413609;9809.313348065567;9845.507724613884;9854.852177217204;10724.624638137628;15660.843391565939;15744.527664170093;16103.436379726654;16445.835541644432 05:30:18 INFO - 2015-11-21 05:30:18,343 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1423.7223741370424;1738.3568079810468;1812.519682284195;1909.73263743076;1937.9418617441472;7304.2330555291655;7673.65468553915;7689.500182488135;7928.127905930343;8060.3954703397185;8081.070676872161;8189.590520473982;8224.876626850602;8235.588220588976;8247.216514431135;2118.205672872673;2363.6100043492847;2388.8208384371155;2391;2392.473655795722;2167.566486702658;2170.8697478151284;2365.562370961378;2378.6788783514176;2384.8092152627746;2293.4495721026915;2347.8943447544816;2350.7061617297836;2352.6588644646604;2361.126383238204;2112.714783504223;2143.539139085104;2357.2574638988663;2390.8565486070806;2391.6532102845076;2160.319499357697;2333.801626861719;2357.834951553392;2360.24472168906;2372.4424760181346;8125.562331300645;8232.670693172266;8235.341172706168;8239.217274358927;8246.958765206136;5123.2315152727015;5228.712420816853;5236.973815130938;5242.554382877422;5244.580433565344;2887.971120288791;3375.679310465526;3411.812350320731;3470.4273794823825;3494.510768492388;1013.0477351289765;1027.9383237005804;1030.4899074957868;1055.4353420919772;1058.4972138234355;11038;11044.944775276153;11055.834162487568;11062.280951738112;11084.722881927935;4619.330197121466;4670.136024835417;4715.363425937455;4720.811167553328;4746.976265118721;9610.95194524023;9620.422774633544;9636.662716804878;9645.180159686504;9647;5202.713850738246;5210.192420174879;5234.555062819627;5235.319408476874;5235.4817103039695;4733.928991065137;4735.644826638016;4775.904481910412;4776.761161941889;4780.928286075712;3784.508013958223;3853.8635628839647;3858.7105967052585;3877.166409222031;3898.1229223424502;1282.1922189021043;1283.6020833541631;1288.814290852418;1290.890274326674;1293.2628401810878;1141.2353723005606;1143.1654891928772;1144.4964215745047;1166.125405945541;1167.0721776187952;7813.179616140337;7870.527768333918;7947.205279472122;7966.402519810921;7970.6413211405625;1124.5951457475303;1158.9246698964541;1205.337064614476;1216.087934049463;1247.1332423965257;5805.303363596396;5962.5826192167;5969.76120955157;6204.441600255908;6280.717367718464;8676;9946.801063978824;9977.600895964226;10053.296269261082;10057.145142662956;9755.122039016522;10040.849387259197;10078.59685612582;10194.388336699822;10195.184385249162;7787.143414224431;7811.570363629941;7881.0936742274225;7915.0897646771355;7926.603669816486;7692.9615351922885;7805.843883122419;7811.882821757792;7822;7825.334846538108;8710.651573937224;8949;9000.50497222659;9110.180083792491;9145.679901203426;9154.26765858743;9449;9467.384619999679;9489.051094890732;9506.001869803571;5863.882722345444;6835.658217089026;6839.076724642109;6924.169099707866;6934.306569343227;7919.049714034353;7978.84042319162;7982.760517184493;7995.200479951958;8012.719554815553;7332.633368331455;7486.925130748623;7497.987771650757;7520.473566850487;7614.124375696866;7256;7305.305995930378;7309.159446663702;7434.1450733166375;7451.888221676788;7404.037475128199;7458.888116678146;7469;7471.88792168107;7523.210062943531;6575.638339891352;6792.456603471809;6831.6242606657115;6842.349976752201;6921.515493915579;6376.107344971615;6720.798376048726;7009.649517524002;7068;7085.6457177141965 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.8836074832686;325.7784706399649;330.3096528255945;330.7221933575796;334.83760376217543;5986.221791167148;6208.627482351057;6737.528373013891;6815.863682726343;6830.180378354592;6496;6554.9344506555035;6665.200175978877;6670.96664516678;6769.966150169254;4045.4336392904943;4983.501649835006;5012.448630650625;5030.899382012358;5051.747412629372;5001.049800537886;5001.749912504379;5022;5023.995200959805;5029.622778291643;4765.90468190636;4834.4923783002805;4872.951270487285;4891.5353041461;5009.323741294933;4766.64150717044;4930.950690493085;4942.975285123569;4949.851504454836;4953.628477864157;3708.9072773180615;4247.405363249148;4264.360345948102;4268.658507319438;4270.743755374688;5284.81503147388;6283.08895210192;6424.582402143892;6455.2253729552285;6472.093906853044;5792.304923409218;5804.680742559158;5805.274340707411;5807;5817.360090390053;7214.783556493314;7225.024621676059;7237.7828665139605;7251.456140789409;7251.70993160273;4641.791119399635;4641.930371044437;4660.627149828006;4660.976695116537;4671.649626278043;6422.871542569169;7242.13094428672;7468.813279667997;7646.502977306513;7651.846963060708;4682.882927926829;4689.296605509133;4691.437027556647;4695.976520117378;4702.3416721659;4762.714237145782;4781.139394908881;4788.329633851264;4791.95208047922;4792.544708252711;4910.337104490919;5565.30433695788;5702;5706.80026199081;5715.142728590745;7247.9490473881;7265.709371625076;7270.272972702794;7280.781576552712;7286.526375785557;1371.9862801372058;1638.598543356885;1661.3935913391767;1661.5430756542048;1664.167916041979;1043.8538604595362;1052.6578861869923;1073.0771536478621;1074.897884700952;1077.6874706335232;5880.235569376039;6481.157449531625;6765.42493888025;6779.593224406552;6791;7287.562746235243;7517.436192285601;7525.2098529654695;7548.962255188689;7564;5496;6640.169978752656;6738.427233685094;6836.897446538306;6861.794146175623;3952.7430717003303;4007.6593489553716;4031.7825196142003;4052.250333688277;4054.0878302382316;6398.232212134573;7363.8159046024275;7659.348955338747;7667.808304792425;7688.192739762245;6492.67536623167;7785.3771698264;7879.251471110236;7889.921100788919;7913.446058775946;6136.29432615255;7625.161232264447;7642.312191902755;7658.770236892902;7662.310392064741;7349.412047036118;7567.091948966159;7590.354819840155;7597.240275972358;7610.467267291237;6784.219814721173;6807.897881531682;7466.962665186857;7474.402047836269;7475.36459400957;6154.476869466145;7424.294692004251;7621.69513219465;7627;7637.5035622684345;4704.741239231738;4714.269288260325;4720.622350212044;4723;4736.834210802605;7504.812379690333;7530.510516816608;7539.736109236151;7546;7548.962255188689;7042.366187043191;7191.7842464726145;7198.6400679964745;7220.1696804866015;7224.060872086595;7222.927770722225;7227.457940654577;7230.74692385764;7231.168415632059;7231.63841807897;6078.149059131813;6437.195350581177;7041.647917604202;7083.787486375417;7088.184858741311;6991.335823096798;7182.3894968928225;7188.568685878864;7264.927350726425;7272.636368181676;6816.727330906709;7027.508074434741;7028.191757947697;7028.437724982092;7045.577265364094 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: |5;yui.html;737.4358615659019;745.6234601526229;765.506248469737;801.0467543623084;854.3549620036873;14884.77672834907;15076.310287113409;15201.011934224282;15204.771928421083;15226.695466090672;14024.43902243909;14419.639509012253;14423.206723630195;14428.927855360735;14448.349824257908;782.6556315221285;791.0744429018034;973.5667627905602;1006.0693858181189;1010.9191264698807;769.3844924060757;989.5893204320234;1003.4731765822928;1005.3766664667879;1005.8038682456923;919.1130559010553;1026.8408396698524;1035.8860525342243;1036.1400037968506;1040.1314902056793;799.5242830515805;800.7357572001225;809.380823669893;1022.396785896321;1026.1175389165312;600.2406955201674;601.7863658401249;608.5253502268238;764.3541207679502;772.0002596637368;12475.625731228078;14907.2546372682;15053.172075535842;15091.320890559951;15140.470083547134;12405.503779848796;12489.250644961332;12618.873811261861;12732.745345093139;12980.091393602452;10146.883842777288;10176.670679260556;10221.131203847683;10228.590856365736;10249.948750256275;3510.4558793387064;3552.7335449841107;3553.3248682750195;3554.306910152521;3559.430491121434;78976.81534776984;80469;81802;82560;82696.58651706763;9482.668106616235;9499.857502137473;9599.664011759554;9759.65841195569;9787.608495660093;21817.563648726937;21825.345239642837;21827.454313642287;21835.454113647287;21841.890790546262;7496.962515187389;7512.849743005218;7585.051868516435;7590.696372145163;7691.5385076894445;4004.619561141687;4069.654079403284;4201.7268877523475;4204.117135401539;4214.485437854168;3530.3115892401247;3578.5169002184894;3580.9104772380897;3583.175869550018;3583.94624080639;609.8201030695956;630.3822254190918;633.2053273142177;652.3900153356627;654.7642848574509;569.5898952754011;571.8970585294604;609.2323672173005;623.7941479311907;626.6866566716551;7502.62486875654;7966.681332746741;7985.760427187193;8364.58177091143;9160.496172710566;441.7437886026097;541.6695815552509;578.8955464625534;596.7553303145689;621.2638023941644;3056.9847150764103;3784.564775050849;3887.7667339959694;4095.692823038284;4152.958470415318;95053;96968.51515742518;97188;97288.05423891483;97300;63771.681141593996;83013.16986830054;83367;83707;84297;72100.9184862238;72683.00486946432;73402;74112;74219.62890185515;8075.798105047421;8098.230668086522;8184.918150818654;8306.626201821053;8315.334773218006;50599;51328.716782080744;51412.48587514077;51936.48063519316;52577.7371113142;72019.63990180015;74153;74408;74478.62760686161;74748;10026;10161.339512931636;10214.744631384276;10334.586616535255;10572.401329911965;10967.451627418437;11010.559577616805;11141.498632561392;11479.139064570023;12071.698207544881;9007;10502;10728.195385346286;10729.839052414376;10741.087007604128;10256.179505639382;10300.278980471296;10327.173826094046;10483.266171368236;10676.57293708243;9935.552900119368;9972.152367048882;10249.590016399261;10482.004209600076;10813.189010824062;8765.737027889174;8805.603747831236;8879;9016.90983090187;9074.591643375932;8147.470414423044;8650.351223658377;8962.372633915564;9087.818243634958;9187 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1458 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: __startTimestamp1448112618334__endTimestamp 05:30:18 INFO - 2015-11-21 05:30:18,347 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,348 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:18 INFO - 2015-11-21 05:30:18,348 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:30:18 INFO - 2015-11-21 05:30:18,348 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,349 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5882.19 Median:6137.88 stddev:629.05 (10.2%) stddev-sans-first:600.49 05:30:18 INFO - 2015-11-21 05:30:18,349 DEBUG : BROWSER_OUTPUT: Values: 3415.7 3496.2 3516.8 3517.9 3556.6 5698.9 5828.8 5995.5 5997.7 6039.2 5848.0 5892.4 5895.7 5898.9 5901.9 4966.8 5139.1 5331.9 5381.4 5443.9 5486.1 5486.6 5489.3 5492.0 5498.8 5478.0 5479.0 5482.8 5483.1 5484.9 5310.7 5415.6 5434.8 5451.4 5473.1 5398.6 5402.5 5482.9 5483.8 5500.8 5935.0 6033.6 6069.7 6102.5 6113.4 6195.3 6217.7 6332.5 6345.7 6392.2 6349.4 6358.6 6383.3 6389.5 6400.8 5078.9 6113.7 6118.0 6129.4 6132.3 6206.2 6291.7 6318.6 6346.9 6402.5 6364.8 6370.3 6389.2 6389.4 6394.0 6355.0 6375.2 6380.0 6384.8 6399.4 5258.5 6261.6 6301.7 6324.0 6366.9 6203.2 6285.3 6325.2 6333.0 6334.0 5094.4 5104.9 5110.7 5112.7 5139.5 4472.6 4565.0 4590.7 4597.6 4617.9 5896.9 5903.3 5908.8 5918.6 5931.9 6220.1 6308.0 6327.5 6343.4 6349.1 5801.2 5893.1 5914.3 5951.3 5953.9 5520.1 5530.4 5551.7 5560.6 5570.6 5396.7 6204.9 6258.4 6309.2 6336.7 6354.5 6359.4 6360.3 6367.3 6380.2 6295.3 6351.4 6354.2 6372.1 6512.8 6145.6 6184.4 6287.7 6289.9 6321.6 6335.7 6358.5 6360.2 6366.6 6371.2 6283.6 6343.7 6355.7 6356.9 6360.8 6137.9 6169.0 6221.5 6230.8 6234.3 5199.5 5954.2 6198.5 6229.8 6243.4 6301.1 6324.1 6338.2 6343.0 6349.5 5388.0 5970.2 6098.1 6176.5 6226.3 05:30:18 INFO - 2015-11-21 05:30:18,349 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,349 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63007.89 Median:20100.41 stddev:128457.65 (639.1%) stddev-sans-first:128732.36 05:30:18 INFO - 2015-11-21 05:30:18,351 DEBUG : BROWSER_OUTPUT: Values: 529.9 577.5 590.8 594.9 636.9 31195.8 31533.4 31586.4 40975.0 41782.0 44068.8 44426.6 44572.6 44623.8 44631.3 8660.6 9517.3 9864.7 9880.7 9922.7 8835.5 8963.0 8973.1 8976.2 8996.0 11817.0 12010.8 12012.3 12023.3 12039.7 11784.8 11854.8 11862.6 11875.0 11922.5 8786.7 8932.1 8985.6 11697.4 11830.7 32244.4 32485.2 41098.6 41595.8 41671.4 3399.5 3426.9 3618.7 3793.7 3900.2 28892.7 29046.7 29138.5 29183.4 30037.4 2656.9 2694.1 2701.6 2761.2 2769.3 454529.0 455163.0 455257.7 455464.0 638667.0 55416.4 70088.6 71039.3 71147.0 71160.9 68417.7 69091.0 69258.7 69362.0 69437.0 13939.6 17039.1 17052.1 17056.5 17083.6 12924.4 13119.7 13120.9 13122.3 13126.5 20508.5 20778.9 20781.4 20781.6 20792.7 8302.5 8501.1 8521.1 8534.2 8590.4 916.6 928.3 1022.3 1022.7 1065.5 29901.6 30090.1 30172.9 30260.5 31083.2 1082.3 1137.5 1183.0 1230.7 1291.0 15309.0 15439.5 15704.8 15747.0 15844.1 539842.0 544099.0 544546.0 544641.0 546807.0 61351.0 61419.4 61645.7 61651.7 61834.1 1441.7 1454.3 1474.7 1478.8 1481.4 30072.4 30211.7 30303.0 30725.7 30765.7 49158.5 49879.0 50209.0 52777.0 56574.7 389298.0 395432.0 398289.0 398311.0 398804.0 30247.7 30372.4 30581.7 30586.1 30632.8 35091.0 44159.0 44777.0 45044.5 45364.5 36922.4 36996.3 37680.2 37826.0 37970.4 28968.9 36117.0 36582.1 36909.0 37061.6 37196.0 37582.8 38065.2 38074.6 38392.6 30447.5 32923.3 32949.3 34237.5 34280.7 20766.6 24865.4 25184.6 25693.5 25814.7 05:30:18 INFO - 2015-11-21 05:30:18,351 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,351 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39839.68 Median:2342.02 stddev:129693.58 (5537.7%) stddev-sans-first:130023.43 05:30:18 INFO - 2015-11-21 05:30:18,352 DEBUG : BROWSER_OUTPUT: Values: 307.4 360.8 362.2 362.7 363.0 16183.5 16591.6 19970.8 20580.6 21377.1 16923.8 16981.9 17001.3 18015.8 20760.8 5665.0 5669.5 5806.7 5810.1 5814.7 4073.8 4278.6 5003.8 5776.1 5827.8 4220.0 6103.9 6290.6 6292.3 6294.3 6153.1 6291.7 6323.5 6324.3 6330.5 5444.8 5447.5 5454.4 5457.2 5460.1 25987.7 26274.9 26576.8 26616.8 26826.8 2128.2 2170.5 2243.2 2306.6 2377.4 14533.6 14706.4 14740.7 14892.6 15108.5 1676.7 1724.0 1726.9 1755.4 1779.1 94097.1 98106.0 98219.0 99229.5 99422.5 10353.5 10721.1 10737.8 10754.8 10847.2 12529.5 12682.2 12769.8 12789.2 12803.2 7157.9 8278.2 8331.4 8342.3 8347.9 8388.7 8400.0 8407.2 8473.4 8622.7 4230.9 4263.8 4264.5 4279.6 4324.0 1316.7 1599.8 1741.4 1747.9 1828.1 696.4 878.6 907.6 1000.5 1017.8 19593.1 20413.9 20569.1 20573.5 20729.4 836.8 917.8 926.9 934.2 963.9 10310.6 10562.0 10605.9 10612.7 10641.7 779156.0 780078.0 788381.0 800074.0 801805.0 98824.7 114780.0 116552.0 118471.4 123485.4 1147.7 1153.5 1161.4 1210.6 1210.7 12949.3 18049.0 18460.4 18705.2 18862.5 51443.2 51485.0 51745.7 51779.0 53901.2 70836.6 72225.0 72519.9 73033.6 75381.6 9632.0 9675.9 9793.0 9984.1 10007.9 11749.8 11848.5 17120.8 20151.7 20223.1 15208.5 15811.8 15924.4 16342.3 16378.0 15453.6 15792.5 15805.4 16009.7 16411.5 16418.0 16752.2 16787.7 16793.7 16797.7 9433.9 9765.5 9809.3 9845.5 9854.9 10724.6 15660.8 15744.5 16103.4 16445.8 05:30:18 INFO - 2015-11-21 05:30:18,352 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,352 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5786.58 Median:5524.94 stddev:2987.80 (54.1%) stddev-sans-first:2978.18 05:30:18 INFO - 2015-11-21 05:30:18,353 DEBUG : BROWSER_OUTPUT: Values: 1423.7 1738.4 1812.5 1909.7 1937.9 7304.2 7673.7 7689.5 7928.1 8060.4 8081.1 8189.6 8224.9 8235.6 8247.2 2118.2 2363.6 2388.8 2391.0 2392.5 2167.6 2170.9 2365.6 2378.7 2384.8 2293.4 2347.9 2350.7 2352.7 2361.1 2112.7 2143.5 2357.3 2390.9 2391.7 2160.3 2333.8 2357.8 2360.2 2372.4 8125.6 8232.7 8235.3 8239.2 8247.0 5123.2 5228.7 5237.0 5242.6 5244.6 2888.0 3375.7 3411.8 3470.4 3494.5 1013.0 1027.9 1030.5 1055.4 1058.5 11038.0 11044.9 11055.8 11062.3 11084.7 4619.3 4670.1 4715.4 4720.8 4747.0 9611.0 9620.4 9636.7 9645.2 9647.0 5202.7 5210.2 5234.6 5235.3 5235.5 4733.9 4735.6 4775.9 4776.8 4780.9 3784.5 3853.9 3858.7 3877.2 3898.1 1282.2 1283.6 1288.8 1290.9 1293.3 1141.2 1143.2 1144.5 1166.1 1167.1 7813.2 7870.5 7947.2 7966.4 7970.6 1124.6 1158.9 1205.3 1216.1 1247.1 5805.3 5962.6 5969.8 6204.4 6280.7 8676.0 9946.8 9977.6 10053.3 10057.1 9755.1 10040.8 10078.6 10194.4 10195.2 7787.1 7811.6 7881.1 7915.1 7926.6 7693.0 7805.8 7811.9 7822.0 7825.3 8710.7 8949.0 9000.5 9110.2 9145.7 9154.3 9449.0 9467.4 9489.1 9506.0 5863.9 6835.7 6839.1 6924.2 6934.3 7919.0 7978.8 7982.8 7995.2 8012.7 7332.6 7486.9 7498.0 7520.5 7614.1 7256.0 7305.3 7309.2 7434.1 7451.9 7404.0 7458.9 7469.0 7471.9 7523.2 6575.6 6792.5 6831.6 6842.3 6921.5 6376.1 6720.8 7009.6 7068.0 7085.6 05:30:18 INFO - 2015-11-21 05:30:18,354 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,354 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5828.18 Median:6486.92 stddev:1867.27 (28.8%) stddev-sans-first:1826.14 05:30:18 INFO - 2015-11-21 05:30:18,355 DEBUG : BROWSER_OUTPUT: Values: 318.9 325.8 330.3 330.7 334.8 5986.2 6208.6 6737.5 6815.9 6830.2 6496.0 6554.9 6665.2 6671.0 6770.0 4045.4 4983.5 5012.4 5030.9 5051.7 5001.0 5001.7 5022.0 5024.0 5029.6 4765.9 4834.5 4873.0 4891.5 5009.3 4766.6 4931.0 4943.0 4949.9 4953.6 3708.9 4247.4 4264.4 4268.7 4270.7 5284.8 6283.1 6424.6 6455.2 6472.1 5792.3 5804.7 5805.3 5807.0 5817.4 7214.8 7225.0 7237.8 7251.5 7251.7 4641.8 4641.9 4660.6 4661.0 4671.6 6422.9 7242.1 7468.8 7646.5 7651.8 4682.9 4689.3 4691.4 4696.0 4702.3 4762.7 4781.1 4788.3 4792.0 4792.5 4910.3 5565.3 5702.0 5706.8 5715.1 7247.9 7265.7 7270.3 7280.8 7286.5 1372.0 1638.6 1661.4 1661.5 1664.2 1043.9 1052.7 1073.1 1074.9 1077.7 5880.2 6481.2 6765.4 6779.6 6791.0 7287.6 7517.4 7525.2 7549.0 7564.0 5496.0 6640.2 6738.4 6836.9 6861.8 3952.7 4007.7 4031.8 4052.3 4054.1 6398.2 7363.8 7659.3 7667.8 7688.2 6492.7 7785.4 7879.3 7889.9 7913.4 6136.3 7625.2 7642.3 7658.8 7662.3 7349.4 7567.1 7590.4 7597.2 7610.5 6784.2 6807.9 7467.0 7474.4 7475.4 6154.5 7424.3 7621.7 7627.0 7637.5 4704.7 4714.3 4720.6 4723.0 4736.8 7504.8 7530.5 7539.7 7546.0 7549.0 7042.4 7191.8 7198.6 7220.2 7224.1 7222.9 7227.5 7230.7 7231.2 7231.6 6078.1 6437.2 7041.6 7083.8 7088.2 6991.3 7182.4 7188.6 7264.9 7272.6 6816.7 7027.5 7028.2 7028.4 7045.6 05:30:18 INFO - 2015-11-21 05:30:18,355 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,355 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18644.97 Median:570.74 stddev:26854.33 (4705.1%) stddev-sans-first:26896.00 05:30:18 INFO - 2015-11-21 05:30:18,356 DEBUG : BROWSER_OUTPUT: Values: 737.4 745.6 765.5 801.0 854.4 14884.8 15076.3 15201.0 15204.8 15226.7 14024.4 14419.6 14423.2 14428.9 14448.3 782.7 791.1 973.6 1006.1 1010.9 769.4 989.6 1003.5 1005.4 1005.8 919.1 1026.8 1035.9 1036.1 1040.1 799.5 800.7 809.4 1022.4 1026.1 600.2 601.8 608.5 764.4 772.0 12475.6 14907.3 15053.2 15091.3 15140.5 12405.5 12489.3 12618.9 12732.7 12980.1 10146.9 10176.7 10221.1 10228.6 10249.9 3510.5 3552.7 3553.3 3554.3 3559.4 78976.8 80469.0 81802.0 82560.0 82696.6 9482.7 9499.9 9599.7 9759.7 9787.6 21817.6 21825.3 21827.5 21835.5 21841.9 7497.0 7512.8 7585.1 7590.7 7691.5 4004.6 4069.7 4201.7 4204.1 4214.5 3530.3 3578.5 3580.9 3583.2 3583.9 609.8 630.4 633.2 652.4 654.8 569.6 571.9 609.2 623.8 626.7 7502.6 7966.7 7985.8 8364.6 9160.5 441.7 541.7 578.9 596.8 621.3 3057.0 3784.6 3887.8 4095.7 4153.0 95053.0 96968.5 97188.0 97288.1 97300.0 63771.7 83013.2 83367.0 83707.0 84297.0 72100.9 72683.0 73402.0 74112.0 74219.6 8075.8 8098.2 8184.9 8306.6 8315.3 50599.0 51328.7 51412.5 51936.5 52577.7 72019.6 74153.0 74408.0 74478.6 74748.0 10026.0 10161.3 10214.7 10334.6 10572.4 10967.5 11010.6 11141.5 11479.1 12071.7 9007.0 10502.0 10728.2 10729.8 10741.1 10256.2 10300.3 10327.2 10483.3 10676.6 9935.6 9972.2 10249.6 10482.0 10813.2 8765.7 8805.6 8879.0 9016.9 9074.6 8147.5 8650.4 8962.4 9087.8 9187.0 05:30:18 INFO - 2015-11-21 05:30:18,356 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:18 INFO - 2015-11-21 05:30:18,356 DEBUG : BROWSER_OUTPUT: 05:30:18 INFO - 2015-11-21 05:30:18,801 INFO : Browser exited with error code: 0 05:30:18 INFO - 2015-11-21 05:30:18,825 INFO : Completed test dromaeo_css (00:18:34) 05:30:18 INFO - 2015-11-21 05:30:18,826 INFO : Starting test kraken 05:30:18 INFO - 2015-11-21 05:30:18,826 DEBUG : operating with platform_type : mac_ 05:30:18 INFO - 2015-11-21 05:30:18,826 INFO : Initialising browser for kraken test... 05:30:18 INFO - 2015-11-21 05:30:18,838 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmps0UhTR/profile http://localhost:49675/getInfo.html 05:30:20 INFO - 2015-11-21 05:30:20,890 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:20 INFO - 2015-11-21 05:30:20,890 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:20 INFO - 2015-11-21 05:30:20,890 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:30:20 INFO - 2015-11-21 05:30:20,890 DEBUG : BROWSER_OUTPUT: __metrics 05:30:20 INFO - 2015-11-21 05:30:20,906 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:21 INFO - 2015-11-21 05:30:21,703 INFO : Browser initialized. 05:30:21 INFO - 2015-11-21 05:30:21,703 INFO : Running cycle 1/1 for kraken test... 05:30:21 INFO - 2015-11-21 05:30:21,703 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmps0UhTR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:33 INFO - 2015-11-21 05:30:33,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 226045952 05:30:33 INFO - 2015-11-21 05:30:33,597 DEBUG : BROWSER_OUTPUT: 05:30:36 INFO - 2015-11-21 05:30:36,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:36 INFO - 2015-11-21 05:30:36,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 274862080 05:30:36 INFO - 2015-11-21 05:30:36,726 DEBUG : BROWSER_OUTPUT: 05:30:39 INFO - 2015-11-21 05:30:39,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-dft) 05:30:39 INFO - 2015-11-21 05:30:39,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 290443264 05:30:39 INFO - 2015-11-21 05:30:39,930 DEBUG : BROWSER_OUTPUT: 05:30:43 INFO - 2015-11-21 05:30:43,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-fft) 05:30:43 INFO - 2015-11-21 05:30:43,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 277065728 05:30:43 INFO - 2015-11-21 05:30:43,715 DEBUG : BROWSER_OUTPUT: 05:30:45 INFO - 2015-11-21 05:30:45,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49675/tests/kraken/driver.html?testName=audio-oscillator) 05:30:46 INFO - 2015-11-21 05:30:46,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 277377024 05:30:46 INFO - 2015-11-21 05:30:46,164 DEBUG : BROWSER_OUTPUT: 05:30:48 INFO - 2015-11-21 05:30:48,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:48 INFO - 2015-11-21 05:30:48,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 280559616 05:30:48 INFO - 2015-11-21 05:30:48,740 DEBUG : BROWSER_OUTPUT: 05:30:51 INFO - 2015-11-21 05:30:51,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49675/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:52 INFO - 2015-11-21 05:30:52,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 281272320 05:30:52 INFO - 2015-11-21 05:30:52,009 DEBUG : BROWSER_OUTPUT: 05:30:54 INFO - 2015-11-21 05:30:54,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49675/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:55 INFO - 2015-11-21 05:30:55,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 281186304 05:30:55 INFO - 2015-11-21 05:30:55,446 DEBUG : BROWSER_OUTPUT: 05:30:58 INFO - 2015-11-21 05:30:58,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49675/tests/kraken/driver.html?testName=json-parse-financial) 05:30:58 INFO - 2015-11-21 05:30:58,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 280023040 05:30:58 INFO - 2015-11-21 05:30:58,847 DEBUG : BROWSER_OUTPUT: 05:31:00 INFO - 2015-11-21 05:31:00,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:00 INFO - 2015-11-21 05:31:00,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 313384960 05:31:00 INFO - 2015-11-21 05:31:00,933 DEBUG : BROWSER_OUTPUT: 05:31:02 INFO - 2015-11-21 05:31:02,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:03 INFO - 2015-11-21 05:31:03,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 316157952 05:31:03 INFO - 2015-11-21 05:31:03,318 DEBUG : BROWSER_OUTPUT: 05:31:05 INFO - 2015-11-21 05:31:05,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:05 INFO - 2015-11-21 05:31:05,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 323637248 05:31:05 INFO - 2015-11-21 05:31:05,958 DEBUG : BROWSER_OUTPUT: 05:31:08 INFO - 2015-11-21 05:31:08,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:09 INFO - 2015-11-21 05:31:09,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 324210688 05:31:09 INFO - 2015-11-21 05:31:09,153 DEBUG : BROWSER_OUTPUT: 05:31:11 INFO - 2015-11-21 05:31:11,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:12 INFO - 2015-11-21 05:31:12,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 323407872 05:31:12 INFO - 2015-11-21 05:31:12,130 DEBUG : BROWSER_OUTPUT: 05:31:13 INFO - 2015-11-21 05:31:13,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49675/tests/kraken/driver.html?testName=ai-astar) 05:31:14 INFO - 2015-11-21 05:31:14,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 383590400 05:31:14 INFO - 2015-11-21 05:31:14,131 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;111;111;111;98;111;113;111 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;119;144;138;145;167;161;116;156;118 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |2;audio-dft;185;184;181;184;183;184;184;188;183;186 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;68;74;71;55;57;57;69;70;55 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;86;79;121;75;73;75;113;74;76;114 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;86;86;85;87;87;87;87;85;91 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;93;93;94;94;94;95;93;107;144 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;87;87;87;95;87;70;131;143;86 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;55;55;54;54;55;54;65;53;54 05:31:14 INFO - 2015-11-21 05:31:14,132 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;64;65;66;68;67;68;67;69 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;79;82;81;81;82;82;83;82 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;142;127;122;123;126;128;130;131;128 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;124;132;136;134;119;148;134;134;126 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;63;67;65;65;67;66;71;91;91 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1035 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: __startTimestamp1448112674125__endTimestamp 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,133 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.55 (4.1%) stddev-sans-first:4.82 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 111.0 111.0 111.0 98.0 111.0 113.0 111.0 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:147.50 stddev:18.42 (12.5%) stddev-sans-first:19.27 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: Values: 150.0 119.0 144.0 138.0 145.0 167.0 161.0 116.0 156.0 118.0 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:184.20 Median:184.00 stddev:1.87 (1.0%) stddev-sans-first:1.96 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: Values: 185.0 184.0 181.0 184.0 183.0 184.0 184.0 188.0 183.0 186.0 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:63.70 Median:68.50 stddev:7.41 (10.8%) stddev-sans-first:7.79 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: Values: 61.0 68.0 74.0 71.0 55.0 57.0 57.0 69.0 70.0 55.0 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.60 Median:75.00 stddev:19.36 (25.8%) stddev-sans-first:20.51 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: Values: 86.0 79.0 121.0 75.0 73.0 75.0 113.0 74.0 76.0 114.0 05:31:14 INFO - 2015-11-21 05:31:14,134 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:1.69 (1.9%) stddev-sans-first:1.79 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 86.0 85.0 87.0 87.0 87.0 87.0 85.0 91.0 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:100.10 Median:94.00 stddev:15.99 (17.0%) stddev-sans-first:16.81 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 93.0 94.0 94.0 94.0 95.0 93.0 107.0 144.0 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:87.00 stddev:22.45 (25.8%) stddev-sans-first:23.79 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: Values: 94.0 87.0 87.0 87.0 95.0 87.0 70.0 131.0 143.0 86.0 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.47 (6.3%) stddev-sans-first:3.64 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: Values: 57.0 55.0 55.0 54.0 54.0 55.0 54.0 65.0 53.0 54.0 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:67.00 stddev:2.02 (3.0%) stddev-sans-first:2.00 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 64.0 65.0 66.0 68.0 67.0 68.0 67.0 69.0 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,135 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 79.0 82.0 81.0 81.0 82.0 82.0 83.0 82.0 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:129.00 stddev:5.52 (4.3%) stddev-sans-first:5.83 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: Values: 130.0 142.0 127.0 122.0 123.0 126.0 128.0 130.0 131.0 128.0 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.20 Median:134.00 stddev:7.90 (5.9%) stddev-sans-first:8.31 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: Values: 135.0 124.0 132.0 136.0 134.0 119.0 148.0 134.0 134.0 126.0 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:67.00 stddev:10.76 (16.1%) stddev-sans-first:11.11 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 67.0 65.0 65.0 67.0 66.0 71.0 91.0 91.0 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:14 INFO - 2015-11-21 05:31:14,136 DEBUG : BROWSER_OUTPUT: 05:31:14 INFO - 2015-11-21 05:31:14,891 INFO : Browser exited with error code: 0 05:31:14 INFO - 2015-11-21 05:31:14,937 INFO : Completed test kraken (00:00:56) 05:31:14 INFO - 2015-11-21 05:31:14,937 INFO : Starting test v8_7 05:31:14 INFO - 2015-11-21 05:31:14,937 DEBUG : operating with platform_type : mac_ 05:31:14 INFO - 2015-11-21 05:31:14,937 INFO : Initialising browser for v8_7 test... 05:31:14 INFO - 2015-11-21 05:31:14,949 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmptildCQ/profile http://localhost:49675/getInfo.html 05:31:16 INFO - 2015-11-21 05:31:16,870 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:31:16 INFO - 2015-11-21 05:31:16,871 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:31:16 INFO - 2015-11-21 05:31:16,871 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:31:16 INFO - 2015-11-21 05:31:16,871 DEBUG : BROWSER_OUTPUT: __metrics 05:31:16 INFO - 2015-11-21 05:31:16,886 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:17 INFO - 2015-11-21 05:31:17,529 INFO : Browser initialized. 05:31:17 INFO - 2015-11-21 05:31:17,530 INFO : Running cycle 1/1 for v8_7 test... 05:31:17 INFO - 2015-11-21 05:31:17,530 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmptildCQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:31:29 INFO - 2015-11-21 05:31:29,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 224321536 05:31:29 INFO - 2015-11-21 05:31:29,317 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49675/tests/v8_7/run.html (next: http://localhost:49675/tests/v8_7/run.html) 05:31:50 INFO - 2015-11-21 05:31:50,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 685088768 05:31:50 INFO - 2015-11-21 05:31:50,970 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,970 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:50 INFO - 2015-11-21 05:31:50,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |0;Richards;146.177459435755 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.47263038914903 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.4858757062147 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4761.9047619047615 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1903.041825095057 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |5;Earley;800.640512409928 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |6;Boyer;12525 05:31:50 INFO - 2015-11-21 05:31:50,972 DEBUG : BROWSER_OUTPUT: |7;RegExp;28742.85714285714 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: |8;Splay;926.5381083562902 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4518.018018018018 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: __startTimestamp1448112710970__endTimestamp 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.18 Median:146.18 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: Values: 146.2 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.47 Median:161.47 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: Values: 161.5 05:31:50 INFO - 2015-11-21 05:31:50,973 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.49 Median:282.49 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: Values: 282.5 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4761.90 Median:4761.90 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: Values: 4761.9 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1903.04 Median:1903.04 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: Values: 1903.0 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:800.64 Median:800.64 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: Values: 800.6 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,974 DEBUG : BROWSER_OUTPUT: Values: 12525.0 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28742.86 Median:28742.86 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: Values: 28742.9 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:926.54 Median:926.54 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: Values: 926.5 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4518.02 Median:4518.02 stddev:0.00 (0.0%) 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: Values: 4518.0 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:50 INFO - 2015-11-21 05:31:50,975 DEBUG : BROWSER_OUTPUT: 05:31:51 INFO - 2015-11-21 05:31:51,621 INFO : Browser exited with error code: 0 05:31:51 INFO - 2015-11-21 05:31:51,638 INFO : Completed test v8_7 (00:00:36) 05:31:52 INFO - 2015-11-21 05:31:52,104 INFO : Completed test suite (00:20:08) 05:31:52 INFO - 2015-11-21 05:31:52,104 DEBUG : Working with test: dromaeo_css 05:31:52 INFO - 2015-11-21 05:31:52,104 DEBUG : Generating results file: dromaeo_css 05:31:52 INFO - 2015-11-21 05:31:52,105 DEBUG : Working with test: kraken 05:31:52 INFO - 2015-11-21 05:31:52,105 DEBUG : Generating results file: kraken 05:31:52 INFO - 2015-11-21 05:31:52,105 INFO : javascript benchmark 05:31:52 INFO - 2015-11-21 05:31:52,105 DEBUG : Working with test: v8_7 05:31:52 INFO - 2015-11-21 05:31:52,105 DEBUG : Generating results file: v8_7 05:31:52 INFO - 2015-11-21 05:31:52,106 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:52 INFO - 2015-11-21 05:31:52,610 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 05:31:52 INFO - 2015-11-21 05:31:52,610 DEBUG : process_Request line: dromaeo_css 7641.88 graph.html#tests=[[72,1,59]] 05:31:52 INFO - 2015-11-21 05:31:52,610 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:52 INFO - 2015-11-21 05:31:52,634 DEBUG : process_Request line: kraken 1405.40 graph.html#tests=[[232,1,59]] 05:31:52 INFO - 2015-11-21 05:31:52,634 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:52 INFO - 2015-11-21 05:31:52,746 DEBUG : process_Request line: v8_7 19646.96 graph.html#tests=[[230,1,59]] 05:31:52 INFO - 2015-11-21 05:31:52,747 INFO : javascript benchmark 05:31:52 INFO - 2015-11-21 05:31:52,748 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3415.7267418606516, 3496.2133519957997, 3516.753827232093, 3517.9120521986947, 3556.6443355664437, 5698.886022279552, 5828.825135245939, 5995.520358371331, 5997.730102145403, 6039.18471006414, 5847.970760146204, 5892.440218179277, 5895.734691938862, 5898.941010589893, 5901.940980590193, 4966.826161084363, 5139.0749665060275, 5331.867253098762, 5381.354237491507, 5443.863903402427, 5486.1222204447295, 5486.61593688442, 5489.258950041753, 5491.983982963145, 5498.752556134964, 5477.972610136943, 5479.0, 5482.780688772445, 5483.122700367942, 5484.890302193954, 5310.734463276859, 5415.6479828811, 5434.755436005389, 5451.427600101992, 5473.0969390050595, 5398.595105367074, 5402.486763757437, 5482.945170548283, 5483.835484935458, 5500.7524661390335, 5935.0, 6033.637981721067, 6069.666168360738, 6102.481289090389, 6113.358097399753, 6195.28754193269, 6217.68911554425, 6332.461740752042, 6345.682715864188, 6392.232932048138, 6349.428551430394, 6358.58669186506, 6383.265924418705, 6389.520785941073, 6400.775972840928, 5078.9238161427975, 6113.694315284218, 6117.96941015292, 6129.38706129388, 6132.264128304588, 6206.162168107247, 6291.748330066746, 6318.589291696025, 6346.936530634634, 6402.519811014193, 6364.809055728336, 6370.267419246753, 6389.233292004989, 6389.393007664265, 6394.0408938659575, 6355.046742988588, 6375.203099612549, 6380.042993551005, 6384.808455746335, 6399.392057754506, 5258.526732594085, 6261.592996455307, 6301.653409062454, 6323.968380158161, 6366.872662546816, 6203.2245969253845, 6285.308616052231, 6325.240971083499, 6332.968335158294, 6333.968330158412, 5094.4141423736, 5104.872378190501, 5110.71891045996, 5112.693238405707, 5139.537441630271, 4472.642188624902, 4565.0, 4590.67865249436, 4597.632189424905, 4617.861464156081, 5896.941030589639, 5903.321118071391, 5908.822735317947, 5918.644881307136, 5931.881362372815, 6220.129181914535, 6307.96846015767, 6327.462165715873, 6343.397377249154, 6349.079383489368, 5801.158831969341, 5893.116032595145, 5914.319853216849, 5951.256092988377, 5953.880922381528, 5520.089185284463, 5530.364008139035, 5551.666899986014, 5560.638558493685, 5570.61005729595, 5396.730163491889, 6204.906926396107, 6258.43674069336, 6309.179806625109, 6336.6831658416895, 6354.459870911024, 6359.395857393541, 6360.332165122781, 6367.267764207176, 6380.202474690664, 6295.338989406229, 6351.428371446592, 6354.173957385695, 6372.0760489729655, 6512.772052978123, 6145.631262124287, 6184.350643182401, 6287.717052732546, 6289.905651415141, 6321.557490975588, 6335.746570137143, 6358.523110766803, 6360.236771587439, 6366.586171898812, 6371.203599550056, 6283.591566548343, 6343.714532845941, 6355.682215889279, 6356.872862542816, 6360.809175724736, 6137.877242455215, 6168.9691551541955, 6221.502279817513, 6230.7507699693315, 6234.251889773075, 5199.48005199477, 5954.225950626391, 6198.504119670506, 6229.813105606839, 6243.37566243372, 6301.054841773771, 6324.083007963727, 6338.176037115146, 6343.0485427186295, 6349.523785715997, 5388.0, 5970.223870896755, 6098.146259523582, 6176.474999624902, 6226.283977342664], "unit": "ms", "name": "dojo.html", "value": 5844.509288997529}, {"lowerIsBetter": false, "replicates": [529.8516415403687, 577.4918072096556, 590.8109404990402, 594.8608414885495, 636.8535236895514, 31195.844020779892, 31533.36933261336, 31586.368272634532, 40975.0, 41782.0, 44068.77965610167, 44426.55573444265, 44572.554274457245, 44623.77688111555, 44631.330530042076, 8660.566971651408, 9517.286203534728, 9864.654737084204, 9880.654177103803, 9922.702318930407, 8835.514046727427, 8963.0, 8973.057828927966, 8976.192142707156, 8996.0, 11817.0, 12010.778006068862, 12012.339321337324, 12023.338716370596, 12039.699007524838, 11784.823227651592, 11854.822177667256, 11862.584809531625, 11875.049996000342, 11922.463489143009, 8786.692465763668, 8932.062133476022, 8985.640574377017, 11697.3566453845, 11830.704232394173, 32244.355112897847, 32485.187870303194, 41098.589014110075, 41595.7920210397, 41671.374929376085, 3399.5240666306736, 3426.9143271418166, 3618.7285953553587, 3793.677537409296, 3900.180961997984, 28892.699828507557, 29046.709532904613, 29138.549820552016, 29183.41633167325, 30037.39925201484, 2656.907008254702, 2694.0840114361213, 2701.648785657852, 2761.1716485054403, 2769.252301878502, 454529.0, 455163.0, 455257.72371138266, 455464.0, 638667.0, 55416.445835541934, 70088.59822803516, 71039.28960710327, 71147.0, 71160.93258601124, 68417.65791171113, 69091.0, 69258.65370673114, 69362.0, 69437.0, 13939.581812545639, 17039.14804259782, 17052.14739263032, 17056.48830535086, 17083.572910677332, 12924.353782310847, 13119.737605248032, 13120.868791312156, 13122.34388280582, 13126.540571079966, 20508.487287817625, 20778.896105519376, 20781.376558703265, 20781.58436831255, 20792.688109678365, 8302.54336011525, 8501.14988501145, 8521.147885211429, 8534.231919127309, 8590.355723320776, 916.5875356089787, 928.3455164109287, 1022.2549273085308, 1022.703416009349, 1065.477915821242, 29901.551476727866, 30090.12873395808, 30172.94394696219, 30260.54609180864, 31083.222919427197, 1082.3127314155568, 1137.5279259107542, 1182.9940850295693, 1230.655416483386, 1290.9806352904714, 15309.00491468051, 15439.459618913284, 15704.764428533581, 15747.0, 15844.128572928368, 539842.0, 544099.0, 544546.0, 544641.0, 546807.0, 61351.0, 61419.38580614226, 61645.691771540856, 61651.691741541006, 61834.0724889127, 1441.6972435788603, 1454.2946670864833, 1474.727175472541, 1478.7560052591416, 1481.3704175725275, 30072.3985520284, 30211.69788302089, 30303.0, 30725.692743072283, 30765.69234307718, 49158.50841491539, 49879.0, 50208.99582008412, 52777.0, 56574.71712641411, 389298.0, 395432.0, 398289.0, 398311.0, 398804.0, 30247.69752302449, 30372.39255214839, 30581.694183057883, 30586.08241752751, 30632.84683576568, 35091.0, 44159.0, 44777.0, 45044.54955450535, 45364.54635453603, 36922.44616330811, 36996.260074797814, 37680.24639507139, 37826.0, 37970.43044354281, 28968.855155724086, 36117.0, 36582.08544786402, 36909.0, 37061.629383706895, 37196.0, 37582.8120859394, 38065.23869522649, 38074.61925380822, 38392.6160738389, 30447.543286850272, 32923.34153316968, 32949.341013179124, 34237.486437703956, 34280.65719342874, 20766.58466830625, 24865.378365541008, 25184.622230666922, 25693.486130277663, 25814.741852581985], "unit": "ms", "name": "ext.html", "value": 20187.764092124205}, {"lowerIsBetter": false, "replicates": [307.3606897652882, 360.83762306961876, 362.1543695471075, 362.69171204476197, 362.95281613390256, 16183.514494565152, 16591.585210369747, 19970.800291997075, 20580.588388232227, 21377.14491420345, 16923.830761692378, 16981.91509042453, 17001.319947202097, 18015.82897111687, 20760.792392076073, 5664.971675141618, 5669.546436285108, 5806.651600903938, 5810.128480727883, 5814.651120932736, 4073.8370465181356, 4278.550752171009, 5003.774830132635, 5776.104703770901, 5827.825165245049, 4220.008298049956, 6103.877922441548, 6290.559660823744, 6292.276388215368, 6294.276158241815, 6153.138560601519, 6291.716872740715, 6323.494120470397, 6324.3043265240785, 6330.461910737593, 5444.754986025599, 5447.4824891635235, 5454.400015998237, 5457.181422786574, 5460.126379779256, 25987.74012259872, 26274.86862565675, 26576.804043818076, 26616.802243898877, 26826.7927943243, 2128.2231985325243, 2170.489934865321, 2243.1924507177405, 2306.630939049744, 2377.405648587853, 14533.636659083502, 14706.411743530245, 14740.705185896222, 14892.62768430787, 15108.471203507934, 1676.7233406487915, 1723.9741403878952, 1726.9120454113827, 1755.4207111653125, 1779.0659903550738, 94097.05902940952, 98106.0, 98219.0, 99229.5115573267, 99422.50866237085, 10353.482325883826, 10721.142308615292, 10737.83893241602, 10754.784904302027, 10847.186461015455, 12529.498820047278, 12682.239065656091, 12769.808452873214, 12789.168704034208, 12803.231806091664, 7157.928420715831, 8278.172182781673, 8331.416800824005, 8342.332613391036, 8347.916520834835, 8388.748337549883, 8400.0, 8407.2433480987, 8473.449225800303, 8622.655093796178, 4230.873073807791, 4263.786810659454, 4264.509581398117, 4279.550647182001, 4323.956760432418, 1316.6774140335679, 1599.7600359945868, 1741.3556983916033, 1747.9213435395438, 1828.1499102917207, 696.4324075878143, 878.6178012564554, 907.6233363154217, 1000.5397517142196, 1017.7710015246511, 19593.118309676098, 20413.89793051025, 20569.074391652113, 20573.485662858548, 20729.378118656463, 836.7573403712977, 917.7889085510236, 926.8795056642593, 934.1919239857474, 963.8843338799389, 10310.587576497006, 10562.0, 10605.893941060645, 10612.734681632866, 10641.680749577525, 779156.0, 780078.0, 788381.0, 800074.0, 801805.0, 98824.66752103013, 114780.0, 116552.0, 118471.40764296123, 123485.38257308835, 1147.701597584634, 1153.5212886652114, 1161.4192903548226, 1210.5883999440232, 1210.7336385995068, 12949.287789171685, 18049.0, 18460.35388761387, 18705.158267877705, 18862.52843678919, 51443.19948801774, 51485.0, 51745.7412712934, 51779.0, 53901.19148212702, 70836.64581677059, 72225.0, 72519.91220131596, 73033.6348318255, 75381.62309188639, 9632.036796320312, 9675.854862177213, 9793.020697930435, 9984.051515106054, 10007.949960250153, 11749.823752643888, 11848.52605895789, 17120.828791711923, 20151.69772453444, 20223.089960952086, 15208.46770363032, 15811.841881581497, 15924.442644507386, 16342.346306147621, 16378.017318960425, 15453.613659658598, 15792.526224213292, 15805.446809361618, 16009.67980640404, 16411.507654770376, 16418.0, 16752.1623918806, 16787.66424671524, 16793.664126717642, 16797.664046718754, 9433.858492122761, 9765.511724413609, 9809.313348065567, 9845.507724613884, 9854.852177217204, 10724.624638137628, 15660.843391565939, 15744.527664170093, 16103.436379726654, 16445.835541644432], "unit": "ms", "name": "jquery.html", "value": 9944.945913145653}, {"lowerIsBetter": false, "replicates": [1423.7223741370424, 1738.3568079810468, 1812.519682284195, 1909.73263743076, 1937.9418617441472, 7304.2330555291655, 7673.65468553915, 7689.500182488135, 7928.127905930343, 8060.3954703397185, 8081.070676872161, 8189.590520473982, 8224.876626850602, 8235.588220588976, 8247.216514431135, 2118.205672872673, 2363.6100043492847, 2388.8208384371155, 2391.0, 2392.473655795722, 2167.566486702658, 2170.8697478151284, 2365.562370961378, 2378.6788783514176, 2384.8092152627746, 2293.4495721026915, 2347.8943447544816, 2350.7061617297836, 2352.6588644646604, 2361.126383238204, 2112.714783504223, 2143.539139085104, 2357.2574638988663, 2390.8565486070806, 2391.6532102845076, 2160.319499357697, 2333.801626861719, 2357.834951553392, 2360.24472168906, 2372.4424760181346, 8125.562331300645, 8232.670693172266, 8235.341172706168, 8239.217274358927, 8246.958765206136, 5123.2315152727015, 5228.712420816853, 5236.973815130938, 5242.554382877422, 5244.580433565344, 2887.971120288791, 3375.679310465526, 3411.812350320731, 3470.4273794823825, 3494.510768492388, 1013.0477351289765, 1027.9383237005804, 1030.4899074957868, 1055.4353420919772, 1058.4972138234355, 11038.0, 11044.944775276153, 11055.834162487568, 11062.280951738112, 11084.722881927935, 4619.330197121466, 4670.136024835417, 4715.363425937455, 4720.811167553328, 4746.976265118721, 9610.95194524023, 9620.422774633544, 9636.662716804878, 9645.180159686504, 9647.0, 5202.713850738246, 5210.192420174879, 5234.555062819627, 5235.319408476874, 5235.4817103039695, 4733.928991065137, 4735.644826638016, 4775.904481910412, 4776.761161941889, 4780.928286075712, 3784.508013958223, 3853.8635628839647, 3858.7105967052585, 3877.166409222031, 3898.1229223424502, 1282.1922189021043, 1283.6020833541631, 1288.814290852418, 1290.890274326674, 1293.2628401810878, 1141.2353723005606, 1143.1654891928772, 1144.4964215745047, 1166.125405945541, 1167.0721776187952, 7813.179616140337, 7870.527768333918, 7947.205279472122, 7966.402519810921, 7970.6413211405625, 1124.5951457475303, 1158.9246698964541, 1205.337064614476, 1216.087934049463, 1247.1332423965257, 5805.303363596396, 5962.5826192167, 5969.76120955157, 6204.441600255908, 6280.717367718464, 8676.0, 9946.801063978824, 9977.600895964226, 10053.296269261082, 10057.145142662956, 9755.122039016522, 10040.849387259197, 10078.59685612582, 10194.388336699822, 10195.184385249162, 7787.143414224431, 7811.570363629941, 7881.0936742274225, 7915.0897646771355, 7926.603669816486, 7692.9615351922885, 7805.843883122419, 7811.882821757792, 7822.0, 7825.334846538108, 8710.651573937224, 8949.0, 9000.50497222659, 9110.180083792491, 9145.679901203426, 9154.26765858743, 9449.0, 9467.384619999679, 9489.051094890732, 9506.001869803571, 5863.882722345444, 6835.658217089026, 6839.076724642109, 6924.169099707866, 6934.306569343227, 7919.049714034353, 7978.84042319162, 7982.760517184493, 7995.200479951958, 8012.719554815553, 7332.633368331455, 7486.925130748623, 7497.987771650757, 7520.473566850487, 7614.124375696866, 7256.0, 7305.305995930378, 7309.159446663702, 7434.1450733166375, 7451.888221676788, 7404.037475128199, 7458.888116678146, 7469.0, 7471.88792168107, 7523.210062943531, 6575.638339891352, 6792.456603471809, 6831.6242606657115, 6842.349976752201, 6921.515493915579, 6376.107344971615, 6720.798376048726, 7009.649517524002, 7068.0, 7085.6457177141965], "unit": "ms", "name": "mootools.html", "value": 4749.955677543026}, {"lowerIsBetter": false, "replicates": [318.8836074832686, 325.7784706399649, 330.3096528255945, 330.7221933575796, 334.83760376217543, 5986.221791167148, 6208.627482351057, 6737.528373013891, 6815.863682726343, 6830.180378354592, 6496.0, 6554.9344506555035, 6665.200175978877, 6670.96664516678, 6769.966150169254, 4045.4336392904943, 4983.501649835006, 5012.448630650625, 5030.899382012358, 5051.747412629372, 5001.049800537886, 5001.749912504379, 5022.0, 5023.995200959805, 5029.622778291643, 4765.90468190636, 4834.4923783002805, 4872.951270487285, 4891.5353041461, 5009.323741294933, 4766.64150717044, 4930.950690493085, 4942.975285123569, 4949.851504454836, 4953.628477864157, 3708.9072773180615, 4247.405363249148, 4264.360345948102, 4268.658507319438, 4270.743755374688, 5284.81503147388, 6283.08895210192, 6424.582402143892, 6455.2253729552285, 6472.093906853044, 5792.304923409218, 5804.680742559158, 5805.274340707411, 5807.0, 5817.360090390053, 7214.783556493314, 7225.024621676059, 7237.7828665139605, 7251.456140789409, 7251.70993160273, 4641.791119399635, 4641.930371044437, 4660.627149828006, 4660.976695116537, 4671.649626278043, 6422.871542569169, 7242.13094428672, 7468.813279667997, 7646.502977306513, 7651.846963060708, 4682.882927926829, 4689.296605509133, 4691.437027556647, 4695.976520117378, 4702.3416721659, 4762.714237145782, 4781.139394908881, 4788.329633851264, 4791.95208047922, 4792.544708252711, 4910.337104490919, 5565.30433695788, 5702.0, 5706.80026199081, 5715.142728590745, 7247.9490473881, 7265.709371625076, 7270.272972702794, 7280.781576552712, 7286.526375785557, 1371.9862801372058, 1638.598543356885, 1661.3935913391767, 1661.5430756542048, 1664.167916041979, 1043.8538604595362, 1052.6578861869923, 1073.0771536478621, 1074.897884700952, 1077.6874706335232, 5880.235569376039, 6481.157449531625, 6765.42493888025, 6779.593224406552, 6791.0, 7287.562746235243, 7517.436192285601, 7525.2098529654695, 7548.962255188689, 7564.0, 5496.0, 6640.169978752656, 6738.427233685094, 6836.897446538306, 6861.794146175623, 3952.7430717003303, 4007.6593489553716, 4031.7825196142003, 4052.250333688277, 4054.0878302382316, 6398.232212134573, 7363.8159046024275, 7659.348955338747, 7667.808304792425, 7688.192739762245, 6492.67536623167, 7785.3771698264, 7879.251471110236, 7889.921100788919, 7913.446058775946, 6136.29432615255, 7625.161232264447, 7642.312191902755, 7658.770236892902, 7662.310392064741, 7349.412047036118, 7567.091948966159, 7590.354819840155, 7597.240275972358, 7610.467267291237, 6784.219814721173, 6807.897881531682, 7466.962665186857, 7474.402047836269, 7475.36459400957, 6154.476869466145, 7424.294692004251, 7621.69513219465, 7627.0, 7637.5035622684345, 4704.741239231738, 4714.269288260325, 4720.622350212044, 4723.0, 4736.834210802605, 7504.812379690333, 7530.510516816608, 7539.736109236151, 7546.0, 7548.962255188689, 7042.366187043191, 7191.7842464726145, 7198.6400679964745, 7220.1696804866015, 7224.060872086595, 7222.927770722225, 7227.457940654577, 7230.74692385764, 7231.168415632059, 7231.63841807897, 6078.149059131813, 6437.195350581177, 7041.647917604202, 7083.787486375417, 7088.184858741311, 6991.335823096798, 7182.3894968928225, 7188.568685878864, 7264.927350726425, 7272.636368181676, 6816.727330906709, 7027.508074434741, 7028.191757947697, 7028.437724982092, 7045.577265364094], "unit": "ms", "name": "prototype.html", "value": 5200.988719672467}, {"lowerIsBetter": false, "replicates": [737.4358615659019, 745.6234601526229, 765.506248469737, 801.0467543623084, 854.3549620036873, 14884.77672834907, 15076.310287113409, 15201.011934224282, 15204.771928421083, 15226.695466090672, 14024.43902243909, 14419.639509012253, 14423.206723630195, 14428.927855360735, 14448.349824257908, 782.6556315221285, 791.0744429018034, 973.5667627905602, 1006.0693858181189, 1010.9191264698807, 769.3844924060757, 989.5893204320234, 1003.4731765822928, 1005.3766664667879, 1005.8038682456923, 919.1130559010553, 1026.8408396698524, 1035.8860525342243, 1036.1400037968506, 1040.1314902056793, 799.5242830515805, 800.7357572001225, 809.380823669893, 1022.396785896321, 1026.1175389165312, 600.2406955201674, 601.7863658401249, 608.5253502268238, 764.3541207679502, 772.0002596637368, 12475.625731228078, 14907.2546372682, 15053.172075535842, 15091.320890559951, 15140.470083547134, 12405.503779848796, 12489.250644961332, 12618.873811261861, 12732.745345093139, 12980.091393602452, 10146.883842777288, 10176.670679260556, 10221.131203847683, 10228.590856365736, 10249.948750256275, 3510.4558793387064, 3552.7335449841107, 3553.3248682750195, 3554.306910152521, 3559.430491121434, 78976.81534776984, 80469.0, 81802.0, 82560.0, 82696.58651706763, 9482.668106616235, 9499.857502137473, 9599.664011759554, 9759.65841195569, 9787.608495660093, 21817.563648726937, 21825.345239642837, 21827.454313642287, 21835.454113647287, 21841.890790546262, 7496.962515187389, 7512.849743005218, 7585.051868516435, 7590.696372145163, 7691.5385076894445, 4004.619561141687, 4069.654079403284, 4201.7268877523475, 4204.117135401539, 4214.485437854168, 3530.3115892401247, 3578.5169002184894, 3580.9104772380897, 3583.175869550018, 3583.94624080639, 609.8201030695956, 630.3822254190918, 633.2053273142177, 652.3900153356627, 654.7642848574509, 569.5898952754011, 571.8970585294604, 609.2323672173005, 623.7941479311907, 626.6866566716551, 7502.62486875654, 7966.681332746741, 7985.760427187193, 8364.58177091143, 9160.496172710566, 441.7437886026097, 541.6695815552509, 578.8955464625534, 596.7553303145689, 621.2638023941644, 3056.9847150764103, 3784.564775050849, 3887.7667339959694, 4095.692823038284, 4152.958470415318, 95053.0, 96968.51515742518, 97188.0, 97288.05423891483, 97300.0, 63771.681141593996, 83013.16986830054, 83367.0, 83707.0, 84297.0, 72100.9184862238, 72683.00486946432, 73402.0, 74112.0, 74219.62890185515, 8075.798105047421, 8098.230668086522, 8184.918150818654, 8306.626201821053, 8315.334773218006, 50599.0, 51328.716782080744, 51412.48587514077, 51936.48063519316, 52577.7371113142, 72019.63990180015, 74153.0, 74408.0, 74478.62760686161, 74748.0, 10026.0, 10161.339512931636, 10214.744631384276, 10334.586616535255, 10572.401329911965, 10967.451627418437, 11010.559577616805, 11141.498632561392, 11479.139064570023, 12071.698207544881, 9007.0, 10502.0, 10728.195385346286, 10729.839052414376, 10741.087007604128, 10256.179505639382, 10300.278980471296, 10327.173826094046, 10483.266171368236, 10676.57293708243, 9935.552900119368, 9972.152367048882, 10249.590016399261, 10482.004209600076, 10813.189010824062, 8765.737027889174, 8805.603747831236, 8879.0, 9016.90983090187, 9074.591643375932, 8147.470414423044, 8650.351223658377, 8962.372633915564, 9087.818243634958, 9187.0], "unit": "ms", "name": "yui.html", "value": 6869.8884197007455}], "name": "dromaeo_css", "value": 7641.8777041293415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 111.0, 111.0, 111.0, 98.0, 111.0, 113.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [150.0, 119.0, 144.0, 138.0, 145.0, 167.0, 161.0, 116.0, 156.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 181.0, 184.0, 183.0, 184.0, 184.0, 188.0, 183.0, 186.0], "unit": "ms", "name": "audio-dft", "value": 184.2}, {"lowerIsBetter": true, "replicates": [61.0, 68.0, 74.0, 71.0, 55.0, 57.0, 57.0, 69.0, 70.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 63.7}, {"lowerIsBetter": true, "replicates": [86.0, 79.0, 121.0, 75.0, 73.0, 75.0, 113.0, 74.0, 76.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 88.6}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 86.0, 85.0, 87.0, 87.0, 87.0, 87.0, 85.0, 91.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 95.0, 93.0, 107.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 100.1}, {"lowerIsBetter": true, "replicates": [94.0, 87.0, 87.0, 87.0, 95.0, 87.0, 70.0, 131.0, 143.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 65.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 65.0, 66.0, 68.0, 67.0, 68.0, 67.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 79.0, 82.0, 81.0, 81.0, 82.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [130.0, 142.0, 127.0, 122.0, 123.0, 126.0, 128.0, 130.0, 131.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [135.0, 124.0, 132.0, 136.0, 134.0, 119.0, 148.0, 134.0, 134.0, 126.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 132.2}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 67.0, 65.0, 65.0, 67.0, 66.0, 71.0, 91.0, 91.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1405.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.177459435755], "unit": "score", "name": "Richards", "value": 241.50098199999996}, {"lowerIsBetter": false, "replicates": [161.47263038914903], "unit": "score", "name": "DeltaBlue", "value": 409.468774}, {"lowerIsBetter": false, "replicates": [282.4858757062147], "unit": "score", "name": "Encrypt", "value": 942.2807399999999}, {"lowerIsBetter": false, "replicates": [4761.9047619047615], "unit": "score", "name": "Decrypt", "value": 55.89801000000001}, {"lowerIsBetter": false, "replicates": [1903.041825095057], "unit": "score", "name": "RayTrace", "value": 388.84536863136873}, {"lowerIsBetter": false, "replicates": [800.640512409928], "unit": "score", "name": "Earley", "value": 832.4122870000002}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [28742.85714285714], "unit": "score", "name": "RegExp", "value": 31.69430914512922}, {"lowerIsBetter": false, "replicates": [926.5381083562902], "unit": "score", "name": "Splay", "value": 87.95212983151639}, {"lowerIsBetter": false, "replicates": [4518.018018018018], "unit": "score", "name": "NavierStokes", "value": 328.4626121635092}], "name": "v8_7", "value": 19646.962280243104}]} 05:31:52 INFO - RETURN: dromaeo_css: 7641.88 05:31:52 INFO - RETURN: kraken: 1405.40 05:31:52 INFO - RETURN: v8_7: 19646.96 05:31:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "19646.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1405.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7641.88"}}} 05:31:52 INFO - Return code: 0 05:31:52 INFO - # TBPL SUCCESS # 05:31:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:52 INFO - 2015-11-21 05:31:52.864 screenresolution[2007:19341] starting screenresolution argv=screenresolution get 05:31:52 INFO - 2015-11-21 05:31:52.866 screenresolution[2007:19341] Display 0: 1600x1200x32@60 05:31:52 INFO - 2015-11-21 05:31:52.872 screenresolution[2008:19344] starting screenresolution argv=screenresolution list 05:31:52 INFO - Available Modes on Display 0 05:31:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:53 INFO - Intel Iris: 05:31:53 INFO - Chipset Model: Intel Iris 05:31:53 INFO - Type: GPU 05:31:53 INFO - Bus: Built-In 05:31:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:53 INFO - Vendor: Intel (0x8086) 05:31:53 INFO - Device ID: 0x0a2e 05:31:53 INFO - Revision ID: 0x0009 05:31:53 INFO - Displays: 05:31:53 INFO - Display: 05:31:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:53 INFO - Display Serial Number: 1600x1200 60 05:31:53 INFO - Main Display: Yes 05:31:53 INFO - Mirror: Off 05:31:53 INFO - Online: Yes 05:31:53 INFO - Rotation: Supported 05:31:53 INFO - Return code: 0 05:31:53 INFO - Running post-action listener: _resource_record_post_action 05:31:53 INFO - Running post-run listener: _resource_record_post_run 05:31:54 INFO - Total resource usage - Wall time: 1240s; CPU: 53.0%; Read bytes: 2367488; Write bytes: 694110208; Read time: 35; Write time: 2169 05:31:54 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 334090752; Write bytes: 338733056; Read time: 26113; Write time: 706 05:31:54 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 2367488; Write bytes: 345010176; Read time: 35; Write time: 1429 05:31:54 INFO - Running post-run listener: _upload_blobber_files 05:31:54 INFO - Blob upload gear active. 05:31:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:31:54 INFO - Copying logs to upload dir... 05:31:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1345.658969 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2015-11-21 05:31:54.225671) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 05:31:54.228706) ========= 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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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/pQHj_Wb0RhuGKCza2Skljg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009284 build_url: 'https://queue.taskcluster.net/v1/task/pQHj_Wb0RhuGKCza2Skljg/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-21 05:31:54.251625) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:31:54.251924) ========= 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.G7z7m0jmVX/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.NBgeRpbrXI/Listeners TMPDIR=/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/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.004946 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 05:31:54.300847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 05:31:54.301273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 05:31:54.301757) ========= ========= Total master_lag: 0.26 =========