builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0034 starttime: 1447953620.88 results: success (0) buildid: 20151119065326 builduid: 3fcf9953c55f45268bec00dfe185599f revision: a523d4c7efe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.878926) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.879389) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.879683) ========= 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.cfAfBIHhlC/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.QdKxVTszwu/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.005453 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.904158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.907528) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.926466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.926824) ========= 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.cfAfBIHhlC/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.QdKxVTszwu/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.005513 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.976058) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.980566) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.981085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:20.981488) ========= 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.cfAfBIHhlC/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.QdKxVTszwu/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-19 09:20:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.36M=0.001s 2015-11-19 09:20:21 (8.36 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:21.212287) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:21.212828) ========= 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.cfAfBIHhlC/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.QdKxVTszwu/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.026682 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:21.267868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 09:20:21.268468) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a523d4c7efe2 --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 a523d4c7efe2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cfAfBIHhlC/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.QdKxVTszwu/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-19 09:20:21,348 Setting DEBUG logging. 2015-11-19 09:20:21,348 attempt 1/10 2015-11-19 09:20:21,348 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a523d4c7efe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 09:20:22,903 unpacking tar archive at: mozilla-central-a523d4c7efe2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.800240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 09:20:23.090743) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:23.091335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:23.106633) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:23.107021) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:20:23.107480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 09:20:23.107819) ========= /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.cfAfBIHhlC/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.QdKxVTszwu/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 09:20:23 INFO - MultiFileLogger online at 20151119 09:20:23 in /builds/slave/test 09:20:23 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 09:20:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:23 INFO - {'append_to_log': False, 09:20:23 INFO - 'base_work_dir': '/builds/slave/test', 09:20:23 INFO - 'blob_upload_branch': 'Firefox', 09:20:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:23 INFO - 'branch': 'Firefox', 09:20:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:23 INFO - 'config_files': ('talos/mac_config.py',), 09:20:23 INFO - 'default_actions': ('clobber', 09:20:23 INFO - 'read-buildbot-config', 09:20:23 INFO - 'download-and-extract', 09:20:23 INFO - 'populate-webroot', 09:20:23 INFO - 'create-virtualenv', 09:20:23 INFO - 'install', 09:20:23 INFO - 'run-tests'), 09:20:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:23 INFO - 'download_minidump_stackwalk': True, 09:20:23 INFO - 'download_symbols': 'ondemand', 09:20:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:23 INFO - 'installer_path': 'installer.exe', 09:20:23 INFO - 'log_level': 'info', 09:20:23 INFO - 'log_name': 'talos', 09:20:23 INFO - 'log_to_console': True, 09:20:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:20:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:20:23 INFO - 'opt_config_files': (), 09:20:23 INFO - 'pip_index': False, 09:20:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:23 INFO - 'cmd': ('bash', 09:20:23 INFO - '-c', 09:20:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:23 INFO - 'enabled': True, 09:20:23 INFO - 'halt_on_failure': False, 09:20:23 INFO - 'name': 'check_screen_resolution'},), 09:20:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:23 INFO - 'cmd': ('bash', 09:20:23 INFO - '-c', 09:20:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:23 INFO - 'enabled': True, 09:20:23 INFO - 'halt_on_failure': False, 09:20:23 INFO - 'name': 'check_screen_resolution'},), 09:20:23 INFO - 'run_cmd_checks_enabled': True, 09:20:23 INFO - 'sps_profile': False, 09:20:23 INFO - 'sps_profile_interval': 0, 09:20:23 INFO - 'suite': 'dromaeojs', 09:20:23 INFO - 'system_bits': '64', 09:20:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:23 INFO - 'title': 't-yosemite-r7-0034', 09:20:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:23 INFO - 'use_talos_json': True, 09:20:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:23 INFO - 'work_dir': 'build'} 09:20:23 INFO - ##### 09:20:23 INFO - ##### Running clobber step. 09:20:23 INFO - ##### 09:20:23 INFO - Running pre-action listener: _resource_record_pre_action 09:20:23 INFO - Running main action method: clobber 09:20:23 INFO - rmtree: /builds/slave/test/build 09:20:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:24 INFO - Running post-action listener: _resource_record_post_action 09:20:24 INFO - ##### 09:20:24 INFO - ##### Running read-buildbot-config step. 09:20:24 INFO - ##### 09:20:24 INFO - Running pre-action listener: _resource_record_pre_action 09:20:24 INFO - Running main action method: read_buildbot_config 09:20:24 INFO - Using buildbot properties: 09:20:24 INFO - { 09:20:24 INFO - "properties": { 09:20:24 INFO - "buildnumber": 1, 09:20:24 INFO - "product": "firefox", 09:20:24 INFO - "script_repo_revision": "production", 09:20:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:20:24 INFO - "repository": "", 09:20:24 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:20:24 INFO - "buildid": "20151119065326", 09:20:24 INFO - "slavename": "t-yosemite-r7-0034", 09:20:24 INFO - "stage_platform": "macosx64", 09:20:24 INFO - "basedir": "/builds/slave/test", 09:20:24 INFO - "nightly_build": "True", 09:20:24 INFO - "project": "", 09:20:24 INFO - "platform": "yosemite_r7", 09:20:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:20:24 INFO - "slavebuilddir": "test", 09:20:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:20:24 INFO - "branch": "mozilla-central", 09:20:24 INFO - "repo_path": "mozilla-central", 09:20:24 INFO - "pgo_build": "False", 09:20:24 INFO - "builduid": "3fcf9953c55f45268bec00dfe185599f", 09:20:24 INFO - "revision": "a523d4c7efe2" 09:20:24 INFO - }, 09:20:24 INFO - "sourcestamp": { 09:20:24 INFO - "repository": "", 09:20:24 INFO - "hasPatch": false, 09:20:24 INFO - "project": "", 09:20:24 INFO - "branch": "mozilla-central-macosx64-talos", 09:20:24 INFO - "changes": [ 09:20:24 INFO - { 09:20:24 INFO - "category": null, 09:20:24 INFO - "files": [ 09:20:24 INFO - { 09:20:24 INFO - "url": null, 09:20:24 INFO - "name": "https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:20:24 INFO - } 09:20:24 INFO - ], 09:20:24 INFO - "repository": "", 09:20:24 INFO - "rev": "a523d4c7efe2", 09:20:24 INFO - "who": "sendchange", 09:20:24 INFO - "when": 1447952705, 09:20:24 INFO - "number": 6683731, 09:20:24 INFO - "comments": "", 09:20:24 INFO - "project": "", 09:20:24 INFO - "at": "Thu 19 Nov 2015 09:05:05", 09:20:24 INFO - "branch": "mozilla-central-macosx64-talos", 09:20:24 INFO - "revlink": "", 09:20:24 INFO - "properties": [ 09:20:24 INFO - [ 09:20:24 INFO - "buildid", 09:20:24 INFO - "20151119065326", 09:20:24 INFO - "Change" 09:20:24 INFO - ], 09:20:24 INFO - [ 09:20:24 INFO - "builduid", 09:20:24 INFO - "3fcf9953c55f45268bec00dfe185599f", 09:20:24 INFO - "Change" 09:20:24 INFO - ], 09:20:24 INFO - [ 09:20:24 INFO - "nightly_build", 09:20:24 INFO - "True", 09:20:24 INFO - "Change" 09:20:24 INFO - ], 09:20:24 INFO - [ 09:20:24 INFO - "pgo_build", 09:20:24 INFO - "False", 09:20:24 INFO - "Change" 09:20:24 INFO - ] 09:20:24 INFO - ], 09:20:24 INFO - "revision": "a523d4c7efe2" 09:20:24 INFO - } 09:20:24 INFO - ], 09:20:24 INFO - "revision": "a523d4c7efe2" 09:20:24 INFO - } 09:20:24 INFO - } 09:20:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:20:24 INFO - Running post-action listener: _resource_record_post_action 09:20:24 INFO - ##### 09:20:24 INFO - ##### Running download-and-extract step. 09:20:24 INFO - ##### 09:20:24 INFO - Running pre-action listener: _resource_record_pre_action 09:20:24 INFO - Running main action method: download_and_extract 09:20:24 INFO - mkdir: /builds/slave/test/build/tests 09:20:24 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')]} 09:20:24 INFO - https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:20:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/test_packages.json 09:20:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/test_packages.json 09:20:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:20:26 INFO - Downloaded 1149 bytes. 09:20:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:20:26 INFO - Using the following test package requirements: 09:20:26 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:20:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:20:26 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 09:20:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:20:26 INFO - u'jsshell-mac.zip'], 09:20:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:20:26 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 09:20:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:20:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:20:26 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 09:20:26 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:20:26 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 09:20:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:20:26 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 09:20:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:20:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:20:26 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 09:20:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:26 INFO - https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/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 09:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/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 09:20:32 INFO - Downloaded 17522271 bytes. 09:20:32 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 09:20:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:20:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:20:35 INFO - Return code: 0 09:20:35 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 09:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:35 INFO - https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/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 09:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/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 09:20:36 INFO - Downloaded 17522271 bytes. 09:20:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:20:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:20:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:20:39 INFO - Return code: 0 09:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:39 INFO - https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/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 09:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/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 09:20:40 INFO - Downloaded 11130997 bytes. 09:20:40 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 09:20:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:20:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:20:40 INFO - Return code: 0 09:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:40 INFO - https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 09:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AhyXgK1cQcCBL53ZKsJA2g/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 09:20:43 INFO - Downloaded 109497901 bytes. 09:20:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:20:43 INFO - mkdir: /builds/slave/test/properties 09:20:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:43 INFO - Contents: 09:20:43 INFO - build_url:https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:20:43 INFO - Running post-action listener: _resource_record_post_action 09:20:43 INFO - Running post-action listener: set_extra_try_arguments 09:20:43 INFO - ##### 09:20:43 INFO - ##### Running populate-webroot step. 09:20:43 INFO - ##### 09:20:43 INFO - Running pre-action listener: _resource_record_pre_action 09:20:43 INFO - Running main action method: populate_webroot 09:20:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:20:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:20:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:20:43 INFO - '../fennec_ids.txt'], 09:20:43 INFO - 'tests': ['tcheck2']}, 09:20:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:20:43 INFO - '--tppagecycles', 09:20:43 INFO - '7'], 09:20:43 INFO - 'tests': ['tsvgm']}}, 09:20:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:20:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:20:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:20:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:20:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'tests': ['damp', 'tps']}, 09:20:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['damp', 'tps']}, 09:20:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:20:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:43 INFO - 'other': {'tests': ['a11yr', 09:20:43 INFO - 'ts_paint', 09:20:43 INFO - 'tpaint', 09:20:43 INFO - 'sessionrestore', 09:20:43 INFO - 'sessionrestore_no_auto_restore']}, 09:20:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['a11yr', 09:20:43 INFO - 'ts_paint', 09:20:43 INFO - 'tpaint', 09:20:43 INFO - 'sessionrestore', 09:20:43 INFO - 'sessionrestore_no_auto_restore']}, 09:20:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['a11yr', 09:20:43 INFO - 'ts_paint', 09:20:43 INFO - 'tpaint', 09:20:43 INFO - 'sessionrestore', 09:20:43 INFO - 'sessionrestore_no_auto_restore']}, 09:20:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['a11yr', 09:20:43 INFO - 'ts_paint', 09:20:43 INFO - 'tpaint', 09:20:43 INFO - 'sessionrestore', 09:20:43 INFO - 'sessionrestore_no_auto_restore']}, 09:20:43 INFO - 'other_l64': {'tests': ['a11yr', 09:20:43 INFO - 'ts_paint', 09:20:43 INFO - 'tpaint', 09:20:43 INFO - 'sessionrestore', 09:20:43 INFO - 'sessionrestore_no_auto_restore']}, 09:20:43 INFO - 'other_nol64': {'tests': ['a11yr', 09:20:43 INFO - 'ts_paint', 09:20:43 INFO - 'tpaint', 09:20:43 INFO - 'sessionrestore', 09:20:43 INFO - 'sessionrestore_no_auto_restore']}, 09:20:43 INFO - 'svgr': {'tests': ['tsvgx', 09:20:43 INFO - 'tsvgr_opacity', 09:20:43 INFO - 'tart', 09:20:43 INFO - 'tscrollx', 09:20:43 INFO - 'cart']}, 09:20:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['tsvgx', 09:20:43 INFO - 'tsvgr_opacity', 09:20:43 INFO - 'tart', 09:20:43 INFO - 'tscrollx', 09:20:43 INFO - 'cart']}, 09:20:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'tests': ['tp5o']}, 09:20:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'talos_options': ['--e10s'], 09:20:43 INFO - 'tests': ['tp5o']}, 09:20:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'talos_options': ['--xperf_path', 09:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:43 INFO - 'tests': ['tp5n']}, 09:20:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:43 INFO - 'talos_options': ['--e10s', 09:20:43 INFO - '--xperf_path', 09:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:43 INFO - 'tests': ['tp5n']}}, 09:20:43 INFO - 'talos.zip': {'path': '', 09:20:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:20:43 INFO - Running post-action listener: _resource_record_post_action 09:20:43 INFO - ##### 09:20:43 INFO - ##### Running create-virtualenv step. 09:20:43 INFO - ##### 09:20:43 INFO - Running pre-action listener: _resource_record_pre_action 09:20:43 INFO - Running main action method: create_virtualenv 09:20:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:43 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 09:20:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:43 INFO - Using real prefix '/tools/python27' 09:20:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:47 INFO - Installing pip.................done. 09:20:47 INFO - Return code: 0 09:20:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 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 0x10dc5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc37228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837acdb660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, '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.cfAfBIHhlC/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.QdKxVTszwu/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 09:20:47 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 09:20:47 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 09:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:47 INFO - 'HOME': '/Users/cltbld', 09:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:47 INFO - 'LOGNAME': 'cltbld', 09:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:47 INFO - 'MOZ_NO_REMOTE': '1', 09:20:47 INFO - 'NO_EM_RESTART': '1', 09:20:47 INFO - 'PAGER': '/bin/cat', 09:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:47 INFO - 'PWD': '/builds/slave/test', 09:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:47 INFO - 'SHELL': '/bin/bash', 09:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:20:47 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:47 INFO - 'USER': 'cltbld', 09:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:47 INFO - 'XPC_FLAGS': '0x0', 09:20:47 INFO - 'XPC_SERVICE_NAME': '0', 09:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:47 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 09:20:47 INFO - Cleaning up... 09:20:47 INFO - Return code: 0 09:20:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 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 0x10dc5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc37228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837acdb660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, '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.cfAfBIHhlC/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.QdKxVTszwu/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 09:20:47 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 09:20:47 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 09:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:47 INFO - 'HOME': '/Users/cltbld', 09:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:47 INFO - 'LOGNAME': 'cltbld', 09:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:47 INFO - 'MOZ_NO_REMOTE': '1', 09:20:47 INFO - 'NO_EM_RESTART': '1', 09:20:47 INFO - 'PAGER': '/bin/cat', 09:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:47 INFO - 'PWD': '/builds/slave/test', 09:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:47 INFO - 'SHELL': '/bin/bash', 09:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:20:47 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:47 INFO - 'USER': 'cltbld', 09:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:47 INFO - 'XPC_FLAGS': '0x0', 09:20:47 INFO - 'XPC_SERVICE_NAME': '0', 09:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:48 INFO - Downloading/unpacking psutil>=0.7.1 09:20:48 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 09:20:48 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 09:20:48 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 09:20:48 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 09:20:48 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 09:20:48 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 09:20:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:20:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:50 INFO - Installing collected packages: psutil 09:20:50 INFO - Running setup.py install for psutil 09:20:50 INFO - building 'psutil._psutil_osx' extension 09:20:50 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 09:20:51 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 09:20:51 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 09:20:51 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 09:20:51 INFO - building 'psutil._psutil_posix' extension 09:20:51 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 09:20:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:20:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:20:51 INFO - ^ 09:20:51 INFO - 1 warning generated. 09:20:51 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 09:20:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:51 INFO - Successfully installed psutil 09:20:51 INFO - Cleaning up... 09:20:51 INFO - Return code: 0 09:20:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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', '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 0x10dc5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc37228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837acdb660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, '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.cfAfBIHhlC/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.QdKxVTszwu/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 09:20: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:20: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 mozsystemmonitor==0.0.0 09:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:51 INFO - 'HOME': '/Users/cltbld', 09:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:51 INFO - 'LOGNAME': 'cltbld', 09:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:51 INFO - 'MOZ_NO_REMOTE': '1', 09:20:51 INFO - 'NO_EM_RESTART': '1', 09:20:51 INFO - 'PAGER': '/bin/cat', 09:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:51 INFO - 'PWD': '/builds/slave/test', 09:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:51 INFO - 'SHELL': '/bin/bash', 09:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:20:51 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:51 INFO - 'USER': 'cltbld', 09:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:51 INFO - 'XPC_FLAGS': '0x0', 09:20:51 INFO - 'XPC_SERVICE_NAME': '0', 09:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:20:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:20:54 INFO - Installing collected packages: mozsystemmonitor 09:20:54 INFO - Running setup.py install for mozsystemmonitor 09:20:54 INFO - Successfully installed mozsystemmonitor 09:20:54 INFO - Cleaning up... 09:20:54 INFO - Return code: 0 09:20:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:20:54 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')]} 09:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:54 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')]} 09:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:54 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 0x10dc5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc37228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837acdb660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, '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.cfAfBIHhlC/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.QdKxVTszwu/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 09:20:54 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 09:20:54 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 09:20:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:20:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:54 INFO - 'HOME': '/Users/cltbld', 09:20:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:54 INFO - 'LOGNAME': 'cltbld', 09:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:54 INFO - 'MOZ_NO_REMOTE': '1', 09:20:54 INFO - 'NO_EM_RESTART': '1', 09:20:54 INFO - 'PAGER': '/bin/cat', 09:20:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:54 INFO - 'PWD': '/builds/slave/test', 09:20:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:54 INFO - 'SHELL': '/bin/bash', 09:20:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:20:54 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:20:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:54 INFO - 'USER': 'cltbld', 09:20:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:54 INFO - 'XPC_FLAGS': '0x0', 09:20:54 INFO - 'XPC_SERVICE_NAME': '0', 09:20:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:20:54 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 09:20:54 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 09:20:54 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 09:20:54 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 09:20:54 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 09:20:54 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 09:20:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20:56 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 09:20:56 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 09:20:56 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 09:20:56 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 09:20:56 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 09:20:56 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 09:20:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20:57 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 09:20:57 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 09:20:57 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 09:20:57 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 09:20:57 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 09:20:57 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 09:20:57 INFO - Downloading docopt-0.6.1.tar.gz 09:20:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:57 INFO - Running setup.py install for blobuploader 09:20:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:57 INFO - Running setup.py install for requests 09:20:58 INFO - Running setup.py install for docopt 09:20:58 INFO - Successfully installed blobuploader requests docopt 09:20:58 INFO - Cleaning up... 09:20:58 INFO - Return code: 0 09:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:58 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 0x10dc5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc37228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837acdb660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, '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.cfAfBIHhlC/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.QdKxVTszwu/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 09:20:58 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 09:20:58 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 09:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:58 INFO - 'HOME': '/Users/cltbld', 09:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:58 INFO - 'LOGNAME': 'cltbld', 09:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:58 INFO - 'MOZ_NO_REMOTE': '1', 09:20:58 INFO - 'NO_EM_RESTART': '1', 09:20:58 INFO - 'PAGER': '/bin/cat', 09:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:58 INFO - 'PWD': '/builds/slave/test', 09:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:58 INFO - 'SHELL': '/bin/bash', 09:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:20:58 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:58 INFO - 'USER': 'cltbld', 09:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:58 INFO - 'XPC_FLAGS': '0x0', 09:20:58 INFO - 'XPC_SERVICE_NAME': '0', 09:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:58 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-YTT7JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-8ueLwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-KvcRHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-tR63Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Bz2JYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-JQfXHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-caQpnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-cuZ9Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-1q8nUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-77EvBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:59 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-_W1lPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:00 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-rvYLSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:00 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-JFTT5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:00 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-hq8bHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:00 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-1FBJQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:00 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-oezfeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:00 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-sjFDlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:00 INFO - Running setup.py install for manifestparser 09:21:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:00 INFO - Running setup.py install for mozcrash 09:21:01 INFO - Running setup.py install for mozdebug 09:21:01 INFO - Running setup.py install for mozdevice 09:21:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Running setup.py install for mozfile 09:21:01 INFO - Running setup.py install for mozhttpd 09:21:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Running setup.py install for mozinfo 09:21:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Running setup.py install for mozInstall 09:21:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:01 INFO - Running setup.py install for mozleak 09:21:02 INFO - Running setup.py install for mozlog 09:21:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:02 INFO - Running setup.py install for moznetwork 09:21:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:02 INFO - Running setup.py install for mozprocess 09:21:02 INFO - Running setup.py install for mozprofile 09:21:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:02 INFO - Running setup.py install for mozrunner 09:21:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:02 INFO - Running setup.py install for mozscreenshot 09:21:03 INFO - Running setup.py install for moztest 09:21:03 INFO - Running setup.py install for mozversion 09:21:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:03 INFO - Cleaning up... 09:21:03 INFO - Return code: 0 09:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:03 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 0x10dc5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc37228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837acdb660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, '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.cfAfBIHhlC/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.QdKxVTszwu/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 09:21:03 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 09:21:03 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 09:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:03 INFO - 'HOME': '/Users/cltbld', 09:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:03 INFO - 'LOGNAME': 'cltbld', 09:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:03 INFO - 'MOZ_NO_REMOTE': '1', 09:21:03 INFO - 'NO_EM_RESTART': '1', 09:21:03 INFO - 'PAGER': '/bin/cat', 09:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:03 INFO - 'PWD': '/builds/slave/test', 09:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:03 INFO - 'SHELL': '/bin/bash', 09:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:21:03 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:03 INFO - 'USER': 'cltbld', 09:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:03 INFO - 'XPC_FLAGS': '0x0', 09:21:03 INFO - 'XPC_SERVICE_NAME': '0', 09:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-ywehnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:03 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)) 09:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Z7IKiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:03 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)) 09:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-tBlVG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:03 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)) 09:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:03 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Bh3X0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-a1ljdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Gb4lS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-d_iwKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-ufYq5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-4loFVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-OfO6GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-U3H72B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-xpBX6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-xh9At2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:04 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)) 09:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:04 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-HMY1Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:05 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)) 09:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:05 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-oJSH0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:05 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)) 09:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:05 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-Tsz9ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:05 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)) 09:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:05 INFO - Running setup.py (path:/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/pip-ZRpu2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:05 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)) 09:21:05 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)) 09:21:05 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)) 09:21:05 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)) 09:21:05 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)) 09:21:05 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)) 09:21:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:05 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 09:21:05 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 09:21:05 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 09:21:05 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 09:21:05 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 09:21:05 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 09:21:07 INFO - Downloading blessings-1.5.1.tar.gz 09:21:07 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 09:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:07 INFO - Installing collected packages: blessings 09:21:07 INFO - Running setup.py install for blessings 09:21:07 INFO - Successfully installed blessings 09:21:07 INFO - Cleaning up... 09:21:07 INFO - Return code: 0 09:21:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:08 INFO - Reading from file tmpfile_stdout 09:21:08 INFO - Current package versions: 09:21:08 INFO - blessings == 1.5.1 09:21:08 INFO - blobuploader == 1.2.4 09:21:08 INFO - docopt == 0.6.1 09:21:08 INFO - manifestparser == 1.1 09:21:08 INFO - mozInstall == 1.12 09:21:08 INFO - mozcrash == 0.16 09:21:08 INFO - mozdebug == 0.1 09:21:08 INFO - mozdevice == 0.47 09:21:08 INFO - mozfile == 1.2 09:21:08 INFO - mozhttpd == 0.7 09:21:08 INFO - mozinfo == 0.9 09:21:08 INFO - mozleak == 0.1 09:21:08 INFO - mozlog == 3.0 09:21:08 INFO - moznetwork == 0.27 09:21:08 INFO - mozprocess == 0.22 09:21:08 INFO - mozprofile == 0.27 09:21:08 INFO - mozrunner == 6.11 09:21:08 INFO - mozscreenshot == 0.1 09:21:08 INFO - mozsystemmonitor == 0.0 09:21:08 INFO - moztest == 0.7 09:21:08 INFO - mozversion == 1.4 09:21:08 INFO - psutil == 3.1.1 09:21:08 INFO - requests == 1.2.3 09:21:08 INFO - wsgiref == 0.1.2 09:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:08 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')]} 09:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:08 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')]} 09:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:08 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 0x10dc5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc37228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f837acdb660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, '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.cfAfBIHhlC/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.QdKxVTszwu/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 09:21:08 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 09:21:08 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 09:21:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:21:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:08 INFO - 'HOME': '/Users/cltbld', 09:21:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:08 INFO - 'LOGNAME': 'cltbld', 09:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:08 INFO - 'MOZ_NO_REMOTE': '1', 09:21:08 INFO - 'NO_EM_RESTART': '1', 09:21:08 INFO - 'PAGER': '/bin/cat', 09:21:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:08 INFO - 'PWD': '/builds/slave/test', 09:21:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:08 INFO - 'SHELL': '/bin/bash', 09:21:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:21:08 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:21:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:08 INFO - 'USER': 'cltbld', 09:21:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:08 INFO - 'XPC_FLAGS': '0x0', 09:21:08 INFO - 'XPC_SERVICE_NAME': '0', 09:21:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 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)) 09:21:08 INFO - Cleaning up... 09:21:08 INFO - Return code: 0 09:21:08 INFO - Running post-action listener: _resource_record_post_action 09:21:08 INFO - Running post-action listener: _start_resource_monitoring 09:21:08 INFO - Starting resource monitoring. 09:21:08 INFO - ##### 09:21:08 INFO - ##### Running install step. 09:21:08 INFO - ##### 09:21:08 INFO - Running pre-action listener: _resource_record_pre_action 09:21:08 INFO - Running main action method: install 09:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:08 INFO - Reading from file tmpfile_stdout 09:21:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:08 INFO - Reading from file tmpfile_stdout 09:21:08 INFO - Output received: 09:21:08 INFO - Usage: mozinstall [options] installer 09:21:08 INFO - Options: 09:21:08 INFO - -h, --help show this help message and exit 09:21:08 INFO - -d DEST, --destination=DEST 09:21:08 INFO - Directory to install application into. [default: 09:21:08 INFO - "/builds/slave/test"] 09:21:08 INFO - --app=APP Application being installed. [default: firefox] 09:21:08 INFO - mkdir: /builds/slave/test/build/application 09:21:08 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'] 09:21:08 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 09:21:39 INFO - Reading from file tmpfile_stdout 09:21:39 INFO - Output received: 09:21:39 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 09:21:39 INFO - Running post-action listener: _resource_record_post_action 09:21:39 INFO - ##### 09:21:39 INFO - ##### Running run-tests step. 09:21:39 INFO - ##### 09:21:39 INFO - Running pre-action listener: _resource_record_pre_action 09:21:39 INFO - Running main action method: run_tests 09:21:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:21:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:21:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:21:39 INFO - 2015-11-19 09:21:39.336 screenresolution[1646:7952] starting screenresolution argv=screenresolution get 09:21:39 INFO - 2015-11-19 09:21:39.338 screenresolution[1646:7952] Display 0: 1600x1200x32@60 09:21:39 INFO - 2015-11-19 09:21:39.344 screenresolution[1647:7954] starting screenresolution argv=screenresolution list 09:21:39 INFO - Available Modes on Display 0 09:21:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:21:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:21:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:21:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:21:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:21:39 INFO - Intel Iris: 09:21:39 INFO - Chipset Model: Intel Iris 09:21:39 INFO - Type: GPU 09:21:39 INFO - Bus: Built-In 09:21:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:21:39 INFO - Vendor: Intel (0x8086) 09:21:39 INFO - Device ID: 0x0a2e 09:21:39 INFO - Revision ID: 0x0009 09:21:39 INFO - Displays: 09:21:39 INFO - Display: 09:21:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:21:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:21:39 INFO - Display Serial Number: 1600x1200 60 09:21:39 INFO - Main Display: Yes 09:21:39 INFO - Mirror: Off 09:21:39 INFO - Online: Yes 09:21:39 INFO - Rotation: Supported 09:21:39 INFO - Return code: 0 09:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:39 INFO - Python 2.7.3 09:21:39 INFO - Return code: 0 09:21:39 INFO - grabbing minidump binary from tooltool 09:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:39 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 0x10db7e9f0>, '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 0x10d8dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db718c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:39 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 09:21:39 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 09:21:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:39 INFO - Return code: 0 09:21:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:21:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:21:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:39 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/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--webServer', 'localhost'] in /builds/slave/test/build 09:21:39 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/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --webServer localhost 09:21:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfAfBIHhlC/Render', 09:21:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:39 INFO - 'HOME': '/Users/cltbld', 09:21:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:39 INFO - 'LOGNAME': 'cltbld', 09:21:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:39 INFO - 'MOZ_NO_REMOTE': '1', 09:21:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:39 INFO - 'NO_EM_RESTART': '1', 09:21:39 INFO - 'PAGER': '/bin/cat', 09:21:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:39 INFO - 'PWD': '/builds/slave/test', 09:21:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:39 INFO - 'SHELL': '/bin/bash', 09:21:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QdKxVTszwu/Listeners', 09:21:39 INFO - 'TMPDIR': '/var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/', 09:21:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:39 INFO - 'USER': 'cltbld', 09:21:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:39 INFO - 'XPC_FLAGS': '0x0', 09:21:39 INFO - 'XPC_SERVICE_NAME': '0', 09:21:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:39 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/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--webServer', 'localhost'] with output_timeout 3600 09:21:39 INFO - mozversion INFO | application_buildid: 20151119065326 09:21:39 INFO - mozversion INFO | application_changeset: a523d4c7efe2f43dd6b25a176c07b729918d550f 09:21:39 INFO - mozversion INFO | application_display_name: Nightly 09:21:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:39 INFO - mozversion INFO | application_name: Firefox 09:21:39 INFO - mozversion INFO | application_remotingname: firefox 09:21:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 09:21:39 INFO - mozversion INFO | application_vendor: Mozilla 09:21:39 INFO - mozversion INFO | application_version: 45.0a1 09:21:39 INFO - mozversion INFO | platform_buildid: 20151119065326 09:21:39 INFO - mozversion INFO | platform_changeset: a523d4c7efe2f43dd6b25a176c07b729918d550f 09:21:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 09:21:39 INFO - mozversion INFO | platform_version: 45.0a1 09:21:39 INFO - 2015-11-19 09:21:39,907 DEBUG : using testdate: 1447953699 09:21:39 INFO - 2015-11-19 09:21:39,907 DEBUG : actual date: 1447953699 09:21:39 INFO - 2015-11-19 09:21:39,914 INFO : starting webserver on 'localhost:49261' 09:21:39 INFO - 2015-11-19 09:21:39,915 INFO : Starting test suite t-yosemite-r7-0034 09:21:39 INFO - 2015-11-19 09:21:39,915 INFO : Starting test dromaeo_css 09:21:39 INFO - 2015-11-19 09:21:39,915 DEBUG : operating with platform_type : mac_ 09:21:39 INFO - 2015-11-19 09:21:39,916 INFO : Initialising browser for dromaeo_css test... 09:21:39 INFO - 2015-11-19 09:21:39,928 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmpxkrSWV/profile http://localhost:49261/getInfo.html 09:21:42 INFO - 2015-11-19 09:21:42,078 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:21:42 INFO - 2015-11-19 09:21:42,078 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:21:42 INFO - 2015-11-19 09:21:42,079 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:21:42 INFO - 2015-11-19 09:21:42,079 DEBUG : BROWSER_OUTPUT: __metrics 09:21:42 INFO - 2015-11-19 09:21:42,094 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:42 INFO - 2015-11-19 09:21:42,749 INFO : Browser initialized. 09:21:42 INFO - 2015-11-19 09:21:42,750 INFO : Running cycle 1/1 for dromaeo_css test... 09:21:42 INFO - 2015-11-19 09:21:42,750 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmpxkrSWV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:21:54 INFO - 2015-11-19 09:21:54,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 224509952 09:21:54 INFO - 2015-11-19 09:21:54,550 DEBUG : BROWSER_OUTPUT: 09:22:45 INFO - 2015-11-19 09:22:45,552 DEBUG : BROWSER_OUTPUT: 1447953765545 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] 09:24:57 INFO - 2015-11-19 09:24:57,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49261/tests/dromaeo/cssquery-ext.html) 09:24:59 INFO - 2015-11-19 09:24:59,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 348995584 09:24:59 INFO - 2015-11-19 09:24:59,135 DEBUG : BROWSER_OUTPUT: 09:28:02 INFO - 2015-11-19 09:28:02,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-ext.html (next: http://localhost:49261/tests/dromaeo/cssquery-jquery.html) 09:28:02 INFO - 2015-11-19 09:28:02,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 362831872 09:28:02 INFO - 2015-11-19 09:28:02,664 DEBUG : BROWSER_OUTPUT: 09:31:04 INFO - 2015-11-19 09:31:04,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49261/tests/dromaeo/cssquery-mootools.html) 09:31:05 INFO - 2015-11-19 09:31:05,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 366055424 09:31:05 INFO - 2015-11-19 09:31:05,448 DEBUG : BROWSER_OUTPUT: 09:34:07 INFO - 2015-11-19 09:34:07,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49261/tests/dromaeo/cssquery-prototype.html) 09:34:08 INFO - 2015-11-19 09:34:08,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 329805824 09:34:08 INFO - 2015-11-19 09:34:08,034 DEBUG : BROWSER_OUTPUT: 09:37:11 INFO - 2015-11-19 09:37:11,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49261/tests/dromaeo/cssquery-yui.html) 09:37:11 INFO - 2015-11-19 09:37:11,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 330883072 09:37:11 INFO - 2015-11-19 09:37:11,644 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/dromaeo/cssquery-yui.html (next: http://localhost:49261/tests/dromaeo/cssquery-dojo.html) 09:40:14 INFO - 2015-11-19 09:40:14,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 383221760 09:40:14 INFO - 2015-11-19 09:40:14,269 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,269 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:40:14 INFO - 2015-11-19 09:40:14,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:40:14 INFO - 2015-11-19 09:40:14,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:40:14 INFO - 2015-11-19 09:40:14,269 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:40:14 INFO - 2015-11-19 09:40:14,269 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3424.9143771405716;3474.583050033995;3485.6862882340592;3505.1587618971453;3524.68277854993;5746.109353050284;5853.61951473155;5901.793437229698;5945.702714864261;5948.464638182568;5883.0881213411885;5931.703414829252;5951.910721339173;5957.106434034897;5959.672218028007;5294.629375943686;5339;5392.083345831198;5412.079946409101;5429.294191755066;5442.428545002777;5446.509814116729;5452.645578037414;5455.1817227416;5457.454254574551;5439.83680489584;5441.211024401459;5445.019896418643;5453.918191227135;5454.672719636815;5431.891362172774;5439.401665816757;5439.864003399907;5440.782368705247;5457.208704737791;5226.477352264781;5278.683279003234;5378.946210537883;5398.649087809319;5419.241306217133;5844.357120716718;6043.7884674036195;6051.1225872248715;6052.788152414644;6057.273127224761;6296.68516574174;6329.2721337045905;6341.334159913189;6350.491960643138;6362.936370636281;6205.87588248237;6282.842928926768;6325.715342809584;6331.240251169843;6334.2398912130375;5994.280686317583;6061.121137435047;6078.878422431527;6079.936011198022;6090.725917333731;6481.740730370732;6486.059521369375;6488.448481878999;6495.545311828221;6502.057201705727;6123.479504242189;6211.503079753609;6244.718987645567;6250.9062364064575;6326.936730632727;6358.618482891041;6371.139896113966;6410.391012853772;6418.454431373386;6430.3891130342545;6175.783847565313;6329.651869147149;6341.873162536724;6358.395952384516;6370.267419246846;6188.4739797116845;6216.222972128484;6297.685115744286;6320.336364681642;6342.112104305401;5096.082705113041;5112.923306150411;5115.386153661584;5120.18077107661;5165.354330708661;4544.454665440168;4546.454425468899;4551.362809206714;4557.361969324297;4597.7241365518175;5866.442687944638;5932.288125424977;5966.880662386815;5999.5800293979;6076;6326.778562750282;6331.461825744771;6343.921533339343;6347.650879201688;6359.268684101295;5880.852978675567;6007.879842403127;6028.909566356509;6038.818835434944;6106.236720409949;5586.35756887955;5599.776008959678;5601.719914004365;5602.915956260659;5604.915926261109;6370.93629063722;6437.871242575216;6575.145231119924;6578.473722102221;6580.374864387972;6245.594036387621;6356.237251529846;6367.872642547216;6369.87260254783;6396.9040464394;6488.805335839932;6548.639824809491;6559.048937904073;6572.704228309642;6578.671066446755;6168.136460895388;6365.458935990493;6369.172007638977;6370.108184854032;6374.872502550016;6218.409251121137;6315.905261421174;6319.842003949938;6326.240851097898;6338.461230795249;6089;6309.842253943688;6317.084022816758;6321.715522801577;6335.113084168128;6104.216637118914;6260.561760676709;6317.147185129948;6335.873282534231;6347.333529979285;6092.449494447823;6099.491378240913;6163.013917773134;6165.660888651168;6210.254769427697;6180.165677633462;6232.439080482778;6233.127362169391;6237.625742455467;6251.78118765841;6034.2155519782145;6132.386761323832;6135.6932153393045;6141.723622437091;6174.413430724074 09:40:14 INFO - 2015-11-19 09:40:14,271 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.7985935133678;563.7744902039182;581.3459857660132;606.5299392970447;636.3763511758474;32722.67277327229;40200.79899600498;41869.581304186984;41949.58050419495;41984.580154198484;39043.80478097613;45835;45950;45951.080978380414;45992.77003614977;8730.781730456725;8869.822603547957;9731.805363892736;9945;9965.15296199824;8726.825463490726;12120.333381664004;12314.876851231507;12323.5070597176;12371.814422783666;11946.581869634565;12015.579454719087;12020.759584808298;12022.819657705142;12085.335306558136;7739.6904123834975;8883.689070882552;9042.593083311267;11939;12036;8788;8905.996150866069;8941.50821704806;11775.764484710258;11986.160968732192;40563;41218.587814121776;41259.1748165038;41274.38088428676;41354;3282.83585820708;3350.1289664687356;3353.917963365643;3458.1181798641437;3519.0498565387456;28615;30352.848235758902;30390.088297351114;30581.694183058105;30676.2330941726;2571.2286314105695;2577.80666450017;2604.6744156980376;2717.619533265344;2748.093129267337;505327;507198;508701;509772;511337;72925.6353718228;73523;73619.89570156451;73704;73748.26251737414;65458.672706636164;75700.62149689326;76965.61517192378;77136;77313;15502.302396391964;17098.487045388658;17313.39403120885;17334.913325433292;17343;11644.6506604802;11652.825207621892;11716.414179291001;11719;13078.542251021168;17848.121502797763;21540.784592154192;22501.887490562443;22542.887285563465;22572.435689107904;7905.821686795159;8793.648254069765;8854.734357969272;8861.64553417869;8875.600597973107;779.5985067690144;896.3814967672286;955.245356168633;972.3096601412934;1034.8292531732332;29064.982725604503;29933.70066299309;30228.546571801442;30503.389932201233;30517;944.5041353289578;1023.2939271902363;1076.967690969272;1081.6106201767357;1138.4933704501418;15414;15428.614284642974;15523.767143492856;15621.375144994301;15802.841971580137;672973;685762;686211;686230;686772;56953.01993290728;56953.71523142358;57172;62585.43536411535;63118.368816311246;1257;1457.9635509112145;1494.1707352419512;1497.453429498247;1509.532045066033;31277;32036.51945220777;32191.195220119684;32752.50871236981;33056.843010494515;45623.54376456193;46988.295175573076;54072.91854162973;55336.16995745148;55341;425027;430010;434404;434716;434794;34476;35019.949401517995;35260.64739352574;35353.646463535035;35394.11514712153;45114.323285150094;46301.76849115733;46719.532804671515;46739.766301168274;47393.52606473891;36970;38389.80805095957;38645.806770965966;38971.6102838968;39425.60574394219;37519.249615007;37661.942764852545;38271.6172838268;38426.23147537089;38435.80782096072;38267.42598860963;39776.60223397729;40731.79634101929;40922;41026.38460423036;31280.530792038593;33794.41903201934;34359.656403436646;34378;34499.48250776291;25532.361690957874;25839.41387111709;25953.351166220997;26072.34819129461;26075.348116297246 09:40:14 INFO - 2015-11-19 09:40:14,272 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.3092803569022;354.4258301551487;354.43467669067843;357.85506869717767;357.91231148368655;15727.370905163809;15997.680046399095;19016.334428295013;19793.703094453576;20721.68917466239;16459.25933333;19166.46668266539;19976;20371.796282037176;20509.794902050977;5055.646104772667;5420.24116623672;5897.587168898179;5946.405359464062;5959.553033522481;4229.577042295761;4383.890402739925;4384.758838263894;5951.851203719898;5998.580099393044;5467.316585426822;6318.8104356869135;6439.452646525051;6467.062275969982;6492.448141907944;6083.300420451638;6155.661438620874;6160.476359509447;6167.167432396636;6437.774677886275;5579.218909352694;5626.578006649518;5646.068398714207;5659.490645841894;5682.119271512922;24785.504289914283;24847.13035043765;24856.87571562149;25028.998840046377;25442.618360724606;1870.494966359089;1986.433866348084;2002.4192984034612;2044.7137400763904;2326.1858349577683;9859.260555458297;9898.9505052475;9915.256355773347;10182.389056656624;10230.795384092351;1280.5774094548776;1553.0448774003905;1593.1715507935924;1625.8292879247745;1677.1278934953755;69048;94152.52923735406;96056;96713;96722.51638741832;5517.36550296713;6626.237982631963;6672.7330906764155;6716.429103526158;6721.966390168018;7601.847963040708;7607.809804754926;7610.8097297568;7613.162552119263;7614.581198034161;4636.327732478771;5621.100623900156;5633.042382794934;5681.914771278434;5694.1458781183155;5214.243934629533;6092.598702298407;6151.477124444383;6197.194364732646;6205.131281620576;2964.6442426908907;2993.595864558257;3000.2349400903067;3021.77336699744;3022.486177349856;1039.1946241662772;1040.9063184313297;1045.51536817719;1082.718493191776;1135.8012347839094;406.8372650939648;440.5704438172756;456.1401757686718;463.5850913432459;464.7745843266013;11661.591844285409;11847.703807404712;12222.816657750142;12318.260904345769;12377.443015064344;449.67398635988644;450.3155204089765;452.8482958208971;460.1280573313552;466.69664717933614;6343.968280158662;6538.967305163539;6623;6625.105610742585;6665.433438157811;657946;794333;797759;807226;809303.9534802288;118360;120097;120407;120516;121550;529.1216580476467;531.4632221456279;534.5269436548682;534.5322842512801;535.199876185098;10832.079273261861;11508.769824603629;11989.700257493632;12022.158448908493;12093.818592721293;48719.07685538879;48826;49357;49432.25851612301;49776;53915.6521086976;54026.83892644408;63618.68190659017;64462;70529;6375.649339286384;6469.5794773339585;6474.0612611172055;6479.31967143462;6481.675916204265;12017.879821201675;12476.376181191086;12506.624801255977;12541.874581254071;12584.370781460708;10701.090407315465;10832.945835270773;10887;10990.395528246023;10995.120390368911;8483.363747718822;10407.739806504898;10720.785584288114;10816.351018938889;10924.508397122308;9438.622455101993;10668.359898406121;11228.606998755004;11234.4382780859;11254.268472549258;5357.410684824588;5705.4009329019855;5986.2517185351835;6122.877542449215;6404.711787969646;10921.781564368826;11117.27737697047;11274.210805243554;11295.491702873225;11315.660530184108 09:40:14 INFO - 2015-11-19 09:40:14,277 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1613.354658136746;1673.138333758114;1734.9826501734983;1843.2903332217102;1929.5079754662559;7200.567965922041;7382.667779949915;7386.889196662054;7398.001269828572;7401.8519629607445;7427.814304642373;8110.513369197837;8294.668213271478;8296.460730052542;8335;2304.493011537463;2390.270967354956;2390.748971358;2395.209580838319;2400.939976500584;2248.85382450141;2290.324354315481;2308.1459859851793;2311.3759284993043;2311.3759284993043;2322.8257880658934;2357.0925193800426;2365.2431222008963;2374.8337616366775;2390.5457962987066;2027.7668068172127;2308.1921327535397;2329.9767002329927;2330.3358542815386;2336.7780060894274;2351.2005917987794;2379;2383.380321116505;2384.308550520347;2388.474535602182;8238.958805205995;8344.749657510285;8371;8375.288100511403;8392.664293428255;4415.602595766364;4571.108633816407;5107.668001579886;5221.060209162387;5221.242919776649;3116.797408168462;3427.417339052367;3465.8440370183403;3571.2143328467696;3596.17288023756;1040.0691381213846;1041.500079961615;1066.1311031509294;1087.5649740103943;1092.257265059759;10977.506012229389;11002.834957475645;11008.229423940327;11009.229353945228;11014.559417623286;4630.609077338295;4684.836030738976;4759.048190361941;4761.999980004238;4766.308885211625;9603.759906002266;9623.941366449824;9630.759231019141;9637.614495420245;9654.22766178704;5132.101882170605;5164.92252616211;5174.767135478913;5221.530062294411;5222.086134926372;4718.811247550128;4719.457262414798;4726.125666751594;4775.092732380836;4820.493848145894;3798.5441746990537;3815.961840381616;3838.596947320547;3861.2084522672785;3871.4192871069004;1257.8867901888873;1257.9874201257871;1263.8293830332786;1271.6375832887582;1273.9426725797362;1301.479408236713;1310.0240320960945;1320.9141405808784;1343.8588948160498;1344.8050032745198;7706.845863082707;7769.883451748228;7817.452778305577;7818.8827167592535;7824.491408058458;488.75806475793996;491.09638265591485;491.1012846490913;494.5178451010236;508.7430847422028;5166.5866730661455;6090.756369745249;6171.814845554641;6184.257889053252;6191.628502289877;7758.650860711282;9502.239820814319;10164.33931794431;10176.796464070678;10185.134263587677;9691.418514889128;9843.852342214872;9910.851337229948;9961.203103751683;9975.052370024836;7821.530708157528;7847.843043139105;7859.371250299962;7865.410094242955;7886.171951945078;7601.201873803171;7667.156612772479;7691.653875575725;7712.460127791225;7713.845723085619;8794.736157915273;8814;8878.86681699788;9099.1810737034;9162.770930726785;9125.863112053457;9373.531323433937;9384.812303754023;9557.474338911426;9564.95217523908;7300.23347548521;7367.005454263606;7386.593737344498;7388.667509961957;7405.96297018533;7538.170801211752;7766.922330776846;7774.766756997299;7782.649780759993;7795.64919578609;7212.531185472927;7434.628268586441;7446.404287657083;7563.243675632612;7599.810004749705;7314.890276645748;7319.34125928669;7444.367228785397;7448.664810083451;7502;7354.742584009534;7499.512531685423;7519.887201692089;7532.43506736986;7539.660715267936;6855.245922948571;6889.724411023503;6909.723611055501;6914.757983470555;6916.100906882073;6886.208086070166;6958.025876377413;6958.930410695828;6966.12923384577;6971.79084627462 09:40:14 INFO - 2015-11-19 09:40:14,277 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.7818683295359;324.16204112369525;327.2505961348512;329.69338515180885;330.62474091905693;6812.386885180339;6812.897806532906;6891.965540172292;6924.78816207163;6929.965350173255;6821.283765204656;6824.7952561423235;6836.521443498945;6837.188145141529;6861.691223894924;4849.199882019462;4990.326305948705;4991.1016017117;5000.149974504343;5015.849524514252;4951.678140920847;4970.826021089262;4974.37820272466;4992.400911890578;5008.2738002989545;4912.975435122819;4913.533214344631;4922.778474968635;4936.6297527685565;4956.355673762406;3801.752886062397;4811.13399588074;4817.951820481785;4927.965127323284;4932.432770231416;4074.775887326196;4122.6083522065355;4240.406343111967;4247.8300867965245;4260.723053001545;6557.704903279317;6570.653016131681;6601.184674214582;6601.405873471363;6613.140291762088;5560.6941618210985;5564.969232141274;5924.881502369972;5928.584999050068;5961.195238642815;5895.380984996599;7172.13934327884;7284.814555633342;7287.817804554876;7292.489525733201;4719.433667959833;4742.786574604151;4742.834000809989;4757;4769.570738633505;5507.218854478503;7747.496412733154;7758;7758.495697779626;7786.57173855432;4336.869893903125;4379.934300985487;4712.64655150865;4767.4994125617;4770.308305295713;4816.133096042676;4831.637627177975;4836.927446088241;4845.781939812647;4849.9030019399415;5817.94182058174;5832.766689332379;5852.180694702745;5854.151148083504;5861.9706901465215;7131.001659767637;7368.815779605446;7369.263073692588;7386.59373734439;7397.112346518452;1658.8009438867414;1663.8502534771928;1668.4994501649699;1672.1137796967625;1672.4564516532175;1047.7904419116207;1053.931494452858;1067.9946600266949;1072.8819829818713;1084.8643919510062;6925;6954.374106330454;6964.930350696428;6965.65171741421;6966.02475653409;7600.1639819619795;7602.7339043133225;7603.163651998276;7627.12288086866;7628.084629844343;5730.914036289459;6697.933020669731;6871.931280687129;6949.478789090838;6952.756653517103;4027;4063.167050754588;4065.5527891931865;4067.186562687474;4078.592140785957;7909.525428474195;7976.242256985577;7988.961435013411;8011.118776934532;8030.39772017101;6503.959366501337;7620.961895190489;7720.845583088307;7761.883571746428;7927.8810817837775;7816.68733250675;7950;7968.442209045543;7968.800779980547;7981;6184.319724830355;7644.770656880302;7649.923500765144;7660.770176894702;7673.079230492153;7206.495545311778;7453.776386708408;7454.701811927463;7460.515066520658;7485.288897554724;7900.209979002054;7926.088499822594;7926.128125906261;7931;7940.6029698515995;3921.627445392683;4707.29390591414;4742.454617719007;4755.857324280277;4773.284007398779;7433.776986690408;7667.3099421052375;7678.078630564368;7682.961585192038;7685.923140768745;7401.444891633041;7416.851662966603;7422.47839192975;7424.0348754661545;7431.702731890664;5857.209276747755;6957.617331046841;7388.778336649909;7409.555426674417;7431.331180193809;7210.783676489714;7225.205227425085;7228.20489746138;7231.2768723127265;7231.385332246818;7378.29906158914;7379.852402952019;7390.334869861738;7390.445716571171;7402.3707984821895;6976.302369762983;7195.676194571152;7259.12890453149;7262.709491620276;7263.128424589083 09:40:14 INFO - 2015-11-19 09:40:14,278 DEBUG : BROWSER_OUTPUT: |5;yui.html;715.4240836126918;787.4920676163874;800.9107613645438;807.685002848889;812.3420029775882;13128.73742525149;15038.473653422132;15042.022268552537;15054.473093441731;15064.548063558112;12691.4923403064;13955.93022034891;14206.289685515734;14259.857401425983;14279.71440571188;930.2976252929046;955.0592666223764;955.0592666223764;955.106974978394;957.3298690916351;943.4575119306427;960.9855852162223;961.2646325560952;962.9759256018585;963.8602402651646;981.9803603927953;1002.2382988928431;1002.8896821349646;1003.9548220330066;1004.5128112865254;993.1607791416242;1000.4947501511726;1001.864748258983;1002.0680766886792;1002.5739060899125;701.1586096684;737.6385571070138;743.4015617427968;743.4721347843038;744.7505085796265;13216;13354.86645133546;13380.86619133806;13381.26403047832;14794;10247.538860751283;10273.229507786871;10654.307470014424;10790.298630588986;11020.889791102147;9764.951175244149;9859;9894.455804930725;9903.108720215143;10547.156227501782;3110.0514343125337;3116.4234616596004;3133.905982820519;3155.368926214743;3170.651228364878;54212.18681719778;54558;61441;63260.051099234006;74642;7266.237045110293;7314.45141614381;7372.189059203483;7375.262473752582;7684.654190561439;12786.168899021533;12811.807822882663;12820.61538153857;12831.871681283068;12839.935800320938;6445.645489498029;6460.709268082947;6574.704138313692;6693;6720.563163394461;3941.2117576484816;4001.0397504598686;4002.1195337025806;4002.899927501836;4004.7196696231567;3174.777765556435;3203.3753418083716;3213.839308034589;3215;3216.3567286542784;445.6746575000268;464.0487001646611;465.12092145844383;465.1650287733526;488.0312579529631;471.37307381182944;476.8307250925941;486.50619621084627;490.9312696222532;511.4706279001216;8012.959935200287;8695.826063481349;8939.776505587412;9265.536723163816;9542.761430964143;469.0706537672191;497.9975100124476;506.6270407196465;507.8857257117119;534.3374215972167;3985.70107241958;4117.547069822317;4171.374293855946;4178.937315940263;4246.10831725335;93371.0662893376;103239;104457.95542044635;104555.4772226134;104707;64417;66330.0050499243;82701.58649206716;84385;84678.57660711657;74849;74928.62535687287;75012.62493687497;75516;77616;8750.387472876837;9147;9153.954230228806;9165.77085572866;9229.261659067124;42649;46966.29550556676;50398.488045358696;51031.744841275555;55354;47440.52559474361;67282;67806.66096669485;67835;73166.63416682882;7625.542467451971;8034.517928924283;8062.153473885158;8122.959385203036;8177.6320065596;10443.582256709951;11112.944270294309;11269.887301126884;12030.270616109034;12967.286799226133;11700.06399488056;11709.590164344207;11752.23610465317;11977.520899163936;12147.132593207185;11444.771104577696;11510.654680359603;11554.480048397674;11757.353345566076;12312.26126432417;9290.303227257848;11058.944705276423;11282.746791387974;11295.661130166109;11412.828807567726;9757.707268781947;9876.35803672759;10220.744481388025;10353.17174626013;10738.12778781191;9279.860802087838;9522.387168075278;9763.316567840184;10152.593896244067;10205.38767673942 09:40:14 INFO - 2015-11-19 09:40:14,279 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:40:14 INFO - 2015-11-19 09:40:14,279 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:40:14 INFO - 2015-11-19 09:40:14,279 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1106 09:40:14 INFO - 2015-11-19 09:40:14,279 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:40:14 INFO - 2015-11-19 09:40:14,280 DEBUG : BROWSER_OUTPUT: __startTimestamp1447954814265__endTimestamp 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5922.72 Median:6135.69 stddev:631.32 (10.3%) stddev-sans-first:602.08 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: Values: 3424.9 3474.6 3485.7 3505.2 3524.7 5746.1 5853.6 5901.8 5945.7 5948.5 5883.1 5931.7 5951.9 5957.1 5959.7 5294.6 5339.0 5392.1 5412.1 5429.3 5442.4 5446.5 5452.6 5455.2 5457.5 5439.8 5441.2 5445.0 5453.9 5454.7 5431.9 5439.4 5439.9 5440.8 5457.2 5226.5 5278.7 5378.9 5398.6 5419.2 5844.4 6043.8 6051.1 6052.8 6057.3 6296.7 6329.3 6341.3 6350.5 6362.9 6205.9 6282.8 6325.7 6331.2 6334.2 5994.3 6061.1 6078.9 6079.9 6090.7 6481.7 6486.1 6488.4 6495.5 6502.1 6123.5 6211.5 6244.7 6250.9 6326.9 6358.6 6371.1 6410.4 6418.5 6430.4 6175.8 6329.7 6341.9 6358.4 6370.3 6188.5 6216.2 6297.7 6320.3 6342.1 5096.1 5112.9 5115.4 5120.2 5165.4 4544.5 4546.5 4551.4 4557.4 4597.7 5866.4 5932.3 5966.9 5999.6 6076.0 6326.8 6331.5 6343.9 6347.7 6359.3 5880.9 6007.9 6028.9 6038.8 6106.2 5586.4 5599.8 5601.7 5602.9 5604.9 6370.9 6437.9 6575.1 6578.5 6580.4 6245.6 6356.2 6367.9 6369.9 6396.9 6488.8 6548.6 6559.0 6572.7 6578.7 6168.1 6365.5 6369.2 6370.1 6374.9 6218.4 6315.9 6319.8 6326.2 6338.5 6089.0 6309.8 6317.1 6321.7 6335.1 6104.2 6260.6 6317.1 6335.9 6347.3 6092.4 6099.5 6163.0 6165.7 6210.3 6180.2 6232.4 6233.1 6237.6 6251.8 6034.2 6132.4 6135.7 6141.7 6174.4 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,281 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:69332.13 Median:38431.02 stddev:147239.43 (383.1%) stddev-sans-first:147561.92 09:40:14 INFO - 2015-11-19 09:40:14,283 DEBUG : BROWSER_OUTPUT: Values: 551.8 563.8 581.3 606.5 636.4 32722.7 40200.8 41869.6 41949.6 41984.6 39043.8 45835.0 45950.0 45951.1 45992.8 8730.8 8869.8 9731.8 9945.0 9965.2 8726.8 12120.3 12314.9 12323.5 12371.8 11946.6 12015.6 12020.8 12022.8 12085.3 7739.7 8883.7 9042.6 11939.0 12036.0 8788.0 8906.0 8941.5 11775.8 11986.2 40563.0 41218.6 41259.2 41274.4 41354.0 3282.8 3350.1 3353.9 3458.1 3519.0 28615.0 30352.8 30390.1 30581.7 30676.2 2571.2 2577.8 2604.7 2717.6 2748.1 505327.0 507198.0 508701.0 509772.0 511337.0 72925.6 73523.0 73619.9 73704.0 73748.3 65458.7 75700.6 76965.6 77136.0 77313.0 15502.3 17098.5 17313.4 17334.9 17343.0 11644.7 11652.8 11716.4 11719.0 13078.5 17848.1 21540.8 22501.9 22542.9 22572.4 7905.8 8793.6 8854.7 8861.6 8875.6 779.6 896.4 955.2 972.3 1034.8 29065.0 29933.7 30228.5 30503.4 30517.0 944.5 1023.3 1077.0 1081.6 1138.5 15414.0 15428.6 15523.8 15621.4 15802.8 672973.0 685762.0 686211.0 686230.0 686772.0 56953.0 56953.7 57172.0 62585.4 63118.4 1257.0 1458.0 1494.2 1497.5 1509.5 31277.0 32036.5 32191.2 32752.5 33056.8 45623.5 46988.3 54072.9 55336.2 55341.0 425027.0 430010.0 434404.0 434716.0 434794.0 34476.0 35019.9 35260.6 35353.6 35394.1 45114.3 46301.8 46719.5 46739.8 47393.5 36970.0 38389.8 38645.8 38971.6 39425.6 37519.2 37661.9 38271.6 38426.2 38435.8 38267.4 39776.6 40731.8 40922.0 41026.4 31280.5 33794.4 34359.7 34378.0 34499.5 25532.4 25839.4 25953.4 26072.3 26075.3 09:40:14 INFO - 2015-11-19 09:40:14,283 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,283 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36917.25 Median:2549.96 stddev:127732.94 (5009.2%) stddev-sans-first:128061.75 09:40:14 INFO - 2015-11-19 09:40:14,284 DEBUG : BROWSER_OUTPUT: Values: 353.3 354.4 354.4 357.9 357.9 15727.4 15997.7 19016.3 19793.7 20721.7 16459.3 19166.5 19976.0 20371.8 20509.8 5055.6 5420.2 5897.6 5946.4 5959.6 4229.6 4383.9 4384.8 5951.9 5998.6 5467.3 6318.8 6439.5 6467.1 6492.4 6083.3 6155.7 6160.5 6167.2 6437.8 5579.2 5626.6 5646.1 5659.5 5682.1 24785.5 24847.1 24856.9 25029.0 25442.6 1870.5 1986.4 2002.4 2044.7 2326.2 9859.3 9899.0 9915.3 10182.4 10230.8 1280.6 1553.0 1593.2 1625.8 1677.1 69048.0 94152.5 96056.0 96713.0 96722.5 5517.4 6626.2 6672.7 6716.4 6722.0 7601.8 7607.8 7610.8 7613.2 7614.6 4636.3 5621.1 5633.0 5681.9 5694.1 5214.2 6092.6 6151.5 6197.2 6205.1 2964.6 2993.6 3000.2 3021.8 3022.5 1039.2 1040.9 1045.5 1082.7 1135.8 406.8 440.6 456.1 463.6 464.8 11661.6 11847.7 12222.8 12318.3 12377.4 449.7 450.3 452.8 460.1 466.7 6344.0 6539.0 6623.0 6625.1 6665.4 657946.0 794333.0 797759.0 807226.0 809304.0 118360.0 120097.0 120407.0 120516.0 121550.0 529.1 531.5 534.5 534.5 535.2 10832.1 11508.8 11989.7 12022.2 12093.8 48719.1 48826.0 49357.0 49432.3 49776.0 53915.7 54026.8 63618.7 64462.0 70529.0 6375.6 6469.6 6474.1 6479.3 6481.7 12017.9 12476.4 12506.6 12541.9 12584.4 10701.1 10832.9 10887.0 10990.4 10995.1 8483.4 10407.7 10720.8 10816.4 10924.5 9438.6 10668.4 11228.6 11234.4 11254.3 5357.4 5705.4 5986.3 6122.9 6404.7 10921.8 11117.3 11274.2 11295.5 11315.7 09:40:14 INFO - 2015-11-19 09:40:14,284 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,284 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5755.68 Median:6178.04 stddev:2989.28 (48.4%) stddev-sans-first:2981.45 09:40:14 INFO - 2015-11-19 09:40:14,286 DEBUG : BROWSER_OUTPUT: Values: 1613.4 1673.1 1735.0 1843.3 1929.5 7200.6 7382.7 7386.9 7398.0 7401.9 7427.8 8110.5 8294.7 8296.5 8335.0 2304.5 2390.3 2390.7 2395.2 2400.9 2248.9 2290.3 2308.1 2311.4 2311.4 2322.8 2357.1 2365.2 2374.8 2390.5 2027.8 2308.2 2330.0 2330.3 2336.8 2351.2 2379.0 2383.4 2384.3 2388.5 8239.0 8344.7 8371.0 8375.3 8392.7 4415.6 4571.1 5107.7 5221.1 5221.2 3116.8 3427.4 3465.8 3571.2 3596.2 1040.1 1041.5 1066.1 1087.6 1092.3 10977.5 11002.8 11008.2 11009.2 11014.6 4630.6 4684.8 4759.0 4762.0 4766.3 9603.8 9623.9 9630.8 9637.6 9654.2 5132.1 5164.9 5174.8 5221.5 5222.1 4718.8 4719.5 4726.1 4775.1 4820.5 3798.5 3816.0 3838.6 3861.2 3871.4 1257.9 1258.0 1263.8 1271.6 1273.9 1301.5 1310.0 1320.9 1343.9 1344.8 7706.8 7769.9 7817.5 7818.9 7824.5 488.8 491.1 491.1 494.5 508.7 5166.6 6090.8 6171.8 6184.3 6191.6 7758.7 9502.2 10164.3 10176.8 10185.1 9691.4 9843.9 9910.9 9961.2 9975.1 7821.5 7847.8 7859.4 7865.4 7886.2 7601.2 7667.2 7691.7 7712.5 7713.8 8794.7 8814.0 8878.9 9099.2 9162.8 9125.9 9373.5 9384.8 9557.5 9565.0 7300.2 7367.0 7386.6 7388.7 7406.0 7538.2 7766.9 7774.8 7782.6 7795.6 7212.5 7434.6 7446.4 7563.2 7599.8 7314.9 7319.3 7444.4 7448.7 7502.0 7354.7 7499.5 7519.9 7532.4 7539.7 6855.2 6889.7 6909.7 6914.8 6916.1 6886.2 6958.0 6958.9 6966.1 6971.8 09:40:14 INFO - 2015-11-19 09:40:14,286 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,286 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5954.39 Median:6830.66 stddev:1944.02 (28.5%) stddev-sans-first:1902.93 09:40:14 INFO - 2015-11-19 09:40:14,286 DEBUG : BROWSER_OUTPUT: Values: 320.8 324.2 327.3 329.7 330.6 6812.4 6812.9 6892.0 6924.8 6930.0 6821.3 6824.8 6836.5 6837.2 6861.7 4849.2 4990.3 4991.1 5000.1 5015.8 4951.7 4970.8 4974.4 4992.4 5008.3 4913.0 4913.5 4922.8 4936.6 4956.4 3801.8 4811.1 4818.0 4928.0 4932.4 4074.8 4122.6 4240.4 4247.8 4260.7 6557.7 6570.7 6601.2 6601.4 6613.1 5560.7 5565.0 5924.9 5928.6 5961.2 5895.4 7172.1 7284.8 7287.8 7292.5 4719.4 4742.8 4742.8 4757.0 4769.6 5507.2 7747.5 7758.0 7758.5 7786.6 4336.9 4379.9 4712.6 4767.5 4770.3 4816.1 4831.6 4836.9 4845.8 4849.9 5817.9 5832.8 5852.2 5854.2 5862.0 7131.0 7368.8 7369.3 7386.6 7397.1 1658.8 1663.9 1668.5 1672.1 1672.5 1047.8 1053.9 1068.0 1072.9 1084.9 6925.0 6954.4 6964.9 6965.7 6966.0 7600.2 7602.7 7603.2 7627.1 7628.1 5730.9 6697.9 6871.9 6949.5 6952.8 4027.0 4063.2 4065.6 4067.2 4078.6 7909.5 7976.2 7989.0 8011.1 8030.4 6504.0 7621.0 7720.8 7761.9 7927.9 7816.7 7950.0 7968.4 7968.8 7981.0 6184.3 7644.8 7649.9 7660.8 7673.1 7206.5 7453.8 7454.7 7460.5 7485.3 7900.2 7926.1 7926.1 7931.0 7940.6 3921.6 4707.3 4742.5 4755.9 4773.3 7433.8 7667.3 7678.1 7683.0 7685.9 7401.4 7416.9 7422.5 7424.0 7431.7 5857.2 6957.6 7388.8 7409.6 7431.3 7210.8 7225.2 7228.2 7231.3 7231.4 7378.3 7379.9 7390.3 7390.4 7402.4 6976.3 7195.7 7259.1 7262.7 7263.1 09:40:14 INFO - 2015-11-19 09:40:14,286 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,286 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:17573.41 Median:23958.68 stddev:25686.06 (107.2%) stddev-sans-first:25726.93 09:40:14 INFO - 2015-11-19 09:40:14,288 DEBUG : BROWSER_OUTPUT: Values: 715.4 787.5 800.9 807.7 812.3 13128.7 15038.5 15042.0 15054.5 15064.5 12691.5 13955.9 14206.3 14259.9 14279.7 930.3 955.1 955.1 955.1 957.3 943.5 961.0 961.3 963.0 963.9 982.0 1002.2 1002.9 1004.0 1004.5 993.2 1000.5 1001.9 1002.1 1002.6 701.2 737.6 743.4 743.5 744.8 13216.0 13354.9 13380.9 13381.3 14794.0 10247.5 10273.2 10654.3 10790.3 11020.9 9765.0 9859.0 9894.5 9903.1 10547.2 3110.1 3116.4 3133.9 3155.4 3170.7 54212.2 54558.0 61441.0 63260.1 74642.0 7266.2 7314.5 7372.2 7375.3 7684.7 12786.2 12811.8 12820.6 12831.9 12839.9 6445.6 6460.7 6574.7 6693.0 6720.6 3941.2 4001.0 4002.1 4002.9 4004.7 3174.8 3203.4 3213.8 3215.0 3216.4 445.7 464.0 465.1 465.2 488.0 471.4 476.8 486.5 490.9 511.5 8013.0 8695.8 8939.8 9265.5 9542.8 469.1 498.0 506.6 507.9 534.3 3985.7 4117.5 4171.4 4178.9 4246.1 93371.1 103239.0 104458.0 104555.5 104707.0 64417.0 66330.0 82701.6 84385.0 84678.6 74849.0 74928.6 75012.6 75516.0 77616.0 8750.4 9147.0 9154.0 9165.8 9229.3 42649.0 46966.3 50398.5 51031.7 55354.0 47440.5 67282.0 67806.7 67835.0 73166.6 7625.5 8034.5 8062.2 8123.0 8177.6 10443.6 11112.9 11269.9 12030.3 12967.3 11700.1 11709.6 11752.2 11977.5 12147.1 11444.8 11510.7 11554.5 11757.4 12312.3 9290.3 11058.9 11282.7 11295.7 11412.8 9757.7 9876.4 10220.7 10353.2 10738.1 9279.9 9522.4 9763.3 10152.6 10205.4 09:40:14 INFO - 2015-11-19 09:40:14,288 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:40:14 INFO - 2015-11-19 09:40:14,288 DEBUG : BROWSER_OUTPUT: 09:40:14 INFO - 2015-11-19 09:40:14,712 INFO : Browser exited with error code: 0 09:40:14 INFO - 2015-11-19 09:40:14,736 INFO : Completed test dromaeo_css (00:18:34) 09:40:14 INFO - 2015-11-19 09:40:14,737 INFO : Starting test kraken 09:40:14 INFO - 2015-11-19 09:40:14,737 DEBUG : operating with platform_type : mac_ 09:40:14 INFO - 2015-11-19 09:40:14,737 INFO : Initialising browser for kraken test... 09:40:14 INFO - 2015-11-19 09:40:14,749 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmp93iptq/profile http://localhost:49261/getInfo.html 09:40:16 INFO - 2015-11-19 09:40:16,960 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:40:16 INFO - 2015-11-19 09:40:16,961 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:40:16 INFO - 2015-11-19 09:40:16,961 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:40:16 INFO - 2015-11-19 09:40:16,961 DEBUG : BROWSER_OUTPUT: __metrics 09:40:16 INFO - 2015-11-19 09:40:16,970 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:17 INFO - 2015-11-19 09:40:17,644 INFO : Browser initialized. 09:40:17 INFO - 2015-11-19 09:40:17,644 INFO : Running cycle 1/1 for kraken test... 09:40:17 INFO - 2015-11-19 09:40:17,644 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmp93iptq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:40:29 INFO - 2015-11-19 09:40:29,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 226021376 09:40:29 INFO - 2015-11-19 09:40:29,684 DEBUG : BROWSER_OUTPUT: 09:40:32 INFO - 2015-11-19 09:40:32,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:32 INFO - 2015-11-19 09:40:32,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 274493440 09:40:32 INFO - 2015-11-19 09:40:32,820 DEBUG : BROWSER_OUTPUT: 09:40:35 INFO - 2015-11-19 09:40:35,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-dft) 09:40:36 INFO - 2015-11-19 09:40:36,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 287723520 09:40:36 INFO - 2015-11-19 09:40:36,018 DEBUG : BROWSER_OUTPUT: 09:40:39 INFO - 2015-11-19 09:40:39,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-fft) 09:40:39 INFO - 2015-11-19 09:40:39,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 274657280 09:40:39 INFO - 2015-11-19 09:40:39,802 DEBUG : BROWSER_OUTPUT: 09:40:41 INFO - 2015-11-19 09:40:41,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator) 09:40:42 INFO - 2015-11-19 09:40:42,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 278589440 09:40:42 INFO - 2015-11-19 09:40:42,288 DEBUG : BROWSER_OUTPUT: 09:40:44 INFO - 2015-11-19 09:40:44,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:44 INFO - 2015-11-19 09:40:44,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 278290432 09:40:44 INFO - 2015-11-19 09:40:44,902 DEBUG : BROWSER_OUTPUT: 09:40:47 INFO - 2015-11-19 09:40:47,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:48 INFO - 2015-11-19 09:40:48,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 279564288 09:40:48 INFO - 2015-11-19 09:40:48,165 DEBUG : BROWSER_OUTPUT: 09:40:50 INFO - 2015-11-19 09:40:50,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:51 INFO - 2015-11-19 09:40:51,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 279982080 09:40:51 INFO - 2015-11-19 09:40:51,543 DEBUG : BROWSER_OUTPUT: 09:40:54 INFO - 2015-11-19 09:40:54,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial) 09:40:54 INFO - 2015-11-19 09:40:54,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 279425024 09:40:54 INFO - 2015-11-19 09:40:54,849 DEBUG : BROWSER_OUTPUT: 09:40:56 INFO - 2015-11-19 09:40:56,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:56 INFO - 2015-11-19 09:40:56,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 312049664 09:40:56 INFO - 2015-11-19 09:40:56,966 DEBUG : BROWSER_OUTPUT: 09:40:58 INFO - 2015-11-19 09:40:58,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:59 INFO - 2015-11-19 09:40:59,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 314843136 09:40:59 INFO - 2015-11-19 09:40:59,376 DEBUG : BROWSER_OUTPUT: 09:41:01 INFO - 2015-11-19 09:41:01,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:02 INFO - 2015-11-19 09:41:02,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 322826240 09:41:02 INFO - 2015-11-19 09:41:02,160 DEBUG : BROWSER_OUTPUT: 09:41:04 INFO - 2015-11-19 09:41:04,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:05 INFO - 2015-11-19 09:41:05,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 324358144 09:41:05 INFO - 2015-11-19 09:41:05,308 DEBUG : BROWSER_OUTPUT: 09:41:07 INFO - 2015-11-19 09:41:07,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:08 INFO - 2015-11-19 09:41:08,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 323670016 09:41:08 INFO - 2015-11-19 09:41:08,358 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49261/tests/kraken/driver.html?testName=ai-astar) 09:41:10 INFO - 2015-11-19 09:41:10,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 382128128 09:41:10 INFO - 2015-11-19 09:41:10,319 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,319 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:41:10 INFO - 2015-11-19 09:41:10,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:41:10 INFO - 2015-11-19 09:41:10,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;105;110;109;109;101;110;114;110 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;114;143;153;117;137;126;119;184;150 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;181;179;184;185;187;187;182;183;179 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;75;82;74;55;56;57;77;74;54 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;85;115;74;75;74;110;74;76;114 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;89;86;84;85;85;85;84;85;84 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;93;93;93;93;94;94;92;93;96 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;85;85;85;84;91;126;84;85;84 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;55;54;53;54;54;63;52;54 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;63;64;66;66;67;67;66;68 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;80;78;82;69;97;106;107;107 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;128;125;105;120;121;134;124;107;124 09:41:10 INFO - 2015-11-19 09:41:10,320 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;135;135;134;135;123;136;136;133;139 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;63;63;64;64;66;67;63;91;63 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1058 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: __startTimestamp1447954870314__endTimestamp 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:109.50 stddev:3.44 (3.1%) stddev-sans-first:3.64 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 105.0 110.0 109.0 109.0 101.0 110.0 114.0 110.0 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,321 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.00 Median:145.00 stddev:21.35 (14.7%) stddev-sans-first:22.45 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: Values: 147.0 114.0 143.0 153.0 117.0 137.0 126.0 119.0 184.0 150.0 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.70 Median:183.50 stddev:3.02 (1.6%) stddev-sans-first:3.04 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: Values: 180.0 181.0 179.0 184.0 185.0 187.0 187.0 182.0 183.0 179.0 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:67.40 Median:74.00 stddev:10.69 (14.4%) stddev-sans-first:11.30 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: Values: 70.0 75.0 82.0 74.0 55.0 56.0 57.0 77.0 74.0 54.0 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.00 Median:74.50 stddev:17.71 (23.8%) stddev-sans-first:18.70 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 115.0 74.0 75.0 74.0 110.0 74.0 76.0 114.0 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.56 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: Values: 85.0 89.0 86.0 84.0 85.0 85.0 85.0 84.0 85.0 84.0 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,322 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:1.07 (1.2%) stddev-sans-first:1.13 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 93.0 93.0 93.0 94.0 94.0 92.0 93.0 96.0 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:89.40 Median:85.00 stddev:13.02 (15.3%) stddev-sans-first:13.72 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 85.0 84.0 91.0 126.0 84.0 85.0 84.0 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:3.03 (5.6%) stddev-sans-first:3.20 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 55.0 54.0 53.0 54.0 54.0 63.0 52.0 54.0 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:1.56 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 63.0 64.0 66.0 66.0 67.0 67.0 66.0 68.0 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:80.50 stddev:14.00 (17.4%) stddev-sans-first:14.56 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 80.0 78.0 82.0 69.0 97.0 106.0 107.0 107.0 09:41:10 INFO - 2015-11-19 09:41:10,323 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:124.50 stddev:9.13 (7.3%) stddev-sans-first:9.39 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: Values: 128.0 128.0 125.0 105.0 120.0 121.0 134.0 124.0 107.0 124.0 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:135.00 stddev:4.20 (3.1%) stddev-sans-first:4.44 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 135.0 134.0 135.0 123.0 136.0 136.0 133.0 139.0 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:64.50 stddev:8.58 (13.3%) stddev-sans-first:9.08 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 63.0 64.0 64.0 66.0 67.0 63.0 91.0 63.0 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:41:10 INFO - 2015-11-19 09:41:10,324 DEBUG : BROWSER_OUTPUT: 09:41:10 INFO - 2015-11-19 09:41:10,985 INFO : Browser exited with error code: 0 09:41:11 INFO - 2015-11-19 09:41:11,032 INFO : Completed test kraken (00:00:56) 09:41:11 INFO - 2015-11-19 09:41:11,032 INFO : Starting test v8_7 09:41:11 INFO - 2015-11-19 09:41:11,032 DEBUG : operating with platform_type : mac_ 09:41:11 INFO - 2015-11-19 09:41:11,032 INFO : Initialising browser for v8_7 test... 09:41:11 INFO - 2015-11-19 09:41:11,044 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmpYIWul0/profile http://localhost:49261/getInfo.html 09:41:12 INFO - 2015-11-19 09:41:12,905 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:41:12 INFO - 2015-11-19 09:41:12,905 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:41:12 INFO - 2015-11-19 09:41:12,905 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:41:12 INFO - 2015-11-19 09:41:12,905 DEBUG : BROWSER_OUTPUT: __metrics 09:41:12 INFO - 2015-11-19 09:41:12,922 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:13 INFO - 2015-11-19 09:41:13,711 INFO : Browser initialized. 09:41:13 INFO - 2015-11-19 09:41:13,711 INFO : Running cycle 1/1 for v8_7 test... 09:41:13 INFO - 2015-11-19 09:41:13,712 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/dr9m7yf13jg0k8bs6vvr8z3m00000w/T/tmpYIWul0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:41:25 INFO - 2015-11-19 09:41:25,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 226381824 09:41:25 INFO - 2015-11-19 09:41:25,503 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49261/tests/v8_7/run.html (next: http://localhost:49261/tests/v8_7/run.html) 09:41:47 INFO - 2015-11-19 09:41:47,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 705937408 09:41:47 INFO - 2015-11-19 09:41:47,287 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,287 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:41:47 INFO - 2015-11-19 09:41:47,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:41:47 INFO - 2015-11-19 09:41:47,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:41:47 INFO - 2015-11-19 09:41:47,287 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |0;Richards;147.95088030773783 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.26431220770843 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4694.835680751174 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1890.359168241966 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |5;Earley;790.0552486187845 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |6;Boyer;13381.578947368422 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |7;RegExp;27459.45945945946 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |8;Splay;757.5757575757576 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4566.2100456621 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: __startTimestamp1447954907278__endTimestamp 09:41:47 INFO - 2015-11-19 09:41:47,288 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.95 Median:147.95 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: Values: 148.0 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.26 Median:161.26 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: Values: 161.3 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: Values: 278.9 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4694.84 Median:4694.84 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,289 DEBUG : BROWSER_OUTPUT: Values: 4694.8 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1890.36 Median:1890.36 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: Values: 1890.4 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.06 Median:790.06 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: Values: 790.1 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13381.58 Median:13381.58 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: Values: 13381.6 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27459.46 Median:27459.46 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: Values: 27459.5 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:757.58 Median:757.58 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,290 DEBUG : BROWSER_OUTPUT: Values: 757.6 09:41:47 INFO - 2015-11-19 09:41:47,291 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,291 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4566.21 Median:4566.21 stddev:0.00 (0.0%) 09:41:47 INFO - 2015-11-19 09:41:47,291 DEBUG : BROWSER_OUTPUT: Values: 4566.2 09:41:47 INFO - 2015-11-19 09:41:47,291 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:41:47 INFO - 2015-11-19 09:41:47,291 DEBUG : BROWSER_OUTPUT: 09:41:47 INFO - 2015-11-19 09:41:47,905 INFO : Browser exited with error code: 0 09:41:47 INFO - 2015-11-19 09:41:47,923 INFO : Completed test v8_7 (00:00:36) 09:41:48 INFO - 2015-11-19 09:41:48,323 INFO : Completed test suite (00:20:08) 09:41:48 INFO - 2015-11-19 09:41:48,324 DEBUG : Working with test: dromaeo_css 09:41:48 INFO - 2015-11-19 09:41:48,324 DEBUG : Generating results file: dromaeo_css 09:41:48 INFO - 2015-11-19 09:41:48,325 DEBUG : Working with test: kraken 09:41:48 INFO - 2015-11-19 09:41:48,325 DEBUG : Generating results file: kraken 09:41:48 INFO - 2015-11-19 09:41:48,325 INFO : javascript benchmark 09:41:48 INFO - 2015-11-19 09:41:48,325 DEBUG : Working with test: v8_7 09:41:48 INFO - 2015-11-19 09:41:48,325 DEBUG : Generating results file: v8_7 09:41:48 INFO - 2015-11-19 09:41:48,325 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:41:48 INFO - 2015-11-19 09:41:48,405 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 09:41:48 INFO - 2015-11-19 09:41:48,405 DEBUG : process_Request line: dromaeo_css 7286.76 graph.html#tests=[[72,1,59]] 09:41:48 INFO - 2015-11-19 09:41:48,405 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:41:48 INFO - 2015-11-19 09:41:48,437 DEBUG : process_Request line: kraken 1386.00 graph.html#tests=[[232,1,59]] 09:41:48 INFO - 2015-11-19 09:41:48,437 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:41:48 INFO - 2015-11-19 09:41:48,466 DEBUG : process_Request line: v8_7 20054.34 graph.html#tests=[[230,1,59]] 09:41:48 INFO - 2015-11-19 09:41:48,467 INFO : javascript benchmark 09:41:48 INFO - 2015-11-19 09:41:48,469 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3424.9143771405716, 3474.583050033995, 3485.6862882340592, 3505.1587618971453, 3524.68277854993, 5746.109353050284, 5853.61951473155, 5901.793437229698, 5945.702714864261, 5948.464638182568, 5883.0881213411885, 5931.703414829252, 5951.910721339173, 5957.106434034897, 5959.672218028007, 5294.629375943686, 5339.0, 5392.083345831198, 5412.079946409101, 5429.294191755066, 5442.428545002777, 5446.509814116729, 5452.645578037414, 5455.1817227416, 5457.454254574551, 5439.83680489584, 5441.211024401459, 5445.019896418643, 5453.918191227135, 5454.672719636815, 5431.891362172774, 5439.401665816757, 5439.864003399907, 5440.782368705247, 5457.208704737791, 5226.477352264781, 5278.683279003234, 5378.946210537883, 5398.649087809319, 5419.241306217133, 5844.357120716718, 6043.7884674036195, 6051.1225872248715, 6052.788152414644, 6057.273127224761, 6296.68516574174, 6329.2721337045905, 6341.334159913189, 6350.491960643138, 6362.936370636281, 6205.87588248237, 6282.842928926768, 6325.715342809584, 6331.240251169843, 6334.2398912130375, 5994.280686317583, 6061.121137435047, 6078.878422431527, 6079.936011198022, 6090.725917333731, 6481.740730370732, 6486.059521369375, 6488.448481878999, 6495.545311828221, 6502.057201705727, 6123.479504242189, 6211.503079753609, 6244.718987645567, 6250.9062364064575, 6326.936730632727, 6358.618482891041, 6371.139896113966, 6410.391012853772, 6418.454431373386, 6430.3891130342545, 6175.783847565313, 6329.651869147149, 6341.873162536724, 6358.395952384516, 6370.267419246846, 6188.4739797116845, 6216.222972128484, 6297.685115744286, 6320.336364681642, 6342.112104305401, 5096.082705113041, 5112.923306150411, 5115.386153661584, 5120.18077107661, 5165.354330708661, 4544.454665440168, 4546.454425468899, 4551.362809206714, 4557.361969324297, 4597.7241365518175, 5866.442687944638, 5932.288125424977, 5966.880662386815, 5999.5800293979, 6076.0, 6326.778562750282, 6331.461825744771, 6343.921533339343, 6347.650879201688, 6359.268684101295, 5880.852978675567, 6007.879842403127, 6028.909566356509, 6038.818835434944, 6106.236720409949, 5586.35756887955, 5599.776008959678, 5601.719914004365, 5602.915956260659, 5604.915926261109, 6370.93629063722, 6437.871242575216, 6575.145231119924, 6578.473722102221, 6580.374864387972, 6245.594036387621, 6356.237251529846, 6367.872642547216, 6369.87260254783, 6396.9040464394, 6488.805335839932, 6548.639824809491, 6559.048937904073, 6572.704228309642, 6578.671066446755, 6168.136460895388, 6365.458935990493, 6369.172007638977, 6370.108184854032, 6374.872502550016, 6218.409251121137, 6315.905261421174, 6319.842003949938, 6326.240851097898, 6338.461230795249, 6089.0, 6309.842253943688, 6317.084022816758, 6321.715522801577, 6335.113084168128, 6104.216637118914, 6260.561760676709, 6317.147185129948, 6335.873282534231, 6347.333529979285, 6092.449494447823, 6099.491378240913, 6163.013917773134, 6165.660888651168, 6210.254769427697, 6180.165677633462, 6232.439080482778, 6233.127362169391, 6237.625742455467, 6251.78118765841, 6034.2155519782145, 6132.386761323832, 6135.6932153393045, 6141.723622437091, 6174.413430724074], "unit": "ms", "name": "dojo.html", "value": 5882.648095424911}, {"lowerIsBetter": false, "replicates": [551.7985935133678, 563.7744902039182, 581.3459857660132, 606.5299392970447, 636.3763511758474, 32722.67277327229, 40200.79899600498, 41869.581304186984, 41949.58050419495, 41984.580154198484, 39043.80478097613, 45835.0, 45950.0, 45951.080978380414, 45992.77003614977, 8730.781730456725, 8869.822603547957, 9731.805363892736, 9945.0, 9965.15296199824, 8726.825463490726, 12120.333381664004, 12314.876851231507, 12323.5070597176, 12371.814422783666, 11946.581869634565, 12015.579454719087, 12020.759584808298, 12022.819657705142, 12085.335306558136, 7739.6904123834975, 8883.689070882552, 9042.593083311267, 11939.0, 12036.0, 8788.0, 8905.996150866069, 8941.50821704806, 11775.764484710258, 11986.160968732192, 40563.0, 41218.587814121776, 41259.1748165038, 41274.38088428676, 41354.0, 3282.83585820708, 3350.1289664687356, 3353.917963365643, 3458.1181798641437, 3519.0498565387456, 28615.0, 30352.848235758902, 30390.088297351114, 30581.694183058105, 30676.2330941726, 2571.2286314105695, 2577.80666450017, 2604.6744156980376, 2717.619533265344, 2748.093129267337, 505327.0, 507198.0, 508701.0, 509772.0, 511337.0, 72925.6353718228, 73523.0, 73619.89570156451, 73704.0, 73748.26251737414, 65458.672706636164, 75700.62149689326, 76965.61517192378, 77136.0, 77313.0, 15502.302396391964, 17098.487045388658, 17313.39403120885, 17334.913325433292, 17343.0, 11644.6506604802, 11652.825207621892, 11716.414179291001, 11719.0, 13078.542251021168, 17848.121502797763, 21540.784592154192, 22501.887490562443, 22542.887285563465, 22572.435689107904, 7905.821686795159, 8793.648254069765, 8854.734357969272, 8861.64553417869, 8875.600597973107, 779.5985067690144, 896.3814967672286, 955.245356168633, 972.3096601412934, 1034.8292531732332, 29064.982725604503, 29933.70066299309, 30228.546571801442, 30503.389932201233, 30517.0, 944.5041353289578, 1023.2939271902363, 1076.967690969272, 1081.6106201767357, 1138.4933704501418, 15414.0, 15428.614284642974, 15523.767143492856, 15621.375144994301, 15802.841971580137, 672973.0, 685762.0, 686211.0, 686230.0, 686772.0, 56953.01993290728, 56953.71523142358, 57172.0, 62585.43536411535, 63118.368816311246, 1257.0, 1457.9635509112145, 1494.1707352419512, 1497.453429498247, 1509.532045066033, 31277.0, 32036.51945220777, 32191.195220119684, 32752.50871236981, 33056.843010494515, 45623.54376456193, 46988.295175573076, 54072.91854162973, 55336.16995745148, 55341.0, 425027.0, 430010.0, 434404.0, 434716.0, 434794.0, 34476.0, 35019.949401517995, 35260.64739352574, 35353.646463535035, 35394.11514712153, 45114.323285150094, 46301.76849115733, 46719.532804671515, 46739.766301168274, 47393.52606473891, 36970.0, 38389.80805095957, 38645.806770965966, 38971.6102838968, 39425.60574394219, 37519.249615007, 37661.942764852545, 38271.6172838268, 38426.23147537089, 38435.80782096072, 38267.42598860963, 39776.60223397729, 40731.79634101929, 40922.0, 41026.38460423036, 31280.530792038593, 33794.41903201934, 34359.656403436646, 34378.0, 34499.48250776291, 25532.361690957874, 25839.41387111709, 25953.351166220997, 26072.34819129461, 26075.348116297246], "unit": "ms", "name": "ext.html", "value": 20743.86539856866}, {"lowerIsBetter": false, "replicates": [353.3092803569022, 354.4258301551487, 354.43467669067843, 357.85506869717767, 357.91231148368655, 15727.370905163809, 15997.680046399095, 19016.334428295013, 19793.703094453576, 20721.68917466239, 16459.25933333, 19166.46668266539, 19976.0, 20371.796282037176, 20509.794902050977, 5055.646104772667, 5420.24116623672, 5897.587168898179, 5946.405359464062, 5959.553033522481, 4229.577042295761, 4383.890402739925, 4384.758838263894, 5951.851203719898, 5998.580099393044, 5467.316585426822, 6318.8104356869135, 6439.452646525051, 6467.062275969982, 6492.448141907944, 6083.300420451638, 6155.661438620874, 6160.476359509447, 6167.167432396636, 6437.774677886275, 5579.218909352694, 5626.578006649518, 5646.068398714207, 5659.490645841894, 5682.119271512922, 24785.504289914283, 24847.13035043765, 24856.87571562149, 25028.998840046377, 25442.618360724606, 1870.494966359089, 1986.433866348084, 2002.4192984034612, 2044.7137400763904, 2326.1858349577683, 9859.260555458297, 9898.9505052475, 9915.256355773347, 10182.389056656624, 10230.795384092351, 1280.5774094548776, 1553.0448774003905, 1593.1715507935924, 1625.8292879247745, 1677.1278934953755, 69048.0, 94152.52923735406, 96056.0, 96713.0, 96722.51638741832, 5517.36550296713, 6626.237982631963, 6672.7330906764155, 6716.429103526158, 6721.966390168018, 7601.847963040708, 7607.809804754926, 7610.8097297568, 7613.162552119263, 7614.581198034161, 4636.327732478771, 5621.100623900156, 5633.042382794934, 5681.914771278434, 5694.1458781183155, 5214.243934629533, 6092.598702298407, 6151.477124444383, 6197.194364732646, 6205.131281620576, 2964.6442426908907, 2993.595864558257, 3000.2349400903067, 3021.77336699744, 3022.486177349856, 1039.1946241662772, 1040.9063184313297, 1045.51536817719, 1082.718493191776, 1135.8012347839094, 406.8372650939648, 440.5704438172756, 456.1401757686718, 463.5850913432459, 464.7745843266013, 11661.591844285409, 11847.703807404712, 12222.816657750142, 12318.260904345769, 12377.443015064344, 449.67398635988644, 450.3155204089765, 452.8482958208971, 460.1280573313552, 466.69664717933614, 6343.968280158662, 6538.967305163539, 6623.0, 6625.105610742585, 6665.433438157811, 657946.0, 794333.0, 797759.0, 807226.0, 809303.9534802288, 118360.0, 120097.0, 120407.0, 120516.0, 121550.0, 529.1216580476467, 531.4632221456279, 534.5269436548682, 534.5322842512801, 535.199876185098, 10832.079273261861, 11508.769824603629, 11989.700257493632, 12022.158448908493, 12093.818592721293, 48719.07685538879, 48826.0, 49357.0, 49432.25851612301, 49776.0, 53915.6521086976, 54026.83892644408, 63618.68190659017, 64462.0, 70529.0, 6375.649339286384, 6469.5794773339585, 6474.0612611172055, 6479.31967143462, 6481.675916204265, 12017.879821201675, 12476.376181191086, 12506.624801255977, 12541.874581254071, 12584.370781460708, 10701.090407315465, 10832.945835270773, 10887.0, 10990.395528246023, 10995.120390368911, 8483.363747718822, 10407.739806504898, 10720.785584288114, 10816.351018938889, 10924.508397122308, 9438.622455101993, 10668.359898406121, 11228.606998755004, 11234.4382780859, 11254.268472549258, 5357.410684824588, 5705.4009329019855, 5986.2517185351835, 6122.877542449215, 6404.711787969646, 10921.781564368826, 11117.27737697047, 11274.210805243554, 11295.491702873225, 11315.660530184108], "unit": "ms", "name": "jquery.html", "value": 7601.22222284405}, {"lowerIsBetter": false, "replicates": [1613.354658136746, 1673.138333758114, 1734.9826501734983, 1843.2903332217102, 1929.5079754662559, 7200.567965922041, 7382.667779949915, 7386.889196662054, 7398.001269828572, 7401.8519629607445, 7427.814304642373, 8110.513369197837, 8294.668213271478, 8296.460730052542, 8335.0, 2304.493011537463, 2390.270967354956, 2390.748971358, 2395.209580838319, 2400.939976500584, 2248.85382450141, 2290.324354315481, 2308.1459859851793, 2311.3759284993043, 2311.3759284993043, 2322.8257880658934, 2357.0925193800426, 2365.2431222008963, 2374.8337616366775, 2390.5457962987066, 2027.7668068172127, 2308.1921327535397, 2329.9767002329927, 2330.3358542815386, 2336.7780060894274, 2351.2005917987794, 2379.0, 2383.380321116505, 2384.308550520347, 2388.474535602182, 8238.958805205995, 8344.749657510285, 8371.0, 8375.288100511403, 8392.664293428255, 4415.602595766364, 4571.108633816407, 5107.668001579886, 5221.060209162387, 5221.242919776649, 3116.797408168462, 3427.417339052367, 3465.8440370183403, 3571.2143328467696, 3596.17288023756, 1040.0691381213846, 1041.500079961615, 1066.1311031509294, 1087.5649740103943, 1092.257265059759, 10977.506012229389, 11002.834957475645, 11008.229423940327, 11009.229353945228, 11014.559417623286, 4630.609077338295, 4684.836030738976, 4759.048190361941, 4761.999980004238, 4766.308885211625, 9603.759906002266, 9623.941366449824, 9630.759231019141, 9637.614495420245, 9654.22766178704, 5132.101882170605, 5164.92252616211, 5174.767135478913, 5221.530062294411, 5222.086134926372, 4718.811247550128, 4719.457262414798, 4726.125666751594, 4775.092732380836, 4820.493848145894, 3798.5441746990537, 3815.961840381616, 3838.596947320547, 3861.2084522672785, 3871.4192871069004, 1257.8867901888873, 1257.9874201257871, 1263.8293830332786, 1271.6375832887582, 1273.9426725797362, 1301.479408236713, 1310.0240320960945, 1320.9141405808784, 1343.8588948160498, 1344.8050032745198, 7706.845863082707, 7769.883451748228, 7817.452778305577, 7818.8827167592535, 7824.491408058458, 488.75806475793996, 491.09638265591485, 491.1012846490913, 494.5178451010236, 508.7430847422028, 5166.5866730661455, 6090.756369745249, 6171.814845554641, 6184.257889053252, 6191.628502289877, 7758.650860711282, 9502.239820814319, 10164.33931794431, 10176.796464070678, 10185.134263587677, 9691.418514889128, 9843.852342214872, 9910.851337229948, 9961.203103751683, 9975.052370024836, 7821.530708157528, 7847.843043139105, 7859.371250299962, 7865.410094242955, 7886.171951945078, 7601.201873803171, 7667.156612772479, 7691.653875575725, 7712.460127791225, 7713.845723085619, 8794.736157915273, 8814.0, 8878.86681699788, 9099.1810737034, 9162.770930726785, 9125.863112053457, 9373.531323433937, 9384.812303754023, 9557.474338911426, 9564.95217523908, 7300.23347548521, 7367.005454263606, 7386.593737344498, 7388.667509961957, 7405.96297018533, 7538.170801211752, 7766.922330776846, 7774.766756997299, 7782.649780759993, 7795.64919578609, 7212.531185472927, 7434.628268586441, 7446.404287657083, 7563.243675632612, 7599.810004749705, 7314.890276645748, 7319.34125928669, 7444.367228785397, 7448.664810083451, 7502.0, 7354.742584009534, 7499.512531685423, 7519.887201692089, 7532.43506736986, 7539.660715267936, 6855.245922948571, 6889.724411023503, 6909.723611055501, 6914.757983470555, 6916.100906882073, 6886.208086070166, 6958.025876377413, 6958.930410695828, 6966.12923384577, 6971.79084627462], "unit": "ms", "name": "mootools.html", "value": 4650.82322214307}, {"lowerIsBetter": false, "replicates": [320.7818683295359, 324.16204112369525, 327.2505961348512, 329.69338515180885, 330.62474091905693, 6812.386885180339, 6812.897806532906, 6891.965540172292, 6924.78816207163, 6929.965350173255, 6821.283765204656, 6824.7952561423235, 6836.521443498945, 6837.188145141529, 6861.691223894924, 4849.199882019462, 4990.326305948705, 4991.1016017117, 5000.149974504343, 5015.849524514252, 4951.678140920847, 4970.826021089262, 4974.37820272466, 4992.400911890578, 5008.2738002989545, 4912.975435122819, 4913.533214344631, 4922.778474968635, 4936.6297527685565, 4956.355673762406, 3801.752886062397, 4811.13399588074, 4817.951820481785, 4927.965127323284, 4932.432770231416, 4074.775887326196, 4122.6083522065355, 4240.406343111967, 4247.8300867965245, 4260.723053001545, 6557.704903279317, 6570.653016131681, 6601.184674214582, 6601.405873471363, 6613.140291762088, 5560.6941618210985, 5564.969232141274, 5924.881502369972, 5928.584999050068, 5961.195238642815, 5895.380984996599, 7172.13934327884, 7284.814555633342, 7287.817804554876, 7292.489525733201, 4719.433667959833, 4742.786574604151, 4742.834000809989, 4757.0, 4769.570738633505, 5507.218854478503, 7747.496412733154, 7758.0, 7758.495697779626, 7786.57173855432, 4336.869893903125, 4379.934300985487, 4712.64655150865, 4767.4994125617, 4770.308305295713, 4816.133096042676, 4831.637627177975, 4836.927446088241, 4845.781939812647, 4849.9030019399415, 5817.94182058174, 5832.766689332379, 5852.180694702745, 5854.151148083504, 5861.9706901465215, 7131.001659767637, 7368.815779605446, 7369.263073692588, 7386.59373734439, 7397.112346518452, 1658.8009438867414, 1663.8502534771928, 1668.4994501649699, 1672.1137796967625, 1672.4564516532175, 1047.7904419116207, 1053.931494452858, 1067.9946600266949, 1072.8819829818713, 1084.8643919510062, 6925.0, 6954.374106330454, 6964.930350696428, 6965.65171741421, 6966.02475653409, 7600.1639819619795, 7602.7339043133225, 7603.163651998276, 7627.12288086866, 7628.084629844343, 5730.914036289459, 6697.933020669731, 6871.931280687129, 6949.478789090838, 6952.756653517103, 4027.0, 4063.167050754588, 4065.5527891931865, 4067.186562687474, 4078.592140785957, 7909.525428474195, 7976.242256985577, 7988.961435013411, 8011.118776934532, 8030.39772017101, 6503.959366501337, 7620.961895190489, 7720.845583088307, 7761.883571746428, 7927.8810817837775, 7816.68733250675, 7950.0, 7968.442209045543, 7968.800779980547, 7981.0, 6184.319724830355, 7644.770656880302, 7649.923500765144, 7660.770176894702, 7673.079230492153, 7206.495545311778, 7453.776386708408, 7454.701811927463, 7460.515066520658, 7485.288897554724, 7900.209979002054, 7926.088499822594, 7926.128125906261, 7931.0, 7940.6029698515995, 3921.627445392683, 4707.29390591414, 4742.454617719007, 4755.857324280277, 4773.284007398779, 7433.776986690408, 7667.3099421052375, 7678.078630564368, 7682.961585192038, 7685.923140768745, 7401.444891633041, 7416.851662966603, 7422.47839192975, 7424.0348754661545, 7431.702731890664, 5857.209276747755, 6957.617331046841, 7388.778336649909, 7409.555426674417, 7431.331180193809, 7210.783676489714, 7225.205227425085, 7228.20489746138, 7231.2768723127265, 7231.385332246818, 7378.29906158914, 7379.852402952019, 7390.334869861738, 7390.445716571171, 7402.3707984821895, 6976.302369762983, 7195.676194571152, 7259.12890453149, 7262.709491620276, 7263.128424589083], "unit": "ms", "name": "prototype.html", "value": 5298.432524329152}, {"lowerIsBetter": false, "replicates": [715.4240836126918, 787.4920676163874, 800.9107613645438, 807.685002848889, 812.3420029775882, 13128.73742525149, 15038.473653422132, 15042.022268552537, 15054.473093441731, 15064.548063558112, 12691.4923403064, 13955.93022034891, 14206.289685515734, 14259.857401425983, 14279.71440571188, 930.2976252929046, 955.0592666223764, 955.0592666223764, 955.106974978394, 957.3298690916351, 943.4575119306427, 960.9855852162223, 961.2646325560952, 962.9759256018585, 963.8602402651646, 981.9803603927953, 1002.2382988928431, 1002.8896821349646, 1003.9548220330066, 1004.5128112865254, 993.1607791416242, 1000.4947501511726, 1001.864748258983, 1002.0680766886792, 1002.5739060899125, 701.1586096684, 737.6385571070138, 743.4015617427968, 743.4721347843038, 744.7505085796265, 13216.0, 13354.86645133546, 13380.86619133806, 13381.26403047832, 14794.0, 10247.538860751283, 10273.229507786871, 10654.307470014424, 10790.298630588986, 11020.889791102147, 9764.951175244149, 9859.0, 9894.455804930725, 9903.108720215143, 10547.156227501782, 3110.0514343125337, 3116.4234616596004, 3133.905982820519, 3155.368926214743, 3170.651228364878, 54212.18681719778, 54558.0, 61441.0, 63260.051099234006, 74642.0, 7266.237045110293, 7314.45141614381, 7372.189059203483, 7375.262473752582, 7684.654190561439, 12786.168899021533, 12811.807822882663, 12820.61538153857, 12831.871681283068, 12839.935800320938, 6445.645489498029, 6460.709268082947, 6574.704138313692, 6693.0, 6720.563163394461, 3941.2117576484816, 4001.0397504598686, 4002.1195337025806, 4002.899927501836, 4004.7196696231567, 3174.777765556435, 3203.3753418083716, 3213.839308034589, 3215.0, 3216.3567286542784, 445.6746575000268, 464.0487001646611, 465.12092145844383, 465.1650287733526, 488.0312579529631, 471.37307381182944, 476.8307250925941, 486.50619621084627, 490.9312696222532, 511.4706279001216, 8012.959935200287, 8695.826063481349, 8939.776505587412, 9265.536723163816, 9542.761430964143, 469.0706537672191, 497.9975100124476, 506.6270407196465, 507.8857257117119, 534.3374215972167, 3985.70107241958, 4117.547069822317, 4171.374293855946, 4178.937315940263, 4246.10831725335, 93371.0662893376, 103239.0, 104457.95542044635, 104555.4772226134, 104707.0, 64417.0, 66330.0050499243, 82701.58649206716, 84385.0, 84678.57660711657, 74849.0, 74928.62535687287, 75012.62493687497, 75516.0, 77616.0, 8750.387472876837, 9147.0, 9153.954230228806, 9165.77085572866, 9229.261659067124, 42649.0, 46966.29550556676, 50398.488045358696, 51031.744841275555, 55354.0, 47440.52559474361, 67282.0, 67806.66096669485, 67835.0, 73166.63416682882, 7625.542467451971, 8034.517928924283, 8062.153473885158, 8122.959385203036, 8177.6320065596, 10443.582256709951, 11112.944270294309, 11269.887301126884, 12030.270616109034, 12967.286799226133, 11700.06399488056, 11709.590164344207, 11752.23610465317, 11977.520899163936, 12147.132593207185, 11444.771104577696, 11510.654680359603, 11554.480048397674, 11757.353345566076, 12312.26126432417, 9290.303227257848, 11058.944705276423, 11282.746791387974, 11295.661130166109, 11412.828807567726, 9757.707268781947, 9876.35803672759, 10220.744481388025, 10353.17174626013, 10738.12778781191, 9279.860802087838, 9522.387168075278, 9763.316567840184, 10152.593896244067, 10205.38767673942], "unit": "ms", "name": "yui.html", "value": 6548.610265768101}], "name": "dromaeo_css", "value": 7286.764268349973}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 105.0, 110.0, 109.0, 109.0, 101.0, 110.0, 114.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [147.0, 114.0, 143.0, 153.0, 117.0, 137.0, 126.0, 119.0, 184.0, 150.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.0}, {"lowerIsBetter": true, "replicates": [180.0, 181.0, 179.0, 184.0, 185.0, 187.0, 187.0, 182.0, 183.0, 179.0], "unit": "ms", "name": "audio-dft", "value": 182.7}, {"lowerIsBetter": true, "replicates": [70.0, 75.0, 82.0, 74.0, 55.0, 56.0, 57.0, 77.0, 74.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 67.4}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 115.0, 74.0, 75.0, 74.0, 110.0, 74.0, 76.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 88.0}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 86.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 92.0, 93.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 91.0, 126.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 89.4}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 54.0, 53.0, 54.0, 54.0, 63.0, 52.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 63.0, 64.0, 66.0, 66.0, 67.0, 67.0, 66.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 80.0, 78.0, 82.0, 69.0, 97.0, 106.0, 107.0, 107.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [128.0, 128.0, 125.0, 105.0, 120.0, 121.0, 134.0, 124.0, 107.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [135.0, 135.0, 135.0, 134.0, 135.0, 123.0, 136.0, 136.0, 133.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 63.0, 64.0, 64.0, 66.0, 67.0, 63.0, 91.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1386.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.95088030773783], "unit": "score", "name": "Richards", "value": 238.6062180000001}, {"lowerIsBetter": false, "replicates": [161.26431220770843], "unit": "score", "name": "DeltaBlue", "value": 409.99771799999996}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [4694.835680751174], "unit": "score", "name": "Decrypt", "value": 56.69655300000001}, {"lowerIsBetter": false, "replicates": [1890.359168241966], "unit": "score", "name": "RayTrace", "value": 391.45418100000006}, {"lowerIsBetter": false, "replicates": [790.0552486187845], "unit": "score", "name": "Earley", "value": 843.565055944056}, {"lowerIsBetter": false, "replicates": [13381.578947368422], "unit": "score", "name": "Boyer", "value": 49.80451130776796}, {"lowerIsBetter": false, "replicates": [27459.45945945946], "unit": "score", "name": "RegExp", "value": 33.17563484251969}, {"lowerIsBetter": false, "replicates": [757.5757575757576], "unit": "score", "name": "Splay", "value": 107.56812000000001}, {"lowerIsBetter": false, "replicates": [4566.2100456621], "unit": "score", "name": "NavierStokes", "value": 324.9960000000002}], "name": "v8_7", "value": 20054.3361267978}]} 09:41:48 INFO - RETURN: dromaeo_css: 7286.76 09:41:48 INFO - RETURN: kraken: 1386.00 09:41:48 INFO - RETURN: v8_7: 20054.34 09:41:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "20054.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1386.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7286.76"}}} 09:41:48 INFO - Return code: 0 09:41:48 INFO - # TBPL SUCCESS # 09:41:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:48 INFO - 2015-11-19 09:41:48.552 screenresolution[1677:10586] starting screenresolution argv=screenresolution get 09:41:48 INFO - 2015-11-19 09:41:48.555 screenresolution[1677:10586] Display 0: 1600x1200x32@60 09:41:48 INFO - 2015-11-19 09:41:48.561 screenresolution[1678:10589] starting screenresolution argv=screenresolution list 09:41:48 INFO - Available Modes on Display 0 09:41:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:48 INFO - Intel Iris: 09:41:48 INFO - Chipset Model: Intel Iris 09:41:48 INFO - Type: GPU 09:41:48 INFO - Bus: Built-In 09:41:48 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:48 INFO - Vendor: Intel (0x8086) 09:41:48 INFO - Device ID: 0x0a2e 09:41:48 INFO - Revision ID: 0x0009 09:41:48 INFO - Displays: 09:41:48 INFO - Display: 09:41:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:48 INFO - Display Serial Number: 1600x1200 60 09:41:48 INFO - Main Display: Yes 09:41:48 INFO - Mirror: Off 09:41:48 INFO - Online: Yes 09:41:48 INFO - Rotation: Supported 09:41:48 INFO - Return code: 0 09:41:48 INFO - Running post-action listener: _resource_record_post_action 09:41:48 INFO - Running post-run listener: _resource_record_post_run 09:41:49 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 33570304; Write bytes: 694581248; Read time: 366; Write time: 2261 09:41:49 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 335608320; Write bytes: 339326976; Read time: 26171; Write time: 614 09:41:49 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 32644608; Write bytes: 344887296; Read time: 352; Write time: 1612 09:41:49 INFO - Running post-run listener: _upload_blobber_files 09:41:49 INFO - Blob upload gear active. 09:41:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:41:49 INFO - Copying logs to upload dir... 09:41:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.777776 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 09:41:50.075356) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:41:50.080140) ========= 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.cfAfBIHhlC/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.QdKxVTszwu/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/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009660 build_url: 'https://queue.taskcluster.net/v1/task/AhyXgK1cQcCBL53ZKsJA2g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:41:50.126763) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:41:50.127075) ========= 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.cfAfBIHhlC/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.QdKxVTszwu/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.005332 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:41:50.250710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 09:41:50.251011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 09:41:50.251557) ========= ========= Total master_lag: 0.48 =========