builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1490162211.6 results: success (0) buildid: 20170321204834 builduid: c07d158701bf4f3182c5462409fe5ca3 revision: 201231223cd4354a450c3e5d80959f35b8e4cf0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:51.604257) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:51.604706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:51.604983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:51.630624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:51.631045) ========= 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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-03-21 22:56:51-- 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% 52.3M=0s 2017-03-21 22:56:52 (52.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124753 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:52.076880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:52.077242) ========= 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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.020755 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:52.127511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 22:56:52.127884) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 201231223cd4354a450c3e5d80959f35b8e4cf0c --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 201231223cd4354a450c3e5d80959f35b8e4cf0c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-03-21 22:56:52,211 truncating revision to first 12 chars 2017-03-21 22:56:52,211 Setting DEBUG logging. 2017-03-21 22:56:52,211 attempt 1/10 2017-03-21 22:56:52,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/201231223cd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 22:56:53,092 unpacking tar archive at: mozilla-central-201231223cd4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.138495 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 22:56:53.292065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:53.292369) ========= script_repo_revision: 201231223cd4354a450c3e5d80959f35b8e4cf0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:53.292779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:53.293043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 22:56:53.313058) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-21 22:56:53.313432) ========= /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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:56:53 INFO - MultiFileLogger online at 20170321 22:56:53 in /builds/slave/test 22:56:53 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 22:56:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:56:53 INFO - {'append_to_log': False, 22:56:53 INFO - 'base_work_dir': '/builds/slave/test', 22:56:53 INFO - 'blob_upload_branch': 'Firefox', 22:56:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:56:53 INFO - 'branch': 'Firefox', 22:56:53 INFO - 'buildbot_json_path': 'buildprops.json', 22:56:53 INFO - 'config_files': ('talos/mac_config.py',), 22:56:53 INFO - 'default_actions': ('clobber', 22:56:53 INFO - 'read-buildbot-config', 22:56:53 INFO - 'download-and-extract', 22:56:53 INFO - 'populate-webroot', 22:56:53 INFO - 'create-virtualenv', 22:56:53 INFO - 'install', 22:56:53 INFO - 'run-tests'), 22:56:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:56:53 INFO - 'download_minidump_stackwalk': True, 22:56:53 INFO - 'download_symbols': 'ondemand', 22:56:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:56:53 INFO - 'tooltool.py': '/tools/tooltool.py', 22:56:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:56:53 INFO - '/tools/misc-python/virtualenv.py')}, 22:56:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:56:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:56:53 INFO - 'gecko_profile': False, 22:56:53 INFO - 'gecko_profile_interval': 0, 22:56:53 INFO - 'installer_path': 'installer.exe', 22:56:53 INFO - 'log_level': 'info', 22:56:53 INFO - 'log_name': 'talos', 22:56:53 INFO - 'log_to_console': True, 22:56:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:56:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:56:53 INFO - 'opt_config_files': (), 22:56:53 INFO - 'pip_index': False, 22:56:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:53 INFO - 'cmd': ('bash', 22:56:53 INFO - '-c', 22:56:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:53 INFO - 'enabled': True, 22:56:53 INFO - 'halt_on_failure': False, 22:56:53 INFO - 'name': 'check_screen_resolution'},), 22:56:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:53 INFO - 'cmd': ('bash', 22:56:53 INFO - '-c', 22:56:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:53 INFO - 'enabled': True, 22:56:53 INFO - 'halt_on_failure': False, 22:56:53 INFO - 'name': 'check_screen_resolution'},), 22:56:53 INFO - 'run_cmd_checks_enabled': True, 22:56:53 INFO - 'suite': 'dromaeojs', 22:56:53 INFO - 'system_bits': '32', 22:56:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:56:53 INFO - 'title': 't-yosemite-r7-0102', 22:56:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:56:53 INFO - 'use_talos_json': True, 22:56:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:56:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:56:53 INFO - 'work_dir': 'build'} 22:56:53 INFO - [mozharness: 2017-03-22 05:56:53.518115Z] Running clobber step. 22:56:53 INFO - Running pre-action listener: _resource_record_pre_action 22:56:53 INFO - Running main action method: clobber 22:56:53 INFO - rmtree: /builds/slave/test/build 22:56:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:56:53 INFO - Running post-action listener: _resource_record_post_action 22:56:53 INFO - [mozharness: 2017-03-22 05:56:53.671572Z] Finished clobber step (success) 22:56:53 INFO - [mozharness: 2017-03-22 05:56:53.671648Z] Running read-buildbot-config step. 22:56:53 INFO - Running pre-action listener: _resource_record_pre_action 22:56:53 INFO - Running main action method: read_buildbot_config 22:56:53 INFO - Using buildbot properties: 22:56:53 INFO - { 22:56:53 INFO - "project": "", 22:56:53 INFO - "product": "firefox", 22:56:53 INFO - "script_repo_revision": "production", 22:56:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 22:56:53 INFO - "repository": "", 22:56:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 22:56:53 INFO - "buildid": "20170321204834", 22:56:53 INFO - "pgo_build": "False", 22:56:53 INFO - "basedir": "/builds/slave/test", 22:56:53 INFO - "buildnumber": 27, 22:56:53 INFO - "slavename": "t-yosemite-r7-0102", 22:56:53 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 22:56:53 INFO - "platform": "yosemite_r7", 22:56:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 22:56:53 INFO - "branch": "mozilla-central", 22:56:53 INFO - "repo_path": "mozilla-central", 22:56:53 INFO - "revision": "201231223cd4354a450c3e5d80959f35b8e4cf0c", 22:56:53 INFO - "stage_platform": "macosx64", 22:56:53 INFO - "builduid": "c07d158701bf4f3182c5462409fe5ca3", 22:56:53 INFO - "slavebuilddir": "test" 22:56:53 INFO - } 22:56:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 22:56:53 INFO - Running post-action listener: _resource_record_post_action 22:56:53 INFO - [mozharness: 2017-03-22 05:56:53.675210Z] Finished read-buildbot-config step (success) 22:56:53 INFO - [mozharness: 2017-03-22 05:56:53.675312Z] Running download-and-extract step. 22:56:53 INFO - Running pre-action listener: _resource_record_pre_action 22:56:53 INFO - Running main action method: download_and_extract 22:56:53 INFO - mkdir: /builds/slave/test/build/tests 22:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:53 INFO - trying https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 22:56:53 INFO - Downloading https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 22:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 22:56:55 INFO - Downloaded 1325 bytes. 22:56:55 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 22:56:55 INFO - Using the following test package requirements: 22:56:55 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 22:56:55 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 22:56:55 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 22:56:55 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 22:56:55 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'jsshell-mac.zip'], 22:56:55 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 22:56:55 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 22:56:55 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 22:56:55 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 22:56:55 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 22:56:55 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 22:56:55 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 22:56:55 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:56:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 22:56:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:56:55 INFO - Fetch https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 22:56:56 INFO - Expected file size: 52476217 22:56:56 INFO - Obtained file size: 52476217 22:57:13 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:57:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 22:57:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:57:13 INFO - Fetch https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 22:57:15 INFO - Expected file size: 52476217 22:57:15 INFO - Obtained file size: 52476217 22:57:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 22:57:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:57:30 INFO - Fetch https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 22:57:32 INFO - Expected file size: 14404171 22:57:32 INFO - Obtained file size: 14404171 22:57:32 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')]} 22:57:32 INFO - trying https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 22:57:32 INFO - Downloading https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 22:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 22:57:35 INFO - Downloaded 75278845 bytes. 22:57:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 22:57:35 INFO - mkdir: /builds/slave/test/properties 22:57:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:57:35 INFO - Writing to file /builds/slave/test/properties/build_url 22:57:35 INFO - Contents: 22:57:35 INFO - build_url:https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 22:57:35 INFO - Running post-action listener: _resource_record_post_action 22:57:35 INFO - Running post-action listener: set_extra_try_arguments 22:57:35 INFO - [mozharness: 2017-03-22 05:57:35.781872Z] Finished download-and-extract step (success) 22:57:35 INFO - [mozharness: 2017-03-22 05:57:35.781997Z] Running populate-webroot step. 22:57:35 INFO - Running pre-action listener: _resource_record_pre_action 22:57:35 INFO - Running main action method: populate_webroot 22:57:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:57:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:57:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:57:35 INFO - '--tppagecycles', 22:57:35 INFO - '7'], 22:57:35 INFO - 'tests': ['tsvgm']}}, 22:57:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:57:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:57:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:57:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:57:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:57:35 INFO - 'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:57:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:57:35 INFO - 'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['damp', 'tps']}, 22:57:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:57:35 INFO - 'tests': ['damp', 'tps']}, 22:57:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['dromaeo_dom']}, 22:57:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:57:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['basic_compositor_video']}, 22:57:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:57:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['a11yr', 22:57:35 INFO - 'ts_paint', 22:57:35 INFO - 'tpaint', 22:57:35 INFO - 'sessionrestore', 22:57:35 INFO - 'sessionrestore_no_auto_restore', 22:57:35 INFO - 'tabpaint']}, 22:57:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:57:35 INFO - 'ts_paint', 22:57:35 INFO - 'tpaint', 22:57:35 INFO - 'sessionrestore', 22:57:35 INFO - 'sessionrestore_no_auto_restore', 22:57:35 INFO - 'tabpaint']}, 22:57:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:57:35 INFO - 'ts_paint', 22:57:35 INFO - 'tpaint', 22:57:35 INFO - 'sessionrestore', 22:57:35 INFO - 'sessionrestore_no_auto_restore', 22:57:35 INFO - 'tabpaint']}, 22:57:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:57:35 INFO - 'ts_paint', 22:57:35 INFO - 'tpaint', 22:57:35 INFO - 'sessionrestore', 22:57:35 INFO - 'sessionrestore_no_auto_restore', 22:57:35 INFO - 'tabpaint']}, 22:57:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['a11yr', 22:57:35 INFO - 'ts_paint', 22:57:35 INFO - 'tpaint', 22:57:35 INFO - 'sessionrestore', 22:57:35 INFO - 'sessionrestore_no_auto_restore', 22:57:35 INFO - 'tabpaint']}, 22:57:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['a11yr', 22:57:35 INFO - 'ts_paint', 22:57:35 INFO - 'tpaint', 22:57:35 INFO - 'sessionrestore', 22:57:35 INFO - 'sessionrestore_no_auto_restore', 22:57:35 INFO - 'tabpaint']}, 22:57:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['tsvgx', 22:57:35 INFO - 'tsvgr_opacity', 22:57:35 INFO - 'tart', 22:57:35 INFO - 'tscrollx', 22:57:35 INFO - 'cart', 22:57:35 INFO - 'tsvg_static']}, 22:57:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:57:35 INFO - 'tsvgr_opacity', 22:57:35 INFO - 'tart', 22:57:35 INFO - 'tscrollx', 22:57:35 INFO - 'cart', 22:57:35 INFO - 'tsvg_static']}, 22:57:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:57:35 INFO - 'talos_options': ['--disable-e10s'], 22:57:35 INFO - 'tests': ['tp5o']}, 22:57:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:57:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:57:35 INFO - 'talos_options': ['--disable-e10s', 22:57:35 INFO - '--xperf_path', 22:57:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:35 INFO - 'tests': ['tp5n']}, 22:57:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:57:35 INFO - 'talos_options': ['--xperf_path', 22:57:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:35 INFO - 'tests': ['tp5n']}}, 22:57:35 INFO - 'talos.zip': {'path': '', 22:57:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:57:35 INFO - Running post-action listener: _resource_record_post_action 22:57:35 INFO - [mozharness: 2017-03-22 05:57:35.800306Z] Finished populate-webroot step (success) 22:57:35 INFO - [mozharness: 2017-03-22 05:57:35.800435Z] Running create-virtualenv step. 22:57:35 INFO - Running pre-action listener: _resource_record_pre_action 22:57:35 INFO - Running main action method: create_virtualenv 22:57:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:57:35 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 22:57:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:57:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:57:35 INFO - Using real prefix '/tools/python27' 22:57:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:57:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:57:39 INFO - Installing pip.................done. 22:57:39 INFO - Return code: 0 22:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:57:39 INFO - Reading from file tmpfile_stdout 22:57:39 INFO - Output received: 22:57:39 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) 22:57:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:39 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:57:39 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 22:57:39 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 22:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:39 INFO - 'HOME': '/Users/cltbld', 22:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:39 INFO - 'LOGNAME': 'cltbld', 22:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:39 INFO - 'MOZ_NO_REMOTE': '1', 22:57:39 INFO - 'NO_EM_RESTART': '1', 22:57:39 INFO - 'PAGER': '/bin/cat', 22:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:39 INFO - 'PWD': '/builds/slave/test', 22:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:39 INFO - 'SHELL': '/bin/bash', 22:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:57:39 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:39 INFO - 'USER': 'cltbld', 22:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:39 INFO - 'XPC_FLAGS': '0x0', 22:57:39 INFO - 'XPC_SERVICE_NAME': '0', 22:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:40 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 22:57:40 INFO - Cleaning up... 22:57:40 INFO - Return code: 0 22:57:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:40 INFO - 'HOME': '/Users/cltbld', 22:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:40 INFO - 'LOGNAME': 'cltbld', 22:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:40 INFO - 'MOZ_NO_REMOTE': '1', 22:57:40 INFO - 'NO_EM_RESTART': '1', 22:57:40 INFO - 'PAGER': '/bin/cat', 22:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:40 INFO - 'PWD': '/builds/slave/test', 22:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:40 INFO - 'SHELL': '/bin/bash', 22:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:57:40 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:40 INFO - 'USER': 'cltbld', 22:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:40 INFO - 'XPC_FLAGS': '0x0', 22:57:40 INFO - 'XPC_SERVICE_NAME': '0', 22:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:40 INFO - Downloading/unpacking psutil>=3.1.1 22:57:40 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 22:57:40 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 22:57:40 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 22:57:40 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 22:57:40 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 22:57:40 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 22:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:57:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:43 INFO - Installing collected packages: psutil 22:57:43 INFO - Running setup.py install for psutil 22:57:43 INFO - building 'psutil._psutil_osx' extension 22:57:43 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 22:57:44 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 22:57:44 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 22:57:44 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 22:57:44 INFO - building 'psutil._psutil_posix' extension 22:57:44 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 22:57:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:57:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:57:44 INFO - ^ 22:57:44 INFO - 1 warning generated. 22:57:44 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 22:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:44 INFO - Successfully installed psutil 22:57:44 INFO - Cleaning up... 22:57:44 INFO - Return code: 0 22:57:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:57:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:44 INFO - 'HOME': '/Users/cltbld', 22:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:44 INFO - 'LOGNAME': 'cltbld', 22:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:44 INFO - 'MOZ_NO_REMOTE': '1', 22:57:44 INFO - 'NO_EM_RESTART': '1', 22:57:44 INFO - 'PAGER': '/bin/cat', 22:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:44 INFO - 'PWD': '/builds/slave/test', 22:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:44 INFO - 'SHELL': '/bin/bash', 22:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:57:44 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:44 INFO - 'USER': 'cltbld', 22:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:44 INFO - 'XPC_FLAGS': '0x0', 22:57:44 INFO - 'XPC_SERVICE_NAME': '0', 22:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:57:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:57:47 INFO - Installing collected packages: mozsystemmonitor 22:57:47 INFO - Running setup.py install for mozsystemmonitor 22:57:47 INFO - Successfully installed mozsystemmonitor 22:57:47 INFO - Cleaning up... 22:57:47 INFO - Return code: 0 22:57:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:57:47 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')]} 22:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:48 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')]} 22:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:48 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:57:48 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 22:57:48 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 22:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:48 INFO - 'HOME': '/Users/cltbld', 22:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:48 INFO - 'LOGNAME': 'cltbld', 22:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:48 INFO - 'MOZ_NO_REMOTE': '1', 22:57:48 INFO - 'NO_EM_RESTART': '1', 22:57:48 INFO - 'PAGER': '/bin/cat', 22:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:48 INFO - 'PWD': '/builds/slave/test', 22:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:48 INFO - 'SHELL': '/bin/bash', 22:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:57:48 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:48 INFO - 'USER': 'cltbld', 22:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:48 INFO - 'XPC_FLAGS': '0x0', 22:57:48 INFO - 'XPC_SERVICE_NAME': '0', 22:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:48 INFO - Downloading/unpacking jsonschema==2.5.1 22:57:48 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 22:57:48 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 22:57:48 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 22:57:48 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 22:57:48 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 22:57:48 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 22:57:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:57:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:57:51 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 22:57:51 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 22:57:51 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 22:57:51 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 22:57:51 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 22:57:51 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 22:57:52 INFO - Downloading functools32-3.2.3-2.tar.gz 22:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:57:52 INFO - warning: no files found matching '*.txt' 22:57:52 INFO - no previously-included directories found matching 'build' 22:57:52 INFO - no previously-included directories found matching 'dist' 22:57:52 INFO - no previously-included directories found matching '.git*' 22:57:52 INFO - Installing collected packages: jsonschema, functools32 22:57:52 INFO - Running setup.py install for functools32 22:57:52 INFO - warning: no files found matching '*.txt' 22:57:52 INFO - no previously-included directories found matching 'build' 22:57:52 INFO - no previously-included directories found matching 'dist' 22:57:52 INFO - no previously-included directories found matching '.git*' 22:57:52 INFO - Successfully installed jsonschema functools32 22:57:52 INFO - Cleaning up... 22:57:52 INFO - Return code: 0 22:57:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:52 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:57:52 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 22:57:52 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 22:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:52 INFO - 'HOME': '/Users/cltbld', 22:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:52 INFO - 'LOGNAME': 'cltbld', 22:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:52 INFO - 'MOZ_NO_REMOTE': '1', 22:57:52 INFO - 'NO_EM_RESTART': '1', 22:57:52 INFO - 'PAGER': '/bin/cat', 22:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:52 INFO - 'PWD': '/builds/slave/test', 22:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:52 INFO - 'SHELL': '/bin/bash', 22:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:57:52 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:52 INFO - 'USER': 'cltbld', 22:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:52 INFO - 'XPC_FLAGS': '0x0', 22:57:52 INFO - 'XPC_SERVICE_NAME': '0', 22:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:57:52 INFO - Cleaning up... 22:57:52 INFO - Return code: 0 22:57:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:52 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:57:52 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 22:57:52 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 22:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:52 INFO - 'HOME': '/Users/cltbld', 22:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:52 INFO - 'LOGNAME': 'cltbld', 22:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:52 INFO - 'MOZ_NO_REMOTE': '1', 22:57:52 INFO - 'NO_EM_RESTART': '1', 22:57:52 INFO - 'PAGER': '/bin/cat', 22:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:52 INFO - 'PWD': '/builds/slave/test', 22:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:52 INFO - 'SHELL': '/bin/bash', 22:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:57:52 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:52 INFO - 'USER': 'cltbld', 22:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:52 INFO - 'XPC_FLAGS': '0x0', 22:57:52 INFO - 'XPC_SERVICE_NAME': '0', 22:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:53 INFO - Downloading/unpacking blobuploader==1.2.4 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57:55 INFO - Downloading blobuploader-1.2.4.tar.gz 22:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:57:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:57:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:57:56 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 22:57:56 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 22:57:56 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 22:57:56 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 22:57:56 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 22:57:56 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 22:57:57 INFO - Downloading docopt-0.6.1.tar.gz 22:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:57:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:57:57 INFO - Running setup.py install for blobuploader 22:57:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:57:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:57:57 INFO - Running setup.py install for requests 22:57:57 INFO - Running setup.py install for docopt 22:57:57 INFO - Successfully installed blobuploader requests docopt 22:57:57 INFO - Cleaning up... 22:57:58 INFO - Return code: 0 22:57:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:58 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:57:58 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 22:57:58 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 22:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:58 INFO - 'HOME': '/Users/cltbld', 22:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:58 INFO - 'LOGNAME': 'cltbld', 22:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:58 INFO - 'MOZ_NO_REMOTE': '1', 22:57:58 INFO - 'NO_EM_RESTART': '1', 22:57:58 INFO - 'PAGER': '/bin/cat', 22:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:58 INFO - 'PWD': '/builds/slave/test', 22:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:58 INFO - 'SHELL': '/bin/bash', 22:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:57:58 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:58 INFO - 'USER': 'cltbld', 22:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:58 INFO - 'XPC_FLAGS': '0x0', 22:57:58 INFO - 'XPC_SERVICE_NAME': '0', 22:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-L3DSVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-91L5Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-d0FP3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5pgokn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ah6Ukc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-HGp4Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:58 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kIFFib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-rdRt6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ttPwYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6fKIWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-SdIvPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kjgUTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EuVzEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-gw_z3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-_e2gk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:59 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-1145Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:58:00 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-p_9cAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:58:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:58:00 INFO - Running setup.py install for manifestparser 22:58:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:58:00 INFO - Running setup.py install for mozcrash 22:58:00 INFO - Running setup.py install for mozdebug 22:58:00 INFO - Running setup.py install for mozdevice 22:58:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:58:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:58:00 INFO - Running setup.py install for mozfile 22:58:00 INFO - Running setup.py install for mozhttpd 22:58:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Running setup.py install for mozinfo 22:58:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Running setup.py install for mozInstall 22:58:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Running setup.py install for mozleak 22:58:01 INFO - Running setup.py install for mozlog 22:58:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Running setup.py install for moznetwork 22:58:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:58:01 INFO - Running setup.py install for mozprocess 22:58:01 INFO - Running setup.py install for mozprofile 22:58:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:58:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:58:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:58:02 INFO - Running setup.py install for mozrunner 22:58:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:58:02 INFO - Running setup.py install for mozscreenshot 22:58:02 INFO - Running setup.py install for moztest 22:58:02 INFO - Running setup.py install for mozversion 22:58:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:58:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:58:02 INFO - Cleaning up... 22:58:02 INFO - Return code: 0 22:58:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:02 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:58:02 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 22:58:02 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 22:58:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:58:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:58:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:58:02 INFO - 'HOME': '/Users/cltbld', 22:58:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:58:02 INFO - 'LOGNAME': 'cltbld', 22:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:02 INFO - 'MOZ_NO_REMOTE': '1', 22:58:02 INFO - 'NO_EM_RESTART': '1', 22:58:02 INFO - 'PAGER': '/bin/cat', 22:58:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:02 INFO - 'PWD': '/builds/slave/test', 22:58:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:58:02 INFO - 'SHELL': '/bin/bash', 22:58:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:58:02 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:58:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:58:02 INFO - 'USER': 'cltbld', 22:58:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:58:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:02 INFO - 'XPC_FLAGS': '0x0', 22:58:02 INFO - 'XPC_SERVICE_NAME': '0', 22:58:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GacQEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4sKv8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Ym7O9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-0hi7KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-U6wnG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-7GJVXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GZw9fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-hjtswV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:58:03 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-w9ditZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:58:03 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)) 22:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-8bzYVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:58:04 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)) 22:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kt_Hsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:58:04 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)) 22:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ZljVHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 22:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-OLpw0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:58:04 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)) 22:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6xDQFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:58:04 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)) 22:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-UNpWlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:58:04 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)) 22:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zdusnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:58:04 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)) 22:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:58:04 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-UYiVtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:58:04 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)) 22:58:04 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)) 22:58:04 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)) 22:58:04 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)) 22:58:04 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)) 22:58:04 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)) 22:58:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:07 INFO - Downloading blessings-1.6.tar.gz 22:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:58:07 INFO - Installing collected packages: blessings 22:58:07 INFO - Running setup.py install for blessings 22:58:07 INFO - Successfully installed blessings 22:58:07 INFO - Cleaning up... 22:58:07 INFO - Return code: 0 22:58:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:58:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:58:08 INFO - Reading from file tmpfile_stdout 22:58:08 INFO - Current package versions: 22:58:08 INFO - blessings == 1.6 22:58:08 INFO - blobuploader == 1.2.4 22:58:08 INFO - docopt == 0.6.1 22:58:08 INFO - functools32 == 3.2.3-2 22:58:08 INFO - jsonschema == 2.5.1 22:58:08 INFO - manifestparser == 1.1 22:58:08 INFO - mozInstall == 1.12 22:58:08 INFO - mozcrash == 1.0 22:58:08 INFO - mozdebug == 0.1 22:58:08 INFO - mozdevice == 0.49 22:58:08 INFO - mozfile == 1.2 22:58:08 INFO - mozhttpd == 0.7 22:58:08 INFO - mozinfo == 0.9 22:58:08 INFO - mozleak == 0.1 22:58:08 INFO - mozlog == 3.4 22:58:08 INFO - moznetwork == 0.27 22:58:08 INFO - mozprocess == 0.25 22:58:08 INFO - mozprofile == 0.28 22:58:08 INFO - mozrunner == 6.13 22:58:08 INFO - mozscreenshot == 0.1 22:58:08 INFO - mozsystemmonitor == 0.3 22:58:08 INFO - moztest == 0.8 22:58:08 INFO - mozversion == 1.4 22:58:08 INFO - psutil == 3.1.1 22:58:08 INFO - requests == 1.2.3 22:58:08 INFO - wsgiref == 0.1.2 22:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:58:08 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')]} 22:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:08 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')]} 22:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:08 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:58:08 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 22:58:08 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 22:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:58:08 INFO - 'HOME': '/Users/cltbld', 22:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:58:08 INFO - 'LOGNAME': 'cltbld', 22:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:08 INFO - 'MOZ_NO_REMOTE': '1', 22:58:08 INFO - 'NO_EM_RESTART': '1', 22:58:08 INFO - 'PAGER': '/bin/cat', 22:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:08 INFO - 'PWD': '/builds/slave/test', 22:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:58:08 INFO - 'SHELL': '/bin/bash', 22:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:58:08 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:58:08 INFO - 'USER': 'cltbld', 22:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:08 INFO - 'XPC_FLAGS': '0x0', 22:58:08 INFO - 'XPC_SERVICE_NAME': '0', 22:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 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)) 22:58:08 INFO - Cleaning up... 22:58:08 INFO - Return code: 0 22:58:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:58:08 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')]} 22:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:08 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')]} 22:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:08 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 0x103220b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103223768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ce95e44e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, '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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 22:58:08 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 22:58:08 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 22:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:58:08 INFO - 'HOME': '/Users/cltbld', 22:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:58:08 INFO - 'LOGNAME': 'cltbld', 22:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:08 INFO - 'MOZ_NO_REMOTE': '1', 22:58:08 INFO - 'NO_EM_RESTART': '1', 22:58:08 INFO - 'PAGER': '/bin/cat', 22:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:08 INFO - 'PWD': '/builds/slave/test', 22:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:58:08 INFO - 'SHELL': '/bin/bash', 22:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:58:08 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:58:08 INFO - 'USER': 'cltbld', 22:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:08 INFO - 'XPC_FLAGS': '0x0', 22:58:08 INFO - 'XPC_SERVICE_NAME': '0', 22:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:58:08 INFO - Cleaning up... 22:58:08 INFO - Return code: 0 22:58:08 INFO - Running post-action listener: _resource_record_post_action 22:58:08 INFO - Running post-action listener: _start_resource_monitoring 22:58:08 INFO - Starting resource monitoring. 22:58:08 INFO - [mozharness: 2017-03-22 05:58:08.705639Z] Finished create-virtualenv step (success) 22:58:08 INFO - [mozharness: 2017-03-22 05:58:08.706468Z] Running install step. 22:58:08 INFO - Running pre-action listener: _resource_record_pre_action 22:58:08 INFO - Running main action method: install 22:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:58:08 INFO - Reading from file tmpfile_stdout 22:58:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:58:09 INFO - Reading from file tmpfile_stdout 22:58:09 INFO - Output received: 22:58:09 INFO - Usage: mozinstall [options] installer 22:58:09 INFO - Options: 22:58:09 INFO - -h, --help show this help message and exit 22:58:09 INFO - -d DEST, --destination=DEST 22:58:09 INFO - Directory to install application into. [default: 22:58:09 INFO - "/builds/slave/test"] 22:58:09 INFO - --app=APP Application being installed. [default: firefox] 22:58:09 INFO - mkdir: /builds/slave/test/build/application 22:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:58:29 INFO - Reading from file tmpfile_stdout 22:58:29 INFO - Output received: 22:58:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:58:29 INFO - Running post-action listener: _resource_record_post_action 22:58:29 INFO - [mozharness: 2017-03-22 05:58:29.623230Z] Finished install step (success) 22:58:29 INFO - [mozharness: 2017-03-22 05:58:29.623359Z] Running run-tests step. 22:58:29 INFO - Running pre-action listener: _resource_record_pre_action 22:58:29 INFO - Running main action method: run_tests 22:58:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:58:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:58:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:58:29 INFO - 2017-03-21 22:58:29.637 screenresolution[2282:18083] starting screenresolution argv=screenresolution get 22:58:29 INFO - 2017-03-21 22:58:29.640 screenresolution[2282:18083] Display 0: 1600x1200x32@60 22:58:29 INFO - 2017-03-21 22:58:29.646 screenresolution[2283:18086] starting screenresolution argv=screenresolution list 22:58:29 INFO - Available Modes on Display 0 22:58:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:58:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:58:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:58:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:58:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:58:29 INFO - Intel Iris: 22:58:29 INFO - Chipset Model: Intel Iris 22:58:29 INFO - Type: GPU 22:58:29 INFO - Bus: Built-In 22:58:29 INFO - VRAM (Dynamic, Max): 1536 MB 22:58:29 INFO - Vendor: Intel (0x8086) 22:58:29 INFO - Device ID: 0x0a2e 22:58:29 INFO - Revision ID: 0x0009 22:58:29 INFO - Displays: 22:58:29 INFO - Display: 22:58:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:58:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:58:29 INFO - Display Serial Number: 1600x1200 60 22:58:29 INFO - Main Display: Yes 22:58:29 INFO - Mirror: Off 22:58:29 INFO - Online: Yes 22:58:29 INFO - Rotation: Supported 22:58:29 INFO - Return code: 0 22:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:58:29 INFO - Python 2.7.3 22:58:29 INFO - Return code: 0 22:58:29 INFO - grabbing minidump binary from tooltool 22:58: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')]} 22:58: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 0x102ffed30>, '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 0x102f25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:58: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 22:58: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 22:58: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 22:58:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:58:30 INFO - Return code: 0 22:58:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:58:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:58:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:58:30 INFO - ENV: RUST_BACKTRACE is now 1 22:58:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:58:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:58:30 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/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 22:58:30 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/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 22:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.woa9X5Dz3Z/Render', 22:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:58:30 INFO - 'HOME': '/Users/cltbld', 22:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:58:30 INFO - 'LOGNAME': 'cltbld', 22:58:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:58:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:30 INFO - 'MOZ_NO_REMOTE': '1', 22:58:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:58:30 INFO - 'NO_EM_RESTART': '1', 22:58:30 INFO - 'PAGER': '/bin/cat', 22:58:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:30 INFO - 'PWD': '/builds/slave/test', 22:58:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:58:30 INFO - 'RUST_BACKTRACE': '1', 22:58:30 INFO - 'SHELL': '/bin/bash', 22:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2Szahg4jVZ/Listeners', 22:58:30 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 22:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:58:30 INFO - 'USER': 'cltbld', 22:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:30 INFO - 'XPC_FLAGS': '0x0', 22:58:30 INFO - 'XPC_SERVICE_NAME': '0', 22:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:58:30 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/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 22:58:30 INFO - mozversion application_buildid: 20170321204834 22:58:30 INFO - mozversion application_changeset: 201231223cd4354a450c3e5d80959f35b8e4cf0c 22:58:30 INFO - mozversion application_display_name: Nightly 22:58:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:58:30 INFO - mozversion application_name: Firefox 22:58:30 INFO - mozversion application_remotingname: firefox 22:58:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:58:30 INFO - mozversion application_vendor: Mozilla 22:58:30 INFO - mozversion application_version: 55.0a1 22:58:30 INFO - mozversion platform_buildid: 20170321204834 22:58:30 INFO - mozversion platform_changeset: 201231223cd4354a450c3e5d80959f35b8e4cf0c 22:58:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:58:30 INFO - mozversion platform_version: 55.0a1 22:58:30 INFO - using testdate: 1490162310 22:58:30 INFO - actual date: 1490162310 22:58:30 INFO - starting webserver on 'localhost:50487' 22:58:30 INFO - SUITE-START | Running 2 tests 22:58:30 INFO - TEST-START | dromaeo_css 22:58:30 INFO - operating with platform_type : mac_ 22:58:30 INFO - Initialising browser for dromaeo_css test... 22:58:30 INFO - TEST-INFO | started process 2293 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpBeFsRu/profile http://localhost:50487/getInfo.html) 22:58:32 INFO - PID 2293 | __metrics Screen width/height:1600/1200 22:58:32 INFO - PID 2293 | colorDepth:24 22:58:32 INFO - PID 2293 | Browser inner width/height: 1024/689 22:58:32 INFO - PID 2293 | __metrics 22:58:32 INFO - PID 2293 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:58:32 INFO - PID 2293 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:58:33 INFO - TEST-INFO | 2293: exit 0 22:58:33 INFO - Browser initialized. 22:58:33 INFO - Running cycle 1/1 for dromaeo_css test... 22:58:33 INFO - TEST-INFO | started process 2295 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpBeFsRu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:45 INFO - PID 2295 | RSS: Main: 233799680 22:58:45 INFO - PID 2295 | 23:01:50 INFO - PID 2295 | Cycle 1(1): loaded http://localhost:50487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50487/tests/dromaeo/cssquery-ext.html) 23:01:54 INFO - PID 2295 | RSS: Main: 487563264 23:01:54 INFO - PID 2295 | 23:03:35 INFO - PID 2295 | ************************* 23:03:35 INFO - PID 2295 | A coding exception was thrown and uncaught in a Task. 23:03:35 INFO - PID 2295 | 23:03:35 ERROR - PID 2295 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:03:35 INFO - PID 2295 | Full stack: 23:03:35 INFO - PID 2295 | ************************* 23:04:57 INFO - PID 2295 | Cycle 1(1): loaded http://localhost:50487/tests/dromaeo/cssquery-ext.html (next: http://localhost:50487/tests/dromaeo/cssquery-jquery.html) 23:04:57 INFO - PID 2295 | RSS: Main: 363700224 23:04:57 INFO - PID 2295 | 23:08:00 INFO - PID 2295 | Cycle 1(1): loaded http://localhost:50487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50487/tests/dromaeo/cssquery-mootools.html) 23:08:00 INFO - PID 2295 | RSS: Main: 333774848 23:08:00 INFO - PID 2295 | 23:11:03 INFO - PID 2295 | Cycle 1(1): loaded http://localhost:50487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50487/tests/dromaeo/cssquery-prototype.html) 23:11:03 INFO - PID 2295 | RSS: Main: 328151040 23:11:03 INFO - PID 2295 | 23:14:07 INFO - PID 2295 | Cycle 1(1): loaded http://localhost:50487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50487/tests/dromaeo/cssquery-yui.html) 23:14:07 INFO - PID 2295 | RSS: Main: 331948032 23:14:07 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | Cycle 1(1): loaded http://localhost:50487/tests/dromaeo/cssquery-yui.html (next: http://localhost:50487/tests/dromaeo/cssquery-dojo.html) 23:17:11 INFO - PID 2295 | RSS: Main: 540594176 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | __start_tp_report 23:17:11 INFO - PID 2295 | _x_x_mozilla_page_load 23:17:11 INFO - PID 2295 | _x_x_mozilla_page_load_details 23:17:11 INFO - PID 2295 | |i|pagename|runs| 23:17:11 INFO - PID 2295 | |0;dojo.html;3337.0345105732526;3361.1093060339;3377.9662203377957;3433.1073920780595;3436.82815859207;6141.877162456748;6150.969245153768;6152.415520525554;6164.907526387102;6184.381561843819;6099.309783606499;6105.77884423116;6125.693326622244;6161.599496032754;6170.506359491241;5110.540051395374;5413.133898576229;5560.7219639018085;5581.581381396391;5703.54371650267;5589.469000444971;5606.859828504279;5644.125160600113;5654.773809047633;5676.659400435987;5313.814016509404;5373.59698022646;5379.300690910157;5448.91826622601;5551.666899985973;5527.170924361338;5577.247071645316;5585.916211256835;5588.720563971785;5623.803166889139;5501.642393244466;5507.03626865297;5507.917381239285;5508.504234618864;5527.170924361338;5923.407659234085;6202.34875338092;6210.254769427653;6218.036204388327;6228.906566401508;6349.4602958748565;6382.234131904155;6387.776427825004;6396.712147953353;6409.230892292908;6472.3204063573585;6474.870502589922;6492.675366231717;6613.239477460057;6635.071090047397;6200.038993955944;6295.055741638699;6299.181106456132;6308.243010838729;6311.747530098791;6750.291219421988;6766.391024807693;6767.187937447439;6767.864642707118;6771;6287.591306565058;6355.237371515448;6364.981602943507;6367.267764207176;6383.808485745342;6440;6453.612783233021;6456.806295811133;6472.838179045561;6478.157839480931;6385.106085148083;6387.105805187278;6422.74309027643;6486.805395838132;6499.2850786413455;6548.9017664735065;6561.0814485972005;6565.474762019027;6575.112359831362;6620.205575330991;5254.238135470336;5257.658252213594;5267.367915850123;5274.103402421598;5305.177697456823;4480.439945006874;4580.1755683976535;4637;4640.303954406799;4685.1332503486965;5519.972400137974;6176.320604733476;6187;6194.566380353423;6211.751529938842;6590.340965903467;6591.670416479157;6592;6598.571092878948;6610.272869984298;5998.970005150034;6112.51099912006;6186.907196392058;6187.783427580013;6195.752169913243;5683.090705487102;5725.627834190765;5775.942240577624;5779.393163717749;5804.419558044162;6766.796996090224;6826.180858296838;6828.975653651992;6848.897266541106;6853.7943861684225;6350.618962862059;6582.76960306387;6610.735570577315;6625.304343044104;6628.767993120217;6609.966950165219;6645.202575690948;6652.368025037614;6667.19993600771;6672.332766723289;6411.4229719325485;6415.71129299192;6421.614703117828;6428.710708018057;6439.130717353098;6453.257875344396;6532.771353002622;6548.246951600437;6580.670966451563;6592.274849766618;6416.358364163733;6429.099926010455;6430.710618022106;6434.485241180788;6442.226932768098;6408.935910640834;6425.1004859320665;6430.228372595318;6433.324500927335;6438.742450301936;6182.1345011699295;6257.78097766576;6258.311585725475;6276.278228003838;6341.904871427025;6153;6309.148264984168;6313.179286692701;6340.080688300263;6342.207224096988;6274.435300822948;6297.748090076529;6341.524385671001;6352.301246862934;6359.109724638462 23:17:11 INFO - PID 2295 | |1;ext.html;787.755795703332;807.6607824713619;1126.6957921361234;1152.1186292486245;1154.9249298795573;34583.481247781274;35103.4734478983;35109.94670159896;35350.93947181582;35392.46911296326;38401.03997400066;38808.61191388092;38818;38823;38883;5949.345571987078;8362.958185209081;8524.531150786705;8524.957375213145;8536.615852286632;6009.278886533622;8250.092489826115;8412.621432035543;8413.70552030679;8463.534505602189;8478.66085356585;8514.318854491627;8633.179847914438;8639.65441382344;8642.265407440374;6008.939910600881;8491.23578877901;8595.398322117455;8596.656133754643;8613.181747733955;6038.57729958903;6112.083187521907;6119.908201376983;6143.539234557426;8080.39397045224;36495.4525682115;36823.631763682286;36916.07709807276;36967;36976.44535331972;2937.6621688505884;2939.5884576159356;2980.821150730963;2989.865456054483;3055.8777648894015;20688.5862282755;27087.458250834872;27211.183664490098;27494.450110997666;27613.86193069022;2788.3726161613677;2798.4682910247193;2801.1176479408923;2821.5485522316535;2833.192540126054;320195;322781;323309;325059.61099141685;325093.9999999976;36913.815430922674;37578.81210593984;48810.755946220044;48825.75587122042;48867.5113248863;48486;49029.754851225516;49107.754461227465;49139.017219655405;49164;11853.585124520772;13554.322283885766;14002.439902403994;14032.579022629337;14080.295985200699;11440.256383335223;11444.942775286238;11445.370504622326;11459.541618335339;11715.707107322385;13201.73596528064;13210.603681889559;13211;13256;13341.132826366254;4757.14371413142;5637.26715526987;5653.378128405872;5664.376918538957;5673.8297851064535;887.3123329419751;891.772597987522;944.7260294514651;966.0098399140937;978.1148061004802;24078.51842963131;24100.87949560241;24133.276001719976;24178.51642967131;24571.508569828504;1053.7681710023783;1062.1874266186219;1098.1763677242068;1103.8564986551696;1116.3748300951493;11918;12271.509139634492;12351.3824308786;12377.257364557976;12416.255024698547;399049;399728;401054;401245;402131;55213;55222.89554208893;55255.342339729876;55341.44658553363;55455.72272138613;1411.089847048648;1435.2868363271868;1484.2504535209434;1487.5834766265464;1495.6559991202084;23097.65353519665;23190.536189275783;23200.535989279782;23257.76742232556;23270.534589308456;37623.43564846584;37717;37734;37812.62187378091;37845.243095138496;404308;406027;408622;408768;409443;25219.621705674064;28639.856800715865;30529;30542.84728576343;33134.83432582822;38430.231395372495;39199.608003919595;39268.80365598154;40248.1950360997;41252.58747412488;33511.32977340391;33761.324773503904;33856.49215261724;34198;35010;31491.897783577464;32653.836730816194;33343.83328083344;33751.83124084364;34337;33401.830935917125;33920.321593568486;33981.83009084939;34245.97262082141;34401.65598343984;25932.481350373266;27136.72863271342;30314.090577282717;30465.695343046285;30506.237344066576;22820.201292954665;23056;23269.88365058164;23315.883420582788;23414.297571072893 23:17:11 INFO - PID 2295 | |2;jquery.html;418.8931822385291;424.3570989950228;425.82115511485176;429.8559982405894;444.6154076723635;19338.51653708656;20585.794142058574;21341.93290335485;21747.565048699016;22108.447288817788;21424.03591838367;21895.452613684665;22875.771242287574;22945.967431465582;23067.769322306773;6097.115918191871;6293.716782744765;6309.589876658002;6316.147320111795;6326.08271800591;6018.6689732064715;6228.8442788930415;6296.779612713556;6311.431971122598;6312.179416675825;6057;6271.905921411182;6273.937260627381;6311.242650881901;6326.525510586702;6160.537959653022;6297.307296197415;6312.747490100413;6326.49388048955;6328.462080723144;5332.866678333034;5485;5565.972170139124;5600.635958662715;5603.80386686464;27079.729202707917;27659.723402765914;27745.445091098067;27761.86119069412;27958.720412795814;1815.337401848316;1967.567135230247;1980.6236815005248;1997.7702564205158;2028.8174064334132;15340.769888451681;15592.220388980506;15884;16319.34722611106;16557.337706491726;1632.167594526788;1649.1177220187142;1658.5356100291817;1669;1687.4009726547022;114209.71580568425;120108;122067;128037;129858.3507082468;11483.77032459346;12091;12106.75786484283;12111.939440302918;12650.292210551457;16199.595010124605;16243.106629135511;16274.75587866183;16275.430359937345;16277.186140692918;7330.523515971551;8486.0665326814;8725.607347669371;8755.453524542138;8908.020117787039;6609.405153536109;8309.626066827008;8500.787480312918;8529.061803201643;8604.053554109043;7553.811154721176;7714.421418393643;7755.302022817974;7755.3855456003585;7757.7672669819995;1767.814379490135;1789.3737191982962;1956.4815323939167;2050.39513343564;2072.6062048210792;795.3517882925397;869.5782545465444;905.6965916418073;928.2063835420618;949.808642959655;18602.813971860378;19593.902030489757;19896.403107906786;19935.60128797416;20501.282455114;940.6190492850407;956.0732493087625;964.5225613321311;971.771633666088;987.1411871671692;10208.591656333812;10630.096441802534;11943.641690749291;12128.69678258033;12910.289934053717;610303;689155;720922;724349;730909;118239;120932.39533802451;138549.30725346308;150614;159538;1197.6706405738491;1213.9271643701406;1251.2117366059324;1251.881071298207;1255.54172726954;17677.213014302437;21616.67574986345;21722.34832955014;21953.67069493991;22217.77782222157;54348.18477722758;58381;58504.82990340255;60709.69645151922;62977.37022629715;81639;81664;83143.16856831354;83154.58422707848;84240.57879710563;10913.890861091606;11907.46416411281;12213.389330533615;12401.75196496047;12807.359632018548;12686;13589.86410135886;13623.795643065163;13985.44058237659;14023.439062437388;11523.53905843757;11576.536938522364;11919.344436055753;11974.521019159485;11995.160338776202;11002.22984391117;11487.310761354345;11557.24877882935;11558.364289964133;11923.9864611509;11723.179377443497;11832.585859494877;11973.580924667594;12027.158098933342;12116.333601651993;12184.512619495476;12335.50657973671;12469.563565275172;12617.36913154357;13310.667233319244;11675;11859.703507412383;12204.450799713857;12271.263724176579;12309.076819238413 23:17:11 INFO - PID 2295 | |3;mootools.html;1156.3928937307917;1320.2276668149134;1375.0512146618833;1398.9930050349747;1399.9300034998248;7521.699132034719;9539.236861051117;10505.422201778909;10815;10837.349759014465;10576.153907687385;10690.679279621605;10698.411587362692;10766.977137171956;10829.025387715104;2047.7030830529563;2303.7120359955047;2365.5387199496104;2368.052778888441;2368.6210206366986;1949.6100779844016;2089.6656534954336;2174.0542863854193;2439.524292762912;2452.766987136219;2409.229046705055;2437.683101196842;2437.9634305485433;2440.7681270279295;2443.157110796781;2389.247387073075;2424.8908799104083;2425.551273014498;2431.9878400607886;2432.1244352033254;2340.719113706349;2354.5048893952294;2415.0219161239725;2418.6130219164847;2420.9394765130837;10810.027097561178;10906.454677266185;10914.945425272903;10919.836202456969;10953.34279943206;5587.245721827542;5763.855903602402;5774.82675519735;5781.219535362714;5794.333651630074;3703.203811180609;3789.2421515696697;3867.690584753213;3947.1710940702487;4010.3984402339593;1066.3761699405857;1116.6315116011779;1157.7510835170394;1173.3312012153076;1201.195199216527;15079.095254284668;15274.31265593051;15278;15308.234588270654;15316.617084572976;5360.276362691065;5559.388467268597;5702.059160238514;5709.314882214161;5719.571032172604;12794.552190673281;12826.486940522274;12830.101892867597;12832.29422381778;12835.871641283655;6421.197350331208;6425.5502114851515;6429.742810287629;6436.16329877113;6439.581427207217;4930.802767889244;5602.075657516546;5635.380108188096;5787.71061446926;5844.7205589820005;3799.088218827517;3946.427767973685;4171.395147703566;4239.872803815891;4268.914621707549;1230.3356187658565;1254.3728135932033;1265.436880588148;1265.9556915507912;1275.8724127587168;750.3584435307733;757.4508481350977;778.7157687444155;782.6869252299012;790.5256845892419;5366.409694933554;5524.972375138099;5817.505512031525;5991.951408503494;6306.306306306303;840.7183593496247;871.6121326009865;883.9425437346681;915.7435917942987;921.530019689963;3302.8018318900945;3477.043812951408;3785.37541305687;3821.7898015609408;3892.902677433087;13406.731865362639;13968.58094257174;14028.158310501403;14202.786958195635;14211.928940355232;13837.238951857744;13920.58238252854;14065.648358791112;14116.364763585663;14126.223057731924;10079.848802267972;10168.949155254177;10183.999999999853;10220.948895255477;10288.12550933179;6374.776882809079;6408.487321014401;6513.100087866511;6540.280569137486;6675.33246675348;12055.397230138633;12314.322712250912;12409.08386529183;12486.375681216085;12544.121911466475;12407.193532420364;12715.364231788188;12907.612771616867;12925.15986460877;13098.803517947428;8383.119772423808;8411.579421029046;8442.32461403074;8450.323974082181;8746.256568191775;10145.492725363554;10154.238432117472;10251.641192558225;10260.538275777459;10269.743256418351;8699.521526316114;8914.821703566022;8977.28181745472;9010.954945225232;9014.774630634287;8687.39188256816;8692.043875173853;8750.387472876837;8798.47209167452;9000.549972501218;7723;7884.763457096296;7890.289873911375;7893.960530197312;7900.051993760785;5703.8859222816145;5813.418658134153;5835.503982161564;5994.3705910878725;6038.607490513278;5881.5588830838715;6014.1580178775885;6089.086637004485;6181.505479561534;6236.158118653923 23:17:11 INFO - PID 2295 | |4;prototype.html;382.30611440235975;387.38212550981194;391.2859032266115;393.06254582819986;395.6103238310265;5493.807716729911;5576.079946808777;5826.300843898733;5929;5945.762169513214;5042.344495215626;5629.7333100052465;5731.770729170838;5788.27646544182;5873.412658734124;3911.02224443889;4369.563043695637;4545.204589196894;4559.863204103882;4581.7709114544305;4253.553376895412;4538.228501154812;4553.42731356784;4563.954360456386;4580.297624401603;4311.698181127323;4507.72953622782;4523.6607254455885;4537.773111344436;4538.319252112193;4477.902913786111;4478.664100192483;4496.348029535699;4501.414816073922;4510.548945105496;3970.642642162219;3994.6005399460114;4021.597840215955;4024.7987600619854;4040.616141466556;4738.4313882334;4783.928241076386;5749.885002299972;5750.827475175752;5789.2763404574425;4294.518391155047;5140.563052140573;5189.714565698885;5196.220566914993;5199.126650645256;5496.203050557647;6297.874042519124;6362.936370636327;6373.71318290678;6384.585001974857;4122.732022418533;4235.2800023996;4282.593153650399;4283.229018776619;4294.141171765628;5911.793087242012;6287.339829317947;6491.870162596769;6597.1423714916755;6717.816709569361;4050.675945924319;4189.518205406356;4191.3293872980175;4205.873823785291;4209.116085621992;3851.67260782831;4249.405083288342;4375.846845360397;4394.846180383671;4413.3159360299205;4285.46431696038;4941.851744447672;5098.4646612105935;5152.433232344439;5186.014657215117;5650.660960342392;6036.637801731822;6170.290416602058;6173.753049877954;6358.809235722936;1491.8885430354455;1500.724384273359;1501.9549413517611;1504.9398024079132;1509.3585226279008;926.6988228825659;942.4580866002076;984.6996666016934;1009.742515658517;1010.570507534295;4900.917110228139;5193.611398368373;5390.21841832932;5908.852278692981;5914.408559144137;5917.911231331534;6540.313267106981;6540.771073012422;6559.24568674599;6602.669866506655;5711.885762284731;5867.237259156283;5890.705464726832;5911.7635294587735;5933.465988061095;2749.8900043998015;3380.9661903381143;3427.520147179397;3431.519587257786;3447.293304872495;6269.843253918597;6759.425448836904;6764.154480689914;6797.286284940109;6842.281560436182;5619.831405057855;5714.142878568165;6644.468442524587;6718.260991290954;6767.2894346093935;5951.672658003765;6423.916520070486;6814.718593090394;6818.318168183241;6822.522423430411;6477.4494167996245;6530.67346632657;6539.11721917554;6553.4101930826455;6564.868702626016;5666.498377929935;6439.903401449075;6458.967705161444;6488.967555162194;6496.888511233773;6141.113676572004;6451.54839161273;6611.801645950629;6722.865542689216;6783.93216067833;3316.2869982952816;3886.989382760446;4208.684348673801;4334.653227741836;4360.694751367374;5177.663451875616;5583;6151.8926593213655;6562.639054852029;6565.80302590923;6286.685665716787;6287.968560157353;6304.621722696653;6310.6213627182515;6333.701591173891;4789.898323385711;5264.657797243167;6060.939335616162;6078.3921607838865;6341.7780377688405;4898.94672645383;5148.58811295088;5510.256115424367;6126.387361263838;6178.289496707936;5193.636445448782;5473.917891231555;6194.938050619617;6301.180846489927;6443.420092191725;4855.830045948375;5327.786888524415;6002.609830361012;6026.8764789167035;6164.229471316085 23:17:11 INFO - PID 2295 | |5;yui.html;726.5495392856429;731.5318196354334;732.5677850068461;741.6143605325227;749.093596747935;14825;15053.021553599008;15319.327605080445;15343.539693809176;15353.692926141484;14810.925945370285;14951.850481495181;14954.401823927057;14964.775528367083;14989.850101498982;921.0927236671873;928.5635751196927;939.3940908114262;942.4157022645969;945.9668911588096;945.8155659646371;950.9001554836747;952.3524003677496;952.6046690623383;954.9427034377925;955.7085089047838;1001.1040119093443;1006.9446180460071;1007.7833265847842;1009.6264382178567;996.7906739584696;997.0876647867229;997.6258902911409;998.1366118307684;998.3760149906309;733.4645708632675;736.5838301359714;736.8121129112096;737.0160835284901;738.970441182352;15721.292541835644;15786.368545258176;15868.444604438904;16088.034717916846;16244.51266462008;14375.78436323456;14689.485867994568;14816.3332650031;14821.925890370587;14871.851281487156;11762.17664763467;11801.46893389791;11816.827257375619;12046.698832529257;12301.815472767916;3066.9233269168226;3122.016564782109;3162.968370316313;3166.5566820645126;3189.9043028709175;99531.0046899529;103854.48072759663;104830.47584762104;107288;109029;10229.897701022894;10876.945615271872;11117.610883619034;11566.496355473735;11768.235064720766;24870.253892383258;24874.626880596807;24877.751222487906;24897.62653560198;24916.5016699665;6747.6626168692355;7633.618319084024;7710.884336734954;7723.34351580122;7888.605569721606;3985.7608543487486;4075.775832329191;4079.1433798902563;4138.482689663792;4143.212789569972;3983.960160398417;4009.759414435085;4078.4290199372113;4095.733777304525;4099.1596722672375;693.5526585352419;789.5933594198992;791.2680770287461;800.139849661616;804.8068463568701;553.6318348298337;556.6020295488664;557.9888402231933;567.7360027587109;593.0629605223736;9514.238860891111;9888.703338899844;10014.39913605186;10145.64490242838;10168.949155254177;533.3519773475247;551.5868077162414;567.7360027587192;581.4708615160184;583.072914066636;4138.379243113557;4611.746353950498;4626.838244423803;4666.070884736232;4711.387519622427;71681.28318716746;74342.62828685822;77813;89042;90569.54715226381;61113;65679.67160164169;66144.33855661478;72826.63586682138;75839.24160758432;58191;65315.73421328914;66338.66830665912;66525.66737166283;67322.66338668275;9383.202427793714;9866.753331166778;9962.55168517404;9964.701058968243;9990.700278991642;22280.554388912456;32312.515312270803;32394;32411.351772963935;32470.512942305413;42368.57631423646;42932.57067429286;62778.372216277254;64251.35748642454;67447;13534.822601839825;13731.24478153711;13834.515791947233;13978.44086236539;14189.361478733275;13199.934000329937;14095.154290742588;14371.425142994163;14809.851901480848;15224.238788060775;13553.661158471117;13640.522581709592;13723.45106195741;13850.515231966832;14015.299235038003;13569.389377477839;13657;13773;13782.310884455937;14378.065425747292;13335.733285334432;13399.933000334935;13538.120022198525;13558.728825423634;14062.718745625234;10459.895401045893;10817.025367579687;10846.349219046882;10990.835137473105;11731.88268117308;9791.461469618955;11241.437928103398;11242.66272011841;11511.884881151082;11584.536618535165 23:17:11 INFO - PID 2295 | __end_tp_report 23:17:11 INFO - PID 2295 | __start_cc_report 23:17:11 INFO - PID 2295 | _x_x_mozilla_cycle_collect,3371 23:17:11 INFO - PID 2295 | __end_cc_report 23:17:11 INFO - PID 2295 | __startTimestamp1490163431383__endTimestamp 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | ------- Summary: start ------- 23:17:11 INFO - PID 2295 | Number of tests: 6 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | [#0] dojo.html Cycles:165 Average:6072.72 Median:6309.15 stddev:686.45 (10.9%) stddev-sans-first:654.14 23:17:11 INFO - PID 2295 | Values: 3337.0 3361.1 3378.0 3433.1 3436.8 6141.9 6151.0 6152.4 6164.9 6184.4 6099.3 6105.8 6125.7 6161.6 6170.5 5110.5 5413.1 5560.7 5581.6 5703.5 5589.5 5606.9 5644.1 5654.8 5676.7 5313.8 5373.6 5379.3 5448.9 5551.7 5527.2 5577.2 5585.9 5588.7 5623.8 5501.6 5507.0 5507.9 5508.5 5527.2 5923.4 6202.3 6210.3 6218.0 6228.9 6349.5 6382.2 6387.8 6396.7 6409.2 6472.3 6474.9 6492.7 6613.2 6635.1 6200.0 6295.1 6299.2 6308.2 6311.7 6750.3 6766.4 6767.2 6767.9 6771.0 6287.6 6355.2 6365.0 6367.3 6383.8 6440.0 6453.6 6456.8 6472.8 6478.2 6385.1 6387.1 6422.7 6486.8 6499.3 6548.9 6561.1 6565.5 6575.1 6620.2 5254.2 5257.7 5267.4 5274.1 5305.2 4480.4 4580.2 4637.0 4640.3 4685.1 5520.0 6176.3 6187.0 6194.6 6211.8 6590.3 6591.7 6592.0 6598.6 6610.3 5999.0 6112.5 6186.9 6187.8 6195.8 5683.1 5725.6 5775.9 5779.4 5804.4 6766.8 6826.2 6829.0 6848.9 6853.8 6350.6 6582.8 6610.7 6625.3 6628.8 6610.0 6645.2 6652.4 6667.2 6672.3 6411.4 6415.7 6421.6 6428.7 6439.1 6453.3 6532.8 6548.2 6580.7 6592.3 6416.4 6429.1 6430.7 6434.5 6442.2 6408.9 6425.1 6430.2 6433.3 6438.7 6182.1 6257.8 6258.3 6276.3 6341.9 6153.0 6309.1 6313.2 6340.1 6342.2 6274.4 6297.7 6341.5 6352.3 6359.1 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | [#1] ext.html Cycles:180 Average:50820.37 Median:34369.33 stddev:100429.38 (292.2%) stddev-sans-first:100640.86 23:17:11 INFO - PID 2295 | Values: 787.8 807.7 1126.7 1152.1 1154.9 34583.5 35103.5 35109.9 35350.9 35392.5 38401.0 38808.6 38818.0 38823.0 38883.0 5949.3 8363.0 8524.5 8525.0 8536.6 6009.3 8250.1 8412.6 8413.7 8463.5 8478.7 8514.3 8633.2 8639.7 8642.3 6008.9 8491.2 8595.4 8596.7 8613.2 6038.6 6112.1 6119.9 6143.5 8080.4 36495.5 36823.6 36916.1 36967.0 36976.4 2937.7 2939.6 2980.8 2989.9 3055.9 20688.6 27087.5 27211.2 27494.5 27613.9 2788.4 2798.5 2801.1 2821.5 2833.2 320195.0 322781.0 323309.0 325059.6 325094.0 36913.8 37578.8 48810.8 48825.8 48867.5 48486.0 49029.8 49107.8 49139.0 49164.0 11853.6 13554.3 14002.4 14032.6 14080.3 11440.3 11444.9 11445.4 11459.5 11715.7 13201.7 13210.6 13211.0 13256.0 13341.1 4757.1 5637.3 5653.4 5664.4 5673.8 887.3 891.8 944.7 966.0 978.1 24078.5 24100.9 24133.3 24178.5 24571.5 1053.8 1062.2 1098.2 1103.9 1116.4 11918.0 12271.5 12351.4 12377.3 12416.3 399049.0 399728.0 401054.0 401245.0 402131.0 55213.0 55222.9 55255.3 55341.4 55455.7 1411.1 1435.3 1484.3 1487.6 1495.7 23097.7 23190.5 23200.5 23257.8 23270.5 37623.4 37717.0 37734.0 37812.6 37845.2 404308.0 406027.0 408622.0 408768.0 409443.0 25219.6 28639.9 30529.0 30542.8 33134.8 38430.2 39199.6 39268.8 40248.2 41252.6 33511.3 33761.3 33856.5 34198.0 35010.0 31491.9 32653.8 33343.8 33751.8 34337.0 33401.8 33920.3 33981.8 34246.0 34401.7 25932.5 27136.7 30314.1 30465.7 30506.2 22820.2 23056.0 23269.9 23315.9 23414.3 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | [#2] jquery.html Cycles:180 Average:39288.79 Median:20543.54 stddev:115681.37 (563.1%) stddev-sans-first:115969.06 23:17:11 INFO - PID 2295 | Values: 418.9 424.4 425.8 429.9 444.6 19338.5 20585.8 21341.9 21747.6 22108.4 21424.0 21895.5 22875.8 22946.0 23067.8 6097.1 6293.7 6309.6 6316.1 6326.1 6018.7 6228.8 6296.8 6311.4 6312.2 6057.0 6271.9 6273.9 6311.2 6326.5 6160.5 6297.3 6312.7 6326.5 6328.5 5332.9 5485.0 5566.0 5600.6 5603.8 27079.7 27659.7 27745.4 27761.9 27958.7 1815.3 1967.6 1980.6 1997.8 2028.8 15340.8 15592.2 15884.0 16319.3 16557.3 1632.2 1649.1 1658.5 1669.0 1687.4 114209.7 120108.0 122067.0 128037.0 129858.4 11483.8 12091.0 12106.8 12111.9 12650.3 16199.6 16243.1 16274.8 16275.4 16277.2 7330.5 8486.1 8725.6 8755.5 8908.0 6609.4 8309.6 8500.8 8529.1 8604.1 7553.8 7714.4 7755.3 7755.4 7757.8 1767.8 1789.4 1956.5 2050.4 2072.6 795.4 869.6 905.7 928.2 949.8 18602.8 19593.9 19896.4 19935.6 20501.3 940.6 956.1 964.5 971.8 987.1 10208.6 10630.1 11943.6 12128.7 12910.3 610303.0 689155.0 720922.0 724349.0 730909.0 118239.0 120932.4 138549.3 150614.0 159538.0 1197.7 1213.9 1251.2 1251.9 1255.5 17677.2 21616.7 21722.3 21953.7 22217.8 54348.2 58381.0 58504.8 60709.7 62977.4 81639.0 81664.0 83143.2 83154.6 84240.6 10913.9 11907.5 12213.4 12401.8 12807.4 12686.0 13589.9 13623.8 13985.4 14023.4 11523.5 11576.5 11919.3 11974.5 11995.2 11002.2 11487.3 11557.2 11558.4 11924.0 11723.2 11832.6 11973.6 12027.2 12116.3 12184.5 12335.5 12469.6 12617.4 13310.7 11675.0 11859.7 12204.5 12271.3 12309.1 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | [#3] mootools.html Cycles:180 Average:6763.73 Median:2441.96 stddev:4270.15 (174.9%) stddev-sans-first:4261.34 23:17:11 INFO - PID 2295 | Values: 1156.4 1320.2 1375.1 1399.0 1399.9 7521.7 9539.2 10505.4 10815.0 10837.3 10576.2 10690.7 10698.4 10767.0 10829.0 2047.7 2303.7 2365.5 2368.1 2368.6 1949.6 2089.7 2174.1 2439.5 2452.8 2409.2 2437.7 2438.0 2440.8 2443.2 2389.2 2424.9 2425.6 2432.0 2432.1 2340.7 2354.5 2415.0 2418.6 2420.9 10810.0 10906.5 10914.9 10919.8 10953.3 5587.2 5763.9 5774.8 5781.2 5794.3 3703.2 3789.2 3867.7 3947.2 4010.4 1066.4 1116.6 1157.8 1173.3 1201.2 15079.1 15274.3 15278.0 15308.2 15316.6 5360.3 5559.4 5702.1 5709.3 5719.6 12794.6 12826.5 12830.1 12832.3 12835.9 6421.2 6425.6 6429.7 6436.2 6439.6 4930.8 5602.1 5635.4 5787.7 5844.7 3799.1 3946.4 4171.4 4239.9 4268.9 1230.3 1254.4 1265.4 1266.0 1275.9 750.4 757.5 778.7 782.7 790.5 5366.4 5525.0 5817.5 5992.0 6306.3 840.7 871.6 883.9 915.7 921.5 3302.8 3477.0 3785.4 3821.8 3892.9 13406.7 13968.6 14028.2 14202.8 14211.9 13837.2 13920.6 14065.6 14116.4 14126.2 10079.8 10168.9 10184.0 10220.9 10288.1 6374.8 6408.5 6513.1 6540.3 6675.3 12055.4 12314.3 12409.1 12486.4 12544.1 12407.2 12715.4 12907.6 12925.2 13098.8 8383.1 8411.6 8442.3 8450.3 8746.3 10145.5 10154.2 10251.6 10260.5 10269.7 8699.5 8914.8 8977.3 9011.0 9014.8 8687.4 8692.0 8750.4 8798.5 9000.5 7723.0 7884.8 7890.3 7894.0 7900.1 5703.9 5813.4 5835.5 5994.4 6038.6 5881.6 6014.2 6089.1 6181.5 6236.2 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | [#4] prototype.html Cycles:180 Average:5053.62 Median:5579.54 stddev:1565.49 (28.1%) stddev-sans-first:1530.12 23:17:11 INFO - PID 2295 | Values: 382.3 387.4 391.3 393.1 395.6 5493.8 5576.1 5826.3 5929.0 5945.8 5042.3 5629.7 5731.8 5788.3 5873.4 3911.0 4369.6 4545.2 4559.9 4581.8 4253.6 4538.2 4553.4 4564.0 4580.3 4311.7 4507.7 4523.7 4537.8 4538.3 4477.9 4478.7 4496.3 4501.4 4510.5 3970.6 3994.6 4021.6 4024.8 4040.6 4738.4 4783.9 5749.9 5750.8 5789.3 4294.5 5140.6 5189.7 5196.2 5199.1 5496.2 6297.9 6362.9 6373.7 6384.6 4122.7 4235.3 4282.6 4283.2 4294.1 5911.8 6287.3 6491.9 6597.1 6717.8 4050.7 4189.5 4191.3 4205.9 4209.1 3851.7 4249.4 4375.8 4394.8 4413.3 4285.5 4941.9 5098.5 5152.4 5186.0 5650.7 6036.6 6170.3 6173.8 6358.8 1491.9 1500.7 1502.0 1504.9 1509.4 926.7 942.5 984.7 1009.7 1010.6 4900.9 5193.6 5390.2 5908.9 5914.4 5917.9 6540.3 6540.8 6559.2 6602.7 5711.9 5867.2 5890.7 5911.8 5933.5 2749.9 3381.0 3427.5 3431.5 3447.3 6269.8 6759.4 6764.2 6797.3 6842.3 5619.8 5714.1 6644.5 6718.3 6767.3 5951.7 6423.9 6814.7 6818.3 6822.5 6477.4 6530.7 6539.1 6553.4 6564.9 5666.5 6439.9 6459.0 6489.0 6496.9 6141.1 6451.5 6611.8 6722.9 6783.9 3316.3 3887.0 4208.7 4334.7 4360.7 5177.7 5583.0 6151.9 6562.6 6565.8 6286.7 6288.0 6304.6 6310.6 6333.7 4789.9 5264.7 6060.9 6078.4 6341.8 4898.9 5148.6 5510.3 6126.4 6178.3 5193.6 5473.9 6194.9 6301.2 6443.4 4855.8 5327.8 6002.6 6026.9 6164.2 23:17:11 INFO - PID 2295 | 23:17:11 INFO - PID 2295 | [#5] yui.html Cycles:180 Average:18208.75 Median:3984.86 stddev:24833.47 (623.2%) stddev-sans-first:24868.44 23:17:11 INFO - PID 2295 | Values: 726.5 731.5 732.6 741.6 749.1 14825.0 15053.0 15319.3 15343.5 15353.7 14810.9 14951.9 14954.4 14964.8 14989.9 921.1 928.6 939.4 942.4 946.0 945.8 950.9 952.4 952.6 954.9 955.7 1001.1 1006.9 1007.8 1009.6 996.8 997.1 997.6 998.1 998.4 733.5 736.6 736.8 737.0 739.0 15721.3 15786.4 15868.4 16088.0 16244.5 14375.8 14689.5 14816.3 14821.9 14871.9 11762.2 11801.5 11816.8 12046.7 12301.8 3066.9 3122.0 3163.0 3166.6 3189.9 99531.0 103854.5 104830.5 107288.0 109029.0 10229.9 10876.9 11117.6 11566.5 11768.2 24870.3 24874.6 24877.8 24897.6 24916.5 6747.7 7633.6 7710.9 7723.3 7888.6 3985.8 4075.8 4079.1 4138.5 4143.2 3984.0 4009.8 4078.4 4095.7 4099.2 693.6 789.6 791.3 800.1 804.8 553.6 556.6 558.0 567.7 593.1 9514.2 9888.7 10014.4 10145.6 10168.9 533.4 551.6 567.7 581.5 583.1 4138.4 4611.7 4626.8 4666.1 4711.4 71681.3 74342.6 77813.0 89042.0 90569.5 61113.0 65679.7 66144.3 72826.6 75839.2 58191.0 65315.7 66338.7 66525.7 67322.7 9383.2 9866.8 9962.6 9964.7 9990.7 22280.6 32312.5 32394.0 32411.4 32470.5 42368.6 42932.6 62778.4 64251.4 67447.0 13534.8 13731.2 13834.5 13978.4 14189.4 13199.9 14095.2 14371.4 14809.9 15224.2 13553.7 13640.5 13723.5 13850.5 14015.3 13569.4 13657.0 13773.0 13782.3 14378.1 13335.7 13399.9 13538.1 13558.7 14062.7 10459.9 10817.0 10846.3 10990.8 11731.9 9791.5 11241.4 11242.7 11511.9 11584.5 23:17:11 INFO - PID 2295 | -------- Summary: end -------- 23:17:11 INFO - PID 2295 | 23:17:12 INFO - TEST-INFO | 2295: exit 0 23:17:12 INFO - TEST-OK | dromaeo_css | took 1121875ms 23:17:12 INFO - TEST-START | kraken 23:17:12 INFO - operating with platform_type : mac_ 23:17:12 INFO - Initialising browser for kraken test... 23:17:12 INFO - TEST-INFO | started process 2298 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpYiQ0QJ/profile http://localhost:50487/getInfo.html) 23:17:14 INFO - PID 2298 | __metrics Screen width/height:1600/1200 23:17:14 INFO - PID 2298 | colorDepth:24 23:17:14 INFO - PID 2298 | Browser inner width/height: 1024/689 23:17:14 INFO - PID 2298 | __metrics 23:17:14 INFO - PID 2298 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:17:14 INFO - PID 2298 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:15 INFO - TEST-INFO | 2298: exit 0 23:17:15 INFO - Browser initialized. 23:17:15 INFO - Running cycle 1/1 for kraken test... 23:17:15 INFO - TEST-INFO | started process 2299 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpYiQ0QJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:27 INFO - PID 2299 | RSS: Main: 233742336 23:17:27 INFO - PID 2299 | 23:17:30 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50487/tests/kraken/driver.html?testName=audio-beat-detection) 23:17:31 INFO - PID 2299 | RSS: Main: 284540928 23:17:31 INFO - PID 2299 | 23:17:34 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50487/tests/kraken/driver.html?testName=audio-dft) 23:17:34 INFO - PID 2299 | RSS: Main: 285556736 23:17:34 INFO - PID 2299 | 23:17:38 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50487/tests/kraken/driver.html?testName=audio-fft) 23:17:38 INFO - PID 2299 | RSS: Main: 377446400 23:17:38 INFO - PID 2299 | 23:17:40 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50487/tests/kraken/driver.html?testName=audio-oscillator) 23:17:41 INFO - PID 2299 | RSS: Main: 282251264 23:17:41 INFO - PID 2299 | 23:17:43 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:17:43 INFO - PID 2299 | RSS: Main: 284045312 23:17:43 INFO - PID 2299 | 23:17:46 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50487/tests/kraken/driver.html?testName=imaging-darkroom) 23:17:47 INFO - PID 2299 | RSS: Main: 326426624 23:17:47 INFO - PID 2299 | 23:17:50 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50487/tests/kraken/driver.html?testName=imaging-desaturate) 23:17:51 INFO - PID 2299 | RSS: Main: 334680064 23:17:51 INFO - PID 2299 | 23:17:54 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50487/tests/kraken/driver.html?testName=json-parse-financial) 23:17:54 INFO - PID 2299 | RSS: Main: 339013632 23:17:54 INFO - PID 2299 | 23:17:56 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:17:56 INFO - PID 2299 | RSS: Main: 302534656 23:17:56 INFO - PID 2299 | 23:17:58 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:17:59 INFO - PID 2299 | RSS: Main: 304508928 23:17:59 INFO - PID 2299 | 23:18:01 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:18:02 INFO - PID 2299 | RSS: Main: 307056640 23:18:02 INFO - PID 2299 | 23:18:05 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:18:05 INFO - PID 2299 | RSS: Main: 324694016 23:18:05 INFO - PID 2299 | 23:18:09 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:18:09 INFO - PID 2299 | RSS: Main: 318935040 23:18:09 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | Cycle 1(1): loaded http://localhost:50487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50487/tests/kraken/driver.html?testName=ai-astar) 23:18:11 INFO - PID 2299 | RSS: Main: 380407808 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | __start_tp_report 23:18:11 INFO - PID 2299 | _x_x_mozilla_page_load 23:18:11 INFO - PID 2299 | _x_x_mozilla_page_load_details 23:18:11 INFO - PID 2299 | |i|pagename|runs| 23:18:11 INFO - PID 2299 | |0;ai-astar;113;112;112;112;111;112;111;110;113;112 23:18:11 INFO - PID 2299 | |1;audio-beat-detection;150;115;112;154;112;113;114;140;166;109 23:18:11 INFO - PID 2299 | |2;audio-dft;184;187;187;186;188;182;183;186;185;187 23:18:11 INFO - PID 2299 | |3;audio-fft;78;60;60;91;60;59;57;58;77;60 23:18:11 INFO - PID 2299 | |4;audio-oscillator;89;70;88;71;69;69;83;68;69;85 23:18:11 INFO - PID 2299 | |5;imaging-gaussian-blur;88;87;88;87;88;87;88;88;88;91 23:18:11 INFO - PID 2299 | |6;imaging-darkroom;95;94;95;95;94;95;94;96;96;94 23:18:11 INFO - PID 2299 | |7;imaging-desaturate;82;86;86;86;85;83;82;86;96;116 23:18:11 INFO - PID 2299 | |8;json-parse-financial;65;62;64;64;62;62;62;62;64;61 23:18:11 INFO - PID 2299 | |9;json-stringify-tinderbox;56;59;61;65;61;57;58;59;58;58 23:18:11 INFO - PID 2299 | |10;stanford-crypto-aes;84;84;83;84;83;83;83;83;83;82 23:18:11 INFO - PID 2299 | |11;stanford-crypto-ccm;150;153;145;139;136;142;139;128;205;182 23:18:11 INFO - PID 2299 | |12;stanford-crypto-pbkdf2;184;194;187;187;234;207;185;187;180;182 23:18:11 INFO - PID 2299 | |13;stanford-crypto-sha256-iterative;67;68;68;65;68;66;66;67;68;68 23:18:11 INFO - PID 2299 | __end_tp_report 23:18:11 INFO - PID 2299 | __start_cc_report 23:18:11 INFO - PID 2299 | _x_x_mozilla_cycle_collect,2128 23:18:11 INFO - PID 2299 | __end_cc_report 23:18:11 INFO - PID 2299 | __startTimestamp1490163491760__endTimestamp 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | ------- Summary: start ------- 23:18:11 INFO - PID 2299 | Number of tests: 14 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 23:18:11 INFO - PID 2299 | Values: 113.0 112.0 112.0 112.0 111.0 112.0 111.0 110.0 113.0 112.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:127.50 stddev:21.62 (17.0%) stddev-sans-first:21.49 23:18:11 INFO - PID 2299 | Values: 150.0 115.0 112.0 154.0 112.0 113.0 114.0 140.0 166.0 109.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#2] audio-dft Cycles:10 Average:185.50 Median:186.50 stddev:1.96 (1.0%) stddev-sans-first:2.00 23:18:11 INFO - PID 2299 | Values: 184.0 187.0 187.0 186.0 188.0 182.0 183.0 186.0 185.0 187.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:11.68 (19.5%) stddev-sans-first:11.55 23:18:11 INFO - PID 2299 | Values: 78.0 60.0 60.0 91.0 60.0 59.0 57.0 58.0 77.0 60.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:77.00 stddev:8.91 (11.6%) stddev-sans-first:8.14 23:18:11 INFO - PID 2299 | Values: 89.0 70.0 88.0 71.0 69.0 69.0 83.0 68.0 69.0 85.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.00 stddev:1.15 (1.3%) stddev-sans-first:1.22 23:18:11 INFO - PID 2299 | Values: 88.0 87.0 88.0 87.0 88.0 87.0 88.0 88.0 88.0 91.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 23:18:11 INFO - PID 2299 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 94.0 96.0 96.0 94.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#7] imaging-desaturate Cycles:10 Average:88.80 Median:86.00 stddev:10.35 (12.0%) stddev-sans-first:10.68 23:18:11 INFO - PID 2299 | Values: 82.0 86.0 86.0 86.0 85.0 83.0 82.0 86.0 96.0 116.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:1.13 23:18:11 INFO - PID 2299 | Values: 65.0 62.0 64.0 64.0 62.0 62.0 62.0 62.0 64.0 61.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:2.57 (4.4%) stddev-sans-first:2.46 23:18:11 INFO - PID 2299 | Values: 56.0 59.0 61.0 65.0 61.0 57.0 58.0 59.0 58.0 58.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:0.63 (0.8%) stddev-sans-first:0.60 23:18:11 INFO - PID 2299 | Values: 84.0 84.0 83.0 84.0 83.0 83.0 83.0 83.0 83.0 82.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:147.50 stddev:23.65 (16.0%) stddev-sans-first:25.07 23:18:11 INFO - PID 2299 | Values: 150.0 153.0 145.0 139.0 136.0 142.0 139.0 128.0 205.0 182.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.70 Median:187.00 stddev:16.40 (8.8%) stddev-sans-first:17.09 23:18:11 INFO - PID 2299 | Values: 184.0 194.0 187.0 187.0 234.0 207.0 185.0 187.0 180.0 182.0 23:18:11 INFO - PID 2299 | 23:18:11 INFO - PID 2299 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 23:18:11 INFO - PID 2299 | Values: 67.0 68.0 68.0 65.0 68.0 66.0 66.0 67.0 68.0 68.0 23:18:11 INFO - PID 2299 | -------- Summary: end -------- 23:18:11 INFO - PID 2299 | 23:18:12 INFO - TEST-INFO | 2299: exit 0 23:18:12 INFO - TEST-OK | kraken | took 60603ms 23:18:12 INFO - SUITE-END | took 1182s 23:18:12 INFO - Completed test suite (00:19:42) 23:18:12 INFO - javascript benchmark 23:18:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7554.2561357765235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.0345105732526, 3361.1093060339, 3377.9662203377957, 3433.1073920780595, 3436.82815859207, 6141.877162456748, 6150.969245153768, 6152.415520525554, 6164.907526387102, 6184.381561843819, 6099.309783606499, 6105.77884423116, 6125.693326622244, 6161.599496032754, 6170.506359491241, 5110.540051395374, 5413.133898576229, 5560.7219639018085, 5581.581381396391, 5703.54371650267, 5589.469000444971, 5606.859828504279, 5644.125160600113, 5654.773809047633, 5676.659400435987, 5313.814016509404, 5373.59698022646, 5379.300690910157, 5448.91826622601, 5551.666899985973, 5527.170924361338, 5577.247071645316, 5585.916211256835, 5588.720563971785, 5623.803166889139, 5501.642393244466, 5507.03626865297, 5507.917381239285, 5508.504234618864, 5527.170924361338, 5923.407659234085, 6202.34875338092, 6210.254769427653, 6218.036204388327, 6228.906566401508, 6349.4602958748565, 6382.234131904155, 6387.776427825004, 6396.712147953353, 6409.230892292908, 6472.3204063573585, 6474.870502589922, 6492.675366231717, 6613.239477460057, 6635.071090047397, 6200.038993955944, 6295.055741638699, 6299.181106456132, 6308.243010838729, 6311.747530098791, 6750.291219421988, 6766.391024807693, 6767.187937447439, 6767.864642707118, 6771.0, 6287.591306565058, 6355.237371515448, 6364.981602943507, 6367.267764207176, 6383.808485745342, 6440.0, 6453.612783233021, 6456.806295811133, 6472.838179045561, 6478.157839480931, 6385.106085148083, 6387.105805187278, 6422.74309027643, 6486.805395838132, 6499.2850786413455, 6548.9017664735065, 6561.0814485972005, 6565.474762019027, 6575.112359831362, 6620.205575330991, 5254.238135470336, 5257.658252213594, 5267.367915850123, 5274.103402421598, 5305.177697456823, 4480.439945006874, 4580.1755683976535, 4637.0, 4640.303954406799, 4685.1332503486965, 5519.972400137974, 6176.320604733476, 6187.0, 6194.566380353423, 6211.751529938842, 6590.340965903467, 6591.670416479157, 6592.0, 6598.571092878948, 6610.272869984298, 5998.970005150034, 6112.51099912006, 6186.907196392058, 6187.783427580013, 6195.752169913243, 5683.090705487102, 5725.627834190765, 5775.942240577624, 5779.393163717749, 5804.419558044162, 6766.796996090224, 6826.180858296838, 6828.975653651992, 6848.897266541106, 6853.7943861684225, 6350.618962862059, 6582.76960306387, 6610.735570577315, 6625.304343044104, 6628.767993120217, 6609.966950165219, 6645.202575690948, 6652.368025037614, 6667.19993600771, 6672.332766723289, 6411.4229719325485, 6415.71129299192, 6421.614703117828, 6428.710708018057, 6439.130717353098, 6453.257875344396, 6532.771353002622, 6548.246951600437, 6580.670966451563, 6592.274849766618, 6416.358364163733, 6429.099926010455, 6430.710618022106, 6434.485241180788, 6442.226932768098, 6408.935910640834, 6425.1004859320665, 6430.228372595318, 6433.324500927335, 6438.742450301936, 6182.1345011699295, 6257.78097766576, 6258.311585725475, 6276.278228003838, 6341.904871427025, 6153.0, 6309.148264984168, 6313.179286692701, 6340.080688300263, 6342.207224096988, 6274.435300822948, 6297.748090076529, 6341.524385671001, 6352.301246862934, 6359.109724638462], "value": 6025.77637540982, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.755795703332, 807.6607824713619, 1126.6957921361234, 1152.1186292486245, 1154.9249298795573, 34583.481247781274, 35103.4734478983, 35109.94670159896, 35350.93947181582, 35392.46911296326, 38401.03997400066, 38808.61191388092, 38818.0, 38823.0, 38883.0, 5949.345571987078, 8362.958185209081, 8524.531150786705, 8524.957375213145, 8536.615852286632, 6009.278886533622, 8250.092489826115, 8412.621432035543, 8413.70552030679, 8463.534505602189, 8478.66085356585, 8514.318854491627, 8633.179847914438, 8639.65441382344, 8642.265407440374, 6008.939910600881, 8491.23578877901, 8595.398322117455, 8596.656133754643, 8613.181747733955, 6038.57729958903, 6112.083187521907, 6119.908201376983, 6143.539234557426, 8080.39397045224, 36495.4525682115, 36823.631763682286, 36916.07709807276, 36967.0, 36976.44535331972, 2937.6621688505884, 2939.5884576159356, 2980.821150730963, 2989.865456054483, 3055.8777648894015, 20688.5862282755, 27087.458250834872, 27211.183664490098, 27494.450110997666, 27613.86193069022, 2788.3726161613677, 2798.4682910247193, 2801.1176479408923, 2821.5485522316535, 2833.192540126054, 320195.0, 322781.0, 323309.0, 325059.61099141685, 325093.9999999976, 36913.815430922674, 37578.81210593984, 48810.755946220044, 48825.75587122042, 48867.5113248863, 48486.0, 49029.754851225516, 49107.754461227465, 49139.017219655405, 49164.0, 11853.585124520772, 13554.322283885766, 14002.439902403994, 14032.579022629337, 14080.295985200699, 11440.256383335223, 11444.942775286238, 11445.370504622326, 11459.541618335339, 11715.707107322385, 13201.73596528064, 13210.603681889559, 13211.0, 13256.0, 13341.132826366254, 4757.14371413142, 5637.26715526987, 5653.378128405872, 5664.376918538957, 5673.8297851064535, 887.3123329419751, 891.772597987522, 944.7260294514651, 966.0098399140937, 978.1148061004802, 24078.51842963131, 24100.87949560241, 24133.276001719976, 24178.51642967131, 24571.508569828504, 1053.7681710023783, 1062.1874266186219, 1098.1763677242068, 1103.8564986551696, 1116.3748300951493, 11918.0, 12271.509139634492, 12351.3824308786, 12377.257364557976, 12416.255024698547, 399049.0, 399728.0, 401054.0, 401245.0, 402131.0, 55213.0, 55222.89554208893, 55255.342339729876, 55341.44658553363, 55455.72272138613, 1411.089847048648, 1435.2868363271868, 1484.2504535209434, 1487.5834766265464, 1495.6559991202084, 23097.65353519665, 23190.536189275783, 23200.535989279782, 23257.76742232556, 23270.534589308456, 37623.43564846584, 37717.0, 37734.0, 37812.62187378091, 37845.243095138496, 404308.0, 406027.0, 408622.0, 408768.0, 409443.0, 25219.621705674064, 28639.856800715865, 30529.0, 30542.84728576343, 33134.83432582822, 38430.231395372495, 39199.608003919595, 39268.80365598154, 40248.1950360997, 41252.58747412488, 33511.32977340391, 33761.324773503904, 33856.49215261724, 34198.0, 35010.0, 31491.897783577464, 32653.836730816194, 33343.83328083344, 33751.83124084364, 34337.0, 33401.830935917125, 33920.321593568486, 33981.83009084939, 34245.97262082141, 34401.65598343984, 25932.481350373266, 27136.72863271342, 30314.090577282717, 30465.695343046285, 30506.237344066576, 22820.201292954665, 23056.0, 23269.88365058164, 23315.883420582788, 23414.297571072893], "value": 17128.153515377293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.8931822385291, 424.3570989950228, 425.82115511485176, 429.8559982405894, 444.6154076723635, 19338.51653708656, 20585.794142058574, 21341.93290335485, 21747.565048699016, 22108.447288817788, 21424.03591838367, 21895.452613684665, 22875.771242287574, 22945.967431465582, 23067.769322306773, 6097.115918191871, 6293.716782744765, 6309.589876658002, 6316.147320111795, 6326.08271800591, 6018.6689732064715, 6228.8442788930415, 6296.779612713556, 6311.431971122598, 6312.179416675825, 6057.0, 6271.905921411182, 6273.937260627381, 6311.242650881901, 6326.525510586702, 6160.537959653022, 6297.307296197415, 6312.747490100413, 6326.49388048955, 6328.462080723144, 5332.866678333034, 5485.0, 5565.972170139124, 5600.635958662715, 5603.80386686464, 27079.729202707917, 27659.723402765914, 27745.445091098067, 27761.86119069412, 27958.720412795814, 1815.337401848316, 1967.567135230247, 1980.6236815005248, 1997.7702564205158, 2028.8174064334132, 15340.769888451681, 15592.220388980506, 15884.0, 16319.34722611106, 16557.337706491726, 1632.167594526788, 1649.1177220187142, 1658.5356100291817, 1669.0, 1687.4009726547022, 114209.71580568425, 120108.0, 122067.0, 128037.0, 129858.3507082468, 11483.77032459346, 12091.0, 12106.75786484283, 12111.939440302918, 12650.292210551457, 16199.595010124605, 16243.106629135511, 16274.75587866183, 16275.430359937345, 16277.186140692918, 7330.523515971551, 8486.0665326814, 8725.607347669371, 8755.453524542138, 8908.020117787039, 6609.405153536109, 8309.626066827008, 8500.787480312918, 8529.061803201643, 8604.053554109043, 7553.811154721176, 7714.421418393643, 7755.302022817974, 7755.3855456003585, 7757.7672669819995, 1767.814379490135, 1789.3737191982962, 1956.4815323939167, 2050.39513343564, 2072.6062048210792, 795.3517882925397, 869.5782545465444, 905.6965916418073, 928.2063835420618, 949.808642959655, 18602.813971860378, 19593.902030489757, 19896.403107906786, 19935.60128797416, 20501.282455114, 940.6190492850407, 956.0732493087625, 964.5225613321311, 971.771633666088, 987.1411871671692, 10208.591656333812, 10630.096441802534, 11943.641690749291, 12128.69678258033, 12910.289934053717, 610303.0, 689155.0, 720922.0, 724349.0, 730909.0, 118239.0, 120932.39533802451, 138549.30725346308, 150614.0, 159538.0, 1197.6706405738491, 1213.9271643701406, 1251.2117366059324, 1251.881071298207, 1255.54172726954, 17677.213014302437, 21616.67574986345, 21722.34832955014, 21953.67069493991, 22217.77782222157, 54348.18477722758, 58381.0, 58504.82990340255, 60709.69645151922, 62977.37022629715, 81639.0, 81664.0, 83143.16856831354, 83154.58422707848, 84240.57879710563, 10913.890861091606, 11907.46416411281, 12213.389330533615, 12401.75196496047, 12807.359632018548, 12686.0, 13589.86410135886, 13623.795643065163, 13985.44058237659, 14023.439062437388, 11523.53905843757, 11576.536938522364, 11919.344436055753, 11974.521019159485, 11995.160338776202, 11002.22984391117, 11487.310761354345, 11557.24877882935, 11558.364289964133, 11923.9864611509, 11723.179377443497, 11832.585859494877, 11973.580924667594, 12027.158098933342, 12116.333601651993, 12184.512619495476, 12335.50657973671, 12469.563565275172, 12617.36913154357, 13310.667233319244, 11675.0, 11859.703507412383, 12204.450799713857, 12271.263724176579, 12309.076819238413], "value": 10498.978633616258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1156.3928937307917, 1320.2276668149134, 1375.0512146618833, 1398.9930050349747, 1399.9300034998248, 7521.699132034719, 9539.236861051117, 10505.422201778909, 10815.0, 10837.349759014465, 10576.153907687385, 10690.679279621605, 10698.411587362692, 10766.977137171956, 10829.025387715104, 2047.7030830529563, 2303.7120359955047, 2365.5387199496104, 2368.052778888441, 2368.6210206366986, 1949.6100779844016, 2089.6656534954336, 2174.0542863854193, 2439.524292762912, 2452.766987136219, 2409.229046705055, 2437.683101196842, 2437.9634305485433, 2440.7681270279295, 2443.157110796781, 2389.247387073075, 2424.8908799104083, 2425.551273014498, 2431.9878400607886, 2432.1244352033254, 2340.719113706349, 2354.5048893952294, 2415.0219161239725, 2418.6130219164847, 2420.9394765130837, 10810.027097561178, 10906.454677266185, 10914.945425272903, 10919.836202456969, 10953.34279943206, 5587.245721827542, 5763.855903602402, 5774.82675519735, 5781.219535362714, 5794.333651630074, 3703.203811180609, 3789.2421515696697, 3867.690584753213, 3947.1710940702487, 4010.3984402339593, 1066.3761699405857, 1116.6315116011779, 1157.7510835170394, 1173.3312012153076, 1201.195199216527, 15079.095254284668, 15274.31265593051, 15278.0, 15308.234588270654, 15316.617084572976, 5360.276362691065, 5559.388467268597, 5702.059160238514, 5709.314882214161, 5719.571032172604, 12794.552190673281, 12826.486940522274, 12830.101892867597, 12832.29422381778, 12835.871641283655, 6421.197350331208, 6425.5502114851515, 6429.742810287629, 6436.16329877113, 6439.581427207217, 4930.802767889244, 5602.075657516546, 5635.380108188096, 5787.71061446926, 5844.7205589820005, 3799.088218827517, 3946.427767973685, 4171.395147703566, 4239.872803815891, 4268.914621707549, 1230.3356187658565, 1254.3728135932033, 1265.436880588148, 1265.9556915507912, 1275.8724127587168, 750.3584435307733, 757.4508481350977, 778.7157687444155, 782.6869252299012, 790.5256845892419, 5366.409694933554, 5524.972375138099, 5817.505512031525, 5991.951408503494, 6306.306306306303, 840.7183593496247, 871.6121326009865, 883.9425437346681, 915.7435917942987, 921.530019689963, 3302.8018318900945, 3477.043812951408, 3785.37541305687, 3821.7898015609408, 3892.902677433087, 13406.731865362639, 13968.58094257174, 14028.158310501403, 14202.786958195635, 14211.928940355232, 13837.238951857744, 13920.58238252854, 14065.648358791112, 14116.364763585663, 14126.223057731924, 10079.848802267972, 10168.949155254177, 10183.999999999853, 10220.948895255477, 10288.12550933179, 6374.776882809079, 6408.487321014401, 6513.100087866511, 6540.280569137486, 6675.33246675348, 12055.397230138633, 12314.322712250912, 12409.08386529183, 12486.375681216085, 12544.121911466475, 12407.193532420364, 12715.364231788188, 12907.612771616867, 12925.15986460877, 13098.803517947428, 8383.119772423808, 8411.579421029046, 8442.32461403074, 8450.323974082181, 8746.256568191775, 10145.492725363554, 10154.238432117472, 10251.641192558225, 10260.538275777459, 10269.743256418351, 8699.521526316114, 8914.821703566022, 8977.28181745472, 9010.954945225232, 9014.774630634287, 8687.39188256816, 8692.043875173853, 8750.387472876837, 8798.47209167452, 9000.549972501218, 7723.0, 7884.763457096296, 7890.289873911375, 7893.960530197312, 7900.051993760785, 5703.8859222816145, 5813.418658134153, 5835.503982161564, 5994.3705910878725, 6038.607490513278, 5881.5588830838715, 6014.1580178775885, 6089.086637004485, 6181.505479561534, 6236.158118653923], "value": 5110.527988868618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.30611440235975, 387.38212550981194, 391.2859032266115, 393.06254582819986, 395.6103238310265, 5493.807716729911, 5576.079946808777, 5826.300843898733, 5929.0, 5945.762169513214, 5042.344495215626, 5629.7333100052465, 5731.770729170838, 5788.27646544182, 5873.412658734124, 3911.02224443889, 4369.563043695637, 4545.204589196894, 4559.863204103882, 4581.7709114544305, 4253.553376895412, 4538.228501154812, 4553.42731356784, 4563.954360456386, 4580.297624401603, 4311.698181127323, 4507.72953622782, 4523.6607254455885, 4537.773111344436, 4538.319252112193, 4477.902913786111, 4478.664100192483, 4496.348029535699, 4501.414816073922, 4510.548945105496, 3970.642642162219, 3994.6005399460114, 4021.597840215955, 4024.7987600619854, 4040.616141466556, 4738.4313882334, 4783.928241076386, 5749.885002299972, 5750.827475175752, 5789.2763404574425, 4294.518391155047, 5140.563052140573, 5189.714565698885, 5196.220566914993, 5199.126650645256, 5496.203050557647, 6297.874042519124, 6362.936370636327, 6373.71318290678, 6384.585001974857, 4122.732022418533, 4235.2800023996, 4282.593153650399, 4283.229018776619, 4294.141171765628, 5911.793087242012, 6287.339829317947, 6491.870162596769, 6597.1423714916755, 6717.816709569361, 4050.675945924319, 4189.518205406356, 4191.3293872980175, 4205.873823785291, 4209.116085621992, 3851.67260782831, 4249.405083288342, 4375.846845360397, 4394.846180383671, 4413.3159360299205, 4285.46431696038, 4941.851744447672, 5098.4646612105935, 5152.433232344439, 5186.014657215117, 5650.660960342392, 6036.637801731822, 6170.290416602058, 6173.753049877954, 6358.809235722936, 1491.8885430354455, 1500.724384273359, 1501.9549413517611, 1504.9398024079132, 1509.3585226279008, 926.6988228825659, 942.4580866002076, 984.6996666016934, 1009.742515658517, 1010.570507534295, 4900.917110228139, 5193.611398368373, 5390.21841832932, 5908.852278692981, 5914.408559144137, 5917.911231331534, 6540.313267106981, 6540.771073012422, 6559.24568674599, 6602.669866506655, 5711.885762284731, 5867.237259156283, 5890.705464726832, 5911.7635294587735, 5933.465988061095, 2749.8900043998015, 3380.9661903381143, 3427.520147179397, 3431.519587257786, 3447.293304872495, 6269.843253918597, 6759.425448836904, 6764.154480689914, 6797.286284940109, 6842.281560436182, 5619.831405057855, 5714.142878568165, 6644.468442524587, 6718.260991290954, 6767.2894346093935, 5951.672658003765, 6423.916520070486, 6814.718593090394, 6818.318168183241, 6822.522423430411, 6477.4494167996245, 6530.67346632657, 6539.11721917554, 6553.4101930826455, 6564.868702626016, 5666.498377929935, 6439.903401449075, 6458.967705161444, 6488.967555162194, 6496.888511233773, 6141.113676572004, 6451.54839161273, 6611.801645950629, 6722.865542689216, 6783.93216067833, 3316.2869982952816, 3886.989382760446, 4208.684348673801, 4334.653227741836, 4360.694751367374, 5177.663451875616, 5583.0, 6151.8926593213655, 6562.639054852029, 6565.80302590923, 6286.685665716787, 6287.968560157353, 6304.621722696653, 6310.6213627182515, 6333.701591173891, 4789.898323385711, 5264.657797243167, 6060.939335616162, 6078.3921607838865, 6341.7780377688405, 4898.94672645383, 5148.58811295088, 5510.256115424367, 6126.387361263838, 6178.289496707936, 5193.636445448782, 5473.917891231555, 6194.938050619617, 6301.180846489927, 6443.420092191725, 4855.830045948375, 5327.786888524415, 6002.609830361012, 6026.8764789167035, 6164.229471316085], "value": 4572.220882355921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.5495392856429, 731.5318196354334, 732.5677850068461, 741.6143605325227, 749.093596747935, 14825.0, 15053.021553599008, 15319.327605080445, 15343.539693809176, 15353.692926141484, 14810.925945370285, 14951.850481495181, 14954.401823927057, 14964.775528367083, 14989.850101498982, 921.0927236671873, 928.5635751196927, 939.3940908114262, 942.4157022645969, 945.9668911588096, 945.8155659646371, 950.9001554836747, 952.3524003677496, 952.6046690623383, 954.9427034377925, 955.7085089047838, 1001.1040119093443, 1006.9446180460071, 1007.7833265847842, 1009.6264382178567, 996.7906739584696, 997.0876647867229, 997.6258902911409, 998.1366118307684, 998.3760149906309, 733.4645708632675, 736.5838301359714, 736.8121129112096, 737.0160835284901, 738.970441182352, 15721.292541835644, 15786.368545258176, 15868.444604438904, 16088.034717916846, 16244.51266462008, 14375.78436323456, 14689.485867994568, 14816.3332650031, 14821.925890370587, 14871.851281487156, 11762.17664763467, 11801.46893389791, 11816.827257375619, 12046.698832529257, 12301.815472767916, 3066.9233269168226, 3122.016564782109, 3162.968370316313, 3166.5566820645126, 3189.9043028709175, 99531.0046899529, 103854.48072759663, 104830.47584762104, 107288.0, 109029.0, 10229.897701022894, 10876.945615271872, 11117.610883619034, 11566.496355473735, 11768.235064720766, 24870.253892383258, 24874.626880596807, 24877.751222487906, 24897.62653560198, 24916.5016699665, 6747.6626168692355, 7633.618319084024, 7710.884336734954, 7723.34351580122, 7888.605569721606, 3985.7608543487486, 4075.775832329191, 4079.1433798902563, 4138.482689663792, 4143.212789569972, 3983.960160398417, 4009.759414435085, 4078.4290199372113, 4095.733777304525, 4099.1596722672375, 693.5526585352419, 789.5933594198992, 791.2680770287461, 800.139849661616, 804.8068463568701, 553.6318348298337, 556.6020295488664, 557.9888402231933, 567.7360027587109, 593.0629605223736, 9514.238860891111, 9888.703338899844, 10014.39913605186, 10145.64490242838, 10168.949155254177, 533.3519773475247, 551.5868077162414, 567.7360027587192, 581.4708615160184, 583.072914066636, 4138.379243113557, 4611.746353950498, 4626.838244423803, 4666.070884736232, 4711.387519622427, 71681.28318716746, 74342.62828685822, 77813.0, 89042.0, 90569.54715226381, 61113.0, 65679.67160164169, 66144.33855661478, 72826.63586682138, 75839.24160758432, 58191.0, 65315.73421328914, 66338.66830665912, 66525.66737166283, 67322.66338668275, 9383.202427793714, 9866.753331166778, 9962.55168517404, 9964.701058968243, 9990.700278991642, 22280.554388912456, 32312.515312270803, 32394.0, 32411.351772963935, 32470.512942305413, 42368.57631423646, 42932.57067429286, 62778.372216277254, 64251.35748642454, 67447.0, 13534.822601839825, 13731.24478153711, 13834.515791947233, 13978.44086236539, 14189.361478733275, 13199.934000329937, 14095.154290742588, 14371.425142994163, 14809.851901480848, 15224.238788060775, 13553.661158471117, 13640.522581709592, 13723.45106195741, 13850.515231966832, 14015.299235038003, 13569.389377477839, 13657.0, 13773.0, 13782.310884455937, 14378.065425747292, 13335.733285334432, 13399.933000334935, 13538.120022198525, 13558.728825423634, 14062.718745625234, 10459.895401045893, 10817.025367579687, 10846.349219046882, 10990.835137473105, 11731.88268117308, 9791.461469618955, 11241.437928103398, 11242.66272011841, 11511.884881151082, 11584.536618535165], "value": 7339.283574026386, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0, 110.0, 113.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 112.0, 154.0, 112.0, 113.0, 114.0, 140.0, 166.0, 109.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 187.0, 186.0, 188.0, 182.0, 183.0, 186.0, 185.0, 187.0], "value": 185.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 60.0, 91.0, 60.0, 59.0, 57.0, 58.0, 77.0, 60.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 88.0, 71.0, 69.0, 69.0, 83.0, 68.0, 69.0, 85.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 87.0, 88.0, 87.0, 88.0, 88.0, 88.0, 91.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 96.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 86.0, 86.0, 85.0, 83.0, 82.0, 86.0, 96.0, 116.0], "value": 88.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 64.0, 62.0, 62.0, 62.0, 62.0, 64.0, 61.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 61.0, 65.0, 61.0, 57.0, 58.0, 59.0, 58.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 83.0, 83.0, 83.0, 83.0, 83.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 145.0, 139.0, 136.0, 142.0, 139.0, 128.0, 205.0, 182.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 194.0, 187.0, 187.0, 234.0, 207.0, 185.0, 187.0, 180.0, 182.0], "value": 192.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 65.0, 68.0, 66.0, 66.0, 67.0, 68.0, 68.0], "value": 67.1, "unit": "score"}]}]} 23:18:12 INFO - Return code: 0 23:18:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:18:13 ERROR - # TBPL SUCCESS # 23:18:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:18:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:18:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:18:13 INFO - 2017-03-21 23:18:13.078 screenresolution[2303:20055] starting screenresolution argv=screenresolution get 23:18:13 INFO - 2017-03-21 23:18:13.081 screenresolution[2303:20055] Display 0: 1600x1200x32@60 23:18:13 INFO - 2017-03-21 23:18:13.087 screenresolution[2304:20058] starting screenresolution argv=screenresolution list 23:18:13 INFO - Available Modes on Display 0 23:18:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:18:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:18:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:18:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:18:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:18:13 INFO - Intel Iris: 23:18:13 INFO - Chipset Model: Intel Iris 23:18:13 INFO - Type: GPU 23:18:13 INFO - Bus: Built-In 23:18:13 INFO - VRAM (Dynamic, Max): 1536 MB 23:18:13 INFO - Vendor: Intel (0x8086) 23:18:13 INFO - Device ID: 0x0a2e 23:18:13 INFO - Revision ID: 0x0009 23:18:13 INFO - Displays: 23:18:13 INFO - Display: 23:18:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:18:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:18:13 INFO - Display Serial Number: 1600x1200 60 23:18:13 INFO - Main Display: Yes 23:18:13 INFO - Mirror: Off 23:18:13 INFO - Online: Yes 23:18:13 INFO - Rotation: Supported 23:18:13 INFO - Return code: 0 23:18:13 INFO - Running post-action listener: _resource_record_post_action 23:18:13 INFO - [mozharness: 2017-03-22 06:18:13.322504Z] Finished run-tests step (success) 23:18:13 INFO - Running post-run listener: _resource_record_post_run 23:18:13 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 724992; Write bytes: 511368192; Read time: 10; Write time: 1529 23:18:13 INFO - TinderboxPrint: CPU usage
53.3% 23:18:13 INFO - TinderboxPrint: I/O read bytes / time
724,992 / 10 23:18:13 INFO - TinderboxPrint: I/O write bytes / time
511,368,192 / 1,529 23:18:13 INFO - TinderboxPrint: CPU idle
2,248.0 (46.7%) 23:18:13 INFO - TinderboxPrint: CPU system
959.3 (19.9%) 23:18:13 INFO - TinderboxPrint: CPU user
1,610.3 (33.4%) 23:18:13 INFO - TinderboxPrint: Swap in / out
211,357,696 / 0 23:18:13 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201728512; Write bytes: 201369088; Read time: 15627; Write time: 388 23:18:13 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 724992; Write bytes: 298587648; Read time: 10; Write time: 1101 23:18:13 INFO - Running post-run listener: _upload_blobber_files 23:18:13 INFO - Blob upload gear active. 23:18:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:18:13 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 23:18:13 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'] 23:18:13 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 23:18:14 INFO - (blobuploader) - INFO - Open directory for files ... 23:18:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:18:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:18:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:14 INFO - (blobuploader) - INFO - Done attempting. 23:18:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:18:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:18:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:15 INFO - (blobuploader) - INFO - Done attempting. 23:18:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:18:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:17 INFO - (blobuploader) - INFO - Done attempting. 23:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:18:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:19 INFO - (blobuploader) - INFO - Done attempting. 23:18:19 INFO - (blobuploader) - INFO - Iteration through files over. 23:18:19 INFO - Return code: 0 23:18:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:18:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:18:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98b10863e5eec73bbb535b1adb9b5a9653ebfca0e76de39e1544e3bec5b12c49732812ea785ea702f76bd38ecf3b2203fea0c8b2cf5fba87336ead6444b7be08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a817575d7ead674dfd1c9c547ec610f1d9d5534b93d2667360e2f87babc4d0314abe9a5f4393608e5354fb138cb2c59598539af83b494b0e3bc25831ed568f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aa4f366d12152c1bf8d683f82cd540734d4de44745943fdd68426bf8e7f28d42edb972444d02ec6c3a662e4c01651869ee01d85cd1c76993758bd9e395325ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4f010d2e9ff8f1114ec2401a655d9475a4fa0c0be3e8551fe03ddddb6ea24d19137d43029c6ce53ddf6b6e71a08aab9ab595b257fc40ce83a8b02905964237a"} 23:18:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:18:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:18:19 INFO - Contents: 23:18:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98b10863e5eec73bbb535b1adb9b5a9653ebfca0e76de39e1544e3bec5b12c49732812ea785ea702f76bd38ecf3b2203fea0c8b2cf5fba87336ead6444b7be08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a817575d7ead674dfd1c9c547ec610f1d9d5534b93d2667360e2f87babc4d0314abe9a5f4393608e5354fb138cb2c59598539af83b494b0e3bc25831ed568f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aa4f366d12152c1bf8d683f82cd540734d4de44745943fdd68426bf8e7f28d42edb972444d02ec6c3a662e4c01651869ee01d85cd1c76993758bd9e395325ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4f010d2e9ff8f1114ec2401a655d9475a4fa0c0be3e8551fe03ddddb6ea24d19137d43029c6ce53ddf6b6e71a08aab9ab595b257fc40ce83a8b02905964237a"} 23:18:19 INFO - Running post-run listener: copy_logs_to_upload_dir 23:18:19 INFO - Copying logs to upload dir... 23:18:19 INFO - mkdir: /builds/slave/test/build/upload/logs 23:18:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.686719 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-21 23:18:20.038399) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 23:18:20.042070) ========= 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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/98b10863e5eec73bbb535b1adb9b5a9653ebfca0e76de39e1544e3bec5b12c49732812ea785ea702f76bd38ecf3b2203fea0c8b2cf5fba87336ead6444b7be08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a817575d7ead674dfd1c9c547ec610f1d9d5534b93d2667360e2f87babc4d0314abe9a5f4393608e5354fb138cb2c59598539af83b494b0e3bc25831ed568f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aa4f366d12152c1bf8d683f82cd540734d4de44745943fdd68426bf8e7f28d42edb972444d02ec6c3a662e4c01651869ee01d85cd1c76993758bd9e395325ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4f010d2e9ff8f1114ec2401a655d9475a4fa0c0be3e8551fe03ddddb6ea24d19137d43029c6ce53ddf6b6e71a08aab9ab595b257fc40ce83a8b02905964237a"} build_url:https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/NMneLvmfQJGWwc2uKTj57A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98b10863e5eec73bbb535b1adb9b5a9653ebfca0e76de39e1544e3bec5b12c49732812ea785ea702f76bd38ecf3b2203fea0c8b2cf5fba87336ead6444b7be08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a817575d7ead674dfd1c9c547ec610f1d9d5534b93d2667360e2f87babc4d0314abe9a5f4393608e5354fb138cb2c59598539af83b494b0e3bc25831ed568f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aa4f366d12152c1bf8d683f82cd540734d4de44745943fdd68426bf8e7f28d42edb972444d02ec6c3a662e4c01651869ee01d85cd1c76993758bd9e395325ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4f010d2e9ff8f1114ec2401a655d9475a4fa0c0be3e8551fe03ddddb6ea24d19137d43029c6ce53ddf6b6e71a08aab9ab595b257fc40ce83a8b02905964237a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 23:18:20.077449) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 23:18:20.077795) ========= 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.woa9X5Dz3Z/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.2Szahg4jVZ/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005177 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 23:18:20.126474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 23:18:20.126819) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 23:18:20.127157) ========= ========= Total master_lag: 0.48 =========