builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0162 starttime: 1487156402.34 results: success (0) buildid: 20170209170211 builduid: eadb590b78a6436a8ffabcb183f51b85 revision: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.341582) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.342002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.342275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.374187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.374575) ========= 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.N0Lrv24WJt/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.e0rk29xeLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 --2017-02-15 03:00:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.48M=0.002s 2017-02-15 03:00:02 (6.48 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.494145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.500504) ========= 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.N0Lrv24WJt/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.e0rk29xeLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.020120 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.549207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2017-02-15 03:00:02.549585) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25a94c1047e793ef096d8556fa3c26dd72bd37d7 --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 25a94c1047e793ef096d8556fa3c26dd72bd37d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N0Lrv24WJt/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.e0rk29xeLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 2017-02-15 03:00:02,627 truncating revision to first 12 chars 2017-02-15 03:00:02,627 Setting DEBUG logging. 2017-02-15 03:00:02,628 attempt 1/10 2017-02-15 03:00:02,628 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25a94c1047e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 03:00:07,381 unpacking tar archive at: mozilla-central-25a94c1047e7/testing/mozharness/ program finished with exit code 0 elapsedTime=5.008181 ========= master_lag: 2.81 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2017-02-15 03:00:10.362981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:10.363301) ========= script_repo_revision: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:10.367732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:10.368009) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:10.974172) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-15 03:00:10.974537) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.N0Lrv24WJt/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.e0rk29xeLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:11 INFO - MultiFileLogger online at 20170215 03:00:11 in /builds/slave/test 03:00:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:00:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:11 INFO - {'append_to_log': False, 03:00:11 INFO - 'base_work_dir': '/builds/slave/test', 03:00:11 INFO - 'blob_upload_branch': 'Firefox', 03:00:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:11 INFO - 'branch': 'Firefox', 03:00:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:11 INFO - 'config_files': ('talos/mac_config.py',), 03:00:11 INFO - 'default_actions': ('clobber', 03:00:11 INFO - 'read-buildbot-config', 03:00:11 INFO - 'download-and-extract', 03:00:11 INFO - 'populate-webroot', 03:00:11 INFO - 'create-virtualenv', 03:00:11 INFO - 'install', 03:00:11 INFO - 'run-tests'), 03:00:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:11 INFO - 'download_minidump_stackwalk': True, 03:00:11 INFO - 'download_symbols': 'ondemand', 03:00:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:11 INFO - 'installer_path': 'installer.exe', 03:00:11 INFO - 'log_level': 'info', 03:00:11 INFO - 'log_name': 'talos', 03:00:11 INFO - 'log_to_console': True, 03:00:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:00:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:00:11 INFO - 'opt_config_files': (), 03:00:11 INFO - 'pip_index': False, 03:00:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:11 INFO - 'cmd': ('bash', 03:00:11 INFO - '-c', 03:00:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:11 INFO - 'enabled': True, 03:00:11 INFO - 'halt_on_failure': False, 03:00:11 INFO - 'name': 'check_screen_resolution'},), 03:00:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:11 INFO - 'cmd': ('bash', 03:00:11 INFO - '-c', 03:00:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:11 INFO - 'enabled': True, 03:00:11 INFO - 'halt_on_failure': False, 03:00:11 INFO - 'name': 'check_screen_resolution'},), 03:00:11 INFO - 'run_cmd_checks_enabled': True, 03:00:11 INFO - 'sps_profile': False, 03:00:11 INFO - 'sps_profile_interval': 0, 03:00:11 INFO - 'suite': 'dromaeojs', 03:00:11 INFO - 'system_bits': '32', 03:00:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:11 INFO - 'title': 't-yosemite-r7-0162', 03:00:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:11 INFO - 'use_talos_json': True, 03:00:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:11 INFO - 'work_dir': 'build'} 03:00:11 INFO - [mozharness: 2017-02-15 11:00:11.182545Z] Running clobber step. 03:00:11 INFO - Running pre-action listener: _resource_record_pre_action 03:00:11 INFO - Running main action method: clobber 03:00:11 INFO - rmtree: /builds/slave/test/build 03:00:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:13 INFO - Running post-action listener: _resource_record_post_action 03:00:13 INFO - [mozharness: 2017-02-15 11:00:13.257471Z] Finished clobber step (success) 03:00:13 INFO - [mozharness: 2017-02-15 11:00:13.257649Z] Running read-buildbot-config step. 03:00:13 INFO - Running pre-action listener: _resource_record_pre_action 03:00:13 INFO - Running main action method: read_buildbot_config 03:00:13 INFO - Using buildbot properties: 03:00:13 INFO - { 03:00:13 INFO - "project": "", 03:00:13 INFO - "product": "firefox", 03:00:13 INFO - "script_repo_revision": "production", 03:00:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:00:13 INFO - "repository": "", 03:00:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:00:13 INFO - "buildid": "20170209170211", 03:00:13 INFO - "pgo_build": "False", 03:00:13 INFO - "basedir": "/builds/slave/test", 03:00:13 INFO - "buildnumber": 52, 03:00:13 INFO - "slavename": "t-yosemite-r7-0162", 03:00:13 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:00:13 INFO - "platform": "yosemite_r7", 03:00:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:00:13 INFO - "branch": "mozilla-central", 03:00:13 INFO - "repo_path": "mozilla-central", 03:00:13 INFO - "revision": "25a94c1047e793ef096d8556fa3c26dd72bd37d7", 03:00:13 INFO - "stage_platform": "macosx64", 03:00:13 INFO - "builduid": "eadb590b78a6436a8ffabcb183f51b85", 03:00:13 INFO - "slavebuilddir": "test" 03:00:13 INFO - } 03:00:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 03:00:13 INFO - Running post-action listener: _resource_record_post_action 03:00:13 INFO - [mozharness: 2017-02-15 11:00:13.261583Z] Finished read-buildbot-config step (success) 03:00:13 INFO - [mozharness: 2017-02-15 11:00:13.261707Z] Running download-and-extract step. 03:00:13 INFO - Running pre-action listener: _resource_record_pre_action 03:00:13 INFO - Running main action method: download_and_extract 03:00:13 INFO - mkdir: /builds/slave/test/build/tests 03:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:13 INFO - trying https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 03:00:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 03:00:14 INFO - Downloaded 1199 bytes. 03:00:14 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:00:14 INFO - Using the following test package requirements: 03:00:14 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:00:14 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 03:00:14 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 03:00:14 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'jsshell-mac.zip'], 03:00:14 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 03:00:14 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:00:14 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 03:00:14 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 03:00:14 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 03:00:14 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:14 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 03:00:14 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:00:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:00:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:00:15 INFO - Expected file size: 34949027 03:00:15 INFO - Obtained file size: 34949027 03:00:22 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:00:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:00:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:00:23 INFO - Expected file size: 34949027 03:00:23 INFO - Obtained file size: 34949027 03:00:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 03:00:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:00:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 03:00:31 INFO - Expected file size: 14403454 03:00:31 INFO - Obtained file size: 14403454 03:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:31 INFO - trying https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 03:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 03:00:33 INFO - Downloaded 70348678 bytes. 03:00:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:33 INFO - mkdir: /builds/slave/test/properties 03:00:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:33 INFO - Contents: 03:00:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:34 INFO - Running post-action listener: _resource_record_post_action 03:00:34 INFO - Running post-action listener: set_extra_try_arguments 03:00:34 INFO - [mozharness: 2017-02-15 11:00:34.315934Z] Finished download-and-extract step (success) 03:00:34 INFO - [mozharness: 2017-02-15 11:00:34.316098Z] Running populate-webroot step. 03:00:34 INFO - Running pre-action listener: _resource_record_pre_action 03:00:34 INFO - Running main action method: populate_webroot 03:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:34 INFO - '--tppagecycles', 03:00:34 INFO - '7'], 03:00:34 INFO - 'tests': ['tsvgm']}}, 03:00:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:00:34 INFO - 'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:00:34 INFO - 'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['damp', 'tps']}, 03:00:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:34 INFO - 'tests': ['damp', 'tps']}, 03:00:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['dromaeo_dom']}, 03:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['basic_compositor_video']}, 03:00:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:00:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['a11yr', 03:00:34 INFO - 'ts_paint', 03:00:34 INFO - 'tpaint', 03:00:34 INFO - 'sessionrestore', 03:00:34 INFO - 'sessionrestore_no_auto_restore', 03:00:34 INFO - 'tabpaint']}, 03:00:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:34 INFO - 'ts_paint', 03:00:34 INFO - 'tpaint', 03:00:34 INFO - 'sessionrestore', 03:00:34 INFO - 'sessionrestore_no_auto_restore', 03:00:34 INFO - 'tabpaint']}, 03:00:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:34 INFO - 'ts_paint', 03:00:34 INFO - 'tpaint', 03:00:34 INFO - 'sessionrestore', 03:00:34 INFO - 'sessionrestore_no_auto_restore', 03:00:34 INFO - 'tabpaint']}, 03:00:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:34 INFO - 'ts_paint', 03:00:34 INFO - 'tpaint', 03:00:34 INFO - 'sessionrestore', 03:00:34 INFO - 'sessionrestore_no_auto_restore', 03:00:34 INFO - 'tabpaint']}, 03:00:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['a11yr', 03:00:34 INFO - 'ts_paint', 03:00:34 INFO - 'tpaint', 03:00:34 INFO - 'sessionrestore', 03:00:34 INFO - 'sessionrestore_no_auto_restore', 03:00:34 INFO - 'tabpaint']}, 03:00:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['a11yr', 03:00:34 INFO - 'ts_paint', 03:00:34 INFO - 'tpaint', 03:00:34 INFO - 'sessionrestore', 03:00:34 INFO - 'sessionrestore_no_auto_restore', 03:00:34 INFO - 'tabpaint']}, 03:00:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['tsvgx', 03:00:34 INFO - 'tsvgr_opacity', 03:00:34 INFO - 'tart', 03:00:34 INFO - 'tscrollx', 03:00:34 INFO - 'cart', 03:00:34 INFO - 'tsvg_static']}, 03:00:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:34 INFO - 'tsvgr_opacity', 03:00:34 INFO - 'tart', 03:00:34 INFO - 'tscrollx', 03:00:34 INFO - 'cart', 03:00:34 INFO - 'tsvg_static']}, 03:00:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:00:34 INFO - 'talos_options': ['--disable-e10s'], 03:00:34 INFO - 'tests': ['tp5o']}, 03:00:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:00:34 INFO - 'talos_options': ['--disable-e10s', 03:00:34 INFO - '--xperf_path', 03:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:34 INFO - 'tests': ['tp5n']}, 03:00:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:34 INFO - 'talos_options': ['--xperf_path', 03:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:34 INFO - 'tests': ['tp5n']}}, 03:00:34 INFO - 'talos.zip': {'path': '', 03:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:34 INFO - Running post-action listener: _resource_record_post_action 03:00:34 INFO - [mozharness: 2017-02-15 11:00:34.334549Z] Finished populate-webroot step (success) 03:00:34 INFO - [mozharness: 2017-02-15 11:00:34.334682Z] Running create-virtualenv step. 03:00:34 INFO - Running pre-action listener: _resource_record_pre_action 03:00:34 INFO - Running main action method: create_virtualenv 03:00:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:34 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 03:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:34 INFO - Using real prefix '/tools/python27' 03:00:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:38 INFO - Installing pip.................done. 03:00:38 INFO - Return code: 0 03:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:38 INFO - Reading from file tmpfile_stdout 03:00:38 INFO - Output received: 03:00:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:00:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:38 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 03:00:38 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 03:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:38 INFO - 'HOME': '/Users/cltbld', 03:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:38 INFO - 'LOGNAME': 'cltbld', 03:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:38 INFO - 'MOZ_NO_REMOTE': '1', 03:00:38 INFO - 'NO_EM_RESTART': '1', 03:00:38 INFO - 'PAGER': '/bin/cat', 03:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:38 INFO - 'PWD': '/builds/slave/test', 03:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:38 INFO - 'SHELL': '/bin/bash', 03:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:00:38 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:38 INFO - 'USER': 'cltbld', 03:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:38 INFO - 'XPC_FLAGS': '0x0', 03:00:38 INFO - 'XPC_SERVICE_NAME': '0', 03:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:38 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 03:00:38 INFO - Cleaning up... 03:00:38 INFO - Return code: 0 03:00:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:38 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 03:00:38 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 03:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:38 INFO - 'HOME': '/Users/cltbld', 03:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:38 INFO - 'LOGNAME': 'cltbld', 03:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:38 INFO - 'MOZ_NO_REMOTE': '1', 03:00:38 INFO - 'NO_EM_RESTART': '1', 03:00:38 INFO - 'PAGER': '/bin/cat', 03:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:38 INFO - 'PWD': '/builds/slave/test', 03:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:38 INFO - 'SHELL': '/bin/bash', 03:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:00:38 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:38 INFO - 'USER': 'cltbld', 03:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:38 INFO - 'XPC_FLAGS': '0x0', 03:00:38 INFO - 'XPC_SERVICE_NAME': '0', 03:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:38 INFO - Downloading/unpacking psutil>=3.1.1 03:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:42 INFO - Installing collected packages: psutil 03:00:42 INFO - Running setup.py install for psutil 03:00:42 INFO - building 'psutil._psutil_osx' extension 03:00:42 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 03:00:42 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 03:00:42 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 03:00:42 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 03:00:42 INFO - building 'psutil._psutil_posix' extension 03:00:42 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 03:00:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:00:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:00:42 INFO - ^ 03:00:42 INFO - 1 warning generated. 03:00:42 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 03:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:43 INFO - Successfully installed psutil 03:00:43 INFO - Cleaning up... 03:00:43 INFO - Return code: 0 03:00:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:43 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:43 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 03:00:43 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 03:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:43 INFO - 'HOME': '/Users/cltbld', 03:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:43 INFO - 'LOGNAME': 'cltbld', 03:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:43 INFO - 'MOZ_NO_REMOTE': '1', 03:00:43 INFO - 'NO_EM_RESTART': '1', 03:00:43 INFO - 'PAGER': '/bin/cat', 03:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:43 INFO - 'PWD': '/builds/slave/test', 03:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:43 INFO - 'SHELL': '/bin/bash', 03:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:00:43 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:43 INFO - 'USER': 'cltbld', 03:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:43 INFO - 'XPC_FLAGS': '0x0', 03:00:43 INFO - 'XPC_SERVICE_NAME': '0', 03:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:46 INFO - Installing collected packages: mozsystemmonitor 03:00:46 INFO - Running setup.py install for mozsystemmonitor 03:00:46 INFO - Successfully installed mozsystemmonitor 03:00:46 INFO - Cleaning up... 03:00:46 INFO - Return code: 0 03:00:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:46 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:46 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 03:00:46 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 03:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:46 INFO - 'HOME': '/Users/cltbld', 03:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:46 INFO - 'LOGNAME': 'cltbld', 03:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:46 INFO - 'MOZ_NO_REMOTE': '1', 03:00:46 INFO - 'NO_EM_RESTART': '1', 03:00:46 INFO - 'PAGER': '/bin/cat', 03:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:46 INFO - 'PWD': '/builds/slave/test', 03:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:46 INFO - 'SHELL': '/bin/bash', 03:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:00:46 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:46 INFO - 'USER': 'cltbld', 03:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:46 INFO - 'XPC_FLAGS': '0x0', 03:00:46 INFO - 'XPC_SERVICE_NAME': '0', 03:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:46 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 03:00:46 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 03:00:46 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 03:00:46 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 03:00:46 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 03:00:46 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 03:00:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:49 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 03:00:49 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 03:00:49 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 03:00:49 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 03:00:49 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 03:00:49 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 03:00:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:49 INFO - warning: no files found matching '*.txt' 03:00:49 INFO - no previously-included directories found matching 'build' 03:00:49 INFO - no previously-included directories found matching 'dist' 03:00:49 INFO - no previously-included directories found matching '.git*' 03:00:49 INFO - Installing collected packages: jsonschema, functools32 03:00:49 INFO - Running setup.py install for functools32 03:00:50 INFO - warning: no files found matching '*.txt' 03:00:50 INFO - no previously-included directories found matching 'build' 03:00:50 INFO - no previously-included directories found matching 'dist' 03:00:50 INFO - no previously-included directories found matching '.git*' 03:00:50 INFO - Successfully installed jsonschema functools32 03:00:50 INFO - Cleaning up... 03:00:50 INFO - Return code: 0 03:00:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:50 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:50 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:00:50 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 functools32==3.2.3-2 03:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:50 INFO - 'HOME': '/Users/cltbld', 03:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:50 INFO - 'LOGNAME': 'cltbld', 03:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:50 INFO - 'MOZ_NO_REMOTE': '1', 03:00:50 INFO - 'NO_EM_RESTART': '1', 03:00:50 INFO - 'PAGER': '/bin/cat', 03:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:50 INFO - 'PWD': '/builds/slave/test', 03:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:50 INFO - 'SHELL': '/bin/bash', 03:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:00:50 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:50 INFO - 'USER': 'cltbld', 03:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:50 INFO - 'XPC_FLAGS': '0x0', 03:00:50 INFO - 'XPC_SERVICE_NAME': '0', 03:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:50 INFO - Cleaning up... 03:00:50 INFO - Return code: 0 03:00:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:50 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:50 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 03:00:50 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 03:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:50 INFO - 'HOME': '/Users/cltbld', 03:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:50 INFO - 'LOGNAME': 'cltbld', 03:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:50 INFO - 'MOZ_NO_REMOTE': '1', 03:00:50 INFO - 'NO_EM_RESTART': '1', 03:00:50 INFO - 'PAGER': '/bin/cat', 03:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:50 INFO - 'PWD': '/builds/slave/test', 03:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:50 INFO - 'SHELL': '/bin/bash', 03:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:00:50 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:50 INFO - 'USER': 'cltbld', 03:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:50 INFO - 'XPC_FLAGS': '0x0', 03:00:50 INFO - 'XPC_SERVICE_NAME': '0', 03:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:50 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 03:00:50 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 03:00:50 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 03:00:50 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 03:00:50 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 03:00:50 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 03:00:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:54 INFO - Downloading docopt-0.6.1.tar.gz 03:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:54 INFO - Running setup.py install for blobuploader 03:00:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:54 INFO - Running setup.py install for requests 03:00:55 INFO - Running setup.py install for docopt 03:00:55 INFO - Successfully installed blobuploader requests docopt 03:00:55 INFO - Cleaning up... 03:00:55 INFO - Return code: 0 03:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:55 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:00:55 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 03:00:55 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 03:00:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:00:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:55 INFO - 'HOME': '/Users/cltbld', 03:00:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:55 INFO - 'LOGNAME': 'cltbld', 03:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:55 INFO - 'MOZ_NO_REMOTE': '1', 03:00:55 INFO - 'NO_EM_RESTART': '1', 03:00:55 INFO - 'PAGER': '/bin/cat', 03:00:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:55 INFO - 'PWD': '/builds/slave/test', 03:00:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:55 INFO - 'SHELL': '/bin/bash', 03:00:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:00:55 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:00:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:55 INFO - 'USER': 'cltbld', 03:00:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:55 INFO - 'XPC_FLAGS': '0x0', 03:00:55 INFO - 'XPC_SERVICE_NAME': '0', 03:00:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:55 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-K4hEf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:55 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xfv_jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xTDM_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-jxhSYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Nbige0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YL2lCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-irY9Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-hrhttv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-LSxGYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-kpaNUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Ss7kmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:56 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Dp6KA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:57 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Xvrzn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:57 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-sFDsv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:57 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-zGjNPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:57 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Ql_eYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:57 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-uIfiqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:57 INFO - Running setup.py install for manifestparser 03:00:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:57 INFO - Running setup.py install for mozcrash 03:00:57 INFO - Running setup.py install for mozdebug 03:00:58 INFO - Running setup.py install for mozdevice 03:00:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Running setup.py install for mozfile 03:00:58 INFO - Running setup.py install for mozhttpd 03:00:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Running setup.py install for mozinfo 03:00:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Running setup.py install for mozInstall 03:00:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:58 INFO - Running setup.py install for mozleak 03:00:58 INFO - Running setup.py install for mozlog 03:00:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:59 INFO - Running setup.py install for moznetwork 03:00:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:59 INFO - Running setup.py install for mozprocess 03:00:59 INFO - Running setup.py install for mozprofile 03:00:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:59 INFO - Running setup.py install for mozrunner 03:00:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:59 INFO - Running setup.py install for mozscreenshot 03:00:59 INFO - Running setup.py install for moztest 03:01:00 INFO - Running setup.py install for mozversion 03:01:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:00 INFO - Cleaning up... 03:01:00 INFO - Return code: 0 03:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:01 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:01:01 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 03:01:01 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 03:01:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:01:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:01 INFO - 'HOME': '/Users/cltbld', 03:01:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:01 INFO - 'LOGNAME': 'cltbld', 03:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:01 INFO - 'MOZ_NO_REMOTE': '1', 03:01:01 INFO - 'NO_EM_RESTART': '1', 03:01:01 INFO - 'PAGER': '/bin/cat', 03:01:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:01 INFO - 'PWD': '/builds/slave/test', 03:01:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:01 INFO - 'SHELL': '/bin/bash', 03:01:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:01:01 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:01 INFO - 'USER': 'cltbld', 03:01:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:01 INFO - 'XPC_FLAGS': '0x0', 03:01:01 INFO - 'XPC_SERVICE_NAME': '0', 03:01:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:01 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-fXPhcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:01 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)) 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:01 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-_XsW2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:01 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ePoRc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:01 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)) 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:01 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Uamzi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:01 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-LRbj9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:01 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)) 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:01 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-P9hSSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:01 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)) 03:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:01 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-PmaqBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:02 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-byEwW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:02 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Q8pFQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:02 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-p1xZQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-FJthZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:02 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-DRCSxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-wtHU1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:02 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-2vUsNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-z86NUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:02 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)) 03:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:02 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-jbVCVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 03:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:03 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-dInKKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:03 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)) 03:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:01:03 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)) 03:01:03 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:01:03 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:01:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:06 INFO - Downloading blessings-1.6.tar.gz 03:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:06 INFO - Installing collected packages: blessings 03:01:06 INFO - Running setup.py install for blessings 03:01:06 INFO - Successfully installed blessings 03:01:06 INFO - Cleaning up... 03:01:06 INFO - Return code: 0 03:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:06 INFO - Reading from file tmpfile_stdout 03:01:06 INFO - Current package versions: 03:01:06 INFO - blessings == 1.6 03:01:06 INFO - blobuploader == 1.2.4 03:01:06 INFO - docopt == 0.6.1 03:01:06 INFO - functools32 == 3.2.3-2 03:01:06 INFO - jsonschema == 2.5.1 03:01:06 INFO - manifestparser == 1.1 03:01:06 INFO - mozInstall == 1.12 03:01:06 INFO - mozcrash == 1.0 03:01:06 INFO - mozdebug == 0.1 03:01:06 INFO - mozdevice == 0.49 03:01:06 INFO - mozfile == 1.2 03:01:06 INFO - mozhttpd == 0.7 03:01:06 INFO - mozinfo == 0.9 03:01:06 INFO - mozleak == 0.1 03:01:06 INFO - mozlog == 3.4 03:01:06 INFO - moznetwork == 0.27 03:01:06 INFO - mozprocess == 0.24 03:01:06 INFO - mozprofile == 0.28 03:01:06 INFO - mozrunner == 6.13 03:01:06 INFO - mozscreenshot == 0.1 03:01:06 INFO - mozsystemmonitor == 0.3 03:01:06 INFO - moztest == 0.8 03:01:06 INFO - mozversion == 1.4 03:01:06 INFO - psutil == 3.1.1 03:01:06 INFO - requests == 1.2.3 03:01:06 INFO - wsgiref == 0.1.2 03:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:06 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:01:06 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 03:01:06 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 03:01:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:01:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:06 INFO - 'HOME': '/Users/cltbld', 03:01:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:06 INFO - 'LOGNAME': 'cltbld', 03:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:06 INFO - 'MOZ_NO_REMOTE': '1', 03:01:06 INFO - 'NO_EM_RESTART': '1', 03:01:06 INFO - 'PAGER': '/bin/cat', 03:01:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:06 INFO - 'PWD': '/builds/slave/test', 03:01:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:06 INFO - 'SHELL': '/bin/bash', 03:01:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:01:06 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:06 INFO - 'USER': 'cltbld', 03:01:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:06 INFO - 'XPC_FLAGS': '0x0', 03:01:06 INFO - 'XPC_SERVICE_NAME': '0', 03:01:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 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)) 03:01:06 INFO - Cleaning up... 03:01:06 INFO - Return code: 0 03:01:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:06 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 0x10f929b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912adb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, '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.N0Lrv24WJt/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.e0rk29xeLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 03:01:06 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 03:01:06 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 03:01:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:01:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:06 INFO - 'HOME': '/Users/cltbld', 03:01:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:06 INFO - 'LOGNAME': 'cltbld', 03:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:06 INFO - 'MOZ_NO_REMOTE': '1', 03:01:06 INFO - 'NO_EM_RESTART': '1', 03:01:06 INFO - 'PAGER': '/bin/cat', 03:01:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:06 INFO - 'PWD': '/builds/slave/test', 03:01:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:06 INFO - 'SHELL': '/bin/bash', 03:01:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:01:06 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:06 INFO - 'USER': 'cltbld', 03:01:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:06 INFO - 'XPC_FLAGS': '0x0', 03:01:06 INFO - 'XPC_SERVICE_NAME': '0', 03:01:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:07 INFO - Cleaning up... 03:01:07 INFO - Return code: 0 03:01:07 INFO - Running post-action listener: _resource_record_post_action 03:01:07 INFO - Running post-action listener: _start_resource_monitoring 03:01:07 INFO - Starting resource monitoring. 03:01:07 INFO - [mozharness: 2017-02-15 11:01:07.289484Z] Finished create-virtualenv step (success) 03:01:07 INFO - [mozharness: 2017-02-15 11:01:07.290477Z] Running install step. 03:01:07 INFO - Running pre-action listener: _resource_record_pre_action 03:01:07 INFO - Running main action method: install 03:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:07 INFO - Reading from file tmpfile_stdout 03:01:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:07 INFO - Reading from file tmpfile_stdout 03:01:07 INFO - Output received: 03:01:07 INFO - Usage: mozinstall [options] installer 03:01:07 INFO - Options: 03:01:07 INFO - -h, --help show this help message and exit 03:01:07 INFO - -d DEST, --destination=DEST 03:01:07 INFO - Directory to install application into. [default: 03:01:07 INFO - "/builds/slave/test"] 03:01:07 INFO - --app=APP Application being installed. [default: firefox] 03:01:07 INFO - mkdir: /builds/slave/test/build/application 03:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:01:29 INFO - Reading from file tmpfile_stdout 03:01:29 INFO - Output received: 03:01:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:01:29 INFO - Running post-action listener: _resource_record_post_action 03:01:29 INFO - [mozharness: 2017-02-15 11:01:29.601018Z] Finished install step (success) 03:01:29 INFO - [mozharness: 2017-02-15 11:01:29.601159Z] Running run-tests step. 03:01:29 INFO - Running pre-action listener: _resource_record_pre_action 03:01:29 INFO - Running main action method: run_tests 03:01:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:01:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:01:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:01:29 INFO - 2017-02-15 03:01:29.615 screenresolution[1896:18408] starting screenresolution argv=screenresolution get 03:01:29 INFO - 2017-02-15 03:01:29.618 screenresolution[1896:18408] Display 0: 1600x1200x32@60 03:01:29 INFO - 2017-02-15 03:01:29.624 screenresolution[1897:18410] starting screenresolution argv=screenresolution list 03:01:29 INFO - Available Modes on Display 0 03:01:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:01:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:01:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:01:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:01:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:01:29 INFO - Intel Iris: 03:01:29 INFO - Chipset Model: Intel Iris 03:01:29 INFO - Type: GPU 03:01:29 INFO - Bus: Built-In 03:01:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:01:29 INFO - Vendor: Intel (0x8086) 03:01:29 INFO - Device ID: 0x0a2e 03:01:29 INFO - Revision ID: 0x0009 03:01:29 INFO - Displays: 03:01:29 INFO - Display: 03:01:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:01:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:01:29 INFO - Display Serial Number: 1600x1200 60 03:01:29 INFO - Main Display: Yes 03:01:29 INFO - Mirror: Off 03:01:29 INFO - Online: Yes 03:01:29 INFO - Rotation: Supported 03:01:29 INFO - Return code: 0 03:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:29 INFO - Python 2.7.3 03:01:29 INFO - Return code: 0 03:01:29 INFO - grabbing minidump binary from tooltool 03:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f707d30>, '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 0x10f62edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6fcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:01:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:01:29 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 03:01:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:29 INFO - Return code: 0 03:01:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:01:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:01:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N0Lrv24WJt/Render', 03:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:29 INFO - 'HOME': '/Users/cltbld', 03:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:29 INFO - 'LOGNAME': 'cltbld', 03:01:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:29 INFO - 'MOZ_NO_REMOTE': '1', 03:01:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:29 INFO - 'NO_EM_RESTART': '1', 03:01:29 INFO - 'PAGER': '/bin/cat', 03:01:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:29 INFO - 'PWD': '/builds/slave/test', 03:01:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:29 INFO - 'SHELL': '/bin/bash', 03:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e0rk29xeLa/Listeners', 03:01:29 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:29 INFO - 'USER': 'cltbld', 03:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:29 INFO - 'XPC_FLAGS': '0x0', 03:01:29 INFO - 'XPC_SERVICE_NAME': '0', 03:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:01:30 INFO - mozversion application_buildid: 20170209170211 03:01:30 INFO - mozversion application_changeset: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 03:01:30 INFO - mozversion application_display_name: Nightly 03:01:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:30 INFO - mozversion application_name: Firefox 03:01:30 INFO - mozversion application_remotingname: firefox 03:01:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:01:30 INFO - mozversion application_vendor: Mozilla 03:01:30 INFO - mozversion application_version: 54.0a1 03:01:30 INFO - mozversion platform_buildid: 20170209170211 03:01:30 INFO - mozversion platform_changeset: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 03:01:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:01:30 INFO - mozversion platform_version: 54.0a1 03:01:30 INFO - using testdate: 1487156490 03:01:30 INFO - actual date: 1487156490 03:01:30 INFO - starting webserver on 'localhost:49630' 03:01:30 INFO - SUITE-START | Running 2 tests 03:01:30 INFO - TEST-START | dromaeo_css 03:01:30 INFO - operating with platform_type : mac_ 03:01:30 INFO - Initialising browser for dromaeo_css test... 03:01:30 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmplbJzEo/profile http://localhost:49630/getInfo.html) 03:01:32 INFO - PROCESS | 1907 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 03:01:32 INFO - PROCESS | 1907 | __metrics Screen width/height:1600/1200 03:01:32 INFO - PROCESS | 1907 | colorDepth:24 03:01:32 INFO - PROCESS | 1907 | Browser inner width/height: 1024/689 03:01:32 INFO - PROCESS | 1907 | __metrics 03:01:32 INFO - PROCESS | 1907 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:01:32 INFO - PROCESS | 1907 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:01:33 INFO - TEST-INFO | 1907: exit 0 03:01:33 INFO - Browser initialized. 03:01:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:33 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmplbJzEo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:45 INFO - PROCESS | 1909 | RSS: Main: 236707840 03:01:45 INFO - PROCESS | 1909 | 03:04:49 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49630/tests/dromaeo/cssquery-ext.html) 03:04:51 INFO - PROCESS | 1909 | RSS: Main: 364584960 03:04:51 INFO - PROCESS | 1909 | 03:06:35 INFO - PROCESS | 1909 | ************************* 03:06:35 INFO - PROCESS | 1909 | A coding exception was thrown and uncaught in a Task. 03:06:35 INFO - PROCESS | 1909 | 03:06:35 ERROR - PROCESS | 1909 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:06:35 INFO - PROCESS | 1909 | Full stack: 03:06:35 INFO - PROCESS | 1909 | ************************* 03:07:54 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-ext.html (next: http://localhost:49630/tests/dromaeo/cssquery-jquery.html) 03:07:54 INFO - PROCESS | 1909 | RSS: Main: 373743616 03:07:54 INFO - PROCESS | 1909 | 03:10:57 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49630/tests/dromaeo/cssquery-mootools.html) 03:10:57 INFO - PROCESS | 1909 | RSS: Main: 365441024 03:10:57 INFO - PROCESS | 1909 | 03:14:00 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49630/tests/dromaeo/cssquery-prototype.html) 03:14:00 INFO - PROCESS | 1909 | RSS: Main: 338448384 03:14:00 INFO - PROCESS | 1909 | 03:17:04 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49630/tests/dromaeo/cssquery-yui.html) 03:17:04 INFO - PROCESS | 1909 | RSS: Main: 332095488 03:17:04 INFO - PROCESS | 1909 | 03:20:07 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49630/tests/dromaeo/cssquery-yui.html (next: http://localhost:49630/tests/dromaeo/cssquery-dojo.html) 03:20:08 INFO - PROCESS | 1909 | RSS: Main: 504299520 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | __start_tp_report 03:20:08 INFO - PROCESS | 1909 | _x_x_mozilla_page_load 03:20:08 INFO - PROCESS | 1909 | _x_x_mozilla_page_load_details 03:20:08 INFO - PROCESS | 1909 | |i|pagename|runs| 03:20:08 INFO - PROCESS | 1909 | |0;dojo.html;3256.1534001159707;3279.4097062528735;3286.3591599638066;3290.7696461247724;3313.0889005523477;5348.438413966536;5485.780568777254;5492.423295553969;5537.58468114891;5569.805056823012;5505.917411238835;5531.419200983899;5534.169874518824;5549.500544950954;5600.1599760036015;4950.480199579047;4983.601311895058;5025.748712564376;5139.486051394868;5153.484651534835;5124;5138.229265610151;5162.948370516303;5183.196604526304;5213.843584692447;4973.602111831045;4988.67573607718;4995.850124496271;5013.423456302536;5128.333316668846;5068.645194836363;5086.982603479319;5096.541311281965;5146.536811686966;5158.97420512895;5019.272205530214;5047.873803154914;5055.4186268579215;5079.619028572835;5080.288759573626;5362.570994320445;5548.334199895998;5551.861203469905;5570.972145139289;5581;5885.764569417218;5989.520838332923;6022.337542870281;6057.575969682124;6088.878222435526;6093.055576385667;6170.7531698732;6188.690565471708;6202.534809889276;6210.037444196157;5660.60375773696;5664.178694089334;5668.404817494186;5674.2623458950075;5693.544516438675;6136.7852125175405;6155;6155.784547540815;6162.168107305456;6190.0405437157315;5968.880622387528;6014.398560143951;6033.215681961317;6038.698065096728;6073.089036644538;6134.78528251509;6136.693165341715;6137.7851775187655;6139.447449729457;6144.938550614526;5826.329972053268;5881.7647294107755;6049.243844519435;6096.634201947809;6134.447899689049;5988.490978266809;6005.519558435402;6006.219191505076;6009.609375390585;6023.849403764853;4813.446453657804;4815.686980346266;4839.177339852234;4859.708417494961;4864.197407427806;4386.627136693417;4387.714798538149;4415.735055896656;4431.357453169272;4443.355713421536;5561.888762224733;5564.499195072382;5576.219329293902;5585.106382978704;5605.943940560543;5899.616524925866;6149;6153.753849846045;6161;6163.414475624809;5487.533559647474;5522.475364840334;5525.226468294442;5530.225768392428;5542.11326187808;5195.428502864682;5244.816431424882;5250.028744682246;5253.106971814801;5266;6231.158793562811;6297.055441683784;6308.8422789429715;6309.242890853127;6332.366763323631;5876.265466816648;6152.753889844356;6158.168647232746;6158.722857471335;6190.009598464224;6195.101710252078;6231.158793562811;6231.781887633911;6253.937460625518;6278.780242691484;6123.1606109212;6127.678242056309;6130.103847650253;6142.314611233224;6145.555794388404;5886.911696324644;5950.166976623363;5957.642541447527;6011.428914253139;6090.543209259235;5986.580939334379;5994.730237139426;6013.9097913532205;6014.48876845473;6055.818325450244;5963.254593175853;5972.880542389041;5977.133315669291;5981.461668449861;5985.670788106696;5573.27547418833;5628.915566266427;5635;5663.405342438985;5714;5935.495482883831;5937.287525496968;5975.163477113295;5992;6025.517958563217;5699.544036477155;5773.6824474654295;5774.393688662798;5794.565407594531;5796.94203057964 03:20:08 INFO - PROCESS | 1909 | |1;ext.html;463.96520260980435;473.82018773254595;477.6274505885411;485.46113813666824;543.9184122381643;34070;38989.22021559567;39024.21951560967;39030.609693903054;39142.41286380703;39183.80408097956;39674.60325396752;39705.20589588206;39740;39881;7812.726554570563;8000.159983201767;8964.372493925428;9250.537473126351;10754.44060611211;10675.679729608124;10918.344899306026;10935.507902144383;10949.233553651247;10965.287256328313;10909.672709818718;10964.342139471657;10969.890301096966;10988.120950323955;11026.173037022216;7834.68661253552;7961.402894782915;8017.95991020047;8024.719134830253;10869.891301086967;7908.960455197687;10596.841047384218;10874.836877446845;10901.563937442494;10922.29005114665;38995.02512437184;39012.80493597542;39065.80467097646;39102.21795564101;39115.41326880099;3771.076086358832;3780.6786423154067;3782.2624588205313;3873.477080594112;3894.9610503894883;27767.305817354525;28574.999875004276;28633.713662863312;28690.85236590534;28708.856455717796;2659.6808382993972;2978.8659510322086;3119.2825650100376;3129.436701393748;3138.8116712997294;434960;436757;437443;438313;440111.9999999968;57870.13194802081;58257.70871145702;58263.4173658258;58341.70829145827;58475.936229884435;58745.70627146837;59076;59259;59274.96162826122;59432.70283648554;14555.78166327506;14781.92609036948;14791.964562480738;14820.555383338517;14869.702605947821;10947.781044379068;10992.945035274932;10996.835047474295;11012.614558490415;11048.06091482217;14814.555563333117;14832.035917665316;15331.463398780988;15613.921930390276;15628.2185890705;5815.680137592389;6635.966820165868;6663.233728121328;6672.2994085621285;6702.530822842452;829.5437509369943;830.900291964956;831.717216146501;837.9790505237418;862.8662557303628;28429.289267768472;28636.570451443244;28650.570241446396;29040.273993150342;29249;1013.2653825976108;1015.4973288222377;1037.6057098302597;1043.4521876015153;1170.414792603698;11999.400029998465;14047.929760351337;14647;14680.632984175267;14949.591125260902;559104;570619;571670;571883;572152;56008.159877601865;56187.31438056865;56267.43732562622;56391.71804141035;56424.717876411174;1329.6476433745065;1364.8021036949588;1367.0908845617553;1368.0902200037262;1372.5264783649625;21913.671294930908;26800.59799103054;28034.71965280321;28357.43285134327;28717.425651486436;42547;43603.56396435995;47330.52669473261;47576.524234757206;47607.52392476031;463412;464740;466832;466876;467271;36562.817185914966;36931.07672308214;36964.81517592395;37128;37174.25651487009;41797.946819753124;42338.57661423346;42468.78765606152;42705.78647106869;43819.12361752811;33300.500492492145;35307.117322067155;35529.934101976985;36653.26693466169;36807.26385472329;31300.53049204218;33981.49027764536;35323.64676353204;36281.81859090688;36345.27309453849;33706.27064355355;33880.66119338775;33980.830095849364;34568;34625.480617791254;30965.535516967713;31175.36952171999;31677.8416107918;31757;31759.442097633284;22915.96878140521;23339.833008349175;23796.405089872893;23903.76096239085;24100.915458804746 03:20:08 INFO - PROCESS | 1909 | |2;jquery.html;349.8618045871882;371.4817829128366;372.2740655721344;386.41844024742767;410.98561550345727;11170;14193.503227387044;14738.336774845131;19472.902635486837;20037.799622003775;15149.318280677368;17577.736333955;20438.18247270111;20505.794942050576;20559.486012849688;5533.363663178736;5850.76596936122;5855;5856.590038697293;5867.7066146692705;4596.632269418438;5717.885642287151;6400.359964003609;6444.6133232006;6501.837454063662;6175.876482470348;6402.839929001789;6414.294427612959;6422.2293324801085;6440.935590644081;6235.06474028897;6383.936160638381;6392.073149393312;6399.648019358933;6422.100905873182;4428.269335559628;5139.691618502902;5407.215953686693;5541.639793413416;5596.104623260258;20858.478538036517;24735.87632061828;25315.746842531524;25372.365690857692;25676.8716156418;2631.6052592111146;2633.973660263392;2647.761701446879;2648.284963059982;2658.1493921944984;14301.64245893861;14760.926195369062;14793.260336983216;15556.455524056717;15571.610709732235;1743.4856717268435;1787.3297513432462;1792.4353828543967;1807.1235450806348;1829.2682926829375;112214;125432;126511.10233346507;127481.36259318644;128272;11032.338059716443;11144.554217831359;11216.719582010352;11249.156313276373;11481.655550333504;11812.881871181178;14063.789043164361;14247.216403097722;14255.287235638383;14267.92866035684;8004.359651228005;8178.918210817935;8198.631061602124;8238.464499807493;8292.33661307094;8009.159038301011;8050.838983220303;8189.467684600482;8195.262426381654;8231.753047408587;5688;6797.5581587196675;6896.965515172392;6918.861622767517;6943.305669433117;1823.626156637886;1853.508820162658;1854.156358856717;1859.739636450898;1862.1620270878159;765.5291995422775;994.796066806303;1019.3628981886321;1030.90206430389;1033.9534720937577;20440.693389599168;21832;21964.670529942065;21974.670379944313;22339.218127365788;1035.3477309295247;1047.4082143588848;1073.3720773347522;1073.6671631794168;1083.377058191543;9027.50348730813;10614.946925265323;11453.59912403062;11476.655700328836;11512.424378781028;709875.4506227436;712881;728136;734113;737614;123386;125199;129516.35241823731;131837;132796;1003.6838395905412;1028.136365453008;1050.0654417568371;1050.4905121016147;1052.1425038593522;18388.264469421072;18989.430317090508;18998.905005474884;19008.904955475133;19079.52301192481;53943;54308.00542740961;54866.451335486134;54949;56158.315250540916;78922.4215515698;81343.59328203321;82353.3529329398;82787.17212827795;84215.73676394981;5028.497150284942;6372.458341041063;8280.254777070093;8517.105703901001;8599.14008599135;10940.507677154388;12521.686957826127;12815.359232038547;13090.14914030585;13146.737065258832;8976.86534701967;11235;11256;11302.43487825589;11346.489407976496;10110.191184705352;10919.344839309666;10949.671509854717;11280.891713400892;11402.372869492257;10744.677659670222;11183.384913829817;11318.490667920129;11351.48918298695;11790.764184716087;8202.17978202175;8311.95844020776;8387.95806020966;8497.405181637227;8524.957375213084;10661.25371224038;10661.786764264827;10996.890288589244;11063.004329610374;11280.548778048786 03:20:08 INFO - PROCESS | 1909 | |3;mootools.html;1403.3264033264034;1405.7610206264933;1413.9575812725616;1427.1365823676676;1432.498625481081;7641.465097443182;7844.960775196116;7918.722844700436;7921.217726011651;7940.40446966477;8146.75559733209;8303.543305118232;8496.1503849615;8568.957155214215;8577.31381489481;2221.9000144993474;2262.2760716570706;2265.1732117776974;2269;2270.4550907782177;1976.6046790641858;2068.2761033638258;2256.3569382725927;2289.7710228977053;2292.85096468729;1723.276223985929;2011.4468521156653;2155.5365596396773;2244.068711484732;2244.2257421189665;2207.095091012693;2221.178164079293;2227.6324406472913;2233.129079658934;2233.218373569254;2221.7222847144108;2270.3302525754943;2278.475950531387;2278.5556816420803;2281.6577513372963;8528.872066919;8611.26804221642;8631.395802293842;8639.52482613456;8644.005939316934;4661.696989695659;5002.89994200114;5040.47075057121;5206.271122042917;5211.635185537014;2687.2744359022954;3318.6515415881468;3430.8456119474686;3470.2192006798523;3504.8072356020407;1076.445630500293;1195.8624758152837;1200.9819852702128;1229.342301868505;1247.151936683055;10818.945905270502;10830.079443247334;10885.455727213608;10911.890881091247;10918.50866711;4111.60939710727;4305.956940430556;4373.737575745466;4393.428854248928;4427.092446048552;8774.341924355698;8774.473531588124;8777.517236551923;8782.297416206688;8790.824183516423;5031.496850314939;5063.088644044034;5068.543831055223;5074.061298659686;5095.31213286209;4527.320901864747;4542.750148741851;4684.391029166187;4695.201815691273;4698.060387922429;3557.2569440974253;3594.676479116892;3615.5661320641693;3632.473291372736;3651.1419816343137;878.5168157513342;956.6699488676395;1121.9214654974073;1133.257716195893;1143.7483753574368;760.0727112922226;860.836441076206;864.6109250837148;908.2416182487697;923.7644400677918;5445.918311225335;5676.176954341598;5815.9709201453725;5829.795957141479;5833.687420330391;930.265090578449;981.1218959031769;986.5871833084948;986.713852982627;996.2776986684596;3126.499760038383;3638.8180590970346;3732.925341493209;3792.241551689673;3851.614838516126;9830.4101753895;9844.655437059668;9844.901550984541;10156.847647285296;10193.541290641939;9986.20110391167;10130.088292053602;10132.898671013343;10160.593576257015;10164.237682173867;7344.926550734424;7727.613619319011;7749.92250077492;7785;7908.367330613537;4812.302216178565;5554.888902222014;5561.888762224652;5640.0693885508435;5753.683547404933;8912.153345432174;8937.553122343987;9223.354365194373;9337.673181438617;9351.812963740824;9054.004059553576;9121;9362.297827662816;9442.95278523603;9476.289278304017;7555.584442855696;7837.0987336454755;7842.568658723825;7865.724699635485;7866.370690344645;7483.214262502576;7776.183500732342;7830.960845195966;7863.567503787347;7871.291583757489;5611.971940140274;6945.374916257561;7148.320909513588;7188.388986936169;7233.3851622612665;6970.268121847336;7033.613151276524;7056.435485161072;7117.501774875709;7210.89183662256;5594.629315817488;5768.423157684198;6186.1648677427975;6246.906296405648;6363.77726779579;4894.021195760934;4939.604831613534;4989.675671081368;5018.1218286800395;5082.390113186293;4917.827876024465;4986.700797952134;4995.8001679932395;5035.194368900959;5218.347706536683 03:20:08 INFO - PROCESS | 1909 | |4;prototype.html;309.97520198384126;343.8373213619832;356.41903696973935;359.09149850877276;360.7745159275453;4422.766502916023;5399.433059528752;5445.237666726652;5453.700046497446;5481.972590137048;4356.78216089195;4577.702449340791;5028;5067.290579318898;5298.947010529903;4017.156397156586;4021.135455876993;4032.516098068236;4036.3945408188715;4058.1072164123993;4071.145059537501;4075.551689314188;4081.1022874363416;4100.56944020878;4109.815058322368;3319.983400082996;3620.8051343056727;4003.539592946819;4071.6742660587083;4077.2864748669012;3584.982075089634;3843.7309388342687;3932.233214523169;3951.209758048402;3979.383195604686;3043.7260646541918;3407.9488807667904;3437.604675462329;3461.3250416168858;3471.7222622190166;4249.150169965988;4489.685721999462;5093.923591146136;5170.25031370453;5182.818601348935;4250.362445633149;4484.304932735431;4534.31985202219;4599.540045995407;4605.907881842378;4719.787609557578;5054.963732434842;5147.944671342403;5528.494277164139;5537.667739935577;3394.372041172391;3565.53648025755;3787.507624008889;3805.7906815125157;3811.2377524495214;5369.650972686802;5487.6158668893195;5567.749451274662;5823.475887170132;5827.796027139115;3553.4136867417105;3703.814809259526;3782.7730336179916;3821.732418781957;3836.462895194675;3886.4753258310334;3890.96109038906;3899.415087736862;3900.258950799339;3900.4539364488996;4289.871303860889;4556.744411516321;4557.339185818104;4559.931601025921;4568.291914753218;4768.833090841804;5637.8160586277345;5645.322561292671;5675.489205971482;5680.665043714724;1158.137187795098;1238.5107882386408;1265.5383032597365;1287.3241548187277;1295.7214198947272;688.1088989758275;730.1749023603294;802.0215337288498;857.2884505860121;877.6401675313091;4225.68307376948;4531.660125490602;4837.467878533358;4881.707097574157;4981.726005069756;4604;4768.6661933665;5018.1218286800395;5476.17857321405;5482.956958887776;4187.032094915385;4372.628326592212;4384.430024096847;4554.517787805654;4876.683295510264;2345.753695861944;2639.3269716222626;2813.310738868949;2891.6264774232072;2896.362800183956;4956.826511072095;4998.650094493423;5747.310322761212;5776.566757493205;5782.59521833476;5016.673916195436;5276.81531146408;5559.471850174227;5643.701948551856;5714;4581.65637577183;5121.180611102206;5538.762846422571;5621.362376039783;5625.240592520039;4756.025014871874;5104.948950510596;5121.948780512296;5425.376081750649;5458.5087342139395;4925.458199598113;5183.015227106837;5457.590680698884;5662.405447428126;5689.630174038674;4980.651354405301;5223.764930578057;6009.45914867664;6025.427584379477;6058.394160583906;3887.4168874669026;3900.473436086092;3902.200048990007;3903.394973779069;3910.237503686754;5509.311336082989;5671.347795003462;5698;5747.643466178846;5856.472917437451;5593;5608.6073974821375;5645.899049685272;5646.96709184685;5684.8010319638615;5123.002029208537;5552.611317207757;5571.470710282517;5616;5622.791099913538;5463;5472.72636368188;5482.711562782663;5489.176623506346;5493.2858728366655;5437.157240627709;5606.421046318576;5607.495325420732;5631.620253037868;5667.518260947865;4647.35100992431;5173.456787037307;5264.605154613343;5320.600954928474;5515.283013208417 03:20:08 INFO - PROCESS | 1909 | |5;yui.html;706.4948561778331;713.8536599997001;741.0181509499914;786.3787607789845;814.6212011414693;14405.567832965002;14855.702885942275;14973.550793476186;15001;15029.098254104762;13284.070115091947;13561.45754169832;13764.655883602914;13793.586192414243;13825.032247742662;865.7359505350865;874.6719980007497;876.3208513402101;877.3639111644039;881.801594641207;739.9926000740004;835.2441040858002;863.7970077031893;883.2448256740458;885.0043700836559;926.305271046715;933.6125507914207;936.6159874451477;937.3298091864316;940.2900809888558;902.6208992223281;918.6279556779482;929.5073610986188;932.4731526687434;933.2394098809516;686.2862622872207;687.1959807025792;687.9036934829128;690.3200347657553;690.6477696374835;14533.34599943005;14750.926245368812;14792.18642974636;14799.482018129422;14913;13490.178825858482;13625.454981800716;13674.794878076837;13897.374618142208;13948.511802086878;11289.887101128967;11487.195896287263;11542.170830889141;11682.941585292105;12085.274883507018;3503.7897726136257;3545.964540354589;3574.2136729919634;3613.5663720353464;3710.684591809699;99723.50414743712;100431.49784251105;102906;104613.95386046042;105931;10457.581696732197;10529.36823790575;10691.572337106583;10710.785784284426;10835;20016;21792.89103554504;21854.34436966862;21865.016074276697;21865.562688746137;6186.721597528122;7199.388052015533;7214.96392518034;7304.233055529093;7365.779026629102;3808.352580061396;4112.568180341081;4176.477940257468;4177.603127702863;4185.790710464465;3472.4270495368487;3517.402041652874;3546.1666508370513;3556.87550935716;3611.115276757211;642.9070580013995;650.443870490733;651.9706613202417;665.8468552233013;667.0960848050821;652.4975768658106;676.8950812623953;685.6366125953252;697.5953946710896;705.1432509500981;8398.79003024917;9433;9808.901910980941;9839.803203936024;9870.21038316933;649.1820306413953;681.8227260912198;686.9107016087877;693.9167299924042;702.357343031131;4461.10777844426;4754.595859351924;4760.833370832004;4767.928481072787;4784.760761961888;77678;96959.54560681595;97883.51058244806;99204.51193231963;99217;85190;85659;85914;87844.12155878487;88169.55915220383;75850.62074689592;77165.61417192878;78848.60575697085;79378.80931785912;80407.19592804114;8756.693515726918;9182.586783594888;9182.908170918205;9306.953465232902;9380.718578442658;50212.49787502078;50325.490235293;51405;51438;52522;61779.76440471255;61843.38156618556;67593.66203168953;68285.31714682789;69365.95951060839;10390.688279351632;11001.559937602726;11051.005409513182;11155.665330040112;11473.598424055119;11935.920128875428;11950.342731149522;12016.699582510157;12124.757504849676;12142.210756300812;11523.8271425927;13108.410121544362;13435.664108397368;13938.721225575635;14005.43978240859;13000.154989925624;13096.410661520446;13417.875651515129;13534.59396218115;13831.377588008363;13033.47866085346;13144.40850161726;13315.600531984055;13609.659758506117;13752.243626600633;10105.696829095139;10231.079202871777;10237.489060386475;10271.589136434757;10495.632652857419;8740.912590874264;10292.61049758303;10987.450627468435;11267;11314.83027754568 03:20:08 INFO - PROCESS | 1909 | __end_tp_report 03:20:08 INFO - PROCESS | 1909 | __start_cc_report 03:20:08 INFO - PROCESS | 1909 | _x_x_mozilla_cycle_collect,1670 03:20:08 INFO - PROCESS | 1909 | __end_cc_report 03:20:08 INFO - PROCESS | 1909 | __startTimestamp1487157608286__endTimestamp 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | ------- Summary: start ------- 03:20:08 INFO - PROCESS | 1909 | Number of tests: 6 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | [#0] dojo.html Cycles:165 Average:5613.67 Median:5774.39 stddev:626.42 (10.8%) stddev-sans-first:600.42 03:20:08 INFO - PROCESS | 1909 | Values: 3256.2 3279.4 3286.4 3290.8 3313.1 5348.4 5485.8 5492.4 5537.6 5569.8 5505.9 5531.4 5534.2 5549.5 5600.2 4950.5 4983.6 5025.7 5139.5 5153.5 5124.0 5138.2 5162.9 5183.2 5213.8 4973.6 4988.7 4995.9 5013.4 5128.3 5068.6 5087.0 5096.5 5146.5 5159.0 5019.3 5047.9 5055.4 5079.6 5080.3 5362.6 5548.3 5551.9 5571.0 5581.0 5885.8 5989.5 6022.3 6057.6 6088.9 6093.1 6170.8 6188.7 6202.5 6210.0 5660.6 5664.2 5668.4 5674.3 5693.5 6136.8 6155.0 6155.8 6162.2 6190.0 5968.9 6014.4 6033.2 6038.7 6073.1 6134.8 6136.7 6137.8 6139.4 6144.9 5826.3 5881.8 6049.2 6096.6 6134.4 5988.5 6005.5 6006.2 6009.6 6023.8 4813.4 4815.7 4839.2 4859.7 4864.2 4386.6 4387.7 4415.7 4431.4 4443.4 5561.9 5564.5 5576.2 5585.1 5605.9 5899.6 6149.0 6153.8 6161.0 6163.4 5487.5 5522.5 5525.2 5530.2 5542.1 5195.4 5244.8 5250.0 5253.1 5266.0 6231.2 6297.1 6308.8 6309.2 6332.4 5876.3 6152.8 6158.2 6158.7 6190.0 6195.1 6231.2 6231.8 6253.9 6278.8 6123.2 6127.7 6130.1 6142.3 6145.6 5886.9 5950.2 5957.6 6011.4 6090.5 5986.6 5994.7 6013.9 6014.5 6055.8 5963.3 5972.9 5977.1 5981.5 5985.7 5573.3 5628.9 5635.0 5663.4 5714.0 5935.5 5937.3 5975.2 5992.0 6025.5 5699.5 5773.7 5774.4 5794.6 5796.9 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | [#1] ext.html Cycles:180 Average:62592.21 Median:36608.04 stddev:131603.15 (359.5%) stddev-sans-first:131889.66 03:20:08 INFO - PROCESS | 1909 | Values: 464.0 473.8 477.6 485.5 543.9 34070.0 38989.2 39024.2 39030.6 39142.4 39183.8 39674.6 39705.2 39740.0 39881.0 7812.7 8000.2 8964.4 9250.5 10754.4 10675.7 10918.3 10935.5 10949.2 10965.3 10909.7 10964.3 10969.9 10988.1 11026.2 7834.7 7961.4 8018.0 8024.7 10869.9 7909.0 10596.8 10874.8 10901.6 10922.3 38995.0 39012.8 39065.8 39102.2 39115.4 3771.1 3780.7 3782.3 3873.5 3895.0 27767.3 28575.0 28633.7 28690.9 28708.9 2659.7 2978.9 3119.3 3129.4 3138.8 434960.0 436757.0 437443.0 438313.0 440112.0 57870.1 58257.7 58263.4 58341.7 58475.9 58745.7 59076.0 59259.0 59275.0 59432.7 14555.8 14781.9 14792.0 14820.6 14869.7 10947.8 10992.9 10996.8 11012.6 11048.1 14814.6 14832.0 15331.5 15613.9 15628.2 5815.7 6636.0 6663.2 6672.3 6702.5 829.5 830.9 831.7 838.0 862.9 28429.3 28636.6 28650.6 29040.3 29249.0 1013.3 1015.5 1037.6 1043.5 1170.4 11999.4 14047.9 14647.0 14680.6 14949.6 559104.0 570619.0 571670.0 571883.0 572152.0 56008.2 56187.3 56267.4 56391.7 56424.7 1329.6 1364.8 1367.1 1368.1 1372.5 21913.7 26800.6 28034.7 28357.4 28717.4 42547.0 43603.6 47330.5 47576.5 47607.5 463412.0 464740.0 466832.0 466876.0 467271.0 36562.8 36931.1 36964.8 37128.0 37174.3 41797.9 42338.6 42468.8 42705.8 43819.1 33300.5 35307.1 35529.9 36653.3 36807.3 31300.5 33981.5 35323.6 36281.8 36345.3 33706.3 33880.7 33980.8 34568.0 34625.5 30965.5 31175.4 31677.8 31757.0 31759.4 22916.0 23339.8 23796.4 23903.8 24100.9 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | [#2] jquery.html Cycles:180 Average:38859.80 Median:20532.64 stddev:120080.98 (584.8%) stddev-sans-first:120383.02 03:20:08 INFO - PROCESS | 1909 | Values: 349.9 371.5 372.3 386.4 411.0 11170.0 14193.5 14738.3 19472.9 20037.8 15149.3 17577.7 20438.2 20505.8 20559.5 5533.4 5850.8 5855.0 5856.6 5867.7 4596.6 5717.9 6400.4 6444.6 6501.8 6175.9 6402.8 6414.3 6422.2 6440.9 6235.1 6383.9 6392.1 6399.6 6422.1 4428.3 5139.7 5407.2 5541.6 5596.1 20858.5 24735.9 25315.7 25372.4 25676.9 2631.6 2634.0 2647.8 2648.3 2658.1 14301.6 14760.9 14793.3 15556.5 15571.6 1743.5 1787.3 1792.4 1807.1 1829.3 112214.0 125432.0 126511.1 127481.4 128272.0 11032.3 11144.6 11216.7 11249.2 11481.7 11812.9 14063.8 14247.2 14255.3 14267.9 8004.4 8178.9 8198.6 8238.5 8292.3 8009.2 8050.8 8189.5 8195.3 8231.8 5688.0 6797.6 6897.0 6918.9 6943.3 1823.6 1853.5 1854.2 1859.7 1862.2 765.5 994.8 1019.4 1030.9 1034.0 20440.7 21832.0 21964.7 21974.7 22339.2 1035.3 1047.4 1073.4 1073.7 1083.4 9027.5 10614.9 11453.6 11476.7 11512.4 709875.5 712881.0 728136.0 734113.0 737614.0 123386.0 125199.0 129516.4 131837.0 132796.0 1003.7 1028.1 1050.1 1050.5 1052.1 18388.3 18989.4 18998.9 19008.9 19079.5 53943.0 54308.0 54866.5 54949.0 56158.3 78922.4 81343.6 82353.4 82787.2 84215.7 5028.5 6372.5 8280.3 8517.1 8599.1 10940.5 12521.7 12815.4 13090.1 13146.7 8976.9 11235.0 11256.0 11302.4 11346.5 10110.2 10919.3 10949.7 11280.9 11402.4 10744.7 11183.4 11318.5 11351.5 11790.8 8202.2 8312.0 8388.0 8497.4 8525.0 10661.3 10661.8 10996.9 11063.0 11280.5 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | [#3] mootools.html Cycles:180 Average:5375.66 Median:5088.85 stddev:2986.63 (58.7%) stddev-sans-first:2980.09 03:20:08 INFO - PROCESS | 1909 | Values: 1403.3 1405.8 1414.0 1427.1 1432.5 7641.5 7845.0 7918.7 7921.2 7940.4 8146.8 8303.5 8496.2 8569.0 8577.3 2221.9 2262.3 2265.2 2269.0 2270.5 1976.6 2068.3 2256.4 2289.8 2292.9 1723.3 2011.4 2155.5 2244.1 2244.2 2207.1 2221.2 2227.6 2233.1 2233.2 2221.7 2270.3 2278.5 2278.6 2281.7 8528.9 8611.3 8631.4 8639.5 8644.0 4661.7 5002.9 5040.5 5206.3 5211.6 2687.3 3318.7 3430.8 3470.2 3504.8 1076.4 1195.9 1201.0 1229.3 1247.2 10818.9 10830.1 10885.5 10911.9 10918.5 4111.6 4306.0 4373.7 4393.4 4427.1 8774.3 8774.5 8777.5 8782.3 8790.8 5031.5 5063.1 5068.5 5074.1 5095.3 4527.3 4542.8 4684.4 4695.2 4698.1 3557.3 3594.7 3615.6 3632.5 3651.1 878.5 956.7 1121.9 1133.3 1143.7 760.1 860.8 864.6 908.2 923.8 5445.9 5676.2 5816.0 5829.8 5833.7 930.3 981.1 986.6 986.7 996.3 3126.5 3638.8 3732.9 3792.2 3851.6 9830.4 9844.7 9844.9 10156.8 10193.5 9986.2 10130.1 10132.9 10160.6 10164.2 7344.9 7727.6 7749.9 7785.0 7908.4 4812.3 5554.9 5561.9 5640.1 5753.7 8912.2 8937.6 9223.4 9337.7 9351.8 9054.0 9121.0 9362.3 9443.0 9476.3 7555.6 7837.1 7842.6 7865.7 7866.4 7483.2 7776.2 7831.0 7863.6 7871.3 5612.0 6945.4 7148.3 7188.4 7233.4 6970.3 7033.6 7056.4 7117.5 7210.9 5594.6 5768.4 6186.2 6246.9 6363.8 4894.0 4939.6 4989.7 5018.1 5082.4 4917.8 4986.7 4995.8 5035.2 5218.3 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | [#4] prototype.html Cycles:180 Average:4428.98 Median:4903.58 stddev:1362.00 (27.8%) stddev-sans-first:1330.27 03:20:08 INFO - PROCESS | 1909 | Values: 310.0 343.8 356.4 359.1 360.8 4422.8 5399.4 5445.2 5453.7 5482.0 4356.8 4577.7 5028.0 5067.3 5298.9 4017.2 4021.1 4032.5 4036.4 4058.1 4071.1 4075.6 4081.1 4100.6 4109.8 3320.0 3620.8 4003.5 4071.7 4077.3 3585.0 3843.7 3932.2 3951.2 3979.4 3043.7 3407.9 3437.6 3461.3 3471.7 4249.2 4489.7 5093.9 5170.3 5182.8 4250.4 4484.3 4534.3 4599.5 4605.9 4719.8 5055.0 5147.9 5528.5 5537.7 3394.4 3565.5 3787.5 3805.8 3811.2 5369.7 5487.6 5567.7 5823.5 5827.8 3553.4 3703.8 3782.8 3821.7 3836.5 3886.5 3891.0 3899.4 3900.3 3900.5 4289.9 4556.7 4557.3 4559.9 4568.3 4768.8 5637.8 5645.3 5675.5 5680.7 1158.1 1238.5 1265.5 1287.3 1295.7 688.1 730.2 802.0 857.3 877.6 4225.7 4531.7 4837.5 4881.7 4981.7 4604.0 4768.7 5018.1 5476.2 5483.0 4187.0 4372.6 4384.4 4554.5 4876.7 2345.8 2639.3 2813.3 2891.6 2896.4 4956.8 4998.7 5747.3 5776.6 5782.6 5016.7 5276.8 5559.5 5643.7 5714.0 4581.7 5121.2 5538.8 5621.4 5625.2 4756.0 5104.9 5121.9 5425.4 5458.5 4925.5 5183.0 5457.6 5662.4 5689.6 4980.7 5223.8 6009.5 6025.4 6058.4 3887.4 3900.5 3902.2 3903.4 3910.2 5509.3 5671.3 5698.0 5747.6 5856.5 5593.0 5608.6 5645.9 5647.0 5684.8 5123.0 5552.6 5571.5 5616.0 5622.8 5463.0 5472.7 5482.7 5489.2 5493.3 5437.2 5606.4 5607.5 5631.6 5667.5 4647.4 5173.5 5264.6 5320.6 5515.3 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - PROCESS | 1909 | [#5] yui.html Cycles:180 Average:19775.38 Median:4764.38 stddev:28383.63 (595.7%) stddev-sans-first:28427.14 03:20:08 INFO - PROCESS | 1909 | Values: 706.5 713.9 741.0 786.4 814.6 14405.6 14855.7 14973.6 15001.0 15029.1 13284.1 13561.5 13764.7 13793.6 13825.0 865.7 874.7 876.3 877.4 881.8 740.0 835.2 863.8 883.2 885.0 926.3 933.6 936.6 937.3 940.3 902.6 918.6 929.5 932.5 933.2 686.3 687.2 687.9 690.3 690.6 14533.3 14750.9 14792.2 14799.5 14913.0 13490.2 13625.5 13674.8 13897.4 13948.5 11289.9 11487.2 11542.2 11682.9 12085.3 3503.8 3546.0 3574.2 3613.6 3710.7 99723.5 100431.5 102906.0 104614.0 105931.0 10457.6 10529.4 10691.6 10710.8 10835.0 20016.0 21792.9 21854.3 21865.0 21865.6 6186.7 7199.4 7215.0 7304.2 7365.8 3808.4 4112.6 4176.5 4177.6 4185.8 3472.4 3517.4 3546.2 3556.9 3611.1 642.9 650.4 652.0 665.8 667.1 652.5 676.9 685.6 697.6 705.1 8398.8 9433.0 9808.9 9839.8 9870.2 649.2 681.8 686.9 693.9 702.4 4461.1 4754.6 4760.8 4767.9 4784.8 77678.0 96959.5 97883.5 99204.5 99217.0 85190.0 85659.0 85914.0 87844.1 88169.6 75850.6 77165.6 78848.6 79378.8 80407.2 8756.7 9182.6 9182.9 9307.0 9380.7 50212.5 50325.5 51405.0 51438.0 52522.0 61779.8 61843.4 67593.7 68285.3 69366.0 10390.7 11001.6 11051.0 11155.7 11473.6 11935.9 11950.3 12016.7 12124.8 12142.2 11523.8 13108.4 13435.7 13938.7 14005.4 13000.2 13096.4 13417.9 13534.6 13831.4 13033.5 13144.4 13315.6 13609.7 13752.2 10105.7 10231.1 10237.5 10271.6 10495.6 8740.9 10292.6 10987.5 11267.0 11314.8 03:20:08 INFO - PROCESS | 1909 | -------- Summary: end -------- 03:20:08 INFO - PROCESS | 1909 | 03:20:08 INFO - TEST-INFO | 1909: exit 0 03:20:08 INFO - TEST-OK | dromaeo_css | took 1118725ms 03:20:08 INFO - TEST-START | kraken 03:20:08 INFO - operating with platform_type : mac_ 03:20:08 INFO - Initialising browser for kraken test... 03:20:08 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpWYs6OX/profile http://localhost:49630/getInfo.html) 03:20:11 INFO - PROCESS | 1912 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 03:20:11 INFO - PROCESS | 1912 | __metrics Screen width/height:1600/1200 03:20:11 INFO - PROCESS | 1912 | colorDepth:24 03:20:11 INFO - PROCESS | 1912 | Browser inner width/height: 1024/689 03:20:11 INFO - PROCESS | 1912 | __metrics 03:20:11 INFO - PROCESS | 1912 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:20:11 INFO - PROCESS | 1912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:12 INFO - TEST-INFO | 1912: exit 0 03:20:12 INFO - Browser initialized. 03:20:12 INFO - Running cycle 1/1 for kraken test... 03:20:12 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpWYs6OX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:24 INFO - PROCESS | 1913 | RSS: Main: 228388864 03:20:24 INFO - PROCESS | 1913 | 03:20:27 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:28 INFO - PROCESS | 1913 | RSS: Main: 289120256 03:20:28 INFO - PROCESS | 1913 | 03:20:31 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-dft) 03:20:31 INFO - PROCESS | 1913 | RSS: Main: 292765696 03:20:31 INFO - PROCESS | 1913 | 03:20:35 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-fft) 03:20:35 INFO - PROCESS | 1913 | RSS: Main: 382431232 03:20:35 INFO - PROCESS | 1913 | 03:20:37 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49630/tests/kraken/driver.html?testName=audio-oscillator) 03:20:38 INFO - PROCESS | 1913 | RSS: Main: 284499968 03:20:38 INFO - PROCESS | 1913 | 03:20:40 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:40 INFO - PROCESS | 1913 | RSS: Main: 287735808 03:20:40 INFO - PROCESS | 1913 | 03:20:43 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:44 INFO - PROCESS | 1913 | RSS: Main: 330002432 03:20:44 INFO - PROCESS | 1913 | 03:20:47 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49630/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:47 INFO - PROCESS | 1913 | RSS: Main: 331649024 03:20:47 INFO - PROCESS | 1913 | 03:20:50 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49630/tests/kraken/driver.html?testName=json-parse-financial) 03:20:51 INFO - PROCESS | 1913 | RSS: Main: 330502144 03:20:51 INFO - PROCESS | 1913 | 03:20:52 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:53 INFO - PROCESS | 1913 | RSS: Main: 305893376 03:20:53 INFO - PROCESS | 1913 | 03:20:55 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:56 INFO - PROCESS | 1913 | RSS: Main: 310218752 03:20:56 INFO - PROCESS | 1913 | 03:20:58 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:59 INFO - PROCESS | 1913 | RSS: Main: 311996416 03:20:59 INFO - PROCESS | 1913 | 03:21:02 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:02 INFO - PROCESS | 1913 | RSS: Main: 327471104 03:21:02 INFO - PROCESS | 1913 | 03:21:05 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:06 INFO - PROCESS | 1913 | RSS: Main: 321794048 03:21:06 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49630/tests/kraken/driver.html?testName=ai-astar) 03:21:08 INFO - PROCESS | 1913 | RSS: Main: 366219264 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | __start_tp_report 03:21:08 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 03:21:08 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 03:21:08 INFO - PROCESS | 1913 | |i|pagename|runs| 03:21:08 INFO - PROCESS | 1913 | |0;ai-astar;116;113;115;115;127;170;146;113;112;114 03:21:08 INFO - PROCESS | 1913 | |1;audio-beat-detection;141;112;110;148;116;113;113;110;131;111 03:21:08 INFO - PROCESS | 1913 | |2;audio-dft;187;184;187;189;182;184;187;182;184;188 03:21:08 INFO - PROCESS | 1913 | |3;audio-fft;80;60;59;89;62;62;60;59;75;59 03:21:08 INFO - PROCESS | 1913 | |4;audio-oscillator;90;71;85;69;69;70;86;68;69;84 03:21:08 INFO - PROCESS | 1913 | |5;imaging-gaussian-blur;88;88;88;88;89;88;88;88;89;89 03:21:08 INFO - PROCESS | 1913 | |6;imaging-darkroom;96;96;96;96;96;96;94;96;95;95 03:21:08 INFO - PROCESS | 1913 | |7;imaging-desaturate;88;87;87;88;86;87;87;87;87;85 03:21:08 INFO - PROCESS | 1913 | |8;json-parse-financial;61;58;57;57;58;59;58;59;58;58 03:21:08 INFO - PROCESS | 1913 | |9;json-stringify-tinderbox;65;75;70;75;73;71;70;75;71;71 03:21:08 INFO - PROCESS | 1913 | |10;stanford-crypto-aes;91;103;108;99;92;89;90;90;88;90 03:21:08 INFO - PROCESS | 1913 | |11;stanford-crypto-ccm;163;147;145;145;143;146;141;141;184;153 03:21:08 INFO - PROCESS | 1913 | |12;stanford-crypto-pbkdf2;176;174;176;176;175;175;174;175;173;174 03:21:08 INFO - PROCESS | 1913 | |13;stanford-crypto-sha256-iterative;69;79;87;88;84;83;67;66;66;67 03:21:08 INFO - PROCESS | 1913 | __end_tp_report 03:21:08 INFO - PROCESS | 1913 | __start_cc_report 03:21:08 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,2074 03:21:08 INFO - PROCESS | 1913 | __end_cc_report 03:21:08 INFO - PROCESS | 1913 | __startTimestamp1487157668569__endTimestamp 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | ------- Summary: start ------- 03:21:08 INFO - PROCESS | 1913 | Number of tests: 14 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#0] ai-astar Cycles:10 Average:124.10 Median:115.50 stddev:19.21 (16.6%) stddev-sans-first:20.15 03:21:08 INFO - PROCESS | 1913 | Values: 116.0 113.0 115.0 115.0 127.0 170.0 146.0 113.0 112.0 114.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:114.50 stddev:14.15 (12.4%) stddev-sans-first:12.92 03:21:08 INFO - PROCESS | 1913 | Values: 141.0 112.0 110.0 148.0 116.0 113.0 113.0 110.0 131.0 111.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#2] audio-dft Cycles:10 Average:185.40 Median:187.00 stddev:2.50 (1.3%) stddev-sans-first:2.59 03:21:08 INFO - PROCESS | 1913 | Values: 187.0 184.0 187.0 189.0 182.0 184.0 187.0 182.0 184.0 188.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#3] audio-fft Cycles:10 Average:66.50 Median:62.00 stddev:10.82 (17.5%) stddev-sans-first:10.32 03:21:08 INFO - PROCESS | 1913 | Values: 80.0 60.0 59.0 89.0 62.0 62.0 60.0 59.0 75.0 59.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:77.50 stddev:8.90 (11.5%) stddev-sans-first:7.89 03:21:08 INFO - PROCESS | 1913 | Values: 90.0 71.0 85.0 69.0 69.0 70.0 86.0 68.0 69.0 84.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:21:08 INFO - PROCESS | 1913 | Values: 88.0 88.0 88.0 88.0 89.0 88.0 88.0 88.0 89.0 89.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:21:08 INFO - PROCESS | 1913 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 94.0 96.0 95.0 95.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#7] imaging-desaturate Cycles:10 Average:86.90 Median:87.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 03:21:08 INFO - PROCESS | 1913 | Values: 88.0 87.0 87.0 88.0 86.0 87.0 87.0 87.0 87.0 85.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:1.16 (2.0%) stddev-sans-first:0.71 03:21:08 INFO - PROCESS | 1913 | Values: 61.0 58.0 57.0 57.0 58.0 59.0 58.0 59.0 58.0 58.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:3.10 (4.3%) stddev-sans-first:2.18 03:21:08 INFO - PROCESS | 1913 | Values: 65.0 75.0 70.0 75.0 73.0 71.0 70.0 75.0 71.0 71.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:90.00 stddev:6.86 (7.6%) stddev-sans-first:7.19 03:21:08 INFO - PROCESS | 1913 | Values: 91.0 103.0 108.0 99.0 92.0 89.0 90.0 90.0 88.0 90.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:146.50 stddev:13.39 (9.1%) stddev-sans-first:13.45 03:21:08 INFO - PROCESS | 1913 | Values: 163.0 147.0 145.0 145.0 143.0 146.0 141.0 141.0 184.0 153.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 03:21:08 INFO - PROCESS | 1913 | Values: 176.0 174.0 176.0 176.0 175.0 175.0 174.0 175.0 173.0 174.0 03:21:08 INFO - PROCESS | 1913 | 03:21:08 INFO - PROCESS | 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:81.00 stddev:9.41 (11.6%) stddev-sans-first:9.67 03:21:08 INFO - PROCESS | 1913 | Values: 69.0 79.0 87.0 88.0 84.0 83.0 67.0 66.0 66.0 67.0 03:21:08 INFO - PROCESS | 1913 | -------- Summary: end -------- 03:21:08 INFO - PROCESS | 1913 | 03:21:09 INFO - TEST-INFO | 1913: exit 0 03:21:09 INFO - TEST-OK | kraken | took 60555ms 03:21:09 INFO - SUITE-END | took 1179s 03:21:09 INFO - Completed test suite (00:19:39) 03:21:09 INFO - javascript benchmark 03:21:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7126.59531256194, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.1534001159707, 3279.4097062528735, 3286.3591599638066, 3290.7696461247724, 3313.0889005523477, 5348.438413966536, 5485.780568777254, 5492.423295553969, 5537.58468114891, 5569.805056823012, 5505.917411238835, 5531.419200983899, 5534.169874518824, 5549.500544950954, 5600.1599760036015, 4950.480199579047, 4983.601311895058, 5025.748712564376, 5139.486051394868, 5153.484651534835, 5124.0, 5138.229265610151, 5162.948370516303, 5183.196604526304, 5213.843584692447, 4973.602111831045, 4988.67573607718, 4995.850124496271, 5013.423456302536, 5128.333316668846, 5068.645194836363, 5086.982603479319, 5096.541311281965, 5146.536811686966, 5158.97420512895, 5019.272205530214, 5047.873803154914, 5055.4186268579215, 5079.619028572835, 5080.288759573626, 5362.570994320445, 5548.334199895998, 5551.861203469905, 5570.972145139289, 5581.0, 5885.764569417218, 5989.520838332923, 6022.337542870281, 6057.575969682124, 6088.878222435526, 6093.055576385667, 6170.7531698732, 6188.690565471708, 6202.534809889276, 6210.037444196157, 5660.60375773696, 5664.178694089334, 5668.404817494186, 5674.2623458950075, 5693.544516438675, 6136.7852125175405, 6155.0, 6155.784547540815, 6162.168107305456, 6190.0405437157315, 5968.880622387528, 6014.398560143951, 6033.215681961317, 6038.698065096728, 6073.089036644538, 6134.78528251509, 6136.693165341715, 6137.7851775187655, 6139.447449729457, 6144.938550614526, 5826.329972053268, 5881.7647294107755, 6049.243844519435, 6096.634201947809, 6134.447899689049, 5988.490978266809, 6005.519558435402, 6006.219191505076, 6009.609375390585, 6023.849403764853, 4813.446453657804, 4815.686980346266, 4839.177339852234, 4859.708417494961, 4864.197407427806, 4386.627136693417, 4387.714798538149, 4415.735055896656, 4431.357453169272, 4443.355713421536, 5561.888762224733, 5564.499195072382, 5576.219329293902, 5585.106382978704, 5605.943940560543, 5899.616524925866, 6149.0, 6153.753849846045, 6161.0, 6163.414475624809, 5487.533559647474, 5522.475364840334, 5525.226468294442, 5530.225768392428, 5542.11326187808, 5195.428502864682, 5244.816431424882, 5250.028744682246, 5253.106971814801, 5266.0, 6231.158793562811, 6297.055441683784, 6308.8422789429715, 6309.242890853127, 6332.366763323631, 5876.265466816648, 6152.753889844356, 6158.168647232746, 6158.722857471335, 6190.009598464224, 6195.101710252078, 6231.158793562811, 6231.781887633911, 6253.937460625518, 6278.780242691484, 6123.1606109212, 6127.678242056309, 6130.103847650253, 6142.314611233224, 6145.555794388404, 5886.911696324644, 5950.166976623363, 5957.642541447527, 6011.428914253139, 6090.543209259235, 5986.580939334379, 5994.730237139426, 6013.9097913532205, 6014.48876845473, 6055.818325450244, 5963.254593175853, 5972.880542389041, 5977.133315669291, 5981.461668449861, 5985.670788106696, 5573.27547418833, 5628.915566266427, 5635.0, 5663.405342438985, 5714.0, 5935.495482883831, 5937.287525496968, 5975.163477113295, 5992.0, 6025.517958563217, 5699.544036477155, 5773.6824474654295, 5774.393688662798, 5794.565407594531, 5796.94203057964], "value": 5572.820959475282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.96520260980435, 473.82018773254595, 477.6274505885411, 485.46113813666824, 543.9184122381643, 34070.0, 38989.22021559567, 39024.21951560967, 39030.609693903054, 39142.41286380703, 39183.80408097956, 39674.60325396752, 39705.20589588206, 39740.0, 39881.0, 7812.726554570563, 8000.159983201767, 8964.372493925428, 9250.537473126351, 10754.44060611211, 10675.679729608124, 10918.344899306026, 10935.507902144383, 10949.233553651247, 10965.287256328313, 10909.672709818718, 10964.342139471657, 10969.890301096966, 10988.120950323955, 11026.173037022216, 7834.68661253552, 7961.402894782915, 8017.95991020047, 8024.719134830253, 10869.891301086967, 7908.960455197687, 10596.841047384218, 10874.836877446845, 10901.563937442494, 10922.29005114665, 38995.02512437184, 39012.80493597542, 39065.80467097646, 39102.21795564101, 39115.41326880099, 3771.076086358832, 3780.6786423154067, 3782.2624588205313, 3873.477080594112, 3894.9610503894883, 27767.305817354525, 28574.999875004276, 28633.713662863312, 28690.85236590534, 28708.856455717796, 2659.6808382993972, 2978.8659510322086, 3119.2825650100376, 3129.436701393748, 3138.8116712997294, 434960.0, 436757.0, 437443.0, 438313.0, 440111.9999999968, 57870.13194802081, 58257.70871145702, 58263.4173658258, 58341.70829145827, 58475.936229884435, 58745.70627146837, 59076.0, 59259.0, 59274.96162826122, 59432.70283648554, 14555.78166327506, 14781.92609036948, 14791.964562480738, 14820.555383338517, 14869.702605947821, 10947.781044379068, 10992.945035274932, 10996.835047474295, 11012.614558490415, 11048.06091482217, 14814.555563333117, 14832.035917665316, 15331.463398780988, 15613.921930390276, 15628.2185890705, 5815.680137592389, 6635.966820165868, 6663.233728121328, 6672.2994085621285, 6702.530822842452, 829.5437509369943, 830.900291964956, 831.717216146501, 837.9790505237418, 862.8662557303628, 28429.289267768472, 28636.570451443244, 28650.570241446396, 29040.273993150342, 29249.0, 1013.2653825976108, 1015.4973288222377, 1037.6057098302597, 1043.4521876015153, 1170.414792603698, 11999.400029998465, 14047.929760351337, 14647.0, 14680.632984175267, 14949.591125260902, 559104.0, 570619.0, 571670.0, 571883.0, 572152.0, 56008.159877601865, 56187.31438056865, 56267.43732562622, 56391.71804141035, 56424.717876411174, 1329.6476433745065, 1364.8021036949588, 1367.0908845617553, 1368.0902200037262, 1372.5264783649625, 21913.671294930908, 26800.59799103054, 28034.71965280321, 28357.43285134327, 28717.425651486436, 42547.0, 43603.56396435995, 47330.52669473261, 47576.524234757206, 47607.52392476031, 463412.0, 464740.0, 466832.0, 466876.0, 467271.0, 36562.817185914966, 36931.07672308214, 36964.81517592395, 37128.0, 37174.25651487009, 41797.946819753124, 42338.57661423346, 42468.78765606152, 42705.78647106869, 43819.12361752811, 33300.500492492145, 35307.117322067155, 35529.934101976985, 36653.26693466169, 36807.26385472329, 31300.53049204218, 33981.49027764536, 35323.64676353204, 36281.81859090688, 36345.27309453849, 33706.27064355355, 33880.66119338775, 33980.830095849364, 34568.0, 34625.480617791254, 30965.535516967713, 31175.36952171999, 31677.8416107918, 31757.0, 31759.442097633284, 22915.96878140521, 23339.833008349175, 23796.405089872893, 23903.76096239085, 24100.915458804746], "value": 18925.542749060558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8618045871882, 371.4817829128366, 372.2740655721344, 386.41844024742767, 410.98561550345727, 11170.0, 14193.503227387044, 14738.336774845131, 19472.902635486837, 20037.799622003775, 15149.318280677368, 17577.736333955, 20438.18247270111, 20505.794942050576, 20559.486012849688, 5533.363663178736, 5850.76596936122, 5855.0, 5856.590038697293, 5867.7066146692705, 4596.632269418438, 5717.885642287151, 6400.359964003609, 6444.6133232006, 6501.837454063662, 6175.876482470348, 6402.839929001789, 6414.294427612959, 6422.2293324801085, 6440.935590644081, 6235.06474028897, 6383.936160638381, 6392.073149393312, 6399.648019358933, 6422.100905873182, 4428.269335559628, 5139.691618502902, 5407.215953686693, 5541.639793413416, 5596.104623260258, 20858.478538036517, 24735.87632061828, 25315.746842531524, 25372.365690857692, 25676.8716156418, 2631.6052592111146, 2633.973660263392, 2647.761701446879, 2648.284963059982, 2658.1493921944984, 14301.64245893861, 14760.926195369062, 14793.260336983216, 15556.455524056717, 15571.610709732235, 1743.4856717268435, 1787.3297513432462, 1792.4353828543967, 1807.1235450806348, 1829.2682926829375, 112214.0, 125432.0, 126511.10233346507, 127481.36259318644, 128272.0, 11032.338059716443, 11144.554217831359, 11216.719582010352, 11249.156313276373, 11481.655550333504, 11812.881871181178, 14063.789043164361, 14247.216403097722, 14255.287235638383, 14267.92866035684, 8004.359651228005, 8178.918210817935, 8198.631061602124, 8238.464499807493, 8292.33661307094, 8009.159038301011, 8050.838983220303, 8189.467684600482, 8195.262426381654, 8231.753047408587, 5688.0, 6797.5581587196675, 6896.965515172392, 6918.861622767517, 6943.305669433117, 1823.626156637886, 1853.508820162658, 1854.156358856717, 1859.739636450898, 1862.1620270878159, 765.5291995422775, 994.796066806303, 1019.3628981886321, 1030.90206430389, 1033.9534720937577, 20440.693389599168, 21832.0, 21964.670529942065, 21974.670379944313, 22339.218127365788, 1035.3477309295247, 1047.4082143588848, 1073.3720773347522, 1073.6671631794168, 1083.377058191543, 9027.50348730813, 10614.946925265323, 11453.59912403062, 11476.655700328836, 11512.424378781028, 709875.4506227436, 712881.0, 728136.0, 734113.0, 737614.0, 123386.0, 125199.0, 129516.35241823731, 131837.0, 132796.0, 1003.6838395905412, 1028.136365453008, 1050.0654417568371, 1050.4905121016147, 1052.1425038593522, 18388.264469421072, 18989.430317090508, 18998.905005474884, 19008.904955475133, 19079.52301192481, 53943.0, 54308.00542740961, 54866.451335486134, 54949.0, 56158.315250540916, 78922.4215515698, 81343.59328203321, 82353.3529329398, 82787.17212827795, 84215.73676394981, 5028.497150284942, 6372.458341041063, 8280.254777070093, 8517.105703901001, 8599.14008599135, 10940.507677154388, 12521.686957826127, 12815.359232038547, 13090.14914030585, 13146.737065258832, 8976.86534701967, 11235.0, 11256.0, 11302.43487825589, 11346.489407976496, 10110.191184705352, 10919.344839309666, 10949.671509854717, 11280.891713400892, 11402.372869492257, 10744.677659670222, 11183.384913829817, 11318.490667920129, 11351.48918298695, 11790.764184716087, 8202.17978202175, 8311.95844020776, 8387.95806020966, 8497.405181637227, 8524.957375213084, 10661.25371224038, 10661.786764264827, 10996.890288589244, 11063.004329610374, 11280.548778048786], "value": 9810.91036177337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.3264033264034, 1405.7610206264933, 1413.9575812725616, 1427.1365823676676, 1432.498625481081, 7641.465097443182, 7844.960775196116, 7918.722844700436, 7921.217726011651, 7940.40446966477, 8146.75559733209, 8303.543305118232, 8496.1503849615, 8568.957155214215, 8577.31381489481, 2221.9000144993474, 2262.2760716570706, 2265.1732117776974, 2269.0, 2270.4550907782177, 1976.6046790641858, 2068.2761033638258, 2256.3569382725927, 2289.7710228977053, 2292.85096468729, 1723.276223985929, 2011.4468521156653, 2155.5365596396773, 2244.068711484732, 2244.2257421189665, 2207.095091012693, 2221.178164079293, 2227.6324406472913, 2233.129079658934, 2233.218373569254, 2221.7222847144108, 2270.3302525754943, 2278.475950531387, 2278.5556816420803, 2281.6577513372963, 8528.872066919, 8611.26804221642, 8631.395802293842, 8639.52482613456, 8644.005939316934, 4661.696989695659, 5002.89994200114, 5040.47075057121, 5206.271122042917, 5211.635185537014, 2687.2744359022954, 3318.6515415881468, 3430.8456119474686, 3470.2192006798523, 3504.8072356020407, 1076.445630500293, 1195.8624758152837, 1200.9819852702128, 1229.342301868505, 1247.151936683055, 10818.945905270502, 10830.079443247334, 10885.455727213608, 10911.890881091247, 10918.50866711, 4111.60939710727, 4305.956940430556, 4373.737575745466, 4393.428854248928, 4427.092446048552, 8774.341924355698, 8774.473531588124, 8777.517236551923, 8782.297416206688, 8790.824183516423, 5031.496850314939, 5063.088644044034, 5068.543831055223, 5074.061298659686, 5095.31213286209, 4527.320901864747, 4542.750148741851, 4684.391029166187, 4695.201815691273, 4698.060387922429, 3557.2569440974253, 3594.676479116892, 3615.5661320641693, 3632.473291372736, 3651.1419816343137, 878.5168157513342, 956.6699488676395, 1121.9214654974073, 1133.257716195893, 1143.7483753574368, 760.0727112922226, 860.836441076206, 864.6109250837148, 908.2416182487697, 923.7644400677918, 5445.918311225335, 5676.176954341598, 5815.9709201453725, 5829.795957141479, 5833.687420330391, 930.265090578449, 981.1218959031769, 986.5871833084948, 986.713852982627, 996.2776986684596, 3126.499760038383, 3638.8180590970346, 3732.925341493209, 3792.241551689673, 3851.614838516126, 9830.4101753895, 9844.655437059668, 9844.901550984541, 10156.847647285296, 10193.541290641939, 9986.20110391167, 10130.088292053602, 10132.898671013343, 10160.593576257015, 10164.237682173867, 7344.926550734424, 7727.613619319011, 7749.92250077492, 7785.0, 7908.367330613537, 4812.302216178565, 5554.888902222014, 5561.888762224652, 5640.0693885508435, 5753.683547404933, 8912.153345432174, 8937.553122343987, 9223.354365194373, 9337.673181438617, 9351.812963740824, 9054.004059553576, 9121.0, 9362.297827662816, 9442.95278523603, 9476.289278304017, 7555.584442855696, 7837.0987336454755, 7842.568658723825, 7865.724699635485, 7866.370690344645, 7483.214262502576, 7776.183500732342, 7830.960845195966, 7863.567503787347, 7871.291583757489, 5611.971940140274, 6945.374916257561, 7148.320909513588, 7188.388986936169, 7233.3851622612665, 6970.268121847336, 7033.613151276524, 7056.435485161072, 7117.501774875709, 7210.89183662256, 5594.629315817488, 5768.423157684198, 6186.1648677427975, 6246.906296405648, 6363.77726779579, 4894.021195760934, 4939.604831613534, 4989.675671081368, 5018.1218286800395, 5082.390113186293, 4917.827876024465, 4986.700797952134, 4995.8001679932395, 5035.194368900959, 5218.347706536683], "value": 4332.1425139491985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.97520198384126, 343.8373213619832, 356.41903696973935, 359.09149850877276, 360.7745159275453, 4422.766502916023, 5399.433059528752, 5445.237666726652, 5453.700046497446, 5481.972590137048, 4356.78216089195, 4577.702449340791, 5028.0, 5067.290579318898, 5298.947010529903, 4017.156397156586, 4021.135455876993, 4032.516098068236, 4036.3945408188715, 4058.1072164123993, 4071.145059537501, 4075.551689314188, 4081.1022874363416, 4100.56944020878, 4109.815058322368, 3319.983400082996, 3620.8051343056727, 4003.539592946819, 4071.6742660587083, 4077.2864748669012, 3584.982075089634, 3843.7309388342687, 3932.233214523169, 3951.209758048402, 3979.383195604686, 3043.7260646541918, 3407.9488807667904, 3437.604675462329, 3461.3250416168858, 3471.7222622190166, 4249.150169965988, 4489.685721999462, 5093.923591146136, 5170.25031370453, 5182.818601348935, 4250.362445633149, 4484.304932735431, 4534.31985202219, 4599.540045995407, 4605.907881842378, 4719.787609557578, 5054.963732434842, 5147.944671342403, 5528.494277164139, 5537.667739935577, 3394.372041172391, 3565.53648025755, 3787.507624008889, 3805.7906815125157, 3811.2377524495214, 5369.650972686802, 5487.6158668893195, 5567.749451274662, 5823.475887170132, 5827.796027139115, 3553.4136867417105, 3703.814809259526, 3782.7730336179916, 3821.732418781957, 3836.462895194675, 3886.4753258310334, 3890.96109038906, 3899.415087736862, 3900.258950799339, 3900.4539364488996, 4289.871303860889, 4556.744411516321, 4557.339185818104, 4559.931601025921, 4568.291914753218, 4768.833090841804, 5637.8160586277345, 5645.322561292671, 5675.489205971482, 5680.665043714724, 1158.137187795098, 1238.5107882386408, 1265.5383032597365, 1287.3241548187277, 1295.7214198947272, 688.1088989758275, 730.1749023603294, 802.0215337288498, 857.2884505860121, 877.6401675313091, 4225.68307376948, 4531.660125490602, 4837.467878533358, 4881.707097574157, 4981.726005069756, 4604.0, 4768.6661933665, 5018.1218286800395, 5476.17857321405, 5482.956958887776, 4187.032094915385, 4372.628326592212, 4384.430024096847, 4554.517787805654, 4876.683295510264, 2345.753695861944, 2639.3269716222626, 2813.310738868949, 2891.6264774232072, 2896.362800183956, 4956.826511072095, 4998.650094493423, 5747.310322761212, 5776.566757493205, 5782.59521833476, 5016.673916195436, 5276.81531146408, 5559.471850174227, 5643.701948551856, 5714.0, 4581.65637577183, 5121.180611102206, 5538.762846422571, 5621.362376039783, 5625.240592520039, 4756.025014871874, 5104.948950510596, 5121.948780512296, 5425.376081750649, 5458.5087342139395, 4925.458199598113, 5183.015227106837, 5457.590680698884, 5662.405447428126, 5689.630174038674, 4980.651354405301, 5223.764930578057, 6009.45914867664, 6025.427584379477, 6058.394160583906, 3887.4168874669026, 3900.473436086092, 3902.200048990007, 3903.394973779069, 3910.237503686754, 5509.311336082989, 5671.347795003462, 5698.0, 5747.643466178846, 5856.472917437451, 5593.0, 5608.6073974821375, 5645.899049685272, 5646.96709184685, 5684.8010319638615, 5123.002029208537, 5552.611317207757, 5571.470710282517, 5616.0, 5622.791099913538, 5463.0, 5472.72636368188, 5482.711562782663, 5489.176623506346, 5493.2858728366655, 5437.157240627709, 5606.421046318576, 5607.495325420732, 5631.620253037868, 5667.518260947865, 4647.35100992431, 5173.456787037307, 5264.605154613343, 5320.600954928474, 5515.283013208417], "value": 3999.402925050749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4948561778331, 713.8536599997001, 741.0181509499914, 786.3787607789845, 814.6212011414693, 14405.567832965002, 14855.702885942275, 14973.550793476186, 15001.0, 15029.098254104762, 13284.070115091947, 13561.45754169832, 13764.655883602914, 13793.586192414243, 13825.032247742662, 865.7359505350865, 874.6719980007497, 876.3208513402101, 877.3639111644039, 881.801594641207, 739.9926000740004, 835.2441040858002, 863.7970077031893, 883.2448256740458, 885.0043700836559, 926.305271046715, 933.6125507914207, 936.6159874451477, 937.3298091864316, 940.2900809888558, 902.6208992223281, 918.6279556779482, 929.5073610986188, 932.4731526687434, 933.2394098809516, 686.2862622872207, 687.1959807025792, 687.9036934829128, 690.3200347657553, 690.6477696374835, 14533.34599943005, 14750.926245368812, 14792.18642974636, 14799.482018129422, 14913.0, 13490.178825858482, 13625.454981800716, 13674.794878076837, 13897.374618142208, 13948.511802086878, 11289.887101128967, 11487.195896287263, 11542.170830889141, 11682.941585292105, 12085.274883507018, 3503.7897726136257, 3545.964540354589, 3574.2136729919634, 3613.5663720353464, 3710.684591809699, 99723.50414743712, 100431.49784251105, 102906.0, 104613.95386046042, 105931.0, 10457.581696732197, 10529.36823790575, 10691.572337106583, 10710.785784284426, 10835.0, 20016.0, 21792.89103554504, 21854.34436966862, 21865.016074276697, 21865.562688746137, 6186.721597528122, 7199.388052015533, 7214.96392518034, 7304.233055529093, 7365.779026629102, 3808.352580061396, 4112.568180341081, 4176.477940257468, 4177.603127702863, 4185.790710464465, 3472.4270495368487, 3517.402041652874, 3546.1666508370513, 3556.87550935716, 3611.115276757211, 642.9070580013995, 650.443870490733, 651.9706613202417, 665.8468552233013, 667.0960848050821, 652.4975768658106, 676.8950812623953, 685.6366125953252, 697.5953946710896, 705.1432509500981, 8398.79003024917, 9433.0, 9808.901910980941, 9839.803203936024, 9870.21038316933, 649.1820306413953, 681.8227260912198, 686.9107016087877, 693.9167299924042, 702.357343031131, 4461.10777844426, 4754.595859351924, 4760.833370832004, 4767.928481072787, 4784.760761961888, 77678.0, 96959.54560681595, 97883.51058244806, 99204.51193231963, 99217.0, 85190.0, 85659.0, 85914.0, 87844.12155878487, 88169.55915220383, 75850.62074689592, 77165.61417192878, 78848.60575697085, 79378.80931785912, 80407.19592804114, 8756.693515726918, 9182.586783594888, 9182.908170918205, 9306.953465232902, 9380.718578442658, 50212.49787502078, 50325.490235293, 51405.0, 51438.0, 52522.0, 61779.76440471255, 61843.38156618556, 67593.66203168953, 68285.31714682789, 69365.95951060839, 10390.688279351632, 11001.559937602726, 11051.005409513182, 11155.665330040112, 11473.598424055119, 11935.920128875428, 11950.342731149522, 12016.699582510157, 12124.757504849676, 12142.210756300812, 11523.8271425927, 13108.410121544362, 13435.664108397368, 13938.721225575635, 14005.43978240859, 13000.154989925624, 13096.410661520446, 13417.875651515129, 13534.59396218115, 13831.377588008363, 13033.47866085346, 13144.40850161726, 13315.600531984055, 13609.659758506117, 13752.243626600633, 10105.696829095139, 10231.079202871777, 10237.489060386475, 10271.589136434757, 10495.632652857419, 8740.912590874264, 10292.61049758303, 10987.450627468435, 11267.0, 11314.83027754568], "value": 7306.5806290314395, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 115.0, 115.0, 127.0, 170.0, 146.0, 113.0, 112.0, 114.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 110.0, 148.0, 116.0, 113.0, 113.0, 110.0, 131.0, 111.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 187.0, 189.0, 182.0, 184.0, 187.0, 182.0, 184.0, 188.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 89.0, 62.0, 62.0, 60.0, 59.0, 75.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 85.0, 69.0, 69.0, 70.0, 86.0, 68.0, 69.0, 84.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 88.0, 89.0, 88.0, 88.0, 88.0, 89.0, 89.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 94.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 86.0, 87.0, 87.0, 87.0, 87.0, 85.0], "value": 86.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 57.0, 57.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 70.0, 75.0, 73.0, 71.0, 70.0, 75.0, 71.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 103.0, 108.0, 99.0, 92.0, 89.0, 90.0, 90.0, 88.0, 90.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 147.0, 145.0, 145.0, 143.0, 146.0, 141.0, 141.0, 184.0, 153.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 176.0, 176.0, 175.0, 175.0, 174.0, 175.0, 173.0, 174.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 87.0, 88.0, 84.0, 83.0, 67.0, 66.0, 66.0, 67.0], "value": 75.6, "unit": "score"}]}]} 03:21:09 INFO - Return code: 0 03:21:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:09 ERROR - # TBPL SUCCESS # 03:21:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:21:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:21:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:21:09 INFO - 2017-02-15 03:21:09.855 screenresolution[1917:20301] starting screenresolution argv=screenresolution get 03:21:09 INFO - 2017-02-15 03:21:09.858 screenresolution[1917:20301] Display 0: 1600x1200x32@60 03:21:09 INFO - 2017-02-15 03:21:09.864 screenresolution[1918:20304] starting screenresolution argv=screenresolution list 03:21:09 INFO - Available Modes on Display 0 03:21:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:21:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:21:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:21:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:10 INFO - Intel Iris: 03:21:10 INFO - Chipset Model: Intel Iris 03:21:10 INFO - Type: GPU 03:21:10 INFO - Bus: Built-In 03:21:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:10 INFO - Vendor: Intel (0x8086) 03:21:10 INFO - Device ID: 0x0a2e 03:21:10 INFO - Revision ID: 0x0009 03:21:10 INFO - Displays: 03:21:10 INFO - Display: 03:21:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:10 INFO - Display Serial Number: 1600x1200 60 03:21:10 INFO - Main Display: Yes 03:21:10 INFO - Mirror: Off 03:21:10 INFO - Online: Yes 03:21:10 INFO - Rotation: Supported 03:21:10 INFO - Return code: 0 03:21:10 INFO - Running post-action listener: _resource_record_post_action 03:21:10 INFO - [mozharness: 2017-02-15 11:21:10.101900Z] Finished run-tests step (success) 03:21:10 INFO - Running post-run listener: _resource_record_post_run 03:21:10 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 110592; Write bytes: 552751104; Read time: 4; Write time: 1701 03:21:10 INFO - TinderboxPrint: CPU usage
53.9% 03:21:10 INFO - TinderboxPrint: I/O read bytes / time
110,592 / 4 03:21:10 INFO - TinderboxPrint: I/O write bytes / time
552,751,104 / 1,701 03:21:10 INFO - TinderboxPrint: CPU idle
2,218.5 (46.1%) 03:21:10 INFO - TinderboxPrint: CPU system
963.0 (20.0%) 03:21:10 INFO - TinderboxPrint: CPU user
1,628.1 (33.9%) 03:21:10 INFO - TinderboxPrint: Swap in / out
252,403,712 / 0 03:21:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248437248; Write bytes: 243800064; Read time: 17992; Write time: 573 03:21:10 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 110592; Write bytes: 295622656; Read time: 4; Write time: 1092 03:21:10 INFO - Running post-run listener: _upload_blobber_files 03:21:10 INFO - Blob upload gear active. 03:21:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:10 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 03:21:10 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'] 03:21:10 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 03:21:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:21:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:21:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:12 INFO - (blobuploader) - INFO - Done attempting. 03:21:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:21:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:21:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:13 INFO - (blobuploader) - INFO - Done attempting. 03:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:14 INFO - (blobuploader) - INFO - Done attempting. 03:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:16 INFO - (blobuploader) - INFO - Done attempting. 03:21:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:16 INFO - Return code: 0 03:21:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a76da5c6af54c124499386747576fc5a7d62aafb7c18d3d1664e32d42f2fb3828937896546ea729db8ea403faed3a46d043010b1049cd61bac115914ada9a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160044b21e150ae2f32af4162a2d1d2127147ec72a7d96ddbca6846f1af5db2ed6c4db906829458545c2ad7db52e3e1969f60dc62bee0e915950ff671848f5f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f70b430077c4dbaaad623f5b968d4dc533abee6828d754462eb843fa180a474f98082eddc23e4e47f32de92158d7f4b0b684de0da8092e8334a912dada90a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f4d46c25fb2e19e9546168cf129a669877f48cd8f20d411807f9413b74763268bdfa3a644c03b69cb063d99b70a9229ccba66d1df5f1b0cef6084876af30a1"} 03:21:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:16 INFO - Contents: 03:21:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a76da5c6af54c124499386747576fc5a7d62aafb7c18d3d1664e32d42f2fb3828937896546ea729db8ea403faed3a46d043010b1049cd61bac115914ada9a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160044b21e150ae2f32af4162a2d1d2127147ec72a7d96ddbca6846f1af5db2ed6c4db906829458545c2ad7db52e3e1969f60dc62bee0e915950ff671848f5f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f70b430077c4dbaaad623f5b968d4dc533abee6828d754462eb843fa180a474f98082eddc23e4e47f32de92158d7f4b0b684de0da8092e8334a912dada90a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f4d46c25fb2e19e9546168cf129a669877f48cd8f20d411807f9413b74763268bdfa3a644c03b69cb063d99b70a9229ccba66d1df5f1b0cef6084876af30a1"} 03:21:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:16 INFO - Copying logs to upload dir... 03:21:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.508331 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-15 03:21:16.524350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:16.527850) ========= 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.N0Lrv24WJt/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.e0rk29xeLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a76da5c6af54c124499386747576fc5a7d62aafb7c18d3d1664e32d42f2fb3828937896546ea729db8ea403faed3a46d043010b1049cd61bac115914ada9a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160044b21e150ae2f32af4162a2d1d2127147ec72a7d96ddbca6846f1af5db2ed6c4db906829458545c2ad7db52e3e1969f60dc62bee0e915950ff671848f5f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f70b430077c4dbaaad623f5b968d4dc533abee6828d754462eb843fa180a474f98082eddc23e4e47f32de92158d7f4b0b684de0da8092e8334a912dada90a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f4d46c25fb2e19e9546168cf129a669877f48cd8f20d411807f9413b74763268bdfa3a644c03b69cb063d99b70a9229ccba66d1df5f1b0cef6084876af30a1"} build_url:https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a76da5c6af54c124499386747576fc5a7d62aafb7c18d3d1664e32d42f2fb3828937896546ea729db8ea403faed3a46d043010b1049cd61bac115914ada9a95f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160044b21e150ae2f32af4162a2d1d2127147ec72a7d96ddbca6846f1af5db2ed6c4db906829458545c2ad7db52e3e1969f60dc62bee0e915950ff671848f5f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f70b430077c4dbaaad623f5b968d4dc533abee6828d754462eb843fa180a474f98082eddc23e4e47f32de92158d7f4b0b684de0da8092e8334a912dada90a92", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2f4d46c25fb2e19e9546168cf129a669877f48cd8f20d411807f9413b74763268bdfa3a644c03b69cb063d99b70a9229ccba66d1df5f1b0cef6084876af30a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:16.562735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:16.563072) ========= 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.N0Lrv24WJt/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.e0rk29xeLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005295 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:16.612300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:21:16.612655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:21:16.613031) ========= ========= Total master_lag: 2.97 =========