builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0324 starttime: 1467217734.02 results: success (0) buildid: 20160629071428 builduid: 3ce221c54d684cfe9ee4af296fec3836 revision: b69a5bbb5e40bd426e35222baa600b481e50d265 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.020553) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.021333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.021640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.048593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.049033) ========= 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.vL8bVOjlZK/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.4HWvL42pSI/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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-06-29 09:28:54-- 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% 28.4M=0s 2016-06-29 09:28:54 (28.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.161566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.161916) ========= 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.vL8bVOjlZK/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.4HWvL42pSI/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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.025744 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.211267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.211634) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b69a5bbb5e40bd426e35222baa600b481e50d265 --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 b69a5bbb5e40bd426e35222baa600b481e50d265 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vL8bVOjlZK/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.4HWvL42pSI/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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-06-29 09:28:54,292 truncating revision to first 12 chars 2016-06-29 09:28:54,292 Setting DEBUG logging. 2016-06-29 09:28:54,293 attempt 1/10 2016-06-29 09:28:54,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b69a5bbb5e40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 09:28:54,604 unpacking tar archive at: mozilla-central-b69a5bbb5e40/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583088 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.817751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.818115) ========= script_repo_revision: b69a5bbb5e40bd426e35222baa600b481e50d265 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.818516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.818792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 09:28:54.839173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-29 09:28:54.839656) ========= /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.vL8bVOjlZK/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.4HWvL42pSI/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:28:55 INFO - MultiFileLogger online at 20160629 09:28:55 in /builds/slave/test 09:28:55 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 09:28:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:55 INFO - {'append_to_log': False, 09:28:55 INFO - 'base_work_dir': '/builds/slave/test', 09:28:55 INFO - 'blob_upload_branch': 'Firefox', 09:28:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:55 INFO - 'branch': 'Firefox', 09:28:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:55 INFO - 'config_files': ('talos/mac_config.py',), 09:28:55 INFO - 'default_actions': ('clobber', 09:28:55 INFO - 'read-buildbot-config', 09:28:55 INFO - 'download-and-extract', 09:28:55 INFO - 'populate-webroot', 09:28:55 INFO - 'create-virtualenv', 09:28:55 INFO - 'install', 09:28:55 INFO - 'run-tests'), 09:28:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:55 INFO - 'download_minidump_stackwalk': True, 09:28:55 INFO - 'download_symbols': 'ondemand', 09:28:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:55 INFO - 'installer_path': 'installer.exe', 09:28:55 INFO - 'log_level': 'info', 09:28:55 INFO - 'log_name': 'talos', 09:28:55 INFO - 'log_to_console': True, 09:28:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:28:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:28:55 INFO - 'opt_config_files': (), 09:28:55 INFO - 'pip_index': False, 09:28:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:28:55 INFO - 'cmd': ('bash', 09:28:55 INFO - '-c', 09:28:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:28:55 INFO - 'enabled': True, 09:28:55 INFO - 'halt_on_failure': False, 09:28:55 INFO - 'name': 'check_screen_resolution'},), 09:28:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:28:55 INFO - 'cmd': ('bash', 09:28:55 INFO - '-c', 09:28:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:28:55 INFO - 'enabled': True, 09:28:55 INFO - 'halt_on_failure': False, 09:28:55 INFO - 'name': 'check_screen_resolution'},), 09:28:55 INFO - 'run_cmd_checks_enabled': True, 09:28:55 INFO - 'sps_profile': False, 09:28:55 INFO - 'sps_profile_interval': 0, 09:28:55 INFO - 'suite': 'dromaeojs-e10s', 09:28:55 INFO - 'system_bits': '32', 09:28:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:55 INFO - 'title': 't-yosemite-r7-0324', 09:28:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:55 INFO - 'use_talos_json': True, 09:28:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:55 INFO - 'work_dir': 'build'} 09:28:55 INFO - ##### 09:28:55 INFO - ##### Running clobber step. 09:28:55 INFO - ##### 09:28:55 INFO - Running pre-action listener: _resource_record_pre_action 09:28:55 INFO - Running main action method: clobber 09:28:55 INFO - rmtree: /builds/slave/test/build 09:28:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:56 INFO - Running post-action listener: _resource_record_post_action 09:28:56 INFO - ##### 09:28:56 INFO - ##### Finished clobber step (success) 09:28:56 INFO - ##### 09:28:56 INFO - ##### 09:28:56 INFO - ##### Running read-buildbot-config step. 09:28:56 INFO - ##### 09:28:56 INFO - Running pre-action listener: _resource_record_pre_action 09:28:56 INFO - Running main action method: read_buildbot_config 09:28:56 INFO - Using buildbot properties: 09:28:56 INFO - { 09:28:56 INFO - "project": "", 09:28:56 INFO - "product": "firefox", 09:28:56 INFO - "script_repo_revision": "production", 09:28:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:28:56 INFO - "repository": "", 09:28:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:28:56 INFO - "buildid": "20160629071428", 09:28:56 INFO - "pgo_build": "False", 09:28:56 INFO - "basedir": "/builds/slave/test", 09:28:56 INFO - "buildnumber": 2, 09:28:56 INFO - "slavename": "t-yosemite-r7-0324", 09:28:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:28:56 INFO - "platform": "yosemite_r7", 09:28:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:28:56 INFO - "branch": "mozilla-central", 09:28:56 INFO - "repo_path": "mozilla-central", 09:28:56 INFO - "revision": "b69a5bbb5e40bd426e35222baa600b481e50d265", 09:28:56 INFO - "stage_platform": "macosx64", 09:28:56 INFO - "builduid": "3ce221c54d684cfe9ee4af296fec3836", 09:28:56 INFO - "slavebuilddir": "test" 09:28:56 INFO - } 09:28:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 09:28:56 INFO - Running post-action listener: _resource_record_post_action 09:28:56 INFO - ##### 09:28:56 INFO - ##### Finished read-buildbot-config step (success) 09:28:56 INFO - ##### 09:28:56 INFO - ##### 09:28:56 INFO - ##### Running download-and-extract step. 09:28:56 INFO - ##### 09:28:56 INFO - Running pre-action listener: _resource_record_pre_action 09:28:56 INFO - Running main action method: download_and_extract 09:28:56 INFO - mkdir: /builds/slave/test/build/tests 09:28:56 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')]} 09:28:56 INFO - https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:28:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:28:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:28:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:00 INFO - Downloaded 1199 bytes. 09:29:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:29:00 INFO - Using the following test package requirements: 09:29:00 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:29:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:29:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:29:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'jsshell-mac.zip'], 09:29:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:29:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:29:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:29:00 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:29:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:29:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:29:00 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:29:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:29:00 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')]} 09:29:00 INFO - https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:29:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:29:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:29:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:01 INFO - Downloaded 18788519 bytes. 09:29:01 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'] 09:29:01 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 09:29:04 INFO - Return code: 0 09:29:04 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 09:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:04 INFO - https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:29:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:29:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:29:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:06 INFO - Downloaded 18788519 bytes. 09:29:06 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'] 09:29:06 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 09:29:09 INFO - Return code: 0 09:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:09 INFO - https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:29:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:29:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:29:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:10 INFO - Downloaded 14405245 bytes. 09:29:10 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'] 09:29:10 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 09:29:10 INFO - Return code: 0 09:29:10 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')]} 09:29:10 INFO - https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:29:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:29:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:29:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:29:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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 09:29:13 INFO - Downloaded 112481150 bytes. 09:29:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:29:13 INFO - mkdir: /builds/slave/test/properties 09:29:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:13 INFO - Contents: 09:29:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:29:14 INFO - Running post-action listener: _resource_record_post_action 09:29:14 INFO - Running post-action listener: set_extra_try_arguments 09:29:14 INFO - ##### 09:29:14 INFO - ##### Finished download-and-extract step (success) 09:29:14 INFO - ##### 09:29:14 INFO - ##### 09:29:14 INFO - ##### Running populate-webroot step. 09:29:14 INFO - ##### 09:29:14 INFO - Running pre-action listener: _resource_record_pre_action 09:29:14 INFO - Running main action method: populate_webroot 09:29:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:14 INFO - '--tppagecycles', 09:29:14 INFO - '7'], 09:29:14 INFO - 'tests': ['tsvgm']}}, 09:29:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:29:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:29:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['damp', 'tps']}, 09:29:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'tests': ['damp', 'tps']}, 09:29:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['dromaeo_dom']}, 09:29:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['basic_compositor_video']}, 09:29:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:29:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['a11yr', 09:29:14 INFO - 'ts_paint', 09:29:14 INFO - 'tpaint', 09:29:14 INFO - 'sessionrestore', 09:29:14 INFO - 'sessionrestore_no_auto_restore', 09:29:14 INFO - 'tabpaint']}, 09:29:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:29:14 INFO - 'ts_paint', 09:29:14 INFO - 'tpaint', 09:29:14 INFO - 'sessionrestore', 09:29:14 INFO - 'sessionrestore_no_auto_restore', 09:29:14 INFO - 'tabpaint']}, 09:29:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:29:14 INFO - 'ts_paint', 09:29:14 INFO - 'tpaint', 09:29:14 INFO - 'sessionrestore', 09:29:14 INFO - 'sessionrestore_no_auto_restore', 09:29:14 INFO - 'tabpaint']}, 09:29:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:29:14 INFO - 'ts_paint', 09:29:14 INFO - 'tpaint', 09:29:14 INFO - 'sessionrestore', 09:29:14 INFO - 'sessionrestore_no_auto_restore', 09:29:14 INFO - 'tabpaint']}, 09:29:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['a11yr', 09:29:14 INFO - 'ts_paint', 09:29:14 INFO - 'tpaint', 09:29:14 INFO - 'sessionrestore', 09:29:14 INFO - 'sessionrestore_no_auto_restore', 09:29:14 INFO - 'tabpaint']}, 09:29:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['a11yr', 09:29:14 INFO - 'ts_paint', 09:29:14 INFO - 'tpaint', 09:29:14 INFO - 'sessionrestore', 09:29:14 INFO - 'sessionrestore_no_auto_restore', 09:29:14 INFO - 'tabpaint']}, 09:29:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['tsvgx', 09:29:14 INFO - 'tsvgr_opacity', 09:29:14 INFO - 'tart', 09:29:14 INFO - 'tscrollx', 09:29:14 INFO - 'cart']}, 09:29:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:29:14 INFO - 'tsvgr_opacity', 09:29:14 INFO - 'tart', 09:29:14 INFO - 'tscrollx', 09:29:14 INFO - 'cart']}, 09:29:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'talos_options': ['--disable-e10s'], 09:29:14 INFO - 'tests': ['tp5o']}, 09:29:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'tests': ['tp5o']}, 09:29:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'talos_options': ['--disable-e10s', 09:29:14 INFO - '--xperf_path', 09:29:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:14 INFO - 'tests': ['tp5n']}, 09:29:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:14 INFO - 'talos_options': ['--xperf_path', 09:29:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:14 INFO - 'tests': ['tp5n']}}, 09:29:14 INFO - 'talos.zip': {'path': '', 09:29:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:14 INFO - Running post-action listener: _resource_record_post_action 09:29:14 INFO - ##### 09:29:14 INFO - ##### Finished populate-webroot step (success) 09:29:14 INFO - ##### 09:29:14 INFO - ##### 09:29:14 INFO - ##### Running create-virtualenv step. 09:29:14 INFO - ##### 09:29:14 INFO - Running pre-action listener: _resource_record_pre_action 09:29:14 INFO - Running main action method: create_virtualenv 09:29:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29:14 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 09:29:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:15 INFO - Using real prefix '/tools/python27' 09:29:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:18 INFO - Installing pip.................done. 09:29:18 INFO - Return code: 0 09:29:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:18 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:18 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 09:29:18 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 09:29:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:18 INFO - 'HOME': '/Users/cltbld', 09:29:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:18 INFO - 'LOGNAME': 'cltbld', 09:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:18 INFO - 'MOZ_NO_REMOTE': '1', 09:29:18 INFO - 'NO_EM_RESTART': '1', 09:29:18 INFO - 'PAGER': '/bin/cat', 09:29:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:18 INFO - 'PWD': '/builds/slave/test', 09:29:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:18 INFO - 'SHELL': '/bin/bash', 09:29:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:18 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:18 INFO - 'USER': 'cltbld', 09:29:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:18 INFO - 'XPC_FLAGS': '0x0', 09:29:18 INFO - 'XPC_SERVICE_NAME': '0', 09:29:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:19 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 09:29:19 INFO - Cleaning up... 09:29:19 INFO - Return code: 0 09:29:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:19 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:19 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 09:29:19 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 09:29:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:19 INFO - 'HOME': '/Users/cltbld', 09:29:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:19 INFO - 'LOGNAME': 'cltbld', 09:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:19 INFO - 'MOZ_NO_REMOTE': '1', 09:29:19 INFO - 'NO_EM_RESTART': '1', 09:29:19 INFO - 'PAGER': '/bin/cat', 09:29:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:19 INFO - 'PWD': '/builds/slave/test', 09:29:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:19 INFO - 'SHELL': '/bin/bash', 09:29:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:19 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:19 INFO - 'USER': 'cltbld', 09:29:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:19 INFO - 'XPC_FLAGS': '0x0', 09:29:19 INFO - 'XPC_SERVICE_NAME': '0', 09:29:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:19 INFO - Downloading/unpacking psutil>=3.1.1 09:29:19 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 09:29:19 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 09:29:19 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 09:29:19 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 09:29:19 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 09:29:19 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 09:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:22 INFO - Installing collected packages: psutil 09:29:22 INFO - Running setup.py install for psutil 09:29:22 INFO - building 'psutil._psutil_osx' extension 09:29:22 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 09:29:22 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 09:29:23 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 09:29:23 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 09:29:23 INFO - building 'psutil._psutil_posix' extension 09:29:23 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 09:29:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:29:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:29:23 INFO - ^ 09:29:23 INFO - 1 warning generated. 09:29:23 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 09:29:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:23 INFO - Successfully installed psutil 09:29:23 INFO - Cleaning up... 09:29:23 INFO - Return code: 0 09:29:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:29:23 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')]} 09:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:23 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')]} 09:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:23 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:23 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 09:29:23 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 09:29:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:23 INFO - 'HOME': '/Users/cltbld', 09:29:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:23 INFO - 'LOGNAME': 'cltbld', 09:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:23 INFO - 'MOZ_NO_REMOTE': '1', 09:29:23 INFO - 'NO_EM_RESTART': '1', 09:29:23 INFO - 'PAGER': '/bin/cat', 09:29:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:23 INFO - 'PWD': '/builds/slave/test', 09:29:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:23 INFO - 'SHELL': '/bin/bash', 09:29:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:23 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:23 INFO - 'USER': 'cltbld', 09:29:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:23 INFO - 'XPC_FLAGS': '0x0', 09:29:23 INFO - 'XPC_SERVICE_NAME': '0', 09:29:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:29:26 INFO - Installing collected packages: mozsystemmonitor 09:29:26 INFO - Running setup.py install for mozsystemmonitor 09:29:26 INFO - Successfully installed mozsystemmonitor 09:29:26 INFO - Cleaning up... 09:29:26 INFO - Return code: 0 09:29:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:26 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:26 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 09:29:26 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 09:29:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:26 INFO - 'HOME': '/Users/cltbld', 09:29:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:26 INFO - 'LOGNAME': 'cltbld', 09:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:26 INFO - 'MOZ_NO_REMOTE': '1', 09:29:26 INFO - 'NO_EM_RESTART': '1', 09:29:26 INFO - 'PAGER': '/bin/cat', 09:29:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:26 INFO - 'PWD': '/builds/slave/test', 09:29:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:26 INFO - 'SHELL': '/bin/bash', 09:29:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:26 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:26 INFO - 'USER': 'cltbld', 09:29:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:26 INFO - 'XPC_FLAGS': '0x0', 09:29:26 INFO - 'XPC_SERVICE_NAME': '0', 09:29:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:26 INFO - Downloading/unpacking jsonschema==2.5.1 09:29:26 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 09:29:26 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 09:29:26 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 09:29:26 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 09:29:26 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 09:29:26 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 09:29:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:29:29 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 09:29:29 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 09:29:29 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 09:29:29 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 09:29:29 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 09:29:29 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 09:29:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:29 INFO - warning: no files found matching '*.txt' 09:29:29 INFO - no previously-included directories found matching 'build' 09:29:29 INFO - no previously-included directories found matching 'dist' 09:29:29 INFO - no previously-included directories found matching '.git*' 09:29:29 INFO - Installing collected packages: jsonschema, functools32 09:29:29 INFO - Running setup.py install for functools32 09:29:29 INFO - warning: no files found matching '*.txt' 09:29:29 INFO - no previously-included directories found matching 'build' 09:29:29 INFO - no previously-included directories found matching 'dist' 09:29:29 INFO - no previously-included directories found matching '.git*' 09:29:29 INFO - Successfully installed jsonschema functools32 09:29:29 INFO - Cleaning up... 09:29:29 INFO - Return code: 0 09:29:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:29 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:29 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 09:29:29 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 09:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:29 INFO - 'HOME': '/Users/cltbld', 09:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:29 INFO - 'LOGNAME': 'cltbld', 09:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:29 INFO - 'MOZ_NO_REMOTE': '1', 09:29:29 INFO - 'NO_EM_RESTART': '1', 09:29:29 INFO - 'PAGER': '/bin/cat', 09:29:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:29 INFO - 'PWD': '/builds/slave/test', 09:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:29 INFO - 'SHELL': '/bin/bash', 09:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:29 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:29 INFO - 'USER': 'cltbld', 09:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:29 INFO - 'XPC_FLAGS': '0x0', 09:29:29 INFO - 'XPC_SERVICE_NAME': '0', 09:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:29:30 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 09:29:30 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 09:29:30 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 09:29:30 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 09:29:30 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 09:29:30 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 09:29:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:29:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:33 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 09:29:33 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 09:29:33 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 09:29:33 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 09:29:33 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 09:29:33 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 09:29:33 INFO - Downloading docopt-0.6.1.tar.gz 09:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:29:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:29:33 INFO - Running setup.py install for blobuploader 09:29:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:29:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:29:34 INFO - Running setup.py install for requests 09:29:34 INFO - Running setup.py install for docopt 09:29:34 INFO - Successfully installed blobuploader requests docopt 09:29:34 INFO - Cleaning up... 09:29:34 INFO - Return code: 0 09:29:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:34 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:34 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 09:29:34 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 09:29:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:34 INFO - 'HOME': '/Users/cltbld', 09:29:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:34 INFO - 'LOGNAME': 'cltbld', 09:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:34 INFO - 'MOZ_NO_REMOTE': '1', 09:29:34 INFO - 'NO_EM_RESTART': '1', 09:29:34 INFO - 'PAGER': '/bin/cat', 09:29:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:34 INFO - 'PWD': '/builds/slave/test', 09:29:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:34 INFO - 'SHELL': '/bin/bash', 09:29:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:34 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:34 INFO - 'USER': 'cltbld', 09:29:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:34 INFO - 'XPC_FLAGS': '0x0', 09:29:34 INFO - 'XPC_SERVICE_NAME': '0', 09:29:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-vH8LTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-flGIqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-mdNSQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-UbOUJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-GZlgbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-Vj7pLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-C5juZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-MR0H1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:35 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-24Nn1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-XQm4tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-N53V4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-sZKtJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-dZPWqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-DYisDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-nWJVIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-eWH0l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:36 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-AkQ2w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:29:36 INFO - Running setup.py install for manifestparser 09:29:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:29:36 INFO - Running setup.py install for mozcrash 09:29:37 INFO - Running setup.py install for mozdebug 09:29:37 INFO - Running setup.py install for mozdevice 09:29:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Running setup.py install for mozfile 09:29:37 INFO - Running setup.py install for mozhttpd 09:29:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Running setup.py install for mozinfo 09:29:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Running setup.py install for mozInstall 09:29:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:29:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozleak 09:29:38 INFO - Running setup.py install for mozlog 09:29:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for moznetwork 09:29:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozprocess 09:29:38 INFO - Running setup.py install for mozprofile 09:29:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozrunner 09:29:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozscreenshot 09:29:39 INFO - Running setup.py install for moztest 09:29:39 INFO - Running setup.py install for mozversion 09:29:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:39 INFO - Cleaning up... 09:29:39 INFO - Return code: 0 09:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:39 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')]} 09:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:39 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')]} 09:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:39 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:39 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 09:29:39 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 09:29:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:39 INFO - 'HOME': '/Users/cltbld', 09:29:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:39 INFO - 'LOGNAME': 'cltbld', 09:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:39 INFO - 'MOZ_NO_REMOTE': '1', 09:29:39 INFO - 'NO_EM_RESTART': '1', 09:29:39 INFO - 'PAGER': '/bin/cat', 09:29:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:39 INFO - 'PWD': '/builds/slave/test', 09:29:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:39 INFO - 'SHELL': '/bin/bash', 09:29:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:39 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:39 INFO - 'USER': 'cltbld', 09:29:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:39 INFO - 'XPC_FLAGS': '0x0', 09:29:39 INFO - 'XPC_SERVICE_NAME': '0', 09:29:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:39 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-0HLKp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:39 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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:39 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-j0bWDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:39 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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:39 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-INFMQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:39 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)) 09:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-o6xcpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-YwRYcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-ldozpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-VOIh65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-Ov1t1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-lhAq23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-MnF7G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-OsiOUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-uh4v2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:40 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)) 09:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:40 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-JZ8POA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:41 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-vaWrBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:41 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-sgy9JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:41 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-oMukPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:41 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-OjYLE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:41 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)) 09:29:41 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)) 09:29:41 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)) 09:29:41 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)) 09:29:41 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)) 09:29:41 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)) 09:29:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:44 INFO - Downloading blessings-1.6.tar.gz 09:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:44 INFO - Installing collected packages: blessings 09:29:44 INFO - Running setup.py install for blessings 09:29:44 INFO - Successfully installed blessings 09:29:44 INFO - Cleaning up... 09:29:44 INFO - Return code: 0 09:29:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:44 INFO - Reading from file tmpfile_stdout 09:29:44 INFO - Current package versions: 09:29:44 INFO - blessings == 1.6 09:29:44 INFO - blobuploader == 1.2.4 09:29:44 INFO - docopt == 0.6.1 09:29:44 INFO - functools32 == 3.2.3-2 09:29:44 INFO - jsonschema == 2.5.1 09:29:44 INFO - manifestparser == 1.1 09:29:44 INFO - mozInstall == 1.12 09:29:44 INFO - mozcrash == 0.17 09:29:44 INFO - mozdebug == 0.1 09:29:44 INFO - mozdevice == 0.48 09:29:44 INFO - mozfile == 1.2 09:29:44 INFO - mozhttpd == 0.7 09:29:44 INFO - mozinfo == 0.9 09:29:44 INFO - mozleak == 0.1 09:29:44 INFO - mozlog == 3.2 09:29:44 INFO - moznetwork == 0.27 09:29:44 INFO - mozprocess == 0.22 09:29:44 INFO - mozprofile == 0.28 09:29:44 INFO - mozrunner == 6.11 09:29:44 INFO - mozscreenshot == 0.1 09:29:44 INFO - mozsystemmonitor == 0.3 09:29:44 INFO - moztest == 0.7 09:29:44 INFO - mozversion == 1.4 09:29:44 INFO - psutil == 3.1.1 09:29:44 INFO - requests == 1.2.3 09:29:44 INFO - wsgiref == 0.1.2 09:29:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:44 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 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29:44 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 09:29:44 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 09:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:44 INFO - 'HOME': '/Users/cltbld', 09:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:44 INFO - 'LOGNAME': 'cltbld', 09:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:44 INFO - 'MOZ_NO_REMOTE': '1', 09:29:44 INFO - 'NO_EM_RESTART': '1', 09:29:44 INFO - 'PAGER': '/bin/cat', 09:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:44 INFO - 'PWD': '/builds/slave/test', 09:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:44 INFO - 'SHELL': '/bin/bash', 09:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:44 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:44 INFO - 'USER': 'cltbld', 09:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:44 INFO - 'XPC_FLAGS': '0x0', 09:29:44 INFO - 'XPC_SERVICE_NAME': '0', 09:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 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)) 09:29:44 INFO - Cleaning up... 09:29:44 INFO - Return code: 0 09:29:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54a688220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, '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.vL8bVOjlZK/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.4HWvL42pSI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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 09:29: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', 'jsonschema'] in /builds/slave/test/build 09:29: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 jsonschema 09:29:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:29:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:44 INFO - 'HOME': '/Users/cltbld', 09:29:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:44 INFO - 'LOGNAME': 'cltbld', 09:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:44 INFO - 'MOZ_NO_REMOTE': '1', 09:29:44 INFO - 'NO_EM_RESTART': '1', 09:29:44 INFO - 'PAGER': '/bin/cat', 09:29:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:44 INFO - 'PWD': '/builds/slave/test', 09:29:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:44 INFO - 'SHELL': '/bin/bash', 09:29:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:29:44 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:29:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:44 INFO - 'USER': 'cltbld', 09:29:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:44 INFO - 'XPC_FLAGS': '0x0', 09:29:44 INFO - 'XPC_SERVICE_NAME': '0', 09:29:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:29:45 INFO - Cleaning up... 09:29:45 INFO - Return code: 0 09:29:45 INFO - Running post-action listener: _resource_record_post_action 09:29:45 INFO - Running post-action listener: _start_resource_monitoring 09:29:45 INFO - Starting resource monitoring. 09:29:45 INFO - ##### 09:29:45 INFO - ##### Finished create-virtualenv step (success) 09:29:45 INFO - ##### 09:29:45 INFO - ##### 09:29:45 INFO - ##### Running install step. 09:29:45 INFO - ##### 09:29:45 INFO - Running pre-action listener: _resource_record_pre_action 09:29:45 INFO - Running main action method: install 09:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:45 INFO - Reading from file tmpfile_stdout 09:29:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:45 INFO - Reading from file tmpfile_stdout 09:29:45 INFO - Output received: 09:29:45 INFO - Usage: mozinstall [options] installer 09:29:45 INFO - Options: 09:29:45 INFO - -h, --help show this help message and exit 09:29:45 INFO - -d DEST, --destination=DEST 09:29:45 INFO - Directory to install application into. [default: 09:29:45 INFO - "/builds/slave/test"] 09:29:45 INFO - --app=APP Application being installed. [default: firefox] 09:29:45 INFO - mkdir: /builds/slave/test/build/application 09:29:45 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'] 09:29:45 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 09:30:19 INFO - Reading from file tmpfile_stdout 09:30:19 INFO - Output received: 09:30:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:30:19 INFO - Running post-action listener: _resource_record_post_action 09:30:19 INFO - ##### 09:30:19 INFO - ##### Finished install step (success) 09:30:19 INFO - ##### 09:30:19 INFO - ##### 09:30:19 INFO - ##### Running run-tests step. 09:30:19 INFO - ##### 09:30:19 INFO - Running pre-action listener: _resource_record_pre_action 09:30:19 INFO - Running main action method: run_tests 09:30:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:30:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:30:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:30:19 INFO - 2016-06-29 09:30:19.868 screenresolution[1638:7437] starting screenresolution argv=screenresolution get 09:30:19 INFO - 2016-06-29 09:30:19.870 screenresolution[1638:7437] Display 0: 1600x1200x32@60 09:30:19 INFO - 2016-06-29 09:30:19.876 screenresolution[1639:7439] starting screenresolution argv=screenresolution list 09:30:19 INFO - Available Modes on Display 0 09:30:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:30:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:30:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:30:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:30:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:30:20 INFO - Intel Iris: 09:30:20 INFO - Chipset Model: Intel Iris 09:30:20 INFO - Type: GPU 09:30:20 INFO - Bus: Built-In 09:30:20 INFO - VRAM (Dynamic, Max): 1536 MB 09:30:20 INFO - Vendor: Intel (0x8086) 09:30:20 INFO - Device ID: 0x0a2e 09:30:20 INFO - Revision ID: 0x0009 09:30:20 INFO - Displays: 09:30:20 INFO - Display: 09:30:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:30:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:30:20 INFO - Display Serial Number: 1600x1200 60 09:30:20 INFO - Main Display: Yes 09:30:20 INFO - Mirror: Off 09:30:20 INFO - Online: Yes 09:30:20 INFO - Rotation: Supported 09:30:20 INFO - Return code: 0 09:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:20 INFO - Python 2.7.3 09:30:20 INFO - Return code: 0 09:30:20 INFO - grabbing minidump binary from tooltool 09:30: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')]} 09:30:20 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 0x10dac6d30>, '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 0x10d82bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dabeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:20 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 09:30:20 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 09:30:20 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 09:30:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:20 INFO - Return code: 0 09:30:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:30:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:30:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30:20 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/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 09:30:20 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/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0324 --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 09:30:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vL8bVOjlZK/Render', 09:30:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:20 INFO - 'HOME': '/Users/cltbld', 09:30:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:20 INFO - 'LOGNAME': 'cltbld', 09:30:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:20 INFO - 'MOZ_NO_REMOTE': '1', 09:30:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:20 INFO - 'NO_EM_RESTART': '1', 09:30:20 INFO - 'PAGER': '/bin/cat', 09:30:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:20 INFO - 'PWD': '/builds/slave/test', 09:30:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:20 INFO - 'SHELL': '/bin/bash', 09:30:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4HWvL42pSI/Listeners', 09:30:20 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 09:30:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:20 INFO - 'USER': 'cltbld', 09:30:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:20 INFO - 'XPC_FLAGS': '0x0', 09:30:20 INFO - 'XPC_SERVICE_NAME': '0', 09:30:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:20 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/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 09:30:20 INFO - mozversion application_buildid: 20160629071428 09:30:20 INFO - mozversion application_changeset: b69a5bbb5e40bd426e35222baa600b481e50d265 09:30:20 INFO - mozversion application_display_name: Nightly 09:30:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:20 INFO - mozversion application_name: Firefox 09:30:20 INFO - mozversion application_remotingname: firefox 09:30:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:30:20 INFO - mozversion application_vendor: Mozilla 09:30:20 INFO - mozversion application_version: 50.0a1 09:30:20 INFO - mozversion platform_buildid: 20160629071428 09:30:20 INFO - mozversion platform_changeset: b69a5bbb5e40bd426e35222baa600b481e50d265 09:30:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:30:20 INFO - mozversion platform_version: 50.0a1 09:30:20 INFO - using testdate: 1467217820 09:30:20 INFO - actual date: 1467217820 09:30:20 INFO - starting webserver on 'localhost:49274' 09:30:20 INFO - SUITE-START | Running 2 tests 09:30:20 INFO - TEST-START | dromaeo_css 09:30:20 INFO - operating with platform_type : mac_ 09:30:20 INFO - Initialising browser for dromaeo_css test... 09:30:20 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmp1zgGVr/profile http://localhost:49274/getInfo.html) 09:30:23 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:30:23 INFO - PROCESS | 1649 | colorDepth:24 09:30:23 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:30:23 INFO - PROCESS | 1649 | __metrics 09:30:23 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:30:24 INFO - TEST-INFO | 1649: exit 0 09:30:24 INFO - Browser initialized. 09:30:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:24 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmp1zgGVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:35 INFO - PROCESS | 1652 | RSS: Main: 255787008 09:30:35 INFO - PROCESS | 1652 | 09:31:25 INFO - PROCESS | 1652 | 1467217885630 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] 09:33:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 09:33:37 INFO - PROCESS | 1652 | RSS: Main: 268066816 09:33:37 INFO - PROCESS | 1652 | 09:36:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 09:36:40 INFO - PROCESS | 1652 | RSS: Main: 276713472 09:36:40 INFO - PROCESS | 1652 | 09:39:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 09:39:43 INFO - PROCESS | 1652 | RSS: Main: 281325568 09:39:43 INFO - PROCESS | 1652 | 09:42:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 09:42:45 INFO - PROCESS | 1652 | RSS: Main: 280801280 09:42:45 INFO - PROCESS | 1652 | 09:45:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 09:45:49 INFO - PROCESS | 1652 | RSS: Main: 284069888 09:45:49 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 09:48:51 INFO - PROCESS | 1652 | RSS: Main: 284475392 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | __start_tp_report 09:48:51 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 09:48:51 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 09:48:51 INFO - PROCESS | 1652 | |i|pagename|runs| 09:48:51 INFO - PROCESS | 1652 | |0;dojo.html;2795.3151477887923;3046.7714921380893;3379.121428428608;3412.505186747921;3432.3821712091813;5713.2287141235975;5747.942520574793;5760.337561180466;5794.217780599628;5853.648781073133;5627.296587926509;5636.351819540754;5681.659100453965;5707.3721890592105;5805.071188609823;5117.130087885069;5161;5200.349956255468;5235.738213089349;5295.31160949078;5216.973915130438;5326.227696983935;5345.278387417708;5371.382291036542;5393.379761327439;5103.438621751604;5136.280920671109;5174.534291913708;5177.637565370425;5179.792808287664;5200.349956255468;5211.635185537014;5221.921671174935;5226.817061402832;5238.580913526908;5110.361204849394;5168.870778230536;5187.403448603422;5188.610854185951;5238.266642670029;5521.503064724194;5628.0713682242385;5769.04810706233;5818.359980402195;5844.123381492767;5334.546563542103;5740.225069615632;6233.283172435183;6276.686165691697;6288.465480434169;4856.8300109495995;6267.9971204607045;6278.4035516625845;6283.08895210192;6294.0873573332065;4199.790010499493;5514.476124768141;5912.852178695567;5918.674472903988;5935.910961335583;6275.121482992385;6330.05049242608;6333.484915871643;6360.268569114611;6390.265119511223;5139.331886854759;6086.269647642312;6101.298350689639;6103.938960610426;6130.785422510191;5253.632245742761;6120.325235636551;6240.875182496325;6276.905846412307;6294.8111556653375;6010.188624535719;6081.969590152109;6111.257501106225;6116.1836049259855;6126.816195514141;6100.755969761249;6128.479079278222;6134.018557030854;6143.844938207586;6198.969005155035;4916.311716359713;4930.531599498042;4941.777620007037;4962.9007419851405;4983.227599722049;4378.452693413324;4441.0673758511075;4460.553944605514;4474.798634061475;4503.54964503547;5643.379228284885;5793.217915581343;5826.65040097587;5893.5874488785375;5905.734241959122;6276.497880169575;6294.559380843297;6298.7480500780375;6300.684965751694;6322.399372059647;5923.4668879800165;5929.407059294036;5942.910856337158;5980.030064409544;6017.06735456005;5336.359636843526;5443.945560544344;5464.907018596296;5472.015037293326;5497.065498865122;6375.936240637627;6420.935790642034;6432.324605916311;6439.9052161131785;6448.065030570541;6286.18279623646;6289.96855015722;6301.212348456443;6306.46395056407;6313.621182729051;6133.824358647991;6261.186045814197;6268;6326.462250708557;6420.069089981833;6204.7828326008375;6218.968905155445;6240.53196010292;6275.937240627535;6291.276503202191;6106.673025714385;6285.214348206474;6291.905621415774;6309.621422714652;6310.337414571404;5106;6019;6109.495762817132;6111.786087486917;6113.388661133851;5970.9701451492465;6093.482054025458;6151.723172457339;6152.723127459186;6192.8761424770355;5848.970755146197;6009.519238461;6032.487238584769;6042.456178943916;6060.363661815446;5969.910451343147;6086.60437071589;6116.0010150213275;6119.165849017961;6138.232720909887;6042.425969532887;6051.909221361771;6055.091736239599;6072.78745243932;6082.665453400105 09:48:51 INFO - PROCESS | 1652 | |1;ext.html;493.5878541417916;506.92649565812957;527.217082632291;541.3801197628716;578.3118089473529;40531;41495;41530;41569.33722651091;41629.9592510187;41222.38166427506;41834.58165418345;41846.58153418465;41959.79020104903;42069.7896510517;9447.574859131339;9448.527573621326;9524.952375238114;9619.230461563093;9621.27840411972;9525.999770024151;9540.379875308083;9604.663836765714;9632.036796320383;9716.854247186262;9521.143097121292;9527.094925982055;9590.664326748565;9633.373830700983;9656.324057315991;8863.689770858022;8952.865707014367;9594.664186753465;9637.373570717951;9648.807023859483;9431.15119639229;9488.146066853948;9504.239660827117;9600.66397676078;9601.663941762075;33031.50452743211;39552;40293;40687.796561017305;40712.796436017925;3316.718078963267;3452.188735647146;3454.0501362125365;3587.551556055493;3868.5551161616495;30024.54963175554;31405.52891706626;31946.6805331946;32303.6769632303;32930.67069329324;3279.4588892832653;3284.080457471912;3315.336932613487;3409.028426898347;3421.1447138215444;474363;505856;509232;509337;509969.9999999963;33523.82666606657;34267.485987710206;34514.82742586271;35052.474212886824;59373.703131484064;28390.432191356056;35174.94475165698;35591.82204088963;35792.64207357945;35831;14978.850211497964;15145.015573987655;15189;15205.467808626867;15230.771538426932;12767.808482872764;12859.228446293253;12904.677383065498;12925.22448653065;13025.47898084066;7859.724909628136;7870.606469676608;7879.172686867796;7920.76237712858;7943.126256111823;2889.8699558519916;3201.927354336277;3219.3078488125166;3233.4341490239112;3267.18320419895;922.7739203895088;1053.273241463403;1062.6918193723734;1088.1294964028746;1104.447776111944;30156.944506942153;30297.697023029486;30436.39127217443;31014.534781978287;31132.066038018897;1046.706922061824;1062.7661914378825;1066.4667666166918;1118.183725880112;1165.3939951225484;15802.36790528389;15843.762343564857;15966.600834978986;16028.278727457293;16231.350745970265;702337;702543;709853;712087;719473;59336;59600;59602.40397596055;59806.40193598095;59940.100898486555;1361.4003545833607;1383.8062671226037;1387.9236641984787;1394.0590101681325;1404.3189053309136;30316;30395.392092158476;30614.540781887845;31049.534256986615;31071.84464077665;44258.33612495751;50731.49268507268;51001.48998509967;51007;51084.48915510946;574732;581616.0919195378;582520;583167;584984;26917;27358.45283094367;28313.150605481867;28364.716352836207;28492.287692807844;48238.5176148234;48435.75782121067;48632;48780.756096219295;49679.50961471162;29380.78192320544;39855.60505382414;39891.40162897617;40306.041018274256;41124.38313425241;37556.81221593874;40092.59907400889;40235.99410014773;40642.59357406506;41032;33508.664913350556;39079.609203907596;39128.41307380335;39290.410643839794;40261.1947761049;30355;33977.66022339844;35113.122171945906;35367.82316088403;35625.437456255204;23858.642120367862;23879.403014924766;24948.875255623607;25497.49005019852;25851.482970340865 09:48:51 INFO - PROCESS | 1652 | |2;jquery.html;377.84130665120665;378.6705566157443;382.921501092276;394.23715111259696;397.67986770649634;19283;20444.591108177865;21223.575528489422;21317.68023479649;21430.35708928733;11786.29282243066;12150.69623259419;12328.952039076688;12346.8270514301;19801.306954256605;4691.90616187676;5393.2719082923795;5536.058869992091;5577.470140336662;5592.189132575774;3863.1694185750057;6439.710213040425;6763;6786.151731033621;6836.28219036999;5579.995600791855;5947.583669143161;6776.457883369343;6777.966110169467;6815.693293801766;5911.379305172959;5968.134620480049;5975.25309336333;5981.37195594465;6310.495160387158;5758.654480731169;5785.71071446426;5877.294724633071;5932.911006334908;5940.821775346746;12874.935625321814;12949.287789171593;13170.86829131706;13190.208587484782;13379;2042;2116.174691870172;2271.9886400568057;2643.6298918151474;3042.421939831447;8517.48895066298;10167.542460589217;10177.084062434342;10183;10234.9488252559;1786.9642607147784;1813;1872.674122776391;1885.2459016393416;1901.543629528903;131501;136103;136498.31750841282;137499;137677;11581.247218930912;11744.412779361168;11765.941170294265;11804.160279402608;11814.763704726029;12528.373581320897;14476.203808790407;14771.778423323658;14807.407703691732;14835.777463338058;7894.6842126314305;8333.416660833806;8723.738287851374;8744.737657870273;8804;8619.103797164613;8626.396152269406;8629.13708629132;8713.956430217808;8737.038925718165;4132.194222126656;4526.6152377047665;4561.133384656904;4596.10375976688;4616.561426664462;1831.9633607327778;1928.8553358497888;1958.8726732762325;1964.4106767969552;2002.9899850500653;855.4225897519274;919.2921450483091;968.6028728221395;1019.2152042927053;1045.1899777672365;21199.894000529897;21800.781992180193;21880.78119218819;21923.78076219249;21996.340109796733;929.5073610986188;941.3786900645541;956.6392846001838;986.4919566423298;1033.3644808442905;10434.68695939123;11124.443777811239;11437.828432573519;11550.826737598944;11600.6519804406;266658;525392;538491;640745;648972;144604;144626;146657;147648;155382.22308888382;406.73765421303096;437.6214574393127;438.8880835386956;450.9887252818706;451.56198487467105;8766.254868336262;8973.955130224307;10881.075108615856;10904.836427453436;11529.596464123715;48748.268775969096;55326.72336638452;55365;56121.877562449336;58833.70583147057;79390;86267.56866215629;87018.56490717505;88303;88382;8233.300169485661;8307.086220515617;8316.209960053786;8361.540115293717;8469.364797640324;11852.762944740884;13476.191428514321;13495.25776082325;13610.59168224955;13700.65748356299;11608.88391116078;11710.4730287139;11713.824292635787;11784.292942423483;11815.291082535075;10696.732581685521;10926.508307126358;11343.716407089889;11404.144689148181;11490.195686301879;11769.705757356134;11829.349385783864;11929.642110736344;11934.164608477671;12033.518659253532;8305.875411868949;8359.540225287668;8380.622871970654;8411.158884111785;8503.277221436247;11062;11622.94188529052;11698.35659038761;11882.762344752884;11935.52257909674 09:48:51 INFO - PROCESS | 1652 | |3;mootools.html;1536.423841059603;1576.5743249322682;1814.9274029038838;1901.344036307475;1914.2917120665356;7977;8534.786630334245;8656.009117902886;8919.64321427143;8920.241779448746;8635.179657932502;8644.265237454809;8770.473771573694;8782.209601135897;8792.384533082686;2335.6846825678526;2359.9410014749596;2365.254944692425;2372.4306166519996;2372.5610762009082;2319.9768002320016;2330.7319658239267;2348.7416384197722;2369.834111612188;2380.95238095238;2338.286822519131;2347.2019513365453;2364.4561750797325;2364.538914911593;2366.538524987628;2330.6037973544367;2342.7188737351544;2349.2012715676665;2359.457324815302;2359.6106642403984;2317.663938728892;2320.2596457291593;2350.811935045192;2351;2359.056377449017;8788.824223515558;8815.382923195379;8881.555922203865;8885.644574217024;8906.777330566723;5205.167173252262;5269.973650131725;5294;5346.171343441734;5364.839054828361;3463.515107884898;3490.2844916791996;3492.738044646662;3528.5412896323314;3550.5916819565823;1084.8589683341195;1093.9115579997874;1105.2760441910561;1114.8439218509416;1116.6315116011697;11499.425028748528;11707.7073073173;11727.589534366256;11738.295702257978;11751.236169649032;4537.863864084083;4578.336141259499;4753.667243292936;4767.809287628525;4792.520747925249;9936.751581210383;9950.054744799232;9952.552135153936;9973.902870684218;9986.750331241778;5313.734313284321;5317.202419637086;5332.413434522199;5339.3058902342445;5343.171808369709;4380.102079073782;4727.550882666142;4890.902181956341;4906.411230652345;4918.926216106761;3913.62820532049;3980.6218409251655;4014.9197016059516;4040.41413994975;4091.57038510958;1094.7317907112808;1206.6862615719976;1280.2830414967648;1297.1698113207556;1308.9280089595163;728.9562626242442;849.6728759427541;930.4649826349876;947.3226642950324;961.1493827962304;4567.725936443824;6035.185249991195;6084.30030546484;6119.082137679295;6229.906551401733;442.36299728391657;446.39290564831805;446.76768080597907;454.6294769762633;456.7579183032998;4033.890680063006;4130.731502452331;4165.333546632524;4171.395147703627;4203.222403855297;10363.222758293157;10474.633387831542;10746.408947507962;10750.462476876124;10754.946225268981;8985.730428087169;10635;10664.040236378763;10664.520096595672;10691.786164276671;6342.873142537123;7719.768406947801;8136.511809291462;8176.959115204386;8233.300169485541;4868.440129385024;5649.293838270216;5747.597668163188;5750.022496175577;5872.559558033079;9447.763805904908;9972.102510774064;9983.301168918106;10046.648367307109;10089.949550252202;10117.645882394081;10120.84818727705;10235.7441063974;10245.84631230547;10289.485525723834;6610.6694665267505;7334.193238743841;7551.924480755122;7637.770866874002;7697.384209263134;8488.660453582035;8494.277986371228;8521.872171917303;8583.055863855096;8597.484150950962;7486.475946683898;7620.390368770596;7639.541627502367;7653.502522336031;7716.92283077162;7336.486445948733;7374.926250737639;7415.443841712001;7541.283578060075;7563.924360756322;7082.5396349237135;7121.394681452135;7131.7503887365765;7137.643117844191;7153.463490238149;4958.429780575136;5020.920502092068;5063.746812659426;5071.442141364373;5084.491550844886;5106.872328191825;5117.897642047213;5173.92239116406;5214.113600687816;5219.243209734643 09:48:51 INFO - PROCESS | 1652 | |4;prototype.html;263.91422787594036;301.5747795608193;305.67140324151535;314.21289669378206;315.3960166281571;5171.6896986180855;5186.547766625351;5618.2415373924505;5682.516986056185;5689.800856970007;5515.862103447415;5631.099024156136;5647.463490968362;5651;5663.292088488939;3244.853981570835;3869.722991412841;4176.436181115541;4250.766207858566;4288.442502474674;3466.8266586670566;3893.5717071122153;4028.8388464461386;4219.894502637428;4275.118947663034;3772.4529943158227;3974.344233201533;4105.363668631367;4124.401961715549;4138.751674899516;3429.2455659754814;3442.638522955104;4139.2135494256145;4147.6474499667565;4222.788860556991;3579.1052236940764;3603;3606.477060826192;3611.205534782344;3612.259486805199;4050.534188568323;4464.441944756905;5391.16436952273;5394.298741163663;5454.318210223722;3724.5846578300075;4105.794710264475;4734.91097047681;4735.881602959954;4770.785314660814;4228.471441069866;4929.186684197103;5713.685747283897;5846.415358464162;5865.677387743673;3786.583475817658;3897;3923.0780766519847;3923.705722070856;3951.6487689824507;5419.485148910887;5465.808696695596;5639.436056394369;6127.019676851683;6141;3978.3435733103715;4000.7799571023293;4006.759594424344;4017.4777278954134;4019.1157945252;3536.5676900855196;3894.883153505399;4074.796260186979;4078.857239996645;4079.5104587449105;4138.8344466221615;4718.811247550059;4760.643746158949;4768.213244814636;4817.27740838877;4579.885502862455;4958.355413796184;5623.718814059281;6011.5190784737115;6021.54838387114;1317.2952470428274;1336.3318340829585;1372.4167228927665;1373.2927542315715;1377.4903285784324;696.3628280123731;753.8040109571551;827.6565225431499;830.6137645994642;848.2069265237024;4139.834406623701;4663.860084197479;4663.930041049387;4728.71627702339;4777.327935222645;4378.693491455568;4392;5092.898142037138;5159.613029022838;5218.895622087537;4311.986683129462;4542.727436353829;4660.557247061523;4677.18149323867;4725.480197178307;2898;3207.7273431758563;3225.854836532362;3228.3543291341825;3228.4350238708134;5576.860578485489;5884.352381333148;6394.840128996812;6396;6418.486521078303;4890.449339999127;5260.473952604785;5684.459976302244;6123.173371594867;6245.815303746501;6240;6293.77971770995;6315.36846315374;6337.461315788118;6343.9365606343345;5820.447057529528;5862.970685146547;6064.363241859542;6092.329843717276;6094.634321940698;4948.703077815343;5283.313169287968;5972.492338151305;5999.980003399345;6045.425684559959;5414.105063227838;6192;6316.568121273251;6371.522135839923;6381.29805721361;2969.7475714564503;3676.816159192083;3919.980400097981;3985.900352491211;4012.1574469361763;5021.774020169174;5892.440218179266;5961.254843144607;6100.6949652516305;6104.633721976696;5839.912401314069;5930.644161350333;5958.910616340671;5959;5981.521478281814;4475.6643251755595;5660.264165658438;5879.176915231957;5962.821115366546;6005.579609427298;5527.419620939743;5662.462066103713;5774.624649397776;5863.325717542537;5883.499902508334;4730.550597693214;6009.338972713085;6015.2781666200335;6019.277686677627;6034.275886893601;5403.270558474713;5689.118186681071;5795.623284486495;5879.382664820132;5915.733791979285 09:48:51 INFO - PROCESS | 1652 | |5;yui.html;739.5267029101376;757.3373298363931;777.7666699990006;806.717648822912;862.1766213266329;15299.694006119886;15761.842381576182;15863.36546538137;15943.362265509366;16041.518754437357;14369.35337909794;14540.054896431724;14548.781768273459;14549.127052376865;14604;675.2808259203956;842.911494293098;845.8519759042174;878.5519385113574;884.7080463447047;865.5326123893091;874.8294082653885;875.3609864798701;876.2814492116468;877.9868301975475;895.3240303570827;896.3859756067083;927.0173615967096;929.4330458420358;932.5197523275518;772.4013889235831;881.3962435731512;905.5789058087988;924.0805398628407;925.773185569533;657.5627207906737;682.3176823176823;688.8277930517371;689.4622194688151;689.8723736108836;14689.412423503047;14756.262186890612;14780.187089710062;14780.48268310604;14782.260886955717;14736.631584210481;14859.554213373616;14877;14889.255537223096;14953.40186392543;11926.761464770743;12158.756824863452;12277.754444911052;12415.813762793565;12471.937640311831;3831.386978083521;3852.8651497197743;4034.406409468273;4057.1885622875543;4057.377049180322;100818;109626;112007.3198902009;116256.83743162545;118634;10000.199984001263;11374.146938979444;11501.827472587918;11629.767404651859;12067.698307542381;21723.58796678211;23383.41541461477;24456.510869782505;24518.387040324134;24550.263492095266;8336.249737523653;8395.580220988926;8488.448250863674;8566.828663426697;8584.184502472255;3636.5454318210222;4442.600165985077;4541.636669066466;4580.633549316047;4629.768511574408;3664.193877346979;3708.981455092707;3773.8301776419576;3778.848846046127;3794.3739283017994;649.159338656441;658.5291516565678;671.4762485261504;681.465049935798;688.8036909480874;595.6991719181872;600.6726334147812;645.3320812958565;669.9665016749143;691.3846676457956;7788.688452461838;9410.670626528039;9654.420734755937;9751.317407781387;9756.951215243878;581.8421341530324;665.218368417108;674.5514233034977;675.6722989350161;677.8984150755023;4580.083983203373;4608.262677971508;4717.009428020086;4719.7404142772475;4740.525947405232;98895;129116.67066634835;129164;129214;132011.9573693786;120990;124057.37971310086;127694.36152819362;128138;128856;105687;111452;111708.44145779219;113781;113820;8546.401751877558;8958.193762561401;9150.542472876463;9161.175494205287;9439.480828554495;61247;63709.40726481875;63952.68023659852;65100.674496627216;65152;93109;94737.05262947282;94774.05225947929;96110;98047.50976245358;12000.339981301113;12015;12094.939525302318;12256.203346782431;12679.23924564529;13149.276789776653;13175.60473185806;13217.40521676546;13491.797623035465;13853.515126970507;12334.50661973547;12338.876611234133;12756;12756.170848894792;12784.872151278369;11832.34922079294;12282;12640.431180596712;12706.618801435972;12718.427670755023;11925.90485032688;12104;12273;12507.74984500323;12523.31121788274;10081.14310283634;10504.947475262881;10563.260571760211;10682;10794;8731.781705457415;9511.714648560554;9692.70921872345;9944.701658950244;10591.682249532527 09:48:51 INFO - PROCESS | 1652 | __end_tp_report 09:48:51 INFO - PROCESS | 1652 | __start_cc_report 09:48:51 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,432 09:48:51 INFO - PROCESS | 1652 | __end_cc_report 09:48:51 INFO - PROCESS | 1652 | __startTimestamp1467218931849__endTimestamp 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | ------- Summary: start ------- 09:48:51 INFO - PROCESS | 1652 | Number of tests: 6 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5728.44 Median:5980.03 stddev:676.87 (11.3%) stddev-sans-first:638.64 09:48:51 INFO - PROCESS | 1652 | Values: 2795.3 3046.8 3379.1 3412.5 3432.4 5713.2 5747.9 5760.3 5794.2 5853.6 5627.3 5636.4 5681.7 5707.4 5805.1 5117.1 5161.0 5200.3 5235.7 5295.3 5217.0 5326.2 5345.3 5371.4 5393.4 5103.4 5136.3 5174.5 5177.6 5179.8 5200.3 5211.6 5221.9 5226.8 5238.6 5110.4 5168.9 5187.4 5188.6 5238.3 5521.5 5628.1 5769.0 5818.4 5844.1 5334.5 5740.2 6233.3 6276.7 6288.5 4856.8 6268.0 6278.4 6283.1 6294.1 4199.8 5514.5 5912.9 5918.7 5935.9 6275.1 6330.1 6333.5 6360.3 6390.3 5139.3 6086.3 6101.3 6103.9 6130.8 5253.6 6120.3 6240.9 6276.9 6294.8 6010.2 6082.0 6111.3 6116.2 6126.8 6100.8 6128.5 6134.0 6143.8 6199.0 4916.3 4930.5 4941.8 4962.9 4983.2 4378.5 4441.1 4460.6 4474.8 4503.5 5643.4 5793.2 5826.7 5893.6 5905.7 6276.5 6294.6 6298.7 6300.7 6322.4 5923.5 5929.4 5942.9 5980.0 6017.1 5336.4 5443.9 5464.9 5472.0 5497.1 6375.9 6420.9 6432.3 6439.9 6448.1 6286.2 6290.0 6301.2 6306.5 6313.6 6133.8 6261.2 6268.0 6326.5 6420.1 6204.8 6219.0 6240.5 6275.9 6291.3 6106.7 6285.2 6291.9 6309.6 6310.3 5106.0 6019.0 6109.5 6111.8 6113.4 5971.0 6093.5 6151.7 6152.7 6192.9 5849.0 6009.5 6032.5 6042.5 6060.4 5969.9 6086.6 6116.0 6119.2 6138.2 6042.4 6051.9 6055.1 6072.8 6082.7 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:70989.26 Median:39703.80 stddev:161957.70 (407.9%) stddev-sans-first:162325.54 09:48:51 INFO - PROCESS | 1652 | Values: 493.6 506.9 527.2 541.4 578.3 40531.0 41495.0 41530.0 41569.3 41630.0 41222.4 41834.6 41846.6 41959.8 42069.8 9447.6 9448.5 9525.0 9619.2 9621.3 9526.0 9540.4 9604.7 9632.0 9716.9 9521.1 9527.1 9590.7 9633.4 9656.3 8863.7 8952.9 9594.7 9637.4 9648.8 9431.2 9488.1 9504.2 9600.7 9601.7 33031.5 39552.0 40293.0 40687.8 40712.8 3316.7 3452.2 3454.1 3587.6 3868.6 30024.5 31405.5 31946.7 32303.7 32930.7 3279.5 3284.1 3315.3 3409.0 3421.1 474363.0 505856.0 509232.0 509337.0 509970.0 33523.8 34267.5 34514.8 35052.5 59373.7 28390.4 35174.9 35591.8 35792.6 35831.0 14978.9 15145.0 15189.0 15205.5 15230.8 12767.8 12859.2 12904.7 12925.2 13025.5 7859.7 7870.6 7879.2 7920.8 7943.1 2889.9 3201.9 3219.3 3233.4 3267.2 922.8 1053.3 1062.7 1088.1 1104.4 30156.9 30297.7 30436.4 31014.5 31132.1 1046.7 1062.8 1066.5 1118.2 1165.4 15802.4 15843.8 15966.6 16028.3 16231.4 702337.0 702543.0 709853.0 712087.0 719473.0 59336.0 59600.0 59602.4 59806.4 59940.1 1361.4 1383.8 1387.9 1394.1 1404.3 30316.0 30395.4 30614.5 31049.5 31071.8 44258.3 50731.5 51001.5 51007.0 51084.5 574732.0 581616.1 582520.0 583167.0 584984.0 26917.0 27358.5 28313.2 28364.7 28492.3 48238.5 48435.8 48632.0 48780.8 49679.5 29380.8 39855.6 39891.4 40306.0 41124.4 37556.8 40092.6 40236.0 40642.6 41032.0 33508.7 39079.6 39128.4 39290.4 40261.2 30355.0 33977.7 35113.1 35367.8 35625.4 23858.6 23879.4 24948.9 25497.5 25851.5 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33662.18 Median:21960.06 stddev:92582.74 (421.6%) stddev-sans-first:92808.73 09:48:51 INFO - PROCESS | 1652 | Values: 377.8 378.7 382.9 394.2 397.7 19283.0 20444.6 21223.6 21317.7 21430.4 11786.3 12150.7 12329.0 12346.8 19801.3 4691.9 5393.3 5536.1 5577.5 5592.2 3863.2 6439.7 6763.0 6786.2 6836.3 5580.0 5947.6 6776.5 6778.0 6815.7 5911.4 5968.1 5975.3 5981.4 6310.5 5758.7 5785.7 5877.3 5932.9 5940.8 12874.9 12949.3 13170.9 13190.2 13379.0 2042.0 2116.2 2272.0 2643.6 3042.4 8517.5 10167.5 10177.1 10183.0 10234.9 1787.0 1813.0 1872.7 1885.2 1901.5 131501.0 136103.0 136498.3 137499.0 137677.0 11581.2 11744.4 11765.9 11804.2 11814.8 12528.4 14476.2 14771.8 14807.4 14835.8 7894.7 8333.4 8723.7 8744.7 8804.0 8619.1 8626.4 8629.1 8714.0 8737.0 4132.2 4526.6 4561.1 4596.1 4616.6 1832.0 1928.9 1958.9 1964.4 2003.0 855.4 919.3 968.6 1019.2 1045.2 21199.9 21800.8 21880.8 21923.8 21996.3 929.5 941.4 956.6 986.5 1033.4 10434.7 11124.4 11437.8 11550.8 11600.7 266658.0 525392.0 538491.0 640745.0 648972.0 144604.0 144626.0 146657.0 147648.0 155382.2 406.7 437.6 438.9 451.0 451.6 8766.3 8974.0 10881.1 10904.8 11529.6 48748.3 55326.7 55365.0 56121.9 58833.7 79390.0 86267.6 87018.6 88303.0 88382.0 8233.3 8307.1 8316.2 8361.5 8469.4 11852.8 13476.2 13495.3 13610.6 13700.7 11608.9 11710.5 11713.8 11784.3 11815.3 10696.7 10926.5 11343.7 11404.1 11490.2 11769.7 11829.3 11929.6 11934.2 12033.5 8305.9 8359.5 8380.6 8411.2 8503.3 11062.0 11622.9 11698.4 11882.8 11935.5 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5700.07 Median:4898.66 stddev:3203.16 (65.4%) stddev-sans-first:3196.86 09:48:51 INFO - PROCESS | 1652 | Values: 1536.4 1576.6 1814.9 1901.3 1914.3 7977.0 8534.8 8656.0 8919.6 8920.2 8635.2 8644.3 8770.5 8782.2 8792.4 2335.7 2359.9 2365.3 2372.4 2372.6 2320.0 2330.7 2348.7 2369.8 2381.0 2338.3 2347.2 2364.5 2364.5 2366.5 2330.6 2342.7 2349.2 2359.5 2359.6 2317.7 2320.3 2350.8 2351.0 2359.1 8788.8 8815.4 8881.6 8885.6 8906.8 5205.2 5270.0 5294.0 5346.2 5364.8 3463.5 3490.3 3492.7 3528.5 3550.6 1084.9 1093.9 1105.3 1114.8 1116.6 11499.4 11707.7 11727.6 11738.3 11751.2 4537.9 4578.3 4753.7 4767.8 4792.5 9936.8 9950.1 9952.6 9973.9 9986.8 5313.7 5317.2 5332.4 5339.3 5343.2 4380.1 4727.6 4890.9 4906.4 4918.9 3913.6 3980.6 4014.9 4040.4 4091.6 1094.7 1206.7 1280.3 1297.2 1308.9 729.0 849.7 930.5 947.3 961.1 4567.7 6035.2 6084.3 6119.1 6229.9 442.4 446.4 446.8 454.6 456.8 4033.9 4130.7 4165.3 4171.4 4203.2 10363.2 10474.6 10746.4 10750.5 10754.9 8985.7 10635.0 10664.0 10664.5 10691.8 6342.9 7719.8 8136.5 8177.0 8233.3 4868.4 5649.3 5747.6 5750.0 5872.6 9447.8 9972.1 9983.3 10046.6 10089.9 10117.6 10120.8 10235.7 10245.8 10289.5 6610.7 7334.2 7551.9 7637.8 7697.4 8488.7 8494.3 8521.9 8583.1 8597.5 7486.5 7620.4 7639.5 7653.5 7716.9 7336.5 7374.9 7415.4 7541.3 7563.9 7082.5 7121.4 7131.8 7137.6 7153.5 4958.4 5020.9 5063.7 5071.4 5084.5 5106.9 5117.9 5173.9 5214.1 5219.2 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4629.86 Median:4953.53 stddev:1482.35 (29.9%) stddev-sans-first:1449.84 09:48:51 INFO - PROCESS | 1652 | Values: 263.9 301.6 305.7 314.2 315.4 5171.7 5186.5 5618.2 5682.5 5689.8 5515.9 5631.1 5647.5 5651.0 5663.3 3244.9 3869.7 4176.4 4250.8 4288.4 3466.8 3893.6 4028.8 4219.9 4275.1 3772.5 3974.3 4105.4 4124.4 4138.8 3429.2 3442.6 4139.2 4147.6 4222.8 3579.1 3603.0 3606.5 3611.2 3612.3 4050.5 4464.4 5391.2 5394.3 5454.3 3724.6 4105.8 4734.9 4735.9 4770.8 4228.5 4929.2 5713.7 5846.4 5865.7 3786.6 3897.0 3923.1 3923.7 3951.6 5419.5 5465.8 5639.4 6127.0 6141.0 3978.3 4000.8 4006.8 4017.5 4019.1 3536.6 3894.9 4074.8 4078.9 4079.5 4138.8 4718.8 4760.6 4768.2 4817.3 4579.9 4958.4 5623.7 6011.5 6021.5 1317.3 1336.3 1372.4 1373.3 1377.5 696.4 753.8 827.7 830.6 848.2 4139.8 4663.9 4663.9 4728.7 4777.3 4378.7 4392.0 5092.9 5159.6 5218.9 4312.0 4542.7 4660.6 4677.2 4725.5 2898.0 3207.7 3225.9 3228.4 3228.4 5576.9 5884.4 6394.8 6396.0 6418.5 4890.4 5260.5 5684.5 6123.2 6245.8 6240.0 6293.8 6315.4 6337.5 6343.9 5820.4 5863.0 6064.4 6092.3 6094.6 4948.7 5283.3 5972.5 6000.0 6045.4 5414.1 6192.0 6316.6 6371.5 6381.3 2969.7 3676.8 3920.0 3985.9 4012.2 5021.8 5892.4 5961.3 6100.7 6104.6 5839.9 5930.6 5958.9 5959.0 5981.5 4475.7 5660.3 5879.2 5962.8 6005.6 5527.4 5662.5 5774.6 5863.3 5883.5 4730.6 6009.3 6015.3 6019.3 6034.3 5403.3 5689.1 5795.6 5879.4 5915.7 09:48:51 INFO - PROCESS | 1652 | 09:48:51 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24232.62 Median:3812.88 stddev:37842.81 (992.5%) stddev-sans-first:37907.86 09:48:51 INFO - PROCESS | 1652 | Values: 739.5 757.3 777.8 806.7 862.2 15299.7 15761.8 15863.4 15943.4 16041.5 14369.4 14540.1 14548.8 14549.1 14604.0 675.3 842.9 845.9 878.6 884.7 865.5 874.8 875.4 876.3 878.0 895.3 896.4 927.0 929.4 932.5 772.4 881.4 905.6 924.1 925.8 657.6 682.3 688.8 689.5 689.9 14689.4 14756.3 14780.2 14780.5 14782.3 14736.6 14859.6 14877.0 14889.3 14953.4 11926.8 12158.8 12277.8 12415.8 12471.9 3831.4 3852.9 4034.4 4057.2 4057.4 100818.0 109626.0 112007.3 116256.8 118634.0 10000.2 11374.1 11501.8 11629.8 12067.7 21723.6 23383.4 24456.5 24518.4 24550.3 8336.2 8395.6 8488.4 8566.8 8584.2 3636.5 4442.6 4541.6 4580.6 4629.8 3664.2 3709.0 3773.8 3778.8 3794.4 649.2 658.5 671.5 681.5 688.8 595.7 600.7 645.3 670.0 691.4 7788.7 9410.7 9654.4 9751.3 9757.0 581.8 665.2 674.6 675.7 677.9 4580.1 4608.3 4717.0 4719.7 4740.5 98895.0 129116.7 129164.0 129214.0 132012.0 120990.0 124057.4 127694.4 128138.0 128856.0 105687.0 111452.0 111708.4 113781.0 113820.0 8546.4 8958.2 9150.5 9161.2 9439.5 61247.0 63709.4 63952.7 65100.7 65152.0 93109.0 94737.1 94774.1 96110.0 98047.5 12000.3 12015.0 12094.9 12256.2 12679.2 13149.3 13175.6 13217.4 13491.8 13853.5 12334.5 12338.9 12756.0 12756.2 12784.9 11832.3 12282.0 12640.4 12706.6 12718.4 11925.9 12104.0 12273.0 12507.7 12523.3 10081.1 10504.9 10563.3 10682.0 10794.0 8731.8 9511.7 9692.7 9944.7 10591.7 09:48:51 INFO - PROCESS | 1652 | -------- Summary: end -------- 09:48:51 INFO - PROCESS | 1652 | 09:48:52 INFO - TEST-INFO | 1652: exit 0 09:48:52 INFO - TEST-OK | dromaeo_css | took 1111966ms 09:48:52 INFO - TEST-START | kraken 09:48:52 INFO - operating with platform_type : mac_ 09:48:52 INFO - Initialising browser for kraken test... 09:48:52 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmpupKPGp/profile http://localhost:49274/getInfo.html) 09:48:55 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 09:48:55 INFO - PROCESS | 1663 | colorDepth:24 09:48:55 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 09:48:55 INFO - PROCESS | 1663 | __metrics 09:48:55 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:48:55 INFO - TEST-INFO | 1663: exit 0 09:48:55 INFO - Browser initialized. 09:48:55 INFO - Running cycle 1/1 for kraken test... 09:48:55 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmpupKPGp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:07 INFO - PROCESS | 1665 | RSS: Main: 255918080 09:49:07 INFO - PROCESS | 1665 | 09:49:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:11 INFO - PROCESS | 1665 | RSS: Main: 268742656 09:49:11 INFO - PROCESS | 1665 | 09:49:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 09:49:14 INFO - PROCESS | 1665 | RSS: Main: 272867328 09:49:14 INFO - PROCESS | 1665 | 09:49:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 09:49:18 INFO - PROCESS | 1665 | RSS: Main: 273166336 09:49:18 INFO - PROCESS | 1665 | 09:49:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 09:49:21 INFO - PROCESS | 1665 | RSS: Main: 274083840 09:49:21 INFO - PROCESS | 1665 | 09:49:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:24 INFO - PROCESS | 1665 | RSS: Main: 274677760 09:49:24 INFO - PROCESS | 1665 | 09:49:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:27 INFO - PROCESS | 1665 | RSS: Main: 275193856 09:49:27 INFO - PROCESS | 1665 | 09:49:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:31 INFO - PROCESS | 1665 | RSS: Main: 275337216 09:49:31 INFO - PROCESS | 1665 | 09:49:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 09:49:35 INFO - PROCESS | 1665 | RSS: Main: 275464192 09:49:35 INFO - PROCESS | 1665 | 09:49:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:49:37 INFO - PROCESS | 1665 | RSS: Main: 275279872 09:49:37 INFO - PROCESS | 1665 | 09:49:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:49:39 INFO - PROCESS | 1665 | RSS: Main: 275021824 09:49:39 INFO - PROCESS | 1665 | 09:49:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:49:42 INFO - PROCESS | 1665 | RSS: Main: 275394560 09:49:42 INFO - PROCESS | 1665 | 09:49:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:49:46 INFO - PROCESS | 1665 | RSS: Main: 275668992 09:49:46 INFO - PROCESS | 1665 | 09:49:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:49:49 INFO - PROCESS | 1665 | RSS: Main: 275439616 09:49:49 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 09:49:51 INFO - PROCESS | 1665 | RSS: Main: 276295680 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | __start_tp_report 09:49:51 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 09:49:51 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 09:49:51 INFO - PROCESS | 1665 | |i|pagename|runs| 09:49:51 INFO - PROCESS | 1665 | |0;ai-astar;103;117;108;117;117;118;113;117;138;174 09:49:51 INFO - PROCESS | 1665 | |1;audio-beat-detection;142;108;134;156;111;135;148;144;179;109 09:49:51 INFO - PROCESS | 1665 | |2;audio-dft;190;197;194;205;235;245;272;263;197;192 09:49:51 INFO - PROCESS | 1665 | |3;audio-fft;68;83;77;145;56;59;58;57;134;48 09:49:51 INFO - PROCESS | 1665 | |4;audio-oscillator;69;74;133;102;98;80;149;102;107;142 09:49:51 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;90;79;76;110;135;111;90;99;82;82 09:49:51 INFO - PROCESS | 1665 | |6;imaging-darkroom;95;95;95;99;96;94;154;128;95;127 09:49:51 INFO - PROCESS | 1665 | |7;imaging-desaturate;122;117;82;151;144;106;76;76;130;91 09:49:51 INFO - PROCESS | 1665 | |8;json-parse-financial;56;57;54;57;58;58;57;56;55;57 09:49:51 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;63;69;65;74;78;85;72;70;71;70 09:49:51 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;83;91;90;85;84;84;82;84;83;83 09:49:51 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;140;142;152;154;151;158;167;148;196;144 09:49:51 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;156;224;228;209;164;180;230;172;167;165 09:49:51 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;66;88;85;86;90;67;71;81;74;66 09:49:51 INFO - PROCESS | 1665 | __end_tp_report 09:49:51 INFO - PROCESS | 1665 | __start_cc_report 09:49:51 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1138 09:49:51 INFO - PROCESS | 1665 | __end_cc_report 09:49:51 INFO - PROCESS | 1665 | __startTimestamp1467218991943__endTimestamp 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | ------- Summary: start ------- 09:49:51 INFO - PROCESS | 1665 | Number of tests: 14 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:122.20 Median:117.00 stddev:20.31 (17.4%) stddev-sans-first:20.32 09:49:51 INFO - PROCESS | 1665 | Values: 103.0 117.0 108.0 117.0 117.0 118.0 113.0 117.0 138.0 174.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:143.00 stddev:22.69 (15.9%) stddev-sans-first:23.98 09:49:51 INFO - PROCESS | 1665 | Values: 142.0 108.0 134.0 156.0 111.0 135.0 148.0 144.0 179.0 109.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:219.00 Median:220.00 stddev:31.69 (14.4%) stddev-sans-first:31.82 09:49:51 INFO - PROCESS | 1665 | Values: 190.0 197.0 194.0 205.0 235.0 245.0 272.0 263.0 197.0 192.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:78.50 Median:58.50 stddev:33.89 (57.9%) stddev-sans-first:35.73 09:49:51 INFO - PROCESS | 1665 | Values: 68.0 83.0 77.0 145.0 56.0 59.0 58.0 57.0 134.0 48.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:109.00 stddev:27.97 (25.7%) stddev-sans-first:26.34 09:49:51 INFO - PROCESS | 1665 | Values: 69.0 74.0 133.0 102.0 98.0 80.0 149.0 102.0 107.0 142.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:95.40 Median:82.00 stddev:18.56 (22.6%) stddev-sans-first:19.58 09:49:51 INFO - PROCESS | 1665 | Values: 90.0 79.0 76.0 110.0 135.0 111.0 90.0 99.0 82.0 82.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:107.80 Median:95.00 stddev:21.01 (22.1%) stddev-sans-first:21.77 09:49:51 INFO - PROCESS | 1665 | Values: 95.0 95.0 95.0 99.0 96.0 94.0 154.0 128.0 95.0 127.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:109.50 Median:113.50 stddev:27.69 (24.4%) stddev-sans-first:29.00 09:49:51 INFO - PROCESS | 1665 | Values: 122.0 117.0 82.0 151.0 144.0 106.0 76.0 76.0 130.0 91.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.27 (2.2%) stddev-sans-first:1.33 09:49:51 INFO - PROCESS | 1665 | Values: 56.0 57.0 54.0 57.0 58.0 58.0 57.0 56.0 55.0 57.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:6.29 (8.8%) stddev-sans-first:5.83 09:49:51 INFO - PROCESS | 1665 | Values: 63.0 69.0 65.0 74.0 78.0 85.0 72.0 70.0 71.0 70.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.07 (3.7%) stddev-sans-first:3.18 09:49:51 INFO - PROCESS | 1665 | Values: 83.0 91.0 90.0 85.0 84.0 84.0 82.0 84.0 83.0 83.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:153.00 stddev:16.41 (10.7%) stddev-sans-first:16.46 09:49:51 INFO - PROCESS | 1665 | Values: 140.0 142.0 152.0 154.0 151.0 158.0 167.0 148.0 196.0 144.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.50 Median:194.50 stddev:29.76 (15.3%) stddev-sans-first:28.99 09:49:51 INFO - PROCESS | 1665 | Values: 156.0 224.0 228.0 209.0 164.0 180.0 230.0 172.0 167.0 165.0 09:49:51 INFO - PROCESS | 1665 | 09:49:51 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:83.00 stddev:9.64 (11.6%) stddev-sans-first:9.30 09:49:51 INFO - PROCESS | 1665 | Values: 66.0 88.0 85.0 86.0 90.0 67.0 71.0 81.0 74.0 66.0 09:49:51 INFO - PROCESS | 1665 | -------- Summary: end -------- 09:49:51 INFO - PROCESS | 1665 | 09:49:52 INFO - TEST-INFO | 1665: exit 0 09:49:52 INFO - TEST-OK | kraken | took 60424ms 09:49:52 INFO - SUITE-END | took 1172s 09:49:53 INFO - Completed test suite (00:19:32) 09:49:53 INFO - javascript benchmark 09:49:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7225.625622846005, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2795.3151477887923, 3046.7714921380893, 3379.121428428608, 3412.505186747921, 3432.3821712091813, 5713.2287141235975, 5747.942520574793, 5760.337561180466, 5794.217780599628, 5853.648781073133, 5627.296587926509, 5636.351819540754, 5681.659100453965, 5707.3721890592105, 5805.071188609823, 5117.130087885069, 5161.0, 5200.349956255468, 5235.738213089349, 5295.31160949078, 5216.973915130438, 5326.227696983935, 5345.278387417708, 5371.382291036542, 5393.379761327439, 5103.438621751604, 5136.280920671109, 5174.534291913708, 5177.637565370425, 5179.792808287664, 5200.349956255468, 5211.635185537014, 5221.921671174935, 5226.817061402832, 5238.580913526908, 5110.361204849394, 5168.870778230536, 5187.403448603422, 5188.610854185951, 5238.266642670029, 5521.503064724194, 5628.0713682242385, 5769.04810706233, 5818.359980402195, 5844.123381492767, 5334.546563542103, 5740.225069615632, 6233.283172435183, 6276.686165691697, 6288.465480434169, 4856.8300109495995, 6267.9971204607045, 6278.4035516625845, 6283.08895210192, 6294.0873573332065, 4199.790010499493, 5514.476124768141, 5912.852178695567, 5918.674472903988, 5935.910961335583, 6275.121482992385, 6330.05049242608, 6333.484915871643, 6360.268569114611, 6390.265119511223, 5139.331886854759, 6086.269647642312, 6101.298350689639, 6103.938960610426, 6130.785422510191, 5253.632245742761, 6120.325235636551, 6240.875182496325, 6276.905846412307, 6294.8111556653375, 6010.188624535719, 6081.969590152109, 6111.257501106225, 6116.1836049259855, 6126.816195514141, 6100.755969761249, 6128.479079278222, 6134.018557030854, 6143.844938207586, 6198.969005155035, 4916.311716359713, 4930.531599498042, 4941.777620007037, 4962.9007419851405, 4983.227599722049, 4378.452693413324, 4441.0673758511075, 4460.553944605514, 4474.798634061475, 4503.54964503547, 5643.379228284885, 5793.217915581343, 5826.65040097587, 5893.5874488785375, 5905.734241959122, 6276.497880169575, 6294.559380843297, 6298.7480500780375, 6300.684965751694, 6322.399372059647, 5923.4668879800165, 5929.407059294036, 5942.910856337158, 5980.030064409544, 6017.06735456005, 5336.359636843526, 5443.945560544344, 5464.907018596296, 5472.015037293326, 5497.065498865122, 6375.936240637627, 6420.935790642034, 6432.324605916311, 6439.9052161131785, 6448.065030570541, 6286.18279623646, 6289.96855015722, 6301.212348456443, 6306.46395056407, 6313.621182729051, 6133.824358647991, 6261.186045814197, 6268.0, 6326.462250708557, 6420.069089981833, 6204.7828326008375, 6218.968905155445, 6240.53196010292, 6275.937240627535, 6291.276503202191, 6106.673025714385, 6285.214348206474, 6291.905621415774, 6309.621422714652, 6310.337414571404, 5106.0, 6019.0, 6109.495762817132, 6111.786087486917, 6113.388661133851, 5970.9701451492465, 6093.482054025458, 6151.723172457339, 6152.723127459186, 6192.8761424770355, 5848.970755146197, 6009.519238461, 6032.487238584769, 6042.456178943916, 6060.363661815446, 5969.910451343147, 6086.60437071589, 6116.0010150213275, 6119.165849017961, 6138.232720909887, 6042.425969532887, 6051.909221361771, 6055.091736239599, 6072.78745243932, 6082.665453400105], "value": 5684.81367455628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.5878541417916, 506.92649565812957, 527.217082632291, 541.3801197628716, 578.3118089473529, 40531.0, 41495.0, 41530.0, 41569.33722651091, 41629.9592510187, 41222.38166427506, 41834.58165418345, 41846.58153418465, 41959.79020104903, 42069.7896510517, 9447.574859131339, 9448.527573621326, 9524.952375238114, 9619.230461563093, 9621.27840411972, 9525.999770024151, 9540.379875308083, 9604.663836765714, 9632.036796320383, 9716.854247186262, 9521.143097121292, 9527.094925982055, 9590.664326748565, 9633.373830700983, 9656.324057315991, 8863.689770858022, 8952.865707014367, 9594.664186753465, 9637.373570717951, 9648.807023859483, 9431.15119639229, 9488.146066853948, 9504.239660827117, 9600.66397676078, 9601.663941762075, 33031.50452743211, 39552.0, 40293.0, 40687.796561017305, 40712.796436017925, 3316.718078963267, 3452.188735647146, 3454.0501362125365, 3587.551556055493, 3868.5551161616495, 30024.54963175554, 31405.52891706626, 31946.6805331946, 32303.6769632303, 32930.67069329324, 3279.4588892832653, 3284.080457471912, 3315.336932613487, 3409.028426898347, 3421.1447138215444, 474363.0, 505856.0, 509232.0, 509337.0, 509969.9999999963, 33523.82666606657, 34267.485987710206, 34514.82742586271, 35052.474212886824, 59373.703131484064, 28390.432191356056, 35174.94475165698, 35591.82204088963, 35792.64207357945, 35831.0, 14978.850211497964, 15145.015573987655, 15189.0, 15205.467808626867, 15230.771538426932, 12767.808482872764, 12859.228446293253, 12904.677383065498, 12925.22448653065, 13025.47898084066, 7859.724909628136, 7870.606469676608, 7879.172686867796, 7920.76237712858, 7943.126256111823, 2889.8699558519916, 3201.927354336277, 3219.3078488125166, 3233.4341490239112, 3267.18320419895, 922.7739203895088, 1053.273241463403, 1062.6918193723734, 1088.1294964028746, 1104.447776111944, 30156.944506942153, 30297.697023029486, 30436.39127217443, 31014.534781978287, 31132.066038018897, 1046.706922061824, 1062.7661914378825, 1066.4667666166918, 1118.183725880112, 1165.3939951225484, 15802.36790528389, 15843.762343564857, 15966.600834978986, 16028.278727457293, 16231.350745970265, 702337.0, 702543.0, 709853.0, 712087.0, 719473.0, 59336.0, 59600.0, 59602.40397596055, 59806.40193598095, 59940.100898486555, 1361.4003545833607, 1383.8062671226037, 1387.9236641984787, 1394.0590101681325, 1404.3189053309136, 30316.0, 30395.392092158476, 30614.540781887845, 31049.534256986615, 31071.84464077665, 44258.33612495751, 50731.49268507268, 51001.48998509967, 51007.0, 51084.48915510946, 574732.0, 581616.0919195378, 582520.0, 583167.0, 584984.0, 26917.0, 27358.45283094367, 28313.150605481867, 28364.716352836207, 28492.287692807844, 48238.5176148234, 48435.75782121067, 48632.0, 48780.756096219295, 49679.50961471162, 29380.78192320544, 39855.60505382414, 39891.40162897617, 40306.041018274256, 41124.38313425241, 37556.81221593874, 40092.59907400889, 40235.99410014773, 40642.59357406506, 41032.0, 33508.664913350556, 39079.609203907596, 39128.41307380335, 39290.410643839794, 40261.1947761049, 30355.0, 33977.66022339844, 35113.122171945906, 35367.82316088403, 35625.437456255204, 23858.642120367862, 23879.403014924766, 24948.875255623607, 25497.49005019852, 25851.482970340865], "value": 18745.442329280046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.84130665120665, 378.6705566157443, 382.921501092276, 394.23715111259696, 397.67986770649634, 19283.0, 20444.591108177865, 21223.575528489422, 21317.68023479649, 21430.35708928733, 11786.29282243066, 12150.69623259419, 12328.952039076688, 12346.8270514301, 19801.306954256605, 4691.90616187676, 5393.2719082923795, 5536.058869992091, 5577.470140336662, 5592.189132575774, 3863.1694185750057, 6439.710213040425, 6763.0, 6786.151731033621, 6836.28219036999, 5579.995600791855, 5947.583669143161, 6776.457883369343, 6777.966110169467, 6815.693293801766, 5911.379305172959, 5968.134620480049, 5975.25309336333, 5981.37195594465, 6310.495160387158, 5758.654480731169, 5785.71071446426, 5877.294724633071, 5932.911006334908, 5940.821775346746, 12874.935625321814, 12949.287789171593, 13170.86829131706, 13190.208587484782, 13379.0, 2042.0, 2116.174691870172, 2271.9886400568057, 2643.6298918151474, 3042.421939831447, 8517.48895066298, 10167.542460589217, 10177.084062434342, 10183.0, 10234.9488252559, 1786.9642607147784, 1813.0, 1872.674122776391, 1885.2459016393416, 1901.543629528903, 131501.0, 136103.0, 136498.31750841282, 137499.0, 137677.0, 11581.247218930912, 11744.412779361168, 11765.941170294265, 11804.160279402608, 11814.763704726029, 12528.373581320897, 14476.203808790407, 14771.778423323658, 14807.407703691732, 14835.777463338058, 7894.6842126314305, 8333.416660833806, 8723.738287851374, 8744.737657870273, 8804.0, 8619.103797164613, 8626.396152269406, 8629.13708629132, 8713.956430217808, 8737.038925718165, 4132.194222126656, 4526.6152377047665, 4561.133384656904, 4596.10375976688, 4616.561426664462, 1831.9633607327778, 1928.8553358497888, 1958.8726732762325, 1964.4106767969552, 2002.9899850500653, 855.4225897519274, 919.2921450483091, 968.6028728221395, 1019.2152042927053, 1045.1899777672365, 21199.894000529897, 21800.781992180193, 21880.78119218819, 21923.78076219249, 21996.340109796733, 929.5073610986188, 941.3786900645541, 956.6392846001838, 986.4919566423298, 1033.3644808442905, 10434.68695939123, 11124.443777811239, 11437.828432573519, 11550.826737598944, 11600.6519804406, 266658.0, 525392.0, 538491.0, 640745.0, 648972.0, 144604.0, 144626.0, 146657.0, 147648.0, 155382.22308888382, 406.73765421303096, 437.6214574393127, 438.8880835386956, 450.9887252818706, 451.56198487467105, 8766.254868336262, 8973.955130224307, 10881.075108615856, 10904.836427453436, 11529.596464123715, 48748.268775969096, 55326.72336638452, 55365.0, 56121.877562449336, 58833.70583147057, 79390.0, 86267.56866215629, 87018.56490717505, 88303.0, 88382.0, 8233.300169485661, 8307.086220515617, 8316.209960053786, 8361.540115293717, 8469.364797640324, 11852.762944740884, 13476.191428514321, 13495.25776082325, 13610.59168224955, 13700.65748356299, 11608.88391116078, 11710.4730287139, 11713.824292635787, 11784.292942423483, 11815.291082535075, 10696.732581685521, 10926.508307126358, 11343.716407089889, 11404.144689148181, 11490.195686301879, 11769.705757356134, 11829.349385783864, 11929.642110736344, 11934.164608477671, 12033.518659253532, 8305.875411868949, 8359.540225287668, 8380.622871970654, 8411.158884111785, 8503.277221436247, 11062.0, 11622.94188529052, 11698.35659038761, 11882.762344752884, 11935.52257909674], "value": 9163.956598169543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.423841059603, 1576.5743249322682, 1814.9274029038838, 1901.344036307475, 1914.2917120665356, 7977.0, 8534.786630334245, 8656.009117902886, 8919.64321427143, 8920.241779448746, 8635.179657932502, 8644.265237454809, 8770.473771573694, 8782.209601135897, 8792.384533082686, 2335.6846825678526, 2359.9410014749596, 2365.254944692425, 2372.4306166519996, 2372.5610762009082, 2319.9768002320016, 2330.7319658239267, 2348.7416384197722, 2369.834111612188, 2380.95238095238, 2338.286822519131, 2347.2019513365453, 2364.4561750797325, 2364.538914911593, 2366.538524987628, 2330.6037973544367, 2342.7188737351544, 2349.2012715676665, 2359.457324815302, 2359.6106642403984, 2317.663938728892, 2320.2596457291593, 2350.811935045192, 2351.0, 2359.056377449017, 8788.824223515558, 8815.382923195379, 8881.555922203865, 8885.644574217024, 8906.777330566723, 5205.167173252262, 5269.973650131725, 5294.0, 5346.171343441734, 5364.839054828361, 3463.515107884898, 3490.2844916791996, 3492.738044646662, 3528.5412896323314, 3550.5916819565823, 1084.8589683341195, 1093.9115579997874, 1105.2760441910561, 1114.8439218509416, 1116.6315116011697, 11499.425028748528, 11707.7073073173, 11727.589534366256, 11738.295702257978, 11751.236169649032, 4537.863864084083, 4578.336141259499, 4753.667243292936, 4767.809287628525, 4792.520747925249, 9936.751581210383, 9950.054744799232, 9952.552135153936, 9973.902870684218, 9986.750331241778, 5313.734313284321, 5317.202419637086, 5332.413434522199, 5339.3058902342445, 5343.171808369709, 4380.102079073782, 4727.550882666142, 4890.902181956341, 4906.411230652345, 4918.926216106761, 3913.62820532049, 3980.6218409251655, 4014.9197016059516, 4040.41413994975, 4091.57038510958, 1094.7317907112808, 1206.6862615719976, 1280.2830414967648, 1297.1698113207556, 1308.9280089595163, 728.9562626242442, 849.6728759427541, 930.4649826349876, 947.3226642950324, 961.1493827962304, 4567.725936443824, 6035.185249991195, 6084.30030546484, 6119.082137679295, 6229.906551401733, 442.36299728391657, 446.39290564831805, 446.76768080597907, 454.6294769762633, 456.7579183032998, 4033.890680063006, 4130.731502452331, 4165.333546632524, 4171.395147703627, 4203.222403855297, 10363.222758293157, 10474.633387831542, 10746.408947507962, 10750.462476876124, 10754.946225268981, 8985.730428087169, 10635.0, 10664.040236378763, 10664.520096595672, 10691.786164276671, 6342.873142537123, 7719.768406947801, 8136.511809291462, 8176.959115204386, 8233.300169485541, 4868.440129385024, 5649.293838270216, 5747.597668163188, 5750.022496175577, 5872.559558033079, 9447.763805904908, 9972.102510774064, 9983.301168918106, 10046.648367307109, 10089.949550252202, 10117.645882394081, 10120.84818727705, 10235.7441063974, 10245.84631230547, 10289.485525723834, 6610.6694665267505, 7334.193238743841, 7551.924480755122, 7637.770866874002, 7697.384209263134, 8488.660453582035, 8494.277986371228, 8521.872171917303, 8583.055863855096, 8597.484150950962, 7486.475946683898, 7620.390368770596, 7639.541627502367, 7653.502522336031, 7716.92283077162, 7336.486445948733, 7374.926250737639, 7415.443841712001, 7541.283578060075, 7563.924360756322, 7082.5396349237135, 7121.394681452135, 7131.7503887365765, 7137.643117844191, 7153.463490238149, 4958.429780575136, 5020.920502092068, 5063.746812659426, 5071.442141364373, 5084.491550844886, 5106.872328191825, 5117.897642047213, 5173.92239116406, 5214.113600687816, 5219.243209734643], "value": 4510.277927293422, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.91422787594036, 301.5747795608193, 305.67140324151535, 314.21289669378206, 315.3960166281571, 5171.6896986180855, 5186.547766625351, 5618.2415373924505, 5682.516986056185, 5689.800856970007, 5515.862103447415, 5631.099024156136, 5647.463490968362, 5651.0, 5663.292088488939, 3244.853981570835, 3869.722991412841, 4176.436181115541, 4250.766207858566, 4288.442502474674, 3466.8266586670566, 3893.5717071122153, 4028.8388464461386, 4219.894502637428, 4275.118947663034, 3772.4529943158227, 3974.344233201533, 4105.363668631367, 4124.401961715549, 4138.751674899516, 3429.2455659754814, 3442.638522955104, 4139.2135494256145, 4147.6474499667565, 4222.788860556991, 3579.1052236940764, 3603.0, 3606.477060826192, 3611.205534782344, 3612.259486805199, 4050.534188568323, 4464.441944756905, 5391.16436952273, 5394.298741163663, 5454.318210223722, 3724.5846578300075, 4105.794710264475, 4734.91097047681, 4735.881602959954, 4770.785314660814, 4228.471441069866, 4929.186684197103, 5713.685747283897, 5846.415358464162, 5865.677387743673, 3786.583475817658, 3897.0, 3923.0780766519847, 3923.705722070856, 3951.6487689824507, 5419.485148910887, 5465.808696695596, 5639.436056394369, 6127.019676851683, 6141.0, 3978.3435733103715, 4000.7799571023293, 4006.759594424344, 4017.4777278954134, 4019.1157945252, 3536.5676900855196, 3894.883153505399, 4074.796260186979, 4078.857239996645, 4079.5104587449105, 4138.8344466221615, 4718.811247550059, 4760.643746158949, 4768.213244814636, 4817.27740838877, 4579.885502862455, 4958.355413796184, 5623.718814059281, 6011.5190784737115, 6021.54838387114, 1317.2952470428274, 1336.3318340829585, 1372.4167228927665, 1373.2927542315715, 1377.4903285784324, 696.3628280123731, 753.8040109571551, 827.6565225431499, 830.6137645994642, 848.2069265237024, 4139.834406623701, 4663.860084197479, 4663.930041049387, 4728.71627702339, 4777.327935222645, 4378.693491455568, 4392.0, 5092.898142037138, 5159.613029022838, 5218.895622087537, 4311.986683129462, 4542.727436353829, 4660.557247061523, 4677.18149323867, 4725.480197178307, 2898.0, 3207.7273431758563, 3225.854836532362, 3228.3543291341825, 3228.4350238708134, 5576.860578485489, 5884.352381333148, 6394.840128996812, 6396.0, 6418.486521078303, 4890.449339999127, 5260.473952604785, 5684.459976302244, 6123.173371594867, 6245.815303746501, 6240.0, 6293.77971770995, 6315.36846315374, 6337.461315788118, 6343.9365606343345, 5820.447057529528, 5862.970685146547, 6064.363241859542, 6092.329843717276, 6094.634321940698, 4948.703077815343, 5283.313169287968, 5972.492338151305, 5999.980003399345, 6045.425684559959, 5414.105063227838, 6192.0, 6316.568121273251, 6371.522135839923, 6381.29805721361, 2969.7475714564503, 3676.816159192083, 3919.980400097981, 3985.900352491211, 4012.1574469361763, 5021.774020169174, 5892.440218179266, 5961.254843144607, 6100.6949652516305, 6104.633721976696, 5839.912401314069, 5930.644161350333, 5958.910616340671, 5959.0, 5981.521478281814, 4475.6643251755595, 5660.264165658438, 5879.176915231957, 5962.821115366546, 6005.579609427298, 5527.419620939743, 5662.462066103713, 5774.624649397776, 5863.325717542537, 5883.499902508334, 4730.550597693214, 6009.338972713085, 6015.2781666200335, 6019.277686677627, 6034.275886893601, 5403.270558474713, 5689.118186681071, 5795.623284486495, 5879.382664820132, 5915.733791979285], "value": 4152.31116812539, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.5267029101376, 757.3373298363931, 777.7666699990006, 806.717648822912, 862.1766213266329, 15299.694006119886, 15761.842381576182, 15863.36546538137, 15943.362265509366, 16041.518754437357, 14369.35337909794, 14540.054896431724, 14548.781768273459, 14549.127052376865, 14604.0, 675.2808259203956, 842.911494293098, 845.8519759042174, 878.5519385113574, 884.7080463447047, 865.5326123893091, 874.8294082653885, 875.3609864798701, 876.2814492116468, 877.9868301975475, 895.3240303570827, 896.3859756067083, 927.0173615967096, 929.4330458420358, 932.5197523275518, 772.4013889235831, 881.3962435731512, 905.5789058087988, 924.0805398628407, 925.773185569533, 657.5627207906737, 682.3176823176823, 688.8277930517371, 689.4622194688151, 689.8723736108836, 14689.412423503047, 14756.262186890612, 14780.187089710062, 14780.48268310604, 14782.260886955717, 14736.631584210481, 14859.554213373616, 14877.0, 14889.255537223096, 14953.40186392543, 11926.761464770743, 12158.756824863452, 12277.754444911052, 12415.813762793565, 12471.937640311831, 3831.386978083521, 3852.8651497197743, 4034.406409468273, 4057.1885622875543, 4057.377049180322, 100818.0, 109626.0, 112007.3198902009, 116256.83743162545, 118634.0, 10000.199984001263, 11374.146938979444, 11501.827472587918, 11629.767404651859, 12067.698307542381, 21723.58796678211, 23383.41541461477, 24456.510869782505, 24518.387040324134, 24550.263492095266, 8336.249737523653, 8395.580220988926, 8488.448250863674, 8566.828663426697, 8584.184502472255, 3636.5454318210222, 4442.600165985077, 4541.636669066466, 4580.633549316047, 4629.768511574408, 3664.193877346979, 3708.981455092707, 3773.8301776419576, 3778.848846046127, 3794.3739283017994, 649.159338656441, 658.5291516565678, 671.4762485261504, 681.465049935798, 688.8036909480874, 595.6991719181872, 600.6726334147812, 645.3320812958565, 669.9665016749143, 691.3846676457956, 7788.688452461838, 9410.670626528039, 9654.420734755937, 9751.317407781387, 9756.951215243878, 581.8421341530324, 665.218368417108, 674.5514233034977, 675.6722989350161, 677.8984150755023, 4580.083983203373, 4608.262677971508, 4717.009428020086, 4719.7404142772475, 4740.525947405232, 98895.0, 129116.67066634835, 129164.0, 129214.0, 132011.9573693786, 120990.0, 124057.37971310086, 127694.36152819362, 128138.0, 128856.0, 105687.0, 111452.0, 111708.44145779219, 113781.0, 113820.0, 8546.401751877558, 8958.193762561401, 9150.542472876463, 9161.175494205287, 9439.480828554495, 61247.0, 63709.40726481875, 63952.68023659852, 65100.674496627216, 65152.0, 93109.0, 94737.05262947282, 94774.05225947929, 96110.0, 98047.50976245358, 12000.339981301113, 12015.0, 12094.939525302318, 12256.203346782431, 12679.23924564529, 13149.276789776653, 13175.60473185806, 13217.40521676546, 13491.797623035465, 13853.515126970507, 12334.50661973547, 12338.876611234133, 12756.0, 12756.170848894792, 12784.872151278369, 11832.34922079294, 12282.0, 12640.431180596712, 12706.618801435972, 12718.427670755023, 11925.90485032688, 12104.0, 12273.0, 12507.74984500323, 12523.31121788274, 10081.14310283634, 10504.947475262881, 10563.260571760211, 10682.0, 10794.0, 8731.781705457415, 9511.714648560554, 9692.70921872345, 9944.701658950244, 10591.682249532527], "value": 7780.7520625288535, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 108.0, 117.0, 117.0, 118.0, 113.0, 117.0, 138.0, 174.0], "value": 122.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 134.0, 156.0, 111.0, 135.0, 148.0, 144.0, 179.0, 109.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 197.0, 194.0, 205.0, 235.0, 245.0, 272.0, 263.0, 197.0, 192.0], "value": 219.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 83.0, 77.0, 145.0, 56.0, 59.0, 58.0, 57.0, 134.0, 48.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 133.0, 102.0, 98.0, 80.0, 149.0, 102.0, 107.0, 142.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 79.0, 76.0, 110.0, 135.0, 111.0, 90.0, 99.0, 82.0, 82.0], "value": 95.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 99.0, 96.0, 94.0, 154.0, 128.0, 95.0, 127.0], "value": 107.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 82.0, 151.0, 144.0, 106.0, 76.0, 76.0, 130.0, 91.0], "value": 109.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 57.0, 58.0, 58.0, 57.0, 56.0, 55.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 65.0, 74.0, 78.0, 85.0, 72.0, 70.0, 71.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 90.0, 85.0, 84.0, 84.0, 82.0, 84.0, 83.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 152.0, 154.0, 151.0, 158.0, 167.0, 148.0, 196.0, 144.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 224.0, 228.0, 209.0, 164.0, 180.0, 230.0, 172.0, 167.0, 165.0], "value": 189.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 88.0, 85.0, 86.0, 90.0, 67.0, 71.0, 81.0, 74.0, 66.0], "value": 77.4, "unit": "score"}]}]} 09:49:53 INFO - Return code: 0 09:49:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:49:53 ERROR - # TBPL SUCCESS # 09:49:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:49:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:49:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:49:53 INFO - 2016-06-29 09:49:53.275 screenresolution[1670:10401] starting screenresolution argv=screenresolution get 09:49:53 INFO - 2016-06-29 09:49:53.278 screenresolution[1670:10401] Display 0: 1600x1200x32@60 09:49:53 INFO - 2016-06-29 09:49:53.284 screenresolution[1671:10404] starting screenresolution argv=screenresolution list 09:49:53 INFO - Available Modes on Display 0 09:49:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:49:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:49:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:49:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:49:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:49:53 INFO - Intel Iris: 09:49:53 INFO - Chipset Model: Intel Iris 09:49:53 INFO - Type: GPU 09:49:53 INFO - Bus: Built-In 09:49:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:49:53 INFO - Vendor: Intel (0x8086) 09:49:53 INFO - Device ID: 0x0a2e 09:49:53 INFO - Revision ID: 0x0009 09:49:53 INFO - Displays: 09:49:53 INFO - Display: 09:49:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:49:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:49:53 INFO - Display Serial Number: 1600x1200 60 09:49:53 INFO - Main Display: Yes 09:49:53 INFO - Mirror: Off 09:49:53 INFO - Online: Yes 09:49:53 INFO - Rotation: Supported 09:49:53 INFO - Return code: 0 09:49:53 INFO - Running post-action listener: _resource_record_post_action 09:49:53 INFO - ##### 09:49:53 INFO - ##### Finished run-tests step (success) 09:49:53 INFO - ##### 09:49:53 INFO - Running post-run listener: _resource_record_post_run 09:49:53 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 36984320; Write bytes: 705065472; Read time: 235; Write time: 1925 09:49:53 INFO - TinderboxPrint: CPU usage
54.3% 09:49:53 INFO - TinderboxPrint: I/O read bytes / time
36,984,320 / 235 09:49:53 INFO - TinderboxPrint: I/O write bytes / time
705,065,472 / 1,925 09:49:53 INFO - TinderboxPrint: CPU idle
2,209.1 (45.7%) 09:49:53 INFO - TinderboxPrint: CPU system
973.2 (20.2%) 09:49:53 INFO - TinderboxPrint: CPU user
1,647.4 (34.1%) 09:49:53 INFO - TinderboxPrint: Swap in / out
443,662,336 / 0 09:49:53 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396452352; Write bytes: 390871040; Read time: 29341; Write time: 775 09:49:53 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 35165696; Write bytes: 294361600; Read time: 220; Write time: 1099 09:49:53 INFO - Running post-run listener: _upload_blobber_files 09:49:53 INFO - Blob upload gear active. 09:49:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:49:53 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 09:49:53 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'] 09:49:53 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 09:49:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:55 INFO - (blobuploader) - INFO - Done attempting. 09:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:56 INFO - (blobuploader) - INFO - Done attempting. 09:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:58 INFO - (blobuploader) - INFO - Done attempting. 09:49:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:49:58 INFO - Return code: 0 09:49:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:49:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:49:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a656dbcaa166c598c8eba4aae8fe44ef4c329ba8a4cda6f1ff3cd180144dbfa72fd5377b6c4c0a12a3f332ee679670fb90f7fdbd1affc0b5d6df8d1bd427fe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879e66c3107e760be20f71d9a7dc9c1ea598cdb3cbee3cde404cea6c5a8d38792c234546e9825006b496d51fa200a7beb3c310f116e354a4bfd1b6a52f91c001", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173bac1c622608c3690f7c60ea9df93b1f5288b656c3430dd37ba540d54dcada72505dc4907f4c3bffbbb43a147f3347c02d9609f44d2d33a03c07336b8c83e7"} 09:49:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:49:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:49:58 INFO - Contents: 09:49:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a656dbcaa166c598c8eba4aae8fe44ef4c329ba8a4cda6f1ff3cd180144dbfa72fd5377b6c4c0a12a3f332ee679670fb90f7fdbd1affc0b5d6df8d1bd427fe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879e66c3107e760be20f71d9a7dc9c1ea598cdb3cbee3cde404cea6c5a8d38792c234546e9825006b496d51fa200a7beb3c310f116e354a4bfd1b6a52f91c001", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173bac1c622608c3690f7c60ea9df93b1f5288b656c3430dd37ba540d54dcada72505dc4907f4c3bffbbb43a147f3347c02d9609f44d2d33a03c07336b8c83e7"} 09:49:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:49:58 INFO - Copying logs to upload dir... 09:49:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:49:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.880092 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-29 09:49:58.784222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 09:49:58.787479) ========= 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.vL8bVOjlZK/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.4HWvL42pSI/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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/a656dbcaa166c598c8eba4aae8fe44ef4c329ba8a4cda6f1ff3cd180144dbfa72fd5377b6c4c0a12a3f332ee679670fb90f7fdbd1affc0b5d6df8d1bd427fe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879e66c3107e760be20f71d9a7dc9c1ea598cdb3cbee3cde404cea6c5a8d38792c234546e9825006b496d51fa200a7beb3c310f116e354a4bfd1b6a52f91c001", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173bac1c622608c3690f7c60ea9df93b1f5288b656c3430dd37ba540d54dcada72505dc4907f4c3bffbbb43a147f3347c02d9609f44d2d33a03c07336b8c83e7"} build_url:https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010975 build_url: 'https://queue.taskcluster.net/v1/task/Q7sl7_kmSQWpyf04jZjOzw/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/a656dbcaa166c598c8eba4aae8fe44ef4c329ba8a4cda6f1ff3cd180144dbfa72fd5377b6c4c0a12a3f332ee679670fb90f7fdbd1affc0b5d6df8d1bd427fe5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879e66c3107e760be20f71d9a7dc9c1ea598cdb3cbee3cde404cea6c5a8d38792c234546e9825006b496d51fa200a7beb3c310f116e354a4bfd1b6a52f91c001", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173bac1c622608c3690f7c60ea9df93b1f5288b656c3430dd37ba540d54dcada72505dc4907f4c3bffbbb43a147f3347c02d9609f44d2d33a03c07336b8c83e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 09:49:58.820008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:49:58.820341) ========= 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.vL8bVOjlZK/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.4HWvL42pSI/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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.005113 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 09:49:58.869364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 09:49:58.869688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 09:49:58.870041) ========= ========= Total master_lag: 0.20 =========