builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0031 starttime: 1447319785.76 results: success (0) buildid: 20151111235647 builduid: 362f30425b534477a7581b744d025a45 revision: b5a38550eaf46de5604cd541f88a6620b910e314 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:25.759861) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:25.760445) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:25.760830) ========= 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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.006136 basedir: '/builds/slave/test' ========= master_lag: 0.63 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.399994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.400389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.736070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.736413) ========= 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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.011056 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.817523) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.817907) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.818369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:26.818738) ========= 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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-12 01:16:26-- 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% 7.03M=0.002s 2015-11-12 01:16:27 (7.03 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208355 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.064601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.064983) ========= 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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.077418 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.161504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.161954) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b5a38550eaf46de5604cd541f88a6620b910e314 --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 b5a38550eaf46de5604cd541f88a6620b910e314 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-12 01:16:27,248 truncating revision to first 12 chars 2015-11-12 01:16:27,248 Setting DEBUG logging. 2015-11-12 01:16:27,249 attempt 1/10 2015-11-12 01:16:27,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b5a38550eaf4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 01:16:27,491 unpacking tar archive at: mozilla-inbound-b5a38550eaf4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.684677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.685063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.698342) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.698692) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 01:16:27.699240) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-12 01:16:27.699621) ========= /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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:16:28 INFO - MultiFileLogger online at 20151112 01:16:28 in /builds/slave/test 01:16:28 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 01:16:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:16:28 INFO - {'append_to_log': False, 01:16:28 INFO - 'base_work_dir': '/builds/slave/test', 01:16:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:16:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:16:28 INFO - 'branch': 'Mozilla-Inbound', 01:16:28 INFO - 'buildbot_json_path': 'buildprops.json', 01:16:28 INFO - 'config_files': ('talos/mac_config.py',), 01:16:28 INFO - 'default_actions': ('clobber', 01:16:28 INFO - 'read-buildbot-config', 01:16:28 INFO - 'download-and-extract', 01:16:28 INFO - 'populate-webroot', 01:16:28 INFO - 'create-virtualenv', 01:16:28 INFO - 'install', 01:16:28 INFO - 'run-tests'), 01:16:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:16:28 INFO - 'download_minidump_stackwalk': True, 01:16:28 INFO - 'download_symbols': 'ondemand', 01:16:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:16:28 INFO - 'tooltool.py': '/tools/tooltool.py', 01:16:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:16:28 INFO - '/tools/misc-python/virtualenv.py')}, 01:16:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:16:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:16:28 INFO - 'installer_path': 'installer.exe', 01:16:28 INFO - 'log_level': 'info', 01:16:28 INFO - 'log_name': 'talos', 01:16:28 INFO - 'log_to_console': True, 01:16:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:16:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:16:28 INFO - 'opt_config_files': (), 01:16:28 INFO - 'pip_index': False, 01:16:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:16:28 INFO - 'cmd': ('bash', 01:16:28 INFO - '-c', 01:16:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:16:28 INFO - 'enabled': True, 01:16:28 INFO - 'halt_on_failure': False, 01:16:28 INFO - 'name': 'check_screen_resolution'},), 01:16:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:16:28 INFO - 'cmd': ('bash', 01:16:28 INFO - '-c', 01:16:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:16:28 INFO - 'enabled': True, 01:16:28 INFO - 'halt_on_failure': False, 01:16:28 INFO - 'name': 'check_screen_resolution'},), 01:16:28 INFO - 'run_cmd_checks_enabled': True, 01:16:28 INFO - 'sps_profile': False, 01:16:28 INFO - 'sps_profile_interval': 0, 01:16:28 INFO - 'suite': 'dromaeojs', 01:16:28 INFO - 'system_bits': '64', 01:16:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:16:28 INFO - 'title': 't-yosemite-r5-0031', 01:16:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:16:28 INFO - 'use_talos_json': True, 01:16:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:16:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:16:28 INFO - 'work_dir': 'build'} 01:16:28 INFO - ##### 01:16:28 INFO - ##### Running clobber step. 01:16:28 INFO - ##### 01:16:28 INFO - Running pre-action listener: _resource_record_pre_action 01:16:28 INFO - Running main action method: clobber 01:16:28 INFO - rmtree: /builds/slave/test/build 01:16:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:16:31 INFO - Running post-action listener: _resource_record_post_action 01:16:31 INFO - ##### 01:16:31 INFO - ##### Running read-buildbot-config step. 01:16:31 INFO - ##### 01:16:31 INFO - Running pre-action listener: _resource_record_pre_action 01:16:31 INFO - Running main action method: read_buildbot_config 01:16:31 INFO - Using buildbot properties: 01:16:31 INFO - { 01:16:31 INFO - "properties": { 01:16:31 INFO - "buildnumber": 3358, 01:16:31 INFO - "product": "firefox", 01:16:31 INFO - "script_repo_revision": "production", 01:16:31 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 01:16:31 INFO - "repository": "", 01:16:31 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 01:16:31 INFO - "buildid": "20151111235647", 01:16:31 INFO - "slavename": "t-yosemite-r5-0031", 01:16:31 INFO - "pgo_build": "False", 01:16:31 INFO - "basedir": "/builds/slave/test", 01:16:31 INFO - "project": "", 01:16:31 INFO - "platform": "yosemite", 01:16:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:16:31 INFO - "slavebuilddir": "test", 01:16:31 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 01:16:31 INFO - "branch": "mozilla-inbound", 01:16:31 INFO - "repo_path": "integration/mozilla-inbound", 01:16:31 INFO - "stage_platform": "macosx64", 01:16:31 INFO - "builduid": "362f30425b534477a7581b744d025a45", 01:16:31 INFO - "revision": "b5a38550eaf46de5604cd541f88a6620b910e314" 01:16:31 INFO - }, 01:16:31 INFO - "sourcestamp": { 01:16:31 INFO - "repository": "", 01:16:31 INFO - "hasPatch": false, 01:16:31 INFO - "project": "", 01:16:31 INFO - "branch": "mozilla-inbound-macosx64-talos", 01:16:31 INFO - "changes": [ 01:16:31 INFO - { 01:16:31 INFO - "category": null, 01:16:31 INFO - "files": [ 01:16:31 INFO - { 01:16:31 INFO - "url": null, 01:16:31 INFO - "name": "https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 01:16:31 INFO - } 01:16:31 INFO - ], 01:16:31 INFO - "repository": "", 01:16:31 INFO - "rev": "b5a38550eaf46de5604cd541f88a6620b910e314", 01:16:31 INFO - "who": "jkew@mozilla.com", 01:16:31 INFO - "when": 1447319767, 01:16:31 INFO - "number": 6652597, 01:16:31 INFO - "comments": "Bug 925588 - Extend timeout for test_property_syntax_errors.html, as it frequently takes over 5 minutes on b2g emulator. r=dholbert", 01:16:31 INFO - "project": "", 01:16:31 INFO - "at": "Thu 12 Nov 2015 01:16:07", 01:16:31 INFO - "branch": "mozilla-inbound-macosx64-talos", 01:16:31 INFO - "revlink": "", 01:16:31 INFO - "properties": [ 01:16:31 INFO - [ 01:16:31 INFO - "buildid", 01:16:31 INFO - "20151111235647", 01:16:31 INFO - "Change" 01:16:31 INFO - ], 01:16:31 INFO - [ 01:16:31 INFO - "builduid", 01:16:31 INFO - "362f30425b534477a7581b744d025a45", 01:16:31 INFO - "Change" 01:16:31 INFO - ], 01:16:31 INFO - [ 01:16:31 INFO - "pgo_build", 01:16:31 INFO - "False", 01:16:31 INFO - "Change" 01:16:31 INFO - ] 01:16:31 INFO - ], 01:16:31 INFO - "revision": "b5a38550eaf46de5604cd541f88a6620b910e314" 01:16:31 INFO - } 01:16:31 INFO - ], 01:16:31 INFO - "revision": "b5a38550eaf46de5604cd541f88a6620b910e314" 01:16:31 INFO - } 01:16:31 INFO - } 01:16:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 01:16:31 INFO - Running post-action listener: _resource_record_post_action 01:16:31 INFO - ##### 01:16:31 INFO - ##### Running download-and-extract step. 01:16:31 INFO - ##### 01:16:31 INFO - Running pre-action listener: _resource_record_pre_action 01:16:31 INFO - Running main action method: download_and_extract 01:16:31 INFO - mkdir: /builds/slave/test/build/tests 01:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:31 INFO - https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/test_packages.json 01:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/test_packages.json 01:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:16:49 INFO - Downloaded 1149 bytes. 01:16:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:16:49 INFO - Using the following test package requirements: 01:16:49 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:16:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:16:49 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 01:16:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:16:49 INFO - u'jsshell-mac.zip'], 01:16:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:16:49 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 01:16:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:16:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:16:49 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 01:16:49 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:16:49 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 01:16:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:16:49 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 01:16:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 01:16:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 01:16:49 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 01:16:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:49 INFO - https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:16:54 INFO - Downloaded 17454819 bytes. 01:16:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 01:16:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:16:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:16:59 INFO - Return code: 0 01:16:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:59 INFO - https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:17:00 INFO - Downloaded 17454819 bytes. 01:17:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 01:17:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 01:17:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 01:17:06 INFO - Return code: 0 01:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:06 INFO - https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:17:12 INFO - Downloaded 11131693 bytes. 01:17:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 01:17:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 01:17:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 01:17:12 INFO - Return code: 0 01:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:12 INFO - https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:17:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:17:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:17:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 01:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 01:17:17 INFO - Downloaded 108693114 bytes. 01:17:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:17:17 INFO - mkdir: /builds/slave/test/properties 01:17:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:17:17 INFO - Writing to file /builds/slave/test/properties/build_url 01:17:17 INFO - Contents: 01:17:17 INFO - build_url:https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 01:17:17 INFO - Running post-action listener: _resource_record_post_action 01:17:17 INFO - Running post-action listener: set_extra_try_arguments 01:17:17 INFO - ##### 01:17:17 INFO - ##### Running populate-webroot step. 01:17:17 INFO - ##### 01:17:17 INFO - Running pre-action listener: _resource_record_pre_action 01:17:17 INFO - Running main action method: populate_webroot 01:17:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:17:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:17:17 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:17:17 INFO - '../fennec_ids.txt'], 01:17:17 INFO - 'tests': ['tcheck2']}, 01:17:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:17:17 INFO - '--tppagecycles', 01:17:17 INFO - '7'], 01:17:17 INFO - 'tests': ['tsvgm']}}, 01:17:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:17:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:17:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:17:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:17:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:17:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:17:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'tests': ['damp', 'tps']}, 01:17:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['damp', 'tps']}, 01:17:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:17:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:17:17 INFO - 'other': {'tests': ['a11yr', 01:17:17 INFO - 'ts_paint', 01:17:17 INFO - 'tpaint', 01:17:17 INFO - 'sessionrestore', 01:17:17 INFO - 'sessionrestore_no_auto_restore']}, 01:17:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['a11yr', 01:17:17 INFO - 'ts_paint', 01:17:17 INFO - 'tpaint', 01:17:17 INFO - 'sessionrestore', 01:17:17 INFO - 'sessionrestore_no_auto_restore']}, 01:17:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['a11yr', 01:17:17 INFO - 'ts_paint', 01:17:17 INFO - 'tpaint', 01:17:17 INFO - 'sessionrestore', 01:17:17 INFO - 'sessionrestore_no_auto_restore']}, 01:17:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['a11yr', 01:17:17 INFO - 'ts_paint', 01:17:17 INFO - 'tpaint', 01:17:17 INFO - 'sessionrestore', 01:17:17 INFO - 'sessionrestore_no_auto_restore']}, 01:17:17 INFO - 'other_l64': {'tests': ['a11yr', 01:17:17 INFO - 'ts_paint', 01:17:17 INFO - 'tpaint', 01:17:17 INFO - 'sessionrestore', 01:17:17 INFO - 'sessionrestore_no_auto_restore']}, 01:17:17 INFO - 'other_nol64': {'tests': ['a11yr', 01:17:17 INFO - 'ts_paint', 01:17:17 INFO - 'tpaint', 01:17:17 INFO - 'sessionrestore', 01:17:17 INFO - 'sessionrestore_no_auto_restore']}, 01:17:17 INFO - 'svgr': {'tests': ['tsvgx', 01:17:17 INFO - 'tsvgr_opacity', 01:17:17 INFO - 'tart', 01:17:17 INFO - 'tscrollx', 01:17:17 INFO - 'cart']}, 01:17:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['tsvgx', 01:17:17 INFO - 'tsvgr_opacity', 01:17:17 INFO - 'tart', 01:17:17 INFO - 'tscrollx', 01:17:17 INFO - 'cart']}, 01:17:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'tests': ['tp5o']}, 01:17:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'talos_options': ['--e10s'], 01:17:17 INFO - 'tests': ['tp5o']}, 01:17:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'talos_options': ['--xperf_path', 01:17:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:17:17 INFO - 'tests': ['tp5n']}, 01:17:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:17 INFO - 'talos_options': ['--e10s', 01:17:17 INFO - '--xperf_path', 01:17:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:17:17 INFO - 'tests': ['tp5n']}}, 01:17:17 INFO - 'talos.zip': {'path': '', 01:17:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:17:17 INFO - Running post-action listener: _resource_record_post_action 01:17:17 INFO - ##### 01:17:17 INFO - ##### Running create-virtualenv step. 01:17:17 INFO - ##### 01:17:17 INFO - Running pre-action listener: _resource_record_pre_action 01:17:17 INFO - Running main action method: create_virtualenv 01:17:17 INFO - Creating virtualenv /builds/slave/test/build/venv 01:17:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:17:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:17:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:17:17 INFO - Using real prefix '/tools/python27' 01:17:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:17:18 INFO - Installing distribute.............................................................................................................................................................................................done. 01:17:21 INFO - Installing pip.................done. 01:17:21 INFO - Return code: 0 01:17:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:21 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 0x10a06d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a04a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe420564b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, '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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:17:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:17:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:17:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:17:21 INFO - 'HOME': '/Users/cltbld', 01:17:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:17:21 INFO - 'LOGNAME': 'cltbld', 01:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:21 INFO - 'MOZ_NO_REMOTE': '1', 01:17:21 INFO - 'NO_EM_RESTART': '1', 01:17:21 INFO - 'PAGER': '/bin/cat', 01:17:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:21 INFO - 'PWD': '/builds/slave/test', 01:17:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:17:21 INFO - 'SHELL': '/bin/bash', 01:17:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:17:21 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:17:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:17:21 INFO - 'USER': 'cltbld', 01:17:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:17:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:21 INFO - 'XPC_FLAGS': '0x0', 01:17:21 INFO - 'XPC_SERVICE_NAME': '0', 01:17:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:17:22 INFO - Cleaning up... 01:17:22 INFO - Return code: 0 01:17:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:22 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 0x10a06d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a04a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe420564b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, '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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:17:22 INFO - 'HOME': '/Users/cltbld', 01:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:17:22 INFO - 'LOGNAME': 'cltbld', 01:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:22 INFO - 'MOZ_NO_REMOTE': '1', 01:17:22 INFO - 'NO_EM_RESTART': '1', 01:17:22 INFO - 'PAGER': '/bin/cat', 01:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:22 INFO - 'PWD': '/builds/slave/test', 01:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:17:22 INFO - 'SHELL': '/bin/bash', 01:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:17:22 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:17:22 INFO - 'USER': 'cltbld', 01:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:22 INFO - 'XPC_FLAGS': '0x0', 01:17:22 INFO - 'XPC_SERVICE_NAME': '0', 01:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:23 INFO - Downloading/unpacking psutil>=0.7.1 01:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:25 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:17:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:17:25 INFO - Installing collected packages: psutil 01:17:25 INFO - Running setup.py install for psutil 01:17:25 INFO - building 'psutil._psutil_osx' extension 01:17:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:17:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:17:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:17:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:17:28 INFO - building 'psutil._psutil_posix' extension 01:17:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:17:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:17:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:17:28 INFO - ^ 01:17:28 INFO - 1 warning generated. 01:17:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:17:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:17:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:17:28 INFO - Successfully installed psutil 01:17:28 INFO - Cleaning up... 01:17:28 INFO - Return code: 0 01:17:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:28 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 0x10a06d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a04a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe420564b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, '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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:17:28 INFO - 'HOME': '/Users/cltbld', 01:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:17:28 INFO - 'LOGNAME': 'cltbld', 01:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:28 INFO - 'MOZ_NO_REMOTE': '1', 01:17:28 INFO - 'NO_EM_RESTART': '1', 01:17:28 INFO - 'PAGER': '/bin/cat', 01:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:28 INFO - 'PWD': '/builds/slave/test', 01:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:17:28 INFO - 'SHELL': '/bin/bash', 01:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:17:28 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:17:28 INFO - 'USER': 'cltbld', 01:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:28 INFO - 'XPC_FLAGS': '0x0', 01:17:28 INFO - 'XPC_SERVICE_NAME': '0', 01:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:17:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:17:31 INFO - Installing collected packages: mozsystemmonitor 01:17:31 INFO - Running setup.py install for mozsystemmonitor 01:17:31 INFO - Successfully installed mozsystemmonitor 01:17:31 INFO - Cleaning up... 01:17:31 INFO - Return code: 0 01:17:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17: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', '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 0x10a06d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a04a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe420564b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, '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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:17: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 blobuploader==1.2.4 01:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:17:31 INFO - 'HOME': '/Users/cltbld', 01:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:17:31 INFO - 'LOGNAME': 'cltbld', 01:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:31 INFO - 'MOZ_NO_REMOTE': '1', 01:17:31 INFO - 'NO_EM_RESTART': '1', 01:17:31 INFO - 'PAGER': '/bin/cat', 01:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:31 INFO - 'PWD': '/builds/slave/test', 01:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:17:31 INFO - 'SHELL': '/bin/bash', 01:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:17:31 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:17:31 INFO - 'USER': 'cltbld', 01:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:31 INFO - 'XPC_FLAGS': '0x0', 01:17:31 INFO - 'XPC_SERVICE_NAME': '0', 01:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:32 INFO - Downloading/unpacking blobuploader==1.2.4 01:17: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 01:17: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 01:17: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 01:17: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 01:17: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 01:17: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 01:17:34 INFO - Downloading blobuploader-1.2.4.tar.gz 01:17:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:17:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:17:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:35 INFO - Downloading docopt-0.6.1.tar.gz 01:17:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:17:36 INFO - Installing collected packages: blobuploader, requests, docopt 01:17:36 INFO - Running setup.py install for blobuploader 01:17:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:17:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:17:36 INFO - Running setup.py install for requests 01:17:36 INFO - Running setup.py install for docopt 01:17:36 INFO - Successfully installed blobuploader requests docopt 01:17:36 INFO - Cleaning up... 01:17:37 INFO - Return code: 0 01:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17: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')]} 01:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17: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')]} 01:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:37 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 0x10a06d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a04a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe420564b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, '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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:17:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:17:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:17:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:17:37 INFO - 'HOME': '/Users/cltbld', 01:17:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:17:37 INFO - 'LOGNAME': 'cltbld', 01:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:37 INFO - 'MOZ_NO_REMOTE': '1', 01:17:37 INFO - 'NO_EM_RESTART': '1', 01:17:37 INFO - 'PAGER': '/bin/cat', 01:17:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:37 INFO - 'PWD': '/builds/slave/test', 01:17:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:17:37 INFO - 'SHELL': '/bin/bash', 01:17:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:17:37 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:17:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:17:37 INFO - 'USER': 'cltbld', 01:17:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:17:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:37 INFO - 'XPC_FLAGS': '0x0', 01:17:37 INFO - 'XPC_SERVICE_NAME': '0', 01:17:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-5qFQsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-UnDEM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-jB0Zns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-Jdo0ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-pmK9nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-YVlfmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-O8r3EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-WxaYI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-vhlD8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-8C9nd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-IIfWVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-5icvel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-i9xbzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:39 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-NVuymR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:39 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-iNrIav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:39 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-cprBrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:39 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-m2_nHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:17:39 INFO - Running setup.py install for manifestparser 01:17:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:17:39 INFO - Running setup.py install for mozcrash 01:17:39 INFO - Running setup.py install for mozdebug 01:17:40 INFO - Running setup.py install for mozdevice 01:17:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Running setup.py install for mozfile 01:17:40 INFO - Running setup.py install for mozhttpd 01:17:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Running setup.py install for mozinfo 01:17:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Running setup.py install for mozInstall 01:17:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:17:40 INFO - Running setup.py install for mozleak 01:17:41 INFO - Running setup.py install for mozlog 01:17:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:17:41 INFO - Running setup.py install for moznetwork 01:17:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:17:41 INFO - Running setup.py install for mozprocess 01:17:41 INFO - Running setup.py install for mozprofile 01:17:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:17:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:17:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:17:41 INFO - Running setup.py install for mozrunner 01:17:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:17:42 INFO - Running setup.py install for mozscreenshot 01:17:42 INFO - Running setup.py install for moztest 01:17:42 INFO - Running setup.py install for mozversion 01:17:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:17:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:17:42 INFO - Cleaning up... 01:17:42 INFO - Return code: 0 01:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10a06d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a04a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe420564b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, '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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:17:42 INFO - 'HOME': '/Users/cltbld', 01:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:17:42 INFO - 'LOGNAME': 'cltbld', 01:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:42 INFO - 'MOZ_NO_REMOTE': '1', 01:17:42 INFO - 'NO_EM_RESTART': '1', 01:17:42 INFO - 'PAGER': '/bin/cat', 01:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:42 INFO - 'PWD': '/builds/slave/test', 01:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:17:42 INFO - 'SHELL': '/bin/bash', 01:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:17:42 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:17:42 INFO - 'USER': 'cltbld', 01:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:42 INFO - 'XPC_FLAGS': '0x0', 01:17:42 INFO - 'XPC_SERVICE_NAME': '0', 01:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-VjOgx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-4hSSCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-JjSHhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-d6dMMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-GbKMK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-Cpp3c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-3f7C8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-7aMPLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-vlV8XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-hqFiFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:44 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)) 01:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-KJlTuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-NUbrKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-SFDGYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-WjEE8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-mMM52V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:45 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-Qxd9Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:45 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-OEOIls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:47 INFO - Downloading blessings-1.5.1.tar.gz 01:17:47 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:17:48 INFO - Installing collected packages: blessings 01:17:48 INFO - Running setup.py install for blessings 01:17:48 INFO - Successfully installed blessings 01:17:48 INFO - Cleaning up... 01:17:48 INFO - Return code: 0 01:17:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:48 INFO - Reading from file tmpfile_stdout 01:17:48 INFO - Current package versions: 01:17:48 INFO - blessings == 1.5.1 01:17:48 INFO - blobuploader == 1.2.4 01:17:48 INFO - docopt == 0.6.1 01:17:48 INFO - manifestparser == 1.1 01:17:48 INFO - mozInstall == 1.12 01:17:48 INFO - mozcrash == 0.16 01:17:48 INFO - mozdebug == 0.1 01:17:48 INFO - mozdevice == 0.47 01:17:48 INFO - mozfile == 1.2 01:17:48 INFO - mozhttpd == 0.7 01:17:48 INFO - mozinfo == 0.9 01:17:48 INFO - mozleak == 0.1 01:17:48 INFO - mozlog == 3.0 01:17:48 INFO - moznetwork == 0.27 01:17:48 INFO - mozprocess == 0.22 01:17:48 INFO - mozprofile == 0.27 01:17:48 INFO - mozrunner == 6.11 01:17:48 INFO - mozscreenshot == 0.1 01:17:48 INFO - mozsystemmonitor == 0.0 01:17:48 INFO - moztest == 0.7 01:17:48 INFO - mozversion == 1.4 01:17:48 INFO - psutil == 3.1.1 01:17:48 INFO - requests == 1.2.3 01:17:48 INFO - wsgiref == 0.1.2 01:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:48 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 0x10a06d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a04a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe420564b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, '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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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 01:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:17:48 INFO - 'HOME': '/Users/cltbld', 01:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:17:48 INFO - 'LOGNAME': 'cltbld', 01:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:48 INFO - 'MOZ_NO_REMOTE': '1', 01:17:48 INFO - 'NO_EM_RESTART': '1', 01:17:48 INFO - 'PAGER': '/bin/cat', 01:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:48 INFO - 'PWD': '/builds/slave/test', 01:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:17:48 INFO - 'SHELL': '/bin/bash', 01:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:17:48 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:17:48 INFO - 'USER': 'cltbld', 01:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:48 INFO - 'XPC_FLAGS': '0x0', 01:17:48 INFO - 'XPC_SERVICE_NAME': '0', 01:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:17:48 INFO - Cleaning up... 01:17:48 INFO - Return code: 0 01:17:48 INFO - Running post-action listener: _resource_record_post_action 01:17:48 INFO - Running post-action listener: _start_resource_monitoring 01:17:48 INFO - Starting resource monitoring. 01:17:48 INFO - ##### 01:17:49 INFO - ##### Running install step. 01:17:49 INFO - ##### 01:17:49 INFO - Running pre-action listener: _resource_record_pre_action 01:17:49 INFO - Running main action method: install 01:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:49 INFO - Reading from file tmpfile_stdout 01:17:49 INFO - Detecting whether we're running mozinstall >=1.0... 01:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:17:49 INFO - Reading from file tmpfile_stdout 01:17:49 INFO - Output received: 01:17:49 INFO - Usage: mozinstall [options] installer 01:17:49 INFO - Options: 01:17:49 INFO - -h, --help show this help message and exit 01:17:49 INFO - -d DEST, --destination=DEST 01:17:49 INFO - Directory to install application into. [default: 01:17:49 INFO - "/builds/slave/test"] 01:17:49 INFO - --app=APP Application being installed. [default: firefox] 01:17:49 INFO - mkdir: /builds/slave/test/build/application 01:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:18:29 INFO - Reading from file tmpfile_stdout 01:18:29 INFO - Output received: 01:18:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:18:29 INFO - Running post-action listener: _resource_record_post_action 01:18:29 INFO - ##### 01:18:29 INFO - ##### Running run-tests step. 01:18:29 INFO - ##### 01:18:29 INFO - Running pre-action listener: _resource_record_pre_action 01:18:29 INFO - Running main action method: run_tests 01:18:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:18:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:18:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:18:29 INFO - 2015-11-12 01:18:29.688 screenresolution[1638:8963] starting screenresolution argv=screenresolution get 01:18:29 INFO - 2015-11-12 01:18:29.691 screenresolution[1638:8963] Display 0: 1600x1200x32@60 01:18:29 INFO - 2015-11-12 01:18:29.698 screenresolution[1639:8965] starting screenresolution argv=screenresolution list 01:18:29 INFO - Available Modes on Display 0 01:18:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:18:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:18:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:18:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:18:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:18:29 INFO - Intel HD Graphics 3000: 01:18:29 INFO - Chipset Model: Intel HD Graphics 3000 01:18:29 INFO - Type: GPU 01:18:29 INFO - Bus: Built-In 01:18:29 INFO - VRAM (Total): 512 MB 01:18:29 INFO - VRAM (Dynamic, Max): 10 01:18:29 INFO - Vendor: Intel (0x8086) 01:18:29 INFO - Device ID: 0x0116 01:18:29 INFO - Revision ID: 0x0009 01:18:29 INFO - Displays: 01:18:29 INFO - Display: 01:18:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:18:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:18:29 INFO - Display Serial Number: 1600x1200 60 01:18:29 INFO - Main Display: Yes 01:18:29 INFO - Mirror: Off 01:18:29 INFO - Online: Yes 01:18:29 INFO - Rotation: Supported 01:18:29 INFO - Return code: 0 01:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:18:29 INFO - Python 2.7.3 01:18:29 INFO - Return code: 0 01:18:29 INFO - grabbing minidump binary from tooltool 01:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:29 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 0x109f909f0>, '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 0x109cf0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f848c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:18:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:18:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:18:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:18:30 INFO - Return code: 0 01:18:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:18:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:18:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:18:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:18:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:18:30 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/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0031', '--webServer', 'localhost'] in /builds/slave/test/build 01:18:30 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/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0031 --webServer localhost 01:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Js6iJRMCmA/Render', 01:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:30 INFO - 'HOME': '/Users/cltbld', 01:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:30 INFO - 'LOGNAME': 'cltbld', 01:18:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:18:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:30 INFO - 'MOZ_NO_REMOTE': '1', 01:18:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:18:30 INFO - 'NO_EM_RESTART': '1', 01:18:30 INFO - 'PAGER': '/bin/cat', 01:18:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:30 INFO - 'PWD': '/builds/slave/test', 01:18:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:30 INFO - 'SHELL': '/bin/bash', 01:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vcjqRR6yzH/Listeners', 01:18:30 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 01:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:30 INFO - 'USER': 'cltbld', 01:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:30 INFO - 'XPC_FLAGS': '0x0', 01:18:30 INFO - 'XPC_SERVICE_NAME': '0', 01:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 01:18:30 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/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0031', '--webServer', 'localhost'] with output_timeout 3600 01:18:30 INFO - mozversion INFO | application_buildid: 20151111235647 01:18:30 INFO - mozversion INFO | application_changeset: b5a38550eaf46de5604cd541f88a6620b910e314 01:18:30 INFO - mozversion INFO | application_display_name: Nightly 01:18:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:18:30 INFO - mozversion INFO | application_name: Firefox 01:18:30 INFO - mozversion INFO | application_remotingname: firefox 01:18:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:18:30 INFO - mozversion INFO | application_vendor: Mozilla 01:18:30 INFO - mozversion INFO | application_version: 45.0a1 01:18:30 INFO - mozversion INFO | platform_buildid: 20151111235647 01:18:30 INFO - mozversion INFO | platform_changeset: b5a38550eaf46de5604cd541f88a6620b910e314 01:18:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:18:30 INFO - mozversion INFO | platform_version: 45.0a1 01:18:30 INFO - 2015-11-12 01:18:30,424 DEBUG : using testdate: 1447319910 01:18:30 INFO - 2015-11-12 01:18:30,425 DEBUG : actual date: 1447319910 01:18:30 INFO - 2015-11-12 01:18:30,476 INFO : starting webserver on 'localhost:49269' 01:18:30 INFO - 2015-11-12 01:18:30,477 INFO : Starting test suite t-yosemite-r5-0031 01:18:30 INFO - 2015-11-12 01:18:30,477 INFO : Starting test dromaeo_css 01:18:30 INFO - 2015-11-12 01:18:30,477 DEBUG : operating with platform_type : mac_ 01:18:30 INFO - 2015-11-12 01:18:30,478 INFO : Initialising browser for dromaeo_css test... 01:18:30 INFO - 2015-11-12 01:18:30,503 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpFBPWhu/profile http://localhost:49269/getInfo.html 01:18:34 INFO - 2015-11-12 01:18:34,222 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:18:34 INFO - 2015-11-12 01:18:34,222 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:18:34 INFO - 2015-11-12 01:18:34,222 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:18:34 INFO - 2015-11-12 01:18:34,223 DEBUG : BROWSER_OUTPUT: __metrics 01:18:34 INFO - 2015-11-12 01:18:34,239 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:18:34 INFO - 2015-11-12 01:18:34,968 INFO : Browser initialized. 01:18:34 INFO - 2015-11-12 01:18:34,969 INFO : Running cycle 1/1 for dromaeo_css test... 01:18:34 INFO - 2015-11-12 01:18:34,969 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpFBPWhu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:18:47 INFO - 2015-11-12 01:18:47,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 228466688 01:18:47 INFO - 2015-11-12 01:18:47,169 DEBUG : BROWSER_OUTPUT: 01:19:39 INFO - 2015-11-12 01:19:39,144 DEBUG : BROWSER_OUTPUT: 1447319979140 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:21:49 INFO - 2015-11-12 01:21:49,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 01:21:50 INFO - 2015-11-12 01:21:50,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 320819200 01:21:50 INFO - 2015-11-12 01:21:50,343 DEBUG : BROWSER_OUTPUT: 01:24:53 INFO - 2015-11-12 01:24:53,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 01:24:53 INFO - 2015-11-12 01:24:53,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 363773952 01:24:53 INFO - 2015-11-12 01:24:53,635 DEBUG : BROWSER_OUTPUT: 01:27:55 INFO - 2015-11-12 01:27:55,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 01:27:56 INFO - 2015-11-12 01:27:56,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 326008832 01:27:56 INFO - 2015-11-12 01:27:56,429 DEBUG : BROWSER_OUTPUT: 01:30:58 INFO - 2015-11-12 01:30:58,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 01:30:59 INFO - 2015-11-12 01:30:59,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 317493248 01:30:59 INFO - 2015-11-12 01:30:59,303 DEBUG : BROWSER_OUTPUT: 01:34:02 INFO - 2015-11-12 01:34:02,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 01:34:03 INFO - 2015-11-12 01:34:03,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 319860736 01:34:03 INFO - 2015-11-12 01:34:03,185 DEBUG : BROWSER_OUTPUT: 01:37:05 INFO - 2015-11-12 01:37:05,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 01:37:06 INFO - 2015-11-12 01:37:06,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 369741824 01:37:06 INFO - 2015-11-12 01:37:06,143 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,143 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:37:06 INFO - 2015-11-12 01:37:06,143 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:37:06 INFO - 2015-11-12 01:37:06,143 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:37:06 INFO - 2015-11-12 01:37:06,143 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:37:06 INFO - 2015-11-12 01:37:06,147 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2773.6948935617065;2779.9444011119776;2798.2584615076994;2832.079574138405;2866.455373479039;4551.522090180525;4700.083483720676;4730.90538189236;4815.0610630926985;4825.951740482594;4629.490756016836;4657.604103651185;4734.952650473494;4771.689840160388;4822.156122678526;4339.7396156230725;4420.248557745175;4420.646348292145;4422.447194100738;4444.599986001259;4407.11857628474;4423.66822488313;4450.554944505556;4463.933041004388;4470.284754439291;4279.935800962957;4280.336547835091;4298.18334516444;4335.804888780012;4374.562543745632;4274.978625106885;4299.570042995707;4322.589354011364;4360.978195109036;4378.64970802335;4275.743455392655;4281.850135245251;4295.076558539929;4320.870373888788;4323.2218200723855;4626.236670949289;4709.152352576535;4729.361536192604;4737.668363214576;4751.049790042005;4913.950860491385;4927.605791536705;4985.626078044161;4985.700857948535;5053.090443720129;5001.349824522825;5021.799128034874;5045.772940217662;5055.469175736532;5079.085764562377;4628.166929952641;4693.859184224479;4725.787339569728;4733.148033354029;4733.479317275097;5087.186050231945;5191.299174611379;5207.557357624644;5208.374995000624;5219.634625576249;4694.50707675696;4835.975820120877;4844.927326090112;4847.3698419205275;4889.486603906538;5047.192449208109;5056.140456122468;5115.462876397924;5123.7438128093445;5156.510131537498;4799.136155491975;4861.538153875376;5048.368953880765;5055.469175736494;5057.8229761958155;4929.507049295114;4952.257161425815;4996.675216110941;5007.499250074963;5008.223725322581;3857.4406711026745;3876.903077423087;3883.10688541637;3908.2769687607883;3914.8629797957506;3437.1922598189403;3493.1092571394133;3551.6270791566512;3573.321068996934;3576.91057723559;4630.58324750774;4760.047990401864;4774.832880849153;4787.497312782178;4810.39870016248;5103.770330335144;5192.039472697563;5207.479252074762;5221.269022336875;5231.659942103827;4612.238980568236;4818.4217893852965;4827.61379089672;4855.490173531799;4908.165611845995;4403.295472724349;4427.446569178853;4465.933011004838;4503;4572.497025327211;5179.145441002268;5187.766550505161;5227.3465816772905;5241.030409374278;5306.442823503477;4875.658703890694;5058.696478211319;5065.316182315488;5113.590912727047;5128.256402821645;5114.053900028507;5138.306328645585;5156.4327923927585;5195.76619052136;5215.113430716711;4924.926126108183;4937.777799998937;4940.950590494049;4943.8516844494725;4953.405591329064;4916.582090522203;4991.825286114969;5014.34813474246;5031.572316353005;5049;4945.727984960861;4991.625628077836;5010.298558201782;5021.096202683552;5028.723420211923;4874.122657921608;5024.874378140429;5067.163917953497;5080.034793389244;5118.488151184852;4717.764111794465;4986.626003049858;5009.0983622948215;5009.198528235464;5022.070916880389;4855.902881942412;4904.926426103682;4969.751512424292;5024.899502009866;5037.345145131109;4872.761781085276;4875.488073752347;4878.195097808822;4898.730569818552;4919.434265059421 01:37:06 INFO - 2015-11-12 01:37:06,147 DEBUG : BROWSER_OUTPUT: |1;ext.html;498.7730582584923;504.06999086685056;504.5938019893986;515.5076901559012;527.9049771041211;27292.31769205771;28741.137765867057;28964.275893102684;35176.47235291472;36231.81884090583;37914.43128353077;38386.232275354545;38492.61507384925;38840.22319553614;38844;8044.839103217947;8229.300509456703;8233.464824786399;8249.670013199464;8334.041585217687;7425.925740742605;7620.428467864932;9832.655857045005;9962.551685174185;10058.798824023515;9770.413775173512;9863.358881672704;9905.554250058765;9955.800883982316;9984.151347135503;7483.513571617827;7693.615319234016;9770.853437198448;9825.164860986824;9889.25830562707;9770;9932.702018939442;9934.503274836301;9943.055409736064;10083.647072352505;35570.46644300337;36017.45973810395;36022.819885900666;36024.45963310552;36046.27907441863;2769.379912751043;2962.348283377675;3071.938561228763;3143.4027534768547;3153.1486498645236;24445.633315500105;25061.749382506125;25340;25870.48259034809;26155.869220653964;2186.2894559268143;2189.419803752007;2192.4190089626263;2194.5062360968814;2210.237468073512;250414;253884;254739;255453.722731387;255621;45912.3113153303;46448.76775616168;52970.73514632402;53498;53523.464765352626;43621;55265.72367138138;56155.157672634945;56212;56291.08943560949;14813.407463701331;15049.097054176784;15066.472673456376;15218.16300103505;15224.847751522564;11525.88474115265;11577.710557235969;11607.013403860767;11627.069834413227;11756.58851940178;17340.739888901677;17453.7381939271;17571.824281757275;17576.209070591853;17611.735823962652;7008.404285635778;7083.787486375417;7143.24995875436;7160.391366733782;7177.497575169792;831.8793774902605;859.4843094143464;930.8324501589778;935.5556110847293;999.605155963405;25129;25393.74606253914;25562.23313300604;25602.487950241262;25676.48647027049;836.2807985132781;903.5708038681705;949.6960972488737;994.9353292035994;1029.6653587584065;11794.174407791545;11999.880001199876;12028.27830330183;12137.332446715516;12180.695482613006;209963;217318;217877;218110;218232;46597.06805863864;47392.763036184595;47455.76272118686;47591.76204118957;47982.520174798505;1196.4197364278318;1215.8905698487001;1217.3365515793914;1219.4817202688998;1221.071985291185;21586.028628711432;23833.761662383153;23939.401514962265;24619.261422157364;25835.22494325173;41629.79185104055;41807.1638567233;41907.58092419037;42211.577884221995;42222.366664499445;222486;222852;222938;224412;224853;24247.151349702675;24508.6323705141;26672.333191670365;27284.59073113865;27572.310692232855;35870.10324741902;36960.815195923846;36992.63007369892;37070.62929370672;37716.2456750858;29547.556786647787;31448.842755786074;31530.842345789042;31637.8418107908;31852.5222121673;32376.190595235308;33329;33401.83299083489;33407.33185336231;33863.83068084644;30733.538996914616;31611.525827113073;31717.524237136924;31718.207044824063;31741.20646983844;25615.743842561336;27181.86409068021;27535.86232068827;27558.448831023667;27691.72308276972;21045.684314734986;21211.378984568793;21268.468288292916;21295.78704213;21380.893095535044 01:37:06 INFO - 2015-11-12 01:37:06,149 DEBUG : BROWSER_OUTPUT: |2;jquery.html;295.36054442132786;295.62160434643664;300.12812778877355;300.253869135199;306.36888010697965;12337.876621233785;12805.359732013385;14722.926385368071;14863.108213507197;15226.847731522696;12496.750064998694;14750.926245368784;15261.084334939911;15732.213389330545;15742.212889355544;4548.113117942003;4609.193391156543;4670.579647831694;4675;4712.363830882839;3424.5376874121926;3541.344851202523;3547.8935631930954;4638.049199914027;4665.83669571565;4870.366852309213;5091.287219789214;5094.949050509485;5100.744962751866;5101.693898366091;4952.67807592509;5072.9746351268195;5080.237964305346;5088.771005304733;5097.23541468779;4389.978050109729;4396.384506169139;4403.823847046115;4405.405270288502;4447.644188464915;17733.7339939901;17752.378666746732;17981.640367192584;18156.63686726258;18733.53166170843;1490.5900877258732;1792.5160206744106;1970.339936121401;1984.9702254466195;2034.3795142481538;7859.449838511307;8225.876611850827;8289;8492.405531612789;8555.914440855575;999.7550600102949;1363;1392.6379141423201;1437.3100911562403;1468.8237411510581;50379.74810125926;52935.47064529344;53160.468395316326;53584.99999999961;53683.19475207875;5667.971660141756;5702.201691763156;5748.913766293509;5752.913706294409;5756.366799652035;6525.445337146396;6536;6560.507961902877;6582.868342633216;6585.539012269191;4655.976720116446;4806.759662016885;4830.855074347775;4900.950990490121;4907.631927605444;5179.404368497671;5210.817621383233;5249.110320284694;5299.205119232146;5318.361796584435;2515.6855393075866;2539.4540173862706;2564.564024115905;2573.716891141973;2598.584226523747;886.4858382138344;895.1943251074085;905.8143080668447;946.6071580294101;955.6702937486556;345.15265024365124;358.8421094718316;375.8590528551793;378.42668357438504;417.1406901782338;9528.285378596633;10269.383836969806;10307.072363487172;10372.740681483023;10417.531211095518;398.1102236501417;403.9421578649653;407.9816408261635;408.8287057580012;409.0754893939658;5439.619226654097;5672.829815105553;5710.7430165642645;5725.885482290331;5749.367569567345;356152;390247;391042;397220;458367;54597.72701136469;56465.7176714122;56833.71583142058;57416.71291643515;57566;427.0988214866567;430.2578052858856;431.8790738593199;436.98907527311434;438.35342869268214;9082.863757043782;9379.296552758435;9396.154346108882;9494.857577136487;9497.097775711296;30344.54483182798;30909.536356955112;31194;31958.52062219115;32055.519167212045;42816;42917;43192.13615727731;43345.133097338505;43397.78301108601;5180.430152683277;5385.353757549119;5397.757100930389;5402.864928376822;5403.729813509231;9790.461524616214;9831.410115393099;10159.79680406373;10192.337498062601;10294.845577316497;8405.243528082501;8663.176998185163;8763.561821908752;8771.473711577326;8923.464592124494;8593.613287401957;8710.69512567057;8710.782230444289;8773.689911105163;8833.602487887933;8996.190342869173;9054.909450905407;9121.179093881583;9160.862587061332;9163.862542062008;5320.600954928474;5439.5920305976415;5545.057340252248;5557.666540007613;5571.275734154696;8636.438631488933;8830.116988301119;8953.731388058368;9122.90877091247;9138.908610914072 01:37:06 INFO - 2015-11-12 01:37:06,152 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1124.5333186727507;1517.446132161761;1594.4100682747378;1601.823799382068;1617.6602913388188;6139.938600613992;6327;6714.8992765108505;6861.279565645597;6867.381935625793;6669.09967154434;6690.063391125246;6764.966175169129;6768.052472653832;6792.966035169829;1728.2827626534972;1754.4648882090958;1928.035982008999;1938.3409640722152;1940.9611807763836;1934.0813113770917;1937.94186174415;1961.9509512262166;1966.429735376739;1966.6361723081275;1862.264405559803;1879.9812001879943;1884.5759704066613;1945.2121890634317;1947.8636495445323;1905.3045638341976;1910.722945172956;1929.6044310916368;1933.9709904351305;1937.7384053152925;1864.7575815143944;1913.0817207740363;1913.2347061175642;1915.7701075870984;1917.6452356314126;6812.080369150151;6863.382295593371;6872.209695884987;6879.828004299882;6895.34494223048;3951.585083566242;3999.0802115513593;4006.4591280177387;4022.7988600569856;4059.817308221137;2581.6772903387077;2633.4206474575562;2642.947141057168;2644.3917898883174;2655.468906218764;741.9332260096617;768.800111970886;784.3803395317692;847.3476720395192;901.4095767272447;8866.246369058637;9029.819403611957;9033;9036.683716069905;9037.54812259391;3652.5616925969052;3668;3734.6452087051684;3740.8503659853845;3774.698024158061;7975.042994840656;7985.880211796828;7994.440389172702;7998.280154786097;8003.119656837744;4103.322951712934;4191.1827193697545;4191.664666826647;4193.643540299109;4195.937060944088;3782.319182547113;3783.754055986407;3787.1289603390824;3787.8295476703615;3794.658480736747;2923.254570084615;3013.758899288052;3206.8396580171366;3220.0500852248642;3268.2156282492033;1023.1405619279841;1044.7910417916446;1045.6758404894506;1052.321252791945;1057.1120258982492;1104.8342748587777;1146.644540192543;1172.0447835014436;1186.2763714134371;1197.904167666602;6387.584806987531;6412.64730439821;6428.614283142932;6505.4795616350575;6507.642079685663;992.2855544008303;1035.699647102332;1039.8492218628257;1040.812653722322;1048.9423081730426;4955.851324460272;5012.624053196025;5059.443461219263;5075.644704870698;5102.413222479388;8067.112617612058;8232.958835205905;8269.875951860728;8293.377996650275;8351.997760268807;7941.444098913136;8011.559364235023;8112.310453611509;8124.146964568753;8185.017797864175;6297.370262973757;6398.936010639927;6470.773522926769;6474.935250647527;6514.283428822826;6092.39076092405;6110.511159107172;6190.133381326528;6221.502279817513;6225.035119556476;6808.148981377328;7243.782686519413;7261.927380726125;7279.381252593589;7287.708491660486;7355.227701091522;7442.9255707442235;7510.962445187739;7533.171351151259;7542.585157816373;5697.6296540724725;5827.562932779973;5839.883202336015;5847.415258474119;5849.912251316148;5700.857478562903;5985.371535988833;6623.735050598115;6662.766803161866;6684.7326106957125;5968.104784282393;5984.910226346521;6001.36985616504;6122.081687746873;6154.476869465966;5934.7922822701;5951.375105613848;5986.670733109547;5987.43119403656;6041.969790151197;6045.486133678686;6079.452849243589;6084.148219249397;6104.633721976518;6177.752889884354;5511.255980442589;5546.500814926676;5599.748011339418;5610.074337734228;5621.52217061538;5630.915536267041;5672.064109421899;5673.262475878109;5683.5453163747625;5688.516476099578 01:37:06 INFO - 2015-11-12 01:37:06,154 DEBUG : BROWSER_OUTPUT: |4;prototype.html;270.9837409755414;273.4858466083762;274.7540950848991;275.66644360324;284.2566688110589;5246.449122842104;5352.304200453946;5363.892722145555;5437.429069947658;5476.479734425233;5186.636935414523;5238.7642556084975;5299.205119232117;5308.522232999029;5355.036093503168;3942;4033.5563088060435;4035.132446524004;4051.8379264829373;4090.1615168890307;3881.573026967031;3972.940405893914;3975.8210880510446;4036.616521430459;4037.798110094498;3962.5244970603567;3989.5212574490956;4009.1781184857036;4027.879163625081;4043.009462681647;4024.839006439739;4024.8591299304385;4031.153457773871;4036.65688416482;4056.8580099696514;3463.79217246966;3466.670666286724;3469.6356882527225;3480.5301284326547;3488.2674638325984;5123.333966584358;5139.17773156297;5149.150390185615;5186.896262074737;5222;4564.497905230422;4579.038401935598;4581.5647513486165;4586.1744885920525;4604.079184163181;5551.1673249012565;5567.081431563827;5577.944220557783;5586.022446071962;5622.128570071645;3540.663636954511;3598.712103031751;3607.4408466687705;3787.4886890269736;3796.3925771876643;5727.971360143172;5729.312482502085;5788.507976822018;5804.738786754606;5834.824955251307;3852.845886164578;3854;3857.787821669779;3858.6334298241622;3867.323218436762;3875.7286989910435;3888.6111388861455;3896.8636097737012;3926.5484469285825;3962.742421742635;4433.357163211316;4534.501204867462;4535.863924082283;4538.818447262139;4581.144636422255;5624.578156638268;5639.266895303666;5646.717664116778;5650.943490565041;5694.914576281359;1401.10329389191;1418.6737050478448;1419.7799341102145;1424.017427974694;1424.893133015028;905.4748246017294;917.2295271971443;925.8750068740768;926.1109335038304;934.3272843552631;5367.543758780469;5387.164989426645;5392.245085688007;5408.4050754416985;5434.429384914527;5816.127580862904;5821.301443826768;5831.4168583141345;5840.970795145997;5897.882042359214;5402.756875940592;5415.675059496442;5423.159410291332;5425.403205647375;5447.891042179134;3127.37452509499;3201.887933922348;3229.1765599771907;3236.0615421527496;3237.028891332591;5968.46283834457;5970.9701451492465;5995.310539287951;6025;6071.787487437919;5935.080062590306;5945.375735547792;5951.226340575698;5958.255218097738;5988.191594134823;5781.075027995501;5983.521318294526;6009.06859436788;6017.578769486269;6040.365761595057;5763.452472015152;5764.962306784651;5777.884442311214;5788.189653448605;5864.44287792659;5589.636673616202;5666.688332141772;5667.914981275202;5680.40355762639;5703.458171473703;5884.029135192645;5893;5985.191999080069;6025.849353766191;6064.090386442069;3845;3879.86420475282;3888.9805550972064;3896.0844201613163;3904.941425878671;5797.014507533645;5800.767969281182;5807.506361959281;5835;5847.853803654943;5449.700266485382;5639.943600564106;5658.066419040977;5662.8301150965535;5740.1102829061565;5688.658680479019;5688.914666280092;5692.117721753135;5692.715364231689;5729.62757420783;5571.916421253603;5589.413111623221;5593.356763972032;5597.888042239214;5601.467860553241;5551.528120109836;5690.174924635822;5714.257146570919;5716.256886604715;5723.771049157987;5509.5041446270025;5517.944820551904;5521;5577.3028371453565;5592.692401917933 01:37:06 INFO - 2015-11-12 01:37:06,155 DEBUG : BROWSER_OUTPUT: |5;yui.html;642.306309186079;667.0794303860674;674.2111729276746;684.9965750171249;697.9057827193329;11837.289762614238;12073.215241009328;12077.214981026227;12087.214331068475;12092.879071209285;10724;11256.606018789344;11351.716207094805;11850.7629847403;12084.093692973018;609.2110716621963;610.7770663707737;748.2293237964905;756.0851369842497;766.1534004924562;727.7598392530479;736.6795443981858;743.5501521579448;745.3329270303076;753.1827966656184;768.3277132509055;772.9072511298652;772.98840517392;775.6393277126135;781.9921800781976;634.8984162533995;641.0512441586432;766.4519868294141;775.2983549887362;789.0964845252212;566.283651181256;568.6360729133316;568.9032864413018;575.5711994564076;575.611462262975;11632.360220187886;11859.288442693465;11869.703257418547;11983.161178717406;12005.819912701316;8377.120402357725;8423.199796019368;8543.743687689379;8814.118588141198;9044.321675874337;8035.919640803576;8181.304589109874;8196.959015204946;8232.753017409488;8279.047909490426;2540.8094392920607;2578.6132080187936;2583.8708064596694;2610.464854704781;2641.141628970573;39893;40886.59113408887;41134.58865411337;41223;41263.793681031406;5848.327442344185;5984.790532331347;6090.969545152246;6119.5410344224365;6243;10013.148882345082;10049.899501005042;10067.244956628283;10081.747956301004;10262.076413122706;5295.470452954673;5417.83746487606;5435.782568697208;5452.91820622691;5702.344230413555;3322.734181265493;3341.8496167672515;3342.4819153031317;3357.9160520986684;3367.562216911786;2430.9878450607634;2455.0916161020536;2455.938601534976;2455.9631605525933;2457.4839283750257;370.829418467508;372.66087860047224;379.3607770906032;386.7389512079391;387.521411057344;424.5987541772995;435.3122067133921;439.9880275366644;463.9652026098056;471.8513668194508;6816.761413350609;7381.409487241008;7394.223606521346;7471.9626401867645;7788.598052350518;454.9158405694957;497.32363984980395;549.209576779701;550.0896017091719;566.8922904648103;3223.3714425687235;3408.3864904316965;3453.4474484082425;3454.4768111910203;3629.383004889175;47800.52199477961;48216.27675584869;48421.75789121032;48458.51541484611;48641.513584864406;41073.79463102725;41552.37671434931;42643.57356426458;43279.783601082425;43346.78326608347;40155.39766903499;41034;41305.38041929373;41831.99999999939;41934.580654193065;7124.430045596444;7160.248173941661;7246.855062898818;7472.364848987897;7661.923380766121;30786.38427231398;31327.21681957969;31501.527477087402;31562.36875262528;31692;37413.81293093517;37807.24385512329;38637;38914.80542597269;38921.610783891796;6152.692365381802;6648.933510664831;6783.36545530399;6858.3827455529245;7311.707531698672;9848.162906153057;9971.512809275062;9976.60093596277;10003.449810260505;10011;9373;9432.952835236054;9445.0554944505;9459.810803783748;9501;9044.90955090467;9047.185753282236;9062.909370906207;9067.09329067088;9149.130832570896;9280.767980800534;9288.767780805534;9290.442573445614;9394;9419.105185007413;8117.878231826646;8138.593070346341;8614.91385086141;8643.308535317034;8653.528900087127;7920.643571039202;7923.241108296071;8052;8339.332853371594;8544.273736732199 01:37:06 INFO - 2015-11-12 01:37:06,155 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:37:06 INFO - 2015-11-12 01:37:06,155 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:37:06 INFO - 2015-11-12 01:37:06,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1031 01:37:06 INFO - 2015-11-12 01:37:06,155 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:37:06 INFO - 2015-11-12 01:37:06,156 DEBUG : BROWSER_OUTPUT: __startTimestamp1447321026142__endTimestamp 01:37:06 INFO - 2015-11-12 01:37:06,156 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,156 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:37:06 INFO - 2015-11-12 01:37:06,156 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:37:06 INFO - 2015-11-12 01:37:06,156 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,156 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4708.32 Median:4872.76 stddev:509.09 (10.4%) stddev-sans-first:487.50 01:37:06 INFO - 2015-11-12 01:37:06,158 DEBUG : BROWSER_OUTPUT: Values: 2773.7 2779.9 2798.3 2832.1 2866.5 4551.5 4700.1 4730.9 4815.1 4826.0 4629.5 4657.6 4735.0 4771.7 4822.2 4339.7 4420.2 4420.6 4422.4 4444.6 4407.1 4423.7 4450.6 4463.9 4470.3 4279.9 4280.3 4298.2 4335.8 4374.6 4275.0 4299.6 4322.6 4361.0 4378.6 4275.7 4281.9 4295.1 4320.9 4323.2 4626.2 4709.2 4729.4 4737.7 4751.0 4914.0 4927.6 4985.6 4985.7 5053.1 5001.3 5021.8 5045.8 5055.5 5079.1 4628.2 4693.9 4725.8 4733.1 4733.5 5087.2 5191.3 5207.6 5208.4 5219.6 4694.5 4836.0 4844.9 4847.4 4889.5 5047.2 5056.1 5115.5 5123.7 5156.5 4799.1 4861.5 5048.4 5055.5 5057.8 4929.5 4952.3 4996.7 5007.5 5008.2 3857.4 3876.9 3883.1 3908.3 3914.9 3437.2 3493.1 3551.6 3573.3 3576.9 4630.6 4760.0 4774.8 4787.5 4810.4 5103.8 5192.0 5207.5 5221.3 5231.7 4612.2 4818.4 4827.6 4855.5 4908.2 4403.3 4427.4 4465.9 4503.0 4572.5 5179.1 5187.8 5227.3 5241.0 5306.4 4875.7 5058.7 5065.3 5113.6 5128.3 5114.1 5138.3 5156.4 5195.8 5215.1 4924.9 4937.8 4941.0 4943.9 4953.4 4916.6 4991.8 5014.3 5031.6 5049.0 4945.7 4991.6 5010.3 5021.1 5028.7 4874.1 5024.9 5067.2 5080.0 5118.5 4717.8 4986.6 5009.1 5009.2 5022.1 4855.9 4904.9 4969.8 5024.9 5037.3 4872.8 4875.5 4878.2 4898.7 4919.4 01:37:06 INFO - 2015-11-12 01:37:06,158 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,158 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38697.57 Median:31624.68 stddev:60278.31 (190.6%) stddev-sans-first:60379.17 01:37:06 INFO - 2015-11-12 01:37:06,160 DEBUG : BROWSER_OUTPUT: Values: 498.8 504.1 504.6 515.5 527.9 27292.3 28741.1 28964.3 35176.5 36231.8 37914.4 38386.2 38492.6 38840.2 38844.0 8044.8 8229.3 8233.5 8249.7 8334.0 7425.9 7620.4 9832.7 9962.6 10058.8 9770.4 9863.4 9905.6 9955.8 9984.2 7483.5 7693.6 9770.9 9825.2 9889.3 9770.0 9932.7 9934.5 9943.1 10083.6 35570.5 36017.5 36022.8 36024.5 36046.3 2769.4 2962.3 3071.9 3143.4 3153.1 24445.6 25061.7 25340.0 25870.5 26155.9 2186.3 2189.4 2192.4 2194.5 2210.2 250414.0 253884.0 254739.0 255453.7 255621.0 45912.3 46448.8 52970.7 53498.0 53523.5 43621.0 55265.7 56155.2 56212.0 56291.1 14813.4 15049.1 15066.5 15218.2 15224.8 11525.9 11577.7 11607.0 11627.1 11756.6 17340.7 17453.7 17571.8 17576.2 17611.7 7008.4 7083.8 7143.2 7160.4 7177.5 831.9 859.5 930.8 935.6 999.6 25129.0 25393.7 25562.2 25602.5 25676.5 836.3 903.6 949.7 994.9 1029.7 11794.2 11999.9 12028.3 12137.3 12180.7 209963.0 217318.0 217877.0 218110.0 218232.0 46597.1 47392.8 47455.8 47591.8 47982.5 1196.4 1215.9 1217.3 1219.5 1221.1 21586.0 23833.8 23939.4 24619.3 25835.2 41629.8 41807.2 41907.6 42211.6 42222.4 222486.0 222852.0 222938.0 224412.0 224853.0 24247.2 24508.6 26672.3 27284.6 27572.3 35870.1 36960.8 36992.6 37070.6 37716.2 29547.6 31448.8 31530.8 31637.8 31852.5 32376.2 33329.0 33401.8 33407.3 33863.8 30733.5 31611.5 31717.5 31718.2 31741.2 25615.7 27181.9 27535.9 27558.4 27691.7 21045.7 21211.4 21268.5 21295.8 21380.9 01:37:06 INFO - 2015-11-12 01:37:06,160 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,160 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21464.63 Median:4904.29 stddev:65584.15 (1337.3%) stddev-sans-first:65748.87 01:37:06 INFO - 2015-11-12 01:37:06,160 DEBUG : BROWSER_OUTPUT: Values: 295.4 295.6 300.1 300.3 306.4 12337.9 12805.4 14722.9 14863.1 15226.8 12496.8 14750.9 15261.1 15732.2 15742.2 4548.1 4609.2 4670.6 4675.0 4712.4 3424.5 3541.3 3547.9 4638.0 4665.8 4870.4 5091.3 5094.9 5100.7 5101.7 4952.7 5073.0 5080.2 5088.8 5097.2 4390.0 4396.4 4403.8 4405.4 4447.6 17733.7 17752.4 17981.6 18156.6 18733.5 1490.6 1792.5 1970.3 1985.0 2034.4 7859.4 8225.9 8289.0 8492.4 8555.9 999.8 1363.0 1392.6 1437.3 1468.8 50379.7 52935.5 53160.5 53585.0 53683.2 5668.0 5702.2 5748.9 5752.9 5756.4 6525.4 6536.0 6560.5 6582.9 6585.5 4656.0 4806.8 4830.9 4901.0 4907.6 5179.4 5210.8 5249.1 5299.2 5318.4 2515.7 2539.5 2564.6 2573.7 2598.6 886.5 895.2 905.8 946.6 955.7 345.2 358.8 375.9 378.4 417.1 9528.3 10269.4 10307.1 10372.7 10417.5 398.1 403.9 408.0 408.8 409.1 5439.6 5672.8 5710.7 5725.9 5749.4 356152.0 390247.0 391042.0 397220.0 458367.0 54597.7 56465.7 56833.7 57416.7 57566.0 427.1 430.3 431.9 437.0 438.4 9082.9 9379.3 9396.2 9494.9 9497.1 30344.5 30909.5 31194.0 31958.5 32055.5 42816.0 42917.0 43192.1 43345.1 43397.8 5180.4 5385.4 5397.8 5402.9 5403.7 9790.5 9831.4 10159.8 10192.3 10294.8 8405.2 8663.2 8763.6 8771.5 8923.5 8593.6 8710.7 8710.8 8773.7 8833.6 8996.2 9054.9 9121.2 9160.9 9163.9 5320.6 5439.6 5545.1 5557.7 5571.3 8636.4 8830.1 8953.7 9122.9 9138.9 01:37:06 INFO - 2015-11-12 01:37:06,160 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,161 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4729.88 Median:5764.21 stddev:2435.06 (42.2%) stddev-sans-first:2426.81 01:37:06 INFO - 2015-11-12 01:37:06,162 DEBUG : BROWSER_OUTPUT: Values: 1124.5 1517.4 1594.4 1601.8 1617.7 6139.9 6327.0 6714.9 6861.3 6867.4 6669.1 6690.1 6765.0 6768.1 6793.0 1728.3 1754.5 1928.0 1938.3 1941.0 1934.1 1937.9 1962.0 1966.4 1966.6 1862.3 1880.0 1884.6 1945.2 1947.9 1905.3 1910.7 1929.6 1934.0 1937.7 1864.8 1913.1 1913.2 1915.8 1917.6 6812.1 6863.4 6872.2 6879.8 6895.3 3951.6 3999.1 4006.5 4022.8 4059.8 2581.7 2633.4 2642.9 2644.4 2655.5 741.9 768.8 784.4 847.3 901.4 8866.2 9029.8 9033.0 9036.7 9037.5 3652.6 3668.0 3734.6 3740.9 3774.7 7975.0 7985.9 7994.4 7998.3 8003.1 4103.3 4191.2 4191.7 4193.6 4195.9 3782.3 3783.8 3787.1 3787.8 3794.7 2923.3 3013.8 3206.8 3220.1 3268.2 1023.1 1044.8 1045.7 1052.3 1057.1 1104.8 1146.6 1172.0 1186.3 1197.9 6387.6 6412.6 6428.6 6505.5 6507.6 992.3 1035.7 1039.8 1040.8 1048.9 4955.9 5012.6 5059.4 5075.6 5102.4 8067.1 8233.0 8269.9 8293.4 8352.0 7941.4 8011.6 8112.3 8124.1 8185.0 6297.4 6398.9 6470.8 6474.9 6514.3 6092.4 6110.5 6190.1 6221.5 6225.0 6808.1 7243.8 7261.9 7279.4 7287.7 7355.2 7442.9 7511.0 7533.2 7542.6 5697.6 5827.6 5839.9 5847.4 5849.9 5700.9 5985.4 6623.7 6662.8 6684.7 5968.1 5984.9 6001.4 6122.1 6154.5 5934.8 5951.4 5986.7 5987.4 6042.0 6045.5 6079.5 6084.1 6104.6 6177.8 5511.3 5546.5 5599.7 5610.1 5621.5 5630.9 5672.1 5673.3 5683.5 5688.5 01:37:06 INFO - 2015-11-12 01:37:06,162 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,162 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4682.61 Median:5429.92 stddev:1435.51 (26.4%) stddev-sans-first:1400.82 01:37:06 INFO - 2015-11-12 01:37:06,163 DEBUG : BROWSER_OUTPUT: Values: 271.0 273.5 274.8 275.7 284.3 5246.4 5352.3 5363.9 5437.4 5476.5 5186.6 5238.8 5299.2 5308.5 5355.0 3942.0 4033.6 4035.1 4051.8 4090.2 3881.6 3972.9 3975.8 4036.6 4037.8 3962.5 3989.5 4009.2 4027.9 4043.0 4024.8 4024.9 4031.2 4036.7 4056.9 3463.8 3466.7 3469.6 3480.5 3488.3 5123.3 5139.2 5149.2 5186.9 5222.0 4564.5 4579.0 4581.6 4586.2 4604.1 5551.2 5567.1 5577.9 5586.0 5622.1 3540.7 3598.7 3607.4 3787.5 3796.4 5728.0 5729.3 5788.5 5804.7 5834.8 3852.8 3854.0 3857.8 3858.6 3867.3 3875.7 3888.6 3896.9 3926.5 3962.7 4433.4 4534.5 4535.9 4538.8 4581.1 5624.6 5639.3 5646.7 5650.9 5694.9 1401.1 1418.7 1419.8 1424.0 1424.9 905.5 917.2 925.9 926.1 934.3 5367.5 5387.2 5392.2 5408.4 5434.4 5816.1 5821.3 5831.4 5841.0 5897.9 5402.8 5415.7 5423.2 5425.4 5447.9 3127.4 3201.9 3229.2 3236.1 3237.0 5968.5 5971.0 5995.3 6025.0 6071.8 5935.1 5945.4 5951.2 5958.3 5988.2 5781.1 5983.5 6009.1 6017.6 6040.4 5763.5 5765.0 5777.9 5788.2 5864.4 5589.6 5666.7 5667.9 5680.4 5703.5 5884.0 5893.0 5985.2 6025.8 6064.1 3845.0 3879.9 3889.0 3896.1 3904.9 5797.0 5800.8 5807.5 5835.0 5847.9 5449.7 5639.9 5658.1 5662.8 5740.1 5688.7 5688.9 5692.1 5692.7 5729.6 5571.9 5589.4 5593.4 5597.9 5601.5 5551.5 5690.2 5714.3 5716.3 5723.8 5509.5 5517.9 5521.0 5577.3 5592.7 01:37:06 INFO - 2015-11-12 01:37:06,163 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,164 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11376.05 Median:566.59 stddev:13696.80 (2417.4%) stddev-sans-first:13711.50 01:37:06 INFO - 2015-11-12 01:37:06,164 DEBUG : BROWSER_OUTPUT: Values: 642.3 667.1 674.2 685.0 697.9 11837.3 12073.2 12077.2 12087.2 12092.9 10724.0 11256.6 11351.7 11850.8 12084.1 609.2 610.8 748.2 756.1 766.2 727.8 736.7 743.6 745.3 753.2 768.3 772.9 773.0 775.6 782.0 634.9 641.1 766.5 775.3 789.1 566.3 568.6 568.9 575.6 575.6 11632.4 11859.3 11869.7 11983.2 12005.8 8377.1 8423.2 8543.7 8814.1 9044.3 8035.9 8181.3 8197.0 8232.8 8279.0 2540.8 2578.6 2583.9 2610.5 2641.1 39893.0 40886.6 41134.6 41223.0 41263.8 5848.3 5984.8 6091.0 6119.5 6243.0 10013.1 10049.9 10067.2 10081.7 10262.1 5295.5 5417.8 5435.8 5452.9 5702.3 3322.7 3341.8 3342.5 3357.9 3367.6 2431.0 2455.1 2455.9 2456.0 2457.5 370.8 372.7 379.4 386.7 387.5 424.6 435.3 440.0 464.0 471.9 6816.8 7381.4 7394.2 7472.0 7788.6 454.9 497.3 549.2 550.1 566.9 3223.4 3408.4 3453.4 3454.5 3629.4 47800.5 48216.3 48421.8 48458.5 48641.5 41073.8 41552.4 42643.6 43279.8 43346.8 40155.4 41034.0 41305.4 41832.0 41934.6 7124.4 7160.2 7246.9 7472.4 7661.9 30786.4 31327.2 31501.5 31562.4 31692.0 37413.8 37807.2 38637.0 38914.8 38921.6 6152.7 6648.9 6783.4 6858.4 7311.7 9848.2 9971.5 9976.6 10003.4 10011.0 9373.0 9433.0 9445.1 9459.8 9501.0 9044.9 9047.2 9062.9 9067.1 9149.1 9280.8 9288.8 9290.4 9394.0 9419.1 8117.9 8138.6 8614.9 8643.3 8653.5 7920.6 7923.2 8052.0 8339.3 8544.3 01:37:06 INFO - 2015-11-12 01:37:06,164 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:37:06 INFO - 2015-11-12 01:37:06,164 DEBUG : BROWSER_OUTPUT: 01:37:06 INFO - 2015-11-12 01:37:06,841 INFO : Browser exited with error code: 0 01:37:06 INFO - 2015-11-12 01:37:06,871 INFO : Completed test dromaeo_css (00:18:36) 01:37:06 INFO - 2015-11-12 01:37:06,871 INFO : Starting test kraken 01:37:06 INFO - 2015-11-12 01:37:06,872 DEBUG : operating with platform_type : mac_ 01:37:06 INFO - 2015-11-12 01:37:06,872 INFO : Initialising browser for kraken test... 01:37:06 INFO - 2015-11-12 01:37:06,886 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpUQ41RH/profile http://localhost:49269/getInfo.html 01:37:09 INFO - 2015-11-12 01:37:09,503 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:37:09 INFO - 2015-11-12 01:37:09,503 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:37:09 INFO - 2015-11-12 01:37:09,503 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:37:09 INFO - 2015-11-12 01:37:09,503 DEBUG : BROWSER_OUTPUT: __metrics 01:37:09 INFO - 2015-11-12 01:37:09,520 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:37:10 INFO - 2015-11-12 01:37:10,247 INFO : Browser initialized. 01:37:10 INFO - 2015-11-12 01:37:10,248 INFO : Running cycle 1/1 for kraken test... 01:37:10 INFO - 2015-11-12 01:37:10,248 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpUQ41RH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:37:22 INFO - 2015-11-12 01:37:22,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 227799040 01:37:22 INFO - 2015-11-12 01:37:22,450 DEBUG : BROWSER_OUTPUT: 01:37:25 INFO - 2015-11-12 01:37:25,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 01:37:25 INFO - 2015-11-12 01:37:25,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 284753920 01:37:25 INFO - 2015-11-12 01:37:25,853 DEBUG : BROWSER_OUTPUT: 01:37:28 INFO - 2015-11-12 01:37:28,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 01:37:29 INFO - 2015-11-12 01:37:29,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 298631168 01:37:29 INFO - 2015-11-12 01:37:29,365 DEBUG : BROWSER_OUTPUT: 01:37:32 INFO - 2015-11-12 01:37:32,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 01:37:33 INFO - 2015-11-12 01:37:33,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 283197440 01:37:33 INFO - 2015-11-12 01:37:33,165 DEBUG : BROWSER_OUTPUT: 01:37:35 INFO - 2015-11-12 01:37:35,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 01:37:35 INFO - 2015-11-12 01:37:35,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 284631040 01:37:35 INFO - 2015-11-12 01:37:35,941 DEBUG : BROWSER_OUTPUT: 01:37:38 INFO - 2015-11-12 01:37:38,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:37:38 INFO - 2015-11-12 01:37:38,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 283291648 01:37:38 INFO - 2015-11-12 01:37:38,896 DEBUG : BROWSER_OUTPUT: 01:37:42 INFO - 2015-11-12 01:37:42,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 01:37:42 INFO - 2015-11-12 01:37:42,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 281772032 01:37:42 INFO - 2015-11-12 01:37:42,873 DEBUG : BROWSER_OUTPUT: 01:37:46 INFO - 2015-11-12 01:37:46,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 01:37:46 INFO - 2015-11-12 01:37:46,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 284766208 01:37:46 INFO - 2015-11-12 01:37:46,903 DEBUG : BROWSER_OUTPUT: 01:37:50 INFO - 2015-11-12 01:37:50,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 01:37:50 INFO - 2015-11-12 01:37:50,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 284471296 01:37:50 INFO - 2015-11-12 01:37:50,647 DEBUG : BROWSER_OUTPUT: 01:37:52 INFO - 2015-11-12 01:37:52,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:37:52 INFO - 2015-11-12 01:37:52,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 318976000 01:37:52 INFO - 2015-11-12 01:37:52,895 DEBUG : BROWSER_OUTPUT: 01:37:54 INFO - 2015-11-12 01:37:54,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:37:55 INFO - 2015-11-12 01:37:55,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 320327680 01:37:55 INFO - 2015-11-12 01:37:55,494 DEBUG : BROWSER_OUTPUT: 01:37:57 INFO - 2015-11-12 01:37:57,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:37:58 INFO - 2015-11-12 01:37:58,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 327467008 01:37:58 INFO - 2015-11-12 01:37:58,360 DEBUG : BROWSER_OUTPUT: 01:38:01 INFO - 2015-11-12 01:38:01,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:38:01 INFO - 2015-11-12 01:38:01,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 330371072 01:38:01 INFO - 2015-11-12 01:38:01,828 DEBUG : BROWSER_OUTPUT: 01:38:04 INFO - 2015-11-12 01:38:04,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:38:05 INFO - 2015-11-12 01:38:05,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 329277440 01:38:05 INFO - 2015-11-12 01:38:05,359 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 01:38:07 INFO - 2015-11-12 01:38:07,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 387661824 01:38:07 INFO - 2015-11-12 01:38:07,499 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,500 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:38:07 INFO - 2015-11-12 01:38:07,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:38:07 INFO - 2015-11-12 01:38:07,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:38:07 INFO - 2015-11-12 01:38:07,500 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:38:07 INFO - 2015-11-12 01:38:07,500 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;124;119;123;122;121;121;126;117;120 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;176;152;175;190;144;168;173;146;189;142 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;180;189;184;179;179;181;182;181;180 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;87;94;136;76;81;81;81;132;76 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;110;110;159;104;105;103;141;99;100;142 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;130;136;133;129;136;136;142;139;136;135 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;142;148;143;141;141;147;144;142;141;147 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;119;119;115;113;117;118;116;112;118 01:38:07 INFO - 2015-11-12 01:38:07,501 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;64;66;65;66;69;69;78;68;65 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;75;75;76;83;80;81;78;77;78 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;99;101;102;98;96;95;96;101;102 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;150;156;145;141;149;158;147;150;146 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;166;181;188;188;181;167;171;176;175;184 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;80;82;82;84;85;85;80;80;84 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:38:07 INFO - 2015-11-12 01:38:07,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,934 01:38:07 INFO - 2015-11-12 01:38:07,503 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:38:07 INFO - 2015-11-12 01:38:07,503 DEBUG : BROWSER_OUTPUT: __startTimestamp1447321087499__endTimestamp 01:38:07 INFO - 2015-11-12 01:38:07,503 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,504 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:38:07 INFO - 2015-11-12 01:38:07,504 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:38:07 INFO - 2015-11-12 01:38:07,505 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,505 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:121.10 Median:121.50 stddev:2.77 (2.3%) stddev-sans-first:2.70 01:38:07 INFO - 2015-11-12 01:38:07,505 DEBUG : BROWSER_OUTPUT: Values: 118.0 124.0 119.0 123.0 122.0 121.0 121.0 126.0 117.0 120.0 01:38:07 INFO - 2015-11-12 01:38:07,505 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,505 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:165.50 Median:174.00 stddev:18.23 (10.5%) stddev-sans-first:18.94 01:38:07 INFO - 2015-11-12 01:38:07,506 DEBUG : BROWSER_OUTPUT: Values: 176.0 152.0 175.0 190.0 144.0 168.0 173.0 146.0 189.0 142.0 01:38:07 INFO - 2015-11-12 01:38:07,506 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,506 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.80 Median:181.50 stddev:3.01 (1.7%) stddev-sans-first:3.16 01:38:07 INFO - 2015-11-12 01:38:07,506 DEBUG : BROWSER_OUTPUT: Values: 183.0 180.0 189.0 184.0 179.0 179.0 181.0 182.0 181.0 180.0 01:38:07 INFO - 2015-11-12 01:38:07,507 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,507 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.90 Median:81.00 stddev:22.31 (27.5%) stddev-sans-first:23.48 01:38:07 INFO - 2015-11-12 01:38:07,507 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 94.0 136.0 76.0 81.0 81.0 81.0 132.0 76.0 01:38:07 INFO - 2015-11-12 01:38:07,507 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,507 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.30 Median:125.50 stddev:21.56 (17.2%) stddev-sans-first:22.71 01:38:07 INFO - 2015-11-12 01:38:07,507 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 159.0 104.0 105.0 103.0 141.0 99.0 100.0 142.0 01:38:07 INFO - 2015-11-12 01:38:07,507 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,508 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:135.20 Median:136.00 stddev:3.85 (2.8%) stddev-sans-first:3.60 01:38:07 INFO - 2015-11-12 01:38:07,508 DEBUG : BROWSER_OUTPUT: Values: 130.0 136.0 133.0 129.0 136.0 136.0 142.0 139.0 136.0 135.0 01:38:07 INFO - 2015-11-12 01:38:07,508 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,508 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:143.60 Median:143.50 stddev:2.76 (1.9%) stddev-sans-first:2.86 01:38:07 INFO - 2015-11-12 01:38:07,508 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 143.0 141.0 141.0 147.0 144.0 142.0 141.0 147.0 01:38:07 INFO - 2015-11-12 01:38:07,509 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,509 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.10 Median:117.50 stddev:2.51 (2.1%) stddev-sans-first:2.55 01:38:07 INFO - 2015-11-12 01:38:07,509 DEBUG : BROWSER_OUTPUT: Values: 114.0 119.0 119.0 115.0 113.0 117.0 118.0 116.0 112.0 118.0 01:38:07 INFO - 2015-11-12 01:38:07,509 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,509 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.00 stddev:4.39 (6.6%) stddev-sans-first:4.24 01:38:07 INFO - 2015-11-12 01:38:07,510 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 66.0 65.0 66.0 69.0 69.0 78.0 68.0 65.0 01:38:07 INFO - 2015-11-12 01:38:07,510 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,510 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:78.00 stddev:3.24 (4.2%) stddev-sans-first:2.76 01:38:07 INFO - 2015-11-12 01:38:07,510 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 75.0 76.0 83.0 80.0 81.0 78.0 77.0 78.0 01:38:07 INFO - 2015-11-12 01:38:07,510 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,510 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.50 Median:95.50 stddev:2.88 (3.0%) stddev-sans-first:2.76 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: Values: 95.0 99.0 101.0 102.0 98.0 96.0 95.0 96.0 101.0 102.0 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:150.00 stddev:5.45 (3.6%) stddev-sans-first:5.30 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: Values: 156.0 150.0 156.0 145.0 141.0 149.0 158.0 147.0 150.0 146.0 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:181.00 stddev:8.03 (4.4%) stddev-sans-first:7.31 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: Values: 166.0 181.0 188.0 188.0 181.0 167.0 171.0 176.0 175.0 184.0 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.00 Median:83.00 stddev:2.45 (3.0%) stddev-sans-first:2.13 01:38:07 INFO - 2015-11-12 01:38:07,512 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 82.0 82.0 84.0 85.0 85.0 80.0 80.0 84.0 01:38:07 INFO - 2015-11-12 01:38:07,513 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:38:07 INFO - 2015-11-12 01:38:07,513 DEBUG : BROWSER_OUTPUT: 01:38:08 INFO - 2015-11-12 01:38:08,244 INFO : Browser exited with error code: 0 01:38:08 INFO - 2015-11-12 01:38:08,297 INFO : Completed test kraken (00:01:01) 01:38:08 INFO - 2015-11-12 01:38:08,297 INFO : Starting test v8_7 01:38:08 INFO - 2015-11-12 01:38:08,297 DEBUG : operating with platform_type : mac_ 01:38:08 INFO - 2015-11-12 01:38:08,298 INFO : Initialising browser for v8_7 test... 01:38:08 INFO - 2015-11-12 01:38:08,313 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpbkhCAF/profile http://localhost:49269/getInfo.html 01:38:10 INFO - 2015-11-12 01:38:10,856 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:38:10 INFO - 2015-11-12 01:38:10,857 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:38:10 INFO - 2015-11-12 01:38:10,857 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 01:38:10 INFO - 2015-11-12 01:38:10,857 DEBUG : BROWSER_OUTPUT: __metrics 01:38:10 INFO - 2015-11-12 01:38:10,872 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:38:11 INFO - 2015-11-12 01:38:11,703 INFO : Browser initialized. 01:38:11 INFO - 2015-11-12 01:38:11,704 INFO : Running cycle 1/1 for v8_7 test... 01:38:11 INFO - 2015-11-12 01:38:11,704 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpbkhCAF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:38:23 INFO - 2015-11-12 01:38:23,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 228749312 01:38:23 INFO - 2015-11-12 01:38:23,904 DEBUG : BROWSER_OUTPUT: 01:38:46 INFO - 2015-11-12 01:38:46,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 01:38:46 INFO - 2015-11-12 01:38:46,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 689979392 01:38:46 INFO - 2015-11-12 01:38:46,993 DEBUG : BROWSER_OUTPUT: 01:38:46 INFO - 2015-11-12 01:38:46,993 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:38:46 INFO - 2015-11-12 01:38:46,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:38:46 INFO - 2015-11-12 01:38:46,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:38:46 INFO - 2015-11-12 01:38:46,994 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:38:46 INFO - 2015-11-12 01:38:46,994 DEBUG : BROWSER_OUTPUT: |0;Richards;188.96447467876038 01:38:46 INFO - 2015-11-12 01:38:46,994 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;224.9212775528565 01:38:46 INFO - 2015-11-12 01:38:46,994 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.53289949385396 01:38:46 INFO - 2015-11-12 01:38:46,994 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6890.41095890411 01:38:46 INFO - 2015-11-12 01:38:46,994 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2141.3276231263385 01:38:46 INFO - 2015-11-12 01:38:46,995 DEBUG : BROWSER_OUTPUT: |5;Earley;1024.5901639344263 01:38:46 INFO - 2015-11-12 01:38:46,995 DEBUG : BROWSER_OUTPUT: |6;Boyer;14239.43661971831 01:38:46 INFO - 2015-11-12 01:38:46,995 DEBUG : BROWSER_OUTPUT: |7;RegExp;33616.666666666664 01:38:46 INFO - 2015-11-12 01:38:46,995 DEBUG : BROWSER_OUTPUT: |8;Splay;711.0481586402266 01:38:46 INFO - 2015-11-12 01:38:46,995 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6506.493506493506 01:38:46 INFO - 2015-11-12 01:38:46,996 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:38:46 INFO - 2015-11-12 01:38:46,996 DEBUG : BROWSER_OUTPUT: __startTimestamp1447321126992__endTimestamp 01:38:46 INFO - 2015-11-12 01:38:46,996 DEBUG : BROWSER_OUTPUT: 01:38:46 INFO - 2015-11-12 01:38:46,996 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:38:46 INFO - 2015-11-12 01:38:46,996 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:38:47 INFO - 2015-11-12 01:38:46,997 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:46,997 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:46,997 DEBUG : BROWSER_OUTPUT: Values: 189.0 01:38:47 INFO - 2015-11-12 01:38:46,997 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:46,998 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:224.92 Median:224.92 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:46,998 DEBUG : BROWSER_OUTPUT: Values: 224.9 01:38:47 INFO - 2015-11-12 01:38:46,998 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.53 Median:361.53 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: Values: 361.5 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6890.41 Median:6890.41 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: Values: 6890.4 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2141.33 Median:2141.33 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: Values: 2141.3 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1024.59 Median:1024.59 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: Values: 1024.6 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:46,999 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14239.44 Median:14239.44 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: Values: 14239.4 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33616.67 Median:33616.67 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: Values: 33616.7 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:711.05 Median:711.05 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: Values: 711.0 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6506.49 Median:6506.49 stddev:0.00 (0.0%) 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: Values: 6506.5 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:38:47 INFO - 2015-11-12 01:38:47,000 DEBUG : BROWSER_OUTPUT: 01:38:47 INFO - 2015-11-12 01:38:47,715 INFO : Browser exited with error code: 0 01:38:47 INFO - 2015-11-12 01:38:47,737 INFO : Completed test v8_7 (00:00:39) 01:38:47 INFO - 2015-11-12 01:38:47,777 INFO : Completed test suite (00:20:17) 01:38:47 INFO - 2015-11-12 01:38:47,777 DEBUG : Working with test: dromaeo_css 01:38:47 INFO - 2015-11-12 01:38:47,777 DEBUG : Generating results file: dromaeo_css 01:38:47 INFO - 2015-11-12 01:38:47,778 DEBUG : Working with test: kraken 01:38:47 INFO - 2015-11-12 01:38:47,778 DEBUG : Generating results file: kraken 01:38:47 INFO - 2015-11-12 01:38:47,778 INFO : javascript benchmark 01:38:47 INFO - 2015-11-12 01:38:47,778 DEBUG : Working with test: v8_7 01:38:47 INFO - 2015-11-12 01:38:47,778 DEBUG : Generating results file: v8_7 01:38:47 INFO - 2015-11-12 01:38:47,779 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:38:47 INFO - 2015-11-12 01:38:47,833 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 01:38:47 INFO - 2015-11-12 01:38:47,833 DEBUG : process_Request line: dromaeo_css 5804.10 graph.html#tests=[[72,63,55]] 01:38:47 INFO - 2015-11-12 01:38:47,833 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:38:47 INFO - 2015-11-12 01:38:47,863 DEBUG : process_Request line: kraken 1726.20 graph.html#tests=[[232,63,55]] 01:38:47 INFO - 2015-11-12 01:38:47,863 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:38:47 INFO - 2015-11-12 01:38:47,893 DEBUG : process_Request line: v8_7 16170.36 graph.html#tests=[[230,63,55]] 01:38:47 INFO - 2015-11-12 01:38:47,894 INFO : javascript benchmark 01:38:47 INFO - 2015-11-12 01:38:47,896 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [295.36054442132786, 295.62160434643664, 300.12812778877355, 300.253869135199, 306.36888010697965, 12337.876621233785, 12805.359732013385, 14722.926385368071, 14863.108213507197, 15226.847731522696, 12496.750064998694, 14750.926245368784, 15261.084334939911, 15732.213389330545, 15742.212889355544, 4548.113117942003, 4609.193391156543, 4670.579647831694, 4675.0, 4712.363830882839, 3424.5376874121926, 3541.344851202523, 3547.8935631930954, 4638.049199914027, 4665.83669571565, 4870.366852309213, 5091.287219789214, 5094.949050509485, 5100.744962751866, 5101.693898366091, 4952.67807592509, 5072.9746351268195, 5080.237964305346, 5088.771005304733, 5097.23541468779, 4389.978050109729, 4396.384506169139, 4403.823847046115, 4405.405270288502, 4447.644188464915, 17733.7339939901, 17752.378666746732, 17981.640367192584, 18156.63686726258, 18733.53166170843, 1490.5900877258732, 1792.5160206744106, 1970.339936121401, 1984.9702254466195, 2034.3795142481538, 7859.449838511307, 8225.876611850827, 8289.0, 8492.405531612789, 8555.914440855575, 999.7550600102949, 1363.0, 1392.6379141423201, 1437.3100911562403, 1468.8237411510581, 50379.74810125926, 52935.47064529344, 53160.468395316326, 53584.99999999961, 53683.19475207875, 5667.971660141756, 5702.201691763156, 5748.913766293509, 5752.913706294409, 5756.366799652035, 6525.445337146396, 6536.0, 6560.507961902877, 6582.868342633216, 6585.539012269191, 4655.976720116446, 4806.759662016885, 4830.855074347775, 4900.950990490121, 4907.631927605444, 5179.404368497671, 5210.817621383233, 5249.110320284694, 5299.205119232146, 5318.361796584435, 2515.6855393075866, 2539.4540173862706, 2564.564024115905, 2573.716891141973, 2598.584226523747, 886.4858382138344, 895.1943251074085, 905.8143080668447, 946.6071580294101, 955.6702937486556, 345.15265024365124, 358.8421094718316, 375.8590528551793, 378.42668357438504, 417.1406901782338, 9528.285378596633, 10269.383836969806, 10307.072363487172, 10372.740681483023, 10417.531211095518, 398.1102236501417, 403.9421578649653, 407.9816408261635, 408.8287057580012, 409.0754893939658, 5439.619226654097, 5672.829815105553, 5710.7430165642645, 5725.885482290331, 5749.367569567345, 356152.0, 390247.0, 391042.0, 397220.0, 458367.0, 54597.72701136469, 56465.7176714122, 56833.71583142058, 57416.71291643515, 57566.0, 427.0988214866567, 430.2578052858856, 431.8790738593199, 436.98907527311434, 438.35342869268214, 9082.863757043782, 9379.296552758435, 9396.154346108882, 9494.857577136487, 9497.097775711296, 30344.54483182798, 30909.536356955112, 31194.0, 31958.52062219115, 32055.519167212045, 42816.0, 42917.0, 43192.13615727731, 43345.133097338505, 43397.78301108601, 5180.430152683277, 5385.353757549119, 5397.757100930389, 5402.864928376822, 5403.729813509231, 9790.461524616214, 9831.410115393099, 10159.79680406373, 10192.337498062601, 10294.845577316497, 8405.243528082501, 8663.176998185163, 8763.561821908752, 8771.473711577326, 8923.464592124494, 8593.613287401957, 8710.69512567057, 8710.782230444289, 8773.689911105163, 8833.602487887933, 8996.190342869173, 9054.909450905407, 9121.179093881583, 9160.862587061332, 9163.862542062008, 5320.600954928474, 5439.5920305976415, 5545.057340252248, 5557.666540007613, 5571.275734154696, 8636.438631488933, 8830.116988301119, 8953.731388058368, 9122.90877091247, 9138.908610914072], "dojo.html": [2773.6948935617065, 2779.9444011119776, 2798.2584615076994, 2832.079574138405, 2866.455373479039, 4551.522090180525, 4700.083483720676, 4730.90538189236, 4815.0610630926985, 4825.951740482594, 4629.490756016836, 4657.604103651185, 4734.952650473494, 4771.689840160388, 4822.156122678526, 4339.7396156230725, 4420.248557745175, 4420.646348292145, 4422.447194100738, 4444.599986001259, 4407.11857628474, 4423.66822488313, 4450.554944505556, 4463.933041004388, 4470.284754439291, 4279.935800962957, 4280.336547835091, 4298.18334516444, 4335.804888780012, 4374.562543745632, 4274.978625106885, 4299.570042995707, 4322.589354011364, 4360.978195109036, 4378.64970802335, 4275.743455392655, 4281.850135245251, 4295.076558539929, 4320.870373888788, 4323.2218200723855, 4626.236670949289, 4709.152352576535, 4729.361536192604, 4737.668363214576, 4751.049790042005, 4913.950860491385, 4927.605791536705, 4985.626078044161, 4985.700857948535, 5053.090443720129, 5001.349824522825, 5021.799128034874, 5045.772940217662, 5055.469175736532, 5079.085764562377, 4628.166929952641, 4693.859184224479, 4725.787339569728, 4733.148033354029, 4733.479317275097, 5087.186050231945, 5191.299174611379, 5207.557357624644, 5208.374995000624, 5219.634625576249, 4694.50707675696, 4835.975820120877, 4844.927326090112, 4847.3698419205275, 4889.486603906538, 5047.192449208109, 5056.140456122468, 5115.462876397924, 5123.7438128093445, 5156.510131537498, 4799.136155491975, 4861.538153875376, 5048.368953880765, 5055.469175736494, 5057.8229761958155, 4929.507049295114, 4952.257161425815, 4996.675216110941, 5007.499250074963, 5008.223725322581, 3857.4406711026745, 3876.903077423087, 3883.10688541637, 3908.2769687607883, 3914.8629797957506, 3437.1922598189403, 3493.1092571394133, 3551.6270791566512, 3573.321068996934, 3576.91057723559, 4630.58324750774, 4760.047990401864, 4774.832880849153, 4787.497312782178, 4810.39870016248, 5103.770330335144, 5192.039472697563, 5207.479252074762, 5221.269022336875, 5231.659942103827, 4612.238980568236, 4818.4217893852965, 4827.61379089672, 4855.490173531799, 4908.165611845995, 4403.295472724349, 4427.446569178853, 4465.933011004838, 4503.0, 4572.497025327211, 5179.145441002268, 5187.766550505161, 5227.3465816772905, 5241.030409374278, 5306.442823503477, 4875.658703890694, 5058.696478211319, 5065.316182315488, 5113.590912727047, 5128.256402821645, 5114.053900028507, 5138.306328645585, 5156.4327923927585, 5195.76619052136, 5215.113430716711, 4924.926126108183, 4937.777799998937, 4940.950590494049, 4943.8516844494725, 4953.405591329064, 4916.582090522203, 4991.825286114969, 5014.34813474246, 5031.572316353005, 5049.0, 4945.727984960861, 4991.625628077836, 5010.298558201782, 5021.096202683552, 5028.723420211923, 4874.122657921608, 5024.874378140429, 5067.163917953497, 5080.034793389244, 5118.488151184852, 4717.764111794465, 4986.626003049858, 5009.0983622948215, 5009.198528235464, 5022.070916880389, 4855.902881942412, 4904.926426103682, 4969.751512424292, 5024.899502009866, 5037.345145131109, 4872.761781085276, 4875.488073752347, 4878.195097808822, 4898.730569818552, 4919.434265059421], "mootools.html": [1124.5333186727507, 1517.446132161761, 1594.4100682747378, 1601.823799382068, 1617.6602913388188, 6139.938600613992, 6327.0, 6714.8992765108505, 6861.279565645597, 6867.381935625793, 6669.09967154434, 6690.063391125246, 6764.966175169129, 6768.052472653832, 6792.966035169829, 1728.2827626534972, 1754.4648882090958, 1928.035982008999, 1938.3409640722152, 1940.9611807763836, 1934.0813113770917, 1937.94186174415, 1961.9509512262166, 1966.429735376739, 1966.6361723081275, 1862.264405559803, 1879.9812001879943, 1884.5759704066613, 1945.2121890634317, 1947.8636495445323, 1905.3045638341976, 1910.722945172956, 1929.6044310916368, 1933.9709904351305, 1937.7384053152925, 1864.7575815143944, 1913.0817207740363, 1913.2347061175642, 1915.7701075870984, 1917.6452356314126, 6812.080369150151, 6863.382295593371, 6872.209695884987, 6879.828004299882, 6895.34494223048, 3951.585083566242, 3999.0802115513593, 4006.4591280177387, 4022.7988600569856, 4059.817308221137, 2581.6772903387077, 2633.4206474575562, 2642.947141057168, 2644.3917898883174, 2655.468906218764, 741.9332260096617, 768.800111970886, 784.3803395317692, 847.3476720395192, 901.4095767272447, 8866.246369058637, 9029.819403611957, 9033.0, 9036.683716069905, 9037.54812259391, 3652.5616925969052, 3668.0, 3734.6452087051684, 3740.8503659853845, 3774.698024158061, 7975.042994840656, 7985.880211796828, 7994.440389172702, 7998.280154786097, 8003.119656837744, 4103.322951712934, 4191.1827193697545, 4191.664666826647, 4193.643540299109, 4195.937060944088, 3782.319182547113, 3783.754055986407, 3787.1289603390824, 3787.8295476703615, 3794.658480736747, 2923.254570084615, 3013.758899288052, 3206.8396580171366, 3220.0500852248642, 3268.2156282492033, 1023.1405619279841, 1044.7910417916446, 1045.6758404894506, 1052.321252791945, 1057.1120258982492, 1104.8342748587777, 1146.644540192543, 1172.0447835014436, 1186.2763714134371, 1197.904167666602, 6387.584806987531, 6412.64730439821, 6428.614283142932, 6505.4795616350575, 6507.642079685663, 992.2855544008303, 1035.699647102332, 1039.8492218628257, 1040.812653722322, 1048.9423081730426, 4955.851324460272, 5012.624053196025, 5059.443461219263, 5075.644704870698, 5102.413222479388, 8067.112617612058, 8232.958835205905, 8269.875951860728, 8293.377996650275, 8351.997760268807, 7941.444098913136, 8011.559364235023, 8112.310453611509, 8124.146964568753, 8185.017797864175, 6297.370262973757, 6398.936010639927, 6470.773522926769, 6474.935250647527, 6514.283428822826, 6092.39076092405, 6110.511159107172, 6190.133381326528, 6221.502279817513, 6225.035119556476, 6808.148981377328, 7243.782686519413, 7261.927380726125, 7279.381252593589, 7287.708491660486, 7355.227701091522, 7442.9255707442235, 7510.962445187739, 7533.171351151259, 7542.585157816373, 5697.6296540724725, 5827.562932779973, 5839.883202336015, 5847.415258474119, 5849.912251316148, 5700.857478562903, 5985.371535988833, 6623.735050598115, 6662.766803161866, 6684.7326106957125, 5968.104784282393, 5984.910226346521, 6001.36985616504, 6122.081687746873, 6154.476869465966, 5934.7922822701, 5951.375105613848, 5986.670733109547, 5987.43119403656, 6041.969790151197, 6045.486133678686, 6079.452849243589, 6084.148219249397, 6104.633721976518, 6177.752889884354, 5511.255980442589, 5546.500814926676, 5599.748011339418, 5610.074337734228, 5621.52217061538, 5630.915536267041, 5672.064109421899, 5673.262475878109, 5683.5453163747625, 5688.516476099578], "ext.html": [498.7730582584923, 504.06999086685056, 504.5938019893986, 515.5076901559012, 527.9049771041211, 27292.31769205771, 28741.137765867057, 28964.275893102684, 35176.47235291472, 36231.81884090583, 37914.43128353077, 38386.232275354545, 38492.61507384925, 38840.22319553614, 38844.0, 8044.839103217947, 8229.300509456703, 8233.464824786399, 8249.670013199464, 8334.041585217687, 7425.925740742605, 7620.428467864932, 9832.655857045005, 9962.551685174185, 10058.798824023515, 9770.413775173512, 9863.358881672704, 9905.554250058765, 9955.800883982316, 9984.151347135503, 7483.513571617827, 7693.615319234016, 9770.853437198448, 9825.164860986824, 9889.25830562707, 9770.0, 9932.702018939442, 9934.503274836301, 9943.055409736064, 10083.647072352505, 35570.46644300337, 36017.45973810395, 36022.819885900666, 36024.45963310552, 36046.27907441863, 2769.379912751043, 2962.348283377675, 3071.938561228763, 3143.4027534768547, 3153.1486498645236, 24445.633315500105, 25061.749382506125, 25340.0, 25870.48259034809, 26155.869220653964, 2186.2894559268143, 2189.419803752007, 2192.4190089626263, 2194.5062360968814, 2210.237468073512, 250414.0, 253884.0, 254739.0, 255453.722731387, 255621.0, 45912.3113153303, 46448.76775616168, 52970.73514632402, 53498.0, 53523.464765352626, 43621.0, 55265.72367138138, 56155.157672634945, 56212.0, 56291.08943560949, 14813.407463701331, 15049.097054176784, 15066.472673456376, 15218.16300103505, 15224.847751522564, 11525.88474115265, 11577.710557235969, 11607.013403860767, 11627.069834413227, 11756.58851940178, 17340.739888901677, 17453.7381939271, 17571.824281757275, 17576.209070591853, 17611.735823962652, 7008.404285635778, 7083.787486375417, 7143.24995875436, 7160.391366733782, 7177.497575169792, 831.8793774902605, 859.4843094143464, 930.8324501589778, 935.5556110847293, 999.605155963405, 25129.0, 25393.74606253914, 25562.23313300604, 25602.487950241262, 25676.48647027049, 836.2807985132781, 903.5708038681705, 949.6960972488737, 994.9353292035994, 1029.6653587584065, 11794.174407791545, 11999.880001199876, 12028.27830330183, 12137.332446715516, 12180.695482613006, 209963.0, 217318.0, 217877.0, 218110.0, 218232.0, 46597.06805863864, 47392.763036184595, 47455.76272118686, 47591.76204118957, 47982.520174798505, 1196.4197364278318, 1215.8905698487001, 1217.3365515793914, 1219.4817202688998, 1221.071985291185, 21586.028628711432, 23833.761662383153, 23939.401514962265, 24619.261422157364, 25835.22494325173, 41629.79185104055, 41807.1638567233, 41907.58092419037, 42211.577884221995, 42222.366664499445, 222486.0, 222852.0, 222938.0, 224412.0, 224853.0, 24247.151349702675, 24508.6323705141, 26672.333191670365, 27284.59073113865, 27572.310692232855, 35870.10324741902, 36960.815195923846, 36992.63007369892, 37070.62929370672, 37716.2456750858, 29547.556786647787, 31448.842755786074, 31530.842345789042, 31637.8418107908, 31852.5222121673, 32376.190595235308, 33329.0, 33401.83299083489, 33407.33185336231, 33863.83068084644, 30733.538996914616, 31611.525827113073, 31717.524237136924, 31718.207044824063, 31741.20646983844, 25615.743842561336, 27181.86409068021, 27535.86232068827, 27558.448831023667, 27691.72308276972, 21045.684314734986, 21211.378984568793, 21268.468288292916, 21295.78704213, 21380.893095535044], "prototype.html": [270.9837409755414, 273.4858466083762, 274.7540950848991, 275.66644360324, 284.2566688110589, 5246.449122842104, 5352.304200453946, 5363.892722145555, 5437.429069947658, 5476.479734425233, 5186.636935414523, 5238.7642556084975, 5299.205119232117, 5308.522232999029, 5355.036093503168, 3942.0, 4033.5563088060435, 4035.132446524004, 4051.8379264829373, 4090.1615168890307, 3881.573026967031, 3972.940405893914, 3975.8210880510446, 4036.616521430459, 4037.798110094498, 3962.5244970603567, 3989.5212574490956, 4009.1781184857036, 4027.879163625081, 4043.009462681647, 4024.839006439739, 4024.8591299304385, 4031.153457773871, 4036.65688416482, 4056.8580099696514, 3463.79217246966, 3466.670666286724, 3469.6356882527225, 3480.5301284326547, 3488.2674638325984, 5123.333966584358, 5139.17773156297, 5149.150390185615, 5186.896262074737, 5222.0, 4564.497905230422, 4579.038401935598, 4581.5647513486165, 4586.1744885920525, 4604.079184163181, 5551.1673249012565, 5567.081431563827, 5577.944220557783, 5586.022446071962, 5622.128570071645, 3540.663636954511, 3598.712103031751, 3607.4408466687705, 3787.4886890269736, 3796.3925771876643, 5727.971360143172, 5729.312482502085, 5788.507976822018, 5804.738786754606, 5834.824955251307, 3852.845886164578, 3854.0, 3857.787821669779, 3858.6334298241622, 3867.323218436762, 3875.7286989910435, 3888.6111388861455, 3896.8636097737012, 3926.5484469285825, 3962.742421742635, 4433.357163211316, 4534.501204867462, 4535.863924082283, 4538.818447262139, 4581.144636422255, 5624.578156638268, 5639.266895303666, 5646.717664116778, 5650.943490565041, 5694.914576281359, 1401.10329389191, 1418.6737050478448, 1419.7799341102145, 1424.017427974694, 1424.893133015028, 905.4748246017294, 917.2295271971443, 925.8750068740768, 926.1109335038304, 934.3272843552631, 5367.543758780469, 5387.164989426645, 5392.245085688007, 5408.4050754416985, 5434.429384914527, 5816.127580862904, 5821.301443826768, 5831.4168583141345, 5840.970795145997, 5897.882042359214, 5402.756875940592, 5415.675059496442, 5423.159410291332, 5425.403205647375, 5447.891042179134, 3127.37452509499, 3201.887933922348, 3229.1765599771907, 3236.0615421527496, 3237.028891332591, 5968.46283834457, 5970.9701451492465, 5995.310539287951, 6025.0, 6071.787487437919, 5935.080062590306, 5945.375735547792, 5951.226340575698, 5958.255218097738, 5988.191594134823, 5781.075027995501, 5983.521318294526, 6009.06859436788, 6017.578769486269, 6040.365761595057, 5763.452472015152, 5764.962306784651, 5777.884442311214, 5788.189653448605, 5864.44287792659, 5589.636673616202, 5666.688332141772, 5667.914981275202, 5680.40355762639, 5703.458171473703, 5884.029135192645, 5893.0, 5985.191999080069, 6025.849353766191, 6064.090386442069, 3845.0, 3879.86420475282, 3888.9805550972064, 3896.0844201613163, 3904.941425878671, 5797.014507533645, 5800.767969281182, 5807.506361959281, 5835.0, 5847.853803654943, 5449.700266485382, 5639.943600564106, 5658.066419040977, 5662.8301150965535, 5740.1102829061565, 5688.658680479019, 5688.914666280092, 5692.117721753135, 5692.715364231689, 5729.62757420783, 5571.916421253603, 5589.413111623221, 5593.356763972032, 5597.888042239214, 5601.467860553241, 5551.528120109836, 5690.174924635822, 5714.257146570919, 5716.256886604715, 5723.771049157987, 5509.5041446270025, 5517.944820551904, 5521.0, 5577.3028371453565, 5592.692401917933], "yui.html": [642.306309186079, 667.0794303860674, 674.2111729276746, 684.9965750171249, 697.9057827193329, 11837.289762614238, 12073.215241009328, 12077.214981026227, 12087.214331068475, 12092.879071209285, 10724.0, 11256.606018789344, 11351.716207094805, 11850.7629847403, 12084.093692973018, 609.2110716621963, 610.7770663707737, 748.2293237964905, 756.0851369842497, 766.1534004924562, 727.7598392530479, 736.6795443981858, 743.5501521579448, 745.3329270303076, 753.1827966656184, 768.3277132509055, 772.9072511298652, 772.98840517392, 775.6393277126135, 781.9921800781976, 634.8984162533995, 641.0512441586432, 766.4519868294141, 775.2983549887362, 789.0964845252212, 566.283651181256, 568.6360729133316, 568.9032864413018, 575.5711994564076, 575.611462262975, 11632.360220187886, 11859.288442693465, 11869.703257418547, 11983.161178717406, 12005.819912701316, 8377.120402357725, 8423.199796019368, 8543.743687689379, 8814.118588141198, 9044.321675874337, 8035.919640803576, 8181.304589109874, 8196.959015204946, 8232.753017409488, 8279.047909490426, 2540.8094392920607, 2578.6132080187936, 2583.8708064596694, 2610.464854704781, 2641.141628970573, 39893.0, 40886.59113408887, 41134.58865411337, 41223.0, 41263.793681031406, 5848.327442344185, 5984.790532331347, 6090.969545152246, 6119.5410344224365, 6243.0, 10013.148882345082, 10049.899501005042, 10067.244956628283, 10081.747956301004, 10262.076413122706, 5295.470452954673, 5417.83746487606, 5435.782568697208, 5452.91820622691, 5702.344230413555, 3322.734181265493, 3341.8496167672515, 3342.4819153031317, 3357.9160520986684, 3367.562216911786, 2430.9878450607634, 2455.0916161020536, 2455.938601534976, 2455.9631605525933, 2457.4839283750257, 370.829418467508, 372.66087860047224, 379.3607770906032, 386.7389512079391, 387.521411057344, 424.5987541772995, 435.3122067133921, 439.9880275366644, 463.9652026098056, 471.8513668194508, 6816.761413350609, 7381.409487241008, 7394.223606521346, 7471.9626401867645, 7788.598052350518, 454.9158405694957, 497.32363984980395, 549.209576779701, 550.0896017091719, 566.8922904648103, 3223.3714425687235, 3408.3864904316965, 3453.4474484082425, 3454.4768111910203, 3629.383004889175, 47800.52199477961, 48216.27675584869, 48421.75789121032, 48458.51541484611, 48641.513584864406, 41073.79463102725, 41552.37671434931, 42643.57356426458, 43279.783601082425, 43346.78326608347, 40155.39766903499, 41034.0, 41305.38041929373, 41831.99999999939, 41934.580654193065, 7124.430045596444, 7160.248173941661, 7246.855062898818, 7472.364848987897, 7661.923380766121, 30786.38427231398, 31327.21681957969, 31501.527477087402, 31562.36875262528, 31692.0, 37413.81293093517, 37807.24385512329, 38637.0, 38914.80542597269, 38921.610783891796, 6152.692365381802, 6648.933510664831, 6783.36545530399, 6858.3827455529245, 7311.707531698672, 9848.162906153057, 9971.512809275062, 9976.60093596277, 10003.449810260505, 10011.0, 9373.0, 9432.952835236054, 9445.0554944505, 9459.810803783748, 9501.0, 9044.90955090467, 9047.185753282236, 9062.909370906207, 9067.09329067088, 9149.130832570896, 9280.767980800534, 9288.767780805534, 9290.442573445614, 9394.0, 9419.105185007413, 8117.878231826646, 8138.593070346341, 8614.91385086141, 8643.308535317034, 8653.528900087127, 7920.643571039202, 7923.241108296071, 8052.0, 8339.332853371594, 8544.273736732199]}, "summary": {"lowerIsBetter": false, "suite": 5804.101858533536, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6013.405394241028, "unit": "ms", "value": 6013.405394241028}, "dojo.html": {"lowerIsBetter": false, "filtered": 4675.925836236461, "unit": "ms", "value": 4675.925836236461}, "mootools.html": {"lowerIsBetter": false, "filtered": 3901.2841171923505, "unit": "ms", "value": 3901.2841171923505}, "ext.html": {"lowerIsBetter": false, "filtered": 16347.391707492778, "unit": "ms", "value": 16347.391707492778}, "prototype.html": {"lowerIsBetter": false, "filtered": 4207.4939000217255, "unit": "ms", "value": 4207.4939000217255}, "yui.html": {"lowerIsBetter": false, "filtered": 5066.400878491833, "unit": "ms", "value": 5066.400878491833}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0031"}, "testrun": {"date": 1447319910, "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": "20151111235647", "branch": "Mozilla-Inbound", "revision": "b5a38550eaf46de5604cd541f88a6620b910e314"}}, {"talos_counters": {}, "results": {"audio-dft": [183.0, 180.0, 189.0, 184.0, 179.0, 179.0, 181.0, 182.0, 181.0, 180.0], "ai-astar": [118.0, 124.0, 119.0, 123.0, 122.0, 121.0, 121.0, 126.0, 117.0, 120.0], "imaging-gaussian-blur": [130.0, 136.0, 133.0, 129.0, 136.0, 136.0, 142.0, 139.0, 136.0, 135.0], "audio-beat-detection": [176.0, 152.0, 175.0, 190.0, 144.0, 168.0, 173.0, 146.0, 189.0, 142.0], "json-stringify-tinderbox": [72.0, 75.0, 75.0, 76.0, 83.0, 80.0, 81.0, 78.0, 77.0, 78.0], "stanford-crypto-pbkdf2": [166.0, 181.0, 188.0, 188.0, 181.0, 167.0, 171.0, 176.0, 175.0, 184.0], "json-parse-financial": [62.0, 64.0, 66.0, 65.0, 66.0, 69.0, 69.0, 78.0, 68.0, 65.0], "stanford-crypto-sha256-iterative": [78.0, 80.0, 82.0, 82.0, 84.0, 85.0, 85.0, 80.0, 80.0, 84.0], "audio-fft": [85.0, 87.0, 94.0, 136.0, 76.0, 81.0, 81.0, 81.0, 132.0, 76.0], "imaging-darkroom": [142.0, 148.0, 143.0, 141.0, 141.0, 147.0, 144.0, 142.0, 141.0, 147.0], "stanford-crypto-ccm": [156.0, 150.0, 156.0, 145.0, 141.0, 149.0, 158.0, 147.0, 150.0, 146.0], "audio-oscillator": [110.0, 110.0, 159.0, 104.0, 105.0, 103.0, 141.0, 99.0, 100.0, 142.0], "stanford-crypto-aes": [95.0, 99.0, 101.0, 102.0, 98.0, 96.0, 95.0, 96.0, 101.0, 102.0], "imaging-desaturate": [114.0, 119.0, 119.0, 115.0, 113.0, 117.0, 118.0, 116.0, 112.0, 118.0]}, "summary": {"lowerIsBetter": true, "suite": 1726.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 92.9, "unit": "ms", "value": 92.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 177.7, "unit": "ms", "value": 177.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 165.5, "unit": "ms", "value": 165.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 149.8, "unit": "ms", "value": 149.8}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 143.6, "unit": "ms", "value": 143.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 117.3, "unit": "ms", "value": 117.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 121.1, "unit": "ms", "value": 121.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 181.8, "unit": "ms", "value": 181.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 82.0, "unit": "ms", "value": 82.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 77.5, "unit": "ms", "value": 77.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 135.2, "unit": "ms", "value": 135.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 98.5, "unit": "ms", "value": 98.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 116.1, "unit": "ms", "value": 116.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0031"}, "testrun": {"date": 1447319910, "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": "20151111235647", "branch": "Mozilla-Inbound", "revision": "b5a38550eaf46de5604cd541f88a6620b910e314"}}, {"talos_counters": {}, "results": {"DeltaBlue": [224.9212775528565], "Encrypt": [361.53289949385396], "NavierStokes": [6506.493506493506], "Decrypt": [6890.41095890411], "Splay": [711.0481586402266], "Richards": [188.96447467876038], "RegExp": [33616.666666666664], "Earley": [1024.5901639344263], "Boyer": [14239.43661971831], "RayTrace": [2141.3276231263385]}, "summary": {"lowerIsBetter": false, "suite": 16170.356234373585, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 293.96062800000004, "unit": "score", "value": 293.96062800000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 736.256646, "unit": "score", "value": 736.256646}, "NavierStokes": {"lowerIsBetter": false, "filtered": 228.07984031936115, "unit": "score", "value": 228.07984031936115}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.63064214711727, "unit": "score", "value": 38.63064214711727}, "Splay": {"lowerIsBetter": false, "filtered": 114.60686454183268, "unit": "score", "value": 114.60686454183268}, "RegExp": {"lowerIsBetter": false, "filtered": 27.099206742687166, "unit": "score", "value": 27.099206742687166}, "Richards": {"lowerIsBetter": false, "filtered": 186.818184, "unit": "score", "value": 186.818184}, "Earley": {"lowerIsBetter": false, "filtered": 650.4678880000001, "unit": "score", "value": 650.4678880000001}, "Boyer": {"lowerIsBetter": false, "filtered": 46.80402868447083, "unit": "score", "value": 46.80402868447083}, "RayTrace": {"lowerIsBetter": false, "filtered": 345.574863, "unit": "score", "value": 345.574863}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0031"}, "testrun": {"date": 1447319910, "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": "20151111235647", "branch": "Mozilla-Inbound", "revision": "b5a38550eaf46de5604cd541f88a6620b910e314"}}] 01:38:47 INFO - RETURN: dromaeo_css: 5804.10 01:38:47 INFO - RETURN: kraken: 1726.20 01:38:47 INFO - RETURN: v8_7: 16170.36 01:38:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "16170.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1726.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5804.10"}}} 01:38:47 INFO - Return code: 0 01:38:47 INFO - # TBPL SUCCESS # 01:38:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:48 INFO - 2015-11-12 01:38:48.009 screenresolution[1667:11111] starting screenresolution argv=screenresolution get 01:38:48 INFO - 2015-11-12 01:38:48.013 screenresolution[1667:11111] Display 0: 1600x1200x32@60 01:38:48 INFO - 2015-11-12 01:38:48.020 screenresolution[1668:11114] starting screenresolution argv=screenresolution list 01:38:48 INFO - Available Modes on Display 0 01:38:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:48 INFO - Intel HD Graphics 3000: 01:38:48 INFO - Chipset Model: Intel HD Graphics 3000 01:38:48 INFO - Type: GPU 01:38:48 INFO - Bus: Built-In 01:38:48 INFO - VRAM (Total): 512 MB 01:38:48 INFO - VRAM (Dynamic, Max): 10 01:38:48 INFO - Vendor: Intel (0x8086) 01:38:48 INFO - Device ID: 0x0116 01:38:48 INFO - Revision ID: 0x0009 01:38:48 INFO - Displays: 01:38:48 INFO - Display: 01:38:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:48 INFO - Display Serial Number: 1600x1200 60 01:38:48 INFO - Main Display: Yes 01:38:48 INFO - Mirror: Off 01:38:48 INFO - Online: Yes 01:38:48 INFO - Rotation: Supported 01:38:48 INFO - Return code: 0 01:38:48 INFO - Running post-action listener: _resource_record_post_action 01:38:48 INFO - Running post-run listener: _resource_record_post_run 01:38:49 INFO - Total resource usage - Wall time: 1259s; CPU: 30.0%; Read bytes: 41812992; Write bytes: 687718400; Read time: 5810; Write time: 57080 01:38:49 INFO - install - Wall time: 41s; CPU: 29.0%; Read bytes: 336857600; Write bytes: 334563328; Read time: 34820; Write time: 5123 01:38:49 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 40780800; Write bytes: 342743040; Read time: 5267; Write time: 51074 01:38:49 INFO - Running post-run listener: _upload_blobber_files 01:38:49 INFO - Blob upload gear active. 01:38:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:38:49 INFO - Copying logs to upload dir... 01:38:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1341.716570 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-12 01:38:49.454682) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 01:38:49.458742) ========= 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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009926 build_url: 'https://queue.taskcluster.net/v1/task/J8bBacSFTkakE24d4XOOKg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 01:38:49.486123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:38:49.486592) ========= 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.Js6iJRMCmA/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.vcjqRR6yzH/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.005366 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 01:38:49.539331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 01:38:49.540072) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 01:38:49.541011) ========= ========= Total master_lag: 0.88 =========