builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0008 starttime: 1446252593.84 results: success (0) buildid: 20151030163430 builduid: c080de4e801a40eabb2304f75b477e9f revision: 765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:53.838382) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:53.838844) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:53.839141) ========= 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.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006007 basedir: '/builds/slave/test' ========= master_lag: 0.38 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.220309) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.220631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.415044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.415338) ========= 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.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.026640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.467092) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.467675) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.468417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.468909) ========= 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.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-10-30 17:49:54-- 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.17M=0.001s 2015-10-30 17:49:54 (8.17 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.254091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.745720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.746000) ========= 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.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.073828 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.836545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:54.837328) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-10-30 17:49:54,925 truncating revision to first 12 chars 2015-10-30 17:49:54,925 Setting DEBUG logging. 2015-10-30 17:49:54,925 attempt 1/10 2015-10-30 17:49:54,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/765d51aa96c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-30 17:49:55,181 unpacking tar archive at: mozilla-inbound-765d51aa96c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515847 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:55.631923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:55.632250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:55.650597) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:55.650876) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 17:49:55.651307) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-10-30 17:49:55.651693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 17:49:55 INFO - MultiFileLogger online at 20151030 17:49:55 in /builds/slave/test 17:49:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 17:49:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:55 INFO - {'append_to_log': False, 17:49:55 INFO - 'base_work_dir': '/builds/slave/test', 17:49:55 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 17:49:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:55 INFO - 'branch': 'Mozilla-Inbound', 17:49:55 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:55 INFO - 'config_files': ('talos/mac_config.py',), 17:49:55 INFO - 'default_actions': ('clobber', 17:49:55 INFO - 'read-buildbot-config', 17:49:55 INFO - 'download-and-extract', 17:49:55 INFO - 'populate-webroot', 17:49:55 INFO - 'create-virtualenv', 17:49:55 INFO - 'install', 17:49:55 INFO - 'run-tests'), 17:49:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:55 INFO - 'download_minidump_stackwalk': True, 17:49:55 INFO - 'download_symbols': 'ondemand', 17:49:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:49:55 INFO - 'tooltool.py': '/tools/tooltool.py', 17:49:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:49:55 INFO - '/tools/misc-python/virtualenv.py')}, 17:49:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:55 INFO - 'installer_path': 'installer.exe', 17:49:55 INFO - 'log_level': 'info', 17:49:55 INFO - 'log_name': 'talos', 17:49:55 INFO - 'log_to_console': True, 17:49:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:49:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:49:55 INFO - 'opt_config_files': (), 17:49:55 INFO - 'pip_index': False, 17:49:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:55 INFO - 'cmd': ('bash', 17:49:55 INFO - '-c', 17:49:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:55 INFO - 'enabled': True, 17:49:55 INFO - 'halt_on_failure': False, 17:49:55 INFO - 'name': 'check_screen_resolution'},), 17:49:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:55 INFO - 'cmd': ('bash', 17:49:55 INFO - '-c', 17:49:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:55 INFO - 'enabled': True, 17:49:55 INFO - 'halt_on_failure': False, 17:49:55 INFO - 'name': 'check_screen_resolution'},), 17:49:55 INFO - 'run_cmd_checks_enabled': True, 17:49:55 INFO - 'sps_profile': False, 17:49:55 INFO - 'sps_profile_interval': 0, 17:49:55 INFO - 'suite': 'dromaeojs', 17:49:55 INFO - 'system_bits': '64', 17:49:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:55 INFO - 'title': 't-yosemite-r5-0008', 17:49:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:55 INFO - 'use_talos_json': True, 17:49:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:55 INFO - 'work_dir': 'build'} 17:49:55 INFO - ##### 17:49:55 INFO - ##### Running clobber step. 17:49:55 INFO - ##### 17:49:55 INFO - Running pre-action listener: _resource_record_pre_action 17:49:55 INFO - Running main action method: clobber 17:49:55 INFO - rmtree: /builds/slave/test/build 17:49:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:50:02 INFO - Running post-action listener: _resource_record_post_action 17:50:02 INFO - ##### 17:50:02 INFO - ##### Running read-buildbot-config step. 17:50:02 INFO - ##### 17:50:02 INFO - Running pre-action listener: _resource_record_pre_action 17:50:02 INFO - Running main action method: read_buildbot_config 17:50:02 INFO - Using buildbot properties: 17:50:02 INFO - { 17:50:02 INFO - "properties": { 17:50:02 INFO - "buildnumber": 3168, 17:50:02 INFO - "product": "firefox", 17:50:02 INFO - "script_repo_revision": "production", 17:50:02 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 17:50:02 INFO - "repository": "", 17:50:02 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 17:50:02 INFO - "buildid": "20151030163430", 17:50:02 INFO - "slavename": "t-yosemite-r5-0008", 17:50:02 INFO - "pgo_build": "False", 17:50:02 INFO - "basedir": "/builds/slave/test", 17:50:02 INFO - "project": "", 17:50:02 INFO - "platform": "yosemite", 17:50:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:50:02 INFO - "slavebuilddir": "test", 17:50:02 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 17:50:02 INFO - "branch": "mozilla-inbound", 17:50:02 INFO - "repo_path": "integration/mozilla-inbound", 17:50:02 INFO - "stage_platform": "macosx64", 17:50:02 INFO - "builduid": "c080de4e801a40eabb2304f75b477e9f", 17:50:02 INFO - "revision": "765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9" 17:50:02 INFO - }, 17:50:02 INFO - "sourcestamp": { 17:50:02 INFO - "repository": "", 17:50:02 INFO - "hasPatch": false, 17:50:02 INFO - "project": "", 17:50:02 INFO - "branch": "mozilla-inbound-macosx64-talos", 17:50:02 INFO - "changes": [ 17:50:02 INFO - { 17:50:02 INFO - "category": null, 17:50:02 INFO - "files": [ 17:50:02 INFO - { 17:50:02 INFO - "url": null, 17:50:02 INFO - "name": "https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 17:50:02 INFO - } 17:50:02 INFO - ], 17:50:02 INFO - "repository": "", 17:50:02 INFO - "rev": "765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9", 17:50:02 INFO - "who": "nfroyd@mozilla.com", 17:50:02 INFO - "when": 1446252585, 17:50:02 INFO - "number": 6603064, 17:50:02 INFO - "comments": "Bug 1219405 - use LazyLogModule for PNG decoder logging; r=seth\n\nThis change eliminates some TSan warnings and also eliminates some\nboilerplate.", 17:50:02 INFO - "project": "", 17:50:02 INFO - "at": "Fri 30 Oct 2015 17:49:45", 17:50:02 INFO - "branch": "mozilla-inbound-macosx64-talos", 17:50:02 INFO - "revlink": "", 17:50:02 INFO - "properties": [ 17:50:02 INFO - [ 17:50:02 INFO - "buildid", 17:50:02 INFO - "20151030163430", 17:50:02 INFO - "Change" 17:50:02 INFO - ], 17:50:02 INFO - [ 17:50:02 INFO - "builduid", 17:50:02 INFO - "c080de4e801a40eabb2304f75b477e9f", 17:50:02 INFO - "Change" 17:50:02 INFO - ], 17:50:02 INFO - [ 17:50:02 INFO - "pgo_build", 17:50:02 INFO - "False", 17:50:02 INFO - "Change" 17:50:02 INFO - ] 17:50:02 INFO - ], 17:50:02 INFO - "revision": "765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9" 17:50:02 INFO - } 17:50:02 INFO - ], 17:50:02 INFO - "revision": "765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9" 17:50:02 INFO - } 17:50:02 INFO - } 17:50:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 17:50:02 INFO - Running post-action listener: _resource_record_post_action 17:50:02 INFO - ##### 17:50:02 INFO - ##### Running download-and-extract step. 17:50:02 INFO - ##### 17:50:02 INFO - Running pre-action listener: _resource_record_pre_action 17:50:02 INFO - Running main action method: download_and_extract 17:50:02 INFO - mkdir: /builds/slave/test/build/tests 17:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:02 INFO - https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/test_packages.json 17:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/test_packages.json 17:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:50:04 INFO - Downloaded 1149 bytes. 17:50:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:50:04 INFO - Using the following test package requirements: 17:50:04 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:50:04 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:50:04 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 17:50:04 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:50:04 INFO - u'jsshell-mac.zip'], 17:50:04 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:50:04 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 17:50:04 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:50:04 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:50:04 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 17:50:04 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:50:04 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 17:50:04 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:50:04 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 17:50:04 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:50:04 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:50:04 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 17:50:04 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:50:04 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')]} 17:50:04 INFO - https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/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 17:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/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 17:50:06 INFO - Downloaded 17450404 bytes. 17:50:06 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 17:50:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:50:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:50:11 INFO - Return code: 0 17:50:11 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 17:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:11 INFO - https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/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 17:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/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 17:50:14 INFO - Downloaded 17450404 bytes. 17:50:14 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 17:50:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:50:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:50:20 INFO - Return code: 0 17:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:20 INFO - https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:50:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:50:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:50:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/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 17:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/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 17:50:21 INFO - Downloaded 11131307 bytes. 17:50:21 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 17:50:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:50:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 17:50:22 INFO - Return code: 0 17:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:22 INFO - https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:50:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:50:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:50:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 17:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/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 17:50:25 INFO - Downloaded 108532105 bytes. 17:50:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:50:25 INFO - mkdir: /builds/slave/test/properties 17:50:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:50:25 INFO - Writing to file /builds/slave/test/properties/build_url 17:50:25 INFO - Contents: 17:50:25 INFO - build_url:https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:50:25 INFO - Running post-action listener: _resource_record_post_action 17:50:25 INFO - Running post-action listener: set_extra_try_arguments 17:50:25 INFO - ##### 17:50:25 INFO - ##### Running populate-webroot step. 17:50:25 INFO - ##### 17:50:25 INFO - Running pre-action listener: _resource_record_pre_action 17:50:25 INFO - Running main action method: populate_webroot 17:50:25 INFO - Guessing talos json url... 17:50:25 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')]} 17:50:25 INFO - https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 17:50:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 17:50:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 17:50:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 17:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 17:50:25 INFO - Downloaded 111 bytes. 17:50:25 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 17:50:25 INFO - Contents: 17:50:25 INFO - 20151030163430 17:50:25 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9 17:50:25 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')]} 17:50:25 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/765d51aa96/testing/talos/talos.json 17:50:25 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/765d51aa96/testing/talos/talos.json to /builds/slave/test/build/talos.json 17:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/765d51aa96/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 17:50:26 INFO - Downloaded 4264 bytes. 17:50:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:50:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:50:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:50:26 INFO - '../fennec_ids.txt'], 17:50:26 INFO - 'tests': ['tcheck2']}, 17:50:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:50:26 INFO - '--tppagecycles', 17:50:26 INFO - '7'], 17:50:26 INFO - 'tests': ['tsvgm']}}, 17:50:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:50:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:50:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:50:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:50:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'tests': ['damp', 'tps']}, 17:50:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['damp', 'tps']}, 17:50:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:50:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:26 INFO - 'other': {'tests': ['a11yr', 17:50:26 INFO - 'ts_paint', 17:50:26 INFO - 'tpaint', 17:50:26 INFO - 'sessionrestore', 17:50:26 INFO - 'sessionrestore_no_auto_restore']}, 17:50:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['a11yr', 17:50:26 INFO - 'ts_paint', 17:50:26 INFO - 'tpaint', 17:50:26 INFO - 'sessionrestore', 17:50:26 INFO - 'sessionrestore_no_auto_restore']}, 17:50:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['a11yr', 17:50:26 INFO - 'ts_paint', 17:50:26 INFO - 'tpaint', 17:50:26 INFO - 'sessionrestore', 17:50:26 INFO - 'sessionrestore_no_auto_restore']}, 17:50:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['a11yr', 17:50:26 INFO - 'ts_paint', 17:50:26 INFO - 'tpaint', 17:50:26 INFO - 'sessionrestore', 17:50:26 INFO - 'sessionrestore_no_auto_restore']}, 17:50:26 INFO - 'other_l64': {'tests': ['a11yr', 17:50:26 INFO - 'ts_paint', 17:50:26 INFO - 'tpaint', 17:50:26 INFO - 'sessionrestore', 17:50:26 INFO - 'sessionrestore_no_auto_restore']}, 17:50:26 INFO - 'other_nol64': {'tests': ['a11yr', 17:50:26 INFO - 'ts_paint', 17:50:26 INFO - 'tpaint', 17:50:26 INFO - 'sessionrestore', 17:50:26 INFO - 'sessionrestore_no_auto_restore']}, 17:50:26 INFO - 'svgr': {'tests': ['tsvgx', 17:50:26 INFO - 'tsvgr_opacity', 17:50:26 INFO - 'tart', 17:50:26 INFO - 'tscrollx', 17:50:26 INFO - 'cart']}, 17:50:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['tsvgx', 17:50:26 INFO - 'tsvgr_opacity', 17:50:26 INFO - 'tart', 17:50:26 INFO - 'tscrollx', 17:50:26 INFO - 'cart']}, 17:50:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'tests': ['tp5o']}, 17:50:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'talos_options': ['--e10s'], 17:50:26 INFO - 'tests': ['tp5o']}, 17:50:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'talos_options': ['--xperf_path', 17:50:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:26 INFO - 'tests': ['tp5n']}, 17:50:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:26 INFO - 'talos_options': ['--e10s', 17:50:26 INFO - '--xperf_path', 17:50:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 17:50:26 INFO - 'C:/slave/talos-data/talos/xperf.config'], 17:50:26 INFO - 'tests': ['tp5n']}}, 17:50:26 INFO - 'talos.zip': {'path': '', 17:50:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:50:26 INFO - Running post-action listener: _resource_record_post_action 17:50:26 INFO - ##### 17:50:26 INFO - ##### Running create-virtualenv step. 17:50:26 INFO - ##### 17:50:26 INFO - Running pre-action listener: _resource_record_pre_action 17:50:26 INFO - Running main action method: create_virtualenv 17:50:26 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50:26 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 17:50:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:50:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:26 INFO - Using real prefix '/tools/python27' 17:50:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:27 INFO - Installing distribute.............................................................................................................................................................................................done. 17:50:31 INFO - Installing pip.................done. 17:50:31 INFO - Return code: 0 17:50:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10c476a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963717ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:50:31 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 17:50:31 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 17:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:31 INFO - 'HOME': '/Users/cltbld', 17:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:31 INFO - 'LOGNAME': 'cltbld', 17:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:31 INFO - 'MOZ_NO_REMOTE': '1', 17:50:31 INFO - 'NO_EM_RESTART': '1', 17:50:31 INFO - 'PAGER': '/bin/cat', 17:50:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:31 INFO - 'PWD': '/builds/slave/test', 17:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:31 INFO - 'SHELL': '/bin/bash', 17:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:50:31 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:31 INFO - 'USER': 'cltbld', 17:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:31 INFO - 'XPC_FLAGS': '0x0', 17:50:31 INFO - 'XPC_SERVICE_NAME': '0', 17:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:32 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 17:50:32 INFO - Cleaning up... 17:50:32 INFO - Return code: 0 17:50:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:32 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 0x10c476a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963717ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:50:32 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 17:50:32 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 17:50:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:50:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:32 INFO - 'HOME': '/Users/cltbld', 17:50:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:32 INFO - 'LOGNAME': 'cltbld', 17:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:32 INFO - 'MOZ_NO_REMOTE': '1', 17:50:32 INFO - 'NO_EM_RESTART': '1', 17:50:32 INFO - 'PAGER': '/bin/cat', 17:50:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:32 INFO - 'PWD': '/builds/slave/test', 17:50:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:32 INFO - 'SHELL': '/bin/bash', 17:50:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:50:32 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:50:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:32 INFO - 'USER': 'cltbld', 17:50:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:32 INFO - 'XPC_FLAGS': '0x0', 17:50:32 INFO - 'XPC_SERVICE_NAME': '0', 17:50:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:32 INFO - Downloading/unpacking psutil>=0.7.1 17:50:32 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 17:50:32 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 17:50:32 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 17:50:32 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 17:50:32 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 17:50:32 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 17:50:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:50:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:50:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:35 INFO - Installing collected packages: psutil 17:50:35 INFO - Running setup.py install for psutil 17:50:35 INFO - building 'psutil._psutil_osx' extension 17:50:35 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 17:50:37 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 17:50:37 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 17:50:37 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 17:50:37 INFO - building 'psutil._psutil_posix' extension 17:50:37 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 17:50:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:50:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:50:37 INFO - ^ 17:50:38 INFO - 1 warning generated. 17:50:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:38 INFO - Successfully installed psutil 17:50:38 INFO - Cleaning up... 17:50:38 INFO - Return code: 0 17:50:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:50:38 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')]} 17:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:38 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')]} 17:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:38 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 0x10c476a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963717ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:50:38 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 17:50:38 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 17:50:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:50:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:38 INFO - 'HOME': '/Users/cltbld', 17:50:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:38 INFO - 'LOGNAME': 'cltbld', 17:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:38 INFO - 'MOZ_NO_REMOTE': '1', 17:50:38 INFO - 'NO_EM_RESTART': '1', 17:50:38 INFO - 'PAGER': '/bin/cat', 17:50:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:38 INFO - 'PWD': '/builds/slave/test', 17:50:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:38 INFO - 'SHELL': '/bin/bash', 17:50:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:50:38 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:50:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:38 INFO - 'USER': 'cltbld', 17:50:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:38 INFO - 'XPC_FLAGS': '0x0', 17:50:38 INFO - 'XPC_SERVICE_NAME': '0', 17:50:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:50:38 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 17:50:38 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 17:50:38 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 17:50:38 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 17:50:38 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 17:50:38 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 17:50:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:50:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:50:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:50:41 INFO - Installing collected packages: mozsystemmonitor 17:50:41 INFO - Running setup.py install for mozsystemmonitor 17:50:41 INFO - Successfully installed mozsystemmonitor 17:50:41 INFO - Cleaning up... 17:50:41 INFO - Return code: 0 17:50:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:50:41 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')]} 17:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:41 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')]} 17:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:41 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 0x10c476a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963717ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:50:41 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 17:50:41 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 17:50:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:50:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:41 INFO - 'HOME': '/Users/cltbld', 17:50:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:41 INFO - 'LOGNAME': 'cltbld', 17:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:41 INFO - 'MOZ_NO_REMOTE': '1', 17:50:41 INFO - 'NO_EM_RESTART': '1', 17:50:41 INFO - 'PAGER': '/bin/cat', 17:50:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:41 INFO - 'PWD': '/builds/slave/test', 17:50:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:41 INFO - 'SHELL': '/bin/bash', 17:50:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:50:41 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:50:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:41 INFO - 'USER': 'cltbld', 17:50:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:41 INFO - 'XPC_FLAGS': '0x0', 17:50:41 INFO - 'XPC_SERVICE_NAME': '0', 17:50:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:41 INFO - Downloading/unpacking blobuploader==1.2.4 17:50:41 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 17:50:41 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 17:50:41 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 17:50:41 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 17:50:41 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 17:50:41 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 17:50:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:50:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:50:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:50:44 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 17:50:44 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 17:50:44 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 17:50:44 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 17:50:44 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 17:50:44 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 17:50:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:50:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:50:44 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 17:50:44 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 17:50:44 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 17:50:44 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 17:50:44 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 17:50:44 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 17:50:45 INFO - Downloading docopt-0.6.1.tar.gz 17:50:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:50:45 INFO - Installing collected packages: blobuploader, requests, docopt 17:50:45 INFO - Running setup.py install for blobuploader 17:50:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:50:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:50:45 INFO - Running setup.py install for requests 17:50:46 INFO - Running setup.py install for docopt 17:50:46 INFO - Successfully installed blobuploader requests docopt 17:50:46 INFO - Cleaning up... 17:50:46 INFO - Return code: 0 17:50:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:46 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')]} 17:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:46 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')]} 17:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:46 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 0x10c476a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963717ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:50:46 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 17:50:46 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 17:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:46 INFO - 'HOME': '/Users/cltbld', 17:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:46 INFO - 'LOGNAME': 'cltbld', 17:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:46 INFO - 'MOZ_NO_REMOTE': '1', 17:50:46 INFO - 'NO_EM_RESTART': '1', 17:50:46 INFO - 'PAGER': '/bin/cat', 17:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:46 INFO - 'PWD': '/builds/slave/test', 17:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:46 INFO - 'SHELL': '/bin/bash', 17:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:50:46 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:46 INFO - 'USER': 'cltbld', 17:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:46 INFO - 'XPC_FLAGS': '0x0', 17:50:46 INFO - 'XPC_SERVICE_NAME': '0', 17:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:46 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-E0Pkea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:46 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-A5CDr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:46 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-uX6uLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-KQeoWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-r6Gi7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-zRU9N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-GQ2zt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-bXoj8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-zsk7cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-wpr3SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:47 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-lPsKB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:48 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-uBUICN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:48 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-nRbsKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:48 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-ZXtxja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:48 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-00RtIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:48 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-Qp7vTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:48 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-lCsJmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:50:48 INFO - Running setup.py install for manifestparser 17:50:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:50:49 INFO - Running setup.py install for mozcrash 17:50:49 INFO - Running setup.py install for mozdebug 17:50:49 INFO - Running setup.py install for mozdevice 17:50:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:50:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:50:49 INFO - Running setup.py install for mozfile 17:50:50 INFO - Running setup.py install for mozhttpd 17:50:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:50:50 INFO - Running setup.py install for mozinfo 17:50:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:50:50 INFO - Running setup.py install for mozInstall 17:50:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:50:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:50:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:50:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:50:50 INFO - Running setup.py install for mozleak 17:50:50 INFO - Running setup.py install for mozlog 17:50:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:50:50 INFO - Running setup.py install for moznetwork 17:50:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:50:51 INFO - Running setup.py install for mozprocess 17:50:51 INFO - Running setup.py install for mozprofile 17:50:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:50:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:50:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:50:51 INFO - Running setup.py install for mozrunner 17:50:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:50:51 INFO - Running setup.py install for mozscreenshot 17:50:51 INFO - Running setup.py install for moztest 17:50:51 INFO - Running setup.py install for mozversion 17:50:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:50:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:50:52 INFO - Cleaning up... 17:50:52 INFO - Return code: 0 17:50:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:52 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')]} 17:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:52 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')]} 17:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:52 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 0x10c476a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963717ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:50:52 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 17:50:52 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 17:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:52 INFO - 'HOME': '/Users/cltbld', 17:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:52 INFO - 'LOGNAME': 'cltbld', 17:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:52 INFO - 'MOZ_NO_REMOTE': '1', 17:50:52 INFO - 'NO_EM_RESTART': '1', 17:50:52 INFO - 'PAGER': '/bin/cat', 17:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:52 INFO - 'PWD': '/builds/slave/test', 17:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:52 INFO - 'SHELL': '/bin/bash', 17:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:50:52 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:52 INFO - 'USER': 'cltbld', 17:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:52 INFO - 'XPC_FLAGS': '0x0', 17:50:52 INFO - 'XPC_SERVICE_NAME': '0', 17:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:52 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-kPVUQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:52 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)) 17:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:52 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-ZDT86l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:52 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)) 17:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:52 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-BtAlzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:52 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)) 17:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:52 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-FSmZOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:52 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)) 17:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:52 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-MNOAUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:53 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-HFbyOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:53 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-TiCGuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:53 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-lDBVoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:53 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-FJrM_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:53 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-7rZne1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:53 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-9xy634-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:53 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-0o95Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:53 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)) 17:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:54 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-y7oz11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:54 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)) 17:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:54 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-wesPub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:54 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)) 17:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:54 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-eObMGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:54 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)) 17:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:54 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-E6ZTap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:54 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)) 17:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:54 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-FoLWIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:54 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)) 17:50:54 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)) 17:50:54 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)) 17:50:54 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)) 17:50:54 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)) 17:50:54 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)) 17:50:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:50: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 17:50: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 17:50: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 17:50: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 17:50: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 17:50: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 17:50:57 INFO - Downloading blessings-1.5.1.tar.gz 17:50:57 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 17:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:50:57 INFO - Installing collected packages: blessings 17:50:57 INFO - Running setup.py install for blessings 17:50:57 INFO - Successfully installed blessings 17:50:57 INFO - Cleaning up... 17:50:57 INFO - Return code: 0 17:50:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:50:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:57 INFO - Reading from file tmpfile_stdout 17:50:57 INFO - Current package versions: 17:50:57 INFO - blessings == 1.5.1 17:50:57 INFO - blobuploader == 1.2.4 17:50:57 INFO - docopt == 0.6.1 17:50:57 INFO - manifestparser == 1.1 17:50:57 INFO - mozInstall == 1.12 17:50:57 INFO - mozcrash == 0.16 17:50:57 INFO - mozdebug == 0.1 17:50:57 INFO - mozdevice == 0.47 17:50:57 INFO - mozfile == 1.2 17:50:57 INFO - mozhttpd == 0.7 17:50:57 INFO - mozinfo == 0.9 17:50:57 INFO - mozleak == 0.1 17:50:57 INFO - mozlog == 3.0 17:50:57 INFO - moznetwork == 0.27 17:50:57 INFO - mozprocess == 0.22 17:50:57 INFO - mozprofile == 0.27 17:50:57 INFO - mozrunner == 6.11 17:50:57 INFO - mozscreenshot == 0.1 17:50:57 INFO - mozsystemmonitor == 0.0 17:50:57 INFO - moztest == 0.7 17:50:57 INFO - mozversion == 1.4 17:50:57 INFO - psutil == 3.1.1 17:50:57 INFO - requests == 1.2.3 17:50:57 INFO - wsgiref == 0.1.2 17:50:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:57 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 0x10c476a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e3228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963717ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/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.QJL4EtubeN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:50:57 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 17:50:57 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 17:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:57 INFO - 'HOME': '/Users/cltbld', 17:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:57 INFO - 'LOGNAME': 'cltbld', 17:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:57 INFO - 'MOZ_NO_REMOTE': '1', 17:50:57 INFO - 'NO_EM_RESTART': '1', 17:50:57 INFO - 'PAGER': '/bin/cat', 17:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:57 INFO - 'PWD': '/builds/slave/test', 17:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:57 INFO - 'SHELL': '/bin/bash', 17:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:50:57 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:57 INFO - 'USER': 'cltbld', 17:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:57 INFO - 'XPC_FLAGS': '0x0', 17:50:57 INFO - 'XPC_SERVICE_NAME': '0', 17:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 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)) 17:50:58 INFO - Cleaning up... 17:50:58 INFO - Return code: 0 17:50:58 INFO - Running post-action listener: _resource_record_post_action 17:50:58 INFO - Running post-action listener: _start_resource_monitoring 17:50:58 INFO - Starting resource monitoring. 17:50:58 INFO - ##### 17:50:58 INFO - ##### Running install step. 17:50:58 INFO - ##### 17:50:58 INFO - Running pre-action listener: _resource_record_pre_action 17:50:58 INFO - Running main action method: install 17:50:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:58 INFO - Reading from file tmpfile_stdout 17:50:58 INFO - Detecting whether we're running mozinstall >=1.0... 17:50:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:50:58 INFO - Reading from file tmpfile_stdout 17:50:58 INFO - Output received: 17:50:58 INFO - Usage: mozinstall [options] installer 17:50:58 INFO - Options: 17:50:58 INFO - -h, --help show this help message and exit 17:50:58 INFO - -d DEST, --destination=DEST 17:50:58 INFO - Directory to install application into. [default: 17:50:58 INFO - "/builds/slave/test"] 17:50:58 INFO - --app=APP Application being installed. [default: firefox] 17:50:58 INFO - mkdir: /builds/slave/test/build/application 17:50:58 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'] 17:50:58 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 17:51:37 INFO - Reading from file tmpfile_stdout 17:51:37 INFO - Output received: 17:51:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:51:37 INFO - Running post-action listener: _resource_record_post_action 17:51:37 INFO - ##### 17:51:37 INFO - ##### Running run-tests step. 17:51:37 INFO - ##### 17:51:37 INFO - Running pre-action listener: _resource_record_pre_action 17:51:37 INFO - Running main action method: run_tests 17:51:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:51:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:51:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:51:37 INFO - 2015-10-30 17:51:37.191 screenresolution[1632:7998] starting screenresolution argv=screenresolution get 17:51:37 INFO - 2015-10-30 17:51:37.195 screenresolution[1632:7998] Display 0: 1600x1200x32@60 17:51:37 INFO - 2015-10-30 17:51:37.201 screenresolution[1633:8000] starting screenresolution argv=screenresolution list 17:51:37 INFO - Available Modes on Display 0 17:51:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:51:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:51:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:51:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:51:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:51:37 INFO - Intel HD Graphics 3000: 17:51:37 INFO - Chipset Model: Intel HD Graphics 3000 17:51:37 INFO - Type: GPU 17:51:37 INFO - Bus: Built-In 17:51:37 INFO - VRAM (Total): 512 MB 17:51:37 INFO - VRAM (Dynamic, Max): 10 17:51:37 INFO - Vendor: Intel (0x8086) 17:51:37 INFO - Device ID: 0x0116 17:51:37 INFO - Revision ID: 0x0009 17:51:37 INFO - Displays: 17:51:37 INFO - Display: 17:51:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:51:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:51:37 INFO - Display Serial Number: 1600x1200 60 17:51:37 INFO - Main Display: Yes 17:51:37 INFO - Mirror: Off 17:51:37 INFO - Online: Yes 17:51:37 INFO - Rotation: Supported 17:51:37 INFO - Return code: 0 17:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:37 INFO - Python 2.7.3 17:51:37 INFO - Return code: 0 17:51:37 INFO - grabbing minidump binary from tooltool 17:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:51:37 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 0x10c42b9f0>, '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 0x10c18acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3f5990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51:37 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 17:51:37 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 17:51:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:37 INFO - Return code: 0 17:51:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:51:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:51:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0008', '--webServer', 'localhost'] in /builds/slave/test/build 17:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0008 --webServer localhost 17:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyj1RDj8dU/Render', 17:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:37 INFO - 'HOME': '/Users/cltbld', 17:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:37 INFO - 'LOGNAME': 'cltbld', 17:51:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:37 INFO - 'MOZ_NO_REMOTE': '1', 17:51:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:37 INFO - 'NO_EM_RESTART': '1', 17:51:37 INFO - 'PAGER': '/bin/cat', 17:51:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:37 INFO - 'PWD': '/builds/slave/test', 17:51:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:37 INFO - 'SHELL': '/bin/bash', 17:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJL4EtubeN/Listeners', 17:51:37 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 17:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:37 INFO - 'USER': 'cltbld', 17:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:37 INFO - 'XPC_FLAGS': '0x0', 17:51:37 INFO - 'XPC_SERVICE_NAME': '0', 17:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:51:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0008', '--webServer', 'localhost'] with output_timeout 3600 17:51:37 INFO - mozversion INFO | application_buildid: 20151030163430 17:51:37 INFO - mozversion INFO | application_changeset: 765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9 17:51:37 INFO - mozversion INFO | application_display_name: Nightly 17:51:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:37 INFO - mozversion INFO | application_name: Firefox 17:51:37 INFO - mozversion INFO | application_remotingname: firefox 17:51:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:51:37 INFO - mozversion INFO | application_vendor: Mozilla 17:51:37 INFO - mozversion INFO | application_version: 45.0a1 17:51:37 INFO - mozversion INFO | platform_buildid: 20151030163430 17:51:37 INFO - mozversion INFO | platform_changeset: 765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9 17:51:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:51:37 INFO - mozversion INFO | platform_version: 45.0a1 17:51:37 INFO - 2015-10-30 17:51:37,918 DEBUG : using testdate: 1446252697 17:51:37 INFO - 2015-10-30 17:51:37,918 DEBUG : actual date: 1446252697 17:51:37 INFO - 2015-10-30 17:51:37,993 INFO : starting webserver on 'localhost:49267' 17:51:37 INFO - 2015-10-30 17:51:37,994 INFO : Starting test suite t-yosemite-r5-0008 17:51:37 INFO - 2015-10-30 17:51:37,994 INFO : Starting test dromaeo_css 17:51:37 INFO - 2015-10-30 17:51:37,995 DEBUG : operating with platform_type : mac_ 17:51:37 INFO - 2015-10-30 17:51:37,995 INFO : Initialising browser for dromaeo_css test... 17:51:38 INFO - 2015-10-30 17:51:38,023 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpORhOgh/profile http://localhost:49267/getInfo.html 17:51:40 INFO - 2015-10-30 17:51:40,892 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:51:40 INFO - 2015-10-30 17:51:40,892 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:51:40 INFO - 2015-10-30 17:51:40,892 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:51:40 INFO - 2015-10-30 17:51:40,892 DEBUG : BROWSER_OUTPUT: __metrics 17:51:40 INFO - 2015-10-30 17:51:40,910 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:51:41 INFO - 2015-10-30 17:51:41,654 INFO : Browser initialized. 17:51:41 INFO - 2015-10-30 17:51:41,655 INFO : Running cycle 1/1 for dromaeo_css test... 17:51:41 INFO - 2015-10-30 17:51:41,655 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpORhOgh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:51:53 INFO - 2015-10-30 17:51:53,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 220274688 17:51:53 INFO - 2015-10-30 17:51:53,631 DEBUG : BROWSER_OUTPUT: 17:52:44 INFO - 2015-10-30 17:52:44,640 DEBUG : BROWSER_OUTPUT: 1446252764639 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] 17:54:55 INFO - 2015-10-30 17:54:55,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 17:54:57 INFO - 2015-10-30 17:54:57,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 323649536 17:54:57 INFO - 2015-10-30 17:54:57,005 DEBUG : BROWSER_OUTPUT: 17:57:59 INFO - 2015-10-30 17:57:59,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 17:58:00 INFO - 2015-10-30 17:58:00,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 362151936 17:58:00 INFO - 2015-10-30 17:58:00,358 DEBUG : BROWSER_OUTPUT: 18:01:02 INFO - 2015-10-30 18:01:02,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 18:01:03 INFO - 2015-10-30 18:01:03,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 321060864 18:01:03 INFO - 2015-10-30 18:01:03,081 DEBUG : BROWSER_OUTPUT: 18:04:05 INFO - 2015-10-30 18:04:05,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 18:04:05 INFO - 2015-10-30 18:04:05,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 311390208 18:04:05 INFO - 2015-10-30 18:04:05,701 DEBUG : BROWSER_OUTPUT: 18:07:08 INFO - 2015-10-30 18:07:08,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 18:07:09 INFO - 2015-10-30 18:07:09,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 312799232 18:07:09 INFO - 2015-10-30 18:07:09,262 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 18:10:12 INFO - 2015-10-30 18:10:12,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 358768640 18:10:12 INFO - 2015-10-30 18:10:12,325 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,326 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:10:12 INFO - 2015-10-30 18:10:12,326 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:10:12 INFO - 2015-10-30 18:10:12,326 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:10:12 INFO - 2015-10-30 18:10:12,326 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:10:12 INFO - 2015-10-30 18:10:12,327 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2948.7788415868804;2962.8592991698197;2972.1975066731998;3003.399320135972;3116.4702000659886;4732.9526704733025;4851.684640498374;4899.338589290444;4919.7786099625555;4956.008798240348;4850.296706977486;4864.246041863516;4972.453030166679;5036.82371117011;5047.697138171712;4585.587297143256;4587.0596527711905;4606.239970404879;4627.490975992638;4739.218029025206;4725.716457012591;4778.402699662543;4793.233082706767;4824.5899098576665;4830.106430310386;4371.191329604034;4465.218586747306;4514.841980530666;4748.762561871893;4755.5244475552345;4691.530846915315;4696.671233013691;4700.576948074656;4707.482176960531;4724.362211101492;4644.326572646981;4660.4174478190225;4675.088357770236;4692.343071969927;4724.220503616899;4745.406824146981;4824.614030877521;4901.705897646153;4936.086823937583;4998.4751601081725;5247.842564723064;5338.252644629755;5344.91982620261;5358.571314294847;5377.569794416438;5407.756650950677;5414.675119492843;5420.376656684492;5433.538149257318;5435.076037073707;4822.927656085197;4888.926666100011;4912.9508704913205;4916.901661966741;5101.668391554575;5386.542143917733;5411.242426060355;5422.6475279106735;5447;5500.559955203574;5186.818461353834;5189.636725429184;5205.635605507654;5206.479352064764;5219.530242278137;5082.415522214918;5123.564497017721;5150.356205474316;5218.6868787872845;5377.059014672495;5207.843764687065;5231.450697676765;5234.18870075139;5245.554127899095;5279.47205279469;5222.294990176353;5229.529342359206;5235.73821308933;5263.605229607795;5282.339707536558;3995.0411901143516;4085.0400155963325;4091.0386059276047;4100.7334523255895;4117.75293482392;3714.832832522543;3770.019794853303;3798.772073675588;3802.7718336899875;3889.727719059695;4954.3063971044085;4961.503849615082;4968.080905032508;4973.204287314013;4993.375828021497;5382.946170538323;5383.946160538423;5391.16436952273;5393.13709806437;5437.537809286176;4817.8313759018265;4831;4953.925691114636;4955.40535135786;4960.379952505937;4707.435107787088;4724.385829842167;4729.597984171315;4729.739864307496;4781.737004464788;5448.645838020516;5451.100568406168;5453.045716999509;5465.988792073479;5468.48049435303;5206.765695543785;5298.761555729924;5310.840674779763;5365.356157261153;5393.6763794172475;5450.672959622277;5451.672899626035;5468.070428027325;5476.342838859362;5479.178123281539;5300.178472336794;5333.12003519415;5335.653182543122;5354.223637572608;5410.215518749838;5185.870353241048;5247.396549396868;5387.164989426645;5392.406835248198;5414.214938833768;5146.433892271922;5175.353080864892;5192.896142077213;5198.220266959835;5230.633855630222;5143.974280128576;5178.922316165185;5182.792688292426;5199.4540573239265;5212.374515058065;4895.828645997373;4921.360223170965;5004.724740139327;5038.773255203451;5064.2403639452905;5195.246689229964;5199.454057324077;5217.973910130425;5228.346456692913;5239.973800130975;5099.23511473282;5111.156659151347;5117.641765076558;5122.231665250242;5162.561182299396 18:10:12 INFO - 2015-10-30 18:10:12,332 DEBUG : BROWSER_OUTPUT: |1;ext.html;525.6241787122209;527.2249792804579;532.2947095098993;536.7852858856457;547.6987656788771;28451.715482845164;29277;36152.638473615254;36827.447588286195;36971;38650.42024369637;39112;39191.80404097983;39207.21585568287;39503.40744888822;7619.161892191854;8509.829803403944;8684.435511691752;8732.301415886714;8773.298136149093;7548.773536793905;10203.336783109111;10373.585056597727;10384.48077596121;10422.687319380431;10169.38983660979;10174.084332410082;10181.134603558707;10224.233182511303;10270.845937310947;7781.26078022587;7937.682492700285;10234.795304093876;10247.077763001365;10279.383237005804;9881.308308418413;10040.447775372351;10046.246531510165;10102.242331825142;10106.89893101067;35373.46939795905;35723.82138089319;35743;35799.82100089483;36095.097622559646;2667.4265033017996;2702.4595080983686;2780.457810726909;3080.4917188663844;3308.9172770680925;25038.116212095494;25392.619110713353;25626.359341016436;25761.227163185133;26594.202173934813;2159.0823899842503;2208.3466326204807;2220.811231045363;2221.8444708870384;2360.634101714237;239661;242863;242981;243218;243249.78375108188;50137.24794128091;51412.74293628508;58375.70812145912;59024;59230;55360.72319638376;55641.44358556443;55915.16127258095;55949.44050559524;56630;15124.39502419913;15251.694966100838;15252.237388130548;15267.236638168048;15335.463258786112;11775.646730598095;11804.055675545937;11808.232464889754;11841.052715782716;11862.347570883685;17564.209610567556;17632.91183544074;17640.382586609663;17721.7341739874;17722.645547089243;7619.352355049772;7826.726064587712;7891;7915.881261781078;7923.088844782924;807.8142027333746;857.5926434943477;990.7027891632481;1002;1026.2405819693374;25462.23613291604;25523.36191595225;25633.8718306411;25710.35724106875;25910.09314674015;876.6011464783509;892.9241014513839;922.801597656507;969.6460791810938;972.1590823937244;12237.694057648452;12466.69099744532;12512.749745005049;12659.936700316439;12846.357682115857;274191;277108;279999;280115;281575;47325;47394.5260547397;47426.5257347429;47457.762711186224;47736.28395574069;1183.6389901080254;1284.5889315419163;1293.5989843148654;1304.178367628388;1305.2103477396038;20454.795452045884;25066.62400064037;25087;25609.103681371063;26459.735402646496;42193.578064218964;42447.3632895513;42701.14597708091;42849.35725964051;42915.785421072695;185814;186801;187362.0631896832;240259;244529;28447.146585602466;28808.279793005342;28845.278868027628;29023;29062.27344316409;34945.147089650665;35033.29933401369;35171.29657406889;35236.64763352334;35732.64267357293;29307.41385172242;30130.849345754006;30150.69849301479;30262.394752104396;30579;31467.213319667193;31678;31693;31830.84084579562;32030.51954220642;31464;32004.67995320017;32261.838690806395;32418.83790581032;32501.837490812395;26813.463730725667;28560.85719571389;28618.141455756362;28668.569971450026;29070.273243168245;21327.7867221332;21513.462163446038;21515.8924205378;21547.353579392642;21608.243711470022 18:10:12 INFO - 2015-10-30 18:10:12,332 DEBUG : BROWSER_OUTPUT: |2;jquery.html;307.85223092915413;310.2089671338088;311.97036281553244;316.3846318909722;317.27660933072593;15389.769153462694;16116;16357.263923123459;17469.91265043673;17511.124443777822;16198.919005404956;16728.498145055666;16741.916290418532;16975.83024169758;17142.31430742769;4827.951720482794;4977.203647416414;5012;5013.172826483626;5051.116054690433;4271.060366719316;4407.889802754925;4445.488768791582;4959.256111583255;5042.798288068473;3088.675689052651;3151.6848315168527;3181.1887968567985;4342.696011279212;4358.912821743564;4306.504751953534;4397.6042156206095;4407.140607581523;4432.401625780511;4484.080763443502;3743.157789497341;3747.1568896997956;3753.6997040236715;3787.0910981364273;3791.241751649681;10275.743106422324;10414.16686665065;10493.737656558571;11105.333679979147;11621.302721836717;1604.2219523531078;1643.6219669475968;1725.3271224222563;1767.531604124908;1773.2375078716148;8478.618462169217;8655.35084868631;8692.52191129494;8995;9000.8649870252;1400.3838311143165;1437.5902867682764;1444.6893917807618;1454.978175327371;1518.8025556677671;49353.753231233975;51658.48341516612;52159.73920130413;52340.476595233944;52432.213516796895;5968.1644569760265;5972.671503067373;5990;6021.247344081902;6027.7890273841085;6835.7949261522235;6855.725770969205;6858.417034552019;6860.108185935796;6863.142107236596;5120.61595380348;5143.354126679502;5156.74216289184;5160.200168973815;5177.249298851645;5539.972300138554;5586.301712285965;5615.073512870331;5617.494425501643;5631.493165615114;2680.5979103134687;2712.281245469952;2735.8084934054427;2739.1371717908796;2749.4501099780123;946.2004606107828;950.7385468996082;955.0211033690523;957.2772556719632;1013.002192840052;383.6144674602063;405.27253579824287;407.8980254936266;413.5492313378432;425.41293015638837;10605.89394106049;10626;10720.142388608892;10861.262198048433;10921.12630989519;421.4836824889486;424.0374350224972;427.6771037866453;431.6331118549208;442.76975972494125;5716.685582292931;5812.912806307909;5884.9705751470965;5893.3222679391565;5968.522518198533;465048;473648;475523;508285;535175;60474;63093;63816.68091659605;63852;64813.67593162004;453.40830216567036;459.0360243488647;460.47045897218464;460.47735819844047;461.1353711790393;8402.957985210034;9842.311038227255;9844.409335439897;9903;10020.799584008424;28303.15090547287;28826.711732882402;29276;29410.411791763618;29530;36139.27721445504;37227.255454891296;37358.439623406215;37508.43737343996;37966;5589.077802162597;5616.438356164351;5618.943810561842;5625.662460252398;5667.574931880208;10649.520771565143;10749.785004300027;10860.402677852793;10864.402457864577;10891.945540272249;9178.586963586522;9180.081991800767;9477.289203309641;9490.762730931781;9494.95252523733;9008.909910900808;9095.454272743656;9172.495512746864;9202.769930751785;9296.518799283016;9285.535723213678;9450.43297402158;9536.618535258789;9552.522373881417;9643.228541716506;5290.391604965478;5627.606067575231;5657.066584013592;5658.632188907708;5669.773209071591;8929.642814287356;9142.085791420805;9206.815863682823;9237.769055773659;9294.674686385944 18:10:12 INFO - 2015-10-30 18:10:12,335 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1171.4318555500586;1617.9999999999998;1699.8130205677373;1723.6208034232473;1740.5822602575379;6541.738330466782;7046.577205367682;7219.53073050252;7256.165540962791;7259.2740725927515;6892.8276793080195;7197.53216040957;7210.531315464491;7220.711171553132;7222.494425390225;1996.071826600634;2023.7470316210474;2026.4832467720785;2027.9087441065114;2034.2066594028267;2045.3148195354574;2047.406252186864;2084.0725876984748;2103.810657040866;2109.546447513784;1980.1683293016895;1991.5817678287576;1993.0732209522569;1994.1425187169511;1998.560316730317;1995.950101247466;2000.0999550202466;2008.6585280502277;2010.2763005318075;2011.949701257473;1995.9700604490945;2015.1032790408274;2015.123421311734;2019.5153163240864;2020.1515363547198;6403.103565500834;6561.475081993429;7179.820504487378;7227.927720722778;7248.3838873695795;4200.201961627281;4342.827436592134;4346.543612920629;4351.912961740779;4358.280883654225;2622.5672763993916;2653.230563136688;2688.784897208219;2715.1447294102295;2751.4222013377216;819.6229734322219;820.2904487618167;832.9666813327459;833.2542374574722;862.9007664118644;9406.200472959807;9446.90553094474;9448.90551094494;9474.147326740627;9479.905200947971;3896.8441262349756;3905.8437662493184;3947.388154836005;3958.010497375656;4008.07814202735;8318.41771076031;8326.6669333226;8330.333573314121;8336.374771892133;8383.16168383169;4458.576435238647;4469.10617876426;4482.968917149009;4485.48416932057;4489.147062058199;4050.9594904051173;4060;4060.898477538085;4063.0858056937545;4065.28857449951;3166.4617015107488;3196.5365022072133;3199.472087105648;3213.4215841148352;3220.951685724669;1012.0385633648064;1018.3889666200369;1028.89711028898;1034.7051090439188;1037.2169012395593;916.5966974531185;937.7983733497194;939.3847030195233;977.6578197630772;1249.5876360800914;6687.799366019027;6720.22717387497;6722.831929201809;6743.460523158135;6756.0879281297375;397.838875255522;401.7268257584812;1125.5554056147776;1140.8117660586076;1164.7728692904802;5184.8963020739375;5466.3986961435;5499.697516636624;5506.64206826555;5512.228288039678;8163.346932245525;8414.284785793276;8538;8577.914220857712;8586.78533036679;8460.661573537112;8582.356323275779;8625.094365091574;8648.610812513452;8659.523726194993;6815.693293801791;6923.238443771181;6923.861522769415;6926.272741362185;6938.132733408324;6726.293739157318;6782.287859774653;6819.420349270169;6828.863422731617;6830.351116643911;7600.125985511737;7744.883826742716;7818.413618978486;7822.882656760039;7853.607319633881;7927.603619819101;7949.801254968672;7954.960225198837;7962.482438641469;7977.042754869452;5926.940730592812;6064.3935606439;6078.270607526948;6081.726322315595;6094.78668246627;6948.374646281859;6948.965255173692;6962.23415424313;6962.443004559725;6968.65156742171;6354.205724284465;6474.255460622088;6502.187226596676;6583.440407565219;6611.305812889577;6230.50155987529;6414.486841052611;6430.582012169194;6474.482041436768;6493.967530162319;6531.444827189552;6578.901316480353;6587.835304117435;6602.6698665067515;6629.03878937561;5988.101784732325;5995.91006134917;6023.66869822164;6032.939670603413;6036.426539478743;6073.240844894388;6109.08363745424;6127.571070025056;6148.415900489446;6166.81499555014 18:10:12 INFO - 2015-10-30 18:10:12,337 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.25406149335305;280.0352784656857;284.5518308663855;291.48843779167555;293.96031535742696;5551.167324901262;5553.639013464122;5558.527525160366;5571.749271282792;5627.212190293357;5422.105352616823;5490.121580547113;5531.474509921561;5535.972320138394;5539.41836107209;4336.327869180274;4336.804843782022;4356.194104090753;4376.212281789277;4388.868333949987;4138.3999320098565;4253.723507971988;4262.701610887239;4392.626626736731;4402.07556413152;4288.399624052635;4302.48370195577;4332;4342.174986752522;4373.147236288925;4182.7490350578755;4309.978450107761;4313.396124542551;4320.438343015419;4361.607455329004;3608.585012723544;3665.596784353719;3685.1892583631557;3714.9442758358646;3722.236941427028;5309.177077552986;5326.2543243945875;5344.438833922421;5361.3030306060355;5385.946140538584;4706.152892479352;4717.504662010508;4730.266808644666;4762.64280178988;4781.3545171401765;5526.613137080406;5712;5756.740946657411;5765.942340576583;5822.912656310116;3986.063275130342;3994.3609022556543;4004.739691920016;4033;4041.959580404217;6045.848853778647;6050.969745151246;6052.909206361908;6114.816555503342;6129.478994285491;4034.7175697700877;4051.0277533391773;4058.1477889643506;4096.897577560585;4105.486814148231;4013.8394464221687;4088.4889388826396;4090.1001779608437;4104.8768536943935;4131.9173616527505;4778.116048530964;4778.426588809365;4791.065742180311;4812.590929771009;4824.107540105022;5810.970945145332;5813.418658134237;5845.269341332333;5870.090136028923;5915.08316210988;1466.5453709350136;1486.6803637217834;1488.226122416359;1492.4925525321444;1504.9774253386208;964.155967571093;964.7843716916595;984.2618036472645;987.8814542254976;989.9505024748734;5524.033294173584;5556;5562;5613.663180209201;5626.212330273765;6043.54673399488;6043.8186854394435;6062.302835174011;6068.969655151696;6117.418845209698;5538.723063846792;5547.278853749068;5563.109902415594;5604.215409842625;5613.859653508695;3252;3277.7869438486423;3301.4387554115856;3337.132345590164;3349.9162520936684;5973.910391344133;6058.575899687068;6103.877922441527;6111.663858487826;6141.539384546088;6085.391460853879;6136.8772624548155;6150.876982460415;6215.378462153839;6219.315875253718;6073.392660733891;6083.513318934474;6092.786752463642;6165.32181460039;6170.352113028068;5940.435658612425;6064.423879731418;6071.939280607137;6090.2996155440915;6133.693315334126;5914.34942156371;5936.3470018297085;5963.463288304073;5971.522278217645;5988.910166347421;6092.177556030057;6151.723172457339;6163.291221509405;6180.443760061616;6210.3168651449205;3826.3112639724004;3914.0801911551334;3932.803359832054;3959.40608908666;3976.2445135424177;6064.484518815773;6089.634621922699;6118.235220597426;6162.568620196544;6164.106204600397;5907.527397808251;5933.050711886078;5955.821325360246;5978.222831031938;5993.4006599341465;5811.651300921958;5930.52555795544;5943.435373639497;5943.673097979653;5985.132155837467;5767.394423585463;5770.798022069207;5774.191613174243;5782.190493330853;5823.359430462561;5892.587518873637;5904.498117659875;5927.851803704942;5944.524438044859;5955.434233747787;5629.634073785191;5752.741126649395;5780.393058728773;5811.912821307768;5819.447152520504 18:10:12 INFO - 2015-10-30 18:10:12,338 DEBUG : BROWSER_OUTPUT: |5;yui.html;703.3423748794877;712.5902606001547;713.8964850096736;714.8856183010719;758.5714071549578;12519.06107041972;12683.365831708412;12712.618621441348;12796.48814047437;14169.362378692958;12875.484980600788;12976.091673582852;13006.934965325183;13028.804567931465;13085.14946528475;660.4452260101514;667.0794303860665;805.1827395193868;809.3969992355703;821.4824660463929;822.6709316273478;829.2785276809185;834.0991728932738;835.1856939484015;837.6398148796015;854.581255184958;878.2139984713677;882.7616543533242;883.849745543256;885.7342797160858;705.1573369823063;707.1090426063146;875.2210532625968;882.6381183714678;885.2077390735255;653.0367707631253;656.2125449460618;656.875193713193;658.8155316511337;658.9604623722591;12632.557860474932;12748.553800616934;12748.553800617026;12756.043296752781;12769.87230127696;10745.946270268676;10808.29746066511;10820.458977051194;10890;11254.099672026217;7890.921090789076;8718;8729.563521823948;8991.325650576233;9118;3057.1898446911587;3059.8470076496087;3072.646645635758;3125.828079455629;3139.921501962446;45283.320750188774;45430.592705546886;46075;46127.76936115298;46362.76818615885;8344.165583441607;8356.749297521084;8571.52856592881;8595.44129631572;8968.551572421353;18134.90932545329;18193.181306841223;18215.27138914455;18368.08159592042;18474;6438.323975982455;6537.640429776408;6557.147570815859;6829.6243706596615;6845.691943862538;3460.446328587414;3464.636213197578;3532.1346270163976;3533.7278579711283;3563.6970857476886;2638.630591717161;2656.614790855354;2664.214056853194;2671.49241644087;2685.20786368018;412.4514395853508;413.805511409637;417.63456975146744;422.8308676529351;430.1440134133053;482.9495846533775;518.6162239942415;549.3572520151432;556.1657513729406;578.5776383240258;7160.928390716026;7382.151052629017;7408.881305682235;7557.470977031555;7612.162662107164;426.7354240370928;510;530.5675874162545;553.6843998920657;574.0757380617202;3414.7097496712563;3477.1654802847133;3507.2810073934784;3525.541679581689;3591.44332628443;51931;52706.472935270926;52840;52885;53206.46793532015;42573;43186.784066080094;43622.781886090364;43751.78124109359;44531.55468445274;42029.78985105055;42125.789371053565;42213.788931055766;42840.928976775205;42966.570334296885;7235.2764723527225;7424.331810137113;7579.204183560647;7597.962010190135;7598.758450953173;29188.562171567868;29432.705672943852;31030.68969310278;31289.530657039708;31301.06096817008;40446.59553404428;41393.37909931293;41438.37842432426;41604.58395416007;42142.157156856076;6904.516683832285;6977.965110174417;7003.4397248219;7086.50394472382;7141.428685705027;10226.795464090825;10259.948700256451;10274.178065754571;10362.171026318027;10507.474626268504;9631.181349585364;9815.165710914367;9838.311318207656;9846.803063938538;9915.851262231217;9384;9412.105849944244;9422.575984080595;9449.149576538144;9579;9297.256219502287;9530.523473826419;9805.85291220618;9809.313348065567;9898.257630677872;7928.722494712657;8154.796130096558;8233.876491852507;8275.668973241003;8497.447665901696;7650.73222437212;7959.880601791094;7976.441649084509;8126.460207784414;8417 18:10:12 INFO - 2015-10-30 18:10:12,339 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:10:12 INFO - 2015-10-30 18:10:12,339 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:10:12 INFO - 2015-10-30 18:10:12,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,872 18:10:12 INFO - 2015-10-30 18:10:12,339 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:10:12 INFO - 2015-10-30 18:10:12,339 DEBUG : BROWSER_OUTPUT: __startTimestamp1446253812324__endTimestamp 18:10:12 INFO - 2015-10-30 18:10:12,339 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,340 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:10:12 INFO - 2015-10-30 18:10:12,340 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:10:12 INFO - 2015-10-30 18:10:12,340 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,341 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4956.48 Median:5111.16 stddev:515.98 (10.1%) stddev-sans-first:492.94 18:10:12 INFO - 2015-10-30 18:10:12,341 DEBUG : BROWSER_OUTPUT: Values: 2948.8 2962.9 2972.2 3003.4 3116.5 4733.0 4851.7 4899.3 4919.8 4956.0 4850.3 4864.2 4972.5 5036.8 5047.7 4585.6 4587.1 4606.2 4627.5 4739.2 4725.7 4778.4 4793.2 4824.6 4830.1 4371.2 4465.2 4514.8 4748.8 4755.5 4691.5 4696.7 4700.6 4707.5 4724.4 4644.3 4660.4 4675.1 4692.3 4724.2 4745.4 4824.6 4901.7 4936.1 4998.5 5247.8 5338.3 5344.9 5358.6 5377.6 5407.8 5414.7 5420.4 5433.5 5435.1 4822.9 4888.9 4913.0 4916.9 5101.7 5386.5 5411.2 5422.6 5447.0 5500.6 5186.8 5189.6 5205.6 5206.5 5219.5 5082.4 5123.6 5150.4 5218.7 5377.1 5207.8 5231.5 5234.2 5245.6 5279.5 5222.3 5229.5 5235.7 5263.6 5282.3 3995.0 4085.0 4091.0 4100.7 4117.8 3714.8 3770.0 3798.8 3802.8 3889.7 4954.3 4961.5 4968.1 4973.2 4993.4 5382.9 5383.9 5391.2 5393.1 5437.5 4817.8 4831.0 4953.9 4955.4 4960.4 4707.4 4724.4 4729.6 4729.7 4781.7 5448.6 5451.1 5453.0 5466.0 5468.5 5206.8 5298.8 5310.8 5365.4 5393.7 5450.7 5451.7 5468.1 5476.3 5479.2 5300.2 5333.1 5335.7 5354.2 5410.2 5185.9 5247.4 5387.2 5392.4 5414.2 5146.4 5175.4 5192.9 5198.2 5230.6 5144.0 5178.9 5182.8 5199.5 5212.4 4895.8 4921.4 5004.7 5038.8 5064.2 5195.2 5199.5 5218.0 5228.3 5240.0 5099.2 5111.2 5117.6 5122.2 5162.6 18:10:12 INFO - 2015-10-30 18:10:12,342 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,342 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40150.51 Median:28643.36 stddev:63991.93 (223.4%) stddev-sans-first:64102.28 18:10:12 INFO - 2015-10-30 18:10:12,343 DEBUG : BROWSER_OUTPUT: Values: 525.6 527.2 532.3 536.8 547.7 28451.7 29277.0 36152.6 36827.4 36971.0 38650.4 39112.0 39191.8 39207.2 39503.4 7619.2 8509.8 8684.4 8732.3 8773.3 7548.8 10203.3 10373.6 10384.5 10422.7 10169.4 10174.1 10181.1 10224.2 10270.8 7781.3 7937.7 10234.8 10247.1 10279.4 9881.3 10040.4 10046.2 10102.2 10106.9 35373.5 35723.8 35743.0 35799.8 36095.1 2667.4 2702.5 2780.5 3080.5 3308.9 25038.1 25392.6 25626.4 25761.2 26594.2 2159.1 2208.3 2220.8 2221.8 2360.6 239661.0 242863.0 242981.0 243218.0 243249.8 50137.2 51412.7 58375.7 59024.0 59230.0 55360.7 55641.4 55915.2 55949.4 56630.0 15124.4 15251.7 15252.2 15267.2 15335.5 11775.6 11804.1 11808.2 11841.1 11862.3 17564.2 17632.9 17640.4 17721.7 17722.6 7619.4 7826.7 7891.0 7915.9 7923.1 807.8 857.6 990.7 1002.0 1026.2 25462.2 25523.4 25633.9 25710.4 25910.1 876.6 892.9 922.8 969.6 972.2 12237.7 12466.7 12512.7 12659.9 12846.4 274191.0 277108.0 279999.0 280115.0 281575.0 47325.0 47394.5 47426.5 47457.8 47736.3 1183.6 1284.6 1293.6 1304.2 1305.2 20454.8 25066.6 25087.0 25609.1 26459.7 42193.6 42447.4 42701.1 42849.4 42915.8 185814.0 186801.0 187362.1 240259.0 244529.0 28447.1 28808.3 28845.3 29023.0 29062.3 34945.1 35033.3 35171.3 35236.6 35732.6 29307.4 30130.8 30150.7 30262.4 30579.0 31467.2 31678.0 31693.0 31830.8 32030.5 31464.0 32004.7 32261.8 32418.8 32501.8 26813.5 28560.9 28618.1 28668.6 29070.3 21327.8 21513.5 21515.9 21547.4 21608.2 18:10:12 INFO - 2015-10-30 18:10:12,343 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,343 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24009.75 Median:469348.00 stddev:80536.81 (17.2%) stddev-sans-first:80743.07 18:10:12 INFO - 2015-10-30 18:10:12,345 DEBUG : BROWSER_OUTPUT: Values: 307.9 310.2 312.0 316.4 317.3 15389.8 16116.0 16357.3 17469.9 17511.1 16198.9 16728.5 16741.9 16975.8 17142.3 4828.0 4977.2 5012.0 5013.2 5051.1 4271.1 4407.9 4445.5 4959.3 5042.8 3088.7 3151.7 3181.2 4342.7 4358.9 4306.5 4397.6 4407.1 4432.4 4484.1 3743.2 3747.2 3753.7 3787.1 3791.2 10275.7 10414.2 10493.7 11105.3 11621.3 1604.2 1643.6 1725.3 1767.5 1773.2 8478.6 8655.4 8692.5 8995.0 9000.9 1400.4 1437.6 1444.7 1455.0 1518.8 49353.8 51658.5 52159.7 52340.5 52432.2 5968.2 5972.7 5990.0 6021.2 6027.8 6835.8 6855.7 6858.4 6860.1 6863.1 5120.6 5143.4 5156.7 5160.2 5177.2 5540.0 5586.3 5615.1 5617.5 5631.5 2680.6 2712.3 2735.8 2739.1 2749.5 946.2 950.7 955.0 957.3 1013.0 383.6 405.3 407.9 413.5 425.4 10605.9 10626.0 10720.1 10861.3 10921.1 421.5 424.0 427.7 431.6 442.8 5716.7 5812.9 5885.0 5893.3 5968.5 465048.0 473648.0 475523.0 508285.0 535175.0 60474.0 63093.0 63816.7 63852.0 64813.7 453.4 459.0 460.5 460.5 461.1 8403.0 9842.3 9844.4 9903.0 10020.8 28303.2 28826.7 29276.0 29410.4 29530.0 36139.3 37227.3 37358.4 37508.4 37966.0 5589.1 5616.4 5618.9 5625.7 5667.6 10649.5 10749.8 10860.4 10864.4 10891.9 9178.6 9180.1 9477.3 9490.8 9495.0 9008.9 9095.5 9172.5 9202.8 9296.5 9285.5 9450.4 9536.6 9552.5 9643.2 5290.4 5627.6 5657.1 5658.6 5669.8 8929.6 9142.1 9206.8 9237.8 9294.7 18:10:12 INFO - 2015-10-30 18:10:12,345 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,345 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5008.58 Median:6198.66 stddev:2605.39 (42.0%) stddev-sans-first:2596.73 18:10:12 INFO - 2015-10-30 18:10:12,346 DEBUG : BROWSER_OUTPUT: Values: 1171.4 1618.0 1699.8 1723.6 1740.6 6541.7 7046.6 7219.5 7256.2 7259.3 6892.8 7197.5 7210.5 7220.7 7222.5 1996.1 2023.7 2026.5 2027.9 2034.2 2045.3 2047.4 2084.1 2103.8 2109.5 1980.2 1991.6 1993.1 1994.1 1998.6 1996.0 2000.1 2008.7 2010.3 2011.9 1996.0 2015.1 2015.1 2019.5 2020.2 6403.1 6561.5 7179.8 7227.9 7248.4 4200.2 4342.8 4346.5 4351.9 4358.3 2622.6 2653.2 2688.8 2715.1 2751.4 819.6 820.3 833.0 833.3 862.9 9406.2 9446.9 9448.9 9474.1 9479.9 3896.8 3905.8 3947.4 3958.0 4008.1 8318.4 8326.7 8330.3 8336.4 8383.2 4458.6 4469.1 4483.0 4485.5 4489.1 4051.0 4060.0 4060.9 4063.1 4065.3 3166.5 3196.5 3199.5 3213.4 3221.0 1012.0 1018.4 1028.9 1034.7 1037.2 916.6 937.8 939.4 977.7 1249.6 6687.8 6720.2 6722.8 6743.5 6756.1 397.8 401.7 1125.6 1140.8 1164.8 5184.9 5466.4 5499.7 5506.6 5512.2 8163.3 8414.3 8538.0 8577.9 8586.8 8460.7 8582.4 8625.1 8648.6 8659.5 6815.7 6923.2 6923.9 6926.3 6938.1 6726.3 6782.3 6819.4 6828.9 6830.4 7600.1 7744.9 7818.4 7822.9 7853.6 7927.6 7949.8 7955.0 7962.5 7977.0 5926.9 6064.4 6078.3 6081.7 6094.8 6948.4 6949.0 6962.2 6962.4 6968.7 6354.2 6474.3 6502.2 6583.4 6611.3 6230.5 6414.5 6430.6 6474.5 6494.0 6531.4 6578.9 6587.8 6602.7 6629.0 5988.1 5995.9 6023.7 6032.9 6036.4 6073.2 6109.1 6127.6 6148.4 6166.8 18:10:12 INFO - 2015-10-30 18:10:12,346 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,346 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4886.49 Median:5587.98 stddev:1474.95 (26.4%) stddev-sans-first:1437.91 18:10:12 INFO - 2015-10-30 18:10:12,347 DEBUG : BROWSER_OUTPUT: Values: 275.3 280.0 284.6 291.5 294.0 5551.2 5553.6 5558.5 5571.7 5627.2 5422.1 5490.1 5531.5 5536.0 5539.4 4336.3 4336.8 4356.2 4376.2 4388.9 4138.4 4253.7 4262.7 4392.6 4402.1 4288.4 4302.5 4332.0 4342.2 4373.1 4182.7 4310.0 4313.4 4320.4 4361.6 3608.6 3665.6 3685.2 3714.9 3722.2 5309.2 5326.3 5344.4 5361.3 5385.9 4706.2 4717.5 4730.3 4762.6 4781.4 5526.6 5712.0 5756.7 5765.9 5822.9 3986.1 3994.4 4004.7 4033.0 4042.0 6045.8 6051.0 6052.9 6114.8 6129.5 4034.7 4051.0 4058.1 4096.9 4105.5 4013.8 4088.5 4090.1 4104.9 4131.9 4778.1 4778.4 4791.1 4812.6 4824.1 5811.0 5813.4 5845.3 5870.1 5915.1 1466.5 1486.7 1488.2 1492.5 1505.0 964.2 964.8 984.3 987.9 990.0 5524.0 5556.0 5562.0 5613.7 5626.2 6043.5 6043.8 6062.3 6069.0 6117.4 5538.7 5547.3 5563.1 5604.2 5613.9 3252.0 3277.8 3301.4 3337.1 3349.9 5973.9 6058.6 6103.9 6111.7 6141.5 6085.4 6136.9 6150.9 6215.4 6219.3 6073.4 6083.5 6092.8 6165.3 6170.4 5940.4 6064.4 6071.9 6090.3 6133.7 5914.3 5936.3 5963.5 5971.5 5988.9 6092.2 6151.7 6163.3 6180.4 6210.3 3826.3 3914.1 3932.8 3959.4 3976.2 6064.5 6089.6 6118.2 6162.6 6164.1 5907.5 5933.1 5955.8 5978.2 5993.4 5811.7 5930.5 5943.4 5943.7 5985.1 5767.4 5770.8 5774.2 5782.2 5823.4 5892.6 5904.5 5927.9 5944.5 5955.4 5629.6 5752.7 5780.4 5811.9 5819.4 18:10:12 INFO - 2015-10-30 18:10:12,347 DEBUG : BROWSER_OUTPUT: 18:10:12 INFO - 2015-10-30 18:10:12,347 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12347.18 Median:551.52 stddev:14572.68 (2642.3%) stddev-sans-first:14587.32 18:10:12 INFO - 2015-10-30 18:10:12,348 DEBUG : BROWSER_OUTPUT: Values: 703.3 712.6 713.9 714.9 758.6 12519.1 12683.4 12712.6 12796.5 14169.4 12875.5 12976.1 13006.9 13028.8 13085.1 660.4 667.1 805.2 809.4 821.5 822.7 829.3 834.1 835.2 837.6 854.6 878.2 882.8 883.8 885.7 705.2 707.1 875.2 882.6 885.2 653.0 656.2 656.9 658.8 659.0 12632.6 12748.6 12748.6 12756.0 12769.9 10745.9 10808.3 10820.5 10890.0 11254.1 7890.9 8718.0 8729.6 8991.3 9118.0 3057.2 3059.8 3072.6 3125.8 3139.9 45283.3 45430.6 46075.0 46127.8 46362.8 8344.2 8356.7 8571.5 8595.4 8968.6 18134.9 18193.2 18215.3 18368.1 18474.0 6438.3 6537.6 6557.1 6829.6 6845.7 3460.4 3464.6 3532.1 3533.7 3563.7 2638.6 2656.6 2664.2 2671.5 2685.2 412.5 413.8 417.6 422.8 430.1 482.9 518.6 549.4 556.2 578.6 7160.9 7382.2 7408.9 7557.5 7612.2 426.7 510.0 530.6 553.7 574.1 3414.7 3477.2 3507.3 3525.5 3591.4 51931.0 52706.5 52840.0 52885.0 53206.5 42573.0 43186.8 43622.8 43751.8 44531.6 42029.8 42125.8 42213.8 42840.9 42966.6 7235.3 7424.3 7579.2 7598.0 7598.8 29188.6 29432.7 31030.7 31289.5 31301.1 40446.6 41393.4 41438.4 41604.6 42142.2 6904.5 6978.0 7003.4 7086.5 7141.4 10226.8 10259.9 10274.2 10362.2 10507.5 9631.2 9815.2 9838.3 9846.8 9915.9 9384.0 9412.1 9422.6 9449.1 9579.0 9297.3 9530.5 9805.9 9809.3 9898.3 7928.7 8154.8 8233.9 8275.7 8497.4 7650.7 7959.9 7976.4 8126.5 8417.0 18:10:12 INFO - 2015-10-30 18:10:12,349 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:10:12 INFO - 2015-10-30 18:10:12,349 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-10-30 18:10:13,025 INFO : Browser exited with error code: 0 18:10:13 INFO - 2015-10-30 18:10:13,056 INFO : Completed test dromaeo_css (00:18:35) 18:10:13 INFO - 2015-10-30 18:10:13,056 INFO : Starting test kraken 18:10:13 INFO - 2015-10-30 18:10:13,056 DEBUG : operating with platform_type : mac_ 18:10:13 INFO - 2015-10-30 18:10:13,056 INFO : Initialising browser for kraken test... 18:10:13 INFO - 2015-10-30 18:10:13,070 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpXvYX94/profile http://localhost:49267/getInfo.html 18:10:15 INFO - 2015-10-30 18:10:15,337 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:10:15 INFO - 2015-10-30 18:10:15,338 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:10:15 INFO - 2015-10-30 18:10:15,338 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:10:15 INFO - 2015-10-30 18:10:15,338 DEBUG : BROWSER_OUTPUT: __metrics 18:10:15 INFO - 2015-10-30 18:10:15,356 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:10:16 INFO - 2015-10-30 18:10:16,082 INFO : Browser initialized. 18:10:16 INFO - 2015-10-30 18:10:16,082 INFO : Running cycle 1/1 for kraken test... 18:10:16 INFO - 2015-10-30 18:10:16,082 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpXvYX94/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:10:28 INFO - 2015-10-30 18:10:28,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 220733440 18:10:28 INFO - 2015-10-30 18:10:28,009 DEBUG : BROWSER_OUTPUT: 18:10:30 INFO - 2015-10-30 18:10:30,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:31 INFO - 2015-10-30 18:10:31,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 278331392 18:10:31 INFO - 2015-10-30 18:10:31,175 DEBUG : BROWSER_OUTPUT: 18:10:33 INFO - 2015-10-30 18:10:33,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 18:10:34 INFO - 2015-10-30 18:10:34,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 292188160 18:10:34 INFO - 2015-10-30 18:10:34,576 DEBUG : BROWSER_OUTPUT: 18:10:37 INFO - 2015-10-30 18:10:37,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 18:10:38 INFO - 2015-10-30 18:10:38,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 273653760 18:10:38 INFO - 2015-10-30 18:10:38,356 DEBUG : BROWSER_OUTPUT: 18:10:40 INFO - 2015-10-30 18:10:40,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 18:10:41 INFO - 2015-10-30 18:10:41,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 276275200 18:10:41 INFO - 2015-10-30 18:10:41,053 DEBUG : BROWSER_OUTPUT: 18:10:43 INFO - 2015-10-30 18:10:43,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:43 INFO - 2015-10-30 18:10:43,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 277368832 18:10:43 INFO - 2015-10-30 18:10:43,941 DEBUG : BROWSER_OUTPUT: 18:10:47 INFO - 2015-10-30 18:10:47,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:47 INFO - 2015-10-30 18:10:47,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 277942272 18:10:47 INFO - 2015-10-30 18:10:47,784 DEBUG : BROWSER_OUTPUT: 18:10:51 INFO - 2015-10-30 18:10:51,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:51 INFO - 2015-10-30 18:10:51,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 277073920 18:10:51 INFO - 2015-10-30 18:10:51,741 DEBUG : BROWSER_OUTPUT: 18:10:54 INFO - 2015-10-30 18:10:54,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 18:10:55 INFO - 2015-10-30 18:10:55,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 278306816 18:10:55 INFO - 2015-10-30 18:10:55,429 DEBUG : BROWSER_OUTPUT: 18:10:57 INFO - 2015-10-30 18:10:57,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:57 INFO - 2015-10-30 18:10:57,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 314740736 18:10:57 INFO - 2015-10-30 18:10:57,632 DEBUG : BROWSER_OUTPUT: 18:10:59 INFO - 2015-10-30 18:10:59,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:11:00 INFO - 2015-10-30 18:11:00,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 315158528 18:11:00 INFO - 2015-10-30 18:11:00,138 DEBUG : BROWSER_OUTPUT: 18:11:02 INFO - 2015-10-30 18:11:02,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:11:02 INFO - 2015-10-30 18:11:02,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 320761856 18:11:02 INFO - 2015-10-30 18:11:02,921 DEBUG : BROWSER_OUTPUT: 18:11:05 INFO - 2015-10-30 18:11:05,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:11:06 INFO - 2015-10-30 18:11:06,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 323391488 18:11:06 INFO - 2015-10-30 18:11:06,266 DEBUG : BROWSER_OUTPUT: 18:11:09 INFO - 2015-10-30 18:11:09,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:09 INFO - 2015-10-30 18:11:09,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 322060288 18:11:09 INFO - 2015-10-30 18:11:09,593 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 18:11:11 INFO - 2015-10-30 18:11:11,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 381177856 18:11:11 INFO - 2015-10-30 18:11:11,698 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,698 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:11:11 INFO - 2015-10-30 18:11:11,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:11:11 INFO - 2015-10-30 18:11:11,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:11:11 INFO - 2015-10-30 18:11:11,698 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:11:11 INFO - 2015-10-30 18:11:11,698 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;107;99;110;106;112;98;107;110;109 18:11:11 INFO - 2015-10-30 18:11:11,699 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;170;145;166;183;136;165;162;141;176;141 18:11:11 INFO - 2015-10-30 18:11:11,699 DEBUG : BROWSER_OUTPUT: |2;audio-dft;193;178;173;174;174;182;177;175;179;178 18:11:11 INFO - 2015-10-30 18:11:11,699 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;81;94;94;75;77;80;88;90;73 18:11:11 INFO - 2015-10-30 18:11:11,699 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;109;151;99;101;98;141;101;100;146 18:11:11 INFO - 2015-10-30 18:11:11,699 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;130;138;135;130;129;128;125;130;129;126 18:11:11 INFO - 2015-10-30 18:11:11,699 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;138;142;140;135;140;141;134;140;140;136 18:11:11 INFO - 2015-10-30 18:11:11,699 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;114;113;114;112;109;114;114;114;113 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;61;63;65;64;67;74;63;67 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;71;73;72;74;74;72;72;71;72 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;95;95;96;95;95;95;92;94;97 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;135;138;135;146;135;139;147;139;147 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;171;164;172;165;154;171;174;153;152 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;77;76;81;81;81;80;80;76;77 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:11:11 INFO - 2015-10-30 18:11:11,700 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: __startTimestamp1446253871692__endTimestamp 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.30 Median:110.00 stddev:4.62 (4.2%) stddev-sans-first:4.88 18:11:11 INFO - 2015-10-30 18:11:11,701 DEBUG : BROWSER_OUTPUT: Values: 105.0 107.0 99.0 110.0 106.0 112.0 98.0 107.0 110.0 109.0 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:158.50 Median:165.50 stddev:16.50 (10.0%) stddev-sans-first:16.97 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: Values: 170.0 145.0 166.0 183.0 136.0 165.0 162.0 141.0 176.0 141.0 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:178.30 Median:178.00 stddev:5.85 (3.3%) stddev-sans-first:2.92 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: Values: 193.0 178.0 173.0 174.0 174.0 182.0 177.0 175.0 179.0 178.0 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,702 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.30 Median:84.50 stddev:7.69 (9.1%) stddev-sans-first:8.11 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 94.0 94.0 75.0 77.0 80.0 88.0 90.0 73.0 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.70 Median:143.50 stddev:21.92 (15.3%) stddev-sans-first:22.69 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: Values: 101.0 109.0 151.0 99.0 101.0 98.0 141.0 101.0 100.0 146.0 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:130.00 Median:130.00 stddev:3.89 (3.0%) stddev-sans-first:4.12 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: Values: 130.0 138.0 135.0 130.0 129.0 128.0 125.0 130.0 129.0 126.0 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,703 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:138.60 Median:140.00 stddev:2.72 (1.9%) stddev-sans-first:2.87 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: Values: 138.0 142.0 140.0 135.0 140.0 141.0 134.0 140.0 140.0 136.0 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.10 Median:114.00 stddev:1.60 (1.4%) stddev-sans-first:1.66 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: Values: 114.0 114.0 113.0 114.0 112.0 109.0 114.0 114.0 114.0 113.0 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:4.61 (7.1%) stddev-sans-first:4.32 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 61.0 63.0 65.0 64.0 67.0 74.0 63.0 67.0 18:11:11 INFO - 2015-10-30 18:11:11,704 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:1.99 (2.8%) stddev-sans-first:1.12 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 73.0 72.0 74.0 74.0 72.0 72.0 71.0 72.0 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:95.00 stddev:1.58 (1.7%) stddev-sans-first:1.36 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: Values: 92.0 95.0 95.0 96.0 95.0 95.0 95.0 92.0 94.0 97.0 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:141.50 stddev:5.04 (3.6%) stddev-sans-first:5.18 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: Values: 144.0 135.0 138.0 135.0 146.0 135.0 139.0 147.0 139.0 147.0 18:11:11 INFO - 2015-10-30 18:11:11,705 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,706 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:168.00 stddev:9.45 (5.6%) stddev-sans-first:8.86 18:11:11 INFO - 2015-10-30 18:11:11,706 DEBUG : BROWSER_OUTPUT: Values: 150.0 171.0 164.0 172.0 165.0 154.0 171.0 174.0 153.0 152.0 18:11:11 INFO - 2015-10-30 18:11:11,706 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-10-30 18:11:11,706 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:80.00 stddev:2.78 (3.5%) stddev-sans-first:2.22 18:11:11 INFO - 2015-10-30 18:11:11,706 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 76.0 81.0 81.0 81.0 80.0 80.0 76.0 77.0 18:11:11 INFO - 2015-10-30 18:11:11,706 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:11:11 INFO - 2015-10-30 18:11:11,706 DEBUG : BROWSER_OUTPUT: 18:11:12 INFO - 2015-10-30 18:11:12,381 INFO : Browser exited with error code: 0 18:11:12 INFO - 2015-10-30 18:11:12,433 INFO : Completed test kraken (00:00:59) 18:11:12 INFO - 2015-10-30 18:11:12,433 INFO : Starting test v8_7 18:11:12 INFO - 2015-10-30 18:11:12,433 DEBUG : operating with platform_type : mac_ 18:11:12 INFO - 2015-10-30 18:11:12,433 INFO : Initialising browser for v8_7 test... 18:11:12 INFO - 2015-10-30 18:11:12,447 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpI0s_jy/profile http://localhost:49267/getInfo.html 18:11:14 INFO - 2015-10-30 18:11:14,728 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:11:14 INFO - 2015-10-30 18:11:14,728 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:11:14 INFO - 2015-10-30 18:11:14,728 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:11:14 INFO - 2015-10-30 18:11:14,728 DEBUG : BROWSER_OUTPUT: __metrics 18:11:14 INFO - 2015-10-30 18:11:14,745 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:11:15 INFO - 2015-10-30 18:11:15,034 DEBUG : BROWSER_OUTPUT: console.error: 18:11:15 INFO - 2015-10-30 18:11:15,038 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 18:11:15 INFO - 2015-10-30 18:11:15,038 DEBUG : BROWSER_OUTPUT: Stack: 18:11:15 INFO - 2015-10-30 18:11:15,038 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 18:11:15 INFO - 2015-10-30 18:11:15,038 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 18:11:15 INFO - 2015-10-30 18:11:15,038 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 18:11:15 INFO - 2015-10-30 18:11:15,039 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 18:11:15 INFO - 2015-10-30 18:11:15,039 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 18:11:15 INFO - 2015-10-30 18:11:15,039 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 18:11:15 INFO - 2015-10-30 18:11:15,039 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:11:15 INFO - 2015-10-30 18:11:15,039 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 18:11:15 INFO - 2015-10-30 18:11:15,039 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:11:15 INFO - 2015-10-30 18:11:15,039 DEBUG : BROWSER_OUTPUT: 18:11:15 INFO - 2015-10-30 18:11:15,462 INFO : Browser initialized. 18:11:15 INFO - 2015-10-30 18:11:15,462 INFO : Running cycle 1/1 for v8_7 test... 18:11:15 INFO - 2015-10-30 18:11:15,462 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpI0s_jy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:11:27 INFO - 2015-10-30 18:11:27,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 220475392 18:11:27 INFO - 2015-10-30 18:11:27,422 DEBUG : BROWSER_OUTPUT: 18:11:48 INFO - 2015-10-30 18:11:48,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 18:11:49 INFO - 2015-10-30 18:11:49,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 713084928 18:11:49 INFO - 2015-10-30 18:11:49,240 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,240 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:11:49 INFO - 2015-10-30 18:11:49,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:11:49 INFO - 2015-10-30 18:11:49,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:11:49 INFO - 2015-10-30 18:11:49,241 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:11:49 INFO - 2015-10-30 18:11:49,241 DEBUG : BROWSER_OUTPUT: |0;Richards;172.14666896195558 18:11:49 INFO - 2015-10-30 18:11:49,241 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;219.8768689533861 18:11:49 INFO - 2015-10-30 18:11:49,241 DEBUG : BROWSER_OUTPUT: |2;Encrypt;348.5535029627048 18:11:49 INFO - 2015-10-30 18:11:49,241 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6223.60248447205 18:11:49 INFO - 2015-10-30 18:11:49,242 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2254.5045045045044 18:11:49 INFO - 2015-10-30 18:11:49,242 DEBUG : BROWSER_OUTPUT: |5;Earley;977.5171065493646 18:11:49 INFO - 2015-10-30 18:11:49,242 DEBUG : BROWSER_OUTPUT: |6;Boyer;13662.162162162162 18:11:49 INFO - 2015-10-30 18:11:49,242 DEBUG : BROWSER_OUTPUT: |7;RegExp;31562.5 18:11:49 INFO - 2015-10-30 18:11:49,242 DEBUG : BROWSER_OUTPUT: |8;Splay;691.0850034554251 18:11:49 INFO - 2015-10-30 18:11:49,242 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6289.308176100629 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: __startTimestamp1446253909240__endTimestamp 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.15 Median:172.15 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: Values: 172.1 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:219.88 Median:219.88 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,244 DEBUG : BROWSER_OUTPUT: Values: 219.9 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:348.55 Median:348.55 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: Values: 348.6 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6223.60 Median:6223.60 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: Values: 6223.6 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2254.50 Median:2254.50 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: Values: 2254.5 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:977.52 Median:977.52 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: Values: 977.5 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,245 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13662.16 Median:13662.16 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: Values: 13662.2 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31562.50 Median:31562.50 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: Values: 31562.5 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:691.09 Median:691.09 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: Values: 691.1 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,246 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6289.31 Median:6289.31 stddev:0.00 (0.0%) 18:11:49 INFO - 2015-10-30 18:11:49,247 DEBUG : BROWSER_OUTPUT: Values: 6289.3 18:11:49 INFO - 2015-10-30 18:11:49,247 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:11:49 INFO - 2015-10-30 18:11:49,247 DEBUG : BROWSER_OUTPUT: 18:11:49 INFO - 2015-10-30 18:11:49,976 INFO : Browser exited with error code: 0 18:11:49 INFO - 2015-10-30 18:11:49,997 INFO : Completed test v8_7 (00:00:37) 18:11:50 INFO - 2015-10-30 18:11:50,247 INFO : Completed test suite (00:20:12) 18:11:50 INFO - 2015-10-30 18:11:50,247 DEBUG : Working with test: dromaeo_css 18:11:50 INFO - 2015-10-30 18:11:50,247 DEBUG : Generating results file: dromaeo_css 18:11:50 INFO - 2015-10-30 18:11:50,248 DEBUG : Working with test: kraken 18:11:50 INFO - 2015-10-30 18:11:50,248 DEBUG : Generating results file: kraken 18:11:50 INFO - 2015-10-30 18:11:50,248 INFO : javascript benchmark 18:11:50 INFO - 2015-10-30 18:11:50,248 DEBUG : Working with test: v8_7 18:11:50 INFO - 2015-10-30 18:11:50,248 DEBUG : Generating results file: v8_7 18:11:50 INFO - 2015-10-30 18:11:50,248 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:50 INFO - 2015-10-30 18:11:50,314 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 18:11:50 INFO - 2015-10-30 18:11:50,314 DEBUG : process_Request line: dromaeo_css 6076.57 graph.html#tests=[[72,63,55]] 18:11:50 INFO - 2015-10-30 18:11:50,314 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:50 INFO - 2015-10-30 18:11:50,434 DEBUG : process_Request line: kraken 1634.60 graph.html#tests=[[232,63,55]] 18:11:50 INFO - 2015-10-30 18:11:50,435 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:50 INFO - 2015-10-30 18:11:50,466 DEBUG : process_Request line: v8_7 16851.74 graph.html#tests=[[230,63,55]] 18:11:50 INFO - 2015-10-30 18:11:50,466 INFO : javascript benchmark 18:11:50 INFO - 2015-10-30 18:11:50,468 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [307.85223092915413, 310.2089671338088, 311.97036281553244, 316.3846318909722, 317.27660933072593, 15389.769153462694, 16116.0, 16357.263923123459, 17469.91265043673, 17511.124443777822, 16198.919005404956, 16728.498145055666, 16741.916290418532, 16975.83024169758, 17142.31430742769, 4827.951720482794, 4977.203647416414, 5012.0, 5013.172826483626, 5051.116054690433, 4271.060366719316, 4407.889802754925, 4445.488768791582, 4959.256111583255, 5042.798288068473, 3088.675689052651, 3151.6848315168527, 3181.1887968567985, 4342.696011279212, 4358.912821743564, 4306.504751953534, 4397.6042156206095, 4407.140607581523, 4432.401625780511, 4484.080763443502, 3743.157789497341, 3747.1568896997956, 3753.6997040236715, 3787.0910981364273, 3791.241751649681, 10275.743106422324, 10414.16686665065, 10493.737656558571, 11105.333679979147, 11621.302721836717, 1604.2219523531078, 1643.6219669475968, 1725.3271224222563, 1767.531604124908, 1773.2375078716148, 8478.618462169217, 8655.35084868631, 8692.52191129494, 8995.0, 9000.8649870252, 1400.3838311143165, 1437.5902867682764, 1444.6893917807618, 1454.978175327371, 1518.8025556677671, 49353.753231233975, 51658.48341516612, 52159.73920130413, 52340.476595233944, 52432.213516796895, 5968.1644569760265, 5972.671503067373, 5990.0, 6021.247344081902, 6027.7890273841085, 6835.7949261522235, 6855.725770969205, 6858.417034552019, 6860.108185935796, 6863.142107236596, 5120.61595380348, 5143.354126679502, 5156.74216289184, 5160.200168973815, 5177.249298851645, 5539.972300138554, 5586.301712285965, 5615.073512870331, 5617.494425501643, 5631.493165615114, 2680.5979103134687, 2712.281245469952, 2735.8084934054427, 2739.1371717908796, 2749.4501099780123, 946.2004606107828, 950.7385468996082, 955.0211033690523, 957.2772556719632, 1013.002192840052, 383.6144674602063, 405.27253579824287, 407.8980254936266, 413.5492313378432, 425.41293015638837, 10605.89394106049, 10626.0, 10720.142388608892, 10861.262198048433, 10921.12630989519, 421.4836824889486, 424.0374350224972, 427.6771037866453, 431.6331118549208, 442.76975972494125, 5716.685582292931, 5812.912806307909, 5884.9705751470965, 5893.3222679391565, 5968.522518198533, 465048.0, 473648.0, 475523.0, 508285.0, 535175.0, 60474.0, 63093.0, 63816.68091659605, 63852.0, 64813.67593162004, 453.40830216567036, 459.0360243488647, 460.47045897218464, 460.47735819844047, 461.1353711790393, 8402.957985210034, 9842.311038227255, 9844.409335439897, 9903.0, 10020.799584008424, 28303.15090547287, 28826.711732882402, 29276.0, 29410.411791763618, 29530.0, 36139.27721445504, 37227.255454891296, 37358.439623406215, 37508.43737343996, 37966.0, 5589.077802162597, 5616.438356164351, 5618.943810561842, 5625.662460252398, 5667.574931880208, 10649.520771565143, 10749.785004300027, 10860.402677852793, 10864.402457864577, 10891.945540272249, 9178.586963586522, 9180.081991800767, 9477.289203309641, 9490.762730931781, 9494.95252523733, 9008.909910900808, 9095.454272743656, 9172.495512746864, 9202.769930751785, 9296.518799283016, 9285.535723213678, 9450.43297402158, 9536.618535258789, 9552.522373881417, 9643.228541716506, 5290.391604965478, 5627.606067575231, 5657.066584013592, 5658.632188907708, 5669.773209071591, 8929.642814287356, 9142.085791420805, 9206.815863682823, 9237.769055773659, 9294.674686385944], "dojo.html": [2948.7788415868804, 2962.8592991698197, 2972.1975066731998, 3003.399320135972, 3116.4702000659886, 4732.9526704733025, 4851.684640498374, 4899.338589290444, 4919.7786099625555, 4956.008798240348, 4850.296706977486, 4864.246041863516, 4972.453030166679, 5036.82371117011, 5047.697138171712, 4585.587297143256, 4587.0596527711905, 4606.239970404879, 4627.490975992638, 4739.218029025206, 4725.716457012591, 4778.402699662543, 4793.233082706767, 4824.5899098576665, 4830.106430310386, 4371.191329604034, 4465.218586747306, 4514.841980530666, 4748.762561871893, 4755.5244475552345, 4691.530846915315, 4696.671233013691, 4700.576948074656, 4707.482176960531, 4724.362211101492, 4644.326572646981, 4660.4174478190225, 4675.088357770236, 4692.343071969927, 4724.220503616899, 4745.406824146981, 4824.614030877521, 4901.705897646153, 4936.086823937583, 4998.4751601081725, 5247.842564723064, 5338.252644629755, 5344.91982620261, 5358.571314294847, 5377.569794416438, 5407.756650950677, 5414.675119492843, 5420.376656684492, 5433.538149257318, 5435.076037073707, 4822.927656085197, 4888.926666100011, 4912.9508704913205, 4916.901661966741, 5101.668391554575, 5386.542143917733, 5411.242426060355, 5422.6475279106735, 5447.0, 5500.559955203574, 5186.818461353834, 5189.636725429184, 5205.635605507654, 5206.479352064764, 5219.530242278137, 5082.415522214918, 5123.564497017721, 5150.356205474316, 5218.6868787872845, 5377.059014672495, 5207.843764687065, 5231.450697676765, 5234.18870075139, 5245.554127899095, 5279.47205279469, 5222.294990176353, 5229.529342359206, 5235.73821308933, 5263.605229607795, 5282.339707536558, 3995.0411901143516, 4085.0400155963325, 4091.0386059276047, 4100.7334523255895, 4117.75293482392, 3714.832832522543, 3770.019794853303, 3798.772073675588, 3802.7718336899875, 3889.727719059695, 4954.3063971044085, 4961.503849615082, 4968.080905032508, 4973.204287314013, 4993.375828021497, 5382.946170538323, 5383.946160538423, 5391.16436952273, 5393.13709806437, 5437.537809286176, 4817.8313759018265, 4831.0, 4953.925691114636, 4955.40535135786, 4960.379952505937, 4707.435107787088, 4724.385829842167, 4729.597984171315, 4729.739864307496, 4781.737004464788, 5448.645838020516, 5451.100568406168, 5453.045716999509, 5465.988792073479, 5468.48049435303, 5206.765695543785, 5298.761555729924, 5310.840674779763, 5365.356157261153, 5393.6763794172475, 5450.672959622277, 5451.672899626035, 5468.070428027325, 5476.342838859362, 5479.178123281539, 5300.178472336794, 5333.12003519415, 5335.653182543122, 5354.223637572608, 5410.215518749838, 5185.870353241048, 5247.396549396868, 5387.164989426645, 5392.406835248198, 5414.214938833768, 5146.433892271922, 5175.353080864892, 5192.896142077213, 5198.220266959835, 5230.633855630222, 5143.974280128576, 5178.922316165185, 5182.792688292426, 5199.4540573239265, 5212.374515058065, 4895.828645997373, 4921.360223170965, 5004.724740139327, 5038.773255203451, 5064.2403639452905, 5195.246689229964, 5199.454057324077, 5217.973910130425, 5228.346456692913, 5239.973800130975, 5099.23511473282, 5111.156659151347, 5117.641765076558, 5122.231665250242, 5162.561182299396], "mootools.html": [1171.4318555500586, 1617.9999999999998, 1699.8130205677373, 1723.6208034232473, 1740.5822602575379, 6541.738330466782, 7046.577205367682, 7219.53073050252, 7256.165540962791, 7259.2740725927515, 6892.8276793080195, 7197.53216040957, 7210.531315464491, 7220.711171553132, 7222.494425390225, 1996.071826600634, 2023.7470316210474, 2026.4832467720785, 2027.9087441065114, 2034.2066594028267, 2045.3148195354574, 2047.406252186864, 2084.0725876984748, 2103.810657040866, 2109.546447513784, 1980.1683293016895, 1991.5817678287576, 1993.0732209522569, 1994.1425187169511, 1998.560316730317, 1995.950101247466, 2000.0999550202466, 2008.6585280502277, 2010.2763005318075, 2011.949701257473, 1995.9700604490945, 2015.1032790408274, 2015.123421311734, 2019.5153163240864, 2020.1515363547198, 6403.103565500834, 6561.475081993429, 7179.820504487378, 7227.927720722778, 7248.3838873695795, 4200.201961627281, 4342.827436592134, 4346.543612920629, 4351.912961740779, 4358.280883654225, 2622.5672763993916, 2653.230563136688, 2688.784897208219, 2715.1447294102295, 2751.4222013377216, 819.6229734322219, 820.2904487618167, 832.9666813327459, 833.2542374574722, 862.9007664118644, 9406.200472959807, 9446.90553094474, 9448.90551094494, 9474.147326740627, 9479.905200947971, 3896.8441262349756, 3905.8437662493184, 3947.388154836005, 3958.010497375656, 4008.07814202735, 8318.41771076031, 8326.6669333226, 8330.333573314121, 8336.374771892133, 8383.16168383169, 4458.576435238647, 4469.10617876426, 4482.968917149009, 4485.48416932057, 4489.147062058199, 4050.9594904051173, 4060.0, 4060.898477538085, 4063.0858056937545, 4065.28857449951, 3166.4617015107488, 3196.5365022072133, 3199.472087105648, 3213.4215841148352, 3220.951685724669, 1012.0385633648064, 1018.3889666200369, 1028.89711028898, 1034.7051090439188, 1037.2169012395593, 916.5966974531185, 937.7983733497194, 939.3847030195233, 977.6578197630772, 1249.5876360800914, 6687.799366019027, 6720.22717387497, 6722.831929201809, 6743.460523158135, 6756.0879281297375, 397.838875255522, 401.7268257584812, 1125.5554056147776, 1140.8117660586076, 1164.7728692904802, 5184.8963020739375, 5466.3986961435, 5499.697516636624, 5506.64206826555, 5512.228288039678, 8163.346932245525, 8414.284785793276, 8538.0, 8577.914220857712, 8586.78533036679, 8460.661573537112, 8582.356323275779, 8625.094365091574, 8648.610812513452, 8659.523726194993, 6815.693293801791, 6923.238443771181, 6923.861522769415, 6926.272741362185, 6938.132733408324, 6726.293739157318, 6782.287859774653, 6819.420349270169, 6828.863422731617, 6830.351116643911, 7600.125985511737, 7744.883826742716, 7818.413618978486, 7822.882656760039, 7853.607319633881, 7927.603619819101, 7949.801254968672, 7954.960225198837, 7962.482438641469, 7977.042754869452, 5926.940730592812, 6064.3935606439, 6078.270607526948, 6081.726322315595, 6094.78668246627, 6948.374646281859, 6948.965255173692, 6962.23415424313, 6962.443004559725, 6968.65156742171, 6354.205724284465, 6474.255460622088, 6502.187226596676, 6583.440407565219, 6611.305812889577, 6230.50155987529, 6414.486841052611, 6430.582012169194, 6474.482041436768, 6493.967530162319, 6531.444827189552, 6578.901316480353, 6587.835304117435, 6602.6698665067515, 6629.03878937561, 5988.101784732325, 5995.91006134917, 6023.66869822164, 6032.939670603413, 6036.426539478743, 6073.240844894388, 6109.08363745424, 6127.571070025056, 6148.415900489446, 6166.81499555014], "ext.html": [525.6241787122209, 527.2249792804579, 532.2947095098993, 536.7852858856457, 547.6987656788771, 28451.715482845164, 29277.0, 36152.638473615254, 36827.447588286195, 36971.0, 38650.42024369637, 39112.0, 39191.80404097983, 39207.21585568287, 39503.40744888822, 7619.161892191854, 8509.829803403944, 8684.435511691752, 8732.301415886714, 8773.298136149093, 7548.773536793905, 10203.336783109111, 10373.585056597727, 10384.48077596121, 10422.687319380431, 10169.38983660979, 10174.084332410082, 10181.134603558707, 10224.233182511303, 10270.845937310947, 7781.26078022587, 7937.682492700285, 10234.795304093876, 10247.077763001365, 10279.383237005804, 9881.308308418413, 10040.447775372351, 10046.246531510165, 10102.242331825142, 10106.89893101067, 35373.46939795905, 35723.82138089319, 35743.0, 35799.82100089483, 36095.097622559646, 2667.4265033017996, 2702.4595080983686, 2780.457810726909, 3080.4917188663844, 3308.9172770680925, 25038.116212095494, 25392.619110713353, 25626.359341016436, 25761.227163185133, 26594.202173934813, 2159.0823899842503, 2208.3466326204807, 2220.811231045363, 2221.8444708870384, 2360.634101714237, 239661.0, 242863.0, 242981.0, 243218.0, 243249.78375108188, 50137.24794128091, 51412.74293628508, 58375.70812145912, 59024.0, 59230.0, 55360.72319638376, 55641.44358556443, 55915.16127258095, 55949.44050559524, 56630.0, 15124.39502419913, 15251.694966100838, 15252.237388130548, 15267.236638168048, 15335.463258786112, 11775.646730598095, 11804.055675545937, 11808.232464889754, 11841.052715782716, 11862.347570883685, 17564.209610567556, 17632.91183544074, 17640.382586609663, 17721.7341739874, 17722.645547089243, 7619.352355049772, 7826.726064587712, 7891.0, 7915.881261781078, 7923.088844782924, 807.8142027333746, 857.5926434943477, 990.7027891632481, 1002.0, 1026.2405819693374, 25462.23613291604, 25523.36191595225, 25633.8718306411, 25710.35724106875, 25910.09314674015, 876.6011464783509, 892.9241014513839, 922.801597656507, 969.6460791810938, 972.1590823937244, 12237.694057648452, 12466.69099744532, 12512.749745005049, 12659.936700316439, 12846.357682115857, 274191.0, 277108.0, 279999.0, 280115.0, 281575.0, 47325.0, 47394.5260547397, 47426.5257347429, 47457.762711186224, 47736.28395574069, 1183.6389901080254, 1284.5889315419163, 1293.5989843148654, 1304.178367628388, 1305.2103477396038, 20454.795452045884, 25066.62400064037, 25087.0, 25609.103681371063, 26459.735402646496, 42193.578064218964, 42447.3632895513, 42701.14597708091, 42849.35725964051, 42915.785421072695, 185814.0, 186801.0, 187362.0631896832, 240259.0, 244529.0, 28447.146585602466, 28808.279793005342, 28845.278868027628, 29023.0, 29062.27344316409, 34945.147089650665, 35033.29933401369, 35171.29657406889, 35236.64763352334, 35732.64267357293, 29307.41385172242, 30130.849345754006, 30150.69849301479, 30262.394752104396, 30579.0, 31467.213319667193, 31678.0, 31693.0, 31830.84084579562, 32030.51954220642, 31464.0, 32004.67995320017, 32261.838690806395, 32418.83790581032, 32501.837490812395, 26813.463730725667, 28560.85719571389, 28618.141455756362, 28668.569971450026, 29070.273243168245, 21327.7867221332, 21513.462163446038, 21515.8924205378, 21547.353579392642, 21608.243711470022], "prototype.html": [275.25406149335305, 280.0352784656857, 284.5518308663855, 291.48843779167555, 293.96031535742696, 5551.167324901262, 5553.639013464122, 5558.527525160366, 5571.749271282792, 5627.212190293357, 5422.105352616823, 5490.121580547113, 5531.474509921561, 5535.972320138394, 5539.41836107209, 4336.327869180274, 4336.804843782022, 4356.194104090753, 4376.212281789277, 4388.868333949987, 4138.3999320098565, 4253.723507971988, 4262.701610887239, 4392.626626736731, 4402.07556413152, 4288.399624052635, 4302.48370195577, 4332.0, 4342.174986752522, 4373.147236288925, 4182.7490350578755, 4309.978450107761, 4313.396124542551, 4320.438343015419, 4361.607455329004, 3608.585012723544, 3665.596784353719, 3685.1892583631557, 3714.9442758358646, 3722.236941427028, 5309.177077552986, 5326.2543243945875, 5344.438833922421, 5361.3030306060355, 5385.946140538584, 4706.152892479352, 4717.504662010508, 4730.266808644666, 4762.64280178988, 4781.3545171401765, 5526.613137080406, 5712.0, 5756.740946657411, 5765.942340576583, 5822.912656310116, 3986.063275130342, 3994.3609022556543, 4004.739691920016, 4033.0, 4041.959580404217, 6045.848853778647, 6050.969745151246, 6052.909206361908, 6114.816555503342, 6129.478994285491, 4034.7175697700877, 4051.0277533391773, 4058.1477889643506, 4096.897577560585, 4105.486814148231, 4013.8394464221687, 4088.4889388826396, 4090.1001779608437, 4104.8768536943935, 4131.9173616527505, 4778.116048530964, 4778.426588809365, 4791.065742180311, 4812.590929771009, 4824.107540105022, 5810.970945145332, 5813.418658134237, 5845.269341332333, 5870.090136028923, 5915.08316210988, 1466.5453709350136, 1486.6803637217834, 1488.226122416359, 1492.4925525321444, 1504.9774253386208, 964.155967571093, 964.7843716916595, 984.2618036472645, 987.8814542254976, 989.9505024748734, 5524.033294173584, 5556.0, 5562.0, 5613.663180209201, 5626.212330273765, 6043.54673399488, 6043.8186854394435, 6062.302835174011, 6068.969655151696, 6117.418845209698, 5538.723063846792, 5547.278853749068, 5563.109902415594, 5604.215409842625, 5613.859653508695, 3252.0, 3277.7869438486423, 3301.4387554115856, 3337.132345590164, 3349.9162520936684, 5973.910391344133, 6058.575899687068, 6103.877922441527, 6111.663858487826, 6141.539384546088, 6085.391460853879, 6136.8772624548155, 6150.876982460415, 6215.378462153839, 6219.315875253718, 6073.392660733891, 6083.513318934474, 6092.786752463642, 6165.32181460039, 6170.352113028068, 5940.435658612425, 6064.423879731418, 6071.939280607137, 6090.2996155440915, 6133.693315334126, 5914.34942156371, 5936.3470018297085, 5963.463288304073, 5971.522278217645, 5988.910166347421, 6092.177556030057, 6151.723172457339, 6163.291221509405, 6180.443760061616, 6210.3168651449205, 3826.3112639724004, 3914.0801911551334, 3932.803359832054, 3959.40608908666, 3976.2445135424177, 6064.484518815773, 6089.634621922699, 6118.235220597426, 6162.568620196544, 6164.106204600397, 5907.527397808251, 5933.050711886078, 5955.821325360246, 5978.222831031938, 5993.4006599341465, 5811.651300921958, 5930.52555795544, 5943.435373639497, 5943.673097979653, 5985.132155837467, 5767.394423585463, 5770.798022069207, 5774.191613174243, 5782.190493330853, 5823.359430462561, 5892.587518873637, 5904.498117659875, 5927.851803704942, 5944.524438044859, 5955.434233747787, 5629.634073785191, 5752.741126649395, 5780.393058728773, 5811.912821307768, 5819.447152520504], "yui.html": [703.3423748794877, 712.5902606001547, 713.8964850096736, 714.8856183010719, 758.5714071549578, 12519.06107041972, 12683.365831708412, 12712.618621441348, 12796.48814047437, 14169.362378692958, 12875.484980600788, 12976.091673582852, 13006.934965325183, 13028.804567931465, 13085.14946528475, 660.4452260101514, 667.0794303860665, 805.1827395193868, 809.3969992355703, 821.4824660463929, 822.6709316273478, 829.2785276809185, 834.0991728932738, 835.1856939484015, 837.6398148796015, 854.581255184958, 878.2139984713677, 882.7616543533242, 883.849745543256, 885.7342797160858, 705.1573369823063, 707.1090426063146, 875.2210532625968, 882.6381183714678, 885.2077390735255, 653.0367707631253, 656.2125449460618, 656.875193713193, 658.8155316511337, 658.9604623722591, 12632.557860474932, 12748.553800616934, 12748.553800617026, 12756.043296752781, 12769.87230127696, 10745.946270268676, 10808.29746066511, 10820.458977051194, 10890.0, 11254.099672026217, 7890.921090789076, 8718.0, 8729.563521823948, 8991.325650576233, 9118.0, 3057.1898446911587, 3059.8470076496087, 3072.646645635758, 3125.828079455629, 3139.921501962446, 45283.320750188774, 45430.592705546886, 46075.0, 46127.76936115298, 46362.76818615885, 8344.165583441607, 8356.749297521084, 8571.52856592881, 8595.44129631572, 8968.551572421353, 18134.90932545329, 18193.181306841223, 18215.27138914455, 18368.08159592042, 18474.0, 6438.323975982455, 6537.640429776408, 6557.147570815859, 6829.6243706596615, 6845.691943862538, 3460.446328587414, 3464.636213197578, 3532.1346270163976, 3533.7278579711283, 3563.6970857476886, 2638.630591717161, 2656.614790855354, 2664.214056853194, 2671.49241644087, 2685.20786368018, 412.4514395853508, 413.805511409637, 417.63456975146744, 422.8308676529351, 430.1440134133053, 482.9495846533775, 518.6162239942415, 549.3572520151432, 556.1657513729406, 578.5776383240258, 7160.928390716026, 7382.151052629017, 7408.881305682235, 7557.470977031555, 7612.162662107164, 426.7354240370928, 510.0, 530.5675874162545, 553.6843998920657, 574.0757380617202, 3414.7097496712563, 3477.1654802847133, 3507.2810073934784, 3525.541679581689, 3591.44332628443, 51931.0, 52706.472935270926, 52840.0, 52885.0, 53206.46793532015, 42573.0, 43186.784066080094, 43622.781886090364, 43751.78124109359, 44531.55468445274, 42029.78985105055, 42125.789371053565, 42213.788931055766, 42840.928976775205, 42966.570334296885, 7235.2764723527225, 7424.331810137113, 7579.204183560647, 7597.962010190135, 7598.758450953173, 29188.562171567868, 29432.705672943852, 31030.68969310278, 31289.530657039708, 31301.06096817008, 40446.59553404428, 41393.37909931293, 41438.37842432426, 41604.58395416007, 42142.157156856076, 6904.516683832285, 6977.965110174417, 7003.4397248219, 7086.50394472382, 7141.428685705027, 10226.795464090825, 10259.948700256451, 10274.178065754571, 10362.171026318027, 10507.474626268504, 9631.181349585364, 9815.165710914367, 9838.311318207656, 9846.803063938538, 9915.851262231217, 9384.0, 9412.105849944244, 9422.575984080595, 9449.149576538144, 9579.0, 9297.256219502287, 9530.523473826419, 9805.85291220618, 9809.313348065567, 9898.257630677872, 7928.722494712657, 8154.796130096558, 8233.876491852507, 8275.668973241003, 8497.447665901696, 7650.73222437212, 7959.880601791094, 7976.441649084509, 8126.460207784414, 8417.0]}, "summary": {"suite": 6076.567278771688, "subtests": {"jquery.html": {"filtered": 6100.698401267843, "value": 6100.698401267843}, "dojo.html": {"filtered": 4924.980490524989, "value": 4924.980490524989}, "mootools.html": {"filtered": 4077.5777346918617, "value": 4077.5777346918617}, "ext.html": {"filtered": 16771.888292360847, "value": 16771.888292360847}, "prototype.html": {"filtered": 4397.204846965561, "value": 4397.204846965561}, "yui.html": {"filtered": 5571.411437634708, "value": 5571.411437634708}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0008"}, "testrun": {"date": 1446252697, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151030163430", "branch": "Mozilla-Inbound", "revision": "765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9"}}, {"talos_counters": {}, "results": {"audio-dft": [193.0, 178.0, 173.0, 174.0, 174.0, 182.0, 177.0, 175.0, 179.0, 178.0], "ai-astar": [105.0, 107.0, 99.0, 110.0, 106.0, 112.0, 98.0, 107.0, 110.0, 109.0], "imaging-gaussian-blur": [130.0, 138.0, 135.0, 130.0, 129.0, 128.0, 125.0, 130.0, 129.0, 126.0], "audio-beat-detection": [170.0, 145.0, 166.0, 183.0, 136.0, 165.0, 162.0, 141.0, 176.0, 141.0], "json-stringify-tinderbox": [67.0, 71.0, 73.0, 72.0, 74.0, 74.0, 72.0, 72.0, 71.0, 72.0], "stanford-crypto-pbkdf2": [150.0, 171.0, 164.0, 172.0, 165.0, 154.0, 171.0, 174.0, 153.0, 152.0], "json-parse-financial": [58.0, 59.0, 61.0, 63.0, 65.0, 64.0, 67.0, 74.0, 63.0, 67.0], "stanford-crypto-sha256-iterative": [73.0, 77.0, 76.0, 81.0, 81.0, 81.0, 80.0, 80.0, 76.0, 77.0], "audio-fft": [81.0, 81.0, 94.0, 94.0, 75.0, 77.0, 80.0, 88.0, 90.0, 73.0], "imaging-darkroom": [138.0, 142.0, 140.0, 135.0, 140.0, 141.0, 134.0, 140.0, 140.0, 136.0], "stanford-crypto-ccm": [144.0, 135.0, 138.0, 135.0, 146.0, 135.0, 139.0, 147.0, 139.0, 147.0], "audio-oscillator": [101.0, 109.0, 151.0, 99.0, 101.0, 98.0, 141.0, 101.0, 100.0, 146.0], "stanford-crypto-aes": [92.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 92.0, 94.0, 97.0], "imaging-desaturate": [114.0, 114.0, 113.0, 114.0, 112.0, 109.0, 114.0, 114.0, 114.0, 113.0]}, "summary": {"suite": 1634.6, "subtests": {"audio-fft": {"filtered": 83.3, "value": 83.3}, "stanford-crypto-pbkdf2": {"filtered": 162.6, "value": 162.6}, "audio-beat-detection": {"filtered": 158.5, "value": 158.5}, "stanford-crypto-ccm": {"filtered": 140.5, "value": 140.5}, "imaging-darkroom": {"filtered": 138.6, "value": 138.6}, "json-parse-financial": {"filtered": 64.1, "value": 64.1}, "audio-oscillator": {"filtered": 114.7, "value": 114.7}, "ai-astar": {"filtered": 106.3, "value": 106.3}, "audio-dft": {"filtered": 178.3, "value": 178.3}, "stanford-crypto-sha256-iterative": {"filtered": 78.2, "value": 78.2}, "json-stringify-tinderbox": {"filtered": 71.8, "value": 71.8}, "imaging-gaussian-blur": {"filtered": 130.0, "value": 130.0}, "stanford-crypto-aes": {"filtered": 94.6, "value": 94.6}, "imaging-desaturate": {"filtered": 113.1, "value": 113.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0008"}, "testrun": {"date": 1446252697, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151030163430", "branch": "Mozilla-Inbound", "revision": "765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [219.8768689533861], "Encrypt": [348.5535029627048], "NavierStokes": [6289.308176100629], "Decrypt": [6223.60248447205], "Splay": [691.0850034554251], "Richards": [172.14666896195558], "RegExp": [31562.5], "Earley": [977.5171065493646], "Boyer": [13662.162162162162], "RayTrace": [2254.5045045045044]}, "summary": {"suite": 16851.73687291942, "subtests": {"DeltaBlue": {"filtered": 300.7046640000001, "value": 300.7046640000001}, "Encrypt": {"filtered": 763.6732889999997, "value": 763.6732889999997}, "NavierStokes": {"filtered": 235.95599999999985, "value": 235.95599999999985}, "Decrypt": {"filtered": 42.76960179640721, "value": 42.76960179640721}, "Splay": {"filtered": 117.917477, "value": 117.917477}, "RegExp": {"filtered": 28.86289108910892, "value": 28.86289108910892}, "Richards": {"filtered": 205.069318, "value": 205.069318}, "Earley": {"filtered": 681.791649, "value": 681.791649}, "Boyer": {"filtered": 48.78166369930765, "value": 48.78166369930765}, "RayTrace": {"filtered": 328.22688911088915, "value": 328.22688911088915}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0008"}, "testrun": {"date": 1446252697, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151030163430", "branch": "Mozilla-Inbound", "revision": "765d51aa96c7fe3be4d5cb4ec0533481ddfeb7f9"}}] 18:11:50 INFO - RETURN: dromaeo_css: 6076.57 18:11:50 INFO - RETURN: kraken: 1634.60 18:11:50 INFO - RETURN: v8_7: 16851.74 18:11:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "16851.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1634.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "6076.57"}}} 18:11:50 INFO - Return code: 0 18:11:50 INFO - # TBPL SUCCESS # 18:11:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:11:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:11:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:11:50 INFO - 2015-10-30 18:11:50.600 screenresolution[1662:10272] starting screenresolution argv=screenresolution get 18:11:50 INFO - 2015-10-30 18:11:50.603 screenresolution[1662:10272] Display 0: 1600x1200x32@60 18:11:50 INFO - 2015-10-30 18:11:50.609 screenresolution[1663:10274] starting screenresolution argv=screenresolution list 18:11:50 INFO - Available Modes on Display 0 18:11:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:11:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:11:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:11:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:11:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:11:50 INFO - Intel HD Graphics 3000: 18:11:50 INFO - Chipset Model: Intel HD Graphics 3000 18:11:50 INFO - Type: GPU 18:11:50 INFO - Bus: Built-In 18:11:50 INFO - VRAM (Total): 512 MB 18:11:50 INFO - VRAM (Dynamic, Max): 10 18:11:50 INFO - Vendor: Intel (0x8086) 18:11:50 INFO - Device ID: 0x0116 18:11:50 INFO - Revision ID: 0x0009 18:11:50 INFO - Displays: 18:11:50 INFO - Display: 18:11:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:11:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:11:50 INFO - Display Serial Number: 1600x1200 60 18:11:50 INFO - Main Display: Yes 18:11:50 INFO - Mirror: Off 18:11:50 INFO - Online: Yes 18:11:50 INFO - Rotation: Supported 18:11:50 INFO - Return code: 0 18:11:50 INFO - Running post-action listener: _resource_record_post_action 18:11:50 INFO - Running post-run listener: _resource_record_post_run 18:11:51 INFO - Total resource usage - Wall time: 1252s; CPU: 30.0%; Read bytes: 39248896; Write bytes: 685453312; Read time: 4642; Write time: 51425 18:11:51 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 528384; Write bytes: 346118144; Read time: 491; Write time: 8962 18:11:51 INFO - run-tests - Wall time: 1214s; CPU: 30.0%; Read bytes: 36807680; Write bytes: 338049024; Read time: 3891; Write time: 42406 18:11:51 INFO - Running post-run listener: _upload_blobber_files 18:11:51 INFO - Blob upload gear active. 18:11:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:11:51 INFO - Copying logs to upload dir... 18:11:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.336663 ========= master_lag: 3.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-10-30 18:11:55.479763) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 18:11:55.482880) ========= 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.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009862 build_url: 'https://queue.taskcluster.net/v1/task/mGqBH7OiRKOZXgJMiiGh0g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.03 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 18:11:55.520651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:11:55.520978) ========= 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.tyj1RDj8dU/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.QJL4EtubeN/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005205 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 18:11:55.570353) ========= ========= Started reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-30 18:11:55.570689) ========= ========= Finished reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-30 18:11:57.604684) ========= ========= Total master_lag: 4.28 =========