builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0086 starttime: 1447860079.67 results: success (0) buildid: 20151118054924 builduid: f3a1d1c96e214e44ae8161e445967028 revision: f8cc032951d3e6546c78816dc2bfae80461e1feb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.671327) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.671756) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.672065) ========= 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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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.006611 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.696417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.696731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.712380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.712654) ========= 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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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.005858 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.762398) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.762759) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.763156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.763447) ========= 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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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-18 07:21:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.5M=0s 2015-11-18 07:21:19 (26.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.902423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.902738) ========= 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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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.022469 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:19.952764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-18 07:21:19.953121) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8cc032951d3e6546c78816dc2bfae80461e1feb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8cc032951d3e6546c78816dc2bfae80461e1feb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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-18 07:21:20,041 truncating revision to first 12 chars 2015-11-18 07:21:20,042 Setting DEBUG logging. 2015-11-18 07:21:20,042 attempt 1/10 2015-11-18 07:21:20,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8cc032951d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 07:21:20,517 unpacking tar archive at: mozilla-central-f8cc032951d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754918 ========= master_lag: 3.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-18 07:21:23.916517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:23.916899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:23.935041) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:23.935397) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:21:23.935873) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-18 07:21:23.936194) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:21:24 INFO - MultiFileLogger online at 20151118 07:21:24 in /builds/slave/test 07:21:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:21:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:21:24 INFO - {'append_to_log': False, 07:21:24 INFO - 'base_work_dir': '/builds/slave/test', 07:21:24 INFO - 'blob_upload_branch': 'Firefox', 07:21:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:21:24 INFO - 'branch': 'Firefox', 07:21:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:21:24 INFO - 'config_files': ('talos/mac_config.py',), 07:21:24 INFO - 'default_actions': ('clobber', 07:21:24 INFO - 'read-buildbot-config', 07:21:24 INFO - 'download-and-extract', 07:21:24 INFO - 'populate-webroot', 07:21:24 INFO - 'create-virtualenv', 07:21:24 INFO - 'install', 07:21:24 INFO - 'run-tests'), 07:21:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:21:24 INFO - 'download_minidump_stackwalk': True, 07:21:24 INFO - 'download_symbols': 'ondemand', 07:21:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:21:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:21:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:21:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:21:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:21:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:21:24 INFO - 'installer_path': 'installer.exe', 07:21:24 INFO - 'log_level': 'info', 07:21:24 INFO - 'log_name': 'talos', 07:21:24 INFO - 'log_to_console': True, 07:21:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:21:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:21:24 INFO - 'opt_config_files': (), 07:21:24 INFO - 'pip_index': False, 07:21:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:21:24 INFO - 'cmd': ('bash', 07:21:24 INFO - '-c', 07:21:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:21:24 INFO - 'enabled': True, 07:21:24 INFO - 'halt_on_failure': False, 07:21:24 INFO - 'name': 'check_screen_resolution'},), 07:21:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:21:24 INFO - 'cmd': ('bash', 07:21:24 INFO - '-c', 07:21:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:21:24 INFO - 'enabled': True, 07:21:24 INFO - 'halt_on_failure': False, 07:21:24 INFO - 'name': 'check_screen_resolution'},), 07:21:24 INFO - 'run_cmd_checks_enabled': True, 07:21:24 INFO - 'sps_profile': False, 07:21:24 INFO - 'sps_profile_interval': 0, 07:21:24 INFO - 'suite': 'dromaeojs', 07:21:24 INFO - 'system_bits': '64', 07:21:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:21:24 INFO - 'title': 't-yosemite-r5-0086', 07:21:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:21:24 INFO - 'use_talos_json': True, 07:21:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:21:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:21:24 INFO - 'work_dir': 'build'} 07:21:24 INFO - ##### 07:21:24 INFO - ##### Running clobber step. 07:21:24 INFO - ##### 07:21:24 INFO - Running pre-action listener: _resource_record_pre_action 07:21:24 INFO - Running main action method: clobber 07:21:24 INFO - rmtree: /builds/slave/test/build 07:21:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:21:26 INFO - Running post-action listener: _resource_record_post_action 07:21:26 INFO - ##### 07:21:26 INFO - ##### Running read-buildbot-config step. 07:21:26 INFO - ##### 07:21:26 INFO - Running pre-action listener: _resource_record_pre_action 07:21:26 INFO - Running main action method: read_buildbot_config 07:21:26 INFO - Using buildbot properties: 07:21:26 INFO - { 07:21:26 INFO - "properties": { 07:21:26 INFO - "buildnumber": 486, 07:21:26 INFO - "product": "firefox", 07:21:26 INFO - "script_repo_revision": "production", 07:21:26 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 07:21:26 INFO - "repository": "", 07:21:26 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 07:21:26 INFO - "buildid": "20151118054924", 07:21:26 INFO - "slavename": "t-yosemite-r5-0086", 07:21:26 INFO - "pgo_build": "False", 07:21:26 INFO - "basedir": "/builds/slave/test", 07:21:26 INFO - "project": "", 07:21:26 INFO - "platform": "yosemite", 07:21:26 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:21:26 INFO - "slavebuilddir": "test", 07:21:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:21:26 INFO - "branch": "mozilla-central", 07:21:26 INFO - "repo_path": "mozilla-central", 07:21:26 INFO - "stage_platform": "macosx64", 07:21:26 INFO - "builduid": "f3a1d1c96e214e44ae8161e445967028", 07:21:26 INFO - "revision": "f8cc032951d3e6546c78816dc2bfae80461e1feb" 07:21:26 INFO - }, 07:21:26 INFO - "sourcestamp": { 07:21:26 INFO - "repository": "", 07:21:26 INFO - "hasPatch": false, 07:21:26 INFO - "project": "", 07:21:26 INFO - "branch": "mozilla-central-macosx64-talos", 07:21:26 INFO - "changes": [ 07:21:26 INFO - { 07:21:26 INFO - "category": null, 07:21:26 INFO - "files": [ 07:21:26 INFO - { 07:21:26 INFO - "url": null, 07:21:26 INFO - "name": "https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:21:26 INFO - } 07:21:26 INFO - ], 07:21:26 INFO - "repository": "", 07:21:26 INFO - "rev": "f8cc032951d3e6546c78816dc2bfae80461e1feb", 07:21:26 INFO - "who": "cbook@mozilla.com", 07:21:26 INFO - "when": 1447859538, 07:21:26 INFO - "number": 6677219, 07:21:26 INFO - "comments": "merge fx-team to mozilla-central a=merge", 07:21:26 INFO - "project": "", 07:21:26 INFO - "at": "Wed 18 Nov 2015 07:12:18", 07:21:26 INFO - "branch": "mozilla-central-macosx64-talos", 07:21:26 INFO - "revlink": "", 07:21:26 INFO - "properties": [ 07:21:26 INFO - [ 07:21:26 INFO - "buildid", 07:21:26 INFO - "20151118054924", 07:21:26 INFO - "Change" 07:21:26 INFO - ], 07:21:26 INFO - [ 07:21:26 INFO - "builduid", 07:21:26 INFO - "f3a1d1c96e214e44ae8161e445967028", 07:21:26 INFO - "Change" 07:21:26 INFO - ], 07:21:26 INFO - [ 07:21:26 INFO - "pgo_build", 07:21:26 INFO - "False", 07:21:26 INFO - "Change" 07:21:26 INFO - ] 07:21:26 INFO - ], 07:21:26 INFO - "revision": "f8cc032951d3e6546c78816dc2bfae80461e1feb" 07:21:26 INFO - } 07:21:26 INFO - ], 07:21:26 INFO - "revision": "f8cc032951d3e6546c78816dc2bfae80461e1feb" 07:21:26 INFO - } 07:21:26 INFO - } 07:21:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:21:26 INFO - Running post-action listener: _resource_record_post_action 07:21:26 INFO - ##### 07:21:26 INFO - ##### Running download-and-extract step. 07:21:26 INFO - ##### 07:21:26 INFO - Running pre-action listener: _resource_record_pre_action 07:21:26 INFO - Running main action method: download_and_extract 07:21:26 INFO - mkdir: /builds/slave/test/build/tests 07:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:26 INFO - https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/test_packages.json 07:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/test_packages.json 07:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:21:27 INFO - Downloaded 1149 bytes. 07:21:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:21:27 INFO - Using the following test package requirements: 07:21:27 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:21:27 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:21:27 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:21:27 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:21:27 INFO - u'jsshell-mac.zip'], 07:21:27 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:21:27 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:21:27 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:21:27 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:21:27 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:21:27 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:21:27 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:21:27 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:21:27 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:21:27 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:21:27 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:21:27 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:21:27 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:21:27 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')]} 07:21:27 INFO - https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:21:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:21:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:21:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/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 07:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/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 07:21:28 INFO - Downloaded 17463481 bytes. 07:21:28 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 07:21:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:21:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:21:34 INFO - Return code: 0 07:21:34 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 07:21:34 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')]} 07:21:34 INFO - https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/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 07:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/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 07:21:35 INFO - Downloaded 17463481 bytes. 07:21:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 07:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:21:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:21:43 INFO - Return code: 0 07:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:43 INFO - https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/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 07:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/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 07:21:44 INFO - Downloaded 11131693 bytes. 07:21:44 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 07:21:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:21:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:21:44 INFO - Return code: 0 07:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:44 INFO - https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:21:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:21:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:21:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FrP7aKwjQ7uA_MDcT4htig/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 07:21:48 INFO - Downloaded 108882920 bytes. 07:21:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:21:48 INFO - mkdir: /builds/slave/test/properties 07:21:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:21:48 INFO - Writing to file /builds/slave/test/properties/build_url 07:21:48 INFO - Contents: 07:21:48 INFO - build_url:https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:21:48 INFO - Running post-action listener: _resource_record_post_action 07:21:48 INFO - Running post-action listener: set_extra_try_arguments 07:21:48 INFO - ##### 07:21:48 INFO - ##### Running populate-webroot step. 07:21:48 INFO - ##### 07:21:48 INFO - Running pre-action listener: _resource_record_pre_action 07:21:48 INFO - Running main action method: populate_webroot 07:21:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:21:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:21:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:21:48 INFO - '../fennec_ids.txt'], 07:21:48 INFO - 'tests': ['tcheck2']}, 07:21:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:21:48 INFO - '--tppagecycles', 07:21:48 INFO - '7'], 07:21:48 INFO - 'tests': ['tsvgm']}}, 07:21:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:21:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:21:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:21:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:21:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:21:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:21:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'tests': ['damp', 'tps']}, 07:21:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['damp', 'tps']}, 07:21:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:21:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:21:48 INFO - 'other': {'tests': ['a11yr', 07:21:48 INFO - 'ts_paint', 07:21:48 INFO - 'tpaint', 07:21:48 INFO - 'sessionrestore', 07:21:48 INFO - 'sessionrestore_no_auto_restore']}, 07:21:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['a11yr', 07:21:48 INFO - 'ts_paint', 07:21:48 INFO - 'tpaint', 07:21:48 INFO - 'sessionrestore', 07:21:48 INFO - 'sessionrestore_no_auto_restore']}, 07:21:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['a11yr', 07:21:48 INFO - 'ts_paint', 07:21:48 INFO - 'tpaint', 07:21:48 INFO - 'sessionrestore', 07:21:48 INFO - 'sessionrestore_no_auto_restore']}, 07:21:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['a11yr', 07:21:48 INFO - 'ts_paint', 07:21:48 INFO - 'tpaint', 07:21:48 INFO - 'sessionrestore', 07:21:48 INFO - 'sessionrestore_no_auto_restore']}, 07:21:48 INFO - 'other_l64': {'tests': ['a11yr', 07:21:48 INFO - 'ts_paint', 07:21:48 INFO - 'tpaint', 07:21:48 INFO - 'sessionrestore', 07:21:48 INFO - 'sessionrestore_no_auto_restore']}, 07:21:48 INFO - 'other_nol64': {'tests': ['a11yr', 07:21:48 INFO - 'ts_paint', 07:21:48 INFO - 'tpaint', 07:21:48 INFO - 'sessionrestore', 07:21:48 INFO - 'sessionrestore_no_auto_restore']}, 07:21:48 INFO - 'svgr': {'tests': ['tsvgx', 07:21:48 INFO - 'tsvgr_opacity', 07:21:48 INFO - 'tart', 07:21:48 INFO - 'tscrollx', 07:21:48 INFO - 'cart']}, 07:21:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['tsvgx', 07:21:48 INFO - 'tsvgr_opacity', 07:21:48 INFO - 'tart', 07:21:48 INFO - 'tscrollx', 07:21:48 INFO - 'cart']}, 07:21:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'tests': ['tp5o']}, 07:21:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'talos_options': ['--e10s'], 07:21:48 INFO - 'tests': ['tp5o']}, 07:21:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'talos_options': ['--xperf_path', 07:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:21:48 INFO - 'tests': ['tp5n']}, 07:21:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:48 INFO - 'talos_options': ['--e10s', 07:21:48 INFO - '--xperf_path', 07:21:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:21:48 INFO - 'tests': ['tp5n']}}, 07:21:48 INFO - 'talos.zip': {'path': '', 07:21:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:21:48 INFO - Running post-action listener: _resource_record_post_action 07:21:48 INFO - ##### 07:21:48 INFO - ##### Running create-virtualenv step. 07:21:48 INFO - ##### 07:21:48 INFO - Running pre-action listener: _resource_record_pre_action 07:21:48 INFO - Running main action method: create_virtualenv 07:21:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:21:48 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 07:21:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:21:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:21:48 INFO - Using real prefix '/tools/python27' 07:21:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:21:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:21:53 INFO - Installing pip.................done. 07:21:53 INFO - Return code: 0 07:21:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:53 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 0x10b29b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b278228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a2e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, '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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:21:53 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 07:21:53 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 07:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:53 INFO - 'HOME': '/Users/cltbld', 07:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:53 INFO - 'LOGNAME': 'cltbld', 07:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:53 INFO - 'MOZ_NO_REMOTE': '1', 07:21:53 INFO - 'NO_EM_RESTART': '1', 07:21:53 INFO - 'PAGER': '/bin/cat', 07:21:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:53 INFO - 'PWD': '/builds/slave/test', 07:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:53 INFO - 'SHELL': '/bin/bash', 07:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:21:53 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:53 INFO - 'USER': 'cltbld', 07:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:53 INFO - 'XPC_FLAGS': '0x0', 07:21:53 INFO - 'XPC_SERVICE_NAME': '0', 07:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:53 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 07:21:53 INFO - Cleaning up... 07:21:53 INFO - Return code: 0 07:21:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:53 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 0x10b29b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b278228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a2e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, '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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:21:53 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 07:21:53 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 07:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:53 INFO - 'HOME': '/Users/cltbld', 07:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:53 INFO - 'LOGNAME': 'cltbld', 07:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:53 INFO - 'MOZ_NO_REMOTE': '1', 07:21:53 INFO - 'NO_EM_RESTART': '1', 07:21:53 INFO - 'PAGER': '/bin/cat', 07:21:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:53 INFO - 'PWD': '/builds/slave/test', 07:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:53 INFO - 'SHELL': '/bin/bash', 07:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:21:53 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:53 INFO - 'USER': 'cltbld', 07:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:53 INFO - 'XPC_FLAGS': '0x0', 07:21:53 INFO - 'XPC_SERVICE_NAME': '0', 07:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:54 INFO - Downloading/unpacking psutil>=0.7.1 07:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:21:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:21:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:57 INFO - Installing collected packages: psutil 07:21:57 INFO - Running setup.py install for psutil 07:21:57 INFO - building 'psutil._psutil_osx' extension 07:21:57 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 07:21:57 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 07:21:57 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 07:21:57 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 07:21:57 INFO - building 'psutil._psutil_posix' extension 07:21:57 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 07:21:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:21:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:21:57 INFO - ^ 07:21:57 INFO - 1 warning generated. 07:21:57 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 07:21:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:58 INFO - Successfully installed psutil 07:21:58 INFO - Cleaning up... 07:21:58 INFO - Return code: 0 07:21:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b29b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b278228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a2e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, '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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:21:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:21:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:58 INFO - 'HOME': '/Users/cltbld', 07:21:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:58 INFO - 'LOGNAME': 'cltbld', 07:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:58 INFO - 'MOZ_NO_REMOTE': '1', 07:21:58 INFO - 'NO_EM_RESTART': '1', 07:21:58 INFO - 'PAGER': '/bin/cat', 07:21:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:58 INFO - 'PWD': '/builds/slave/test', 07:21:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:58 INFO - 'SHELL': '/bin/bash', 07:21:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:21:58 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:21:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:58 INFO - 'USER': 'cltbld', 07:21:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:58 INFO - 'XPC_FLAGS': '0x0', 07:21:58 INFO - 'XPC_SERVICE_NAME': '0', 07:21:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:22:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:22:01 INFO - Installing collected packages: mozsystemmonitor 07:22:01 INFO - Running setup.py install for mozsystemmonitor 07:22:01 INFO - Successfully installed mozsystemmonitor 07:22:01 INFO - Cleaning up... 07:22:01 INFO - Return code: 0 07:22:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:22:01 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')]} 07:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:01 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')]} 07:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:01 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 0x10b29b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b278228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a2e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, '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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:22:01 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 07:22:01 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 07:22:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:22:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:01 INFO - 'HOME': '/Users/cltbld', 07:22:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:01 INFO - 'LOGNAME': 'cltbld', 07:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:01 INFO - 'MOZ_NO_REMOTE': '1', 07:22:01 INFO - 'NO_EM_RESTART': '1', 07:22:01 INFO - 'PAGER': '/bin/cat', 07:22:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:01 INFO - 'PWD': '/builds/slave/test', 07:22:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:01 INFO - 'SHELL': '/bin/bash', 07:22:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:22:01 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:22:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:01 INFO - 'USER': 'cltbld', 07:22:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:01 INFO - 'XPC_FLAGS': '0x0', 07:22:01 INFO - 'XPC_SERVICE_NAME': '0', 07:22:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:01 INFO - Downloading/unpacking blobuploader==1.2.4 07:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:22:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:22:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:22:04 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 07:22:04 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 07:22:04 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 07:22:04 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 07:22:04 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 07:22:04 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 07:22:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:22:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:06 INFO - Downloading docopt-0.6.1.tar.gz 07:22:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:22:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:22:06 INFO - Running setup.py install for blobuploader 07:22:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:22:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:22:06 INFO - Running setup.py install for requests 07:22:07 INFO - Running setup.py install for docopt 07:22:07 INFO - Successfully installed blobuploader requests docopt 07:22:07 INFO - Cleaning up... 07:22:07 INFO - Return code: 0 07:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:07 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 0x10b29b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b278228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a2e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, '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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:22:07 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 07:22:07 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 07:22:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:22:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:07 INFO - 'HOME': '/Users/cltbld', 07:22:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:07 INFO - 'LOGNAME': 'cltbld', 07:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:07 INFO - 'MOZ_NO_REMOTE': '1', 07:22:07 INFO - 'NO_EM_RESTART': '1', 07:22:07 INFO - 'PAGER': '/bin/cat', 07:22:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:07 INFO - 'PWD': '/builds/slave/test', 07:22:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:07 INFO - 'SHELL': '/bin/bash', 07:22:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:22:07 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:22:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:07 INFO - 'USER': 'cltbld', 07:22:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:07 INFO - 'XPC_FLAGS': '0x0', 07:22:07 INFO - 'XPC_SERVICE_NAME': '0', 07:22:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:07 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-HdxHTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:07 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-oGRNk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:07 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-u7FINg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:08 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-_W3Res-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:08 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-liaMvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:08 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-0xVf9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:08 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-iXQXhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:08 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-ZIfqDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:08 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-9Iscb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:08 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-jzR0mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:09 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-oox6aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:09 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-4ofmse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:09 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-23PmRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:09 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-4y0fJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:09 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-7L0Xgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:09 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-_nzN8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:09 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-89_GAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:22:10 INFO - Running setup.py install for manifestparser 07:22:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:22:10 INFO - Running setup.py install for mozcrash 07:22:10 INFO - Running setup.py install for mozdebug 07:22:10 INFO - Running setup.py install for mozdevice 07:22:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:22:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:22:10 INFO - Running setup.py install for mozfile 07:22:11 INFO - Running setup.py install for mozhttpd 07:22:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:22:11 INFO - Running setup.py install for mozinfo 07:22:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:22:11 INFO - Running setup.py install for mozInstall 07:22:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:22:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:22:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:22:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:22:11 INFO - Running setup.py install for mozleak 07:22:11 INFO - Running setup.py install for mozlog 07:22:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:22:12 INFO - Running setup.py install for moznetwork 07:22:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:22:12 INFO - Running setup.py install for mozprocess 07:22:12 INFO - Running setup.py install for mozprofile 07:22:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:22:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:22:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:22:12 INFO - Running setup.py install for mozrunner 07:22:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:22:12 INFO - Running setup.py install for mozscreenshot 07:22:13 INFO - Running setup.py install for moztest 07:22:13 INFO - Running setup.py install for mozversion 07:22:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:22:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:22:13 INFO - Cleaning up... 07:22:13 INFO - Return code: 0 07:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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', '-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 0x10b29b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b278228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a2e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, '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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:22:13 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 07:22:13 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 07:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:13 INFO - 'HOME': '/Users/cltbld', 07:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:13 INFO - 'LOGNAME': 'cltbld', 07:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:13 INFO - 'MOZ_NO_REMOTE': '1', 07:22:13 INFO - 'NO_EM_RESTART': '1', 07:22:13 INFO - 'PAGER': '/bin/cat', 07:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:13 INFO - 'PWD': '/builds/slave/test', 07:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:13 INFO - 'SHELL': '/bin/bash', 07:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:22:13 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:13 INFO - 'USER': 'cltbld', 07:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:13 INFO - 'XPC_FLAGS': '0x0', 07:22:13 INFO - 'XPC_SERVICE_NAME': '0', 07:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:13 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-blv8Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:13 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)) 07:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:13 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-YSb_44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:14 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)) 07:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:14 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-BwovRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:14 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)) 07:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:14 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-X9U_cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:14 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)) 07:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:14 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-4FQHRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:14 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)) 07:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:14 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-oqvPL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:14 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)) 07:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:14 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-hT4rib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:14 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)) 07:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:14 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-3NPonZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:14 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)) 07:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:14 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-tvFGfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:15 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)) 07:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:15 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-z0Lj5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:15 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)) 07:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:15 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-bsB5YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:15 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)) 07:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:15 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-dyHii5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:15 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)) 07:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:15 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-oCOvs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:15 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)) 07:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:15 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-Q9DP6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:15 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)) 07:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:15 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-I6zX4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:15 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)) 07:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:15 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-aLeV0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:16 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)) 07:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:16 INFO - Running setup.py (path:/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/pip-rjTvp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:16 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)) 07:22:16 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)) 07:22:16 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)) 07:22:16 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)) 07:22:16 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)) 07:22:16 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)) 07:22:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22:18 INFO - Downloading blessings-1.5.1.tar.gz 07:22:18 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 07:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:22:19 INFO - Installing collected packages: blessings 07:22:19 INFO - Running setup.py install for blessings 07:22:19 INFO - Successfully installed blessings 07:22:19 INFO - Cleaning up... 07:22:19 INFO - Return code: 0 07:22:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:19 INFO - Reading from file tmpfile_stdout 07:22:19 INFO - Current package versions: 07:22:19 INFO - blessings == 1.5.1 07:22:19 INFO - blobuploader == 1.2.4 07:22:19 INFO - docopt == 0.6.1 07:22:19 INFO - manifestparser == 1.1 07:22:19 INFO - mozInstall == 1.12 07:22:19 INFO - mozcrash == 0.16 07:22:19 INFO - mozdebug == 0.1 07:22:19 INFO - mozdevice == 0.47 07:22:19 INFO - mozfile == 1.2 07:22:19 INFO - mozhttpd == 0.7 07:22:19 INFO - mozinfo == 0.9 07:22:19 INFO - mozleak == 0.1 07:22:19 INFO - mozlog == 3.0 07:22:19 INFO - moznetwork == 0.27 07:22:19 INFO - mozprocess == 0.22 07:22:19 INFO - mozprofile == 0.27 07:22:19 INFO - mozrunner == 6.11 07:22:19 INFO - mozscreenshot == 0.1 07:22:19 INFO - mozsystemmonitor == 0.0 07:22:19 INFO - moztest == 0.7 07:22:19 INFO - mozversion == 1.4 07:22:19 INFO - psutil == 3.1.1 07:22:19 INFO - requests == 1.2.3 07:22:19 INFO - wsgiref == 0.1.2 07:22:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:19 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')]} 07:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:19 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')]} 07:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:19 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 0x10b29b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b278228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a2e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, '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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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 07:22:19 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 07:22:19 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 07:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:19 INFO - 'HOME': '/Users/cltbld', 07:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:19 INFO - 'LOGNAME': 'cltbld', 07:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:19 INFO - 'MOZ_NO_REMOTE': '1', 07:22:19 INFO - 'NO_EM_RESTART': '1', 07:22:19 INFO - 'PAGER': '/bin/cat', 07:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:19 INFO - 'PWD': '/builds/slave/test', 07:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:19 INFO - 'SHELL': '/bin/bash', 07:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:22:19 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:19 INFO - 'USER': 'cltbld', 07:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:19 INFO - 'XPC_FLAGS': '0x0', 07:22:19 INFO - 'XPC_SERVICE_NAME': '0', 07:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 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)) 07:22:20 INFO - Cleaning up... 07:22:20 INFO - Return code: 0 07:22:20 INFO - Running post-action listener: _resource_record_post_action 07:22:20 INFO - Running post-action listener: _start_resource_monitoring 07:22:20 INFO - Starting resource monitoring. 07:22:20 INFO - ##### 07:22:20 INFO - ##### Running install step. 07:22:20 INFO - ##### 07:22:20 INFO - Running pre-action listener: _resource_record_pre_action 07:22:20 INFO - Running main action method: install 07:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:20 INFO - Reading from file tmpfile_stdout 07:22:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:22:20 INFO - Reading from file tmpfile_stdout 07:22:20 INFO - Output received: 07:22:20 INFO - Usage: mozinstall [options] installer 07:22:20 INFO - Options: 07:22:20 INFO - -h, --help show this help message and exit 07:22:20 INFO - -d DEST, --destination=DEST 07:22:20 INFO - Directory to install application into. [default: 07:22:20 INFO - "/builds/slave/test"] 07:22:20 INFO - --app=APP Application being installed. [default: firefox] 07:22:20 INFO - mkdir: /builds/slave/test/build/application 07:22:20 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'] 07:22:20 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 07:23:03 INFO - Reading from file tmpfile_stdout 07:23:03 INFO - Output received: 07:23:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:23:03 INFO - Running post-action listener: _resource_record_post_action 07:23:03 INFO - ##### 07:23:03 INFO - ##### Running run-tests step. 07:23:03 INFO - ##### 07:23:03 INFO - Running pre-action listener: _resource_record_pre_action 07:23:03 INFO - Running main action method: run_tests 07:23:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:23:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:23:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:23:03 INFO - 2015-11-18 07:23:03.160 screenresolution[1933:12813] starting screenresolution argv=screenresolution get 07:23:03 INFO - 2015-11-18 07:23:03.164 screenresolution[1933:12813] Display 0: 1600x1200x32@60 07:23:03 INFO - 2015-11-18 07:23:03.171 screenresolution[1934:12815] starting screenresolution argv=screenresolution list 07:23:03 INFO - Available Modes on Display 0 07:23:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:23:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:23:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:23:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:23:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:23:03 INFO - Intel HD Graphics 3000: 07:23:03 INFO - Chipset Model: Intel HD Graphics 3000 07:23:03 INFO - Type: GPU 07:23:03 INFO - Bus: Built-In 07:23:03 INFO - VRAM (Total): 512 MB 07:23:03 INFO - VRAM (Dynamic, Max): 10 07:23:03 INFO - Vendor: Intel (0x8086) 07:23:03 INFO - Device ID: 0x0116 07:23:03 INFO - Revision ID: 0x0009 07:23:03 INFO - Displays: 07:23:03 INFO - Display: 07:23:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:23:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:23:03 INFO - Display Serial Number: 1600x1200 60 07:23:03 INFO - Main Display: Yes 07:23:03 INFO - Mirror: Off 07:23:03 INFO - Online: Yes 07:23:03 INFO - Rotation: Supported 07:23:03 INFO - Return code: 0 07:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:23:03 INFO - Python 2.7.3 07:23:03 INFO - Return code: 0 07:23:03 INFO - grabbing minidump binary from tooltool 07:23: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')]} 07:23:03 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 0x10b1be9f0>, '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 0x10af1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:23:03 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 07:23:03 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 07:23:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:23:03 INFO - Return code: 0 07:23:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:23:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:23:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:23:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:23:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0086', '--webServer', 'localhost'] in /builds/slave/test/build 07:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0086 --webServer localhost 07:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BI1OqtEQOi/Render', 07:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:03 INFO - 'HOME': '/Users/cltbld', 07:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:03 INFO - 'LOGNAME': 'cltbld', 07:23:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:03 INFO - 'MOZ_NO_REMOTE': '1', 07:23:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:03 INFO - 'NO_EM_RESTART': '1', 07:23:03 INFO - 'PAGER': '/bin/cat', 07:23:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:03 INFO - 'PWD': '/builds/slave/test', 07:23:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:03 INFO - 'SHELL': '/bin/bash', 07:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eh7ZUX1GOR/Listeners', 07:23:03 INFO - 'TMPDIR': '/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/', 07:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:03 INFO - 'USER': 'cltbld', 07:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:03 INFO - 'XPC_FLAGS': '0x0', 07:23:03 INFO - 'XPC_SERVICE_NAME': '0', 07:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:23:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0086', '--webServer', 'localhost'] with output_timeout 3600 07:23:03 INFO - mozversion INFO | application_buildid: 20151118054924 07:23:03 INFO - mozversion INFO | application_changeset: f8cc032951d3e6546c78816dc2bfae80461e1feb 07:23:03 INFO - mozversion INFO | application_display_name: Nightly 07:23:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:23:03 INFO - mozversion INFO | application_name: Firefox 07:23:03 INFO - mozversion INFO | application_remotingname: firefox 07:23:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:23:03 INFO - mozversion INFO | application_vendor: Mozilla 07:23:03 INFO - mozversion INFO | application_version: 45.0a1 07:23:03 INFO - mozversion INFO | platform_buildid: 20151118054924 07:23:03 INFO - mozversion INFO | platform_changeset: f8cc032951d3e6546c78816dc2bfae80461e1feb 07:23:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:23:03 INFO - mozversion INFO | platform_version: 45.0a1 07:23:03 INFO - 2015-11-18 07:23:03,852 DEBUG : using testdate: 1447860183 07:23:03 INFO - 2015-11-18 07:23:03,852 DEBUG : actual date: 1447860183 07:23:03 INFO - 2015-11-18 07:23:03,866 INFO : starting webserver on 'localhost:49781' 07:23:03 INFO - 2015-11-18 07:23:03,867 INFO : Starting test suite t-yosemite-r5-0086 07:23:03 INFO - 2015-11-18 07:23:03,867 INFO : Starting test dromaeo_css 07:23:03 INFO - 2015-11-18 07:23:03,867 DEBUG : operating with platform_type : mac_ 07:23:03 INFO - 2015-11-18 07:23:03,868 INFO : Initialising browser for dromaeo_css test... 07:23:03 INFO - 2015-11-18 07:23:03,902 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/tmpqIW6cE/profile http://localhost:49781/getInfo.html 07:23:07 INFO - 2015-11-18 07:23:07,213 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:23:07 INFO - 2015-11-18 07:23:07,213 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:23:07 INFO - 2015-11-18 07:23:07,213 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:23:07 INFO - 2015-11-18 07:23:07,213 DEBUG : BROWSER_OUTPUT: __metrics 07:23:07 INFO - 2015-11-18 07:23:07,233 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:08 INFO - 2015-11-18 07:23:08,037 INFO : Browser initialized. 07:23:08 INFO - 2015-11-18 07:23:08,038 INFO : Running cycle 1/1 for dromaeo_css test... 07:23:08 INFO - 2015-11-18 07:23:08,038 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/tmpqIW6cE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:23:20 INFO - 2015-11-18 07:23:20,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 229945344 07:23:20 INFO - 2015-11-18 07:23:20,256 DEBUG : BROWSER_OUTPUT: 07:24:12 INFO - 2015-11-18 07:24:12,063 DEBUG : BROWSER_OUTPUT: 1447860252060 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] 07:26:21 INFO - 2015-11-18 07:26:21,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49781/tests/dromaeo/cssquery-ext.html) 07:26:23 INFO - 2015-11-18 07:26:23,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 359497728 07:26:23 INFO - 2015-11-18 07:26:23,398 DEBUG : BROWSER_OUTPUT: 07:29:26 INFO - 2015-11-18 07:29:26,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/dromaeo/cssquery-ext.html (next: http://localhost:49781/tests/dromaeo/cssquery-jquery.html) 07:29:27 INFO - 2015-11-18 07:29:27,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 366608384 07:29:27 INFO - 2015-11-18 07:29:27,104 DEBUG : BROWSER_OUTPUT: 07:32:29 INFO - 2015-11-18 07:32:29,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49781/tests/dromaeo/cssquery-mootools.html) 07:32:29 INFO - 2015-11-18 07:32:29,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 332759040 07:32:29 INFO - 2015-11-18 07:32:29,928 DEBUG : BROWSER_OUTPUT: 07:35:32 INFO - 2015-11-18 07:35:32,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49781/tests/dromaeo/cssquery-prototype.html) 07:35:32 INFO - 2015-11-18 07:35:32,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 323256320 07:35:32 INFO - 2015-11-18 07:35:32,865 DEBUG : BROWSER_OUTPUT: 07:38:36 INFO - 2015-11-18 07:38:36,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49781/tests/dromaeo/cssquery-yui.html) 07:38:37 INFO - 2015-11-18 07:38:37,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 329199616 07:38:37 INFO - 2015-11-18 07:38:37,146 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/dromaeo/cssquery-yui.html (next: http://localhost:49781/tests/dromaeo/cssquery-dojo.html) 07:41:40 INFO - 2015-11-18 07:41:40,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 369774592 07:41:40 INFO - 2015-11-18 07:41:40,689 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,690 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:41:40 INFO - 2015-11-18 07:41:40,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:41:40 INFO - 2015-11-18 07:41:40,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:41:40 INFO - 2015-11-18 07:41:40,690 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:41:40 INFO - 2015-11-18 07:41:40,690 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2574.562324404851;2647.563152079907;2667.333166708323;2690.219836247488;2695.703472618012;4321.848735294266;4475.373447717322;4506.549345065492;4508.188526065307;4529.501754806973;4404.779761011952;4484.753338566377;4499.145162419138;4568.086382723461;4605.286180642006;4119.8970025749295;4166.979165104185;4191.308434108369;4242.172776308621;4243;4210.157968406315;4235.74585524868;4257.191133684605;4258.212230737308;4311.051568654907;4018.2365350583295;4124.8556300529335;4138.0689344897455;4152.83388664453;4241.87274381769;4071.470708807836;4159.688023398257;4176.477940257468;4178.435911151986;4192.601702838226;4126.91746165075;4155.501339839208;4156.542780294165;4183.728057676241;4218.008767939563;4235.703500754948;4486.596206341413;4486.910261794778;4523.411956445641;4554.134714404253;4608.976955115237;4696;4699.483056863743;4728.432588089451;4733.786979585927;4813.590844778198;4835;4844.4186697596515;4846.660733748604;4876.4879687633;4500.347449619852;4501.864944051684;4502.842400515999;4518.615917647004;4554.8405805796965;4700.858974230779;4857.854264372075;4925.187344088257;4935;4982.825601103944;4615.169269531517;4626.86119416418;4645.74448405341;4677;4735.692180008288;4842;4859.684120532154;4870.8782280442565;4877.878053048702;4921.212605983025;4597.42532183477;4729.6452766042685;4789.114013907439;4831.178699621073;4854.980454104607;4691.859244222679;4713.151632706145;4738.620910327166;4763;4815.9886423850685;3673.4673472346362;3732.197577520846;3734.047817806442;3739.2521495700425;3752.4934133891575;3295.3244584860045;3388.9663652585705;3404.14896275931;3413.0955296846355;3415.419378705626;4461.888452788641;4520.254158063948;4526.32105184225;4539.477960034638;4565.0641618468135;4868.464468908417;4873.902521949542;4874.53691899269;4891.04624598207;4911.214205727067;4351.4995775485595;4454.28731402974;4565.885852853638;4616.3306320584;4623.606993405531;4137.91724165515;4177.122804211089;4210.768407737603;4226.4505614270565;4228;4829.927551086666;4911.557959783637;4952.232403977389;4955.454899961073;4975.726335051607;4814.20565606671;4818.831340903052;4829.420469543677;4830.420349558076;4845.2732090186755;4770.284457331428;4789.449213340371;4915.65590408668;4928.926066108939;4990.226514890198;4787.664863459524;4787.784549695202;4791.1854984652;4805.879853003563;4831.782569784438;4757.16749568831;4823.324734537237;4873.561379475864;4875.68308059975;4919.557239848431;4521.389612402284;4637.095766325534;4638.976805115953;4647.907041859212;4653.185692503731;4565.954340456553;4640.605548528278;4663.766811659471;4680.882977925579;4728.858134255978;4599.67802253839;4627.838025669085;4651.790669419816;4657.906841863076;4671.7430541320555;4708.952910470988;4723.504032076583;4726.220173671306;4728.692634978715;4770.9980904010545;4456.24243878535;4546.522615125365;4561.178987782231;4573.108243892409;4659.906801863876 07:41:40 INFO - 2015-11-18 07:41:40,691 DEBUG : BROWSER_OUTPUT: |1;ext.html;464.7072344423014;466.43794227955294;471.91033703596315;477.7658947115912;498.53885156230524;26385.20844374667;27001.324966875814;32862.67137328626;33777.32445351091;33814.323713525715;35910.2817943641;36094.09764755876;36262.8186859066;36284;36392.63607363925;6816.045753594476;6971.477139214554;7556.848863022737;7753.147153813076;7776.183500732426;6898.275681053492;6952.2700116487795;7013.719451221945;7049.295070492935;7087.468439867005;9212.539373031355;9426.104520070616;9469.857952130724;9478.620855165786;9483.952580237124;9199.678011269574;9227.44635321883;9304.488253146073;9307.95346023269;9308.813823723487;6963.442924566073;7161.928380716178;7162.033125528039;8923.15230053144;9192.35653504255;26612;26825.46349073027;27093.864530677416;33780;34218.14454638654;2482.193287181673;2493.1024831060804;2515.308290220186;2530.316814460104;2677.250369896432;22691.09235630573;23223.026042786383;23429.531409371888;23704.881475592683;24356.634650480257;1978.1691689490306;2051.128270485038;2066.8863212523456;2075.865068770525;2126.755423126345;355328;361689;362134;362602;364671;48065;49320.506794932306;51919.48080519222;52366;52392.47607523952;45136.77431612821;60417.395826042055;61437;61760.38239617636;61920;13272.601821945356;13731;13833.10084844482;13904.791428128587;13918;10114.595416183418;10367.688969330931;10451.111655509367;10481.008608364386;10508.422036787897;17095.829041709672;17220;17229.91385043067;17258.654826903643;17475.650486990442;6992.440604751608;7262.419006479469;7269.20038795732;7295.89056164158;7375.975849901514;805.6294104711781;832.812617161146;853.4836423963537;868.9355539464106;945.3618807305041;24214;24220.152294669602;24395.14616988397;24400.755992440205;24478.14326498564;850.6002178975872;887.0419946457939;938.6808485115093;946.5314669238771;952.2953014769159;12417.62747117588;13149.408276627575;13463.663408414672;14109.929450352682;14192.503262385768;326046;329839;330187;330286;330919;48736.44585089317;48981.26528102082;48988.510114898396;49001.50998490041;49105.75447122742;1156.2657712352548;1162.6976985983536;1170.8946194842506;1174.142875700726;1175.6179241746468;20345.6948145775;24785.50428991446;25571;25894;26013.21960341193;37307.626923730415;43537;43677.78161109174;43706;43748;232215;235775;236027;236738;236796.81601591883;23293.534129317657;23776.88111559431;23857.761422385553;25148.74851251464;27022.32444188911;31512;32572.674273256966;32916.67083329136;33201;38715.22569548649;29870.402591948474;30490.542641859945;30661.54007689842;33003.83498082494;33782;29570.556441652963;30174.69825301807;30213.848930755204;30284.69715302907;30296.697033029388;30633.693663063084;30832.845835770677;30998.690013099582;31121.53317700191;31290.530642039932;25322.873385632953;28934.7106528932;29561.26096847596;29648.258793529472;29736.553951690308;20211.89894050579;20427.4893127673;20448.488787780425;20612.793872061087;20636.27773027997 07:41:40 INFO - 2015-11-18 07:41:40,694 DEBUG : BROWSER_OUTPUT: |2;jquery.html;276.0586400374723;279.94261176458826;283.81268362880496;284.9943001139977;288.132720511261;9358.532073396336;10057.044580764816;14581.05223160494;15070.171140587263;15129.394824207018;16024.83975160248;16074.75887861683;16529.33882644693;16603.33586656532;16690;4434.334849772544;4626.930596041062;4631;4631.120087183424;4633.49031606523;4592.908141837162;4622.514635963226;4636.837710680127;4642.792873852805;4648.070385922829;3320.4023275810346;3464.307138572283;3469.080693616181;4575.679702420832;4590.678652494326;4982.825601103962;5130.102232109403;5200.453952334989;5202.297689811902;5211;3324.6509116542657;3425.8972230833115;4544.840930567448;4549.294859296814;4560.996580752229;10508.947455262674;10610.681679549625;10799.946000270027;10832.241743077988;10844.13246940243;503.41855157293384;504.8081728943015;505.31277462650763;1156.190561770826;1575.314738088935;7035.366816986496;7710.689182838931;7968.681252749883;8278.586070696501;8288.627011784483;1156.4275683536703;1252.918560293578;1258.1193164784688;1273.719781648036;1308.2608326295708;46989.29516057262;49115.263271050964;49127.01745965097;49412;49586;5374.596905232123;5385.3268341457315;5442.863928401822;5465.945340546544;5483.232347471358;6243.43809057187;6259.436650701367;6279.183706118175;6280.5289603279025;6303.3066362700065;4309.310510318397;4341.674374421931;4381.3427985801745;4383.539728328544;4398.252297109499;4519.683622146418;4554.95445045552;4564.315352697122;4576.656750743708;4591.219492686251;2420.3102115896886;2431.4286142756437;2465.0016743219026;2466.8519888806727;2471.4192164841247;858.1718641510972;863.2230992107154;865.1694373401605;866.6316815353575;919.9972030486801;296.3125548726976;351.26234906695737;353.80363898036325;366.6040676069838;391.1024199462241;9517.619295228113;9642.276829237835;9784.909287396895;9821.36161149523;10009.449480278654;375.6525214176875;376.37521713954703;379.7607507270402;381.92552452272093;389.94150877368054;5086.618503612244;5162.948370516322;5308.30991971049;5362.570994320445;5409.513143817076;415110;418411;426491;427984;428928;55634;59303.70348148232;59532.10701839476;59925;61527.384726152166;369.4587429415972;391.20780419650436;408.4241219879955;408.79560219890055;414.43636654150333;7441.8139546511775;7988.201179881965;8365.874511882448;9197.724068277963;9246.676366327147;30466;31169.220769480038;31481.685183147874;32429.837850810596;32762.50856237206;41087.794561027;41093;41955.79022104992;41993.79003104965;42022.36966445567;6517.315681853337;6551.246606640298;6658.167729033871;6738.494612903954;6743.393094621508;9914.058164474363;10052.748681282734;10150.289479736643;10168.186545076524;10196.235282354002;8414;8592.957035214784;8668.219860212612;8692.608832602422;8801.867971980553;8260.297874680478;8374.120717324837;8394.0766515682;8419.368547359096;8674.436161649724;8579.613917373857;8811.33914956368;8839.46963182211;8867.246284065926;8880.777980550538;6454.806355809334;6625.536212465081;6629.7679581214425;6636.502262330248;6654.500912431684;8206.22040906113;8557.400981931205;8582.527960962207;8680;8706.695265665672 07:41:40 INFO - 2015-11-18 07:41:40,695 DEBUG : BROWSER_OUTPUT: |3;mootools.html;638.7317326722776;1347.1445632023665;1423.3950571007326;1436.2244388030465;1464.62652023734;5601.383847776747;5737.913931291024;5774.884502309951;5800.796972105977;6133.447989680928;5920.3191632962225;5990.850228744283;6010.158577799111;6045.425684559959;6057.606255593383;1634.9673006539863;1825.6531259060803;1842.2262649687164;1844.3729132095084;1847.5473508990317;1684.9831501684948;1692.0270844264535;1693.119577819533;1697.0242110786285;1701.72772356423;1795.237024264689;1838.6414649143424;1843.2995461724593;1848.4916647921862;1862.8044055374194;1828.259554880269;1829.0945981739123;1831.60620466599;1837.503873954025;1882.1718443884647;1892.9337473188373;1910.4459706685045;1915.1669023974475;1915.5881485480688;1917.4726950088698;6087.147799308056;6150.261968563801;6160.5071594272795;6160.6919654017565;6163.137160797492;3908.511436070491;3981.203759248133;3982.960170398288;3993.0616305168264;3994.7003974702016;2366.8343215974887;2503.7621425964503;2508.811839112074;2509.8619575923317;2514.371407148213;746.4811955690743;762.2453770766956;779.3687113438076;788.8777239527882;789.6091434739783;8059.637316320721;8092.878606820902;8093.919060809375;8093.959530202429;8109.918900811034;3239.5464634951127;3568.4647302904773;3570.8937716504547;3594.6045934947133;3645.1069487975615;6604.1414616100565;6620.337966203438;6884.4148247399535;7006.404455621329;7060.117485314336;3849.634284742945;3853.190829925691;3888.8250028748776;3909.315869722844;3912.5891781363116;3412.982935085309;3463.5324231228965;3467.601225859008;3502.6847583717076;3504.5093686883856;2891.7686585073143;2902.506573882445;2941.7646588272887;2948.6461624604754;2949.277427030391;957.1146689312358;985.0346660272972;990.3562684255292;995.2983146881576;997.2969056814928;1066.2962444786558;1074.3714926767927;1100.6422912553292;1105.4196546812987;1105.9391733454738;5819.156222347736;5876.382979787147;5877.235959325346;5885.529157667376;5905.409459054146;550.0484162399072;554.0968221798443;561.898858205527;562.1258942344612;563.6815199412401;4424.542108513128;4550.863474095716;4568.086382723469;4582.587567118975;4586.587207151372;6925.965370173218;7093.32613401726;7095.574265544084;7100.538464999759;7109.751158709524;6820.658967051727;7018.543794653433;7056.576605403692;7147.53541019832;7158.964205178941;5707.486326230659;5708.40061793514;5722.170285308607;5726.627769195073;5746.310442746813;5592.412796656293;5621.409751975983;5623.578231632562;5638.2670252866865;5656.604037717485;6407.967960160169;6413.935860641333;6441.259255185526;6530.183727034121;6551.541392102507;6386.265579458236;6600.141981542369;6697.296783837822;6704.329567043256;6725.7893579156225;4863.319135320987;5004.3166472873645;5348.5186333230195;5384.919226211531;5439.048166570913;5781.392953739797;5975.790847320323;5992.970035149797;6002.0096684048385;6021.969890150521;5532.529734972572;5601.159826026129;5675.0068737971515;5679.119736440858;5727.8568035799435;5086.491350864884;5414;5519.31008623922;5520.834374968757;5569;5525.0883604204855;5588.804391846428;5592.944070559242;5592.972035139798;5601.495865372136;4946.480619534897;5073.44192138857;5106.336176297206;5111;5120.052790233819;5157.922631160461;5196.376434827845;5197.298364720715;5199;5200.271961925409 07:41:40 INFO - 2015-11-18 07:41:40,699 DEBUG : BROWSER_OUTPUT: |4;prototype.html;259.4292556375973;266.03694625455853;268.11655594815085;269.51083782933983;270.442887651438;4988.152014157593;5165.302684137645;5179.948200517993;5189.117849965505;5201.843944681661;5001.974990125044;5031.371078615173;5183.585313174946;5190.532852043315;5197.272381866542;3754.6057663945303;3862.2661694278136;3942.172143849795;3988.7008474364393;3999.1601763629674;3833.8466461341513;3894.162755007673;3919.902002449933;3924.941125883114;3941.31027070263;3890.3775395936655;3896.590857959916;3897.59075297094;3900.57093719692;3907.7655340679507;3846.480725102131;3848.749831260987;3849.9230015399535;3873.767573945558;3878.816960826947;3311.023248141804;3313.453280208763;3316.8507417166284;3323.0861513083855;3331.716804071657;4395.934060989088;4842.903141937177;4849.9757501212625;4891.095147397743;5013.699178049329;4339.934900976488;4341.630961368256;4382.715123516993;4446.288593825005;4454;5268.973655131738;5396.622236443451;5402.6758394496455;5403.432639572867;5434.239206511092;3647.9817600911824;3654.689351405134;3658.2317713280245;3665.505156803824;3669.7798132111893;5433.347998240197;5496.1755736639425;5580.497755202051;5613.410591887875;5647.29408823897;3643.85424583019;3671.2290419012306;3674.52231209941;3687.465317528997;3690.4279836625365;3710.3692372296773;3745.438184272381;3746.6440688134585;3752.3433399155037;3757.3612485877466;4351.695381323277;4356.019895523482;4365.650747940221;4376.015396535818;4389.978050109729;5226.8954620908125;5417.160340147205;5420.457954204548;5437.483439073281;5490.725463726798;1314.1458052265912;1314.6384744195232;1316.045866746601;1316.0655934286572;1319.0568743348551;888.9955550222207;893.1291990309396;896.8609865470733;911.1617312072909;912.3932584831012;5204.34945631796;5211.5830733541225;5212.452692467312;5214.895702085937;5230.607704422184;5648.378678345379;5653.208550802891;5655.575831812631;5658.575606829504;5662.405447428043;5196.116660167705;5200.7139607321205;5208.374995000549;5214.921776173361;5223.4776522347465;2945.4109178164454;3021.8640161192798;3037.559553864677;3064.6935306469177;3073.6004319438775;5778.768849245983;5846.941530584725;5868.706564671835;5873.089671100986;5885.117232415172;5781.797637082766;5793.362730099686;5795.536357091507;5803.738831752581;5821.2141360916585;5853.707314634251;5857.619254748428;5891.675957822361;5896.64620122794;5919.733611987384;5583.832485025456;5732.197492351158;5750.913736294043;5760.395158508296;5769.07694768835;5588.2455868458865;5594.608377413705;5603.7758489659955;5608.495235428831;5616.550675945833;5585.2180694701965;5628.352739435018;5763.394843541368;5794.565407594531;5914.67469289176;3692.538432695913;3707.3512135375663;3724.981375093107;3728.3102626014274;3733.253349330199;5585.525230355465;5590.776368945197;5598.580106492111;5603.411641777718;5613.887722245614;5266.473352664856;5447.536959358499;5449.073657478159;5451.64564303319;5473.8357849264585;5421.484958928895;5425.620206585501;5445.074337362737;5451.3458384994055;5456.399796022513;5290.365156181283;5299.682019078713;5306.124489459196;5311.336082989626;5320.308359913187;5453;5454.890902182014;5455.072637651688;5463.153211252262;5463.9180412294645;5204.583633309402;5345.412004679404;5358.490943360374;5358.892822143457;5368.087425137658 07:41:40 INFO - 2015-11-18 07:41:40,700 DEBUG : BROWSER_OUTPUT: |5;yui.html;557.1280945320575;596.4602035158183;621.2017557438691;621.4401851353103;643.5559463969857;12776;13311.933440332808;13323.26722030288;13335.733285334287;13423.865761342384;12143.757124857497;12194.024478041758;12210.511579536807;12219.572314968978;12224.022078233742;568.1903287814847;573.7934343636288;702.1468915267935;721.9133703955532;724.5833645653744;578.7164289498157;703.5251205436335;720.4380583145155;723.1791916175152;727.5343779980816;740.4224704730319;755.2862544895077;760.646299470746;761.3338328962158;761.8857171424276;579.7854793726306;587.538782056084;588.7027051339089;752.2815710995985;753.4010461682948;432.71657064622406;432.8160531773984;432.84633954946173;536.2412186755736;552.9225908372831;11056.447177641086;11152.665420037412;11216.943915280453;11223.719407014809;11230.326180429118;7704.537727736354;7917.841643167105;7940.325072368798;8172.019357677117;8250.216229458252;6763.053172555846;7280.41756659466;7641.3504852087635;7649.273319034683;7800.395521389394;2412.2401443545227;2441.9511609767883;2490.7384724603835;2518.6977562692596;2561.718210996789;36311.4553281701;37084.62915370866;38682.41976370357;38957.220855583015;39474.60525394738;5478.287822583039;5614.578906581941;5692.31692196939;5809.941900581025;5897.262842144732;10052.145567626687;10100.74748131288;10255.692329229985;10307.742306442398;10327.32872363294;4999.975000124976;5031.993601279685;5039.588969693932;5054.079449809123;5166.992436474927;3147.244661281276;3157.4000939821362;3273.0835366097053;3289.7039266465654;3374.105861946586;2289.8168146548237;2324.8953797078834;2330.4057465346227;2334.696489456394;2335.381124002141;335.6559526485323;339.71803403175306;345.5369804462033;346.1346633416459;347.6419288133227;395.73365231260084;461.9561141691534;486.28030514838235;503.26272011503323;522.5479959834715;6126.479249263773;6407.663017610687;6514.5114116441455;6638;6679.966600166968;335.7632868827471;415.9854405095807;479.35526716566164;497.8929530151035;500.7896683392984;3040.8479576021555;3070.217094640897;3074.8462576871066;3078.9076327710204;3136.2316232523176;47382.76308618435;47693.761531192125;47732.284015739795;47845.5215447848;47994.76002619965;41302;41654.58345416567;42287.788561057;42484.78757606192;42760.78619606944;37340;37691.81154094267;38061.85814425627;38520.6147938517;39011.6098839008;6294.5279104068295;6345;6359.427651511386;6363;6432.09950606906;27799;28023;28648.283792905346;29090.563641545818;29143.85428072846;33706.662933371335;33854.153646159044;34007.3198536023;34285.82857085699;37695.81152094222;5762.394948530344;5773.3072031356505;5806.332271788799;5921.99326114553;5929.851753706192;8194.631241594261;8270.917290827014;8348.707795227137;8387.245147936472;8441.83116337682;7770.222977702185;8089.2315230053055;8176.141505141874;8230.300424463987;8255.42212045175;8088.231617996281;8180;8203.097659257597;8258.793530161794;8290.709825156091;6948.409385202314;8001.919980800118;8036.517808931483;8167.714130005421;8288.668453262044;7400.5189662671755;7421.925780742339;7795.142534321107;7883.646061908887;7910.406719496176;6628.436582890316;6767.796966091025;6959.756408525677;7484.363829074372;7619.123800762984 07:41:40 INFO - 2015-11-18 07:41:40,700 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:41:40 INFO - 2015-11-18 07:41:40,700 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:41:40 INFO - 2015-11-18 07:41:40,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1195 07:41:40 INFO - 2015-11-18 07:41:40,701 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:41:40 INFO - 2015-11-18 07:41:40,701 DEBUG : BROWSER_OUTPUT: __startTimestamp1447861300685__endTimestamp 07:41:40 INFO - 2015-11-18 07:41:40,701 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,701 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:41:40 INFO - 2015-11-18 07:41:40,701 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:41:40 INFO - 2015-11-18 07:41:40,701 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,701 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4475.66 Median:4615.17 stddev:476.46 (10.3%) stddev-sans-first:453.98 07:41:40 INFO - 2015-11-18 07:41:40,703 DEBUG : BROWSER_OUTPUT: Values: 2574.6 2647.6 2667.3 2690.2 2695.7 4321.8 4475.4 4506.5 4508.2 4529.5 4404.8 4484.8 4499.1 4568.1 4605.3 4119.9 4167.0 4191.3 4242.2 4243.0 4210.2 4235.7 4257.2 4258.2 4311.1 4018.2 4124.9 4138.1 4152.8 4241.9 4071.5 4159.7 4176.5 4178.4 4192.6 4126.9 4155.5 4156.5 4183.7 4218.0 4235.7 4486.6 4486.9 4523.4 4554.1 4609.0 4696.0 4699.5 4728.4 4733.8 4813.6 4835.0 4844.4 4846.7 4876.5 4500.3 4501.9 4502.8 4518.6 4554.8 4700.9 4857.9 4925.2 4935.0 4982.8 4615.2 4626.9 4645.7 4677.0 4735.7 4842.0 4859.7 4870.9 4877.9 4921.2 4597.4 4729.6 4789.1 4831.2 4855.0 4691.9 4713.2 4738.6 4763.0 4816.0 3673.5 3732.2 3734.0 3739.3 3752.5 3295.3 3389.0 3404.1 3413.1 3415.4 4461.9 4520.3 4526.3 4539.5 4565.1 4868.5 4873.9 4874.5 4891.0 4911.2 4351.5 4454.3 4565.9 4616.3 4623.6 4137.9 4177.1 4210.8 4226.5 4228.0 4829.9 4911.6 4952.2 4955.5 4975.7 4814.2 4818.8 4829.4 4830.4 4845.3 4770.3 4789.4 4915.7 4928.9 4990.2 4787.7 4787.8 4791.2 4805.9 4831.8 4757.2 4823.3 4873.6 4875.7 4919.6 4521.4 4637.1 4639.0 4647.9 4653.2 4566.0 4640.6 4663.8 4680.9 4728.9 4599.7 4627.8 4651.8 4657.9 4671.7 4709.0 4723.5 4726.2 4728.7 4771.0 4456.2 4546.5 4561.2 4573.1 4659.9 07:41:40 INFO - 2015-11-18 07:41:40,703 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,703 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44632.13 Median:179454.34 stddev:82726.27 (46.1%) stddev-sans-first:82891.88 07:41:40 INFO - 2015-11-18 07:41:40,704 DEBUG : BROWSER_OUTPUT: Values: 464.7 466.4 471.9 477.8 498.5 26385.2 27001.3 32862.7 33777.3 33814.3 35910.3 36094.1 36262.8 36284.0 36392.6 6816.0 6971.5 7556.8 7753.1 7776.2 6898.3 6952.3 7013.7 7049.3 7087.5 9212.5 9426.1 9469.9 9478.6 9484.0 9199.7 9227.4 9304.5 9308.0 9308.8 6963.4 7161.9 7162.0 8923.2 9192.4 26612.0 26825.5 27093.9 33780.0 34218.1 2482.2 2493.1 2515.3 2530.3 2677.3 22691.1 23223.0 23429.5 23704.9 24356.6 1978.2 2051.1 2066.9 2075.9 2126.8 355328.0 361689.0 362134.0 362602.0 364671.0 48065.0 49320.5 51919.5 52366.0 52392.5 45136.8 60417.4 61437.0 61760.4 61920.0 13272.6 13731.0 13833.1 13904.8 13918.0 10114.6 10367.7 10451.1 10481.0 10508.4 17095.8 17220.0 17229.9 17258.7 17475.7 6992.4 7262.4 7269.2 7295.9 7376.0 805.6 832.8 853.5 868.9 945.4 24214.0 24220.2 24395.1 24400.8 24478.1 850.6 887.0 938.7 946.5 952.3 12417.6 13149.4 13463.7 14109.9 14192.5 326046.0 329839.0 330187.0 330286.0 330919.0 48736.4 48981.3 48988.5 49001.5 49105.8 1156.3 1162.7 1170.9 1174.1 1175.6 20345.7 24785.5 25571.0 25894.0 26013.2 37307.6 43537.0 43677.8 43706.0 43748.0 232215.0 235775.0 236027.0 236738.0 236796.8 23293.5 23776.9 23857.8 25148.7 27022.3 31512.0 32572.7 32916.7 33201.0 38715.2 29870.4 30490.5 30661.5 33003.8 33782.0 29570.6 30174.7 30213.8 30284.7 30296.7 30633.7 30832.8 30998.7 31121.5 31290.5 25322.9 28934.7 29561.3 29648.3 29736.6 20211.9 20427.5 20448.5 20612.8 20636.3 07:41:40 INFO - 2015-11-18 07:41:40,705 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,705 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21764.20 Median:4631.06 stddev:69390.83 (1498.4%) stddev-sans-first:69566.73 07:41:40 INFO - 2015-11-18 07:41:40,706 DEBUG : BROWSER_OUTPUT: Values: 276.1 279.9 283.8 285.0 288.1 9358.5 10057.0 14581.1 15070.2 15129.4 16024.8 16074.8 16529.3 16603.3 16690.0 4434.3 4626.9 4631.0 4631.1 4633.5 4592.9 4622.5 4636.8 4642.8 4648.1 3320.4 3464.3 3469.1 4575.7 4590.7 4982.8 5130.1 5200.5 5202.3 5211.0 3324.7 3425.9 4544.8 4549.3 4561.0 10508.9 10610.7 10799.9 10832.2 10844.1 503.4 504.8 505.3 1156.2 1575.3 7035.4 7710.7 7968.7 8278.6 8288.6 1156.4 1252.9 1258.1 1273.7 1308.3 46989.3 49115.3 49127.0 49412.0 49586.0 5374.6 5385.3 5442.9 5465.9 5483.2 6243.4 6259.4 6279.2 6280.5 6303.3 4309.3 4341.7 4381.3 4383.5 4398.3 4519.7 4555.0 4564.3 4576.7 4591.2 2420.3 2431.4 2465.0 2466.9 2471.4 858.2 863.2 865.2 866.6 920.0 296.3 351.3 353.8 366.6 391.1 9517.6 9642.3 9784.9 9821.4 10009.4 375.7 376.4 379.8 381.9 389.9 5086.6 5162.9 5308.3 5362.6 5409.5 415110.0 418411.0 426491.0 427984.0 428928.0 55634.0 59303.7 59532.1 59925.0 61527.4 369.5 391.2 408.4 408.8 414.4 7441.8 7988.2 8365.9 9197.7 9246.7 30466.0 31169.2 31481.7 32429.8 32762.5 41087.8 41093.0 41955.8 41993.8 42022.4 6517.3 6551.2 6658.2 6738.5 6743.4 9914.1 10052.7 10150.3 10168.2 10196.2 8414.0 8593.0 8668.2 8692.6 8801.9 8260.3 8374.1 8394.1 8419.4 8674.4 8579.6 8811.3 8839.5 8867.2 8880.8 6454.8 6625.5 6629.8 6636.5 6654.5 8206.2 8557.4 8582.5 8680.0 8706.7 07:41:40 INFO - 2015-11-18 07:41:40,706 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,706 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4275.64 Median:3043.31 stddev:2150.22 (70.7%) stddev-sans-first:2138.85 07:41:40 INFO - 2015-11-18 07:41:40,706 DEBUG : BROWSER_OUTPUT: Values: 638.7 1347.1 1423.4 1436.2 1464.6 5601.4 5737.9 5774.9 5800.8 6133.4 5920.3 5990.9 6010.2 6045.4 6057.6 1635.0 1825.7 1842.2 1844.4 1847.5 1685.0 1692.0 1693.1 1697.0 1701.7 1795.2 1838.6 1843.3 1848.5 1862.8 1828.3 1829.1 1831.6 1837.5 1882.2 1892.9 1910.4 1915.2 1915.6 1917.5 6087.1 6150.3 6160.5 6160.7 6163.1 3908.5 3981.2 3983.0 3993.1 3994.7 2366.8 2503.8 2508.8 2509.9 2514.4 746.5 762.2 779.4 788.9 789.6 8059.6 8092.9 8093.9 8094.0 8109.9 3239.5 3568.5 3570.9 3594.6 3645.1 6604.1 6620.3 6884.4 7006.4 7060.1 3849.6 3853.2 3888.8 3909.3 3912.6 3413.0 3463.5 3467.6 3502.7 3504.5 2891.8 2902.5 2941.8 2948.6 2949.3 957.1 985.0 990.4 995.3 997.3 1066.3 1074.4 1100.6 1105.4 1105.9 5819.2 5876.4 5877.2 5885.5 5905.4 550.0 554.1 561.9 562.1 563.7 4424.5 4550.9 4568.1 4582.6 4586.6 6926.0 7093.3 7095.6 7100.5 7109.8 6820.7 7018.5 7056.6 7147.5 7159.0 5707.5 5708.4 5722.2 5726.6 5746.3 5592.4 5621.4 5623.6 5638.3 5656.6 6408.0 6413.9 6441.3 6530.2 6551.5 6386.3 6600.1 6697.3 6704.3 6725.8 4863.3 5004.3 5348.5 5384.9 5439.0 5781.4 5975.8 5993.0 6002.0 6022.0 5532.5 5601.2 5675.0 5679.1 5727.9 5086.5 5414.0 5519.3 5520.8 5569.0 5525.1 5588.8 5592.9 5593.0 5601.5 4946.5 5073.4 5106.3 5111.0 5120.1 5157.9 5196.4 5197.3 5199.0 5200.3 07:41:40 INFO - 2015-11-18 07:41:40,707 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,708 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4515.87 Median:5212.02 stddev:1393.79 (26.7%) stddev-sans-first:1360.60 07:41:40 INFO - 2015-11-18 07:41:40,708 DEBUG : BROWSER_OUTPUT: Values: 259.4 266.0 268.1 269.5 270.4 4988.2 5165.3 5179.9 5189.1 5201.8 5002.0 5031.4 5183.6 5190.5 5197.3 3754.6 3862.3 3942.2 3988.7 3999.2 3833.8 3894.2 3919.9 3924.9 3941.3 3890.4 3896.6 3897.6 3900.6 3907.8 3846.5 3848.7 3849.9 3873.8 3878.8 3311.0 3313.5 3316.9 3323.1 3331.7 4395.9 4842.9 4850.0 4891.1 5013.7 4339.9 4341.6 4382.7 4446.3 4454.0 5269.0 5396.6 5402.7 5403.4 5434.2 3648.0 3654.7 3658.2 3665.5 3669.8 5433.3 5496.2 5580.5 5613.4 5647.3 3643.9 3671.2 3674.5 3687.5 3690.4 3710.4 3745.4 3746.6 3752.3 3757.4 4351.7 4356.0 4365.7 4376.0 4390.0 5226.9 5417.2 5420.5 5437.5 5490.7 1314.1 1314.6 1316.0 1316.1 1319.1 889.0 893.1 896.9 911.2 912.4 5204.3 5211.6 5212.5 5214.9 5230.6 5648.4 5653.2 5655.6 5658.6 5662.4 5196.1 5200.7 5208.4 5214.9 5223.5 2945.4 3021.9 3037.6 3064.7 3073.6 5778.8 5846.9 5868.7 5873.1 5885.1 5781.8 5793.4 5795.5 5803.7 5821.2 5853.7 5857.6 5891.7 5896.6 5919.7 5583.8 5732.2 5750.9 5760.4 5769.1 5588.2 5594.6 5603.8 5608.5 5616.6 5585.2 5628.4 5763.4 5794.6 5914.7 3692.5 3707.4 3725.0 3728.3 3733.3 5585.5 5590.8 5598.6 5603.4 5613.9 5266.5 5447.5 5449.1 5451.6 5473.8 5421.5 5425.6 5445.1 5451.3 5456.4 5290.4 5299.7 5306.1 5311.3 5320.3 5453.0 5454.9 5455.1 5463.2 5463.9 5204.6 5345.4 5358.5 5358.9 5368.1 07:41:40 INFO - 2015-11-18 07:41:40,708 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-18 07:41:40,709 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10681.03 Median:5110.54 stddev:13084.11 (256.0%) stddev-sans-first:13098.73 07:41:40 INFO - 2015-11-18 07:41:40,710 DEBUG : BROWSER_OUTPUT: Values: 557.1 596.5 621.2 621.4 643.6 12776.0 13311.9 13323.3 13335.7 13423.9 12143.8 12194.0 12210.5 12219.6 12224.0 568.2 573.8 702.1 721.9 724.6 578.7 703.5 720.4 723.2 727.5 740.4 755.3 760.6 761.3 761.9 579.8 587.5 588.7 752.3 753.4 432.7 432.8 432.8 536.2 552.9 11056.4 11152.7 11216.9 11223.7 11230.3 7704.5 7917.8 7940.3 8172.0 8250.2 6763.1 7280.4 7641.4 7649.3 7800.4 2412.2 2442.0 2490.7 2518.7 2561.7 36311.5 37084.6 38682.4 38957.2 39474.6 5478.3 5614.6 5692.3 5809.9 5897.3 10052.1 10100.7 10255.7 10307.7 10327.3 5000.0 5032.0 5039.6 5054.1 5167.0 3147.2 3157.4 3273.1 3289.7 3374.1 2289.8 2324.9 2330.4 2334.7 2335.4 335.7 339.7 345.5 346.1 347.6 395.7 462.0 486.3 503.3 522.5 6126.5 6407.7 6514.5 6638.0 6680.0 335.8 416.0 479.4 497.9 500.8 3040.8 3070.2 3074.8 3078.9 3136.2 47382.8 47693.8 47732.3 47845.5 47994.8 41302.0 41654.6 42287.8 42484.8 42760.8 37340.0 37691.8 38061.9 38520.6 39011.6 6294.5 6345.0 6359.4 6363.0 6432.1 27799.0 28023.0 28648.3 29090.6 29143.9 33706.7 33854.2 34007.3 34285.8 37695.8 5762.4 5773.3 5806.3 5922.0 5929.9 8194.6 8270.9 8348.7 8387.2 8441.8 7770.2 8089.2 8176.1 8230.3 8255.4 8088.2 8180.0 8203.1 8258.8 8290.7 6948.4 8001.9 8036.5 8167.7 8288.7 7400.5 7421.9 7795.1 7883.6 7910.4 6628.4 6767.8 6959.8 7484.4 7619.1 07:41:40 INFO - 2015-11-18 07:41:40,710 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:41:40 INFO - 2015-11-18 07:41:40,710 DEBUG : BROWSER_OUTPUT: 07:41:41 INFO - 2015-11-18 07:41:41,416 INFO : Browser exited with error code: 0 07:41:41 INFO - 2015-11-18 07:41:41,450 INFO : Completed test dromaeo_css (00:18:37) 07:41:41 INFO - 2015-11-18 07:41:41,450 INFO : Starting test kraken 07:41:41 INFO - 2015-11-18 07:41:41,450 DEBUG : operating with platform_type : mac_ 07:41:41 INFO - 2015-11-18 07:41:41,450 INFO : Initialising browser for kraken test... 07:41:41 INFO - 2015-11-18 07:41:41,466 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/tmpJ36OUf/profile http://localhost:49781/getInfo.html 07:41:44 INFO - 2015-11-18 07:41:44,073 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:41:44 INFO - 2015-11-18 07:41:44,073 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:41:44 INFO - 2015-11-18 07:41:44,073 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:41:44 INFO - 2015-11-18 07:41:44,074 DEBUG : BROWSER_OUTPUT: __metrics 07:41:44 INFO - 2015-11-18 07:41:44,090 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:41:44 INFO - 2015-11-18 07:41:44,871 INFO : Browser initialized. 07:41:44 INFO - 2015-11-18 07:41:44,871 INFO : Running cycle 1/1 for kraken test... 07:41:44 INFO - 2015-11-18 07:41:44,872 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/tmpJ36OUf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:41:57 INFO - 2015-11-18 07:41:57,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 229527552 07:41:57 INFO - 2015-11-18 07:41:57,045 DEBUG : BROWSER_OUTPUT: 07:41:59 INFO - 2015-11-18 07:41:59,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49781/tests/kraken/driver.html?testName=audio-beat-detection) 07:42:00 INFO - 2015-11-18 07:42:00,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 285278208 07:42:00 INFO - 2015-11-18 07:42:00,558 DEBUG : BROWSER_OUTPUT: 07:42:03 INFO - 2015-11-18 07:42:03,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49781/tests/kraken/driver.html?testName=audio-dft) 07:42:04 INFO - 2015-11-18 07:42:04,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 298323968 07:42:04 INFO - 2015-11-18 07:42:04,245 DEBUG : BROWSER_OUTPUT: 07:42:07 INFO - 2015-11-18 07:42:07,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49781/tests/kraken/driver.html?testName=audio-fft) 07:42:08 INFO - 2015-11-18 07:42:08,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 283987968 07:42:08 INFO - 2015-11-18 07:42:08,250 DEBUG : BROWSER_OUTPUT: 07:42:10 INFO - 2015-11-18 07:42:10,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49781/tests/kraken/driver.html?testName=audio-oscillator) 07:42:11 INFO - 2015-11-18 07:42:11,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 283947008 07:42:11 INFO - 2015-11-18 07:42:11,148 DEBUG : BROWSER_OUTPUT: 07:42:13 INFO - 2015-11-18 07:42:13,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49781/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:42:14 INFO - 2015-11-18 07:42:14,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 283267072 07:42:14 INFO - 2015-11-18 07:42:14,248 DEBUG : BROWSER_OUTPUT: 07:42:17 INFO - 2015-11-18 07:42:17,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49781/tests/kraken/driver.html?testName=imaging-darkroom) 07:42:18 INFO - 2015-11-18 07:42:18,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 279293952 07:42:18 INFO - 2015-11-18 07:42:18,406 DEBUG : BROWSER_OUTPUT: 07:42:22 INFO - 2015-11-18 07:42:22,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49781/tests/kraken/driver.html?testName=imaging-desaturate) 07:42:22 INFO - 2015-11-18 07:42:22,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 279625728 07:42:22 INFO - 2015-11-18 07:42:22,690 DEBUG : BROWSER_OUTPUT: 07:42:26 INFO - 2015-11-18 07:42:26,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49781/tests/kraken/driver.html?testName=json-parse-financial) 07:42:26 INFO - 2015-11-18 07:42:26,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 280694784 07:42:26 INFO - 2015-11-18 07:42:26,617 DEBUG : BROWSER_OUTPUT: 07:42:28 INFO - 2015-11-18 07:42:28,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49781/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:42:28 INFO - 2015-11-18 07:42:28,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 316952576 07:42:28 INFO - 2015-11-18 07:42:28,971 DEBUG : BROWSER_OUTPUT: 07:42:31 INFO - 2015-11-18 07:42:31,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:42:31 INFO - 2015-11-18 07:42:31,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 319942656 07:42:31 INFO - 2015-11-18 07:42:31,691 DEBUG : BROWSER_OUTPUT: 07:42:34 INFO - 2015-11-18 07:42:34,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:42:34 INFO - 2015-11-18 07:42:34,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 326840320 07:42:34 INFO - 2015-11-18 07:42:34,689 DEBUG : BROWSER_OUTPUT: 07:42:37 INFO - 2015-11-18 07:42:37,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:42:38 INFO - 2015-11-18 07:42:38,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 326823936 07:42:38 INFO - 2015-11-18 07:42:38,285 DEBUG : BROWSER_OUTPUT: 07:42:41 INFO - 2015-11-18 07:42:41,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:42:41 INFO - 2015-11-18 07:42:41,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 326713344 07:42:41 INFO - 2015-11-18 07:42:41,898 DEBUG : BROWSER_OUTPUT: 07:42:43 INFO - 2015-11-18 07:42:43,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49781/tests/kraken/driver.html?testName=ai-astar) 07:42:44 INFO - 2015-11-18 07:42:44,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 386895872 07:42:44 INFO - 2015-11-18 07:42:44,130 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,132 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:42:44 INFO - 2015-11-18 07:42:44,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:42:44 INFO - 2015-11-18 07:42:44,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:42:44 INFO - 2015-11-18 07:42:44,132 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:42:44 INFO - 2015-11-18 07:42:44,132 DEBUG : BROWSER_OUTPUT: |0;ai-astar;126;132;133;132;131;132;132;131;129;138 07:42:44 INFO - 2015-11-18 07:42:44,133 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;191;160;188;206;153;182;180;152;200;163 07:42:44 INFO - 2015-11-18 07:42:44,133 DEBUG : BROWSER_OUTPUT: |2;audio-dft;194;200;197;195;198;196;196;190;197;199 07:42:44 INFO - 2015-11-18 07:42:44,133 DEBUG : BROWSER_OUTPUT: |3;audio-fft;93;99;104;105;83;84;85;105;108;84 07:42:44 INFO - 2015-11-18 07:42:44,133 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;117;120;162;108;110;109;155;109;108;159 07:42:44 INFO - 2015-11-18 07:42:44,133 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;148;148;141;142;141;148;139;141;141;148 07:42:44 INFO - 2015-11-18 07:42:44,134 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;155;155;155;155;155;155;155;155;155 07:42:44 INFO - 2015-11-18 07:42:44,134 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;115;130;127;115;114;124;115;130;117;123 07:42:44 INFO - 2015-11-18 07:42:44,134 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;71;74;73;74;74;76;83;72;72 07:42:44 INFO - 2015-11-18 07:42:44,134 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;81;83;85;89;86;87;87;87;83;84 07:42:44 INFO - 2015-11-18 07:42:44,134 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;105;105;106;104;106;104;106;106;106 07:42:44 INFO - 2015-11-18 07:42:44,134 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;161;159;158;150;151;153;167;158;154;149 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;172;183;189;189;191;167;190;189;189;176 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;86;86;89;89;87;87;87;89;88 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,999 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: __startTimestamp1447861364131__endTimestamp 07:42:44 INFO - 2015-11-18 07:42:44,135 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,137 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:42:44 INFO - 2015-11-18 07:42:44,137 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:42:44 INFO - 2015-11-18 07:42:44,137 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,138 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.60 Median:132.00 stddev:3.03 (2.3%) stddev-sans-first:2.44 07:42:44 INFO - 2015-11-18 07:42:44,138 DEBUG : BROWSER_OUTPUT: Values: 126.0 132.0 133.0 132.0 131.0 132.0 132.0 131.0 129.0 138.0 07:42:44 INFO - 2015-11-18 07:42:44,138 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,138 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:177.50 Median:185.00 stddev:19.45 (10.5%) stddev-sans-first:20.01 07:42:44 INFO - 2015-11-18 07:42:44,138 DEBUG : BROWSER_OUTPUT: Values: 191.0 160.0 188.0 206.0 153.0 182.0 180.0 152.0 200.0 163.0 07:42:44 INFO - 2015-11-18 07:42:44,138 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,138 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.20 Median:197.00 stddev:2.82 (1.4%) stddev-sans-first:2.88 07:42:44 INFO - 2015-11-18 07:42:44,139 DEBUG : BROWSER_OUTPUT: Values: 194.0 200.0 197.0 195.0 198.0 196.0 196.0 190.0 197.0 199.0 07:42:44 INFO - 2015-11-18 07:42:44,139 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,139 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:95.00 Median:84.00 stddev:10.31 (12.3%) stddev-sans-first:10.91 07:42:44 INFO - 2015-11-18 07:42:44,139 DEBUG : BROWSER_OUTPUT: Values: 93.0 99.0 104.0 105.0 83.0 84.0 85.0 105.0 108.0 84.0 07:42:44 INFO - 2015-11-18 07:42:44,139 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,139 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:125.70 Median:118.50 stddev:23.15 (19.5%) stddev-sans-first:24.34 07:42:44 INFO - 2015-11-18 07:42:44,140 DEBUG : BROWSER_OUTPUT: Values: 117.0 120.0 162.0 108.0 110.0 109.0 155.0 109.0 108.0 159.0 07:42:44 INFO - 2015-11-18 07:42:44,140 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,140 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.70 Median:145.00 stddev:3.77 (2.6%) stddev-sans-first:3.67 07:42:44 INFO - 2015-11-18 07:42:44,140 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 141.0 142.0 141.0 148.0 139.0 141.0 141.0 148.0 07:42:44 INFO - 2015-11-18 07:42:44,141 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:155.00 Median:155.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: Values: 155.0 155.0 155.0 155.0 155.0 155.0 155.0 155.0 155.0 155.0 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:121.00 Median:123.50 stddev:6.53 (5.3%) stddev-sans-first:6.56 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: Values: 115.0 130.0 127.0 115.0 114.0 124.0 115.0 130.0 117.0 123.0 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.70 Median:74.00 stddev:3.92 (5.3%) stddev-sans-first:3.57 07:42:44 INFO - 2015-11-18 07:42:44,142 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 74.0 73.0 74.0 74.0 76.0 83.0 72.0 72.0 07:42:44 INFO - 2015-11-18 07:42:44,143 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,143 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.20 Median:86.50 stddev:2.44 (2.8%) stddev-sans-first:2.06 07:42:44 INFO - 2015-11-18 07:42:44,143 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 85.0 89.0 86.0 87.0 87.0 87.0 83.0 84.0 07:42:44 INFO - 2015-11-18 07:42:44,143 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,143 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.10 Median:106.00 stddev:1.10 (1.0%) stddev-sans-first:0.87 07:42:44 INFO - 2015-11-18 07:42:44,143 DEBUG : BROWSER_OUTPUT: Values: 103.0 105.0 105.0 106.0 104.0 106.0 104.0 106.0 106.0 106.0 07:42:44 INFO - 2015-11-18 07:42:44,144 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,144 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:156.00 Median:158.00 stddev:5.64 (3.6%) stddev-sans-first:5.68 07:42:44 INFO - 2015-11-18 07:42:44,144 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 158.0 150.0 151.0 153.0 167.0 158.0 154.0 149.0 07:42:44 INFO - 2015-11-18 07:42:44,144 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,144 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:189.00 stddev:8.70 (4.6%) stddev-sans-first:8.17 07:42:44 INFO - 2015-11-18 07:42:44,145 DEBUG : BROWSER_OUTPUT: Values: 172.0 183.0 189.0 189.0 191.0 167.0 190.0 189.0 189.0 176.0 07:42:44 INFO - 2015-11-18 07:42:44,145 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,145 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.00 Median:87.50 stddev:2.11 (2.4%) stddev-sans-first:1.24 07:42:44 INFO - 2015-11-18 07:42:44,147 DEBUG : BROWSER_OUTPUT: Values: 82.0 86.0 86.0 89.0 89.0 87.0 87.0 87.0 89.0 88.0 07:42:44 INFO - 2015-11-18 07:42:44,147 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:42:44 INFO - 2015-11-18 07:42:44,147 DEBUG : BROWSER_OUTPUT: 07:42:44 INFO - 2015-11-18 07:42:44,914 INFO : Browser exited with error code: 0 07:42:44 INFO - 2015-11-18 07:42:44,970 INFO : Completed test kraken (00:01:03) 07:42:44 INFO - 2015-11-18 07:42:44,970 INFO : Starting test v8_7 07:42:44 INFO - 2015-11-18 07:42:44,970 DEBUG : operating with platform_type : mac_ 07:42:44 INFO - 2015-11-18 07:42:44,970 INFO : Initialising browser for v8_7 test... 07:42:44 INFO - 2015-11-18 07:42:44,984 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/tmp3n1IBb/profile http://localhost:49781/getInfo.html 07:42:47 INFO - 2015-11-18 07:42:47,533 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:42:47 INFO - 2015-11-18 07:42:47,534 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:42:47 INFO - 2015-11-18 07:42:47,534 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:42:47 INFO - 2015-11-18 07:42:47,534 DEBUG : BROWSER_OUTPUT: __metrics 07:42:47 INFO - 2015-11-18 07:42:47,554 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:42:48 INFO - 2015-11-18 07:42:48,335 INFO : Browser initialized. 07:42:48 INFO - 2015-11-18 07:42:48,336 INFO : Running cycle 1/1 for v8_7 test... 07:42:48 INFO - 2015-11-18 07:42:48,336 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/T/tmp3n1IBb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:43:00 INFO - 2015-11-18 07:43:00,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 228413440 07:43:00 INFO - 2015-11-18 07:43:00,496 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49781/tests/v8_7/run.html (next: http://localhost:49781/tests/v8_7/run.html) 07:43:23 INFO - 2015-11-18 07:43:23,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 689410048 07:43:23 INFO - 2015-11-18 07:43:23,744 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,744 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:43:23 INFO - 2015-11-18 07:43:23,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:43:23 INFO - 2015-11-18 07:43:23,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:43:23 INFO - 2015-11-18 07:43:23,744 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |0;Richards;201.8978396931153 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;238.60653781913624 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |2;Encrypt;382.84839203675347 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7099.290780141844 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2358.490566037736 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |5;Earley;955.1526717557252 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |6;Boyer;16258.064516129032 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |7;RegExp;35293.10344827586 07:43:23 INFO - 2015-11-18 07:43:23,745 DEBUG : BROWSER_OUTPUT: |8;Splay;889.6797153024911 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6863.013698630137 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: __startTimestamp1447861403740__endTimestamp 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:201.90 Median:201.90 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,746 DEBUG : BROWSER_OUTPUT: Values: 201.9 07:43:23 INFO - 2015-11-18 07:43:23,747 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,747 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:238.61 Median:238.61 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,747 DEBUG : BROWSER_OUTPUT: Values: 238.6 07:43:23 INFO - 2015-11-18 07:43:23,747 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,747 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:382.85 Median:382.85 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,747 DEBUG : BROWSER_OUTPUT: Values: 382.8 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7099.29 Median:7099.29 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: Values: 7099.3 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2358.49 Median:2358.49 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: Values: 2358.5 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,748 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:955.15 Median:955.15 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: Values: 955.2 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16258.06 Median:16258.06 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: Values: 16258.1 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35293.10 Median:35293.10 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: Values: 35293.1 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,749 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:889.68 Median:889.68 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,750 DEBUG : BROWSER_OUTPUT: Values: 889.7 07:43:23 INFO - 2015-11-18 07:43:23,750 DEBUG : BROWSER_OUTPUT: 07:43:23 INFO - 2015-11-18 07:43:23,750 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6863.01 Median:6863.01 stddev:0.00 (0.0%) 07:43:23 INFO - 2015-11-18 07:43:23,750 DEBUG : BROWSER_OUTPUT: Values: 6863.0 07:43:23 INFO - 2015-11-18 07:43:23,750 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:43:23 INFO - 2015-11-18 07:43:23,750 DEBUG : BROWSER_OUTPUT: 07:43:24 INFO - 2015-11-18 07:43:24,527 INFO : Browser exited with error code: 0 07:43:24 INFO - 2015-11-18 07:43:24,551 INFO : Completed test v8_7 (00:00:39) 07:43:24 INFO - 2015-11-18 07:43:24,893 INFO : Completed test suite (00:20:21) 07:43:24 INFO - 2015-11-18 07:43:24,893 DEBUG : Working with test: dromaeo_css 07:43:24 INFO - 2015-11-18 07:43:24,893 DEBUG : Generating results file: dromaeo_css 07:43:24 INFO - 2015-11-18 07:43:24,894 DEBUG : Working with test: kraken 07:43:24 INFO - 2015-11-18 07:43:24,894 DEBUG : Generating results file: kraken 07:43:24 INFO - 2015-11-18 07:43:24,894 INFO : javascript benchmark 07:43:24 INFO - 2015-11-18 07:43:24,894 DEBUG : Working with test: v8_7 07:43:24 INFO - 2015-11-18 07:43:24,894 DEBUG : Generating results file: v8_7 07:43:24 INFO - 2015-11-18 07:43:24,894 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:43:24 INFO - 2015-11-18 07:43:24,954 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 07:43:24 INFO - 2015-11-18 07:43:24,954 DEBUG : process_Request line: dromaeo_css 5475.01 graph.html#tests=[[72,1,55]] 07:43:24 INFO - 2015-11-18 07:43:24,954 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:43:24 INFO - 2015-11-18 07:43:24,984 DEBUG : process_Request line: kraken 1836.20 graph.html#tests=[[232,1,55]] 07:43:24 INFO - 2015-11-18 07:43:24,984 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:43:25 INFO - 2015-11-18 07:43:25,017 DEBUG : process_Request line: v8_7 15087.39 graph.html#tests=[[230,1,55]] 07:43:25 INFO - 2015-11-18 07:43:25,017 INFO : javascript benchmark 07:43:25 INFO - 2015-11-18 07:43:25,020 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [276.0586400374723, 279.94261176458826, 283.81268362880496, 284.9943001139977, 288.132720511261, 9358.532073396336, 10057.044580764816, 14581.05223160494, 15070.171140587263, 15129.394824207018, 16024.83975160248, 16074.75887861683, 16529.33882644693, 16603.33586656532, 16690.0, 4434.334849772544, 4626.930596041062, 4631.0, 4631.120087183424, 4633.49031606523, 4592.908141837162, 4622.514635963226, 4636.837710680127, 4642.792873852805, 4648.070385922829, 3320.4023275810346, 3464.307138572283, 3469.080693616181, 4575.679702420832, 4590.678652494326, 4982.825601103962, 5130.102232109403, 5200.453952334989, 5202.297689811902, 5211.0, 3324.6509116542657, 3425.8972230833115, 4544.840930567448, 4549.294859296814, 4560.996580752229, 10508.947455262674, 10610.681679549625, 10799.946000270027, 10832.241743077988, 10844.13246940243, 503.41855157293384, 504.8081728943015, 505.31277462650763, 1156.190561770826, 1575.314738088935, 7035.366816986496, 7710.689182838931, 7968.681252749883, 8278.586070696501, 8288.627011784483, 1156.4275683536703, 1252.918560293578, 1258.1193164784688, 1273.719781648036, 1308.2608326295708, 46989.29516057262, 49115.263271050964, 49127.01745965097, 49412.0, 49586.0, 5374.596905232123, 5385.3268341457315, 5442.863928401822, 5465.945340546544, 5483.232347471358, 6243.43809057187, 6259.436650701367, 6279.183706118175, 6280.5289603279025, 6303.3066362700065, 4309.310510318397, 4341.674374421931, 4381.3427985801745, 4383.539728328544, 4398.252297109499, 4519.683622146418, 4554.95445045552, 4564.315352697122, 4576.656750743708, 4591.219492686251, 2420.3102115896886, 2431.4286142756437, 2465.0016743219026, 2466.8519888806727, 2471.4192164841247, 858.1718641510972, 863.2230992107154, 865.1694373401605, 866.6316815353575, 919.9972030486801, 296.3125548726976, 351.26234906695737, 353.80363898036325, 366.6040676069838, 391.1024199462241, 9517.619295228113, 9642.276829237835, 9784.909287396895, 9821.36161149523, 10009.449480278654, 375.6525214176875, 376.37521713954703, 379.7607507270402, 381.92552452272093, 389.94150877368054, 5086.618503612244, 5162.948370516322, 5308.30991971049, 5362.570994320445, 5409.513143817076, 415110.0, 418411.0, 426491.0, 427984.0, 428928.0, 55634.0, 59303.70348148232, 59532.10701839476, 59925.0, 61527.384726152166, 369.4587429415972, 391.20780419650436, 408.4241219879955, 408.79560219890055, 414.43636654150333, 7441.8139546511775, 7988.201179881965, 8365.874511882448, 9197.724068277963, 9246.676366327147, 30466.0, 31169.220769480038, 31481.685183147874, 32429.837850810596, 32762.50856237206, 41087.794561027, 41093.0, 41955.79022104992, 41993.79003104965, 42022.36966445567, 6517.315681853337, 6551.246606640298, 6658.167729033871, 6738.494612903954, 6743.393094621508, 9914.058164474363, 10052.748681282734, 10150.289479736643, 10168.186545076524, 10196.235282354002, 8414.0, 8592.957035214784, 8668.219860212612, 8692.608832602422, 8801.867971980553, 8260.297874680478, 8374.120717324837, 8394.0766515682, 8419.368547359096, 8674.436161649724, 8579.613917373857, 8811.33914956368, 8839.46963182211, 8867.246284065926, 8880.777980550538, 6454.806355809334, 6625.536212465081, 6629.7679581214425, 6636.502262330248, 6654.500912431684, 8206.22040906113, 8557.400981931205, 8582.527960962207, 8680.0, 8706.695265665672], "dojo.html": [2574.562324404851, 2647.563152079907, 2667.333166708323, 2690.219836247488, 2695.703472618012, 4321.848735294266, 4475.373447717322, 4506.549345065492, 4508.188526065307, 4529.501754806973, 4404.779761011952, 4484.753338566377, 4499.145162419138, 4568.086382723461, 4605.286180642006, 4119.8970025749295, 4166.979165104185, 4191.308434108369, 4242.172776308621, 4243.0, 4210.157968406315, 4235.74585524868, 4257.191133684605, 4258.212230737308, 4311.051568654907, 4018.2365350583295, 4124.8556300529335, 4138.0689344897455, 4152.83388664453, 4241.87274381769, 4071.470708807836, 4159.688023398257, 4176.477940257468, 4178.435911151986, 4192.601702838226, 4126.91746165075, 4155.501339839208, 4156.542780294165, 4183.728057676241, 4218.008767939563, 4235.703500754948, 4486.596206341413, 4486.910261794778, 4523.411956445641, 4554.134714404253, 4608.976955115237, 4696.0, 4699.483056863743, 4728.432588089451, 4733.786979585927, 4813.590844778198, 4835.0, 4844.4186697596515, 4846.660733748604, 4876.4879687633, 4500.347449619852, 4501.864944051684, 4502.842400515999, 4518.615917647004, 4554.8405805796965, 4700.858974230779, 4857.854264372075, 4925.187344088257, 4935.0, 4982.825601103944, 4615.169269531517, 4626.86119416418, 4645.74448405341, 4677.0, 4735.692180008288, 4842.0, 4859.684120532154, 4870.8782280442565, 4877.878053048702, 4921.212605983025, 4597.42532183477, 4729.6452766042685, 4789.114013907439, 4831.178699621073, 4854.980454104607, 4691.859244222679, 4713.151632706145, 4738.620910327166, 4763.0, 4815.9886423850685, 3673.4673472346362, 3732.197577520846, 3734.047817806442, 3739.2521495700425, 3752.4934133891575, 3295.3244584860045, 3388.9663652585705, 3404.14896275931, 3413.0955296846355, 3415.419378705626, 4461.888452788641, 4520.254158063948, 4526.32105184225, 4539.477960034638, 4565.0641618468135, 4868.464468908417, 4873.902521949542, 4874.53691899269, 4891.04624598207, 4911.214205727067, 4351.4995775485595, 4454.28731402974, 4565.885852853638, 4616.3306320584, 4623.606993405531, 4137.91724165515, 4177.122804211089, 4210.768407737603, 4226.4505614270565, 4228.0, 4829.927551086666, 4911.557959783637, 4952.232403977389, 4955.454899961073, 4975.726335051607, 4814.20565606671, 4818.831340903052, 4829.420469543677, 4830.420349558076, 4845.2732090186755, 4770.284457331428, 4789.449213340371, 4915.65590408668, 4928.926066108939, 4990.226514890198, 4787.664863459524, 4787.784549695202, 4791.1854984652, 4805.879853003563, 4831.782569784438, 4757.16749568831, 4823.324734537237, 4873.561379475864, 4875.68308059975, 4919.557239848431, 4521.389612402284, 4637.095766325534, 4638.976805115953, 4647.907041859212, 4653.185692503731, 4565.954340456553, 4640.605548528278, 4663.766811659471, 4680.882977925579, 4728.858134255978, 4599.67802253839, 4627.838025669085, 4651.790669419816, 4657.906841863076, 4671.7430541320555, 4708.952910470988, 4723.504032076583, 4726.220173671306, 4728.692634978715, 4770.9980904010545, 4456.24243878535, 4546.522615125365, 4561.178987782231, 4573.108243892409, 4659.906801863876], "mootools.html": [638.7317326722776, 1347.1445632023665, 1423.3950571007326, 1436.2244388030465, 1464.62652023734, 5601.383847776747, 5737.913931291024, 5774.884502309951, 5800.796972105977, 6133.447989680928, 5920.3191632962225, 5990.850228744283, 6010.158577799111, 6045.425684559959, 6057.606255593383, 1634.9673006539863, 1825.6531259060803, 1842.2262649687164, 1844.3729132095084, 1847.5473508990317, 1684.9831501684948, 1692.0270844264535, 1693.119577819533, 1697.0242110786285, 1701.72772356423, 1795.237024264689, 1838.6414649143424, 1843.2995461724593, 1848.4916647921862, 1862.8044055374194, 1828.259554880269, 1829.0945981739123, 1831.60620466599, 1837.503873954025, 1882.1718443884647, 1892.9337473188373, 1910.4459706685045, 1915.1669023974475, 1915.5881485480688, 1917.4726950088698, 6087.147799308056, 6150.261968563801, 6160.5071594272795, 6160.6919654017565, 6163.137160797492, 3908.511436070491, 3981.203759248133, 3982.960170398288, 3993.0616305168264, 3994.7003974702016, 2366.8343215974887, 2503.7621425964503, 2508.811839112074, 2509.8619575923317, 2514.371407148213, 746.4811955690743, 762.2453770766956, 779.3687113438076, 788.8777239527882, 789.6091434739783, 8059.637316320721, 8092.878606820902, 8093.919060809375, 8093.959530202429, 8109.918900811034, 3239.5464634951127, 3568.4647302904773, 3570.8937716504547, 3594.6045934947133, 3645.1069487975615, 6604.1414616100565, 6620.337966203438, 6884.4148247399535, 7006.404455621329, 7060.117485314336, 3849.634284742945, 3853.190829925691, 3888.8250028748776, 3909.315869722844, 3912.5891781363116, 3412.982935085309, 3463.5324231228965, 3467.601225859008, 3502.6847583717076, 3504.5093686883856, 2891.7686585073143, 2902.506573882445, 2941.7646588272887, 2948.6461624604754, 2949.277427030391, 957.1146689312358, 985.0346660272972, 990.3562684255292, 995.2983146881576, 997.2969056814928, 1066.2962444786558, 1074.3714926767927, 1100.6422912553292, 1105.4196546812987, 1105.9391733454738, 5819.156222347736, 5876.382979787147, 5877.235959325346, 5885.529157667376, 5905.409459054146, 550.0484162399072, 554.0968221798443, 561.898858205527, 562.1258942344612, 563.6815199412401, 4424.542108513128, 4550.863474095716, 4568.086382723469, 4582.587567118975, 4586.587207151372, 6925.965370173218, 7093.32613401726, 7095.574265544084, 7100.538464999759, 7109.751158709524, 6820.658967051727, 7018.543794653433, 7056.576605403692, 7147.53541019832, 7158.964205178941, 5707.486326230659, 5708.40061793514, 5722.170285308607, 5726.627769195073, 5746.310442746813, 5592.412796656293, 5621.409751975983, 5623.578231632562, 5638.2670252866865, 5656.604037717485, 6407.967960160169, 6413.935860641333, 6441.259255185526, 6530.183727034121, 6551.541392102507, 6386.265579458236, 6600.141981542369, 6697.296783837822, 6704.329567043256, 6725.7893579156225, 4863.319135320987, 5004.3166472873645, 5348.5186333230195, 5384.919226211531, 5439.048166570913, 5781.392953739797, 5975.790847320323, 5992.970035149797, 6002.0096684048385, 6021.969890150521, 5532.529734972572, 5601.159826026129, 5675.0068737971515, 5679.119736440858, 5727.8568035799435, 5086.491350864884, 5414.0, 5519.31008623922, 5520.834374968757, 5569.0, 5525.0883604204855, 5588.804391846428, 5592.944070559242, 5592.972035139798, 5601.495865372136, 4946.480619534897, 5073.44192138857, 5106.336176297206, 5111.0, 5120.052790233819, 5157.922631160461, 5196.376434827845, 5197.298364720715, 5199.0, 5200.271961925409], "ext.html": [464.7072344423014, 466.43794227955294, 471.91033703596315, 477.7658947115912, 498.53885156230524, 26385.20844374667, 27001.324966875814, 32862.67137328626, 33777.32445351091, 33814.323713525715, 35910.2817943641, 36094.09764755876, 36262.8186859066, 36284.0, 36392.63607363925, 6816.045753594476, 6971.477139214554, 7556.848863022737, 7753.147153813076, 7776.183500732426, 6898.275681053492, 6952.2700116487795, 7013.719451221945, 7049.295070492935, 7087.468439867005, 9212.539373031355, 9426.104520070616, 9469.857952130724, 9478.620855165786, 9483.952580237124, 9199.678011269574, 9227.44635321883, 9304.488253146073, 9307.95346023269, 9308.813823723487, 6963.442924566073, 7161.928380716178, 7162.033125528039, 8923.15230053144, 9192.35653504255, 26612.0, 26825.46349073027, 27093.864530677416, 33780.0, 34218.14454638654, 2482.193287181673, 2493.1024831060804, 2515.308290220186, 2530.316814460104, 2677.250369896432, 22691.09235630573, 23223.026042786383, 23429.531409371888, 23704.881475592683, 24356.634650480257, 1978.1691689490306, 2051.128270485038, 2066.8863212523456, 2075.865068770525, 2126.755423126345, 355328.0, 361689.0, 362134.0, 362602.0, 364671.0, 48065.0, 49320.506794932306, 51919.48080519222, 52366.0, 52392.47607523952, 45136.77431612821, 60417.395826042055, 61437.0, 61760.38239617636, 61920.0, 13272.601821945356, 13731.0, 13833.10084844482, 13904.791428128587, 13918.0, 10114.595416183418, 10367.688969330931, 10451.111655509367, 10481.008608364386, 10508.422036787897, 17095.829041709672, 17220.0, 17229.91385043067, 17258.654826903643, 17475.650486990442, 6992.440604751608, 7262.419006479469, 7269.20038795732, 7295.89056164158, 7375.975849901514, 805.6294104711781, 832.812617161146, 853.4836423963537, 868.9355539464106, 945.3618807305041, 24214.0, 24220.152294669602, 24395.14616988397, 24400.755992440205, 24478.14326498564, 850.6002178975872, 887.0419946457939, 938.6808485115093, 946.5314669238771, 952.2953014769159, 12417.62747117588, 13149.408276627575, 13463.663408414672, 14109.929450352682, 14192.503262385768, 326046.0, 329839.0, 330187.0, 330286.0, 330919.0, 48736.44585089317, 48981.26528102082, 48988.510114898396, 49001.50998490041, 49105.75447122742, 1156.2657712352548, 1162.6976985983536, 1170.8946194842506, 1174.142875700726, 1175.6179241746468, 20345.6948145775, 24785.50428991446, 25571.0, 25894.0, 26013.21960341193, 37307.626923730415, 43537.0, 43677.78161109174, 43706.0, 43748.0, 232215.0, 235775.0, 236027.0, 236738.0, 236796.81601591883, 23293.534129317657, 23776.88111559431, 23857.761422385553, 25148.74851251464, 27022.32444188911, 31512.0, 32572.674273256966, 32916.67083329136, 33201.0, 38715.22569548649, 29870.402591948474, 30490.542641859945, 30661.54007689842, 33003.83498082494, 33782.0, 29570.556441652963, 30174.69825301807, 30213.848930755204, 30284.69715302907, 30296.697033029388, 30633.693663063084, 30832.845835770677, 30998.690013099582, 31121.53317700191, 31290.530642039932, 25322.873385632953, 28934.7106528932, 29561.26096847596, 29648.258793529472, 29736.553951690308, 20211.89894050579, 20427.4893127673, 20448.488787780425, 20612.793872061087, 20636.27773027997], "prototype.html": [259.4292556375973, 266.03694625455853, 268.11655594815085, 269.51083782933983, 270.442887651438, 4988.152014157593, 5165.302684137645, 5179.948200517993, 5189.117849965505, 5201.843944681661, 5001.974990125044, 5031.371078615173, 5183.585313174946, 5190.532852043315, 5197.272381866542, 3754.6057663945303, 3862.2661694278136, 3942.172143849795, 3988.7008474364393, 3999.1601763629674, 3833.8466461341513, 3894.162755007673, 3919.902002449933, 3924.941125883114, 3941.31027070263, 3890.3775395936655, 3896.590857959916, 3897.59075297094, 3900.57093719692, 3907.7655340679507, 3846.480725102131, 3848.749831260987, 3849.9230015399535, 3873.767573945558, 3878.816960826947, 3311.023248141804, 3313.453280208763, 3316.8507417166284, 3323.0861513083855, 3331.716804071657, 4395.934060989088, 4842.903141937177, 4849.9757501212625, 4891.095147397743, 5013.699178049329, 4339.934900976488, 4341.630961368256, 4382.715123516993, 4446.288593825005, 4454.0, 5268.973655131738, 5396.622236443451, 5402.6758394496455, 5403.432639572867, 5434.239206511092, 3647.9817600911824, 3654.689351405134, 3658.2317713280245, 3665.505156803824, 3669.7798132111893, 5433.347998240197, 5496.1755736639425, 5580.497755202051, 5613.410591887875, 5647.29408823897, 3643.85424583019, 3671.2290419012306, 3674.52231209941, 3687.465317528997, 3690.4279836625365, 3710.3692372296773, 3745.438184272381, 3746.6440688134585, 3752.3433399155037, 3757.3612485877466, 4351.695381323277, 4356.019895523482, 4365.650747940221, 4376.015396535818, 4389.978050109729, 5226.8954620908125, 5417.160340147205, 5420.457954204548, 5437.483439073281, 5490.725463726798, 1314.1458052265912, 1314.6384744195232, 1316.045866746601, 1316.0655934286572, 1319.0568743348551, 888.9955550222207, 893.1291990309396, 896.8609865470733, 911.1617312072909, 912.3932584831012, 5204.34945631796, 5211.5830733541225, 5212.452692467312, 5214.895702085937, 5230.607704422184, 5648.378678345379, 5653.208550802891, 5655.575831812631, 5658.575606829504, 5662.405447428043, 5196.116660167705, 5200.7139607321205, 5208.374995000549, 5214.921776173361, 5223.4776522347465, 2945.4109178164454, 3021.8640161192798, 3037.559553864677, 3064.6935306469177, 3073.6004319438775, 5778.768849245983, 5846.941530584725, 5868.706564671835, 5873.089671100986, 5885.117232415172, 5781.797637082766, 5793.362730099686, 5795.536357091507, 5803.738831752581, 5821.2141360916585, 5853.707314634251, 5857.619254748428, 5891.675957822361, 5896.64620122794, 5919.733611987384, 5583.832485025456, 5732.197492351158, 5750.913736294043, 5760.395158508296, 5769.07694768835, 5588.2455868458865, 5594.608377413705, 5603.7758489659955, 5608.495235428831, 5616.550675945833, 5585.2180694701965, 5628.352739435018, 5763.394843541368, 5794.565407594531, 5914.67469289176, 3692.538432695913, 3707.3512135375663, 3724.981375093107, 3728.3102626014274, 3733.253349330199, 5585.525230355465, 5590.776368945197, 5598.580106492111, 5603.411641777718, 5613.887722245614, 5266.473352664856, 5447.536959358499, 5449.073657478159, 5451.64564303319, 5473.8357849264585, 5421.484958928895, 5425.620206585501, 5445.074337362737, 5451.3458384994055, 5456.399796022513, 5290.365156181283, 5299.682019078713, 5306.124489459196, 5311.336082989626, 5320.308359913187, 5453.0, 5454.890902182014, 5455.072637651688, 5463.153211252262, 5463.9180412294645, 5204.583633309402, 5345.412004679404, 5358.490943360374, 5358.892822143457, 5368.087425137658], "yui.html": [557.1280945320575, 596.4602035158183, 621.2017557438691, 621.4401851353103, 643.5559463969857, 12776.0, 13311.933440332808, 13323.26722030288, 13335.733285334287, 13423.865761342384, 12143.757124857497, 12194.024478041758, 12210.511579536807, 12219.572314968978, 12224.022078233742, 568.1903287814847, 573.7934343636288, 702.1468915267935, 721.9133703955532, 724.5833645653744, 578.7164289498157, 703.5251205436335, 720.4380583145155, 723.1791916175152, 727.5343779980816, 740.4224704730319, 755.2862544895077, 760.646299470746, 761.3338328962158, 761.8857171424276, 579.7854793726306, 587.538782056084, 588.7027051339089, 752.2815710995985, 753.4010461682948, 432.71657064622406, 432.8160531773984, 432.84633954946173, 536.2412186755736, 552.9225908372831, 11056.447177641086, 11152.665420037412, 11216.943915280453, 11223.719407014809, 11230.326180429118, 7704.537727736354, 7917.841643167105, 7940.325072368798, 8172.019357677117, 8250.216229458252, 6763.053172555846, 7280.41756659466, 7641.3504852087635, 7649.273319034683, 7800.395521389394, 2412.2401443545227, 2441.9511609767883, 2490.7384724603835, 2518.6977562692596, 2561.718210996789, 36311.4553281701, 37084.62915370866, 38682.41976370357, 38957.220855583015, 39474.60525394738, 5478.287822583039, 5614.578906581941, 5692.31692196939, 5809.941900581025, 5897.262842144732, 10052.145567626687, 10100.74748131288, 10255.692329229985, 10307.742306442398, 10327.32872363294, 4999.975000124976, 5031.993601279685, 5039.588969693932, 5054.079449809123, 5166.992436474927, 3147.244661281276, 3157.4000939821362, 3273.0835366097053, 3289.7039266465654, 3374.105861946586, 2289.8168146548237, 2324.8953797078834, 2330.4057465346227, 2334.696489456394, 2335.381124002141, 335.6559526485323, 339.71803403175306, 345.5369804462033, 346.1346633416459, 347.6419288133227, 395.73365231260084, 461.9561141691534, 486.28030514838235, 503.26272011503323, 522.5479959834715, 6126.479249263773, 6407.663017610687, 6514.5114116441455, 6638.0, 6679.966600166968, 335.7632868827471, 415.9854405095807, 479.35526716566164, 497.8929530151035, 500.7896683392984, 3040.8479576021555, 3070.217094640897, 3074.8462576871066, 3078.9076327710204, 3136.2316232523176, 47382.76308618435, 47693.761531192125, 47732.284015739795, 47845.5215447848, 47994.76002619965, 41302.0, 41654.58345416567, 42287.788561057, 42484.78757606192, 42760.78619606944, 37340.0, 37691.81154094267, 38061.85814425627, 38520.6147938517, 39011.6098839008, 6294.5279104068295, 6345.0, 6359.427651511386, 6363.0, 6432.09950606906, 27799.0, 28023.0, 28648.283792905346, 29090.563641545818, 29143.85428072846, 33706.662933371335, 33854.153646159044, 34007.3198536023, 34285.82857085699, 37695.81152094222, 5762.394948530344, 5773.3072031356505, 5806.332271788799, 5921.99326114553, 5929.851753706192, 8194.631241594261, 8270.917290827014, 8348.707795227137, 8387.245147936472, 8441.83116337682, 7770.222977702185, 8089.2315230053055, 8176.141505141874, 8230.300424463987, 8255.42212045175, 8088.231617996281, 8180.0, 8203.097659257597, 8258.793530161794, 8290.709825156091, 6948.409385202314, 8001.919980800118, 8036.517808931483, 8167.714130005421, 8288.668453262044, 7400.5189662671755, 7421.925780742339, 7795.142534321107, 7883.646061908887, 7910.406719496176, 6628.436582890316, 6767.796966091025, 6959.756408525677, 7484.363829074372, 7619.123800762984]}, "summary": {"lowerIsBetter": false, "suite": 5475.013962435034, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5655.225588049019, "unit": "ms", "value": 5655.225588049019}, "dojo.html": {"lowerIsBetter": false, "filtered": 4445.637006821832, "unit": "ms", "value": 4445.637006821832}, "mootools.html": {"lowerIsBetter": false, "filtered": 3521.114994100378, "unit": "ms", "value": 3521.114994100378}, "ext.html": {"lowerIsBetter": false, "filtered": 16002.72020043702, "unit": "ms", "value": 16002.72020043702}, "prototype.html": {"lowerIsBetter": false, "filtered": 4054.553251694054, "unit": "ms", "value": 4054.553251694054}, "yui.html": {"lowerIsBetter": false, "filtered": 4688.79966483163, "unit": "ms", "value": 4688.79966483163}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0086"}, "testrun": {"date": 1447860183, "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": "20151118054924", "branch": "Firefox", "revision": "f8cc032951d3e6546c78816dc2bfae80461e1feb"}}, {"talos_counters": {}, "results": {"audio-dft": [194.0, 200.0, 197.0, 195.0, 198.0, 196.0, 196.0, 190.0, 197.0, 199.0], "ai-astar": [126.0, 132.0, 133.0, 132.0, 131.0, 132.0, 132.0, 131.0, 129.0, 138.0], "imaging-gaussian-blur": [148.0, 148.0, 141.0, 142.0, 141.0, 148.0, 139.0, 141.0, 141.0, 148.0], "audio-beat-detection": [191.0, 160.0, 188.0, 206.0, 153.0, 182.0, 180.0, 152.0, 200.0, 163.0], "json-stringify-tinderbox": [81.0, 83.0, 85.0, 89.0, 86.0, 87.0, 87.0, 87.0, 83.0, 84.0], "stanford-crypto-pbkdf2": [172.0, 183.0, 189.0, 189.0, 191.0, 167.0, 190.0, 189.0, 189.0, 176.0], "json-parse-financial": [68.0, 71.0, 74.0, 73.0, 74.0, 74.0, 76.0, 83.0, 72.0, 72.0], "stanford-crypto-sha256-iterative": [82.0, 86.0, 86.0, 89.0, 89.0, 87.0, 87.0, 87.0, 89.0, 88.0], "audio-fft": [93.0, 99.0, 104.0, 105.0, 83.0, 84.0, 85.0, 105.0, 108.0, 84.0], "imaging-darkroom": [155.0, 155.0, 155.0, 155.0, 155.0, 155.0, 155.0, 155.0, 155.0, 155.0], "stanford-crypto-ccm": [161.0, 159.0, 158.0, 150.0, 151.0, 153.0, 167.0, 158.0, 154.0, 149.0], "audio-oscillator": [117.0, 120.0, 162.0, 108.0, 110.0, 109.0, 155.0, 109.0, 108.0, 159.0], "stanford-crypto-aes": [103.0, 105.0, 105.0, 106.0, 104.0, 106.0, 104.0, 106.0, 106.0, 106.0], "imaging-desaturate": [115.0, 130.0, 127.0, 115.0, 114.0, 124.0, 115.0, 130.0, 117.0, 123.0]}, "summary": {"lowerIsBetter": true, "suite": 1836.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 95.0, "unit": "ms", "value": 95.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 183.5, "unit": "ms", "value": 183.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 177.5, "unit": "ms", "value": 177.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 156.0, "unit": "ms", "value": 156.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 155.0, "unit": "ms", "value": 155.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.7, "unit": "ms", "value": 73.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 125.7, "unit": "ms", "value": 125.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 131.6, "unit": "ms", "value": 131.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 196.2, "unit": "ms", "value": 196.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 87.0, "unit": "ms", "value": 87.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 85.2, "unit": "ms", "value": 85.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 143.7, "unit": "ms", "value": 143.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 105.1, "unit": "ms", "value": 105.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 121.0, "unit": "ms", "value": 121.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0086"}, "testrun": {"date": 1447860183, "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": "20151118054924", "branch": "Firefox", "revision": "f8cc032951d3e6546c78816dc2bfae80461e1feb"}}, {"talos_counters": {}, "results": {"DeltaBlue": [238.60653781913624], "Encrypt": [382.84839203675347], "NavierStokes": [6863.013698630137], "Decrypt": [7099.290780141844], "Splay": [889.6797153024911], "Richards": [201.8978396931153], "RegExp": [35293.10344827586], "Earley": [955.1526717557252], "Boyer": [16258.064516129032], "RayTrace": [2358.490566037736]}, "summary": {"lowerIsBetter": false, "suite": 15087.385756445792, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 277.10053799999986, "unit": "score", "value": 277.10053799999986}, "Encrypt": {"lowerIsBetter": false, "filtered": 695.2647719999998, "unit": "score", "value": 695.2647719999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 216.2315369261477, "unit": "score", "value": 216.2315369261477}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.49402697302694, "unit": "score", "value": 37.49402697302694}, "Splay": {"lowerIsBetter": false, "filtered": 91.59588400000001, "unit": "score", "value": 91.59588400000001}, "RegExp": {"lowerIsBetter": false, "filtered": 25.81198339032731, "unit": "score", "value": 25.81198339032731}, "Richards": {"lowerIsBetter": false, "filtered": 174.85080599999998, "unit": "score", "value": 174.85080599999998}, "Earley": {"lowerIsBetter": false, "filtered": 697.7554685314686, "unit": "score", "value": 697.7554685314686}, "Boyer": {"lowerIsBetter": false, "filtered": 40.992763888888916, "unit": "score", "value": 40.992763888888916}, "RayTrace": {"lowerIsBetter": false, "filtered": 313.755336, "unit": "score", "value": 313.755336}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0086"}, "testrun": {"date": 1447860183, "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": "20151118054924", "branch": "Firefox", "revision": "f8cc032951d3e6546c78816dc2bfae80461e1feb"}}] 07:43:25 INFO - RETURN: dromaeo_css: 5475.01 07:43:25 INFO - RETURN: kraken: 1836.20 07:43:25 INFO - RETURN: v8_7: 15087.39 07:43:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "15087.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1836.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5475.01"}}} 07:43:25 INFO - Return code: 0 07:43:25 INFO - # TBPL SUCCESS # 07:43:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:43:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:43:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:43:25 INFO - 2015-11-18 07:43:25.143 screenresolution[1960:14874] starting screenresolution argv=screenresolution get 07:43:25 INFO - 2015-11-18 07:43:25.146 screenresolution[1960:14874] Display 0: 1600x1200x32@60 07:43:25 INFO - 2015-11-18 07:43:25.153 screenresolution[1961:14878] starting screenresolution argv=screenresolution list 07:43:25 INFO - Available Modes on Display 0 07:43:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:43:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:43:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:43:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:43:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:43:25 INFO - Intel HD Graphics 3000: 07:43:25 INFO - Chipset Model: Intel HD Graphics 3000 07:43:25 INFO - Type: GPU 07:43:25 INFO - Bus: Built-In 07:43:25 INFO - VRAM (Total): 512 MB 07:43:25 INFO - VRAM (Dynamic, Max): 10 07:43:25 INFO - Vendor: Intel (0x8086) 07:43:25 INFO - Device ID: 0x0116 07:43:25 INFO - Revision ID: 0x0009 07:43:25 INFO - Displays: 07:43:25 INFO - Display: 07:43:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:43:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:43:25 INFO - Display Serial Number: 1600x1200 60 07:43:25 INFO - Main Display: Yes 07:43:25 INFO - Mirror: Off 07:43:25 INFO - Online: Yes 07:43:25 INFO - Rotation: Supported 07:43:25 INFO - Return code: 0 07:43:25 INFO - Running post-action listener: _resource_record_post_action 07:43:25 INFO - Running post-run listener: _resource_record_post_run 07:43:26 INFO - Total resource usage - Wall time: 1265s; CPU: 30.0%; Read bytes: 2437120; Write bytes: 686041088; Read time: 1401; Write time: 61161 07:43:26 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 335086080; Write bytes: 335525888; Read time: 36906; Write time: 5810 07:43:26 INFO - run-tests - Wall time: 1222s; CPU: 30.0%; Read bytes: 2433024; Write bytes: 340140032; Read time: 1371; Write time: 54002 07:43:26 INFO - Running post-run listener: _upload_blobber_files 07:43:26 INFO - Blob upload gear active. 07:43:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:43:26 INFO - Copying logs to upload dir... 07:43:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1322.629357 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-18 07:43:26.628559) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:43:26.632279) ========= 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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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/FrP7aKwjQ7uA_MDcT4htig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/FrP7aKwjQ7uA_MDcT4htig/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-18 07:43:26.667153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:43:26.667501) ========= 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.BI1OqtEQOi/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.Eh7ZUX1GOR/Listeners TMPDIR=/var/folders/gj/14qsb1p13_v2qlqjn3b8clxm00000w/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.005762 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:43:26.754698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:43:26.755022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:43:26.756959) ========= ========= Total master_lag: 3.48 =========