builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0271 starttime: 1467803470.59 results: success (0) buildid: 20160706024124 builduid: 61d539fbfe6c4133a8983e336060d99c revision: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.587504) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.588015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.588344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.611587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.612201) ========= 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.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-06 04:11:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 40.9M=0s 2016-07-06 04:11:10 (40.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.739314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.739659) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020200 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:10.789285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 04:11:10.789886) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 --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 a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-06 04:11:10,862 truncating revision to first 12 chars 2016-07-06 04:11:10,862 Setting DEBUG logging. 2016-07-06 04:11:10,862 attempt 1/10 2016-07-06 04:11:10,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a7d6bb9e7d12?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 04:11:12,321 unpacking tar archive at: mozilla-central-a7d6bb9e7d12/testing/mozharness/ program finished with exit code 0 elapsedTime=1.732290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 04:11:12.545167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:12.545540) ========= script_repo_revision: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:12.546000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:12.546309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:12.565492) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-06 04:11:12.565898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--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.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:11:12 INFO - MultiFileLogger online at 20160706 04:11:12 in /builds/slave/test 04:11:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:11:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:12 INFO - {'append_to_log': False, 04:11:12 INFO - 'base_work_dir': '/builds/slave/test', 04:11:12 INFO - 'blob_upload_branch': 'Firefox', 04:11:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:12 INFO - 'branch': 'Firefox', 04:11:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:12 INFO - 'config_files': ('talos/mac_config.py',), 04:11:12 INFO - 'default_actions': ('clobber', 04:11:12 INFO - 'read-buildbot-config', 04:11:12 INFO - 'download-and-extract', 04:11:12 INFO - 'populate-webroot', 04:11:12 INFO - 'create-virtualenv', 04:11:12 INFO - 'install', 04:11:12 INFO - 'run-tests'), 04:11:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:12 INFO - 'download_minidump_stackwalk': True, 04:11:12 INFO - 'download_symbols': 'ondemand', 04:11:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:12 INFO - 'installer_path': 'installer.exe', 04:11:12 INFO - 'log_level': 'info', 04:11:12 INFO - 'log_name': 'talos', 04:11:12 INFO - 'log_to_console': True, 04:11:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:11:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:11:12 INFO - 'opt_config_files': (), 04:11:12 INFO - 'pip_index': False, 04:11:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:12 INFO - 'cmd': ('bash', 04:11:12 INFO - '-c', 04:11:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:12 INFO - 'enabled': True, 04:11:12 INFO - 'halt_on_failure': False, 04:11:12 INFO - 'name': 'check_screen_resolution'},), 04:11:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:12 INFO - 'cmd': ('bash', 04:11:12 INFO - '-c', 04:11:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:12 INFO - 'enabled': True, 04:11:12 INFO - 'halt_on_failure': False, 04:11:12 INFO - 'name': 'check_screen_resolution'},), 04:11:12 INFO - 'run_cmd_checks_enabled': True, 04:11:12 INFO - 'sps_profile': False, 04:11:12 INFO - 'sps_profile_interval': 0, 04:11:12 INFO - 'suite': 'dromaeojs-e10s', 04:11:12 INFO - 'system_bits': '32', 04:11:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:12 INFO - 'title': 't-yosemite-r7-0271', 04:11:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:12 INFO - 'use_talos_json': True, 04:11:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:12 INFO - 'work_dir': 'build'} 04:11:12 INFO - ##### 04:11:12 INFO - ##### Running clobber step. 04:11:12 INFO - ##### 04:11:12 INFO - Running pre-action listener: _resource_record_pre_action 04:11:12 INFO - Running main action method: clobber 04:11:12 INFO - rmtree: /builds/slave/test/build 04:11:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:14 INFO - Running post-action listener: _resource_record_post_action 04:11:14 INFO - ##### 04:11:14 INFO - ##### Finished clobber step (success) 04:11:14 INFO - ##### 04:11:14 INFO - ##### 04:11:14 INFO - ##### Running read-buildbot-config step. 04:11:14 INFO - ##### 04:11:14 INFO - Running pre-action listener: _resource_record_pre_action 04:11:14 INFO - Running main action method: read_buildbot_config 04:11:14 INFO - Using buildbot properties: 04:11:14 INFO - { 04:11:14 INFO - "project": "", 04:11:14 INFO - "product": "firefox", 04:11:14 INFO - "script_repo_revision": "production", 04:11:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:11:14 INFO - "repository": "", 04:11:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:11:14 INFO - "buildid": "20160706024124", 04:11:14 INFO - "pgo_build": "False", 04:11:14 INFO - "basedir": "/builds/slave/test", 04:11:14 INFO - "buildnumber": 42, 04:11:14 INFO - "slavename": "t-yosemite-r7-0271", 04:11:14 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:11:14 INFO - "platform": "yosemite_r7", 04:11:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:11:14 INFO - "branch": "mozilla-central", 04:11:14 INFO - "repo_path": "mozilla-central", 04:11:14 INFO - "revision": "a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8", 04:11:14 INFO - "stage_platform": "macosx64", 04:11:14 INFO - "builduid": "61d539fbfe6c4133a8983e336060d99c", 04:11:14 INFO - "slavebuilddir": "test" 04:11:14 INFO - } 04:11:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 04:11:14 INFO - Running post-action listener: _resource_record_post_action 04:11:14 INFO - ##### 04:11:14 INFO - ##### Finished read-buildbot-config step (success) 04:11:14 INFO - ##### 04:11:14 INFO - ##### 04:11:14 INFO - ##### Running download-and-extract step. 04:11:14 INFO - ##### 04:11:14 INFO - Running pre-action listener: _resource_record_pre_action 04:11:14 INFO - Running main action method: download_and_extract 04:11:14 INFO - mkdir: /builds/slave/test/build/tests 04:11:14 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')]} 04:11:14 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:11:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 04:11:16 INFO - Downloaded 1199 bytes. 04:11:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:16 INFO - Using the following test package requirements: 04:11:16 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:11:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 04:11:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 04:11:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'jsshell-mac.zip'], 04:11:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 04:11:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:11:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 04:11:16 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 04:11:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 04:11:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:16 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 04:11:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:11:16 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')]} 04:11:16 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:17 INFO - Downloaded 18804128 bytes. 04:11:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:11:20 INFO - Return code: 0 04:11:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:20 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:21 INFO - Downloaded 18804128 bytes. 04:11:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:11:24 INFO - Return code: 0 04:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:24 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:11:25 INFO - Downloaded 14403333 bytes. 04:11:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:11:26 INFO - Return code: 0 04:11: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')]} 04:11:26 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 04:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 04:11:29 INFO - Downloaded 112518062 bytes. 04:11:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:29 INFO - mkdir: /builds/slave/test/properties 04:11:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:29 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:29 INFO - Contents: 04:11:29 INFO - build_url:https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:30 INFO - Running post-action listener: _resource_record_post_action 04:11:30 INFO - Running post-action listener: set_extra_try_arguments 04:11:30 INFO - ##### 04:11:30 INFO - ##### Finished download-and-extract step (success) 04:11:30 INFO - ##### 04:11:30 INFO - ##### 04:11:30 INFO - ##### Running populate-webroot step. 04:11:30 INFO - ##### 04:11:30 INFO - Running pre-action listener: _resource_record_pre_action 04:11:30 INFO - Running main action method: populate_webroot 04:11:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:30 INFO - '--tppagecycles', 04:11:30 INFO - '7'], 04:11:30 INFO - 'tests': ['tsvgm']}}, 04:11:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['damp', 'tps']}, 04:11:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'tests': ['damp', 'tps']}, 04:11:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['dromaeo_dom']}, 04:11:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['basic_compositor_video']}, 04:11:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:11:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['a11yr', 04:11:30 INFO - 'ts_paint', 04:11:30 INFO - 'tpaint', 04:11:30 INFO - 'sessionrestore', 04:11:30 INFO - 'sessionrestore_no_auto_restore', 04:11:30 INFO - 'tabpaint']}, 04:11:30 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:30 INFO - 'ts_paint', 04:11:30 INFO - 'tpaint', 04:11:30 INFO - 'sessionrestore', 04:11:30 INFO - 'sessionrestore_no_auto_restore', 04:11:30 INFO - 'tabpaint']}, 04:11:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:30 INFO - 'ts_paint', 04:11:30 INFO - 'tpaint', 04:11:30 INFO - 'sessionrestore', 04:11:30 INFO - 'sessionrestore_no_auto_restore', 04:11:30 INFO - 'tabpaint']}, 04:11:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:30 INFO - 'ts_paint', 04:11:30 INFO - 'tpaint', 04:11:30 INFO - 'sessionrestore', 04:11:30 INFO - 'sessionrestore_no_auto_restore', 04:11:30 INFO - 'tabpaint']}, 04:11:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['a11yr', 04:11:30 INFO - 'ts_paint', 04:11:30 INFO - 'tpaint', 04:11:30 INFO - 'sessionrestore', 04:11:30 INFO - 'sessionrestore_no_auto_restore', 04:11:30 INFO - 'tabpaint']}, 04:11:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['a11yr', 04:11:30 INFO - 'ts_paint', 04:11:30 INFO - 'tpaint', 04:11:30 INFO - 'sessionrestore', 04:11:30 INFO - 'sessionrestore_no_auto_restore', 04:11:30 INFO - 'tabpaint']}, 04:11:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['tsvgx', 04:11:30 INFO - 'tsvgr_opacity', 04:11:30 INFO - 'tart', 04:11:30 INFO - 'tscrollx', 04:11:30 INFO - 'cart']}, 04:11:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:30 INFO - 'tsvgr_opacity', 04:11:30 INFO - 'tart', 04:11:30 INFO - 'tscrollx', 04:11:30 INFO - 'cart']}, 04:11:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'talos_options': ['--disable-e10s'], 04:11:30 INFO - 'tests': ['tp5o']}, 04:11:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'tests': ['tp5o']}, 04:11:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'talos_options': ['--disable-e10s', 04:11:30 INFO - '--xperf_path', 04:11:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:30 INFO - 'tests': ['tp5n']}, 04:11:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:30 INFO - 'talos_options': ['--xperf_path', 04:11:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:30 INFO - 'tests': ['tp5n']}}, 04:11:30 INFO - 'talos.zip': {'path': '', 04:11:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:30 INFO - Running post-action listener: _resource_record_post_action 04:11:30 INFO - ##### 04:11:30 INFO - ##### Finished populate-webroot step (success) 04:11:30 INFO - ##### 04:11:30 INFO - ##### 04:11:30 INFO - ##### Running create-virtualenv step. 04:11:30 INFO - ##### 04:11:30 INFO - Running pre-action listener: _resource_record_pre_action 04:11:30 INFO - Running main action method: create_virtualenv 04:11:30 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:30 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 04:11:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:30 INFO - Using real prefix '/tools/python27' 04:11:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:33 INFO - Installing pip.................done. 04:11:33 INFO - Return code: 0 04:11:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:33 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')]} 04:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:33 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')]} 04:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:33 INFO - 'HOME': '/Users/cltbld', 04:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:33 INFO - 'LOGNAME': 'cltbld', 04:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:33 INFO - 'MOZ_NO_REMOTE': '1', 04:11:33 INFO - 'NO_EM_RESTART': '1', 04:11:33 INFO - 'PAGER': '/bin/cat', 04:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:33 INFO - 'PWD': '/builds/slave/test', 04:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:33 INFO - 'SHELL': '/bin/bash', 04:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:33 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:33 INFO - 'USER': 'cltbld', 04:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:33 INFO - 'XPC_FLAGS': '0x0', 04:11:33 INFO - 'XPC_SERVICE_NAME': '0', 04:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:34 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 04:11:34 INFO - Cleaning up... 04:11:34 INFO - Return code: 0 04:11:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 04:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 04:11:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:34 INFO - 'HOME': '/Users/cltbld', 04:11:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:34 INFO - 'LOGNAME': 'cltbld', 04:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:34 INFO - 'MOZ_NO_REMOTE': '1', 04:11:34 INFO - 'NO_EM_RESTART': '1', 04:11:34 INFO - 'PAGER': '/bin/cat', 04:11:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:34 INFO - 'PWD': '/builds/slave/test', 04:11:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:34 INFO - 'SHELL': '/bin/bash', 04:11:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:34 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:34 INFO - 'USER': 'cltbld', 04:11:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:34 INFO - 'XPC_FLAGS': '0x0', 04:11:34 INFO - 'XPC_SERVICE_NAME': '0', 04:11:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:34 INFO - Downloading/unpacking psutil>=3.1.1 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:36 INFO - Installing collected packages: psutil 04:11:36 INFO - Running setup.py install for psutil 04:11:37 INFO - building 'psutil._psutil_osx' extension 04:11:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:11:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:11:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:11:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:11:37 INFO - building 'psutil._psutil_posix' extension 04:11:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:11:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:11:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:11:37 INFO - ^ 04:11:37 INFO - 1 warning generated. 04:11:37 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 04:11:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:37 INFO - Successfully installed psutil 04:11:37 INFO - Cleaning up... 04:11:37 INFO - Return code: 0 04:11:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 04:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 04:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:37 INFO - 'HOME': '/Users/cltbld', 04:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:37 INFO - 'LOGNAME': 'cltbld', 04:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:37 INFO - 'MOZ_NO_REMOTE': '1', 04:11:37 INFO - 'NO_EM_RESTART': '1', 04:11:37 INFO - 'PAGER': '/bin/cat', 04:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:37 INFO - 'PWD': '/builds/slave/test', 04:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:37 INFO - 'SHELL': '/bin/bash', 04:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:37 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:37 INFO - 'USER': 'cltbld', 04:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:37 INFO - 'XPC_FLAGS': '0x0', 04:11:37 INFO - 'XPC_SERVICE_NAME': '0', 04:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:40 INFO - Installing collected packages: mozsystemmonitor 04:11:40 INFO - Running setup.py install for mozsystemmonitor 04:11:40 INFO - Successfully installed mozsystemmonitor 04:11:40 INFO - Cleaning up... 04:11:40 INFO - Return code: 0 04:11:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema==2.5.1 04:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:40 INFO - 'HOME': '/Users/cltbld', 04:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:40 INFO - 'LOGNAME': 'cltbld', 04:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:40 INFO - 'MOZ_NO_REMOTE': '1', 04:11:40 INFO - 'NO_EM_RESTART': '1', 04:11:40 INFO - 'PAGER': '/bin/cat', 04:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:40 INFO - 'PWD': '/builds/slave/test', 04:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:40 INFO - 'SHELL': '/bin/bash', 04:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:40 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:40 INFO - 'USER': 'cltbld', 04:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:40 INFO - 'XPC_FLAGS': '0x0', 04:11:40 INFO - 'XPC_SERVICE_NAME': '0', 04:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:41 INFO - Downloading/unpacking jsonschema==2.5.1 04:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:11:43 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 04:11:43 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 04:11:43 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 04:11:43 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 04:11:43 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 04:11:43 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 04:11:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:43 INFO - warning: no files found matching '*.txt' 04:11:43 INFO - no previously-included directories found matching 'build' 04:11:43 INFO - no previously-included directories found matching 'dist' 04:11:43 INFO - no previously-included directories found matching '.git*' 04:11:43 INFO - Installing collected packages: jsonschema, functools32 04:11:43 INFO - Running setup.py install for functools32 04:11:44 INFO - warning: no files found matching '*.txt' 04:11:44 INFO - no previously-included directories found matching 'build' 04:11:44 INFO - no previously-included directories found matching 'dist' 04:11:44 INFO - no previously-included directories found matching '.git*' 04:11:44 INFO - Successfully installed jsonschema functools32 04:11:44 INFO - Cleaning up... 04:11:44 INFO - Return code: 0 04:11:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:44 INFO - 'HOME': '/Users/cltbld', 04:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:44 INFO - 'LOGNAME': 'cltbld', 04:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:44 INFO - 'MOZ_NO_REMOTE': '1', 04:11:44 INFO - 'NO_EM_RESTART': '1', 04:11:44 INFO - 'PAGER': '/bin/cat', 04:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:44 INFO - 'PWD': '/builds/slave/test', 04:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:44 INFO - 'SHELL': '/bin/bash', 04:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:44 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:44 INFO - 'USER': 'cltbld', 04:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:44 INFO - 'XPC_FLAGS': '0x0', 04:11:44 INFO - 'XPC_SERVICE_NAME': '0', 04:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:47 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 04:11:47 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 04:11:47 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 04:11:47 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 04:11:47 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 04:11:47 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 04:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:47 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 04:11:47 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 04:11:47 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 04:11:47 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 04:11:47 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 04:11:47 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 04:11:48 INFO - Downloading docopt-0.6.1.tar.gz 04:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:48 INFO - Running setup.py install for blobuploader 04:11:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:48 INFO - Running setup.py install for requests 04:11:48 INFO - Running setup.py install for docopt 04:11:48 INFO - Successfully installed blobuploader requests docopt 04:11:48 INFO - Cleaning up... 04:11:49 INFO - Return code: 0 04:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 04:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 04:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:49 INFO - 'HOME': '/Users/cltbld', 04:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:49 INFO - 'LOGNAME': 'cltbld', 04:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:49 INFO - 'MOZ_NO_REMOTE': '1', 04:11:49 INFO - 'NO_EM_RESTART': '1', 04:11:49 INFO - 'PAGER': '/bin/cat', 04:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:49 INFO - 'PWD': '/builds/slave/test', 04:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:49 INFO - 'SHELL': '/bin/bash', 04:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:49 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:49 INFO - 'USER': 'cltbld', 04:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:49 INFO - 'XPC_FLAGS': '0x0', 04:11:49 INFO - 'XPC_SERVICE_NAME': '0', 04:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:49 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-HZrxdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:49 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-SMI0pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:49 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-iO9I5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:49 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-tVVHtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:49 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-pdwou3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:49 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-TrI6xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:49 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-7urC7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-naEjf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-n3afJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-3y5gat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-a1Q9hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-GnAGQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-KcTmVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-4PRlem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-eN87Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:50 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-FNBwTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:51 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-1MeGmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:51 INFO - Running setup.py install for manifestparser 04:11:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:51 INFO - Running setup.py install for mozcrash 04:11:51 INFO - Running setup.py install for mozdebug 04:11:51 INFO - Running setup.py install for mozdevice 04:11:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:51 INFO - Running setup.py install for mozfile 04:11:51 INFO - Running setup.py install for mozhttpd 04:11:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Running setup.py install for mozinfo 04:11:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Running setup.py install for mozInstall 04:11:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Running setup.py install for mozleak 04:11:52 INFO - Running setup.py install for mozlog 04:11:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Running setup.py install for moznetwork 04:11:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:52 INFO - Running setup.py install for mozprocess 04:11:52 INFO - Running setup.py install for mozprofile 04:11:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:53 INFO - Running setup.py install for mozrunner 04:11:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:53 INFO - Running setup.py install for mozscreenshot 04:11:53 INFO - Running setup.py install for moztest 04:11:53 INFO - Running setup.py install for mozversion 04:11:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:53 INFO - Cleaning up... 04:11:53 INFO - Return code: 0 04:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:53 INFO - 'HOME': '/Users/cltbld', 04:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:53 INFO - 'LOGNAME': 'cltbld', 04:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:53 INFO - 'MOZ_NO_REMOTE': '1', 04:11:53 INFO - 'NO_EM_RESTART': '1', 04:11:53 INFO - 'PAGER': '/bin/cat', 04:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:53 INFO - 'PWD': '/builds/slave/test', 04:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:53 INFO - 'SHELL': '/bin/bash', 04:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:53 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:53 INFO - 'USER': 'cltbld', 04:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:53 INFO - 'XPC_FLAGS': '0x0', 04:11:53 INFO - 'XPC_SERVICE_NAME': '0', 04:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-fiEQXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:54 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-OmeQk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Mg9Cuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:54 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-GI1tYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Gsa0Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:54 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-c6dIX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:54 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-21zncG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:54 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-wSqjj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:54 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-tPEcz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:54 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)) 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:54 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-d4X14T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:55 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-KtmaV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:55 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)) 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:55 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-dm6n_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:55 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)) 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:55 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-qMQxLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:55 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-qK9VJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:55 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)) 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:55 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-2eqo6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:55 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)) 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:55 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-ER54QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:55 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)) 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:55 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-mHzIjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:55 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)) 04:11:55 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:55 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:55 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)) 04:11:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:55 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 04:11:55 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 04:11:55 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 04:11:55 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 04:11:55 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 04:11:55 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 04:11:58 INFO - Downloading blessings-1.6.tar.gz 04:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:58 INFO - Installing collected packages: blessings 04:11:58 INFO - Running setup.py install for blessings 04:11:58 INFO - Successfully installed blessings 04:11:58 INFO - Cleaning up... 04:11:58 INFO - Return code: 0 04:11:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:58 INFO - Reading from file tmpfile_stdout 04:11:58 INFO - Current package versions: 04:11:58 INFO - blessings == 1.6 04:11:58 INFO - blobuploader == 1.2.4 04:11:58 INFO - docopt == 0.6.1 04:11:58 INFO - functools32 == 3.2.3-2 04:11:58 INFO - jsonschema == 2.5.1 04:11:58 INFO - manifestparser == 1.1 04:11:58 INFO - mozInstall == 1.12 04:11:58 INFO - mozcrash == 0.17 04:11:58 INFO - mozdebug == 0.1 04:11:58 INFO - mozdevice == 0.48 04:11:58 INFO - mozfile == 1.2 04:11:58 INFO - mozhttpd == 0.7 04:11:58 INFO - mozinfo == 0.9 04:11:58 INFO - mozleak == 0.1 04:11:58 INFO - mozlog == 3.2 04:11:58 INFO - moznetwork == 0.27 04:11:58 INFO - mozprocess == 0.22 04:11:58 INFO - mozprofile == 0.28 04:11:58 INFO - mozrunner == 6.11 04:11:58 INFO - mozscreenshot == 0.1 04:11:58 INFO - mozsystemmonitor == 0.3 04:11:58 INFO - moztest == 0.7 04:11:58 INFO - mozversion == 1.4 04:11:58 INFO - psutil == 3.1.1 04:11:58 INFO - requests == 1.2.3 04:11:58 INFO - wsgiref == 0.1.2 04:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:11:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:58 INFO - 'HOME': '/Users/cltbld', 04:11:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:58 INFO - 'LOGNAME': 'cltbld', 04:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:58 INFO - 'MOZ_NO_REMOTE': '1', 04:11:58 INFO - 'NO_EM_RESTART': '1', 04:11:58 INFO - 'PAGER': '/bin/cat', 04:11:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:58 INFO - 'PWD': '/builds/slave/test', 04:11:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:58 INFO - 'SHELL': '/bin/bash', 04:11:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:58 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:58 INFO - 'USER': 'cltbld', 04:11:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:58 INFO - 'XPC_FLAGS': '0x0', 04:11:58 INFO - 'XPC_SERVICE_NAME': '0', 04:11:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:59 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 2)) 04:11:59 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 3)) 04:11:59 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 4)) 04:11:59 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 5)) 04:11:59 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 6)) 04:11:59 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 7)) 04:11:59 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 8)) 04:11:59 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 9)) 04:11:59 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:59 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 4)) 04:11:59 INFO - Cleaning up... 04:11:59 INFO - Return code: 0 04:11:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10621aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062af618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02ad8bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 04:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 04:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:59 INFO - 'HOME': '/Users/cltbld', 04:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:59 INFO - 'LOGNAME': 'cltbld', 04:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:59 INFO - 'MOZ_NO_REMOTE': '1', 04:11:59 INFO - 'NO_EM_RESTART': '1', 04:11:59 INFO - 'PAGER': '/bin/cat', 04:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:59 INFO - 'PWD': '/builds/slave/test', 04:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:59 INFO - 'SHELL': '/bin/bash', 04:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:11:59 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:59 INFO - 'USER': 'cltbld', 04:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:59 INFO - 'XPC_FLAGS': '0x0', 04:11:59 INFO - 'XPC_SERVICE_NAME': '0', 04:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:11:59 INFO - Cleaning up... 04:11:59 INFO - Return code: 0 04:11:59 INFO - Running post-action listener: _resource_record_post_action 04:11:59 INFO - Running post-action listener: _start_resource_monitoring 04:11:59 INFO - Starting resource monitoring. 04:11:59 INFO - ##### 04:11:59 INFO - ##### Finished create-virtualenv step (success) 04:11:59 INFO - ##### 04:11:59 INFO - ##### 04:11:59 INFO - ##### Running install step. 04:11:59 INFO - ##### 04:11:59 INFO - Running pre-action listener: _resource_record_pre_action 04:11:59 INFO - Running main action method: install 04:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:59 INFO - Reading from file tmpfile_stdout 04:11:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:59 INFO - Reading from file tmpfile_stdout 04:11:59 INFO - Output received: 04:11:59 INFO - Usage: mozinstall [options] installer 04:11:59 INFO - Options: 04:11:59 INFO - -h, --help show this help message and exit 04:11:59 INFO - -d DEST, --destination=DEST 04:11:59 INFO - Directory to install application into. [default: 04:11:59 INFO - "/builds/slave/test"] 04:11:59 INFO - --app=APP Application being installed. [default: firefox] 04:11:59 INFO - mkdir: /builds/slave/test/build/application 04:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:12:33 INFO - Reading from file tmpfile_stdout 04:12:33 INFO - Output received: 04:12:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:12:33 INFO - Running post-action listener: _resource_record_post_action 04:12:33 INFO - ##### 04:12:33 INFO - ##### Finished install step (success) 04:12:33 INFO - ##### 04:12:33 INFO - ##### 04:12:33 INFO - ##### Running run-tests step. 04:12:33 INFO - ##### 04:12:33 INFO - Running pre-action listener: _resource_record_pre_action 04:12:33 INFO - Running main action method: run_tests 04:12:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:12:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:12:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:12:34 INFO - 2016-07-06 04:12:34.012 screenresolution[1933:11015] starting screenresolution argv=screenresolution get 04:12:34 INFO - 2016-07-06 04:12:34.015 screenresolution[1933:11015] Display 0: 1600x1200x32@60 04:12:34 INFO - 2016-07-06 04:12:34.020 screenresolution[1934:11017] starting screenresolution argv=screenresolution list 04:12:34 INFO - Available Modes on Display 0 04:12:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:12:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:12:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:12:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:12:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:12:34 INFO - Intel Iris: 04:12:34 INFO - Chipset Model: Intel Iris 04:12:34 INFO - Type: GPU 04:12:34 INFO - Bus: Built-In 04:12:34 INFO - VRAM (Dynamic, Max): 1536 MB 04:12:34 INFO - Vendor: Intel (0x8086) 04:12:34 INFO - Device ID: 0x0a2e 04:12:34 INFO - Revision ID: 0x0009 04:12:34 INFO - Displays: 04:12:34 INFO - Display: 04:12:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:12:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:12:34 INFO - Display Serial Number: 1600x1200 60 04:12:34 INFO - Main Display: Yes 04:12:34 INFO - Mirror: Off 04:12:34 INFO - Online: Yes 04:12:34 INFO - Rotation: Supported 04:12:34 INFO - Return code: 0 04:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:34 INFO - Python 2.7.3 04:12:34 INFO - Return code: 0 04:12:34 INFO - grabbing minidump binary from tooltool 04:12: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')]} 04:12:34 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10617ed30>, '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 0x105ee3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106176b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:34 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 04:12:34 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 04:12:34 INFO - Calling ['/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'] with output_timeout 600 04:12:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:34 INFO - Return code: 0 04:12:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:12:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:12:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0271 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37SZsg3Uzt/Render', 04:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:34 INFO - 'HOME': '/Users/cltbld', 04:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:34 INFO - 'LOGNAME': 'cltbld', 04:12:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:34 INFO - 'MOZ_NO_REMOTE': '1', 04:12:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:34 INFO - 'NO_EM_RESTART': '1', 04:12:34 INFO - 'PAGER': '/bin/cat', 04:12:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:34 INFO - 'PWD': '/builds/slave/test', 04:12:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:34 INFO - 'SHELL': '/bin/bash', 04:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bjHFdTE8hZ/Listeners', 04:12:34 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 04:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:34 INFO - 'USER': 'cltbld', 04:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:34 INFO - 'XPC_FLAGS': '0x0', 04:12:34 INFO - 'XPC_SERVICE_NAME': '0', 04:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:12:34 INFO - mozversion application_buildid: 20160706024124 04:12:34 INFO - mozversion application_changeset: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 04:12:34 INFO - mozversion application_display_name: Nightly 04:12:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:34 INFO - mozversion application_name: Firefox 04:12:34 INFO - mozversion application_remotingname: firefox 04:12:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:12:34 INFO - mozversion application_vendor: Mozilla 04:12:34 INFO - mozversion application_version: 50.0a1 04:12:34 INFO - mozversion platform_buildid: 20160706024124 04:12:34 INFO - mozversion platform_changeset: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 04:12:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:12:34 INFO - mozversion platform_version: 50.0a1 04:12:34 INFO - using testdate: 1467803554 04:12:34 INFO - actual date: 1467803554 04:12:34 INFO - starting webserver on 'localhost:50334' 04:12:34 INFO - SUITE-START | Running 2 tests 04:12:34 INFO - TEST-START | dromaeo_css 04:12:34 INFO - operating with platform_type : mac_ 04:12:34 INFO - Initialising browser for dromaeo_css test... 04:12:34 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpKjN5lb/profile http://localhost:50334/getInfo.html) 04:12:37 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 04:12:37 INFO - PROCESS | 1944 | colorDepth:24 04:12:37 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 04:12:37 INFO - PROCESS | 1944 | __metrics 04:12:37 ERROR - PROCESS | 1944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 04:12:38 INFO - TEST-INFO | 1944: exit 0 04:12:38 INFO - Browser initialized. 04:12:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:38 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpKjN5lb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:50 INFO - PROCESS | 1947 | RSS: Main: 255746048 04:12:50 INFO - PROCESS | 1947 | 04:13:39 INFO - PROCESS | 1947 | 1467803619929 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] 04:15:51 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50334/tests/dromaeo/cssquery-ext.html) 04:15:53 INFO - PROCESS | 1947 | RSS: Main: 268316672 04:15:53 INFO - PROCESS | 1947 | 04:18:55 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-ext.html (next: http://localhost:50334/tests/dromaeo/cssquery-jquery.html) 04:18:56 INFO - PROCESS | 1947 | RSS: Main: 276901888 04:18:56 INFO - PROCESS | 1947 | 04:21:58 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50334/tests/dromaeo/cssquery-mootools.html) 04:21:58 INFO - PROCESS | 1947 | RSS: Main: 281509888 04:21:58 INFO - PROCESS | 1947 | 04:25:00 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50334/tests/dromaeo/cssquery-prototype.html) 04:25:01 INFO - PROCESS | 1947 | RSS: Main: 280883200 04:25:01 INFO - PROCESS | 1947 | 04:28:03 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50334/tests/dromaeo/cssquery-yui.html) 04:28:04 INFO - PROCESS | 1947 | RSS: Main: 284057600 04:28:04 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-yui.html (next: http://localhost:50334/tests/dromaeo/cssquery-dojo.html) 04:31:07 INFO - PROCESS | 1947 | RSS: Main: 284205056 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | __start_tp_report 04:31:07 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 04:31:07 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 04:31:07 INFO - PROCESS | 1947 | |i|pagename|runs| 04:31:07 INFO - PROCESS | 1947 | |0;dojo.html;3407.6421975692565;3422.229998250394;3454.533637958875;3456;3461.13471632092;4700.341952126705;5864.706764661772;5998.340182579918;6028.186194863692;6072.271327440708;4960.578350840183;5832.650040997543;5941.554383421239;5977.88044239115;6059.545534084939;4233.8094785734565;5245.10833158364;5258.0272649559765;5267.446918073604;5371.462853714636;4633.513481084488;5329.440408757083;5445.074337362658;5471.671699698011;5487.314085739283;4958.181899986498;5227.764750586232;5295.629305948585;5322.547583455373;5330.653507521999;5324.254604355393;5329.440408757102;5331.44019877915;5332.840014799563;5363.436839131874;4573.977130114328;5273.551748101416;5289.841304760864;5299.311089558371;5313.362396512443;5609.046462101453;5885.646861188299;5941.346451890288;5955.493783028404;5992.34084250732;6180.969095154495;6215.061977014666;6225.346338634468;6249.750009999594;6269.028300613412;6188.84527886802;6303.936960630381;6309.747610095636;6320.71556779946;6333.493320534346;5961.7317220724735;5970.701464926779;6014.729337179838;6053;6064.241969753781;6187.84530386735;6411.871762564722;6478.449331806755;6488.188976377953;6583.341665833378;6125.662799505688;6160.907586386208;6257.7184026718905;6267.9373206268265;6269.811905642747;6210.968945155336;6244.937550624527;6293.842653933688;6295.874082518324;6318.557700960889;6103.701349646901;6120.843333897677;6199.845003874939;6204.751809927642;6209.813705588839;5351.973240133774;6102.095423428478;6201.193844800147;6237.220347456568;6260.718267677966;5029.723365214948;5047.949520504748;5069.31564238823;5069.315642388304;5120.948790512121;4492.854322147831;4534.591886730144;4560.475545312332;4588.472325682523;4610.74640894754;5980.820575382745;6020.036794112921;6065.786842631492;6066.998945174085;6132.08018797184;6283.622982621057;6322.36776322364;6346.809595712136;6352.872942541123;6388.488920886318;6111.694415279218;6136.417040381157;6148.44663980244;6154.169187159766;6180.752769889244;5474.945250547523;5541.224228607998;5560.749766260447;5590.552755779528;5615.0454422748235;6500.154979852683;6562.114114594564;6569.310222426768;6581.243157037002;6594.241662208908;6292.182016337847;6292.276388215414;6301.905471418024;6314.021326694186;6329.367063293818;6199.690015499297;6379.553431259767;6401.679916004088;6442.387973142544;6526.379993900572;6191.380861913773;6210.844728881633;6229.1590635265475;6247.344028877084;6254.906176407449;6101.145839582373;6292.653904035139;6296.212973378328;6300.653464059521;6308.84227894288;6122.520135281246;6129.756146212394;6139.645466941873;6153.538484613761;6188.907166392418;6194.132821405097;6239.688015599293;6247.187865577446;6254.061890716429;6264.404881536247;6011.789587364421;6120.510359171167;6174;6221.875562488815;6252.874942501034;5967.8209653710455;6144.446999770043;6144.910730351702;6171.691415429301;6244.0321750128805;5765.019946609171;6190.473809726043;6194.38056194377;6211;6234.251889773256 04:31:07 INFO - PROCESS | 1947 | |1;ext.html;456.83782257298657;476.6306112762609;485.65275827783125;498.97505124743753;526.8419474157753;34379.65620343796;38797.22405551887;40868;41020.38469422961;41205.969850753674;41648.58351416485;42111.78944105275;42183;42198.15603687932;42275.94310142248;9492.905070949288;9638.807223855518;9649.131578157965;9682.70951871445;9691.370060946052;9634.132928036475;9707.029297070307;9733.853992190123;9738.977407372231;9740.75648108796;8813.603387847563;9452.149306562407;9694.709158725249;9703.660371886985;9789.510524473748;8857.557122143899;9654.179394751489;9690.515474226295;9732.41605503672;9766.023397660249;9644;9644.75888102803;9724.076212759777;9750.804983900352;9767.413955162712;32900.67099329;40078.79960600178;40400.1919961602;40473.59526404757;40673.38989915154;3278.7540934429776;3619.6561326673923;3687.2994131115;3966.980165099185;4113.136241389282;31808.840955795073;32473.837630811693;32503.34993300121;32681.69273229068;32724.6727532724;3237.6924192201704;3291.4569096099117;3409.07954852191;3418.418868792311;3446.3107378524396;509500;516193;517907;518013;522298;52128;58868.4113158863;59682.40317596855;60157;60504.39495604987;60554;61486.38513614806;62167.689161553906;62239.06641400383;62548.687256563426;14518;15578.221088945507;16471.91764041172;16556;16668.33326666944;11246.66260012201;12922.41849116792;12942.935285323701;12993.285369304778;13120.475180992653;15630.35881232477;15698.607534811721;15757.921210393875;15777.29002194904;15798.842011579967;5937.851553711105;5968.22413086296;6720.764773232913;6734.619766094117;6812.523123381316;907.7458311672742;1025.3335332034237;1035.53918506264;1057.4924036462387;1155.049729923663;28106.437871242462;29916.850415748217;30247.243818904702;30340.940884927615;30399.240018999702;1092.3937214845837;1111.488715191005;1113.1651261553834;1155.2952698853692;1160.8490896183441;15699.136547489768;15836.366545338287;15886.52340429789;16204.918975405048;16421.261043253082;652762;657664;660163;661351.6932415403;665735;58465.70767146137;58524;58593;58603.12095318574;58631.120533192036;1374.3265799758046;1417.248858105206;1422.665673566711;1434.325866842603;1440.1862947434665;29995;30010.54984175283;30210.54684179783;30238.395232095674;30247.546286805275;49337.75331123322;49626.50373496363;49653.75865603389;50073.49926500688;50082.2487662678;598372;606096;606742;607981;610242;40505.79747101363;40664.186716264914;40976.79511602423;41591.752247432625;41844.58155418407;48170.759146204044;48486.75756621194;48803.511964879894;49513.75243123761;49745.75127124341;34947.825260873535;40051.79974100227;40130.59869401269;40493.797531012155;40919;39635;39938.400923986745;40379;40789.96050197537;41308.967275817144;38877.6112238874;39166;39945;40054.998625034605;41363.586364135976;33012.834935825165;35115.64884351226;35863;35900;35992.64007359893;25954.015288242095;25994.35014124662;26114.477710445306;26116.477670446104;26231.950721971672 04:31:07 INFO - PROCESS | 1947 | |2;jquery.html;368.15141099765043;381.9751716138449;393.7420989252039;401.752921952999;410.9465769449973;19985.300514481994;20188.394348169542;21664.02511886965;22223.22218722345;22255.888720556395;20344.796552034477;21109.261175858846;21406.357809265748;21595.352139435803;21879.015444305005;5382.757775900094;5459.454054594548;5613.933352662981;5621.943780562183;5625.859353516174;3962.5046869141356;5274.314339135926;5505.311836020497;5873.2952045754355;6173.660448675343;6212.658303793312;6238.095476155955;6242.500599951993;6248.593841400295;6251.531135164858;5308.761105750251;5642.57680673949;5919.023361145406;6011.969940150293;6047.0627052806885;4566.771661416916;5373.247745315659;5440.537554307889;5469.808556700496;5897.705114744245;13244.602661920158;13477.932610336886;13684.315784210849;16526.256318465697;26143.869280653664;2117.947051323714;2239.6528538076623;2424.612062070078;2604.244769016983;2944.764418846487;9959.701208963743;10078.244131690153;10210.744731381701;10257.17942564593;10286;1838.7517685112473;1920.5102698811854;2132.509522809747;2146.967795483069;2347.6713260143592;134046;141016;141673.2916335422;143109.28445357812;145515;21233.68149477759;21250.681239781417;21488.355349339545;21667;21749.891250543962;35387;35921.46117808235;35963.460548091796;35988.460173097425;36120.458193127124;10889.564417423373;11299.49152288149;11346.773064538664;11352;11415.714607134722;9256;9312;9332.346735728433;9394.859077113848;9472.621095156117;8000.4399692021;8328;8567.443116197428;9869.802603947881;9977.80044399108;1478.5047009251805;1505.8042454480847;1600.2558810153334;1701.2854601067581;3783.356829339019;913.488446469979;925.6667599664115;931.3573634192386;940.6736501532943;964.599691128174;19379;21507.247246346302;22288.442788930406;22437.653740775604;23117.190898318477;913.8903331600118;946.0303189231093;993.9850902236473;1009.8131845608586;1047.6909311753052;11315.981561659326;11323;11633.88366116328;11676.47455864488;11757.176997610086;533918.312859048;570898;613824;636234;642778;118896;127100;127528;128417;128768;1007.1238022920106;1013.9543720532446;1021.6934919524113;1032.200044965143;1032.3238278927165;19246.037698115317;19516.60966780685;19685.50786230356;19694.212231511152;19771.308004219783;51140.90872730098;53543.12599059014;53829.46170538245;55254;55532.444675552724;77291;78854.605726971;79121.60439197767;81756.77364839413;83729.74405383802;7070.116235470567;7503.287187717158;7560.243975602396;7631.465797394351;7730.304272615266;12475.563355282522;13393.263370514715;13464.730705386033;13502.189868607915;13533.458661653818;11426.143039272254;11564.479598417924;11672.591459298883;11678.299302041905;11774.352410617155;11157.051650609788;11533.653990380302;11603.825942610698;11653.359065251492;11858.288502689866;11765.705857353634;11803.527858885549;11850;11879.940600296943;12125;8344.457610255315;8378;8431.915680843358;8527.701530446404;8550.802887595617;8416.452930559493;11513.481893314653;11640.767184656428;11705.824412633987;11826.231294965799 04:31:07 INFO - PROCESS | 1947 | |3;mootools.html;1578.2424436270594;1601.9919900400496;1844.9631007379853;1919.1671953284615;1942.7183058456515;8094.91905080949;8672.30621550276;8744;9226.953865230673;9245.260379169667;8757.562121893912;8819.294456443486;8948.73153805387;8950;8957.507337096456;2345.1323010486144;2385.1651921827397;2385.6183010718287;2396.209250947192;2400.411899084727;2358.7523310052457;2368.6683864259016;2378.8334816562847;2391.473875747333;2408.8072954163626;2364.113457453455;2371.134535894395;2375.904963801446;2376.5128148729555;2380.0360853854218;2326.8138548916045;2337.5208082343247;2344.097522453859;2364.3852598324474;2368.3842201027855;2337.801286890616;2355.6937598112136;2358.6108292131776;2359.1860808021206;2363.2673871100014;8779.29765618749;8795.516246606434;8869.600867960893;8972.775680608038;9007.459552426875;5272.051030814452;5330.173823057432;5407.270018547485;5409;5426.186072089218;3592.209713862946;3600.837962291703;3658.1220507078374;3665.2119794244363;3667.688246499051;1060.5523460476472;1076.0799516413433;1078.9082927951133;1092.229977865603;1093.305750848217;11783.234089784137;11823.231489953125;12008.339541325224;12010.69973250667;12023.699407514881;4693.366395536559;4733.763311834395;4775.0615066192895;4836.298736683161;4894.583960363338;10050.346727462691;10077.042680945298;10153.796924061626;10176.694699159038;10183.18534517237;5114.0539000284325;5292.338457692788;5301.257823904656;5308.628396012319;5386.030514507348;4445.666575006822;4809.326694262806;4952.4057113146655;4960.156773348539;4963.8262660806695;3448.517207590939;3944.881653550398;4006.859759908389;4061.837526498966;4120.1553681495225;1303.1855090568395;1308.4569903490135;1312.3503865586595;1313.9408726607326;1319.6766792135795;842.3513894301353;907.8093600344001;945.5414124149781;961.778790878102;966.6713317472094;5461.208124821878;5569.909003000205;5967.791127310524;6140.815775526741;6197.5351848611535;418.35990933871227;425.9701820872509;439.67024731451414;441.119965668487;463.59898687634956;3807.4479200516325;3948.58539853317;3981.7457500887126;4074.9185016299507;4198.412222288882;10455.372677639367;10823.67528974132;10954.178436617285;10977.28647637901;11001.339919604849;10593.311434756715;10596.629117980834;10635.787284254271;10955.561777528968;11168.720781980515;7819.3744500439825;8240.13478584752;8291.129431409736;8317.085120636724;8364.874526882102;6071.939280607137;6088.147659327787;6128.387161283836;6234.064890266496;6254.8123556293385;9964.950175249078;10046.69859904204;10079.899201007896;10208.438535880598;10434.060934515626;10251.436171010666;10287.948560257151;10437;10438.68683939483;10494.475276236006;7074.787756367317;7379.077615298088;7549.0941087069905;7612.162662107053;7777;8308.376871734765;8332.625031873458;8394.622241999246;8394.832103357776;8407.831843363221;7451.5901625411125;7536.0956685198125;7569.810754731176;7654.578998155155;7735.922640773745;7369.078865141857;7422.220666830121;7430.219826918095;7512.849743005218;7579.090509138939;6963.40811031068;7005.789826305219;7005.859882802213;7010.439164866696;7048.859022819617;4905.9018819624125;5026.421961474477;5048.293238946624;5094.694318340911;5106.872328191825;5056.988602279485;5065.518775716301;5097.1844504879045;5160.793568257228;5244.5279924806955 04:31:07 INFO - PROCESS | 1947 | |4;prototype.html;313.2466418264075;320.53202324606076;320.9630892447368;322.22826330937403;328.36297582689565;4951.727654978975;5213.400458947222;5887.146363777255;5891.322497912742;5905.586608937376;4466.754328511931;4790.904181916359;5484.204790305404;5549.197655184126;5771.662476696944;4170.416141740151;4296.205202037633;4359.2371335016405;4388.210122178023;4420.447444069491;3510.4032314506467;4148.548008197137;4343.261645520253;4380.817179361587;4389.692721509496;4328.718633288842;4354.869353919372;4357.886425083831;4390.253656878338;4390.868273951786;4056.9999999999854;4126.566710495415;4247.0039081631585;4292;4380.97809510952;3117.9220519486967;3630.2557975614936;3666.5416822897137;3677.933399314196;3687.797171155585;5092.0579692756955;5627.971860140714;5643.435656434365;5661.60368774186;5683.54531637468;4054.6350828425584;4627.676062675614;4786.856394308176;4977.825776097856;5014.623903207237;5407.3781515125875;5424.403315635277;6070.6661133637635;6085.300190478108;6085.3914608539235;4091.529474110486;4107.67138628909;4114.506259248879;4120.402541631447;4121.8969525761795;5075.213341932006;5542.196381524656;6446.580972236837;6454.096426500294;6477.870442591122;3540.4866294387684;4115.403266526337;4127.133302006552;4134.689898257643;4160.708750387444;4184.372344148342;4188.371744238389;4207.915841683149;4211.494620645481;4211.957880421218;4688.343631891538;4970.229614409773;4987.451380348159;4990.900181996412;5010.949890501049;5623.132202576634;5728.427157284238;6127.938720612737;6133.883810085514;6152.8769424611255;1288.9291088990196;1384.8338199415932;1410.9911413339512;1425.6598797130664;1444.6677264229286;792.2117493094293;832.8459235041537;868.188243991857;882.8146089321186;897.1835629577054;5289.735513224324;5613.354464236665;5673.602847800615;5678.914816277759;5741.770329186869;5946.672932988728;6063.9090413643835;6169.01295792671;6241.313455519889;6252.937470625327;4725.527447255316;5497.39528651848;5648.655807839783;5687.260656114679;5690.829275121753;3256.2185075581688;3259.3970115528705;3291.7491353286077;3298.983505082459;3300.6369299377047;5861.677607731531;6466.547341686037;6482.708278127401;6494.590340071501;6501.642409667514;5046.596272298208;5449.746558291615;5539.889202215933;6201.875962480815;6305.896468118061;6002.309734380515;6109.778044391051;6533.464635810581;6540.631574738918;6568.124806364172;5630.73308505583;5838.562107842014;6207.81376558704;6275.874482510416;6295.685215739103;5544.3346798384455;6167.938320616737;6210.72051757681;6224.470919971853;6244.750209991549;6087.721578468571;6169.537284703575;6465.418112369909;6469.223693156851;6501.804945851632;3628.564572251347;4060.878173654795;4096.689059500931;4100.815463304099;4116.547179810159;5169.65588946869;5415.702136382537;6036.645708173728;6224.128621993015;6238.719257633508;5705.971470142788;6084.6349219047;6160.630362178284;6178.598391104564;6181.289151747606;5062.519060689228;6160.476359509313;6162.691865406801;6196.349383314687;6233.1612174407755;5191.922121168261;6050.42520960508;6066.69465603068;6078.939210607838;6092.725827337869;5482.424345443671;6222.315545290105;6230.127782110418;6256.155419018556;6309;5241.659292146151;5370.355557333145;6078.331383547717;6124.326324104256;6193.293097246215 04:31:07 INFO - PROCESS | 1947 | |5;yui.html;755.3088923634874;787.7085478373003;793.1909452358598;843.9451435656678;891.1445012787724;15453.45912893049;15625.21873906303;15775.84224157758;15796.999999999985;15866.920665396672;14163.362648680808;15704.057756534616;16325.83674163258;16326.428574999878;16677.24952377143;719.0508528742063;781.1758594682608;836.8284501677142;917.4724533393326;921.5484412637793;724.7390939261861;909.7225346269386;917.321182325078;924.0343840686498;931.529577563333;927.3601215161517;927.7355953553239;967.3905439573059;968.5012218707371;968.651285537206;815.9592020398957;819.1399031017438;921.3688623293032;924.533110779059;960.3085778239691;706.1490903461316;711.3029231353252;716.9532482575446;719.1980941250521;720.7981765105778;15226.086434813946;15831;15850.841491585052;15947.362105515766;15971.600709982344;14749.926250368786;14761.409543618242;14787.630309242248;14806.111633301929;14883.776743348859;11992.100592455601;12385;12595.24428534291;12616.684582885502;12748.80876786849;3765.3975363941636;3850.0759817643843;4028.4158796974566;4051.7771522566245;4058.370952502367;120017.79982200153;122231;122839;123110.38444807808;127019.3649031749;10362.689119326433;11333.886661133449;11339.829902551468;11496.195266331444;11513.481893314653;19920.800791992184;23478;23489.88255058748;23512.64731029036;23573.29280121599;7812.179721129313;8245.917540824636;8304.70933517324;8346.540940248344;8365.665373385118;4575.450945886449;4638.744869032168;4641.6286697064825;4652.744099074584;4658.650601204923;3648.927021459556;3768.5477742670505;3922.13712983149;4110.835566577363;4113.239050775616;709.5848928376957;710.1123595505618;727.1492353945896;735.1729304532402;736.8268456912622;635.3551145587232;642.5662677692538;663.5156335874839;682.9180498340231;695.8086526205233;9275.840519935007;9343.859842102374;9767;10016.39901605906;10095.293329466867;505.70669011972967;573.3482642777155;578.6325683191204;609.5489337890018;610.4018062298971;4678.134545109097;4687.648426367968;4742.596879265301;4747.905041899143;4755.5719985201495;76301;142794.2860285692;153810.46189538186;169671;169807;139978;142512;142607;144019;144630;105013.94986050042;114440;117025;124145;127514.08728869075;10108;10216;10226.07965283128;10233.641822536176;10346.5344059516;55349.72325138348;61396.38603613907;61557.692211538655;62834.685826570574;63637.36362636314;58162;62202.68898655478;72025.91961120692;93610;94064;13281.734365312834;13675.384607692478;14007.369668364745;14312.354079281016;14350.354234059701;15574.610634734223;15578.509518265715;15649.530514084596;15690.293936773101;15723.685526289182;13691.315434228449;14518.782218266524;14562.490312839;14891.58529939654;14959.626009349418;14345.426182952566;14426.711465770415;14645.340959656627;15035.097894126387;15059.548213553611;10552.314099583502;13032.218066916015;13274.469021239041;13984.091034082752;14640.560783176521;11261.22975147146;11916.285022898654;11949.554276855413;12122.212056216318;12500.31248281317;11927.105467090176;12048.51805927753;12112.636620901387;12155.149139560146;12227.266364018187 04:31:07 INFO - PROCESS | 1947 | __end_tp_report 04:31:07 INFO - PROCESS | 1947 | __start_cc_report 04:31:07 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,441 04:31:07 INFO - PROCESS | 1947 | __end_cc_report 04:31:07 INFO - PROCESS | 1947 | __startTimestamp1467804667517__endTimestamp 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | ------- Summary: start ------- 04:31:07 INFO - PROCESS | 1947 | Number of tests: 6 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5841.70 Median:6132.08 stddev:668.46 (10.9%) stddev-sans-first:642.66 04:31:07 INFO - PROCESS | 1947 | Values: 3407.6 3422.2 3454.5 3456.0 3461.1 4700.3 5864.7 5998.3 6028.2 6072.3 4960.6 5832.7 5941.6 5977.9 6059.5 4233.8 5245.1 5258.0 5267.4 5371.5 4633.5 5329.4 5445.1 5471.7 5487.3 4958.2 5227.8 5295.6 5322.5 5330.7 5324.3 5329.4 5331.4 5332.8 5363.4 4574.0 5273.6 5289.8 5299.3 5313.4 5609.0 5885.6 5941.3 5955.5 5992.3 6181.0 6215.1 6225.3 6249.8 6269.0 6188.8 6303.9 6309.7 6320.7 6333.5 5961.7 5970.7 6014.7 6053.0 6064.2 6187.8 6411.9 6478.4 6488.2 6583.3 6125.7 6160.9 6257.7 6267.9 6269.8 6211.0 6244.9 6293.8 6295.9 6318.6 6103.7 6120.8 6199.8 6204.8 6209.8 5352.0 6102.1 6201.2 6237.2 6260.7 5029.7 5047.9 5069.3 5069.3 5120.9 4492.9 4534.6 4560.5 4588.5 4610.7 5980.8 6020.0 6065.8 6067.0 6132.1 6283.6 6322.4 6346.8 6352.9 6388.5 6111.7 6136.4 6148.4 6154.2 6180.8 5474.9 5541.2 5560.7 5590.6 5615.0 6500.2 6562.1 6569.3 6581.2 6594.2 6292.2 6292.3 6301.9 6314.0 6329.4 6199.7 6379.6 6401.7 6442.4 6526.4 6191.4 6210.8 6229.2 6247.3 6254.9 6101.1 6292.7 6296.2 6300.7 6308.8 6122.5 6129.8 6139.6 6153.5 6188.9 6194.1 6239.7 6247.2 6254.1 6264.4 6011.8 6120.5 6174.0 6221.9 6252.9 5967.8 6144.4 6144.9 6171.7 6244.0 5765.0 6190.5 6194.4 6211.0 6234.3 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:72782.13 Median:40947.90 stddev:159569.53 (389.7%) stddev-sans-first:159924.76 04:31:07 INFO - PROCESS | 1947 | Values: 456.8 476.6 485.7 499.0 526.8 34379.7 38797.2 40868.0 41020.4 41206.0 41648.6 42111.8 42183.0 42198.2 42275.9 9492.9 9638.8 9649.1 9682.7 9691.4 9634.1 9707.0 9733.9 9739.0 9740.8 8813.6 9452.1 9694.7 9703.7 9789.5 8857.6 9654.2 9690.5 9732.4 9766.0 9644.0 9644.8 9724.1 9750.8 9767.4 32900.7 40078.8 40400.2 40473.6 40673.4 3278.8 3619.7 3687.3 3967.0 4113.1 31808.8 32473.8 32503.3 32681.7 32724.7 3237.7 3291.5 3409.1 3418.4 3446.3 509500.0 516193.0 517907.0 518013.0 522298.0 52128.0 58868.4 59682.4 60157.0 60504.4 60554.0 61486.4 62167.7 62239.1 62548.7 14518.0 15578.2 16471.9 16556.0 16668.3 11246.7 12922.4 12942.9 12993.3 13120.5 15630.4 15698.6 15757.9 15777.3 15798.8 5937.9 5968.2 6720.8 6734.6 6812.5 907.7 1025.3 1035.5 1057.5 1155.0 28106.4 29916.9 30247.2 30340.9 30399.2 1092.4 1111.5 1113.2 1155.3 1160.8 15699.1 15836.4 15886.5 16204.9 16421.3 652762.0 657664.0 660163.0 661351.7 665735.0 58465.7 58524.0 58593.0 58603.1 58631.1 1374.3 1417.2 1422.7 1434.3 1440.2 29995.0 30010.5 30210.5 30238.4 30247.5 49337.8 49626.5 49653.8 50073.5 50082.2 598372.0 606096.0 606742.0 607981.0 610242.0 40505.8 40664.2 40976.8 41591.8 41844.6 48170.8 48486.8 48803.5 49513.8 49745.8 34947.8 40051.8 40130.6 40493.8 40919.0 39635.0 39938.4 40379.0 40790.0 41309.0 38877.6 39166.0 39945.0 40055.0 41363.6 33012.8 35115.6 35863.0 35900.0 35992.6 25954.0 25994.4 26114.5 26116.5 26232.0 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:36758.77 Median:12264.05 stddev:100701.10 (821.1%) stddev-sans-first:100946.53 04:31:07 INFO - PROCESS | 1947 | Values: 368.2 382.0 393.7 401.8 410.9 19985.3 20188.4 21664.0 22223.2 22255.9 20344.8 21109.3 21406.4 21595.4 21879.0 5382.8 5459.5 5613.9 5621.9 5625.9 3962.5 5274.3 5505.3 5873.3 6173.7 6212.7 6238.1 6242.5 6248.6 6251.5 5308.8 5642.6 5919.0 6012.0 6047.1 4566.8 5373.2 5440.5 5469.8 5897.7 13244.6 13477.9 13684.3 16526.3 26143.9 2117.9 2239.7 2424.6 2604.2 2944.8 9959.7 10078.2 10210.7 10257.2 10286.0 1838.8 1920.5 2132.5 2147.0 2347.7 134046.0 141016.0 141673.3 143109.3 145515.0 21233.7 21250.7 21488.4 21667.0 21749.9 35387.0 35921.5 35963.5 35988.5 36120.5 10889.6 11299.5 11346.8 11352.0 11415.7 9256.0 9312.0 9332.3 9394.9 9472.6 8000.4 8328.0 8567.4 9869.8 9977.8 1478.5 1505.8 1600.3 1701.3 3783.4 913.5 925.7 931.4 940.7 964.6 19379.0 21507.2 22288.4 22437.7 23117.2 913.9 946.0 994.0 1009.8 1047.7 11316.0 11323.0 11633.9 11676.5 11757.2 533918.3 570898.0 613824.0 636234.0 642778.0 118896.0 127100.0 127528.0 128417.0 128768.0 1007.1 1014.0 1021.7 1032.2 1032.3 19246.0 19516.6 19685.5 19694.2 19771.3 51140.9 53543.1 53829.5 55254.0 55532.4 77291.0 78854.6 79121.6 81756.8 83729.7 7070.1 7503.3 7560.2 7631.5 7730.3 12475.6 13393.3 13464.7 13502.2 13533.5 11426.1 11564.5 11672.6 11678.3 11774.4 11157.1 11533.7 11603.8 11653.4 11858.3 11765.7 11803.5 11850.0 11879.9 12125.0 8344.5 8378.0 8431.9 8527.7 8550.8 8416.5 11513.5 11640.8 11705.8 11826.2 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5785.38 Median:4713.56 stddev:3270.65 (69.4%) stddev-sans-first:3264.55 04:31:07 INFO - PROCESS | 1947 | Values: 1578.2 1602.0 1845.0 1919.2 1942.7 8094.9 8672.3 8744.0 9227.0 9245.3 8757.6 8819.3 8948.7 8950.0 8957.5 2345.1 2385.2 2385.6 2396.2 2400.4 2358.8 2368.7 2378.8 2391.5 2408.8 2364.1 2371.1 2375.9 2376.5 2380.0 2326.8 2337.5 2344.1 2364.4 2368.4 2337.8 2355.7 2358.6 2359.2 2363.3 8779.3 8795.5 8869.6 8972.8 9007.5 5272.1 5330.2 5407.3 5409.0 5426.2 3592.2 3600.8 3658.1 3665.2 3667.7 1060.6 1076.1 1078.9 1092.2 1093.3 11783.2 11823.2 12008.3 12010.7 12023.7 4693.4 4733.8 4775.1 4836.3 4894.6 10050.3 10077.0 10153.8 10176.7 10183.2 5114.1 5292.3 5301.3 5308.6 5386.0 4445.7 4809.3 4952.4 4960.2 4963.8 3448.5 3944.9 4006.9 4061.8 4120.2 1303.2 1308.5 1312.4 1313.9 1319.7 842.4 907.8 945.5 961.8 966.7 5461.2 5569.9 5967.8 6140.8 6197.5 418.4 426.0 439.7 441.1 463.6 3807.4 3948.6 3981.7 4074.9 4198.4 10455.4 10823.7 10954.2 10977.3 11001.3 10593.3 10596.6 10635.8 10955.6 11168.7 7819.4 8240.1 8291.1 8317.1 8364.9 6071.9 6088.1 6128.4 6234.1 6254.8 9965.0 10046.7 10079.9 10208.4 10434.1 10251.4 10287.9 10437.0 10438.7 10494.5 7074.8 7379.1 7549.1 7612.2 7777.0 8308.4 8332.6 8394.6 8394.8 8407.8 7451.6 7536.1 7569.8 7654.6 7735.9 7369.1 7422.2 7430.2 7512.8 7579.1 6963.4 7005.8 7005.9 7010.4 7048.9 4905.9 5026.4 5048.3 5094.7 5106.9 5057.0 5065.5 5097.2 5160.8 5244.5 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4895.13 Median:5518.64 stddev:1531.87 (27.8%) stddev-sans-first:1497.07 04:31:07 INFO - PROCESS | 1947 | Values: 313.2 320.5 321.0 322.2 328.4 4951.7 5213.4 5887.1 5891.3 5905.6 4466.8 4790.9 5484.2 5549.2 5771.7 4170.4 4296.2 4359.2 4388.2 4420.4 3510.4 4148.5 4343.3 4380.8 4389.7 4328.7 4354.9 4357.9 4390.3 4390.9 4057.0 4126.6 4247.0 4292.0 4381.0 3117.9 3630.3 3666.5 3677.9 3687.8 5092.1 5628.0 5643.4 5661.6 5683.5 4054.6 4627.7 4786.9 4977.8 5014.6 5407.4 5424.4 6070.7 6085.3 6085.4 4091.5 4107.7 4114.5 4120.4 4121.9 5075.2 5542.2 6446.6 6454.1 6477.9 3540.5 4115.4 4127.1 4134.7 4160.7 4184.4 4188.4 4207.9 4211.5 4212.0 4688.3 4970.2 4987.5 4990.9 5010.9 5623.1 5728.4 6127.9 6133.9 6152.9 1288.9 1384.8 1411.0 1425.7 1444.7 792.2 832.8 868.2 882.8 897.2 5289.7 5613.4 5673.6 5678.9 5741.8 5946.7 6063.9 6169.0 6241.3 6252.9 4725.5 5497.4 5648.7 5687.3 5690.8 3256.2 3259.4 3291.7 3299.0 3300.6 5861.7 6466.5 6482.7 6494.6 6501.6 5046.6 5449.7 5539.9 6201.9 6305.9 6002.3 6109.8 6533.5 6540.6 6568.1 5630.7 5838.6 6207.8 6275.9 6295.7 5544.3 6167.9 6210.7 6224.5 6244.8 6087.7 6169.5 6465.4 6469.2 6501.8 3628.6 4060.9 4096.7 4100.8 4116.5 5169.7 5415.7 6036.6 6224.1 6238.7 5706.0 6084.6 6160.6 6178.6 6181.3 5062.5 6160.5 6162.7 6196.3 6233.2 5191.9 6050.4 6066.7 6078.9 6092.7 5482.4 6222.3 6230.1 6256.2 6309.0 5241.7 5370.4 6078.3 6124.3 6193.3 04:31:07 INFO - PROCESS | 1947 | 04:31:07 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:25549.70 Median:94863.90 stddev:41142.84 (43.4%) stddev-sans-first:41216.14 04:31:07 INFO - PROCESS | 1947 | Values: 755.3 787.7 793.2 843.9 891.1 15453.5 15625.2 15775.8 15797.0 15866.9 14163.4 15704.1 16325.8 16326.4 16677.2 719.1 781.2 836.8 917.5 921.5 724.7 909.7 917.3 924.0 931.5 927.4 927.7 967.4 968.5 968.7 816.0 819.1 921.4 924.5 960.3 706.1 711.3 717.0 719.2 720.8 15226.1 15831.0 15850.8 15947.4 15971.6 14749.9 14761.4 14787.6 14806.1 14883.8 11992.1 12385.0 12595.2 12616.7 12748.8 3765.4 3850.1 4028.4 4051.8 4058.4 120017.8 122231.0 122839.0 123110.4 127019.4 10362.7 11333.9 11339.8 11496.2 11513.5 19920.8 23478.0 23489.9 23512.6 23573.3 7812.2 8245.9 8304.7 8346.5 8365.7 4575.5 4638.7 4641.6 4652.7 4658.7 3648.9 3768.5 3922.1 4110.8 4113.2 709.6 710.1 727.1 735.2 736.8 635.4 642.6 663.5 682.9 695.8 9275.8 9343.9 9767.0 10016.4 10095.3 505.7 573.3 578.6 609.5 610.4 4678.1 4687.6 4742.6 4747.9 4755.6 76301.0 142794.3 153810.5 169671.0 169807.0 139978.0 142512.0 142607.0 144019.0 144630.0 105013.9 114440.0 117025.0 124145.0 127514.1 10108.0 10216.0 10226.1 10233.6 10346.5 55349.7 61396.4 61557.7 62834.7 63637.4 58162.0 62202.7 72025.9 93610.0 94064.0 13281.7 13675.4 14007.4 14312.4 14350.4 15574.6 15578.5 15649.5 15690.3 15723.7 13691.3 14518.8 14562.5 14891.6 14959.6 14345.4 14426.7 14645.3 15035.1 15059.5 10552.3 13032.2 13274.5 13984.1 14640.6 11261.2 11916.3 11949.6 12122.2 12500.3 11927.1 12048.5 12112.6 12155.1 12227.3 04:31:07 INFO - PROCESS | 1947 | -------- Summary: end -------- 04:31:07 INFO - PROCESS | 1947 | 04:31:08 INFO - TEST-INFO | 1947: exit 0 04:31:08 INFO - TEST-OK | dromaeo_css | took 1113638ms 04:31:08 INFO - TEST-START | kraken 04:31:08 INFO - operating with platform_type : mac_ 04:31:08 INFO - Initialising browser for kraken test... 04:31:08 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpA7hqcl/profile http://localhost:50334/getInfo.html) 04:31:11 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 04:31:11 INFO - PROCESS | 1954 | colorDepth:24 04:31:11 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 04:31:11 INFO - PROCESS | 1954 | __metrics 04:31:11 ERROR - PROCESS | 1954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 04:31:11 INFO - TEST-INFO | 1954: exit 0 04:31:11 INFO - Browser initialized. 04:31:11 INFO - Running cycle 1/1 for kraken test... 04:31:11 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpA7hqcl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:24 INFO - PROCESS | 1956 | RSS: Main: 255918080 04:31:24 INFO - PROCESS | 1956 | 04:31:27 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:27 INFO - PROCESS | 1956 | RSS: Main: 268873728 04:31:27 INFO - PROCESS | 1956 | 04:31:30 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-dft) 04:31:31 INFO - PROCESS | 1956 | RSS: Main: 272912384 04:31:31 INFO - PROCESS | 1956 | 04:31:34 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-fft) 04:31:35 INFO - PROCESS | 1956 | RSS: Main: 273412096 04:31:35 INFO - PROCESS | 1956 | 04:31:37 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-oscillator) 04:31:37 INFO - PROCESS | 1956 | RSS: Main: 274325504 04:31:37 INFO - PROCESS | 1956 | 04:31:39 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:40 INFO - PROCESS | 1956 | RSS: Main: 274890752 04:31:40 INFO - PROCESS | 1956 | 04:31:43 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:44 INFO - PROCESS | 1956 | RSS: Main: 275935232 04:31:44 INFO - PROCESS | 1956 | 04:31:46 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:47 INFO - PROCESS | 1956 | RSS: Main: 275664896 04:31:47 INFO - PROCESS | 1956 | 04:31:50 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50334/tests/kraken/driver.html?testName=json-parse-financial) 04:31:51 INFO - PROCESS | 1956 | RSS: Main: 275935232 04:31:51 INFO - PROCESS | 1956 | 04:31:52 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:53 INFO - PROCESS | 1956 | RSS: Main: 275963904 04:31:53 INFO - PROCESS | 1956 | 04:31:55 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:55 INFO - PROCESS | 1956 | RSS: Main: 275689472 04:31:55 INFO - PROCESS | 1956 | 04:31:58 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:58 INFO - PROCESS | 1956 | RSS: Main: 275771392 04:31:58 INFO - PROCESS | 1956 | 04:32:01 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:02 INFO - PROCESS | 1956 | RSS: Main: 275632128 04:32:02 INFO - PROCESS | 1956 | 04:32:05 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:05 INFO - PROCESS | 1956 | RSS: Main: 275582976 04:32:05 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50334/tests/kraken/driver.html?testName=ai-astar) 04:32:07 INFO - PROCESS | 1956 | RSS: Main: 276738048 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | __start_tp_report 04:32:07 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 04:32:07 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 04:32:07 INFO - PROCESS | 1956 | |i|pagename|runs| 04:32:07 INFO - PROCESS | 1956 | |0;ai-astar;101;93;143;161;163;119;115;162;115;115 04:32:07 INFO - PROCESS | 1956 | |1;audio-beat-detection;170;128;158;151;106;128;127;109;158;107 04:32:07 INFO - PROCESS | 1956 | |2;audio-dft;214;194;210;214;277;265;190;264;249;202 04:32:07 INFO - PROCESS | 1956 | |3;audio-fft;68;84;75;143;58;58;60;63;135;57 04:32:07 INFO - PROCESS | 1956 | |4;audio-oscillator;69;70;118;58;70;60;129;89;65;142 04:32:07 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;88;85;87;86;89;85;87;85;88;85 04:32:07 INFO - PROCESS | 1956 | |6;imaging-darkroom;114;115;93;98;95;94;95;97;136;96 04:32:07 INFO - PROCESS | 1956 | |7;imaging-desaturate;90;94;98;92;92;93;125;146;137;93 04:32:07 INFO - PROCESS | 1956 | |8;json-parse-financial;55;58;57;56;54;57;58;56;57;56 04:32:07 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;67;70;75;70;86;77;74;70;70;70 04:32:07 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;84;89;86;83;83;82;80;86;87;89 04:32:07 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;132;141;138;135;149;160;128;150;233;148 04:32:07 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;161;205;189;163;161;155;165;166;163;162 04:32:07 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;66;68;67;64;70;65;66;66;68;63 04:32:07 INFO - PROCESS | 1956 | __end_tp_report 04:32:07 INFO - PROCESS | 1956 | __start_cc_report 04:32:07 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1116 04:32:07 INFO - PROCESS | 1956 | __end_cc_report 04:32:07 INFO - PROCESS | 1956 | __startTimestamp1467804727703__endTimestamp 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | ------- Summary: start ------- 04:32:07 INFO - PROCESS | 1956 | Number of tests: 14 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:128.70 Median:152.00 stddev:26.31 (17.3%) stddev-sans-first:25.93 04:32:07 INFO - PROCESS | 1956 | Values: 101.0 93.0 143.0 161.0 163.0 119.0 115.0 162.0 115.0 115.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:139.50 stddev:23.56 (16.9%) stddev-sans-first:21.13 04:32:07 INFO - PROCESS | 1956 | Values: 170.0 128.0 158.0 151.0 106.0 128.0 127.0 109.0 158.0 107.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:227.90 Median:231.50 stddev:32.49 (14.0%) stddev-sans-first:34.07 04:32:07 INFO - PROCESS | 1956 | Values: 214.0 194.0 210.0 214.0 277.0 265.0 190.0 264.0 249.0 202.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:80.10 Median:61.50 stddev:32.26 (52.5%) stddev-sans-first:33.92 04:32:07 INFO - PROCESS | 1956 | Values: 68.0 84.0 75.0 143.0 58.0 58.0 60.0 63.0 135.0 57.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:67.00 stddev:31.11 (46.4%) stddev-sans-first:32.31 04:32:07 INFO - PROCESS | 1956 | Values: 69.0 70.0 118.0 58.0 70.0 60.0 129.0 89.0 65.0 142.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:1.51 (1.7%) stddev-sans-first:1.50 04:32:07 INFO - PROCESS | 1956 | Values: 88.0 85.0 87.0 86.0 89.0 85.0 87.0 85.0 88.0 85.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:95.00 stddev:14.03 (14.8%) stddev-sans-first:14.34 04:32:07 INFO - PROCESS | 1956 | Values: 114.0 115.0 93.0 98.0 95.0 94.0 95.0 97.0 136.0 96.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:92.50 stddev:21.39 (23.1%) stddev-sans-first:21.88 04:32:07 INFO - PROCESS | 1956 | Values: 90.0 94.0 98.0 92.0 92.0 93.0 125.0 146.0 137.0 93.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.24 04:32:07 INFO - PROCESS | 1956 | Values: 55.0 58.0 57.0 56.0 54.0 57.0 58.0 56.0 57.0 56.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:72.00 stddev:5.49 (7.6%) stddev-sans-first:5.39 04:32:07 INFO - PROCESS | 1956 | Values: 67.0 70.0 75.0 70.0 86.0 77.0 74.0 70.0 70.0 70.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:86.00 stddev:3.00 (3.5%) stddev-sans-first:3.16 04:32:07 INFO - PROCESS | 1956 | Values: 84.0 89.0 86.0 83.0 83.0 82.0 80.0 86.0 87.0 89.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:148.50 stddev:30.24 (20.4%) stddev-sans-first:31.25 04:32:07 INFO - PROCESS | 1956 | Values: 132.0 141.0 138.0 135.0 149.0 160.0 128.0 150.0 233.0 148.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:164.00 stddev:15.51 (9.5%) stddev-sans-first:16.18 04:32:07 INFO - PROCESS | 1956 | Values: 161.0 205.0 189.0 163.0 161.0 155.0 165.0 166.0 163.0 162.0 04:32:07 INFO - PROCESS | 1956 | 04:32:07 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:2.06 (3.1%) stddev-sans-first:2.18 04:32:07 INFO - PROCESS | 1956 | Values: 66.0 68.0 67.0 64.0 70.0 65.0 66.0 66.0 68.0 63.0 04:32:07 INFO - PROCESS | 1956 | -------- Summary: end -------- 04:32:07 INFO - PROCESS | 1956 | 04:32:08 INFO - TEST-INFO | 1956: exit 0 04:32:08 INFO - TEST-OK | kraken | took 60446ms 04:32:08 INFO - SUITE-END | took 1174s 04:32:08 INFO - Completed test suite (00:19:34) 04:32:08 INFO - javascript benchmark 04:32:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7651.787675725266, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3407.6421975692565, 3422.229998250394, 3454.533637958875, 3456.0, 3461.13471632092, 4700.341952126705, 5864.706764661772, 5998.340182579918, 6028.186194863692, 6072.271327440708, 4960.578350840183, 5832.650040997543, 5941.554383421239, 5977.88044239115, 6059.545534084939, 4233.8094785734565, 5245.10833158364, 5258.0272649559765, 5267.446918073604, 5371.462853714636, 4633.513481084488, 5329.440408757083, 5445.074337362658, 5471.671699698011, 5487.314085739283, 4958.181899986498, 5227.764750586232, 5295.629305948585, 5322.547583455373, 5330.653507521999, 5324.254604355393, 5329.440408757102, 5331.44019877915, 5332.840014799563, 5363.436839131874, 4573.977130114328, 5273.551748101416, 5289.841304760864, 5299.311089558371, 5313.362396512443, 5609.046462101453, 5885.646861188299, 5941.346451890288, 5955.493783028404, 5992.34084250732, 6180.969095154495, 6215.061977014666, 6225.346338634468, 6249.750009999594, 6269.028300613412, 6188.84527886802, 6303.936960630381, 6309.747610095636, 6320.71556779946, 6333.493320534346, 5961.7317220724735, 5970.701464926779, 6014.729337179838, 6053.0, 6064.241969753781, 6187.84530386735, 6411.871762564722, 6478.449331806755, 6488.188976377953, 6583.341665833378, 6125.662799505688, 6160.907586386208, 6257.7184026718905, 6267.9373206268265, 6269.811905642747, 6210.968945155336, 6244.937550624527, 6293.842653933688, 6295.874082518324, 6318.557700960889, 6103.701349646901, 6120.843333897677, 6199.845003874939, 6204.751809927642, 6209.813705588839, 5351.973240133774, 6102.095423428478, 6201.193844800147, 6237.220347456568, 6260.718267677966, 5029.723365214948, 5047.949520504748, 5069.31564238823, 5069.315642388304, 5120.948790512121, 4492.854322147831, 4534.591886730144, 4560.475545312332, 4588.472325682523, 4610.74640894754, 5980.820575382745, 6020.036794112921, 6065.786842631492, 6066.998945174085, 6132.08018797184, 6283.622982621057, 6322.36776322364, 6346.809595712136, 6352.872942541123, 6388.488920886318, 6111.694415279218, 6136.417040381157, 6148.44663980244, 6154.169187159766, 6180.752769889244, 5474.945250547523, 5541.224228607998, 5560.749766260447, 5590.552755779528, 5615.0454422748235, 6500.154979852683, 6562.114114594564, 6569.310222426768, 6581.243157037002, 6594.241662208908, 6292.182016337847, 6292.276388215414, 6301.905471418024, 6314.021326694186, 6329.367063293818, 6199.690015499297, 6379.553431259767, 6401.679916004088, 6442.387973142544, 6526.379993900572, 6191.380861913773, 6210.844728881633, 6229.1590635265475, 6247.344028877084, 6254.906176407449, 6101.145839582373, 6292.653904035139, 6296.212973378328, 6300.653464059521, 6308.84227894288, 6122.520135281246, 6129.756146212394, 6139.645466941873, 6153.538484613761, 6188.907166392418, 6194.132821405097, 6239.688015599293, 6247.187865577446, 6254.061890716429, 6264.404881536247, 6011.789587364421, 6120.510359171167, 6174.0, 6221.875562488815, 6252.874942501034, 5967.8209653710455, 6144.446999770043, 6144.910730351702, 6171.691415429301, 6244.0321750128805, 5765.019946609171, 6190.473809726043, 6194.38056194377, 6211.0, 6234.251889773256], "value": 5799.724205711625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.83782257298657, 476.6306112762609, 485.65275827783125, 498.97505124743753, 526.8419474157753, 34379.65620343796, 38797.22405551887, 40868.0, 41020.38469422961, 41205.969850753674, 41648.58351416485, 42111.78944105275, 42183.0, 42198.15603687932, 42275.94310142248, 9492.905070949288, 9638.807223855518, 9649.131578157965, 9682.70951871445, 9691.370060946052, 9634.132928036475, 9707.029297070307, 9733.853992190123, 9738.977407372231, 9740.75648108796, 8813.603387847563, 9452.149306562407, 9694.709158725249, 9703.660371886985, 9789.510524473748, 8857.557122143899, 9654.179394751489, 9690.515474226295, 9732.41605503672, 9766.023397660249, 9644.0, 9644.75888102803, 9724.076212759777, 9750.804983900352, 9767.413955162712, 32900.67099329, 40078.79960600178, 40400.1919961602, 40473.59526404757, 40673.38989915154, 3278.7540934429776, 3619.6561326673923, 3687.2994131115, 3966.980165099185, 4113.136241389282, 31808.840955795073, 32473.837630811693, 32503.34993300121, 32681.69273229068, 32724.6727532724, 3237.6924192201704, 3291.4569096099117, 3409.07954852191, 3418.418868792311, 3446.3107378524396, 509500.0, 516193.0, 517907.0, 518013.0, 522298.0, 52128.0, 58868.4113158863, 59682.40317596855, 60157.0, 60504.39495604987, 60554.0, 61486.38513614806, 62167.689161553906, 62239.06641400383, 62548.687256563426, 14518.0, 15578.221088945507, 16471.91764041172, 16556.0, 16668.33326666944, 11246.66260012201, 12922.41849116792, 12942.935285323701, 12993.285369304778, 13120.475180992653, 15630.35881232477, 15698.607534811721, 15757.921210393875, 15777.29002194904, 15798.842011579967, 5937.851553711105, 5968.22413086296, 6720.764773232913, 6734.619766094117, 6812.523123381316, 907.7458311672742, 1025.3335332034237, 1035.53918506264, 1057.4924036462387, 1155.049729923663, 28106.437871242462, 29916.850415748217, 30247.243818904702, 30340.940884927615, 30399.240018999702, 1092.3937214845837, 1111.488715191005, 1113.1651261553834, 1155.2952698853692, 1160.8490896183441, 15699.136547489768, 15836.366545338287, 15886.52340429789, 16204.918975405048, 16421.261043253082, 652762.0, 657664.0, 660163.0, 661351.6932415403, 665735.0, 58465.70767146137, 58524.0, 58593.0, 58603.12095318574, 58631.120533192036, 1374.3265799758046, 1417.248858105206, 1422.665673566711, 1434.325866842603, 1440.1862947434665, 29995.0, 30010.54984175283, 30210.54684179783, 30238.395232095674, 30247.546286805275, 49337.75331123322, 49626.50373496363, 49653.75865603389, 50073.49926500688, 50082.2487662678, 598372.0, 606096.0, 606742.0, 607981.0, 610242.0, 40505.79747101363, 40664.186716264914, 40976.79511602423, 41591.752247432625, 41844.58155418407, 48170.759146204044, 48486.75756621194, 48803.511964879894, 49513.75243123761, 49745.75127124341, 34947.825260873535, 40051.79974100227, 40130.59869401269, 40493.797531012155, 40919.0, 39635.0, 39938.400923986745, 40379.0, 40789.96050197537, 41308.967275817144, 38877.6112238874, 39166.0, 39945.0, 40054.998625034605, 41363.586364135976, 33012.834935825165, 35115.64884351226, 35863.0, 35900.0, 35992.64007359893, 25954.015288242095, 25994.35014124662, 26114.477710445306, 26116.477670446104, 26231.950721971672], "value": 20358.07353787973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.15141099765043, 381.9751716138449, 393.7420989252039, 401.752921952999, 410.9465769449973, 19985.300514481994, 20188.394348169542, 21664.02511886965, 22223.22218722345, 22255.888720556395, 20344.796552034477, 21109.261175858846, 21406.357809265748, 21595.352139435803, 21879.015444305005, 5382.757775900094, 5459.454054594548, 5613.933352662981, 5621.943780562183, 5625.859353516174, 3962.5046869141356, 5274.314339135926, 5505.311836020497, 5873.2952045754355, 6173.660448675343, 6212.658303793312, 6238.095476155955, 6242.500599951993, 6248.593841400295, 6251.531135164858, 5308.761105750251, 5642.57680673949, 5919.023361145406, 6011.969940150293, 6047.0627052806885, 4566.771661416916, 5373.247745315659, 5440.537554307889, 5469.808556700496, 5897.705114744245, 13244.602661920158, 13477.932610336886, 13684.315784210849, 16526.256318465697, 26143.869280653664, 2117.947051323714, 2239.6528538076623, 2424.612062070078, 2604.244769016983, 2944.764418846487, 9959.701208963743, 10078.244131690153, 10210.744731381701, 10257.17942564593, 10286.0, 1838.7517685112473, 1920.5102698811854, 2132.509522809747, 2146.967795483069, 2347.6713260143592, 134046.0, 141016.0, 141673.2916335422, 143109.28445357812, 145515.0, 21233.68149477759, 21250.681239781417, 21488.355349339545, 21667.0, 21749.891250543962, 35387.0, 35921.46117808235, 35963.460548091796, 35988.460173097425, 36120.458193127124, 10889.564417423373, 11299.49152288149, 11346.773064538664, 11352.0, 11415.714607134722, 9256.0, 9312.0, 9332.346735728433, 9394.859077113848, 9472.621095156117, 8000.4399692021, 8328.0, 8567.443116197428, 9869.802603947881, 9977.80044399108, 1478.5047009251805, 1505.8042454480847, 1600.2558810153334, 1701.2854601067581, 3783.356829339019, 913.488446469979, 925.6667599664115, 931.3573634192386, 940.6736501532943, 964.599691128174, 19379.0, 21507.247246346302, 22288.442788930406, 22437.653740775604, 23117.190898318477, 913.8903331600118, 946.0303189231093, 993.9850902236473, 1009.8131845608586, 1047.6909311753052, 11315.981561659326, 11323.0, 11633.88366116328, 11676.47455864488, 11757.176997610086, 533918.312859048, 570898.0, 613824.0, 636234.0, 642778.0, 118896.0, 127100.0, 127528.0, 128417.0, 128768.0, 1007.1238022920106, 1013.9543720532446, 1021.6934919524113, 1032.200044965143, 1032.3238278927165, 19246.037698115317, 19516.60966780685, 19685.50786230356, 19694.212231511152, 19771.308004219783, 51140.90872730098, 53543.12599059014, 53829.46170538245, 55254.0, 55532.444675552724, 77291.0, 78854.605726971, 79121.60439197767, 81756.77364839413, 83729.74405383802, 7070.116235470567, 7503.287187717158, 7560.243975602396, 7631.465797394351, 7730.304272615266, 12475.563355282522, 13393.263370514715, 13464.730705386033, 13502.189868607915, 13533.458661653818, 11426.143039272254, 11564.479598417924, 11672.591459298883, 11678.299302041905, 11774.352410617155, 11157.051650609788, 11533.653990380302, 11603.825942610698, 11653.359065251492, 11858.288502689866, 11765.705857353634, 11803.527858885549, 11850.0, 11879.940600296943, 12125.0, 8344.457610255315, 8378.0, 8431.915680843358, 8527.701530446404, 8550.802887595617, 8416.452930559493, 11513.481893314653, 11640.767184656428, 11705.824412633987, 11826.231294965799], "value": 10396.629611820817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.2424436270594, 1601.9919900400496, 1844.9631007379853, 1919.1671953284615, 1942.7183058456515, 8094.91905080949, 8672.30621550276, 8744.0, 9226.953865230673, 9245.260379169667, 8757.562121893912, 8819.294456443486, 8948.73153805387, 8950.0, 8957.507337096456, 2345.1323010486144, 2385.1651921827397, 2385.6183010718287, 2396.209250947192, 2400.411899084727, 2358.7523310052457, 2368.6683864259016, 2378.8334816562847, 2391.473875747333, 2408.8072954163626, 2364.113457453455, 2371.134535894395, 2375.904963801446, 2376.5128148729555, 2380.0360853854218, 2326.8138548916045, 2337.5208082343247, 2344.097522453859, 2364.3852598324474, 2368.3842201027855, 2337.801286890616, 2355.6937598112136, 2358.6108292131776, 2359.1860808021206, 2363.2673871100014, 8779.29765618749, 8795.516246606434, 8869.600867960893, 8972.775680608038, 9007.459552426875, 5272.051030814452, 5330.173823057432, 5407.270018547485, 5409.0, 5426.186072089218, 3592.209713862946, 3600.837962291703, 3658.1220507078374, 3665.2119794244363, 3667.688246499051, 1060.5523460476472, 1076.0799516413433, 1078.9082927951133, 1092.229977865603, 1093.305750848217, 11783.234089784137, 11823.231489953125, 12008.339541325224, 12010.69973250667, 12023.699407514881, 4693.366395536559, 4733.763311834395, 4775.0615066192895, 4836.298736683161, 4894.583960363338, 10050.346727462691, 10077.042680945298, 10153.796924061626, 10176.694699159038, 10183.18534517237, 5114.0539000284325, 5292.338457692788, 5301.257823904656, 5308.628396012319, 5386.030514507348, 4445.666575006822, 4809.326694262806, 4952.4057113146655, 4960.156773348539, 4963.8262660806695, 3448.517207590939, 3944.881653550398, 4006.859759908389, 4061.837526498966, 4120.1553681495225, 1303.1855090568395, 1308.4569903490135, 1312.3503865586595, 1313.9408726607326, 1319.6766792135795, 842.3513894301353, 907.8093600344001, 945.5414124149781, 961.778790878102, 966.6713317472094, 5461.208124821878, 5569.909003000205, 5967.791127310524, 6140.815775526741, 6197.5351848611535, 418.35990933871227, 425.9701820872509, 439.67024731451414, 441.119965668487, 463.59898687634956, 3807.4479200516325, 3948.58539853317, 3981.7457500887126, 4074.9185016299507, 4198.412222288882, 10455.372677639367, 10823.67528974132, 10954.178436617285, 10977.28647637901, 11001.339919604849, 10593.311434756715, 10596.629117980834, 10635.787284254271, 10955.561777528968, 11168.720781980515, 7819.3744500439825, 8240.13478584752, 8291.129431409736, 8317.085120636724, 8364.874526882102, 6071.939280607137, 6088.147659327787, 6128.387161283836, 6234.064890266496, 6254.8123556293385, 9964.950175249078, 10046.69859904204, 10079.899201007896, 10208.438535880598, 10434.060934515626, 10251.436171010666, 10287.948560257151, 10437.0, 10438.68683939483, 10494.475276236006, 7074.787756367317, 7379.077615298088, 7549.0941087069905, 7612.162662107053, 7777.0, 8308.376871734765, 8332.625031873458, 8394.622241999246, 8394.832103357776, 8407.831843363221, 7451.5901625411125, 7536.0956685198125, 7569.810754731176, 7654.578998155155, 7735.922640773745, 7369.078865141857, 7422.220666830121, 7430.219826918095, 7512.849743005218, 7579.090509138939, 6963.40811031068, 7005.789826305219, 7005.859882802213, 7010.439164866696, 7048.859022819617, 4905.9018819624125, 5026.421961474477, 5048.293238946624, 5094.694318340911, 5106.872328191825, 5056.988602279485, 5065.518775716301, 5097.1844504879045, 5160.793568257228, 5244.5279924806955], "value": 4567.2193162439125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2466418264075, 320.53202324606076, 320.9630892447368, 322.22826330937403, 328.36297582689565, 4951.727654978975, 5213.400458947222, 5887.146363777255, 5891.322497912742, 5905.586608937376, 4466.754328511931, 4790.904181916359, 5484.204790305404, 5549.197655184126, 5771.662476696944, 4170.416141740151, 4296.205202037633, 4359.2371335016405, 4388.210122178023, 4420.447444069491, 3510.4032314506467, 4148.548008197137, 4343.261645520253, 4380.817179361587, 4389.692721509496, 4328.718633288842, 4354.869353919372, 4357.886425083831, 4390.253656878338, 4390.868273951786, 4056.9999999999854, 4126.566710495415, 4247.0039081631585, 4292.0, 4380.97809510952, 3117.9220519486967, 3630.2557975614936, 3666.5416822897137, 3677.933399314196, 3687.797171155585, 5092.0579692756955, 5627.971860140714, 5643.435656434365, 5661.60368774186, 5683.54531637468, 4054.6350828425584, 4627.676062675614, 4786.856394308176, 4977.825776097856, 5014.623903207237, 5407.3781515125875, 5424.403315635277, 6070.6661133637635, 6085.300190478108, 6085.3914608539235, 4091.529474110486, 4107.67138628909, 4114.506259248879, 4120.402541631447, 4121.8969525761795, 5075.213341932006, 5542.196381524656, 6446.580972236837, 6454.096426500294, 6477.870442591122, 3540.4866294387684, 4115.403266526337, 4127.133302006552, 4134.689898257643, 4160.708750387444, 4184.372344148342, 4188.371744238389, 4207.915841683149, 4211.494620645481, 4211.957880421218, 4688.343631891538, 4970.229614409773, 4987.451380348159, 4990.900181996412, 5010.949890501049, 5623.132202576634, 5728.427157284238, 6127.938720612737, 6133.883810085514, 6152.8769424611255, 1288.9291088990196, 1384.8338199415932, 1410.9911413339512, 1425.6598797130664, 1444.6677264229286, 792.2117493094293, 832.8459235041537, 868.188243991857, 882.8146089321186, 897.1835629577054, 5289.735513224324, 5613.354464236665, 5673.602847800615, 5678.914816277759, 5741.770329186869, 5946.672932988728, 6063.9090413643835, 6169.01295792671, 6241.313455519889, 6252.937470625327, 4725.527447255316, 5497.39528651848, 5648.655807839783, 5687.260656114679, 5690.829275121753, 3256.2185075581688, 3259.3970115528705, 3291.7491353286077, 3298.983505082459, 3300.6369299377047, 5861.677607731531, 6466.547341686037, 6482.708278127401, 6494.590340071501, 6501.642409667514, 5046.596272298208, 5449.746558291615, 5539.889202215933, 6201.875962480815, 6305.896468118061, 6002.309734380515, 6109.778044391051, 6533.464635810581, 6540.631574738918, 6568.124806364172, 5630.73308505583, 5838.562107842014, 6207.81376558704, 6275.874482510416, 6295.685215739103, 5544.3346798384455, 6167.938320616737, 6210.72051757681, 6224.470919971853, 6244.750209991549, 6087.721578468571, 6169.537284703575, 6465.418112369909, 6469.223693156851, 6501.804945851632, 3628.564572251347, 4060.878173654795, 4096.689059500931, 4100.815463304099, 4116.547179810159, 5169.65588946869, 5415.702136382537, 6036.645708173728, 6224.128621993015, 6238.719257633508, 5705.971470142788, 6084.6349219047, 6160.630362178284, 6178.598391104564, 6181.289151747606, 5062.519060689228, 6160.476359509313, 6162.691865406801, 6196.349383314687, 6233.1612174407755, 5191.922121168261, 6050.42520960508, 6066.69465603068, 6078.939210607838, 6092.725827337869, 5482.424345443671, 6222.315545290105, 6230.127782110418, 6256.155419018556, 6309.0, 5241.659292146151, 5370.355557333145, 6078.331383547717, 6124.326324104256, 6193.293097246215], "value": 4395.007492364623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.3088923634874, 787.7085478373003, 793.1909452358598, 843.9451435656678, 891.1445012787724, 15453.45912893049, 15625.21873906303, 15775.84224157758, 15796.999999999985, 15866.920665396672, 14163.362648680808, 15704.057756534616, 16325.83674163258, 16326.428574999878, 16677.24952377143, 719.0508528742063, 781.1758594682608, 836.8284501677142, 917.4724533393326, 921.5484412637793, 724.7390939261861, 909.7225346269386, 917.321182325078, 924.0343840686498, 931.529577563333, 927.3601215161517, 927.7355953553239, 967.3905439573059, 968.5012218707371, 968.651285537206, 815.9592020398957, 819.1399031017438, 921.3688623293032, 924.533110779059, 960.3085778239691, 706.1490903461316, 711.3029231353252, 716.9532482575446, 719.1980941250521, 720.7981765105778, 15226.086434813946, 15831.0, 15850.841491585052, 15947.362105515766, 15971.600709982344, 14749.926250368786, 14761.409543618242, 14787.630309242248, 14806.111633301929, 14883.776743348859, 11992.100592455601, 12385.0, 12595.24428534291, 12616.684582885502, 12748.80876786849, 3765.3975363941636, 3850.0759817643843, 4028.4158796974566, 4051.7771522566245, 4058.370952502367, 120017.79982200153, 122231.0, 122839.0, 123110.38444807808, 127019.3649031749, 10362.689119326433, 11333.886661133449, 11339.829902551468, 11496.195266331444, 11513.481893314653, 19920.800791992184, 23478.0, 23489.88255058748, 23512.64731029036, 23573.29280121599, 7812.179721129313, 8245.917540824636, 8304.70933517324, 8346.540940248344, 8365.665373385118, 4575.450945886449, 4638.744869032168, 4641.6286697064825, 4652.744099074584, 4658.650601204923, 3648.927021459556, 3768.5477742670505, 3922.13712983149, 4110.835566577363, 4113.239050775616, 709.5848928376957, 710.1123595505618, 727.1492353945896, 735.1729304532402, 736.8268456912622, 635.3551145587232, 642.5662677692538, 663.5156335874839, 682.9180498340231, 695.8086526205233, 9275.840519935007, 9343.859842102374, 9767.0, 10016.39901605906, 10095.293329466867, 505.70669011972967, 573.3482642777155, 578.6325683191204, 609.5489337890018, 610.4018062298971, 4678.134545109097, 4687.648426367968, 4742.596879265301, 4747.905041899143, 4755.5719985201495, 76301.0, 142794.2860285692, 153810.46189538186, 169671.0, 169807.0, 139978.0, 142512.0, 142607.0, 144019.0, 144630.0, 105013.94986050042, 114440.0, 117025.0, 124145.0, 127514.08728869075, 10108.0, 10216.0, 10226.07965283128, 10233.641822536176, 10346.5344059516, 55349.72325138348, 61396.38603613907, 61557.692211538655, 62834.685826570574, 63637.36362636314, 58162.0, 62202.68898655478, 72025.91961120692, 93610.0, 94064.0, 13281.734365312834, 13675.384607692478, 14007.369668364745, 14312.354079281016, 14350.354234059701, 15574.610634734223, 15578.509518265715, 15649.530514084596, 15690.293936773101, 15723.685526289182, 13691.315434228449, 14518.782218266524, 14562.490312839, 14891.58529939654, 14959.626009349418, 14345.426182952566, 14426.711465770415, 14645.340959656627, 15035.097894126387, 15059.548213553611, 10552.314099583502, 13032.218066916015, 13274.469021239041, 13984.091034082752, 14640.560783176521, 11261.22975147146, 11916.285022898654, 11949.554276855413, 12122.212056216318, 12500.31248281317, 11927.105467090176, 12048.51805927753, 12112.636620901387, 12155.149139560146, 12227.266364018187], "value": 8144.8806674868665, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 93.0, 143.0, 161.0, 163.0, 119.0, 115.0, 162.0, 115.0, 115.0], "value": 128.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 128.0, 158.0, 151.0, 106.0, 128.0, 127.0, 109.0, 158.0, 107.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 194.0, 210.0, 214.0, 277.0, 265.0, 190.0, 264.0, 249.0, 202.0], "value": 227.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 84.0, 75.0, 143.0, 58.0, 58.0, 60.0, 63.0, 135.0, 57.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 118.0, 58.0, 70.0, 60.0, 129.0, 89.0, 65.0, 142.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 86.0, 89.0, 85.0, 87.0, 85.0, 88.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 93.0, 98.0, 95.0, 94.0, 95.0, 97.0, 136.0, 96.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 98.0, 92.0, 92.0, 93.0, 125.0, 146.0, 137.0, 93.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 56.0, 54.0, 57.0, 58.0, 56.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 75.0, 70.0, 86.0, 77.0, 74.0, 70.0, 70.0, 70.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 86.0, 83.0, 83.0, 82.0, 80.0, 86.0, 87.0, 89.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 141.0, 138.0, 135.0, 149.0, 160.0, 128.0, 150.0, 233.0, 148.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 205.0, 189.0, 163.0, 161.0, 155.0, 165.0, 166.0, 163.0, 162.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 64.0, 70.0, 65.0, 66.0, 66.0, 68.0, 63.0], "value": 66.3, "unit": "score"}]}]} 04:32:08 INFO - Return code: 0 04:32:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:32:09 ERROR - # TBPL SUCCESS # 04:32:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:09 INFO - 2016-07-06 04:32:09.059 screenresolution[1961:13599] starting screenresolution argv=screenresolution get 04:32:09 INFO - 2016-07-06 04:32:09.062 screenresolution[1961:13599] Display 0: 1600x1200x32@60 04:32:09 INFO - 2016-07-06 04:32:09.068 screenresolution[1962:13602] starting screenresolution argv=screenresolution list 04:32:09 INFO - Available Modes on Display 0 04:32:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:09 INFO - Intel Iris: 04:32:09 INFO - Chipset Model: Intel Iris 04:32:09 INFO - Type: GPU 04:32:09 INFO - Bus: Built-In 04:32:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:09 INFO - Vendor: Intel (0x8086) 04:32:09 INFO - Device ID: 0x0a2e 04:32:09 INFO - Revision ID: 0x0009 04:32:09 INFO - Displays: 04:32:09 INFO - Display: 04:32:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:09 INFO - Display Serial Number: 1600x1200 60 04:32:09 INFO - Main Display: Yes 04:32:09 INFO - Mirror: Off 04:32:09 INFO - Online: Yes 04:32:09 INFO - Rotation: Supported 04:32:09 INFO - Return code: 0 04:32:09 INFO - Running post-action listener: _resource_record_post_action 04:32:09 INFO - ##### 04:32:09 INFO - ##### Finished run-tests step (success) 04:32:09 INFO - ##### 04:32:09 INFO - Running post-run listener: _resource_record_post_run 04:32:09 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 1122304; Write bytes: 707199488; Read time: 12; Write time: 2054 04:32:09 INFO - TinderboxPrint: CPU usage
54.8% 04:32:09 INFO - TinderboxPrint: I/O read bytes / time
1,122,304 / 12 04:32:09 INFO - TinderboxPrint: I/O write bytes / time
707,199,488 / 2,054 04:32:09 INFO - TinderboxPrint: CPU idle
2,185.0 (45.2%) 04:32:09 INFO - TinderboxPrint: CPU system
988.9 (20.4%) 04:32:09 INFO - TinderboxPrint: CPU user
1,663.9 (34.4%) 04:32:09 INFO - TinderboxPrint: Swap in / out
408,633,344 / 0 04:32:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398451200; Write bytes: 392467968; Read time: 29713; Write time: 876 04:32:09 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 1118208; Write bytes: 296893440; Read time: 12; Write time: 1133 04:32:09 INFO - Running post-run listener: _upload_blobber_files 04:32:09 INFO - Blob upload gear active. 04:32:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:11 INFO - (blobuploader) - INFO - Done attempting. 04:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:12 INFO - (blobuploader) - INFO - Done attempting. 04:32:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:32:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:32:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:14 INFO - (blobuploader) - INFO - Done attempting. 04:32:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:14 INFO - Return code: 0 04:32:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4637d2f57869dc59c7c069f762849ca9b72fb2c1338eef89b15690f1c7db42964c9dda612726dab07f451c37720f7bc45bb7c1e14a8c702c27fd2f17baa7a9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125b390323d6d8619e4510f1c92822e34addbe7ee9153af3afabbc9b75fdf4a3999c718cf21fa78090accd8d4a5c1bde2859f4d725902b67357f0518c120c7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9614f841d2ea4af94a877eb97fd82fd4f8cb855223fef24698b9f9efa5c601473b93fe4e2b365e6e2ebb1d9800a6b20004200f81b8cf696bfccf6fd4c028a61"} 04:32:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:14 INFO - Contents: 04:32:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4637d2f57869dc59c7c069f762849ca9b72fb2c1338eef89b15690f1c7db42964c9dda612726dab07f451c37720f7bc45bb7c1e14a8c702c27fd2f17baa7a9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125b390323d6d8619e4510f1c92822e34addbe7ee9153af3afabbc9b75fdf4a3999c718cf21fa78090accd8d4a5c1bde2859f4d725902b67357f0518c120c7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9614f841d2ea4af94a877eb97fd82fd4f8cb855223fef24698b9f9efa5c601473b93fe4e2b365e6e2ebb1d9800a6b20004200f81b8cf696bfccf6fd4c028a61"} 04:32:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:14 INFO - Copying logs to upload dir... 04:32:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.122020 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-06 04:32:14.725927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:14.729205) ========= 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.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4637d2f57869dc59c7c069f762849ca9b72fb2c1338eef89b15690f1c7db42964c9dda612726dab07f451c37720f7bc45bb7c1e14a8c702c27fd2f17baa7a9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125b390323d6d8619e4510f1c92822e34addbe7ee9153af3afabbc9b75fdf4a3999c718cf21fa78090accd8d4a5c1bde2859f4d725902b67357f0518c120c7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9614f841d2ea4af94a877eb97fd82fd4f8cb855223fef24698b9f9efa5c601473b93fe4e2b365e6e2ebb1d9800a6b20004200f81b8cf696bfccf6fd4c028a61"} build_url:https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011087 build_url: 'https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4637d2f57869dc59c7c069f762849ca9b72fb2c1338eef89b15690f1c7db42964c9dda612726dab07f451c37720f7bc45bb7c1e14a8c702c27fd2f17baa7a9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9125b390323d6d8619e4510f1c92822e34addbe7ee9153af3afabbc9b75fdf4a3999c718cf21fa78090accd8d4a5c1bde2859f4d725902b67357f0518c120c7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9614f841d2ea4af94a877eb97fd82fd4f8cb855223fef24698b9f9efa5c601473b93fe4e2b365e6e2ebb1d9800a6b20004200f81b8cf696bfccf6fd4c028a61"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:14.761903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:14.762608) ========= 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.37SZsg3Uzt/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.bjHFdTE8hZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005172 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:14.813776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 04:32:14.814526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 04:32:14.815352) ========= ========= Total master_lag: 0.18 =========