builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0061 starttime: 1447563843.24 results: success (0) buildid: 20151114194733 builduid: a0ac9b5f21b24b58be31afbbf5dfa81a revision: 0f6a404c8d78a4a9a38f1078424a7f33643019a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.235693) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.236210) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.237004) ========= 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.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.006256 basedir: '/builds/slave/test' ========= master_lag: 0.37 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.615826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.616288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.826916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.827278) ========= 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.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.033016 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.881180) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.881593) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.882222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:03.882585) ========= 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.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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-14 21:04:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.1M=0s 2015-11-14 21:04:04 (27.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.239929 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.170245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.170614) ========= 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.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.091881 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.281097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.281579) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0f6a404c8d78a4a9a38f1078424a7f33643019a4 --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 0f6a404c8d78a4a9a38f1078424a7f33643019a4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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-14 21:04:04,375 truncating revision to first 12 chars 2015-11-14 21:04:04,375 Setting DEBUG logging. 2015-11-14 21:04:04,375 attempt 1/10 2015-11-14 21:04:04,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0f6a404c8d78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 21:04:04,644 unpacking tar archive at: mozilla-inbound-0f6a404c8d78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.865281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.865717) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.883726) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.884085) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 21:04:04.884623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2015-11-14 21:04:04.885013) ========= /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.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:04:05 INFO - MultiFileLogger online at 20151114 21:04:05 in /builds/slave/test 21:04:05 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 21:04:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:04:05 INFO - {'append_to_log': False, 21:04:05 INFO - 'base_work_dir': '/builds/slave/test', 21:04:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:04:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:04:05 INFO - 'branch': 'Mozilla-Inbound', 21:04:05 INFO - 'buildbot_json_path': 'buildprops.json', 21:04:05 INFO - 'config_files': ('talos/mac_config.py',), 21:04:05 INFO - 'default_actions': ('clobber', 21:04:05 INFO - 'read-buildbot-config', 21:04:05 INFO - 'download-and-extract', 21:04:05 INFO - 'populate-webroot', 21:04:05 INFO - 'create-virtualenv', 21:04:05 INFO - 'install', 21:04:05 INFO - 'run-tests'), 21:04:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:04:05 INFO - 'download_minidump_stackwalk': True, 21:04:05 INFO - 'download_symbols': 'ondemand', 21:04:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:04:05 INFO - 'tooltool.py': '/tools/tooltool.py', 21:04:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:04:05 INFO - '/tools/misc-python/virtualenv.py')}, 21:04:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:04:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:04:05 INFO - 'installer_path': 'installer.exe', 21:04:05 INFO - 'log_level': 'info', 21:04:05 INFO - 'log_name': 'talos', 21:04:05 INFO - 'log_to_console': True, 21:04:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:04:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:04:05 INFO - 'opt_config_files': (), 21:04:05 INFO - 'pip_index': False, 21:04:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:04:05 INFO - 'cmd': ('bash', 21:04:05 INFO - '-c', 21:04:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:04:05 INFO - 'enabled': True, 21:04:05 INFO - 'halt_on_failure': False, 21:04:05 INFO - 'name': 'check_screen_resolution'},), 21:04:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:04:05 INFO - 'cmd': ('bash', 21:04:05 INFO - '-c', 21:04:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:04:05 INFO - 'enabled': True, 21:04:05 INFO - 'halt_on_failure': False, 21:04:05 INFO - 'name': 'check_screen_resolution'},), 21:04:05 INFO - 'run_cmd_checks_enabled': True, 21:04:05 INFO - 'sps_profile': False, 21:04:05 INFO - 'sps_profile_interval': 0, 21:04:05 INFO - 'suite': 'dromaeojs', 21:04:05 INFO - 'system_bits': '64', 21:04:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:04:05 INFO - 'title': 't-yosemite-r5-0061', 21:04:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:04:05 INFO - 'use_talos_json': True, 21:04:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:04:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:04:05 INFO - 'work_dir': 'build'} 21:04:05 INFO - ##### 21:04:05 INFO - ##### Running clobber step. 21:04:05 INFO - ##### 21:04:05 INFO - Running pre-action listener: _resource_record_pre_action 21:04:05 INFO - Running main action method: clobber 21:04:05 INFO - rmtree: /builds/slave/test/build 21:04:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:04:09 INFO - Running post-action listener: _resource_record_post_action 21:04:09 INFO - ##### 21:04:09 INFO - ##### Running read-buildbot-config step. 21:04:09 INFO - ##### 21:04:09 INFO - Running pre-action listener: _resource_record_pre_action 21:04:09 INFO - Running main action method: read_buildbot_config 21:04:09 INFO - Using buildbot properties: 21:04:09 INFO - { 21:04:09 INFO - "properties": { 21:04:09 INFO - "buildnumber": 3419, 21:04:09 INFO - "product": "firefox", 21:04:09 INFO - "script_repo_revision": "production", 21:04:09 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 21:04:09 INFO - "repository": "", 21:04:09 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 21:04:09 INFO - "buildid": "20151114194733", 21:04:09 INFO - "slavename": "t-yosemite-r5-0061", 21:04:09 INFO - "pgo_build": "False", 21:04:09 INFO - "basedir": "/builds/slave/test", 21:04:09 INFO - "project": "", 21:04:09 INFO - "platform": "yosemite", 21:04:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:04:09 INFO - "slavebuilddir": "test", 21:04:09 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 21:04:09 INFO - "branch": "mozilla-inbound", 21:04:09 INFO - "repo_path": "integration/mozilla-inbound", 21:04:09 INFO - "stage_platform": "macosx64", 21:04:09 INFO - "builduid": "a0ac9b5f21b24b58be31afbbf5dfa81a", 21:04:09 INFO - "revision": "0f6a404c8d78a4a9a38f1078424a7f33643019a4" 21:04:09 INFO - }, 21:04:09 INFO - "sourcestamp": { 21:04:09 INFO - "repository": "", 21:04:09 INFO - "hasPatch": false, 21:04:09 INFO - "project": "", 21:04:09 INFO - "branch": "mozilla-inbound-macosx64-talos", 21:04:09 INFO - "changes": [ 21:04:09 INFO - { 21:04:09 INFO - "category": null, 21:04:09 INFO - "files": [ 21:04:09 INFO - { 21:04:09 INFO - "url": null, 21:04:09 INFO - "name": "https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 21:04:09 INFO - } 21:04:09 INFO - ], 21:04:09 INFO - "repository": "", 21:04:09 INFO - "rev": "0f6a404c8d78a4a9a38f1078424a7f33643019a4", 21:04:09 INFO - "who": "mozilla@christophkerschbaumer.com", 21:04:09 INFO - "when": 1447563721, 21:04:09 INFO - "number": 6663027, 21:04:09 INFO - "comments": "Bug 663570 - Update passing web-platform tests for meta csp (r=sicking)", 21:04:09 INFO - "project": "", 21:04:09 INFO - "at": "Sat 14 Nov 2015 21:02:01", 21:04:09 INFO - "branch": "mozilla-inbound-macosx64-talos", 21:04:09 INFO - "revlink": "", 21:04:09 INFO - "properties": [ 21:04:09 INFO - [ 21:04:09 INFO - "buildid", 21:04:09 INFO - "20151114194733", 21:04:09 INFO - "Change" 21:04:09 INFO - ], 21:04:09 INFO - [ 21:04:09 INFO - "builduid", 21:04:09 INFO - "a0ac9b5f21b24b58be31afbbf5dfa81a", 21:04:09 INFO - "Change" 21:04:09 INFO - ], 21:04:09 INFO - [ 21:04:09 INFO - "pgo_build", 21:04:09 INFO - "False", 21:04:09 INFO - "Change" 21:04:09 INFO - ] 21:04:09 INFO - ], 21:04:09 INFO - "revision": "0f6a404c8d78a4a9a38f1078424a7f33643019a4" 21:04:09 INFO - } 21:04:09 INFO - ], 21:04:09 INFO - "revision": "0f6a404c8d78a4a9a38f1078424a7f33643019a4" 21:04:09 INFO - } 21:04:09 INFO - } 21:04:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 21:04:09 INFO - Running post-action listener: _resource_record_post_action 21:04:09 INFO - ##### 21:04:09 INFO - ##### Running download-and-extract step. 21:04:09 INFO - ##### 21:04:09 INFO - Running pre-action listener: _resource_record_pre_action 21:04:09 INFO - Running main action method: download_and_extract 21:04:09 INFO - mkdir: /builds/slave/test/build/tests 21:04:09 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')]} 21:04:09 INFO - https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:04:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/test_packages.json 21:04:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/test_packages.json 21:04:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:04:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:04:31 INFO - Downloaded 1149 bytes. 21:04:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:04:31 INFO - Using the following test package requirements: 21:04:31 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:04:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:04:31 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 21:04:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:04:31 INFO - u'jsshell-mac.zip'], 21:04:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:04:31 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 21:04:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:04:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:04:31 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 21:04:31 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:04:31 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 21:04:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:04:31 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 21:04:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:04:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:04:31 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 21:04:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:04: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')]} 21:04:31 INFO - https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/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 21:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/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 21:04:39 INFO - Downloaded 17464012 bytes. 21:04:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 21:04:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:04:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:04:45 INFO - Return code: 0 21:04:45 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 21:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:45 INFO - https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/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 21:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/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 21:04:46 INFO - Downloaded 17464012 bytes. 21:04:46 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 21:04:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:04:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:04:52 INFO - Return code: 0 21:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:04:52 INFO - https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:04:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:04:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:04:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/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 21:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/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 21:04:53 INFO - Downloaded 11131693 bytes. 21:04:53 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 21:04:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:04:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 21:04:53 INFO - Return code: 0 21:04:53 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')]} 21:04:53 INFO - https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 21:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YMFGrsHfTCa3fNukodV3kw/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 21:04:57 INFO - Downloaded 108671062 bytes. 21:04:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:04:57 INFO - mkdir: /builds/slave/test/properties 21:04:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:04:57 INFO - Writing to file /builds/slave/test/properties/build_url 21:04:57 INFO - Contents: 21:04:57 INFO - build_url:https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:04:57 INFO - Running post-action listener: _resource_record_post_action 21:04:57 INFO - Running post-action listener: set_extra_try_arguments 21:04:57 INFO - ##### 21:04:57 INFO - ##### Running populate-webroot step. 21:04:57 INFO - ##### 21:04:57 INFO - Running pre-action listener: _resource_record_pre_action 21:04:57 INFO - Running main action method: populate_webroot 21:04:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:04:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:04:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:04:57 INFO - '../fennec_ids.txt'], 21:04:57 INFO - 'tests': ['tcheck2']}, 21:04:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:04:57 INFO - '--tppagecycles', 21:04:57 INFO - '7'], 21:04:57 INFO - 'tests': ['tsvgm']}}, 21:04:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:04:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:04:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:04:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:04:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'tests': ['damp', 'tps']}, 21:04:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['damp', 'tps']}, 21:04:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:04:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:04:57 INFO - 'other': {'tests': ['a11yr', 21:04:57 INFO - 'ts_paint', 21:04:57 INFO - 'tpaint', 21:04:57 INFO - 'sessionrestore', 21:04:57 INFO - 'sessionrestore_no_auto_restore']}, 21:04:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['a11yr', 21:04:57 INFO - 'ts_paint', 21:04:57 INFO - 'tpaint', 21:04:57 INFO - 'sessionrestore', 21:04:57 INFO - 'sessionrestore_no_auto_restore']}, 21:04:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['a11yr', 21:04:57 INFO - 'ts_paint', 21:04:57 INFO - 'tpaint', 21:04:57 INFO - 'sessionrestore', 21:04:57 INFO - 'sessionrestore_no_auto_restore']}, 21:04:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['a11yr', 21:04:57 INFO - 'ts_paint', 21:04:57 INFO - 'tpaint', 21:04:57 INFO - 'sessionrestore', 21:04:57 INFO - 'sessionrestore_no_auto_restore']}, 21:04:57 INFO - 'other_l64': {'tests': ['a11yr', 21:04:57 INFO - 'ts_paint', 21:04:57 INFO - 'tpaint', 21:04:57 INFO - 'sessionrestore', 21:04:57 INFO - 'sessionrestore_no_auto_restore']}, 21:04:57 INFO - 'other_nol64': {'tests': ['a11yr', 21:04:57 INFO - 'ts_paint', 21:04:57 INFO - 'tpaint', 21:04:57 INFO - 'sessionrestore', 21:04:57 INFO - 'sessionrestore_no_auto_restore']}, 21:04:57 INFO - 'svgr': {'tests': ['tsvgx', 21:04:57 INFO - 'tsvgr_opacity', 21:04:57 INFO - 'tart', 21:04:57 INFO - 'tscrollx', 21:04:57 INFO - 'cart']}, 21:04:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['tsvgx', 21:04:57 INFO - 'tsvgr_opacity', 21:04:57 INFO - 'tart', 21:04:57 INFO - 'tscrollx', 21:04:57 INFO - 'cart']}, 21:04:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'tests': ['tp5o']}, 21:04:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'talos_options': ['--e10s'], 21:04:57 INFO - 'tests': ['tp5o']}, 21:04:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'talos_options': ['--xperf_path', 21:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:57 INFO - 'tests': ['tp5n']}, 21:04:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:57 INFO - 'talos_options': ['--e10s', 21:04:57 INFO - '--xperf_path', 21:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:57 INFO - 'tests': ['tp5n']}}, 21:04:57 INFO - 'talos.zip': {'path': '', 21:04:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:04:57 INFO - Running post-action listener: _resource_record_post_action 21:04:57 INFO - ##### 21:04:57 INFO - ##### Running create-virtualenv step. 21:04:57 INFO - ##### 21:04:57 INFO - Running pre-action listener: _resource_record_pre_action 21:04:57 INFO - Running main action method: create_virtualenv 21:04:57 INFO - Creating virtualenv /builds/slave/test/build/venv 21:04:57 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 21:04:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:04:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:04:57 INFO - Using real prefix '/tools/python27' 21:04:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:04:58 INFO - Installing distribute.............................................................................................................................................................................................done. 21:05:02 INFO - Installing pip.................done. 21:05:02 INFO - Return code: 0 21:05:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:02 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 0x10fe6e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc81664460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, '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.cJziLkNlCJ/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.xmAKcghXCk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:05:02 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 21:05:02 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 21:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:05:02 INFO - 'HOME': '/Users/cltbld', 21:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:05:02 INFO - 'LOGNAME': 'cltbld', 21:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:02 INFO - 'MOZ_NO_REMOTE': '1', 21:05:02 INFO - 'NO_EM_RESTART': '1', 21:05:02 INFO - 'PAGER': '/bin/cat', 21:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:02 INFO - 'PWD': '/builds/slave/test', 21:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:05:02 INFO - 'SHELL': '/bin/bash', 21:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:05:02 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:05:02 INFO - 'USER': 'cltbld', 21:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:02 INFO - 'XPC_FLAGS': '0x0', 21:05:02 INFO - 'XPC_SERVICE_NAME': '0', 21:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:03 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 21:05:03 INFO - Cleaning up... 21:05:03 INFO - Return code: 0 21:05:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10fe6e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc81664460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, '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.cJziLkNlCJ/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.xmAKcghXCk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:05:03 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 21:05:03 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 21:05:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:05:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:05:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:05:03 INFO - 'HOME': '/Users/cltbld', 21:05:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:05:03 INFO - 'LOGNAME': 'cltbld', 21:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:03 INFO - 'MOZ_NO_REMOTE': '1', 21:05:03 INFO - 'NO_EM_RESTART': '1', 21:05:03 INFO - 'PAGER': '/bin/cat', 21:05:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:03 INFO - 'PWD': '/builds/slave/test', 21:05:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:05:03 INFO - 'SHELL': '/bin/bash', 21:05:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:05:03 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:05:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:05:03 INFO - 'USER': 'cltbld', 21:05:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:05:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:03 INFO - 'XPC_FLAGS': '0x0', 21:05:03 INFO - 'XPC_SERVICE_NAME': '0', 21:05:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:03 INFO - Downloading/unpacking psutil>=0.7.1 21:05:03 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 21:05:03 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 21:05:03 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 21:05:03 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 21:05:03 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 21:05:03 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 21:05:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:05:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:05:06 INFO - Installing collected packages: psutil 21:05:06 INFO - Running setup.py install for psutil 21:05:06 INFO - building 'psutil._psutil_osx' extension 21:05:06 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 21:05:08 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 21:05:08 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 21:05:09 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 21:05:09 INFO - building 'psutil._psutil_posix' extension 21:05:09 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 21:05:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:05:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:05:09 INFO - ^ 21:05:09 INFO - 1 warning generated. 21:05:09 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 21:05:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:05:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:05:09 INFO - Successfully installed psutil 21:05:09 INFO - Cleaning up... 21:05:09 INFO - Return code: 0 21:05:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:05:09 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')]} 21:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:09 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')]} 21:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:09 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 0x10fe6e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc81664460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, '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.cJziLkNlCJ/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.xmAKcghXCk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:05:09 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 21:05:09 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 21:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:05:09 INFO - 'HOME': '/Users/cltbld', 21:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:05:09 INFO - 'LOGNAME': 'cltbld', 21:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:09 INFO - 'MOZ_NO_REMOTE': '1', 21:05:09 INFO - 'NO_EM_RESTART': '1', 21:05:09 INFO - 'PAGER': '/bin/cat', 21:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:09 INFO - 'PWD': '/builds/slave/test', 21:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:05:09 INFO - 'SHELL': '/bin/bash', 21:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:05:09 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:05:09 INFO - 'USER': 'cltbld', 21:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:09 INFO - 'XPC_FLAGS': '0x0', 21:05:09 INFO - 'XPC_SERVICE_NAME': '0', 21:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:05:10 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 21:05:10 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 21:05:10 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 21:05:10 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 21:05:10 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 21:05:10 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 21:05:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:05:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:05:13 INFO - Installing collected packages: mozsystemmonitor 21:05:13 INFO - Running setup.py install for mozsystemmonitor 21:05:13 INFO - Successfully installed mozsystemmonitor 21:05:13 INFO - Cleaning up... 21:05:13 INFO - Return code: 0 21:05:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:05:13 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')]} 21:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:13 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')]} 21:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:13 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 0x10fe6e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc81664460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, '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.cJziLkNlCJ/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.xmAKcghXCk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:05:13 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 21:05:13 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 21:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:05:13 INFO - 'HOME': '/Users/cltbld', 21:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:05:13 INFO - 'LOGNAME': 'cltbld', 21:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:13 INFO - 'MOZ_NO_REMOTE': '1', 21:05:13 INFO - 'NO_EM_RESTART': '1', 21:05:13 INFO - 'PAGER': '/bin/cat', 21:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:13 INFO - 'PWD': '/builds/slave/test', 21:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:05:13 INFO - 'SHELL': '/bin/bash', 21:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:05:13 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:05:13 INFO - 'USER': 'cltbld', 21:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:13 INFO - 'XPC_FLAGS': '0x0', 21:05:13 INFO - 'XPC_SERVICE_NAME': '0', 21:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:05:13 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 21:05:13 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 21:05:13 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 21:05:13 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 21:05:13 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 21:05:13 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 21:05:16 INFO - Downloading blobuploader-1.2.4.tar.gz 21:05:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:05:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:05:16 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 21:05:16 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 21:05:16 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 21:05:16 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 21:05:16 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 21:05:16 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 21:05:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:05:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:17 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 21:05:17 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 21:05:17 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 21:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:17 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 21:05:17 INFO - Downloading docopt-0.6.1.tar.gz 21:05:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:05:17 INFO - Installing collected packages: blobuploader, requests, docopt 21:05:17 INFO - Running setup.py install for blobuploader 21:05:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:05:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:05:18 INFO - Running setup.py install for requests 21:05:18 INFO - Running setup.py install for docopt 21:05:18 INFO - Successfully installed blobuploader requests docopt 21:05:18 INFO - Cleaning up... 21:05:18 INFO - Return code: 0 21:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:05:18 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')]} 21:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:18 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')]} 21:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:18 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 0x10fe6e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc81664460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, '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.cJziLkNlCJ/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.xmAKcghXCk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:05:18 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 21:05:18 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 21:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:05:18 INFO - 'HOME': '/Users/cltbld', 21:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:05:18 INFO - 'LOGNAME': 'cltbld', 21:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:18 INFO - 'MOZ_NO_REMOTE': '1', 21:05:18 INFO - 'NO_EM_RESTART': '1', 21:05:18 INFO - 'PAGER': '/bin/cat', 21:05:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:18 INFO - 'PWD': '/builds/slave/test', 21:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:05:18 INFO - 'SHELL': '/bin/bash', 21:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:05:18 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:05:18 INFO - 'USER': 'cltbld', 21:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:18 INFO - 'XPC_FLAGS': '0x0', 21:05:18 INFO - 'XPC_SERVICE_NAME': '0', 21:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:05:19 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-CFqryX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:05:19 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-eOWZWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:05:19 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-OKHDyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:05:19 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-dB4FHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:05:19 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-rEfRxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:05:19 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-QzfDxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:05:20 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-HLvG7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:05:20 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-u0qGzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:05:20 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-HOFBEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:05:20 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-w7Thsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:05:20 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-7gax5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:05:20 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-xzNIly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:05:20 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-OZFEcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:05:21 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-nFnlBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:21 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-u2Ma7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:05:21 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-JzZKBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:05:21 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-tRNlIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:05:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:05:21 INFO - Running setup.py install for manifestparser 21:05:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:05:21 INFO - Running setup.py install for mozcrash 21:05:22 INFO - Running setup.py install for mozdebug 21:05:22 INFO - Running setup.py install for mozdevice 21:05:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:05:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:05:22 INFO - Running setup.py install for mozfile 21:05:22 INFO - Running setup.py install for mozhttpd 21:05:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:05:22 INFO - Running setup.py install for mozinfo 21:05:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:05:23 INFO - Running setup.py install for mozInstall 21:05:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:05:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:05:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:05:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:05:23 INFO - Running setup.py install for mozleak 21:05:23 INFO - Running setup.py install for mozlog 21:05:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:05:23 INFO - Running setup.py install for moznetwork 21:05:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:05:23 INFO - Running setup.py install for mozprocess 21:05:24 INFO - Running setup.py install for mozprofile 21:05:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:05:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:05:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:05:24 INFO - Running setup.py install for mozrunner 21:05:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:05:24 INFO - Running setup.py install for mozscreenshot 21:05:24 INFO - Running setup.py install for moztest 21:05:24 INFO - Running setup.py install for mozversion 21:05:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:05:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:05:25 INFO - Cleaning up... 21:05:25 INFO - Return code: 0 21:05:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:25 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 0x10fe6e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc81664460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, '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.cJziLkNlCJ/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.xmAKcghXCk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:05:25 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 21:05:25 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 21:05:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:05:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:05:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:05:25 INFO - 'HOME': '/Users/cltbld', 21:05:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:05:25 INFO - 'LOGNAME': 'cltbld', 21:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:25 INFO - 'MOZ_NO_REMOTE': '1', 21:05:25 INFO - 'NO_EM_RESTART': '1', 21:05:25 INFO - 'PAGER': '/bin/cat', 21:05:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:25 INFO - 'PWD': '/builds/slave/test', 21:05:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:05:25 INFO - 'SHELL': '/bin/bash', 21:05:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:05:25 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:05:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:05:25 INFO - 'USER': 'cltbld', 21:05:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:05:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:25 INFO - 'XPC_FLAGS': '0x0', 21:05:25 INFO - 'XPC_SERVICE_NAME': '0', 21:05:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:05:25 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-pi6vUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:05:25 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)) 21:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:05:25 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-zlkW2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:05:25 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)) 21:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:05:25 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-g42hnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:05:25 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)) 21:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:05:25 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-IJtrG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:05:26 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)) 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:05:26 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-OjuEHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:05:26 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)) 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:05:26 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-3WYIoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:05:26 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)) 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:05:26 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-eLKERW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:05:26 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)) 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:05:26 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-md4_68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:05:26 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)) 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:05:26 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-FoBsnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:05:26 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)) 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:05:26 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-diyDWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:05:26 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)) 21:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:05:26 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-189hr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:05:27 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)) 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:05:27 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-EFGFgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:05:27 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)) 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:05:27 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-_gVmZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:05:27 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)) 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:05:27 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-0hEjNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:05:27 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)) 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:27 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-sTL5OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:05:27 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)) 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:05:27 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-nE25el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:05:27 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)) 21:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:05:27 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-rdrpso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:05:27 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)) 21:05:27 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)) 21:05:27 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)) 21:05:27 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)) 21:05:27 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)) 21:05:27 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)) 21:05:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:05:27 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 21:05:27 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 21:05:27 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 21:05:27 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 21:05:27 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 21:05:27 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 21:05:30 INFO - Downloading blessings-1.5.1.tar.gz 21:05:30 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 21:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:05:30 INFO - Installing collected packages: blessings 21:05:30 INFO - Running setup.py install for blessings 21:05:31 INFO - Successfully installed blessings 21:05:31 INFO - Cleaning up... 21:05:31 INFO - Return code: 0 21:05:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:05:31 INFO - Reading from file tmpfile_stdout 21:05:31 INFO - Current package versions: 21:05:31 INFO - blessings == 1.5.1 21:05:31 INFO - blobuploader == 1.2.4 21:05:31 INFO - docopt == 0.6.1 21:05:31 INFO - manifestparser == 1.1 21:05:31 INFO - mozInstall == 1.12 21:05:31 INFO - mozcrash == 0.16 21:05:31 INFO - mozdebug == 0.1 21:05:31 INFO - mozdevice == 0.47 21:05:31 INFO - mozfile == 1.2 21:05:31 INFO - mozhttpd == 0.7 21:05:31 INFO - mozinfo == 0.9 21:05:31 INFO - mozleak == 0.1 21:05:31 INFO - mozlog == 3.0 21:05:31 INFO - moznetwork == 0.27 21:05:31 INFO - mozprocess == 0.22 21:05:31 INFO - mozprofile == 0.27 21:05:31 INFO - mozrunner == 6.11 21:05:31 INFO - mozscreenshot == 0.1 21:05:31 INFO - mozsystemmonitor == 0.0 21:05:31 INFO - moztest == 0.7 21:05:31 INFO - mozversion == 1.4 21:05:31 INFO - psutil == 3.1.1 21:05:31 INFO - requests == 1.2.3 21:05:31 INFO - wsgiref == 0.1.2 21:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:05: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')]} 21:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05: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')]} 21:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe6e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc81664460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, '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.cJziLkNlCJ/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.xmAKcghXCk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 21:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:05:31 INFO - 'HOME': '/Users/cltbld', 21:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:05:31 INFO - 'LOGNAME': 'cltbld', 21:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:31 INFO - 'MOZ_NO_REMOTE': '1', 21:05:31 INFO - 'NO_EM_RESTART': '1', 21:05:31 INFO - 'PAGER': '/bin/cat', 21:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:31 INFO - 'PWD': '/builds/slave/test', 21:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:05:31 INFO - 'SHELL': '/bin/bash', 21:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:05:31 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:05:31 INFO - 'USER': 'cltbld', 21:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:31 INFO - 'XPC_FLAGS': '0x0', 21:05:31 INFO - 'XPC_SERVICE_NAME': '0', 21:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:05:31 INFO - Cleaning up... 21:05:31 INFO - Return code: 0 21:05:31 INFO - Running post-action listener: _resource_record_post_action 21:05:31 INFO - Running post-action listener: _start_resource_monitoring 21:05:31 INFO - Starting resource monitoring. 21:05:31 INFO - ##### 21:05:31 INFO - ##### Running install step. 21:05:31 INFO - ##### 21:05:31 INFO - Running pre-action listener: _resource_record_pre_action 21:05:31 INFO - Running main action method: install 21:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:05:32 INFO - Reading from file tmpfile_stdout 21:05:32 INFO - Detecting whether we're running mozinstall >=1.0... 21:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:05:32 INFO - Reading from file tmpfile_stdout 21:05:32 INFO - Output received: 21:05:32 INFO - Usage: mozinstall [options] installer 21:05:32 INFO - Options: 21:05:32 INFO - -h, --help show this help message and exit 21:05:32 INFO - -d DEST, --destination=DEST 21:05:32 INFO - Directory to install application into. [default: 21:05:32 INFO - "/builds/slave/test"] 21:05:32 INFO - --app=APP Application being installed. [default: firefox] 21:05:32 INFO - mkdir: /builds/slave/test/build/application 21:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:06:15 INFO - Reading from file tmpfile_stdout 21:06:15 INFO - Output received: 21:06:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:06:15 INFO - Running post-action listener: _resource_record_post_action 21:06:15 INFO - ##### 21:06:15 INFO - ##### Running run-tests step. 21:06:15 INFO - ##### 21:06:15 INFO - Running pre-action listener: _resource_record_pre_action 21:06:15 INFO - Running main action method: run_tests 21:06:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:06:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:06:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:06:15 INFO - 2015-11-14 21:06:15.430 screenresolution[1636:8270] starting screenresolution argv=screenresolution get 21:06:15 INFO - 2015-11-14 21:06:15.433 screenresolution[1636:8270] Display 0: 1600x1200x32@60 21:06:15 INFO - 2015-11-14 21:06:15.440 screenresolution[1637:8272] starting screenresolution argv=screenresolution list 21:06:15 INFO - Available Modes on Display 0 21:06:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:06:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:06:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:06:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:06:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:06:15 INFO - Intel HD Graphics 3000: 21:06:15 INFO - Chipset Model: Intel HD Graphics 3000 21:06:15 INFO - Type: GPU 21:06:15 INFO - Bus: Built-In 21:06:15 INFO - VRAM (Total): 512 MB 21:06:15 INFO - VRAM (Dynamic, Max): 10 21:06:15 INFO - Vendor: Intel (0x8086) 21:06:15 INFO - Device ID: 0x0116 21:06:15 INFO - Revision ID: 0x0009 21:06:15 INFO - Displays: 21:06:15 INFO - Display: 21:06:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:06:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:06:15 INFO - Display Serial Number: 1600x1200 60 21:06:15 INFO - Main Display: Yes 21:06:15 INFO - Mirror: Off 21:06:15 INFO - Online: Yes 21:06:15 INFO - Rotation: Supported 21:06:15 INFO - Return code: 0 21:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:06:15 INFO - Python 2.7.3 21:06:15 INFO - Return code: 0 21:06:15 INFO - grabbing minidump binary from tooltool 21:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:15 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 0x10fd919f0>, '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 0x10faf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd858c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:06:15 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 21:06:15 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 21:06:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:06:15 INFO - Return code: 0 21:06:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:06:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:06:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:06:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:06:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:06:15 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/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0061', '--webServer', 'localhost'] in /builds/slave/test/build 21:06:15 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/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0061 --webServer localhost 21:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cJziLkNlCJ/Render', 21:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:15 INFO - 'HOME': '/Users/cltbld', 21:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:15 INFO - 'LOGNAME': 'cltbld', 21:06:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:06:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:15 INFO - 'MOZ_NO_REMOTE': '1', 21:06:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:06:15 INFO - 'NO_EM_RESTART': '1', 21:06:15 INFO - 'PAGER': '/bin/cat', 21:06:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:15 INFO - 'PWD': '/builds/slave/test', 21:06:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:15 INFO - 'SHELL': '/bin/bash', 21:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xmAKcghXCk/Listeners', 21:06:15 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 21:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:15 INFO - 'USER': 'cltbld', 21:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:15 INFO - 'XPC_FLAGS': '0x0', 21:06:15 INFO - 'XPC_SERVICE_NAME': '0', 21:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:06:15 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/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0061', '--webServer', 'localhost'] with output_timeout 3600 21:06:16 INFO - mozversion INFO | application_buildid: 20151114194733 21:06:16 INFO - mozversion INFO | application_changeset: 0f6a404c8d78a4a9a38f1078424a7f33643019a4 21:06:16 INFO - mozversion INFO | application_display_name: Nightly 21:06:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:06:16 INFO - mozversion INFO | application_name: Firefox 21:06:16 INFO - mozversion INFO | application_remotingname: firefox 21:06:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:06:16 INFO - mozversion INFO | application_vendor: Mozilla 21:06:16 INFO - mozversion INFO | application_version: 45.0a1 21:06:16 INFO - mozversion INFO | platform_buildid: 20151114194733 21:06:16 INFO - mozversion INFO | platform_changeset: 0f6a404c8d78a4a9a38f1078424a7f33643019a4 21:06:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:06:16 INFO - mozversion INFO | platform_version: 45.0a1 21:06:16 INFO - 2015-11-14 21:06:16,273 DEBUG : using testdate: 1447563976 21:06:16 INFO - 2015-11-14 21:06:16,273 DEBUG : actual date: 1447563976 21:06:16 INFO - 2015-11-14 21:06:16,283 INFO : starting webserver on 'localhost:49264' 21:06:16 INFO - 2015-11-14 21:06:16,284 INFO : Starting test suite t-yosemite-r5-0061 21:06:16 INFO - 2015-11-14 21:06:16,284 INFO : Starting test dromaeo_css 21:06:16 INFO - 2015-11-14 21:06:16,284 DEBUG : operating with platform_type : mac_ 21:06:16 INFO - 2015-11-14 21:06:16,285 INFO : Initialising browser for dromaeo_css test... 21:06:16 INFO - 2015-11-14 21:06:16,313 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpRZdou1/profile http://localhost:49264/getInfo.html 21:06:19 INFO - 2015-11-14 21:06:19,996 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:06:19 INFO - 2015-11-14 21:06:19,997 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:06:19 INFO - 2015-11-14 21:06:19,997 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:06:19 INFO - 2015-11-14 21:06:19,997 DEBUG : BROWSER_OUTPUT: __metrics 21:06:20 INFO - 2015-11-14 21:06:20,017 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:06:20 INFO - 2015-11-14 21:06:20,831 INFO : Browser initialized. 21:06:20 INFO - 2015-11-14 21:06:20,832 INFO : Running cycle 1/1 for dromaeo_css test... 21:06:20 INFO - 2015-11-14 21:06:20,832 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpRZdou1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:06:33 INFO - 2015-11-14 21:06:33,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 228126720 21:06:33 INFO - 2015-11-14 21:06:33,119 DEBUG : BROWSER_OUTPUT: 21:07:24 INFO - 2015-11-14 21:07:24,997 DEBUG : BROWSER_OUTPUT: 1447564044989 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] 21:09:35 INFO - 2015-11-14 21:09:35,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 21:09:36 INFO - 2015-11-14 21:09:36,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 331628544 21:09:36 INFO - 2015-11-14 21:09:36,473 DEBUG : BROWSER_OUTPUT: 21:12:39 INFO - 2015-11-14 21:12:39,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 21:12:39 INFO - 2015-11-14 21:12:39,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 355581952 21:12:39 INFO - 2015-11-14 21:12:39,979 DEBUG : BROWSER_OUTPUT: 21:15:42 INFO - 2015-11-14 21:15:42,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 21:15:42 INFO - 2015-11-14 21:15:42,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 322318336 21:15:42 INFO - 2015-11-14 21:15:42,866 DEBUG : BROWSER_OUTPUT: 21:18:45 INFO - 2015-11-14 21:18:45,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 21:18:45 INFO - 2015-11-14 21:18:45,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 317411328 21:18:45 INFO - 2015-11-14 21:18:45,683 DEBUG : BROWSER_OUTPUT: 21:21:49 INFO - 2015-11-14 21:21:49,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 21:21:49 INFO - 2015-11-14 21:21:49,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 320315392 21:21:49 INFO - 2015-11-14 21:21:49,676 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 21:24:52 INFO - 2015-11-14 21:24:52,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 393158656 21:24:52 INFO - 2015-11-14 21:24:52,771 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,772 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:24:52 INFO - 2015-11-14 21:24:52,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:24:52 INFO - 2015-11-14 21:24:52,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:24:52 INFO - 2015-11-14 21:24:52,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:24:52 INFO - 2015-11-14 21:24:52,776 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2579.625954236637;2584.5218634552607;2589.184406911823;2599.6360509528663;2681.8256813307135;4158.106007208449;4191.3503406971895;4347.630451411634;4377.080813029268;4459.041306119184;4360.716553424025;4399.604035636792;4405.493368262642;4462.642988560915;4510.368548403226;4013.1973605278913;4016.2168377166463;4101.405296232045;4146.232946904817;4179.3939878717565;4142.751434913915;4145.316022856225;4181.958180418203;4265.637420819234;4266.040140968288;3989.9202015959518;4055.959440405617;4086.6730661547003;4095.365218391154;4158.355454904495;4010;4113.9098138992895;4114.794260286973;4155.97922010391;4186.58134186582;4089.3865920111925;4095.4061661059277;4121.278776214181;4143.606357396043;4165.10450253197;4219.493660760698;4333.891652708676;4342.261815491374;4435.423394958667;4474.753888536129;4519.435070616173;4588.357629931812;4659.58063774262;4672.626189904833;4688.906221875543;4716.221823399135;4729.9763501182615;4736.786844592001;4782.928256076161;4806.927896081562;4220.155968806251;4333.133373325348;4417.911641767147;4445.022095139064;4454.420925279693;4740.241561350236;4810.4467986181335;4842.806287748451;4871.585915197177;4919.262110683426;4569.405977222939;4574.382458368144;4616.699914505546;4660.720356778605;4663.230566956414;4584.129015487047;4618.284165954283;4627.838025669153;4707.03505781314;4812.927806082912;4518.6611004174165;4585.862424127282;4603.516630753789;4644.396228490275;4695.624350051988;4661.650376221797;4663.393758811333;4665.113628410591;4674;4699.765011749399;3493.7729047611824;3591.44332628443;3636.5090712753968;3657.6890964268337;3664.065663255906;3190.027041752288;3281.753868459875;3296.8846090386724;3301.2737197816923;3308.4044871923284;4433.334999750064;4441.244988351988;4445.066536027406;4451.844185453559;4495.393121928563;4634.328022436728;4677.95322046782;4733.455652599926;4785.449673287547;4842.83050093245;4321.5678432157165;4403.625691816167;4415.006623509685;4420.513743488214;4456.598906098467;4167.604077612622;4230.703850730481;4240.5123410808155;4249.766262855573;4255.893602659897;4795.904081918272;4871.171900776805;4920.6309526785635;4923.77842997066;4986.925196121989;4728.763561821964;4746.4541577719;4746.97626511879;4764.8326160091;4783.95216047835;4925.236588328815;4963.553280204799;4984.327115839315;4987.002599480046;4991.401031876198;4483.394741709958;4670.743109129031;4672.462666793363;4740.5733483986605;4800.0399920016835;4630.976845115888;4650.627949764078;4689.085628302449;4693.718376897397;4713.952860471351;4432.423784907941;4594.839180628662;4613.630909527297;4621.098885717252;4663.673542851968;4404.889877753082;4573.3368661544555;4603.171429142786;4639.744814035261;4672.159011377985;4406.471223453206;4461.687681862369;4500.099980003947;4511.9323210151215;4524.796384162786;4614.838480653161;4672.696274742131;4706.647001474971;4716.622670186308;4727.881802954954;4422.977885110554;4511.09778044399;4566.1552612766745;4604.125216209043;4628.560286772751 21:24:52 INFO - 2015-11-14 21:24:52,778 DEBUG : BROWSER_OUTPUT: |1;ext.html;434.1512343368714;440.3219042674282;446.0321103206044;451.44697745262056;474.43542184800066;25711.35721606961;26353.736462635392;31960.20099497511;32190.83904580474;32663.1834204145;34069;34580.65419345806;35115.64884351162;35128.2974340513;35247.647523524756;6784.084148639944;7131.928680713191;7417.295356941082;7426.071741032371;7524.510906791068;6778.5593936394225;7010.6494675266285;8944.8658270126;9285.860712089325;9320.254379649612;8900.599473023696;8950.597223124942;9005.684801031965;9117.361784675075;9155.54222288883;6771.8984215236815;7068.08114945059;8946.23956963659;9037.909620903773;9112.179903808688;6625.86748265032;9096.408733432305;9108.089191080906;9142.908570914338;9256.490893000882;32365.190870228198;32431.351372972644;32973.83513082443;33054.66945330564;33091.83454082714;2327.7206735191717;2438.8536687798787;2530.7722304992453;2627.4219671672204;2694.5149873022847;22075.33773986783;22321.672486328418;22343.514225526662;22351;22641.660375094223;1972.7829938706732;2004.9699254511195;2033.3188381892085;2039.5003224210163;2044.570640165567;229409;230227;231005;231945;232240;47033.29450058252;47067;47342.526574734504;47356.526434735904;47514.52485475101;46432.5356746435;47812.5218747815;51336.74331628318;52135;52510;11867.703307417383;11956.581519646945;11975.520979160736;12054.397280135958;12139.150259481752;9029.36794424384;9086.500242486594;9120.130373273463;9161.404508706913;9165.266778657824;14947.103173809606;15031.248437578077;15187.392504299925;15544;15882.920585397;6156.445919867144;6767.120274364301;6785.423239024738;6815.863682726318;6890.621015844176;802.8916096327038;824.6206744897414;909.9909000910038;914.8764916736288;941.4915945389413;22563.210287639853;22744.545109098057;22778.544429111324;22793.658095128587;22828.4292892679;775.042822114688;867.0852250875387;887.4675194883018;914.9085091490931;983.2036050798876;12231.57189498381;12605.306708130958;12725.300108494122;12738.554150604685;12942.158759680591;233958;237920;238577;240151;241696;45128.3230751539;45418.77290613526;45546;45845.31232031522;45846;953.7234202081319;1038.2783965144304;1073.1575713065206;1138.7153211697075;1143.382573410349;21770.346889593337;22131.668024979317;22154.22460213885;22298.331050068526;22464.32607021792;34286.65713342834;34447.65552344545;34598.30803383868;34647.65352346444;34965;232085;238894;241753;246398;252076;22908.77091229133;23144.421389464726;23206.3038108857;23547.882260588587;23570.528589428457;30498.847505763217;30516;34010.31979360448;34041.65958340484;34236;28295;28896.566551501324;29009.854950725112;29026.12921612355;29309.12072637824;26515.07197248164;27235;27286.863565682044;27403.867581152666;27850.721492784814;28771.424571508873;29227.41545169127;29526.114216573536;29548.704512954595;29615.851920740257;24107.879460602584;25186.37034074163;25196;25439.61840572356;25951.870240648677;18130.909345453187;18366.632667346847;18534;18727.906360468656;26510 21:24:52 INFO - 2015-11-14 21:24:52,781 DEBUG : BROWSER_OUTPUT: |2;jquery.html;274.578521968778;275.52747038828403;276.8491172311092;284.33323855558723;284.42120285219573;14364.281785910702;14474.782878256834;14760.26198690064;14857.925710371446;14892.478763243302;13704.862951370484;13901.235432051259;14411;15349.155796431192;15430.61423464414;3848.7690738555634;4021.3967904814367;4413.360062790894;4521;4559.498455169929;3930.2139572085553;3972.523297204325;3977.065389633434;3992.540857801361;4001.0597509585223;2787.2474431903474;2861.728135827093;2880.395117025427;3925.9803700981456;3948.9012774680577;3881.844726210948;3942.664873485757;3947.9340578044053;3962.960370396288;3974.364101743707;3333.633300336961;3380.8478618462227;3381.7970921744527;3383.4924761285756;3388.339273841602;9084.591193396313;9371.484568348738;9457.858132128023;10260.538275777608;10593.73515662107;1510.682756621111;1531.2114261155514;1563.577833984829;1612.6935882182347;1618.9476840053942;7511.436642251853;7723;7768.184340644208;7811.765647030541;7896.5262084274555;1228.8955438787714;1237.3503910446998;1244.7572723318956;1288.2077522323798;1297.3448408553713;44851.775741121084;46645.84189343725;47737.52262477366;48781.512184878055;49137;5238.083335416363;5317.73411329432;5335.5464785492895;5381.596380271495;5502.477264659851;6060.181875446847;6082.452579267887;6112.449879510777;6112.541559383064;6134.018557030854;4298.118885628439;4347.087111706577;4365.345198220292;4413.668974826901;4445.822167113344;4498.910021799546;4500.684952053325;4526.569975852289;4570.8171673133365;4685.320628508847;2412.433078226615;2426.46617744096;2428.963565546518;2432.2824766693866;2436.878156092224;849.3714651158222;854.9829003419896;857.1428571428571;869.6217145541709;910.4946754551288;333.79638420563435;335.6254499416637;358.79010778694754;365.61062468470993;392.02386058714166;9039;9651.90348096524;9672.177864881423;9759.756006099762;9846;372.53991320718893;372.7353578958969;377.40747027167635;381.3098292091324;382.3977235853542;5111.3189152623245;5161.406438259573;5210.5831533477985;5257.132662315491;5263.784566841621;330262;340248;341345;341982;344177;58732.41267587355;61825.690871545354;62134;62307.6884615574;62376.688116559126;387.61238761238764;398.2592378176589;400.45338113474895;406.8006676728382;421.5636815895533;8795.384323097322;8854.114588541095;8977.416467929565;9084.22784063362;9134.5432728362;27892.16323510298;28288;28420.715792841806;28849.85575072111;28935.421291574472;36982.63017369899;37644.23557644214;37728.62271377251;37892;38062;5168.147255702767;5220.034293655686;5247.1866860636665;5262.02652509287;5262.342207224097;9620.95189524048;9789.51052447389;9889.357191782512;10027.398356098365;10061.346012509164;8341;8396.454230475;8592.441491303045;8670.046294907681;8678.913210868062;8133.75598732039;8204.343652507905;8283.337333013465;8292;8505.404621676671;8474.957625211835;8606.096359882122;8611.784705382415;8818.735437936872;8841.55792210374;5104.821331253388;5112.028714544224;5159.716215608178;5160.948390516047;5167.92248116271;7846.921530784619;8142.959285203536;8311.33509319265;8338.791530211793;8386.077531471412 21:24:52 INFO - 2015-11-14 21:24:52,782 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1289.3682095773074;1383.4189640351053;1398.4825614522629;1441.8413974462808;1458.8030615866855;5716.3426205986325;6023.879522409555;6311.621302721835;6372.872542549147;6390.329015453381;6541.084248205243;6567.8358041049;6640.568363056398;6648.567843090195;6690.63201523916;1675.4219794171022;1686.6879627268934;1713.0406972095604;1713.4431309824295;1723.9482815515555;1940.8835469871783;1943.3392646500188;1947.4449781812186;1949.6198241342943;1993.0931426201043;1890.3383815664545;1900.2114122639089;1906.0946050625912;1916.396335154429;1919.5968846542173;1844.9169787359601;1900.3443811884877;1900.752902122729;1900.9809901900942;1909.484439201408;1909.837663798579;1918.9424317270364;1919.6352692988287;1940.194819150051;1941.4466876940146;5854.414558544154;6540.70566824494;6627.105340778981;6637.966810165966;6643.435307998826;3814.218085292536;3887.3974533947285;3975.582563830814;4017.2367250222364;4078.5309689385804;2462.236706620953;2467.8395904266167;2484.627305904111;2497.7502249775057;2524.9495010099695;757.5871150223142;778.0546635837428;786.1666633368648;800.7077416742906;806.7257132574953;8732.51971141587;8840.557972101433;8851.77870553235;8883.466991980502;8900.643974241022;3630.473581330745;3803.410471376941;3804.5814960354337;3854.768713877176;3883.7863917484246;7624.970628965129;7661.195574464712;7687.346575541142;7727.1886451922865;7733.8453230935065;4235.8729238122905;4236.788160591958;4236.915261694749;4241.491021077491;4296.419983302214;3835.884923452301;3848.3457812171996;3850.268448994682;3866.4200369944733;3883.2233553289457;2896.0877323642985;2942.058541266817;2952.7490163336356;2965.339409930403;2990;993.6522217223913;993.6571882700457;998.1665309466676;1001.3791449301334;1015.751140970467;1062.166199533378;1090.3948308688755;1093.9507722152523;1119.457063324287;1137.0051205195455;6241.18864547615;6282.654454005074;6311.211098612674;6315.179026726496;6359.427651511386;401.6405317241053;413.1901473112733;414.29156142995816;415.42256263793354;420.4051267456515;4538.2511885538515;4758.07217592573;4808.687435316693;4835.492273311252;4873.439554451284;7350.816229594303;7440.776776696708;7790.493617914931;7926.682932682744;8001;7752.728654497066;7810.1799311072655;7906.486078404885;7936.127026027132;8014.158513356014;5989.52083833301;6182.752689892354;6215.06773983897;6231.999999999909;6270.31026587075;5989.311229208697;6008.789692360747;6035.939640603538;6066.211392518944;6069.2110025696375;6779.220389655253;6827.317268273133;6913.723451061901;6983.1620205575655;7045.506814522934;6924.688389022405;7117.501774875709;7240.674169662272;7242.529235599669;7256.492045556761;5602.467765562265;5712;5759.078547432391;5788.9131663024245;5833.620814647034;6061.787837425669;6244.125822384779;6358.904616430665;6417.422431981144;6491.578047426902;5717.456841600041;5848.356680765028;5974.372690867396;6049.969750151221;6070.180525628984;5749.741261643152;5781.392953739965;5943.940560594338;5972.163897054329;6053.092036194606;5973.790917317873;5993;6055.576109672281;6103.115048318058;6115.571909966259;5469.72651367438;5473.206385074062;5510.91733623988;5556.055470570093;5560.777568897199;5569.415211402907;5645.209670646031;5648.491635752802;5649.774009039593;5664.85837854057 21:24:52 INFO - 2015-11-14 21:24:52,786 DEBUG : BROWSER_OUTPUT: |4;prototype.html;260.4556476963147;267.2636885380776;267.6801222539066;269.9257704131364;276.1797461539228;4724.763761811912;5110.054639891618;5169.250458683493;5183.455737147592;5190.429052804193;5041.974790126053;5049.4698056704065;5110.18237082066;5246.475352464751;5257.316548848654;3765.6046115157924;3925.5681874993797;3950;4011.8997025074314;4087.264292427377;3858.344081506151;3887.280853042182;3892.637576848095;3967.226390853785;3974.304496713078;3882.165334453092;3936.6063393660547;3954.4463775071513;3967.801609919507;3979.960200397988;3961.1681546875193;3963.7027222958395;3971.6624086952643;3974.4960674774707;3983;3405.7956522608724;3407.807267456395;3413.0955296846355;3416.9487457688156;3422.5208470814105;4969.602431805447;5077.847664570068;5081.237814327844;5104.872378190575;5105.412877519096;4431.512533621331;4470.508244093147;4489.236829738952;4490.7979140938405;4501.48232953208;5456.399796022434;5484.91772623411;5495.313085864267;5510.366307874566;5511.834644960658;3504.929901401983;3598.748087633867;3606.8376923038527;3628.2924829658227;3669.541307336583;5702.3157221133315;5747.626404283708;5777.624454410492;5795.2176456178295;5812.157237200582;3713.0717320669833;3756.2111956488898;3757.1170774867883;3760.6803421708914;3789;3774.433834924728;3780.4518344839844;3829.2532956073856;3830.71269654777;3846.519185101862;4172.4784401949755;4379.802908869108;4387.254166791653;4393.450818647669;4484;5413.593980451403;5470.452954704498;5478.369987451494;5488.9725551372785;5561.749721262553;1294.6828027133224;1299.8895093916933;1303.1985329022582;1318.2222488731695;1321.3393303348325;840.4159109418895;841.6296829395046;854.2781349759567;856.2422256303092;862.844687956174;5232.895342093137;5281.973590132025;5294.947050529522;5303.363596368384;5314.362276526765;5677.460641239076;5681.119426488901;5713.914291285634;5717.685527295956;5757.337906140764;5245.213218017328;5321.281626980385;5324.467553244722;5329.094054010828;5339.519443250126;3023.6220472440946;3053.603031605877;3109.0051183621026;3123.7344825689615;3130.9373812523622;5979.073243647242;5987.491063259585;6000.309964354068;6012.488938440281;6036.456718895321;5908.734106965111;5921.28944526651;5923.763049478059;5925.762969481259;5937.990541607937;5817.621854579608;5957.463828255478;5973.940260597426;6030.065339872327;6031.276246850406;5680.091185410314;5693.430656934273;5702.885942281214;5702.942970570241;5714.028615135354;5446.264754258124;5579.721013949367;5585.162225666182;5620.494155526022;5653.236813030353;5908.970455147697;6016.939830601638;6054.122152287981;6058.757649693963;6084.148219249397;3723.7579557328686;3727.4036154215196;3729.254149170231;3731.6268373162466;3740.8877733668032;5627.240322556402;5731.971340143273;5750.079987202195;5752.108423194411;5779.508741756998;5584.301962254718;5596;5602;5602.579806514446;5617.719114044363;5568;5578.972105139448;5583;5607.299087614048;5618.157276408571;5282.656627319212;5424.213489044146;5461.5357694596405;5505.834824955257;5506.504414602705;5303.36359636846;5501.3948465667945;5540.916886246629;5586.944130558805;5588.050031494575;5415.0252954467;5447.918281225864;5462.044142275006;5483.424240454695;5483.890322193613 21:24:52 INFO - 2015-11-14 21:24:52,787 DEBUG : BROWSER_OUTPUT: |5;yui.html;532.2256117349256;580.0487200990376;595.5414330965157;626.9811905642827;627.3663599764237;11105.83341249882;11317.434128293584;11317.603883864067;11349.20555561111;11497.540098396075;11457.828132578017;11616.36110013949;11672.533098676064;11702.941485292582;11722.941385293083;538.0933127679872;574.7930744931821;717.6698718589455;723.0672432561988;724.6485454554537;564.906790379589;711.214108410207;713.4363852556475;714.085969958454;716.7849645106473;729.5367441674548;742.7103429662436;747.5439981611213;748.2031636307343;749.2245525880714;584.4185035889317;592.8962431574457;592.9673867937262;732.1470486882802;744.7579536650583;530.5119290252976;537.7580088959944;537.8467136865975;539.0136051026612;540.3057071662934;11004.724881877937;11014.889851101467;11036.172287078502;11044.33733975964;11114.333140011626;6818.318168183192;7140.678669459887;7781.844363112706;7988.081370642392;8105.799063716262;7164.605946672931;7331.083614548182;7478.740610643138;7553.471257012011;7696.538207707556;2371.5494056129282;2437.914672986437;2508.648789169518;2515.559777039011;2607.478504299129;37075.07312317187;37962;37986.05034874123;38185.23629527394;38204.61795382039;5618.690971996498;5668.546516278688;5678.14827775837;5720.227769251181;5896.056630939115;9959.701208963743;10046.29675922693;10054;10092.192624590016;10121.898781012243;5172.689638621695;5188.403333616682;5233.319668443154;5407.8643484867835;5425.430329815313;2970.064429704636;3014.5628883811723;3083.5066389377594;3101.705337992887;3145.5056764920446;2216.3240211735574;2252.7859853313907;2253.628151355008;2254.1884921428273;2255.943601409945;324.0327622048184;334.3613697837168;338.02142796604187;338.18666108010274;338.21365325618035;477.40086191829727;493.4079105073854;507.4620901844057;508.9185730283211;525.3170877858769;5941.762329506858;6710.261871194165;6737.3599508046655;6848.280930502325;7207.603581802946;382.8533542041603;485.7231378114511;504.6669198329085;529.6583703511213;536.2679941879306;3026.72759451646;3115.2523394385184;3246.756493263015;3327.4842399428126;3360.22714775603;44462;44929;44977.325340119925;46634.30048549274;49057.509424906006;38661.80669096693;39544.40683389751;39587.40618890719;39698.60301396949;40335.79832100821;37815.08403907475;38833.80583097123;38878.22243555113;39163;39292.41061384082;6476.902846457401;6741.797746067626;6815.352541508549;6969.2682268361095;7023.894641580483;26276.56090274823;26616;27497;27678;27892.721072789012;36456.27087458183;37262.44106338461;37280.594313824884;38033.23933521259;38705.6129438702;6235.407636274546;6248.687565621792;6481.449076828522;6564.113844630913;6593.670316484253;9013.639454422011;9158.58786354629;9202.125798049176;9252.722418327192;9295.67465138717;8599.637555579782;8676.826463470821;8774.385792994684;8852.336074794544;9468.715938521855;8702.477851328687;8734.170253825876;8990.730278091667;8999.955000224956;9013.90986090157;6983.790486285419;7967.482113662593;8755.212030916993;8864.556772161237;8890.688825891062;7393.297636724503;7446.776596702108;7653.770386888402;7976.561289129154;8160.877586836321;6001.36985616504;7379.114506259283;7530.246975302426;7538.359239464707;7838.746920028125 21:24:52 INFO - 2015-11-14 21:24:52,787 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:24:52 INFO - 2015-11-14 21:24:52,787 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:24:52 INFO - 2015-11-14 21:24:52,788 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,997 21:24:52 INFO - 2015-11-14 21:24:52,788 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:24:52 INFO - 2015-11-14 21:24:52,788 DEBUG : BROWSER_OUTPUT: __startTimestamp1447565092771__endTimestamp 21:24:52 INFO - 2015-11-14 21:24:52,788 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,788 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:24:52 INFO - 2015-11-14 21:24:52,789 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:24:52 INFO - 2015-11-14 21:24:52,789 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,789 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4394.81 Median:4511.10 stddev:475.49 (10.5%) stddev-sans-first:455.12 21:24:52 INFO - 2015-11-14 21:24:52,790 DEBUG : BROWSER_OUTPUT: Values: 2579.6 2584.5 2589.2 2599.6 2681.8 4158.1 4191.4 4347.6 4377.1 4459.0 4360.7 4399.6 4405.5 4462.6 4510.4 4013.2 4016.2 4101.4 4146.2 4179.4 4142.8 4145.3 4182.0 4265.6 4266.0 3989.9 4056.0 4086.7 4095.4 4158.4 4010.0 4113.9 4114.8 4156.0 4186.6 4089.4 4095.4 4121.3 4143.6 4165.1 4219.5 4333.9 4342.3 4435.4 4474.8 4519.4 4588.4 4659.6 4672.6 4688.9 4716.2 4730.0 4736.8 4782.9 4806.9 4220.2 4333.1 4417.9 4445.0 4454.4 4740.2 4810.4 4842.8 4871.6 4919.3 4569.4 4574.4 4616.7 4660.7 4663.2 4584.1 4618.3 4627.8 4707.0 4812.9 4518.7 4585.9 4603.5 4644.4 4695.6 4661.7 4663.4 4665.1 4674.0 4699.8 3493.8 3591.4 3636.5 3657.7 3664.1 3190.0 3281.8 3296.9 3301.3 3308.4 4433.3 4441.2 4445.1 4451.8 4495.4 4634.3 4678.0 4733.5 4785.4 4842.8 4321.6 4403.6 4415.0 4420.5 4456.6 4167.6 4230.7 4240.5 4249.8 4255.9 4795.9 4871.2 4920.6 4923.8 4986.9 4728.8 4746.5 4747.0 4764.8 4784.0 4925.2 4963.6 4984.3 4987.0 4991.4 4483.4 4670.7 4672.5 4740.6 4800.0 4631.0 4650.6 4689.1 4693.7 4714.0 4432.4 4594.8 4613.6 4621.1 4663.7 4404.9 4573.3 4603.2 4639.7 4672.2 4406.5 4461.7 4500.1 4511.9 4524.8 4614.8 4672.7 4706.6 4716.6 4727.9 4423.0 4511.1 4566.2 4604.1 4628.6 21:24:52 INFO - 2015-11-14 21:24:52,791 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,791 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37372.27 Median:30057.35 stddev:61973.18 (206.2%) stddev-sans-first:62084.98 21:24:52 INFO - 2015-11-14 21:24:52,792 DEBUG : BROWSER_OUTPUT: Values: 434.2 440.3 446.0 451.4 474.4 25711.4 26353.7 31960.2 32190.8 32663.2 34069.0 34580.7 35115.6 35128.3 35247.6 6784.1 7131.9 7417.3 7426.1 7524.5 6778.6 7010.6 8944.9 9285.9 9320.3 8900.6 8950.6 9005.7 9117.4 9155.5 6771.9 7068.1 8946.2 9037.9 9112.2 6625.9 9096.4 9108.1 9142.9 9256.5 32365.2 32431.4 32973.8 33054.7 33091.8 2327.7 2438.9 2530.8 2627.4 2694.5 22075.3 22321.7 22343.5 22351.0 22641.7 1972.8 2005.0 2033.3 2039.5 2044.6 229409.0 230227.0 231005.0 231945.0 232240.0 47033.3 47067.0 47342.5 47356.5 47514.5 46432.5 47812.5 51336.7 52135.0 52510.0 11867.7 11956.6 11975.5 12054.4 12139.2 9029.4 9086.5 9120.1 9161.4 9165.3 14947.1 15031.2 15187.4 15544.0 15882.9 6156.4 6767.1 6785.4 6815.9 6890.6 802.9 824.6 910.0 914.9 941.5 22563.2 22744.5 22778.5 22793.7 22828.4 775.0 867.1 887.5 914.9 983.2 12231.6 12605.3 12725.3 12738.6 12942.2 233958.0 237920.0 238577.0 240151.0 241696.0 45128.3 45418.8 45546.0 45845.3 45846.0 953.7 1038.3 1073.2 1138.7 1143.4 21770.3 22131.7 22154.2 22298.3 22464.3 34286.7 34447.7 34598.3 34647.7 34965.0 232085.0 238894.0 241753.0 246398.0 252076.0 22908.8 23144.4 23206.3 23547.9 23570.5 30498.8 30516.0 34010.3 34041.7 34236.0 28295.0 28896.6 29009.9 29026.1 29309.1 26515.1 27235.0 27286.9 27403.9 27850.7 28771.4 29227.4 29526.1 29548.7 29615.9 24107.9 25186.4 25196.0 25439.6 25951.9 18130.9 18366.6 18534.0 18727.9 26510.0 21:24:52 INFO - 2015-11-14 21:24:52,793 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,793 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19051.44 Median:4429.75 stddev:55922.26 (1262.4%) stddev-sans-first:56061.37 21:24:52 INFO - 2015-11-14 21:24:52,794 DEBUG : BROWSER_OUTPUT: Values: 274.6 275.5 276.8 284.3 284.4 14364.3 14474.8 14760.3 14857.9 14892.5 13704.9 13901.2 14411.0 15349.2 15430.6 3848.8 4021.4 4413.4 4521.0 4559.5 3930.2 3972.5 3977.1 3992.5 4001.1 2787.2 2861.7 2880.4 3926.0 3948.9 3881.8 3942.7 3947.9 3963.0 3974.4 3333.6 3380.8 3381.8 3383.5 3388.3 9084.6 9371.5 9457.9 10260.5 10593.7 1510.7 1531.2 1563.6 1612.7 1618.9 7511.4 7723.0 7768.2 7811.8 7896.5 1228.9 1237.4 1244.8 1288.2 1297.3 44851.8 46645.8 47737.5 48781.5 49137.0 5238.1 5317.7 5335.5 5381.6 5502.5 6060.2 6082.5 6112.4 6112.5 6134.0 4298.1 4347.1 4365.3 4413.7 4445.8 4498.9 4500.7 4526.6 4570.8 4685.3 2412.4 2426.5 2429.0 2432.3 2436.9 849.4 855.0 857.1 869.6 910.5 333.8 335.6 358.8 365.6 392.0 9039.0 9651.9 9672.2 9759.8 9846.0 372.5 372.7 377.4 381.3 382.4 5111.3 5161.4 5210.6 5257.1 5263.8 330262.0 340248.0 341345.0 341982.0 344177.0 58732.4 61825.7 62134.0 62307.7 62376.7 387.6 398.3 400.5 406.8 421.6 8795.4 8854.1 8977.4 9084.2 9134.5 27892.2 28288.0 28420.7 28849.9 28935.4 36982.6 37644.2 37728.6 37892.0 38062.0 5168.1 5220.0 5247.2 5262.0 5262.3 9621.0 9789.5 9889.4 10027.4 10061.3 8341.0 8396.5 8592.4 8670.0 8678.9 8133.8 8204.3 8283.3 8292.0 8505.4 8475.0 8606.1 8611.8 8818.7 8841.6 5104.8 5112.0 5159.7 5160.9 5167.9 7846.9 8143.0 8311.3 8338.8 8386.1 21:24:52 INFO - 2015-11-14 21:24:52,794 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,794 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4587.54 Median:5733.60 stddev:2380.98 (41.5%) stddev-sans-first:2374.75 21:24:52 INFO - 2015-11-14 21:24:52,796 DEBUG : BROWSER_OUTPUT: Values: 1289.4 1383.4 1398.5 1441.8 1458.8 5716.3 6023.9 6311.6 6372.9 6390.3 6541.1 6567.8 6640.6 6648.6 6690.6 1675.4 1686.7 1713.0 1713.4 1723.9 1940.9 1943.3 1947.4 1949.6 1993.1 1890.3 1900.2 1906.1 1916.4 1919.6 1844.9 1900.3 1900.8 1901.0 1909.5 1909.8 1918.9 1919.6 1940.2 1941.4 5854.4 6540.7 6627.1 6638.0 6643.4 3814.2 3887.4 3975.6 4017.2 4078.5 2462.2 2467.8 2484.6 2497.8 2524.9 757.6 778.1 786.2 800.7 806.7 8732.5 8840.6 8851.8 8883.5 8900.6 3630.5 3803.4 3804.6 3854.8 3883.8 7625.0 7661.2 7687.3 7727.2 7733.8 4235.9 4236.8 4236.9 4241.5 4296.4 3835.9 3848.3 3850.3 3866.4 3883.2 2896.1 2942.1 2952.7 2965.3 2990.0 993.7 993.7 998.2 1001.4 1015.8 1062.2 1090.4 1094.0 1119.5 1137.0 6241.2 6282.7 6311.2 6315.2 6359.4 401.6 413.2 414.3 415.4 420.4 4538.3 4758.1 4808.7 4835.5 4873.4 7350.8 7440.8 7790.5 7926.7 8001.0 7752.7 7810.2 7906.5 7936.1 8014.2 5989.5 6182.8 6215.1 6232.0 6270.3 5989.3 6008.8 6035.9 6066.2 6069.2 6779.2 6827.3 6913.7 6983.2 7045.5 6924.7 7117.5 7240.7 7242.5 7256.5 5602.5 5712.0 5759.1 5788.9 5833.6 6061.8 6244.1 6358.9 6417.4 6491.6 5717.5 5848.4 5974.4 6050.0 6070.2 5749.7 5781.4 5943.9 5972.2 6053.1 5973.8 5993.0 6055.6 6103.1 6115.6 5469.7 5473.2 5510.9 5556.1 5560.8 5569.4 5645.2 5648.5 5649.8 5664.9 21:24:52 INFO - 2015-11-14 21:24:52,796 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,796 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4591.32 Median:5303.36 stddev:1432.90 (27.0%) stddev-sans-first:1399.56 21:24:52 INFO - 2015-11-14 21:24:52,797 DEBUG : BROWSER_OUTPUT: Values: 260.5 267.3 267.7 269.9 276.2 4724.8 5110.1 5169.3 5183.5 5190.4 5042.0 5049.5 5110.2 5246.5 5257.3 3765.6 3925.6 3950.0 4011.9 4087.3 3858.3 3887.3 3892.6 3967.2 3974.3 3882.2 3936.6 3954.4 3967.8 3980.0 3961.2 3963.7 3971.7 3974.5 3983.0 3405.8 3407.8 3413.1 3416.9 3422.5 4969.6 5077.8 5081.2 5104.9 5105.4 4431.5 4470.5 4489.2 4490.8 4501.5 5456.4 5484.9 5495.3 5510.4 5511.8 3504.9 3598.7 3606.8 3628.3 3669.5 5702.3 5747.6 5777.6 5795.2 5812.2 3713.1 3756.2 3757.1 3760.7 3789.0 3774.4 3780.5 3829.3 3830.7 3846.5 4172.5 4379.8 4387.3 4393.5 4484.0 5413.6 5470.5 5478.4 5489.0 5561.7 1294.7 1299.9 1303.2 1318.2 1321.3 840.4 841.6 854.3 856.2 862.8 5232.9 5282.0 5294.9 5303.4 5314.4 5677.5 5681.1 5713.9 5717.7 5757.3 5245.2 5321.3 5324.5 5329.1 5339.5 3023.6 3053.6 3109.0 3123.7 3130.9 5979.1 5987.5 6000.3 6012.5 6036.5 5908.7 5921.3 5923.8 5925.8 5938.0 5817.6 5957.5 5973.9 6030.1 6031.3 5680.1 5693.4 5702.9 5702.9 5714.0 5446.3 5579.7 5585.2 5620.5 5653.2 5909.0 6016.9 6054.1 6058.8 6084.1 3723.8 3727.4 3729.3 3731.6 3740.9 5627.2 5732.0 5750.1 5752.1 5779.5 5584.3 5596.0 5602.0 5602.6 5617.7 5568.0 5579.0 5583.0 5607.3 5618.2 5282.7 5424.2 5461.5 5505.8 5506.5 5303.4 5501.4 5540.9 5586.9 5588.1 5415.0 5447.9 5462.0 5483.4 5483.9 21:24:52 INFO - 2015-11-14 21:24:52,798 DEBUG : BROWSER_OUTPUT: 21:24:52 INFO - 2015-11-14 21:24:52,798 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10650.07 Median:537.97 stddev:12886.02 (2395.3%) stddev-sans-first:12899.77 21:24:52 INFO - 2015-11-14 21:24:52,798 DEBUG : BROWSER_OUTPUT: Values: 532.2 580.0 595.5 627.0 627.4 11105.8 11317.4 11317.6 11349.2 11497.5 11457.8 11616.4 11672.5 11702.9 11722.9 538.1 574.8 717.7 723.1 724.6 564.9 711.2 713.4 714.1 716.8 729.5 742.7 747.5 748.2 749.2 584.4 592.9 593.0 732.1 744.8 530.5 537.8 537.8 539.0 540.3 11004.7 11014.9 11036.2 11044.3 11114.3 6818.3 7140.7 7781.8 7988.1 8105.8 7164.6 7331.1 7478.7 7553.5 7696.5 2371.5 2437.9 2508.6 2515.6 2607.5 37075.1 37962.0 37986.1 38185.2 38204.6 5618.7 5668.5 5678.1 5720.2 5896.1 9959.7 10046.3 10054.0 10092.2 10121.9 5172.7 5188.4 5233.3 5407.9 5425.4 2970.1 3014.6 3083.5 3101.7 3145.5 2216.3 2252.8 2253.6 2254.2 2255.9 324.0 334.4 338.0 338.2 338.2 477.4 493.4 507.5 508.9 525.3 5941.8 6710.3 6737.4 6848.3 7207.6 382.9 485.7 504.7 529.7 536.3 3026.7 3115.3 3246.8 3327.5 3360.2 44462.0 44929.0 44977.3 46634.3 49057.5 38661.8 39544.4 39587.4 39698.6 40335.8 37815.1 38833.8 38878.2 39163.0 39292.4 6476.9 6741.8 6815.4 6969.3 7023.9 26276.6 26616.0 27497.0 27678.0 27892.7 36456.3 37262.4 37280.6 38033.2 38705.6 6235.4 6248.7 6481.4 6564.1 6593.7 9013.6 9158.6 9202.1 9252.7 9295.7 8599.6 8676.8 8774.4 8852.3 9468.7 8702.5 8734.2 8990.7 9000.0 9013.9 6983.8 7967.5 8755.2 8864.6 8890.7 7393.3 7446.8 7653.8 7976.6 8160.9 6001.4 7379.1 7530.2 7538.4 7838.7 21:24:52 INFO - 2015-11-14 21:24:52,799 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:24:52 INFO - 2015-11-14 21:24:52,799 DEBUG : BROWSER_OUTPUT: 21:24:53 INFO - 2015-11-14 21:24:53,468 INFO : Browser exited with error code: 0 21:24:53 INFO - 2015-11-14 21:24:53,501 INFO : Completed test dromaeo_css (00:18:37) 21:24:53 INFO - 2015-11-14 21:24:53,501 INFO : Starting test kraken 21:24:53 INFO - 2015-11-14 21:24:53,501 DEBUG : operating with platform_type : mac_ 21:24:53 INFO - 2015-11-14 21:24:53,502 INFO : Initialising browser for kraken test... 21:24:53 INFO - 2015-11-14 21:24:53,518 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpa4Cjtu/profile http://localhost:49264/getInfo.html 21:24:56 INFO - 2015-11-14 21:24:56,142 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:24:56 INFO - 2015-11-14 21:24:56,143 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:24:56 INFO - 2015-11-14 21:24:56,143 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:24:56 INFO - 2015-11-14 21:24:56,143 DEBUG : BROWSER_OUTPUT: __metrics 21:24:56 INFO - 2015-11-14 21:24:56,163 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:24:56 INFO - 2015-11-14 21:24:56,934 INFO : Browser initialized. 21:24:56 INFO - 2015-11-14 21:24:56,934 INFO : Running cycle 1/1 for kraken test... 21:24:56 INFO - 2015-11-14 21:24:56,934 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpa4Cjtu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:25:09 INFO - 2015-11-14 21:25:09,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 229588992 21:25:09 INFO - 2015-11-14 21:25:09,102 DEBUG : BROWSER_OUTPUT: 21:25:12 INFO - 2015-11-14 21:25:12,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 21:25:12 INFO - 2015-11-14 21:25:12,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 285323264 21:25:12 INFO - 2015-11-14 21:25:12,649 DEBUG : BROWSER_OUTPUT: 21:25:15 INFO - 2015-11-14 21:25:15,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 21:25:16 INFO - 2015-11-14 21:25:16,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 298487808 21:25:16 INFO - 2015-11-14 21:25:16,310 DEBUG : BROWSER_OUTPUT: 21:25:19 INFO - 2015-11-14 21:25:19,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 21:25:20 INFO - 2015-11-14 21:25:20,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 283553792 21:25:20 INFO - 2015-11-14 21:25:20,308 DEBUG : BROWSER_OUTPUT: 21:25:22 INFO - 2015-11-14 21:25:22,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 21:25:23 INFO - 2015-11-14 21:25:23,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 285159424 21:25:23 INFO - 2015-11-14 21:25:23,234 DEBUG : BROWSER_OUTPUT: 21:25:25 INFO - 2015-11-14 21:25:25,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:25:26 INFO - 2015-11-14 21:25:26,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 285503488 21:25:26 INFO - 2015-11-14 21:25:26,356 DEBUG : BROWSER_OUTPUT: 21:25:29 INFO - 2015-11-14 21:25:29,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 21:25:30 INFO - 2015-11-14 21:25:30,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 282828800 21:25:30 INFO - 2015-11-14 21:25:30,521 DEBUG : BROWSER_OUTPUT: 21:25:34 INFO - 2015-11-14 21:25:34,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 21:25:34 INFO - 2015-11-14 21:25:34,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 280850432 21:25:34 INFO - 2015-11-14 21:25:34,786 DEBUG : BROWSER_OUTPUT: 21:25:38 INFO - 2015-11-14 21:25:38,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 21:25:38 INFO - 2015-11-14 21:25:38,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 283602944 21:25:38 INFO - 2015-11-14 21:25:38,666 DEBUG : BROWSER_OUTPUT: 21:25:40 INFO - 2015-11-14 21:25:40,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:25:41 INFO - 2015-11-14 21:25:41,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 319840256 21:25:41 INFO - 2015-11-14 21:25:41,010 DEBUG : BROWSER_OUTPUT: 21:25:43 INFO - 2015-11-14 21:25:43,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:25:43 INFO - 2015-11-14 21:25:43,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 319193088 21:25:43 INFO - 2015-11-14 21:25:43,727 DEBUG : BROWSER_OUTPUT: 21:25:46 INFO - 2015-11-14 21:25:46,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:25:46 INFO - 2015-11-14 21:25:46,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 327188480 21:25:46 INFO - 2015-11-14 21:25:46,715 DEBUG : BROWSER_OUTPUT: 21:25:49 INFO - 2015-11-14 21:25:49,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:25:50 INFO - 2015-11-14 21:25:50,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 328884224 21:25:50 INFO - 2015-11-14 21:25:50,341 DEBUG : BROWSER_OUTPUT: 21:25:53 INFO - 2015-11-14 21:25:53,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:25:53 INFO - 2015-11-14 21:25:53,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 327303168 21:25:53 INFO - 2015-11-14 21:25:53,939 DEBUG : BROWSER_OUTPUT: 21:25:55 INFO - 2015-11-14 21:25:55,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 21:25:56 INFO - 2015-11-14 21:25:56,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 387264512 21:25:56 INFO - 2015-11-14 21:25:56,136 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,137 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:25:56 INFO - 2015-11-14 21:25:56,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:25:56 INFO - 2015-11-14 21:25:56,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:25:56 INFO - 2015-11-14 21:25:56,138 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |0;ai-astar;126;131;133;130;131;131;131;130;126;144 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;188;160;187;197;157;183;179;155;198;157 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |2;audio-dft;193;197;195;194;189;196;199;197;195;189 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;90;102;147;85;90;85;87;138;82 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;116;117;171;109;111;116;163;110;108;158 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;141;149;142;142;148;147;135;141;148 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;156;154;154;155;154;155;155;155;154 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;115;124;115;120;117;125;114;123;115;129 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;67;69;75;72;73;74;83;70;73 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;80;84;86;85;86;86;85;86;86 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;105;105;103;102;106;108;111;108;104 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;164;162;160;150;163;166;162;160;151;155 21:25:56 INFO - 2015-11-14 21:25:56,139 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;168;174;189;187;187;175;187;185;187;172 21:25:56 INFO - 2015-11-14 21:25:56,140 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;81;86;86;86;86;87;87;87;87 21:25:56 INFO - 2015-11-14 21:25:56,140 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:25:56 INFO - 2015-11-14 21:25:56,140 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:25:56 INFO - 2015-11-14 21:25:56,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,998 21:25:56 INFO - 2015-11-14 21:25:56,140 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:25:56 INFO - 2015-11-14 21:25:56,140 DEBUG : BROWSER_OUTPUT: __startTimestamp1447565156136__endTimestamp 21:25:56 INFO - 2015-11-14 21:25:56,140 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,143 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:25:56 INFO - 2015-11-14 21:25:56,143 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:25:56 INFO - 2015-11-14 21:25:56,144 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,144 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.30 Median:131.00 stddev:4.99 (3.8%) stddev-sans-first:4.91 21:25:56 INFO - 2015-11-14 21:25:56,144 DEBUG : BROWSER_OUTPUT: Values: 126.0 131.0 133.0 130.0 131.0 131.0 131.0 130.0 126.0 144.0 21:25:56 INFO - 2015-11-14 21:25:56,144 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,144 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:176.10 Median:185.00 stddev:17.21 (9.3%) stddev-sans-first:17.71 21:25:56 INFO - 2015-11-14 21:25:56,145 DEBUG : BROWSER_OUTPUT: Values: 188.0 160.0 187.0 197.0 157.0 183.0 179.0 155.0 198.0 157.0 21:25:56 INFO - 2015-11-14 21:25:56,145 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,145 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:194.40 Median:195.50 stddev:3.31 (1.7%) stddev-sans-first:3.47 21:25:56 INFO - 2015-11-14 21:25:56,145 DEBUG : BROWSER_OUTPUT: Values: 193.0 197.0 195.0 194.0 189.0 196.0 199.0 197.0 195.0 189.0 21:25:56 INFO - 2015-11-14 21:25:56,146 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,146 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:99.60 Median:86.00 stddev:23.33 (27.1%) stddev-sans-first:24.48 21:25:56 INFO - 2015-11-14 21:25:56,146 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 102.0 147.0 85.0 90.0 85.0 87.0 138.0 82.0 21:25:56 INFO - 2015-11-14 21:25:56,146 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,146 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:127.90 Median:116.50 stddev:25.29 (21.7%) stddev-sans-first:26.46 21:25:56 INFO - 2015-11-14 21:25:56,146 DEBUG : BROWSER_OUTPUT: Values: 116.0 117.0 171.0 109.0 111.0 116.0 163.0 110.0 108.0 158.0 21:25:56 INFO - 2015-11-14 21:25:56,146 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,147 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:144.20 Median:147.50 stddev:4.69 (3.2%) stddev-sans-first:4.64 21:25:56 INFO - 2015-11-14 21:25:56,147 DEBUG : BROWSER_OUTPUT: Values: 149.0 141.0 149.0 142.0 142.0 148.0 147.0 135.0 141.0 148.0 21:25:56 INFO - 2015-11-14 21:25:56,147 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,147 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.00 Median:155.00 stddev:2.21 (1.4%) stddev-sans-first:0.71 21:25:56 INFO - 2015-11-14 21:25:56,147 DEBUG : BROWSER_OUTPUT: Values: 148.0 156.0 154.0 154.0 155.0 154.0 155.0 155.0 155.0 154.0 21:25:56 INFO - 2015-11-14 21:25:56,147 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,148 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:119.70 Median:121.50 stddev:5.27 (4.3%) stddev-sans-first:5.31 21:25:56 INFO - 2015-11-14 21:25:56,148 DEBUG : BROWSER_OUTPUT: Values: 115.0 124.0 115.0 120.0 117.0 125.0 114.0 123.0 115.0 129.0 21:25:56 INFO - 2015-11-14 21:25:56,148 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,148 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:73.00 stddev:4.32 (5.9%) stddev-sans-first:4.57 21:25:56 INFO - 2015-11-14 21:25:56,148 DEBUG : BROWSER_OUTPUT: Values: 72.0 67.0 69.0 75.0 72.0 73.0 74.0 83.0 70.0 73.0 21:25:56 INFO - 2015-11-14 21:25:56,148 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,149 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:84.10 Median:86.00 stddev:3.11 (3.6%) stddev-sans-first:1.96 21:25:56 INFO - 2015-11-14 21:25:56,149 DEBUG : BROWSER_OUTPUT: Values: 77.0 80.0 84.0 86.0 85.0 86.0 86.0 85.0 86.0 86.0 21:25:56 INFO - 2015-11-14 21:25:56,149 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,149 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:104.90 Median:107.00 stddev:3.84 (3.6%) stddev-sans-first:2.82 21:25:56 INFO - 2015-11-14 21:25:56,149 DEBUG : BROWSER_OUTPUT: Values: 97.0 105.0 105.0 103.0 102.0 106.0 108.0 111.0 108.0 104.0 21:25:56 INFO - 2015-11-14 21:25:56,150 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,150 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:159.30 Median:162.00 stddev:5.48 (3.4%) stddev-sans-first:5.54 21:25:56 INFO - 2015-11-14 21:25:56,151 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 160.0 150.0 163.0 166.0 162.0 160.0 151.0 155.0 21:25:56 INFO - 2015-11-14 21:25:56,151 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,151 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:187.00 stddev:7.88 (4.2%) stddev-sans-first:6.78 21:25:56 INFO - 2015-11-14 21:25:56,151 DEBUG : BROWSER_OUTPUT: Values: 168.0 174.0 189.0 187.0 187.0 175.0 187.0 185.0 187.0 172.0 21:25:56 INFO - 2015-11-14 21:25:56,151 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,152 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.40 Median:86.50 stddev:2.37 (2.7%) stddev-sans-first:1.90 21:25:56 INFO - 2015-11-14 21:25:56,152 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 86.0 86.0 86.0 86.0 87.0 87.0 87.0 87.0 21:25:56 INFO - 2015-11-14 21:25:56,152 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:25:56 INFO - 2015-11-14 21:25:56,152 DEBUG : BROWSER_OUTPUT: 21:25:56 INFO - 2015-11-14 21:25:56,910 INFO : Browser exited with error code: 0 21:25:56 INFO - 2015-11-14 21:25:56,968 INFO : Completed test kraken (00:01:03) 21:25:56 INFO - 2015-11-14 21:25:56,968 INFO : Starting test v8_7 21:25:56 INFO - 2015-11-14 21:25:56,968 DEBUG : operating with platform_type : mac_ 21:25:56 INFO - 2015-11-14 21:25:56,968 INFO : Initialising browser for v8_7 test... 21:25:56 INFO - 2015-11-14 21:25:56,983 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpiOG83D/profile http://localhost:49264/getInfo.html 21:25:59 INFO - 2015-11-14 21:25:59,492 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:25:59 INFO - 2015-11-14 21:25:59,492 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:25:59 INFO - 2015-11-14 21:25:59,492 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:25:59 INFO - 2015-11-14 21:25:59,492 DEBUG : BROWSER_OUTPUT: __metrics 21:25:59 INFO - 2015-11-14 21:25:59,514 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:26:00 INFO - 2015-11-14 21:26:00,294 INFO : Browser initialized. 21:26:00 INFO - 2015-11-14 21:26:00,295 INFO : Running cycle 1/1 for v8_7 test... 21:26:00 INFO - 2015-11-14 21:26:00,295 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpiOG83D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:26:12 INFO - 2015-11-14 21:26:12,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 228720640 21:26:12 INFO - 2015-11-14 21:26:12,474 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 21:26:35 INFO - 2015-11-14 21:26:35,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 737955840 21:26:35 INFO - 2015-11-14 21:26:35,535 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,535 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:26:35 INFO - 2015-11-14 21:26:35,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:26:35 INFO - 2015-11-14 21:26:35,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:26:35 INFO - 2015-11-14 21:26:35,536 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:26:35 INFO - 2015-11-14 21:26:35,536 DEBUG : BROWSER_OUTPUT: |0;Richards;202.1018593371059 21:26:35 INFO - 2015-11-14 21:26:35,536 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;232.18017181332715 21:26:35 INFO - 2015-11-14 21:26:35,536 DEBUG : BROWSER_OUTPUT: |2;Encrypt;383.8771593090211 21:26:35 INFO - 2015-11-14 21:26:35,536 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6823.1292517006805 21:26:35 INFO - 2015-11-14 21:26:35,536 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2336.448598130841 21:26:35 INFO - 2015-11-14 21:26:35,536 DEBUG : BROWSER_OUTPUT: |5;Earley;968.054211035818 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: |6;Boyer;16145.161290322581 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: |7;RegExp;35396.55172413793 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: |8;Splay;902.9126213592233 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6986.111111111111 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: __startTimestamp1447565195529__endTimestamp 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,537 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:202.10 Median:202.10 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: Values: 202.1 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:232.18 Median:232.18 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: Values: 232.2 21:26:35 INFO - 2015-11-14 21:26:35,538 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,539 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:383.88 Median:383.88 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,539 DEBUG : BROWSER_OUTPUT: Values: 383.9 21:26:35 INFO - 2015-11-14 21:26:35,539 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,539 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6823.13 Median:6823.13 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,539 DEBUG : BROWSER_OUTPUT: Values: 6823.1 21:26:35 INFO - 2015-11-14 21:26:35,539 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,539 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2336.45 Median:2336.45 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: Values: 2336.4 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:968.05 Median:968.05 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: Values: 968.1 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16145.16 Median:16145.16 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: Values: 16145.2 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,540 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35396.55 Median:35396.55 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: Values: 35396.6 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:902.91 Median:902.91 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: Values: 902.9 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6986.11 Median:6986.11 stddev:0.00 (0.0%) 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: Values: 6986.1 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:26:35 INFO - 2015-11-14 21:26:35,541 DEBUG : BROWSER_OUTPUT: 21:26:36 INFO - 2015-11-14 21:26:36,342 INFO : Browser exited with error code: 0 21:26:36 INFO - 2015-11-14 21:26:36,366 INFO : Completed test v8_7 (00:00:39) 21:26:36 INFO - 2015-11-14 21:26:36,373 INFO : Completed test suite (00:20:20) 21:26:36 INFO - 2015-11-14 21:26:36,373 DEBUG : Working with test: dromaeo_css 21:26:36 INFO - 2015-11-14 21:26:36,373 DEBUG : Generating results file: dromaeo_css 21:26:36 INFO - 2015-11-14 21:26:36,374 DEBUG : Working with test: kraken 21:26:36 INFO - 2015-11-14 21:26:36,374 DEBUG : Generating results file: kraken 21:26:36 INFO - 2015-11-14 21:26:36,375 INFO : javascript benchmark 21:26:36 INFO - 2015-11-14 21:26:36,375 DEBUG : Working with test: v8_7 21:26:36 INFO - 2015-11-14 21:26:36,375 DEBUG : Generating results file: v8_7 21:26:36 INFO - 2015-11-14 21:26:36,375 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:26:36 INFO - 2015-11-14 21:26:36,548 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 21:26:36 INFO - 2015-11-14 21:26:36,548 DEBUG : process_Request line: dromaeo_css 5428.05 graph.html#tests=[[72,63,55]] 21:26:36 INFO - 2015-11-14 21:26:36,548 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:26:36 INFO - 2015-11-14 21:26:36,656 DEBUG : process_Request line: kraken 1834.80 graph.html#tests=[[232,63,55]] 21:26:36 INFO - 2015-11-14 21:26:36,656 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:26:36 INFO - 2015-11-14 21:26:36,776 DEBUG : process_Request line: v8_7 15132.77 graph.html#tests=[[230,63,55]] 21:26:36 INFO - 2015-11-14 21:26:36,777 INFO : javascript benchmark 21:26:36 INFO - 2015-11-14 21:26:36,779 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [274.578521968778, 275.52747038828403, 276.8491172311092, 284.33323855558723, 284.42120285219573, 14364.281785910702, 14474.782878256834, 14760.26198690064, 14857.925710371446, 14892.478763243302, 13704.862951370484, 13901.235432051259, 14411.0, 15349.155796431192, 15430.61423464414, 3848.7690738555634, 4021.3967904814367, 4413.360062790894, 4521.0, 4559.498455169929, 3930.2139572085553, 3972.523297204325, 3977.065389633434, 3992.540857801361, 4001.0597509585223, 2787.2474431903474, 2861.728135827093, 2880.395117025427, 3925.9803700981456, 3948.9012774680577, 3881.844726210948, 3942.664873485757, 3947.9340578044053, 3962.960370396288, 3974.364101743707, 3333.633300336961, 3380.8478618462227, 3381.7970921744527, 3383.4924761285756, 3388.339273841602, 9084.591193396313, 9371.484568348738, 9457.858132128023, 10260.538275777608, 10593.73515662107, 1510.682756621111, 1531.2114261155514, 1563.577833984829, 1612.6935882182347, 1618.9476840053942, 7511.436642251853, 7723.0, 7768.184340644208, 7811.765647030541, 7896.5262084274555, 1228.8955438787714, 1237.3503910446998, 1244.7572723318956, 1288.2077522323798, 1297.3448408553713, 44851.775741121084, 46645.84189343725, 47737.52262477366, 48781.512184878055, 49137.0, 5238.083335416363, 5317.73411329432, 5335.5464785492895, 5381.596380271495, 5502.477264659851, 6060.181875446847, 6082.452579267887, 6112.449879510777, 6112.541559383064, 6134.018557030854, 4298.118885628439, 4347.087111706577, 4365.345198220292, 4413.668974826901, 4445.822167113344, 4498.910021799546, 4500.684952053325, 4526.569975852289, 4570.8171673133365, 4685.320628508847, 2412.433078226615, 2426.46617744096, 2428.963565546518, 2432.2824766693866, 2436.878156092224, 849.3714651158222, 854.9829003419896, 857.1428571428571, 869.6217145541709, 910.4946754551288, 333.79638420563435, 335.6254499416637, 358.79010778694754, 365.61062468470993, 392.02386058714166, 9039.0, 9651.90348096524, 9672.177864881423, 9759.756006099762, 9846.0, 372.53991320718893, 372.7353578958969, 377.40747027167635, 381.3098292091324, 382.3977235853542, 5111.3189152623245, 5161.406438259573, 5210.5831533477985, 5257.132662315491, 5263.784566841621, 330262.0, 340248.0, 341345.0, 341982.0, 344177.0, 58732.41267587355, 61825.690871545354, 62134.0, 62307.6884615574, 62376.688116559126, 387.61238761238764, 398.2592378176589, 400.45338113474895, 406.8006676728382, 421.5636815895533, 8795.384323097322, 8854.114588541095, 8977.416467929565, 9084.22784063362, 9134.5432728362, 27892.16323510298, 28288.0, 28420.715792841806, 28849.85575072111, 28935.421291574472, 36982.63017369899, 37644.23557644214, 37728.62271377251, 37892.0, 38062.0, 5168.147255702767, 5220.034293655686, 5247.1866860636665, 5262.02652509287, 5262.342207224097, 9620.95189524048, 9789.51052447389, 9889.357191782512, 10027.398356098365, 10061.346012509164, 8341.0, 8396.454230475, 8592.441491303045, 8670.046294907681, 8678.913210868062, 8133.75598732039, 8204.343652507905, 8283.337333013465, 8292.0, 8505.404621676671, 8474.957625211835, 8606.096359882122, 8611.784705382415, 8818.735437936872, 8841.55792210374, 5104.821331253388, 5112.028714544224, 5159.716215608178, 5160.948390516047, 5167.92248116271, 7846.921530784619, 8142.959285203536, 8311.33509319265, 8338.791530211793, 8386.077531471412], "dojo.html": [2579.625954236637, 2584.5218634552607, 2589.184406911823, 2599.6360509528663, 2681.8256813307135, 4158.106007208449, 4191.3503406971895, 4347.630451411634, 4377.080813029268, 4459.041306119184, 4360.716553424025, 4399.604035636792, 4405.493368262642, 4462.642988560915, 4510.368548403226, 4013.1973605278913, 4016.2168377166463, 4101.405296232045, 4146.232946904817, 4179.3939878717565, 4142.751434913915, 4145.316022856225, 4181.958180418203, 4265.637420819234, 4266.040140968288, 3989.9202015959518, 4055.959440405617, 4086.6730661547003, 4095.365218391154, 4158.355454904495, 4010.0, 4113.9098138992895, 4114.794260286973, 4155.97922010391, 4186.58134186582, 4089.3865920111925, 4095.4061661059277, 4121.278776214181, 4143.606357396043, 4165.10450253197, 4219.493660760698, 4333.891652708676, 4342.261815491374, 4435.423394958667, 4474.753888536129, 4519.435070616173, 4588.357629931812, 4659.58063774262, 4672.626189904833, 4688.906221875543, 4716.221823399135, 4729.9763501182615, 4736.786844592001, 4782.928256076161, 4806.927896081562, 4220.155968806251, 4333.133373325348, 4417.911641767147, 4445.022095139064, 4454.420925279693, 4740.241561350236, 4810.4467986181335, 4842.806287748451, 4871.585915197177, 4919.262110683426, 4569.405977222939, 4574.382458368144, 4616.699914505546, 4660.720356778605, 4663.230566956414, 4584.129015487047, 4618.284165954283, 4627.838025669153, 4707.03505781314, 4812.927806082912, 4518.6611004174165, 4585.862424127282, 4603.516630753789, 4644.396228490275, 4695.624350051988, 4661.650376221797, 4663.393758811333, 4665.113628410591, 4674.0, 4699.765011749399, 3493.7729047611824, 3591.44332628443, 3636.5090712753968, 3657.6890964268337, 3664.065663255906, 3190.027041752288, 3281.753868459875, 3296.8846090386724, 3301.2737197816923, 3308.4044871923284, 4433.334999750064, 4441.244988351988, 4445.066536027406, 4451.844185453559, 4495.393121928563, 4634.328022436728, 4677.95322046782, 4733.455652599926, 4785.449673287547, 4842.83050093245, 4321.5678432157165, 4403.625691816167, 4415.006623509685, 4420.513743488214, 4456.598906098467, 4167.604077612622, 4230.703850730481, 4240.5123410808155, 4249.766262855573, 4255.893602659897, 4795.904081918272, 4871.171900776805, 4920.6309526785635, 4923.77842997066, 4986.925196121989, 4728.763561821964, 4746.4541577719, 4746.97626511879, 4764.8326160091, 4783.95216047835, 4925.236588328815, 4963.553280204799, 4984.327115839315, 4987.002599480046, 4991.401031876198, 4483.394741709958, 4670.743109129031, 4672.462666793363, 4740.5733483986605, 4800.0399920016835, 4630.976845115888, 4650.627949764078, 4689.085628302449, 4693.718376897397, 4713.952860471351, 4432.423784907941, 4594.839180628662, 4613.630909527297, 4621.098885717252, 4663.673542851968, 4404.889877753082, 4573.3368661544555, 4603.171429142786, 4639.744814035261, 4672.159011377985, 4406.471223453206, 4461.687681862369, 4500.099980003947, 4511.9323210151215, 4524.796384162786, 4614.838480653161, 4672.696274742131, 4706.647001474971, 4716.622670186308, 4727.881802954954, 4422.977885110554, 4511.09778044399, 4566.1552612766745, 4604.125216209043, 4628.560286772751], "mootools.html": [1289.3682095773074, 1383.4189640351053, 1398.4825614522629, 1441.8413974462808, 1458.8030615866855, 5716.3426205986325, 6023.879522409555, 6311.621302721835, 6372.872542549147, 6390.329015453381, 6541.084248205243, 6567.8358041049, 6640.568363056398, 6648.567843090195, 6690.63201523916, 1675.4219794171022, 1686.6879627268934, 1713.0406972095604, 1713.4431309824295, 1723.9482815515555, 1940.8835469871783, 1943.3392646500188, 1947.4449781812186, 1949.6198241342943, 1993.0931426201043, 1890.3383815664545, 1900.2114122639089, 1906.0946050625912, 1916.396335154429, 1919.5968846542173, 1844.9169787359601, 1900.3443811884877, 1900.752902122729, 1900.9809901900942, 1909.484439201408, 1909.837663798579, 1918.9424317270364, 1919.6352692988287, 1940.194819150051, 1941.4466876940146, 5854.414558544154, 6540.70566824494, 6627.105340778981, 6637.966810165966, 6643.435307998826, 3814.218085292536, 3887.3974533947285, 3975.582563830814, 4017.2367250222364, 4078.5309689385804, 2462.236706620953, 2467.8395904266167, 2484.627305904111, 2497.7502249775057, 2524.9495010099695, 757.5871150223142, 778.0546635837428, 786.1666633368648, 800.7077416742906, 806.7257132574953, 8732.51971141587, 8840.557972101433, 8851.77870553235, 8883.466991980502, 8900.643974241022, 3630.473581330745, 3803.410471376941, 3804.5814960354337, 3854.768713877176, 3883.7863917484246, 7624.970628965129, 7661.195574464712, 7687.346575541142, 7727.1886451922865, 7733.8453230935065, 4235.8729238122905, 4236.788160591958, 4236.915261694749, 4241.491021077491, 4296.419983302214, 3835.884923452301, 3848.3457812171996, 3850.268448994682, 3866.4200369944733, 3883.2233553289457, 2896.0877323642985, 2942.058541266817, 2952.7490163336356, 2965.339409930403, 2990.0, 993.6522217223913, 993.6571882700457, 998.1665309466676, 1001.3791449301334, 1015.751140970467, 1062.166199533378, 1090.3948308688755, 1093.9507722152523, 1119.457063324287, 1137.0051205195455, 6241.18864547615, 6282.654454005074, 6311.211098612674, 6315.179026726496, 6359.427651511386, 401.6405317241053, 413.1901473112733, 414.29156142995816, 415.42256263793354, 420.4051267456515, 4538.2511885538515, 4758.07217592573, 4808.687435316693, 4835.492273311252, 4873.439554451284, 7350.816229594303, 7440.776776696708, 7790.493617914931, 7926.682932682744, 8001.0, 7752.728654497066, 7810.1799311072655, 7906.486078404885, 7936.127026027132, 8014.158513356014, 5989.52083833301, 6182.752689892354, 6215.06773983897, 6231.999999999909, 6270.31026587075, 5989.311229208697, 6008.789692360747, 6035.939640603538, 6066.211392518944, 6069.2110025696375, 6779.220389655253, 6827.317268273133, 6913.723451061901, 6983.1620205575655, 7045.506814522934, 6924.688389022405, 7117.501774875709, 7240.674169662272, 7242.529235599669, 7256.492045556761, 5602.467765562265, 5712.0, 5759.078547432391, 5788.9131663024245, 5833.620814647034, 6061.787837425669, 6244.125822384779, 6358.904616430665, 6417.422431981144, 6491.578047426902, 5717.456841600041, 5848.356680765028, 5974.372690867396, 6049.969750151221, 6070.180525628984, 5749.741261643152, 5781.392953739965, 5943.940560594338, 5972.163897054329, 6053.092036194606, 5973.790917317873, 5993.0, 6055.576109672281, 6103.115048318058, 6115.571909966259, 5469.72651367438, 5473.206385074062, 5510.91733623988, 5556.055470570093, 5560.777568897199, 5569.415211402907, 5645.209670646031, 5648.491635752802, 5649.774009039593, 5664.85837854057], "ext.html": [434.1512343368714, 440.3219042674282, 446.0321103206044, 451.44697745262056, 474.43542184800066, 25711.35721606961, 26353.736462635392, 31960.20099497511, 32190.83904580474, 32663.1834204145, 34069.0, 34580.65419345806, 35115.64884351162, 35128.2974340513, 35247.647523524756, 6784.084148639944, 7131.928680713191, 7417.295356941082, 7426.071741032371, 7524.510906791068, 6778.5593936394225, 7010.6494675266285, 8944.8658270126, 9285.860712089325, 9320.254379649612, 8900.599473023696, 8950.597223124942, 9005.684801031965, 9117.361784675075, 9155.54222288883, 6771.8984215236815, 7068.08114945059, 8946.23956963659, 9037.909620903773, 9112.179903808688, 6625.86748265032, 9096.408733432305, 9108.089191080906, 9142.908570914338, 9256.490893000882, 32365.190870228198, 32431.351372972644, 32973.83513082443, 33054.66945330564, 33091.83454082714, 2327.7206735191717, 2438.8536687798787, 2530.7722304992453, 2627.4219671672204, 2694.5149873022847, 22075.33773986783, 22321.672486328418, 22343.514225526662, 22351.0, 22641.660375094223, 1972.7829938706732, 2004.9699254511195, 2033.3188381892085, 2039.5003224210163, 2044.570640165567, 229409.0, 230227.0, 231005.0, 231945.0, 232240.0, 47033.29450058252, 47067.0, 47342.526574734504, 47356.526434735904, 47514.52485475101, 46432.5356746435, 47812.5218747815, 51336.74331628318, 52135.0, 52510.0, 11867.703307417383, 11956.581519646945, 11975.520979160736, 12054.397280135958, 12139.150259481752, 9029.36794424384, 9086.500242486594, 9120.130373273463, 9161.404508706913, 9165.266778657824, 14947.103173809606, 15031.248437578077, 15187.392504299925, 15544.0, 15882.920585397, 6156.445919867144, 6767.120274364301, 6785.423239024738, 6815.863682726318, 6890.621015844176, 802.8916096327038, 824.6206744897414, 909.9909000910038, 914.8764916736288, 941.4915945389413, 22563.210287639853, 22744.545109098057, 22778.544429111324, 22793.658095128587, 22828.4292892679, 775.042822114688, 867.0852250875387, 887.4675194883018, 914.9085091490931, 983.2036050798876, 12231.57189498381, 12605.306708130958, 12725.300108494122, 12738.554150604685, 12942.158759680591, 233958.0, 237920.0, 238577.0, 240151.0, 241696.0, 45128.3230751539, 45418.77290613526, 45546.0, 45845.31232031522, 45846.0, 953.7234202081319, 1038.2783965144304, 1073.1575713065206, 1138.7153211697075, 1143.382573410349, 21770.346889593337, 22131.668024979317, 22154.22460213885, 22298.331050068526, 22464.32607021792, 34286.65713342834, 34447.65552344545, 34598.30803383868, 34647.65352346444, 34965.0, 232085.0, 238894.0, 241753.0, 246398.0, 252076.0, 22908.77091229133, 23144.421389464726, 23206.3038108857, 23547.882260588587, 23570.528589428457, 30498.847505763217, 30516.0, 34010.31979360448, 34041.65958340484, 34236.0, 28295.0, 28896.566551501324, 29009.854950725112, 29026.12921612355, 29309.12072637824, 26515.07197248164, 27235.0, 27286.863565682044, 27403.867581152666, 27850.721492784814, 28771.424571508873, 29227.41545169127, 29526.114216573536, 29548.704512954595, 29615.851920740257, 24107.879460602584, 25186.37034074163, 25196.0, 25439.61840572356, 25951.870240648677, 18130.909345453187, 18366.632667346847, 18534.0, 18727.906360468656, 26510.0], "prototype.html": [260.4556476963147, 267.2636885380776, 267.6801222539066, 269.9257704131364, 276.1797461539228, 4724.763761811912, 5110.054639891618, 5169.250458683493, 5183.455737147592, 5190.429052804193, 5041.974790126053, 5049.4698056704065, 5110.18237082066, 5246.475352464751, 5257.316548848654, 3765.6046115157924, 3925.5681874993797, 3950.0, 4011.8997025074314, 4087.264292427377, 3858.344081506151, 3887.280853042182, 3892.637576848095, 3967.226390853785, 3974.304496713078, 3882.165334453092, 3936.6063393660547, 3954.4463775071513, 3967.801609919507, 3979.960200397988, 3961.1681546875193, 3963.7027222958395, 3971.6624086952643, 3974.4960674774707, 3983.0, 3405.7956522608724, 3407.807267456395, 3413.0955296846355, 3416.9487457688156, 3422.5208470814105, 4969.602431805447, 5077.847664570068, 5081.237814327844, 5104.872378190575, 5105.412877519096, 4431.512533621331, 4470.508244093147, 4489.236829738952, 4490.7979140938405, 4501.48232953208, 5456.399796022434, 5484.91772623411, 5495.313085864267, 5510.366307874566, 5511.834644960658, 3504.929901401983, 3598.748087633867, 3606.8376923038527, 3628.2924829658227, 3669.541307336583, 5702.3157221133315, 5747.626404283708, 5777.624454410492, 5795.2176456178295, 5812.157237200582, 3713.0717320669833, 3756.2111956488898, 3757.1170774867883, 3760.6803421708914, 3789.0, 3774.433834924728, 3780.4518344839844, 3829.2532956073856, 3830.71269654777, 3846.519185101862, 4172.4784401949755, 4379.802908869108, 4387.254166791653, 4393.450818647669, 4484.0, 5413.593980451403, 5470.452954704498, 5478.369987451494, 5488.9725551372785, 5561.749721262553, 1294.6828027133224, 1299.8895093916933, 1303.1985329022582, 1318.2222488731695, 1321.3393303348325, 840.4159109418895, 841.6296829395046, 854.2781349759567, 856.2422256303092, 862.844687956174, 5232.895342093137, 5281.973590132025, 5294.947050529522, 5303.363596368384, 5314.362276526765, 5677.460641239076, 5681.119426488901, 5713.914291285634, 5717.685527295956, 5757.337906140764, 5245.213218017328, 5321.281626980385, 5324.467553244722, 5329.094054010828, 5339.519443250126, 3023.6220472440946, 3053.603031605877, 3109.0051183621026, 3123.7344825689615, 3130.9373812523622, 5979.073243647242, 5987.491063259585, 6000.309964354068, 6012.488938440281, 6036.456718895321, 5908.734106965111, 5921.28944526651, 5923.763049478059, 5925.762969481259, 5937.990541607937, 5817.621854579608, 5957.463828255478, 5973.940260597426, 6030.065339872327, 6031.276246850406, 5680.091185410314, 5693.430656934273, 5702.885942281214, 5702.942970570241, 5714.028615135354, 5446.264754258124, 5579.721013949367, 5585.162225666182, 5620.494155526022, 5653.236813030353, 5908.970455147697, 6016.939830601638, 6054.122152287981, 6058.757649693963, 6084.148219249397, 3723.7579557328686, 3727.4036154215196, 3729.254149170231, 3731.6268373162466, 3740.8877733668032, 5627.240322556402, 5731.971340143273, 5750.079987202195, 5752.108423194411, 5779.508741756998, 5584.301962254718, 5596.0, 5602.0, 5602.579806514446, 5617.719114044363, 5568.0, 5578.972105139448, 5583.0, 5607.299087614048, 5618.157276408571, 5282.656627319212, 5424.213489044146, 5461.5357694596405, 5505.834824955257, 5506.504414602705, 5303.36359636846, 5501.3948465667945, 5540.916886246629, 5586.944130558805, 5588.050031494575, 5415.0252954467, 5447.918281225864, 5462.044142275006, 5483.424240454695, 5483.890322193613], "yui.html": [532.2256117349256, 580.0487200990376, 595.5414330965157, 626.9811905642827, 627.3663599764237, 11105.83341249882, 11317.434128293584, 11317.603883864067, 11349.20555561111, 11497.540098396075, 11457.828132578017, 11616.36110013949, 11672.533098676064, 11702.941485292582, 11722.941385293083, 538.0933127679872, 574.7930744931821, 717.6698718589455, 723.0672432561988, 724.6485454554537, 564.906790379589, 711.214108410207, 713.4363852556475, 714.085969958454, 716.7849645106473, 729.5367441674548, 742.7103429662436, 747.5439981611213, 748.2031636307343, 749.2245525880714, 584.4185035889317, 592.8962431574457, 592.9673867937262, 732.1470486882802, 744.7579536650583, 530.5119290252976, 537.7580088959944, 537.8467136865975, 539.0136051026612, 540.3057071662934, 11004.724881877937, 11014.889851101467, 11036.172287078502, 11044.33733975964, 11114.333140011626, 6818.318168183192, 7140.678669459887, 7781.844363112706, 7988.081370642392, 8105.799063716262, 7164.605946672931, 7331.083614548182, 7478.740610643138, 7553.471257012011, 7696.538207707556, 2371.5494056129282, 2437.914672986437, 2508.648789169518, 2515.559777039011, 2607.478504299129, 37075.07312317187, 37962.0, 37986.05034874123, 38185.23629527394, 38204.61795382039, 5618.690971996498, 5668.546516278688, 5678.14827775837, 5720.227769251181, 5896.056630939115, 9959.701208963743, 10046.29675922693, 10054.0, 10092.192624590016, 10121.898781012243, 5172.689638621695, 5188.403333616682, 5233.319668443154, 5407.8643484867835, 5425.430329815313, 2970.064429704636, 3014.5628883811723, 3083.5066389377594, 3101.705337992887, 3145.5056764920446, 2216.3240211735574, 2252.7859853313907, 2253.628151355008, 2254.1884921428273, 2255.943601409945, 324.0327622048184, 334.3613697837168, 338.02142796604187, 338.18666108010274, 338.21365325618035, 477.40086191829727, 493.4079105073854, 507.4620901844057, 508.9185730283211, 525.3170877858769, 5941.762329506858, 6710.261871194165, 6737.3599508046655, 6848.280930502325, 7207.603581802946, 382.8533542041603, 485.7231378114511, 504.6669198329085, 529.6583703511213, 536.2679941879306, 3026.72759451646, 3115.2523394385184, 3246.756493263015, 3327.4842399428126, 3360.22714775603, 44462.0, 44929.0, 44977.325340119925, 46634.30048549274, 49057.509424906006, 38661.80669096693, 39544.40683389751, 39587.40618890719, 39698.60301396949, 40335.79832100821, 37815.08403907475, 38833.80583097123, 38878.22243555113, 39163.0, 39292.41061384082, 6476.902846457401, 6741.797746067626, 6815.352541508549, 6969.2682268361095, 7023.894641580483, 26276.56090274823, 26616.0, 27497.0, 27678.0, 27892.721072789012, 36456.27087458183, 37262.44106338461, 37280.594313824884, 38033.23933521259, 38705.6129438702, 6235.407636274546, 6248.687565621792, 6481.449076828522, 6564.113844630913, 6593.670316484253, 9013.639454422011, 9158.58786354629, 9202.125798049176, 9252.722418327192, 9295.67465138717, 8599.637555579782, 8676.826463470821, 8774.385792994684, 8852.336074794544, 9468.715938521855, 8702.477851328687, 8734.170253825876, 8990.730278091667, 8999.955000224956, 9013.90986090157, 6983.790486285419, 7967.482113662593, 8755.212030916993, 8864.556772161237, 8890.688825891062, 7393.297636724503, 7446.776596702108, 7653.770386888402, 7976.561289129154, 8160.877586836321, 6001.36985616504, 7379.114506259283, 7530.246975302426, 7538.359239464707, 7838.746920028125]}, "summary": {"lowerIsBetter": false, "suite": 5428.053396641016, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5446.023490532451, "unit": "ms", "value": 5446.023490532451}, "dojo.html": {"lowerIsBetter": false, "filtered": 4364.506340243362, "unit": "ms", "value": 4364.506340243362}, "mootools.html": {"lowerIsBetter": false, "filtered": 3704.9720738241786, "unit": "ms", "value": 3704.9720738241786}, "ext.html": {"lowerIsBetter": false, "filtered": 14909.589940641325, "unit": "ms", "value": 14909.589940641325}, "prototype.html": {"lowerIsBetter": false, "filtered": 4110.366573254653, "unit": "ms", "value": 4110.366573254653}, "yui.html": {"lowerIsBetter": false, "filtered": 4738.88317286241, "unit": "ms", "value": 4738.88317286241}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0061"}, "testrun": {"date": 1447563976, "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": "20151114194733", "branch": "Mozilla-Inbound", "revision": "0f6a404c8d78a4a9a38f1078424a7f33643019a4"}}, {"talos_counters": {}, "results": {"audio-dft": [193.0, 197.0, 195.0, 194.0, 189.0, 196.0, 199.0, 197.0, 195.0, 189.0], "ai-astar": [126.0, 131.0, 133.0, 130.0, 131.0, 131.0, 131.0, 130.0, 126.0, 144.0], "imaging-gaussian-blur": [149.0, 141.0, 149.0, 142.0, 142.0, 148.0, 147.0, 135.0, 141.0, 148.0], "audio-beat-detection": [188.0, 160.0, 187.0, 197.0, 157.0, 183.0, 179.0, 155.0, 198.0, 157.0], "json-stringify-tinderbox": [77.0, 80.0, 84.0, 86.0, 85.0, 86.0, 86.0, 85.0, 86.0, 86.0], "stanford-crypto-pbkdf2": [168.0, 174.0, 189.0, 187.0, 187.0, 175.0, 187.0, 185.0, 187.0, 172.0], "json-parse-financial": [72.0, 67.0, 69.0, 75.0, 72.0, 73.0, 74.0, 83.0, 70.0, 73.0], "stanford-crypto-sha256-iterative": [81.0, 81.0, 86.0, 86.0, 86.0, 86.0, 87.0, 87.0, 87.0, 87.0], "audio-fft": [90.0, 90.0, 102.0, 147.0, 85.0, 90.0, 85.0, 87.0, 138.0, 82.0], "imaging-darkroom": [148.0, 156.0, 154.0, 154.0, 155.0, 154.0, 155.0, 155.0, 155.0, 154.0], "stanford-crypto-ccm": [164.0, 162.0, 160.0, 150.0, 163.0, 166.0, 162.0, 160.0, 151.0, 155.0], "audio-oscillator": [116.0, 117.0, 171.0, 109.0, 111.0, 116.0, 163.0, 110.0, 108.0, 158.0], "stanford-crypto-aes": [97.0, 105.0, 105.0, 103.0, 102.0, 106.0, 108.0, 111.0, 108.0, 104.0], "imaging-desaturate": [115.0, 124.0, 115.0, 120.0, 117.0, 125.0, 114.0, 123.0, 115.0, 129.0]}, "summary": {"lowerIsBetter": true, "suite": 1834.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 99.6, "unit": "ms", "value": 99.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 181.1, "unit": "ms", "value": 181.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 176.1, "unit": "ms", "value": 176.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 159.3, "unit": "ms", "value": 159.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 154.0, "unit": "ms", "value": 154.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.8, "unit": "ms", "value": 72.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 127.9, "unit": "ms", "value": 127.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 131.3, "unit": "ms", "value": 131.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 194.4, "unit": "ms", "value": 194.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 85.4, "unit": "ms", "value": 85.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 84.1, "unit": "ms", "value": 84.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 144.2, "unit": "ms", "value": 144.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 104.9, "unit": "ms", "value": 104.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 119.7, "unit": "ms", "value": 119.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0061"}, "testrun": {"date": 1447563976, "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": "20151114194733", "branch": "Mozilla-Inbound", "revision": "0f6a404c8d78a4a9a38f1078424a7f33643019a4"}}, {"talos_counters": {}, "results": {"DeltaBlue": [232.18017181332715], "Encrypt": [383.8771593090211], "NavierStokes": [6986.111111111111], "Decrypt": [6823.1292517006805], "Splay": [902.9126213592233], "Richards": [202.1018593371059], "RegExp": [35396.55172413793], "Earley": [968.054211035818], "Boyer": [16145.161290322581], "RayTrace": [2336.448598130841]}, "summary": {"lowerIsBetter": false, "suite": 15132.767839618344, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 284.77022600000004, "unit": "score", "value": 284.77022600000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 693.4015049999999, "unit": "score", "value": 693.4015049999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 212.42147117296216, "unit": "score", "value": 212.42147117296216}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.01157228315055, "unit": "score", "value": 39.01157228315055}, "Splay": {"lowerIsBetter": false, "filtered": 90.2534731182796, "unit": "score", "value": 90.2534731182796}, "RegExp": {"lowerIsBetter": false, "filtered": 25.73654651729177, "unit": "score", "value": 25.73654651729177}, "Richards": {"lowerIsBetter": false, "filtered": 174.674296, "unit": "score", "value": 174.674296}, "Earley": {"lowerIsBetter": false, "filtered": 688.4562790000001, "unit": "score", "value": 688.4562790000001}, "Boyer": {"lowerIsBetter": false, "filtered": 41.2794265734266, "unit": "score", "value": 41.2794265734266}, "RayTrace": {"lowerIsBetter": false, "filtered": 316.7152919999999, "unit": "score", "value": 316.7152919999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0061"}, "testrun": {"date": 1447563976, "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": "20151114194733", "branch": "Mozilla-Inbound", "revision": "0f6a404c8d78a4a9a38f1078424a7f33643019a4"}}] 21:26:36 INFO - RETURN: dromaeo_css: 5428.05 21:26:36 INFO - RETURN: kraken: 1834.80 21:26:36 INFO - RETURN: v8_7: 15132.77 21:26:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15132.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1834.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5428.05"}}} 21:26:36 INFO - Return code: 0 21:26:36 INFO - # TBPL SUCCESS # 21:26:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:26:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:26:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:26:36 INFO - 2015-11-14 21:26:36.888 screenresolution[1666:10535] starting screenresolution argv=screenresolution get 21:26:36 INFO - 2015-11-14 21:26:36.891 screenresolution[1666:10535] Display 0: 1600x1200x32@60 21:26:36 INFO - 2015-11-14 21:26:36.898 screenresolution[1667:10538] starting screenresolution argv=screenresolution list 21:26:36 INFO - Available Modes on Display 0 21:26:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:26:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:26:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:26:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:26:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:26:37 INFO - Intel HD Graphics 3000: 21:26:37 INFO - Chipset Model: Intel HD Graphics 3000 21:26:37 INFO - Type: GPU 21:26:37 INFO - Bus: Built-In 21:26:37 INFO - VRAM (Total): 512 MB 21:26:37 INFO - VRAM (Dynamic, Max): 10 21:26:37 INFO - Vendor: Intel (0x8086) 21:26:37 INFO - Device ID: 0x0116 21:26:37 INFO - Revision ID: 0x0009 21:26:37 INFO - Displays: 21:26:37 INFO - Display: 21:26:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:26:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:26:37 INFO - Display Serial Number: 1600x1200 60 21:26:37 INFO - Main Display: Yes 21:26:37 INFO - Mirror: Off 21:26:37 INFO - Online: Yes 21:26:37 INFO - Rotation: Supported 21:26:37 INFO - Return code: 0 21:26:37 INFO - Running post-action listener: _resource_record_post_action 21:26:37 INFO - Running post-run listener: _resource_record_post_run 21:26:38 INFO - Total resource usage - Wall time: 1265s; CPU: 30.0%; Read bytes: 40539136; Write bytes: 687358976; Read time: 5211; Write time: 50208 21:26:38 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 338784768; Write bytes: 334116864; Read time: 37806; Write time: 4928 21:26:38 INFO - run-tests - Wall time: 1222s; CPU: 30.0%; Read bytes: 38810624; Write bytes: 342035456; Read time: 4711; Write time: 44863 21:26:38 INFO - Running post-run listener: _upload_blobber_files 21:26:38 INFO - Blob upload gear active. 21:26:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:26:38 INFO - Copying logs to upload dir... 21:26:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1353.433493 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2015-11-14 21:26:38.359828) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 21:26:38.363733) ========= 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.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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/YMFGrsHfTCa3fNukodV3kw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/YMFGrsHfTCa3fNukodV3kw/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-14 21:26:38.393879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:26:38.394370) ========= 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.cJziLkNlCJ/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.xmAKcghXCk/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.005864 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 21:26:38.446340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 21:26:38.446755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 21:26:38.447308) ========= ========= Total master_lag: 0.59 =========