builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0039 starttime: 1486699245.97 results: success (0) buildid: 20170209185011 builduid: 4f89dbd8b6f2442480533108b73d9097 revision: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:45.973640) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:45.974093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:45.974370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:46.001153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:46.001503) ========= 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.14Nor6MInd/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.If4bzDNmLE/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-09 20:00:46-- 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% 14.7M=0.001s 2017-02-09 20:00:46 (14.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127787 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:46.153786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:46.154116) ========= 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.14Nor6MInd/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.If4bzDNmLE/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.027687 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:46.204568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 20:00:46.204989) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.14Nor6MInd/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.If4bzDNmLE/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-09 20:00:46,308 truncating revision to first 12 chars 2017-02-09 20:00:46,308 Setting DEBUG logging. 2017-02-09 20:00:46,308 attempt 1/10 2017-02-09 20:00:46,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6b063631a7d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 20:00:47,613 unpacking tar archive at: mozilla-aurora-6b063631a7d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 20:00:47.802063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:47.802397) ========= script_repo_revision: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:47.802785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:47.803064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:47.822939) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-09 20:00:47.823249) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.14Nor6MInd/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.If4bzDNmLE/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:00:48 INFO - MultiFileLogger online at 20170209 20:00:48 in /builds/slave/test 20:00:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:00:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:00:48 INFO - {'append_to_log': False, 20:00:48 INFO - 'base_work_dir': '/builds/slave/test', 20:00:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:00:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:00:48 INFO - 'branch': 'Mozilla-Aurora', 20:00:48 INFO - 'buildbot_json_path': 'buildprops.json', 20:00:48 INFO - 'config_files': ('talos/mac_config.py',), 20:00:48 INFO - 'default_actions': ('clobber', 20:00:48 INFO - 'read-buildbot-config', 20:00:48 INFO - 'download-and-extract', 20:00:48 INFO - 'populate-webroot', 20:00:48 INFO - 'create-virtualenv', 20:00:48 INFO - 'install', 20:00:48 INFO - 'run-tests'), 20:00:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:00:48 INFO - 'download_minidump_stackwalk': True, 20:00:48 INFO - 'download_symbols': 'ondemand', 20:00:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:00:48 INFO - 'tooltool.py': '/tools/tooltool.py', 20:00:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:00:48 INFO - '/tools/misc-python/virtualenv.py')}, 20:00:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:00:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:00:48 INFO - 'installer_path': 'installer.exe', 20:00:48 INFO - 'log_level': 'info', 20:00:48 INFO - 'log_name': 'talos', 20:00:48 INFO - 'log_to_console': True, 20:00:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:00:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:00:48 INFO - 'opt_config_files': (), 20:00:48 INFO - 'pip_index': False, 20:00:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:00:48 INFO - 'cmd': ('bash', 20:00:48 INFO - '-c', 20:00:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:00:48 INFO - 'enabled': True, 20:00:48 INFO - 'halt_on_failure': False, 20:00:48 INFO - 'name': 'check_screen_resolution'},), 20:00:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:00:48 INFO - 'cmd': ('bash', 20:00:48 INFO - '-c', 20:00:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:00:48 INFO - 'enabled': True, 20:00:48 INFO - 'halt_on_failure': False, 20:00:48 INFO - 'name': 'check_screen_resolution'},), 20:00:48 INFO - 'run_cmd_checks_enabled': True, 20:00:48 INFO - 'sps_profile': False, 20:00:48 INFO - 'sps_profile_interval': 0, 20:00:48 INFO - 'suite': 'dromaeojs', 20:00:48 INFO - 'system_bits': '32', 20:00:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:00:48 INFO - 'title': 't-yosemite-r7-0039', 20:00:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:00:48 INFO - 'use_talos_json': True, 20:00:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:00:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:00:48 INFO - 'work_dir': 'build'} 20:00:48 INFO - [mozharness: 2017-02-10 04:00:48.041859Z] Running clobber step. 20:00:48 INFO - Running pre-action listener: _resource_record_pre_action 20:00:48 INFO - Running main action method: clobber 20:00:48 INFO - rmtree: /builds/slave/test/build 20:00:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:00:50 INFO - Running post-action listener: _resource_record_post_action 20:00:50 INFO - [mozharness: 2017-02-10 04:00:50.634331Z] Finished clobber step (success) 20:00:50 INFO - [mozharness: 2017-02-10 04:00:50.634598Z] Running read-buildbot-config step. 20:00:50 INFO - Running pre-action listener: _resource_record_pre_action 20:00:50 INFO - Running main action method: read_buildbot_config 20:00:50 INFO - Using buildbot properties: 20:00:50 INFO - { 20:00:50 INFO - "project": "", 20:00:50 INFO - "product": "firefox", 20:00:50 INFO - "script_repo_revision": "production", 20:00:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 20:00:50 INFO - "repository": "", 20:00:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 20:00:50 INFO - "buildid": "20170209185011", 20:00:50 INFO - "pgo_build": "False", 20:00:50 INFO - "basedir": "/builds/slave/test", 20:00:50 INFO - "buildnumber": 24, 20:00:50 INFO - "slavename": "t-yosemite-r7-0039", 20:00:50 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:00:50 INFO - "platform": "yosemite_r7", 20:00:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:00:50 INFO - "branch": "mozilla-aurora", 20:00:50 INFO - "repo_path": "releases/mozilla-aurora", 20:00:50 INFO - "revision": "6b063631a7d3ffd5dc2b621852e4d8ac8758ef99", 20:00:50 INFO - "stage_platform": "macosx64", 20:00:50 INFO - "builduid": "4f89dbd8b6f2442480533108b73d9097", 20:00:50 INFO - "slavebuilddir": "test" 20:00:50 INFO - } 20:00:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 20:00:50 INFO - Running post-action listener: _resource_record_post_action 20:00:50 INFO - [mozharness: 2017-02-10 04:00:50.640525Z] Finished read-buildbot-config step (success) 20:00:50 INFO - [mozharness: 2017-02-10 04:00:50.640738Z] Running download-and-extract step. 20:00:50 INFO - Running pre-action listener: _resource_record_pre_action 20:00:50 INFO - Running main action method: download_and_extract 20:00:50 INFO - mkdir: /builds/slave/test/build/tests 20:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:50 INFO - trying https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 20:00:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 20:00:51 INFO - Downloaded 1199 bytes. 20:00:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:00:51 INFO - Using the following test package requirements: 20:00:51 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:00:51 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 20:00:51 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 20:00:51 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'jsshell-mac.zip'], 20:00:51 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 20:00:51 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:00:51 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 20:00:51 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 20:00:51 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 20:00:51 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:51 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 20:00:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:00:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:00:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:00:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:00:52 INFO - Expected file size: 16357895 20:00:52 INFO - Obtained file size: 16357895 20:00:59 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 20:00:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:00:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:00:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:01:00 INFO - Expected file size: 16357895 20:01:00 INFO - Obtained file size: 16357895 20:01:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 20:01:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:01:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 20:01:08 INFO - Expected file size: 14403485 20:01:08 INFO - Obtained file size: 14403485 20:01: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')]} 20:01:08 INFO - trying https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:01:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 20:01:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 20:01:12 INFO - Downloaded 73823279 bytes. 20:01:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:01:12 INFO - mkdir: /builds/slave/test/properties 20:01:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:01:12 INFO - Writing to file /builds/slave/test/properties/build_url 20:01:12 INFO - Contents: 20:01:12 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:01:13 INFO - Running post-action listener: _resource_record_post_action 20:01:13 INFO - Running post-action listener: set_extra_try_arguments 20:01:13 INFO - [mozharness: 2017-02-10 04:01:13.310662Z] Finished download-and-extract step (success) 20:01:13 INFO - [mozharness: 2017-02-10 04:01:13.310769Z] Running populate-webroot step. 20:01:13 INFO - Running pre-action listener: _resource_record_pre_action 20:01:13 INFO - Running main action method: populate_webroot 20:01:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:13 INFO - '--tppagecycles', 20:01:13 INFO - '7'], 20:01:13 INFO - 'tests': ['tsvgm']}}, 20:01:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:01:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:01:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:01:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:01:13 INFO - 'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:01:13 INFO - 'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['damp', 'tps']}, 20:01:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:01:13 INFO - 'tests': ['damp', 'tps']}, 20:01:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['dromaeo_dom']}, 20:01:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['basic_compositor_video']}, 20:01:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:01:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['a11yr', 20:01:13 INFO - 'ts_paint', 20:01:13 INFO - 'tpaint', 20:01:13 INFO - 'sessionrestore', 20:01:13 INFO - 'sessionrestore_no_auto_restore', 20:01:13 INFO - 'tabpaint']}, 20:01:13 INFO - 'other-e10s': {'tests': ['a11yr', 20:01:13 INFO - 'ts_paint', 20:01:13 INFO - 'tpaint', 20:01:13 INFO - 'sessionrestore', 20:01:13 INFO - 'sessionrestore_no_auto_restore', 20:01:13 INFO - 'tabpaint']}, 20:01:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:01:13 INFO - 'ts_paint', 20:01:13 INFO - 'tpaint', 20:01:13 INFO - 'sessionrestore', 20:01:13 INFO - 'sessionrestore_no_auto_restore', 20:01:13 INFO - 'tabpaint']}, 20:01:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:01:13 INFO - 'ts_paint', 20:01:13 INFO - 'tpaint', 20:01:13 INFO - 'sessionrestore', 20:01:13 INFO - 'sessionrestore_no_auto_restore', 20:01:13 INFO - 'tabpaint']}, 20:01:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['a11yr', 20:01:13 INFO - 'ts_paint', 20:01:13 INFO - 'tpaint', 20:01:13 INFO - 'sessionrestore', 20:01:13 INFO - 'sessionrestore_no_auto_restore', 20:01:13 INFO - 'tabpaint']}, 20:01:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['a11yr', 20:01:13 INFO - 'ts_paint', 20:01:13 INFO - 'tpaint', 20:01:13 INFO - 'sessionrestore', 20:01:13 INFO - 'sessionrestore_no_auto_restore', 20:01:13 INFO - 'tabpaint']}, 20:01:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['tsvgx', 20:01:13 INFO - 'tsvgr_opacity', 20:01:13 INFO - 'tart', 20:01:13 INFO - 'tscrollx', 20:01:13 INFO - 'cart', 20:01:13 INFO - 'tsvg_static']}, 20:01:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:01:13 INFO - 'tsvgr_opacity', 20:01:13 INFO - 'tart', 20:01:13 INFO - 'tscrollx', 20:01:13 INFO - 'cart', 20:01:13 INFO - 'tsvg_static']}, 20:01:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:01:13 INFO - 'talos_options': ['--disable-e10s'], 20:01:13 INFO - 'tests': ['tp5o']}, 20:01:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:01:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:01:13 INFO - 'talos_options': ['--disable-e10s', 20:01:13 INFO - '--xperf_path', 20:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:13 INFO - 'tests': ['tp5n']}, 20:01:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:01:13 INFO - 'talos_options': ['--xperf_path', 20:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:13 INFO - 'tests': ['tp5n']}}, 20:01:13 INFO - 'talos.zip': {'path': '', 20:01:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:13 INFO - Running post-action listener: _resource_record_post_action 20:01:13 INFO - [mozharness: 2017-02-10 04:01:13.329788Z] Finished populate-webroot step (success) 20:01:13 INFO - [mozharness: 2017-02-10 04:01:13.329897Z] Running create-virtualenv step. 20:01:13 INFO - Running pre-action listener: _resource_record_pre_action 20:01:13 INFO - Running main action method: create_virtualenv 20:01:13 INFO - Creating virtualenv /builds/slave/test/build/venv 20:01:13 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 20:01:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:01:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:13 INFO - Using real prefix '/tools/python27' 20:01:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:01:14 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:17 INFO - Installing pip.................done. 20:01:17 INFO - Return code: 0 20:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:01:17 INFO - Reading from file tmpfile_stdout 20:01:17 INFO - Output received: 20:01:17 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) 20:01:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:01:17 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')]} 20:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:17 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')]} 20:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:17 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 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:17 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 20:01:17 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 20:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:17 INFO - 'HOME': '/Users/cltbld', 20:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:17 INFO - 'LOGNAME': 'cltbld', 20:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:17 INFO - 'MOZ_NO_REMOTE': '1', 20:01:17 INFO - 'NO_EM_RESTART': '1', 20:01:17 INFO - 'PAGER': '/bin/cat', 20:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:17 INFO - 'PWD': '/builds/slave/test', 20:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:17 INFO - 'SHELL': '/bin/bash', 20:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:17 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:17 INFO - 'USER': 'cltbld', 20:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:17 INFO - 'XPC_FLAGS': '0x0', 20:01:17 INFO - 'XPC_SERVICE_NAME': '0', 20:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:17 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 20:01:17 INFO - Cleaning up... 20:01:17 INFO - Return code: 0 20:01:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:01:17 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')]} 20:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:17 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')]} 20:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:17 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 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:17 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 20:01:17 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 20:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:17 INFO - 'HOME': '/Users/cltbld', 20:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:17 INFO - 'LOGNAME': 'cltbld', 20:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:17 INFO - 'MOZ_NO_REMOTE': '1', 20:01:17 INFO - 'NO_EM_RESTART': '1', 20:01:17 INFO - 'PAGER': '/bin/cat', 20:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:17 INFO - 'PWD': '/builds/slave/test', 20:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:17 INFO - 'SHELL': '/bin/bash', 20:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:17 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:17 INFO - 'USER': 'cltbld', 20:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:17 INFO - 'XPC_FLAGS': '0x0', 20:01:17 INFO - 'XPC_SERVICE_NAME': '0', 20:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:17 INFO - Downloading/unpacking psutil>=3.1.1 20:01:17 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 20:01:17 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 20:01:17 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 20:01:17 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 20:01:17 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 20:01:17 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 20:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:01:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:21 INFO - Installing collected packages: psutil 20:01:21 INFO - Running setup.py install for psutil 20:01:21 INFO - building 'psutil._psutil_osx' extension 20:01:21 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 20:01:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:01:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:01:22 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 20:01:22 INFO - building 'psutil._psutil_posix' extension 20:01:22 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 20:01:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:01:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:01:22 INFO - ^ 20:01:22 INFO - 1 warning generated. 20:01:22 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 20:01:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:22 INFO - Successfully installed psutil 20:01:22 INFO - Cleaning up... 20:01:22 INFO - Return code: 0 20:01:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:01:22 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')]} 20:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:22 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')]} 20:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:22 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 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:22 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 20:01:22 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 20:01:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:22 INFO - 'HOME': '/Users/cltbld', 20:01:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:22 INFO - 'LOGNAME': 'cltbld', 20:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:22 INFO - 'MOZ_NO_REMOTE': '1', 20:01:22 INFO - 'NO_EM_RESTART': '1', 20:01:22 INFO - 'PAGER': '/bin/cat', 20:01:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:22 INFO - 'PWD': '/builds/slave/test', 20:01:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:22 INFO - 'SHELL': '/bin/bash', 20:01:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:22 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:22 INFO - 'USER': 'cltbld', 20:01:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:22 INFO - 'XPC_FLAGS': '0x0', 20:01:22 INFO - 'XPC_SERVICE_NAME': '0', 20:01:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:01:22 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 20:01:22 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 20:01:22 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 20:01:22 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 20:01:22 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 20:01:22 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 20:01:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:01:25 INFO - Installing collected packages: mozsystemmonitor 20:01:25 INFO - Running setup.py install for mozsystemmonitor 20:01:25 INFO - Successfully installed mozsystemmonitor 20:01:25 INFO - Cleaning up... 20:01:25 INFO - Return code: 0 20:01:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:01:25 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')]} 20:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:25 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')]} 20:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:25 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 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:25 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 20:01:25 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 20:01:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:25 INFO - 'HOME': '/Users/cltbld', 20:01:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:25 INFO - 'LOGNAME': 'cltbld', 20:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:25 INFO - 'MOZ_NO_REMOTE': '1', 20:01:25 INFO - 'NO_EM_RESTART': '1', 20:01:25 INFO - 'PAGER': '/bin/cat', 20:01:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:25 INFO - 'PWD': '/builds/slave/test', 20:01:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:25 INFO - 'SHELL': '/bin/bash', 20:01:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:25 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:25 INFO - 'USER': 'cltbld', 20:01:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:25 INFO - 'XPC_FLAGS': '0x0', 20:01:25 INFO - 'XPC_SERVICE_NAME': '0', 20:01:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:26 INFO - Downloading/unpacking jsonschema==2.5.1 20:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:01:28 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 20:01:28 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 20:01:28 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 20:01:28 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 20:01:28 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 20:01:28 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 20:01:29 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:29 INFO - warning: no files found matching '*.txt' 20:01:29 INFO - no previously-included directories found matching 'build' 20:01:29 INFO - no previously-included directories found matching 'dist' 20:01:29 INFO - no previously-included directories found matching '.git*' 20:01:29 INFO - Installing collected packages: jsonschema, functools32 20:01:29 INFO - Running setup.py install for functools32 20:01:29 INFO - warning: no files found matching '*.txt' 20:01:29 INFO - no previously-included directories found matching 'build' 20:01:29 INFO - no previously-included directories found matching 'dist' 20:01:29 INFO - no previously-included directories found matching '.git*' 20:01:29 INFO - Successfully installed jsonschema functools32 20:01:29 INFO - Cleaning up... 20:01:29 INFO - Return code: 0 20:01:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:29 INFO - 'HOME': '/Users/cltbld', 20:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:29 INFO - 'LOGNAME': 'cltbld', 20:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:29 INFO - 'MOZ_NO_REMOTE': '1', 20:01:29 INFO - 'NO_EM_RESTART': '1', 20:01:29 INFO - 'PAGER': '/bin/cat', 20:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:29 INFO - 'PWD': '/builds/slave/test', 20:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:29 INFO - 'SHELL': '/bin/bash', 20:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:29 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:29 INFO - 'USER': 'cltbld', 20:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:29 INFO - 'XPC_FLAGS': '0x0', 20:01:29 INFO - 'XPC_SERVICE_NAME': '0', 20:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:01:29 INFO - Cleaning up... 20:01:29 INFO - Return code: 0 20:01:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:29 INFO - 'HOME': '/Users/cltbld', 20:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:29 INFO - 'LOGNAME': 'cltbld', 20:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:29 INFO - 'MOZ_NO_REMOTE': '1', 20:01:29 INFO - 'NO_EM_RESTART': '1', 20:01:29 INFO - 'PAGER': '/bin/cat', 20:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:29 INFO - 'PWD': '/builds/slave/test', 20:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:29 INFO - 'SHELL': '/bin/bash', 20:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:29 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:29 INFO - 'USER': 'cltbld', 20:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:29 INFO - 'XPC_FLAGS': '0x0', 20:01:29 INFO - 'XPC_SERVICE_NAME': '0', 20:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:30 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:32 INFO - Downloading blobuploader-1.2.4.tar.gz 20:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:01:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:01:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:33 INFO - Downloading docopt-0.6.1.tar.gz 20:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:01:34 INFO - Installing collected packages: blobuploader, requests, docopt 20:01:34 INFO - Running setup.py install for blobuploader 20:01:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:01:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:01:34 INFO - Running setup.py install for requests 20:01:34 INFO - Running setup.py install for docopt 20:01:34 INFO - Successfully installed blobuploader requests docopt 20:01:34 INFO - Cleaning up... 20:01:34 INFO - Return code: 0 20:01:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:34 INFO - 'HOME': '/Users/cltbld', 20:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:34 INFO - 'LOGNAME': 'cltbld', 20:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:34 INFO - 'MOZ_NO_REMOTE': '1', 20:01:34 INFO - 'NO_EM_RESTART': '1', 20:01:34 INFO - 'PAGER': '/bin/cat', 20:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:34 INFO - 'PWD': '/builds/slave/test', 20:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:34 INFO - 'SHELL': '/bin/bash', 20:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:34 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:34 INFO - 'USER': 'cltbld', 20:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:34 INFO - 'XPC_FLAGS': '0x0', 20:01:34 INFO - 'XPC_SERVICE_NAME': '0', 20:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-VYQp5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5wHYs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-p8m7zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-3aZ5wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Pm5YsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-XyJs24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-eUhQoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-uyseIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-AIvpL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-warm65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-GZvlsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-3u2AwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-W9UrLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-azZ3kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-wVkYXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-uNdgh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:36 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Uo0JHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:01:37 INFO - Running setup.py install for manifestparser 20:01:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:01:37 INFO - Running setup.py install for mozcrash 20:01:37 INFO - Running setup.py install for mozdebug 20:01:37 INFO - Running setup.py install for mozdevice 20:01:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:01:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:01:37 INFO - Running setup.py install for mozfile 20:01:37 INFO - Running setup.py install for mozhttpd 20:01:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:01:37 INFO - Running setup.py install for mozinfo 20:01:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:01:38 INFO - Running setup.py install for mozInstall 20:01:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:01:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:01:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:01:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:01:38 INFO - Running setup.py install for mozleak 20:01:38 INFO - Running setup.py install for mozlog 20:01:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:01:38 INFO - Running setup.py install for moznetwork 20:01:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:01:38 INFO - Running setup.py install for mozprocess 20:01:38 INFO - Running setup.py install for mozprofile 20:01:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:01:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:01:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:01:39 INFO - Running setup.py install for mozrunner 20:01:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:01:39 INFO - Running setup.py install for mozscreenshot 20:01:39 INFO - Running setup.py install for moztest 20:01:39 INFO - Running setup.py install for mozversion 20:01:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:01:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:01:39 INFO - Cleaning up... 20:01:39 INFO - Return code: 0 20:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01: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')]} 20:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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')]} 20:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:40 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 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:40 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 20:01:40 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 20:01:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:40 INFO - 'HOME': '/Users/cltbld', 20:01:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:40 INFO - 'LOGNAME': 'cltbld', 20:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:40 INFO - 'MOZ_NO_REMOTE': '1', 20:01:40 INFO - 'NO_EM_RESTART': '1', 20:01:40 INFO - 'PAGER': '/bin/cat', 20:01:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:40 INFO - 'PWD': '/builds/slave/test', 20:01:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:40 INFO - 'SHELL': '/bin/bash', 20:01:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:40 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:40 INFO - 'USER': 'cltbld', 20:01:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:40 INFO - 'XPC_FLAGS': '0x0', 20:01:40 INFO - 'XPC_SERVICE_NAME': '0', 20:01:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-k32Vff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:40 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)) 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-hU0dNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:40 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)) 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-DA7tlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:40 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)) 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-7IeIdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:40 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)) 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-oFOBKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-_lEmYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-HgcEQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:41 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)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-tUDl4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:41 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)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-cUzMSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:41 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)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5DHqQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:41 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)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-xFE5zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:41 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)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-0qyhwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ApZWbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-KxXiRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:41 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)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-cHo4NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-p_M4oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:42 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)) 20:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:42 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ObB26n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:42 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)) 20:01:42 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)) 20:01:42 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)) 20:01:42 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)) 20:01:42 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)) 20:01:42 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)) 20:01:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:42 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 20:01:42 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 20:01:42 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 20:01:42 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 20:01:42 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 20:01:42 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 20:01:45 INFO - Downloading blessings-1.6.tar.gz 20:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:45 INFO - Installing collected packages: blessings 20:01:45 INFO - Running setup.py install for blessings 20:01:45 INFO - Successfully installed blessings 20:01:45 INFO - Cleaning up... 20:01:45 INFO - Return code: 0 20:01:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:01:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:45 INFO - Reading from file tmpfile_stdout 20:01:45 INFO - Current package versions: 20:01:45 INFO - blessings == 1.6 20:01:45 INFO - blobuploader == 1.2.4 20:01:45 INFO - docopt == 0.6.1 20:01:45 INFO - functools32 == 3.2.3-2 20:01:45 INFO - jsonschema == 2.5.1 20:01:45 INFO - manifestparser == 1.1 20:01:45 INFO - mozInstall == 1.12 20:01:45 INFO - mozcrash == 1.0 20:01:45 INFO - mozdebug == 0.1 20:01:45 INFO - mozdevice == 0.49 20:01:45 INFO - mozfile == 1.2 20:01:45 INFO - mozhttpd == 0.7 20:01:45 INFO - mozinfo == 0.9 20:01:45 INFO - mozleak == 0.1 20:01:45 INFO - mozlog == 3.4 20:01:45 INFO - moznetwork == 0.27 20:01:45 INFO - mozprocess == 0.24 20:01:45 INFO - mozprofile == 0.28 20:01:45 INFO - mozrunner == 6.13 20:01:45 INFO - mozscreenshot == 0.1 20:01:45 INFO - mozsystemmonitor == 0.3 20:01:45 INFO - moztest == 0.8 20:01:45 INFO - mozversion == 1.4 20:01:45 INFO - psutil == 3.1.1 20:01:45 INFO - requests == 1.2.3 20:01:45 INFO - wsgiref == 0.1.2 20:01:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:45 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')]} 20:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:45 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')]} 20:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:45 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 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:45 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 20:01:45 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 20:01:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:45 INFO - 'HOME': '/Users/cltbld', 20:01:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:45 INFO - 'LOGNAME': 'cltbld', 20:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:45 INFO - 'MOZ_NO_REMOTE': '1', 20:01:45 INFO - 'NO_EM_RESTART': '1', 20:01:45 INFO - 'PAGER': '/bin/cat', 20:01:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:45 INFO - 'PWD': '/builds/slave/test', 20:01:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:45 INFO - 'SHELL': '/bin/bash', 20:01:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:45 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:45 INFO - 'USER': 'cltbld', 20:01:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:45 INFO - 'XPC_FLAGS': '0x0', 20:01:45 INFO - 'XPC_SERVICE_NAME': '0', 20:01:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 INFO - Cleaning up... 20:01:46 INFO - Return code: 0 20:01:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9429cd93c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, '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.14Nor6MInd/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.If4bzDNmLE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 20:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:46 INFO - 'HOME': '/Users/cltbld', 20:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:46 INFO - 'LOGNAME': 'cltbld', 20:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:46 INFO - 'MOZ_NO_REMOTE': '1', 20:01:46 INFO - 'NO_EM_RESTART': '1', 20:01:46 INFO - 'PAGER': '/bin/cat', 20:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:46 INFO - 'PWD': '/builds/slave/test', 20:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:46 INFO - 'SHELL': '/bin/bash', 20:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:01:46 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:46 INFO - 'USER': 'cltbld', 20:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:46 INFO - 'XPC_FLAGS': '0x0', 20:01:46 INFO - 'XPC_SERVICE_NAME': '0', 20:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:01:46 INFO - Cleaning up... 20:01:46 INFO - Return code: 0 20:01:46 INFO - Running post-action listener: _resource_record_post_action 20:01:46 INFO - Running post-action listener: _start_resource_monitoring 20:01:46 INFO - Starting resource monitoring. 20:01:46 INFO - [mozharness: 2017-02-10 04:01:46.445756Z] Finished create-virtualenv step (success) 20:01:46 INFO - [mozharness: 2017-02-10 04:01:46.446726Z] Running install step. 20:01:46 INFO - Running pre-action listener: _resource_record_pre_action 20:01:46 INFO - Running main action method: install 20:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:46 INFO - Reading from file tmpfile_stdout 20:01:46 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:01:46 INFO - Reading from file tmpfile_stdout 20:01:46 INFO - Output received: 20:01:46 INFO - Usage: mozinstall [options] installer 20:01:46 INFO - Options: 20:01:46 INFO - -h, --help show this help message and exit 20:01:46 INFO - -d DEST, --destination=DEST 20:01:46 INFO - Directory to install application into. [default: 20:01:46 INFO - "/builds/slave/test"] 20:01:46 INFO - --app=APP Application being installed. [default: firefox] 20:01:46 INFO - mkdir: /builds/slave/test/build/application 20:01:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 20:02:07 INFO - Reading from file tmpfile_stdout 20:02:07 INFO - Output received: 20:02:07 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:02:07 INFO - Running post-action listener: _resource_record_post_action 20:02:07 INFO - [mozharness: 2017-02-10 04:02:07.318316Z] Finished install step (success) 20:02:07 INFO - [mozharness: 2017-02-10 04:02:07.318476Z] Running run-tests step. 20:02:07 INFO - Running pre-action listener: _resource_record_pre_action 20:02:07 INFO - Running main action method: run_tests 20:02:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:02:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:02:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:02:07 INFO - 2017-02-09 20:02:07.333 screenresolution[1624:7572] starting screenresolution argv=screenresolution get 20:02:07 INFO - 2017-02-09 20:02:07.335 screenresolution[1624:7572] Display 0: 1600x1200x32@60 20:02:07 INFO - 2017-02-09 20:02:07.341 screenresolution[1625:7574] starting screenresolution argv=screenresolution list 20:02:07 INFO - Available Modes on Display 0 20:02:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:02:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:02:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:02:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:02:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:02:07 INFO - Intel Iris: 20:02:07 INFO - Chipset Model: Intel Iris 20:02:07 INFO - Type: GPU 20:02:07 INFO - Bus: Built-In 20:02:07 INFO - VRAM (Dynamic, Max): 1536 MB 20:02:07 INFO - Vendor: Intel (0x8086) 20:02:07 INFO - Device ID: 0x0a2e 20:02:07 INFO - Revision ID: 0x0009 20:02:07 INFO - Displays: 20:02:07 INFO - Display: 20:02:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:02:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:02:07 INFO - Display Serial Number: 1600x1200 60 20:02:07 INFO - Main Display: Yes 20:02:07 INFO - Mirror: Off 20:02:07 INFO - Online: Yes 20:02:07 INFO - Rotation: Supported 20:02:07 INFO - Return code: 0 20:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:07 INFO - Python 2.7.3 20:02:07 INFO - Return code: 0 20:02:07 INFO - grabbing minidump binary from tooltool 20:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:02:07 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 0x10a1b1d30>, '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 0x10a0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1a6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:07 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 20:02:07 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 20:02:07 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 20:02:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:07 INFO - Return code: 0 20:02:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:02:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:02:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 20:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0039 --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 20:02:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14Nor6MInd/Render', 20:02:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:02:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:02:07 INFO - 'HOME': '/Users/cltbld', 20:02:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:02:07 INFO - 'LOGNAME': 'cltbld', 20:02:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:07 INFO - 'MOZ_NO_REMOTE': '1', 20:02:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:07 INFO - 'NO_EM_RESTART': '1', 20:02:07 INFO - 'PAGER': '/bin/cat', 20:02:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:07 INFO - 'PWD': '/builds/slave/test', 20:02:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:02:07 INFO - 'SHELL': '/bin/bash', 20:02:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.If4bzDNmLE/Listeners', 20:02:07 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 20:02:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:02:07 INFO - 'USER': 'cltbld', 20:02:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:02:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:07 INFO - 'XPC_FLAGS': '0x0', 20:02:07 INFO - 'XPC_SERVICE_NAME': '0', 20:02:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:02:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 20:02:07 INFO - mozversion application_buildid: 20170209185011 20:02:07 INFO - mozversion application_changeset: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 20:02:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:02:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:07 INFO - mozversion application_name: Firefox 20:02:07 INFO - mozversion application_remotingname: firefox-dev 20:02:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:02:07 INFO - mozversion application_vendor: Mozilla 20:02:07 INFO - mozversion application_version: 53.0a2 20:02:07 INFO - mozversion platform_buildid: 20170209185011 20:02:07 INFO - mozversion platform_changeset: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 20:02:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:02:07 INFO - mozversion platform_version: 53.0a2 20:02:07 INFO - using testdate: 1486699327 20:02:07 INFO - actual date: 1486699327 20:02:07 INFO - starting webserver on 'localhost:49244' 20:02:07 INFO - SUITE-START | Running 2 tests 20:02:07 INFO - TEST-START | dromaeo_css 20:02:07 INFO - operating with platform_type : mac_ 20:02:07 INFO - Initialising browser for dromaeo_css test... 20:02:07 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpLXnGMu/profile http://localhost:49244/getInfo.html) 20:02:10 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 20:02:10 INFO - PROCESS | 1635 | colorDepth:24 20:02:10 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 20:02:10 INFO - PROCESS | 1635 | __metrics 20:02:10 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:02:10 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:02:11 INFO - TEST-INFO | 1635: exit 0 20:02:11 INFO - Browser initialized. 20:02:11 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:11 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpLXnGMu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:23 INFO - PROCESS | 1637 | RSS: Main: 213446656 20:02:23 INFO - PROCESS | 1637 | 20:05:27 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 20:05:29 INFO - PROCESS | 1637 | RSS: Main: 369016832 20:05:29 INFO - PROCESS | 1637 | 20:07:13 INFO - PROCESS | 1637 | ************************* 20:07:13 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 20:07:13 INFO - PROCESS | 1637 | 20:07:13 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:07:13 INFO - PROCESS | 1637 | Full stack: 20:07:13 INFO - PROCESS | 1637 | ************************* 20:08:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 20:08:32 INFO - PROCESS | 1637 | RSS: Main: 347344896 20:08:32 INFO - PROCESS | 1637 | 20:11:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 20:11:35 INFO - PROCESS | 1637 | RSS: Main: 327974912 20:11:35 INFO - PROCESS | 1637 | 20:14:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 20:14:38 INFO - PROCESS | 1637 | RSS: Main: 325345280 20:14:38 INFO - PROCESS | 1637 | 20:17:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 20:17:42 INFO - PROCESS | 1637 | RSS: Main: 315428864 20:17:42 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 20:20:46 INFO - PROCESS | 1637 | RSS: Main: 495243264 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | __start_tp_report 20:20:46 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 20:20:46 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 20:20:46 INFO - PROCESS | 1637 | |i|pagename|runs| 20:20:46 INFO - PROCESS | 1637 | |0;dojo.html;3223.7904536205147;3234.0297910626837;3273.1162586101755;3298.3073554553544;3313.5526703894975;4519.163954668385;5493.862653433666;5513.727204100281;5517.668939863606;5545.279113715222;4558.247889098295;5499.560035197184;5512.5589952803775;5525.972370138154;5529.060059789836;4785;5017.774200160983;5056.342675452186;5117.7185254810975;5127.615428842833;4997.575206107485;5008.574271186953;5008.824691135811;5052.494750524955;5123.026624941249;5062.316587260728;5079.542841144296;5086.211637196222;5086.593072554187;5094.847154585368;5051.242313652945;5056.974715126401;5065.1642478990925;5069.214271787879;5080.822171223989;5035.018171456568;5035.144025515671;5035.345405097314;5045.243213517965;5046.495350464961;5420;5553.805616803393;5555.30558680165;5559.610827242094;5568.136938774496;5947.910781338283;5992.131140984577;6055.848603784896;6090.421409966046;6097.963346231151;6174.413430724074;6176.197094377702;6177.351378105324;6178.814635560941;6184.041473571604;5563.860903477405;5615.2700148980775;5624.409437009137;5633.718314084279;5651.011073062197;6104.701693046543;6162.691865406712;6168.753249869955;6173.259208894961;6266.561340706106;5938.020226662552;5942.910856337158;5950.464458198783;5971.28344598651;6019.969900150559;6071.908921366183;6091.994820854598;6095.573309868355;6102.8169154924535;6106;5831;5887.411258874078;6007.06890431975;6042.486388656926;6044.667543285162;5986.850328741816;6045.455908968214;6061.424164704346;6114.032425763494;6118.663473508911;4903.901921961612;4908.312836202935;4909.189983652729;4909.950900491021;4925.38432695913;4324.870253892388;4336.067745434747;4351.521332653406;4351.825926962886;4369.868903932887;5468.0977638689965;5601.159826026047;5610.915836262459;5650.378458369576;5656.208130861683;5873.20711703923;6098.573099883054;6129.785457508966;6139.522803442322;6184.165137706352;5645.858853528613;5664.915026274609;5689.516391106802;5693.4875861172695;5695.430456954355;5295.867603309871;5339.038972984822;5344.812931547377;5349.384820745664;5379.946200538023;6138.38839838597;6188.288346840171;6199.132121502903;6265.185525881606;6276.592021518587;5989.431004054608;6050.969745151246;6055.878882422238;6089.878202436015;6091.360407157184;6130.816075517741;6206.441420272197;6208.751649934133;6214.937850621436;6250.4374606285655;5924.674142922181;5942.168096466412;5983.072623743326;6025.78909738157;6063.242094738158;5949.1076338549565;6135.195258262415;6154.599951003171;6168.19813424252;6177.84555386119;5362.249285100167;5731.140328950691;5940.55445841555;5967.46292833647;5977.252843394575;5768.826935191951;5771.94228057714;5812.331581868139;5823.7670493181495;5905.763769449174;5703.287089113861;5707.800226992035;5717.371089180104;5720.17057526648;5720.885582288414;5812.360640329645;5843.737031833492;5866.325372582037;5870.5010074144175;5898.705064746831;5696.914546281892;5714.9142762857755;5717.42825717425;5753.741081651252;5814.592978491465 20:20:46 INFO - PROCESS | 1637 | |1;ext.html;462.7223665800518;484.30985845170636;497.19454483736354;522.6210997027156;525.2016934259927;28128;32637.83681081597;41029.79485102574;42557;42626.786866065704;43719.78140109303;44264.3360349595;44266.67199984006;44269.55730442695;44343.33484997728;9214.861777073349;9438.150566449018;9448.102430269113;9461.716148515521;9491.240700743923;8412.579371031454;8657.740267791976;11106.944465277662;11402.201845870792;11419;11431.42842857858;11468.19722619417;11476.254043487188;11496.19526633136;11499;11354.772904541904;11409.42952852354;11417.771644567061;11424.257423267461;11431.885681143207;8367.121452247547;8641.308695304424;11004.119670426428;11284.605038823684;11295.717607059807;41456.37815432771;41758;41776.58223417757;41882.58117418817;42005.78997105025;3925.9607403926166;3998.2203470323298;4009.258287216845;4049.4330793688614;4071.2264669712954;29528.852355738083;29705;29752.40495190084;31253.687463125534;31696.841515792272;3141.104785136225;3255.0560337502334;3261.59230096238;3293.8517766700556;3301.636819949804;510380;511944;511979;511988;512688;66631.66684166549;66838.33161668418;66961;67058.32941670618;67073.66463167653;58474.41525584775;70553;70976.29023709697;71014;71134;16719.913205641595;16896.239669214916;17212.913935430242;17221.225044873012;17240.568985775455;11697.707557310965;13030.674233144247;13032.80450793239;13090.280034597998;13111.016673749507;16304.755428668579;16818.813554238117;19748.901255493918;21981.010854511584;22038.669419958715;7352.926470735331;7403.8149046274275;8691.652333906699;8729.254149170192;8849.247813935759;750.2984709296716;770.2528547309101;878.9428687135315;891.7636826241052;924.6578765856676;24874.626880596807;29752.404951901273;30439.695603043685;30756.53865192024;31398.68601314003;992.4938281476499;1019.0675531888387;1056.1761825775907;1140.7602409157867;1199.4422593493894;14212;14624.26878656063;14686.485972991108;14978.951473396975;15022;667711;672862;672973;673266;673641;55005;55530.722346388815;55766.44233557694;55947.16079258815;56101.43898561044;1398.8321401431892;1416.3909518906762;1454.4255019267541;1457.1038811130866;1459.4745891479058;27418.45163096687;27951.58072628953;27980.880764769994;28601;28643.570346445238;48160.518394815605;49051.509484904695;49071.50928490669;49174;49216;577507;578540;579022;579895;581172;22988;26223.606645899945;26440.338991525365;26448.20655380342;26556.8672156638;37197.44203836999;42722.78638606787;44862;46485.53514464812;47214.81962950954;34359.48460773141;36911.63088369082;37011.259774804894;37095.44356834596;37429.812850935574;35778.28443431065;36947.815260923526;37549.06127346838;37822.243555129295;38028.85913422602;35056.94829155129;35347.82326088353;35711.28577428489;35896.820515897256;36029.63970360263;30833.691663083082;32414.513782293758;32666;32928.18894960704;33023.66976330302;24178.637320439855;24496.897639606617;24550.972747145013;24955.126570569944;24970.62544061877 20:20:46 INFO - PROCESS | 1637 | |2;jquery.html;365.1510238695035;385.8283064036503;392.11577891853875;396.1127075351214;416.475241196093;14822.110673359592;15314.846851531482;18348.44954651361;20830.37508874736;21255.362339129813;17815.73276400855;19455.027248637547;21271;21892.45268868275;21923.6711449328;5283.07546179419;5293.338332708421;5438.967706129248;5470.234167216593;5500.119980803072;5290.867728306785;5408.242846001563;5420.186971954199;5420.430854760252;5428.565714742811;3879.5926427725108;4071.043304823364;5836.474717275444;6082.695865206744;6105.938940610604;6058;6147.446729794317;6159.260888693363;6174.876502469971;6617.106690596756;5918.437748413894;5965.254343207099;5992.400759924017;6001.1898393717165;6012.398760123996;10561.524731387106;20949.428792840597;25589.872050639628;25753.96984120633;25855.35361615956;2609.178108895692;2672.5590277604174;2701.2706569226198;2727.2500062482777;2731.05778506415;9614.352983250854;10162.18702503798;10208.336458130272;10328.535215915303;10458.843117353246;1791.7222830461299;1827.3969590035256;1840.9907950460163;1846.676831554486;1848.2514581594476;130064.34967825195;131292.34353828264;137606;138732.30633846868;143038;11757.88242117585;11845.466953987092;11918.88081119195;11939.641810745692;11941.343226122646;15452.5364239073;15676.216189190724;15701.450449234222;15729.606759830867;15745;8608.440451370767;8725.301975841918;8766.167214114648;8785.868211976825;8843.646254149891;8535;8552.786180345542;8560.61477233526;8657.437266577652;8790.692325768696;4734.479207287196;4735.171345014609;4736.8105275788585;4747.928781068286;4807.038592281558;1720.931162753501;1974.7235387045826;2017.6280129511779;2023.716679664848;2025.7163997040427;1002.7894142230214;1004.7186787699455;1004.9045340692622;1013.3160116921049;1048.6696690542456;22217.888910555343;22478.66282005771;22665;22778;22993.195238166583;1031.9226058045676;1035.9896401035894;1046.2937517175876;1059.2320567588438;1061.341967979842;11163.665090047312;11671.007964323127;11712.70718232034;11790.292582445081;11804.232724872856;527752;657620;753034;777298;798698;109769.45115274373;140701.2964935169;141751;165047.3495265032;166059.16970415312;1006.3760468509424;1025.1593693171528;1044.5404022230193;1052.6578861869923;1054.8681414823147;19073.904630476758;19567.180321687665;20356.389308320773;20624.690629640867;20972.895135524224;53739.46260537345;55433.7228313872;55629.33112006646;57128;57402.7129864348;78537;82157.17842821495;82687.5865620692;82782;82920.58539707263;8092.271695547429;8138.3082437993435;8425.95787021061;8529.74410767678;8782.868256976022;11282.774344513227;11905.749896260768;13178.472861085449;13569.52506662262;13570.389332479865;11177;11281.32312061279;11337.886621133683;11741.354225517336;11752.941235293769;10981.83527247076;11227.21409501327;11280.49237784318;11384.37385943781;11405.714857128638;11385.658430247106;11418.942905285421;11713.238639488405;11969.281843089442;12013.939930300292;8345.374096942875;8376.329893608376;8415.747527574182;8590.398672092893;8627.00789409226;8922.241609463008;11165.88834111681;11267.605633802777;11272.83090753623;11552.191346605992 20:20:46 INFO - PROCESS | 1637 | |3;mootools.html;1428.5500067478742;1431.7494438473263;1437.7987081808542;1447.9348429320687;1451.5064877941502;7845.607719614018;8169.87745183822;8180.100188979222;8195.22145396188;8201.753947381589;7209.603471809049;7512.9624351878165;7518.436117291198;7560.735374261902;7569.470137090406;2031.5124370151168;2087.8747275163464;2102.67531455183;2289.7595752446005;2290.278562252885;2251.268337790225;2284.737255215655;2291.9083236670513;2294.8737819419925;2301.6432452969816;1982.5638359560946;2255.8308126890465;2273.238465114189;2274.1699279762934;2281.23578601168;2019.4345583236718;2186.3987403464093;2269.296518079401;2270.4437412833795;2272.522770218256;2212.524307273944;2272.306946381353;2277.36233854521;2281.885905704708;2286.5769832581027;8007.159248278905;8080.353571714249;8085.757427277191;8106.148854370324;8119.066307374668;4872.951270487285;5028.647994640377;5028.748562571856;5030.320906677625;5030.673006254582;2928.136199821037;3239.5950506186728;3366.1584603849037;3377.155711072232;3443.500692399613;1082.8429877667695;1208.299186471853;1212.5089338817793;1240.584404224577;1265.7848165811833;10334.948325258325;10412.635557755519;10433.017726631992;10434;10434.582616695323;4240.257954857888;4452.265376212953;4526.502084770673;4527.818887244539;4552.840650577214;9183.770405739777;9185.586648600829;9205.81588368229;9221.53892305382;9244.029376915461;5045.066662667345;5046.495350464924;5048.469910659402;5049.899002020013;5050.520200580939;4462.3752674625575;4531.478879928851;4568.446728112392;4618.122556714214;4625.560571745679;3359.714424273915;3386.797686821143;3642.4354225095153;3648.288583726148;3692.409214525663;1096.6655170173015;1106.3748981825404;1108.83921831334;1109.4120116338354;1115.3140818396628;734.7428400059936;749.3256069537351;775.6936010276022;783.2637320918318;794.9364050875917;5336.306280183629;5421.484958928974;5449.1826226066405;5466.890662186734;5529.529989950899;534.1400345443832;539.9001184780828;566.5892228134569;571.3144226927703;572.4590262202179;3358.6137594176494;3416.787040600551;3724.8882533523497;3734.8319325630414;3746.625337466286;9462.195713364303;9581.281403894596;9795.9020409795;9811.901880981242;9827.508624568743;9549.474778887088;9731.805363892825;9733.56198971048;9742;9755.317127801127;7462.85074298511;7639.579823109671;7657.961710191525;7666.5050315188;7672.194419585975;5206.713630750345;5234.947650523598;5263.841954769944;5435.157550579666;5582.581306401955;7895.368370530458;8548.273396761097;8692.478451292942;8882.15619516145;8926.776830579287;9008.684696035607;9136;9140;9243.907560924305;9264.629414823601;6467.547271690936;6669.53313268086;6947.7220911162985;7114.893276600752;7118.430525557839;6824.727010919508;7762.456628035983;7791;7803.531788092732;7845.6077196141105;6518.315576864361;6862.245153033262;6909.205441374306;6984.371406573433;7081.6459177039915;6760.594364338155;6868.690908909211;6872.037914691847;6876.484263680344;6880.071190389233;6170.7223174958135;6195.473384762166;6290.2451705793765;6310.305866354605;6311.779087731908;4821.686590371755;4927.359443272351;4963.5780958618925;4971.353724015855;4978.4274808397495;4815.783289752039;4881.096997055556;4891.315215869852;5022.623303252198;5113.846584602468 20:20:46 INFO - PROCESS | 1637 | |4;prototype.html;302.6867192455808;346.32639516141114;354.9006278242093;358.58404251068765;360.27225005488896;5282.600110970591;5298.443663415339;5311.62818602698;5312.707801070939;5368.8389348319515;4335.28756141324;4961.6278779091535;5028.321176641161;5080.882205914702;5269.129459042042;4027.3556231003045;4080.2043601497644;4098.5901409858925;4107.774072426016;4151.730137541065;3365.747568932328;4070.979645101785;4073.388991651261;4088.9182216355657;4103.886498453299;3174.1907112945514;3540.8583656653705;4072.7149099563044;4084.83660653575;4104.8973775655695;3913.4716813230134;3927.6857851371965;3928.2732694451333;3956.347202711549;3963.1677347757004;2995.7603391728608;3372.285310325212;3460.653934606519;3470.6746479858557;3471.9341991515007;5006.374203224597;5105.719185444799;5124.92312615311;5147.6911385317;5165.328507294065;3681.834317455721;3750.0874553977396;4414.977925110386;4506.436695413074;4516.18708632446;5278.788848446057;5531.925527927027;5541.088324528031;5545.667259964415;5591.548240465554;3311.3211791582667;3722.9069273268115;3816.9809150954347;3817.675497582709;3848.903777405559;4870.488598697157;4965.379327584016;5634.549236061187;5652.717364131777;5795.797147099831;3554.91112722184;3563.2695297463956;3612.9277414451562;3821.904452388657;3862.3820188770223;3013.8643761030808;3381.746369022284;3443.913902152416;3874.791368919745;3921.117748506563;4001.579834117434;4151.733721214998;4307.028150576155;4570.748608826547;4578.771061446914;4510.466980684391;4536.160810250114;4729;5007.923296491272;5085.389753229636;1141.948612312448;1219.4329636718792;1222.2910711787142;1268.192825224052;1274.5730180389487;700.4116542104555;768.0092680442278;806.6329819931917;809.7246936041774;836.5402372859278;4847.442544107403;4855.878603034952;4861.586765124934;4864.537868902448;4912.96112113476;4793.736344501086;4893.119238537098;5092.185250359925;5326.733663316819;5346.796970681643;4479.3057076153245;4701.882452938636;4808.471068182497;4818.807247710122;4898.755062246873;2434.975650243475;2636.7231440698833;2796.7203279672276;2809.5083360411845;2854.24362543926;5414.377346605112;5464.754086066137;5526.115821468546;5534.225208470817;5599.776008959596;4672.6215766349005;5165.096108181053;5198.480151984847;5337.653052551572;5907.438793314628;5396.64921780083;5645.322561292671;5839.328477225174;5935.687559634103;5969.95532278541;5270.736463176902;5320.787168513371;5671.8865622688145;5684.914726279192;5814.825555233349;5334.786608535615;5544.695041772741;5673.858153546194;5677.31872175325;5735.763052409647;4925.605951523941;5804.5356371491025;5905.881882362242;5912.320083190316;5954;3979.582143874851;4060.6193894076155;4075.8165882534763;4099.672026237834;4140.3168477200925;4665.090307390162;4919.196058246765;5600.85997850057;5625.79045505202;5630.85922851932;4600.976995115003;5446.836594902159;5488;5585.497305242548;5618.747156378055;4322.5677432256525;5301.4168441472175;5405.837824865261;5412.539934105487;5498.780048798003;4735.7395343255075;5002.774875130701;5076.36545431821;5085.999260436361;5332.440093790251;4954.702717836942;5247.317848679647;5325.627206095691;5524;5536.366771802247;4132.669386449137;4988.12707776145;5158.09733296664;5386.973065134649;5437.972810135924 20:20:46 INFO - PROCESS | 1637 | |5;yui.html;710.8009757267963;762.7749813804927;815.1440986963687;822.8518866604011;827.9921191111555;15251.923740381297;15773.684526309467;15784.92107539462;15803.92098039511;15819.446319378823;14273.214973176471;14398.568042958701;14426.134431934091;14429.422823087063;14446.566603001927;667.7462564225588;688.8725585766649;692.7956252905379;817.3747083481142;835.3233880556738;849.4945507423073;862.3101518784947;863.8617821148617;864.0495454999514;868.2793281576309;904.023654453189;915.7756349694334;916.6791622931987;916.724982505249;919.0441940381995;907.2605826251616;908.8318661047662;910.7358865928873;910.8815853938979;911.0252030327553;523.123767689123;542.7503348459713;652.3639451534763;677.8779819632464;680.0852852912824;14709.190994495299;15197.848021519754;15217.163056031914;15238.695226095417;15247.771283430757;8773.561321933877;10527.420991845445;10556.208284378703;10648.041676249175;11041.282316649473;12178.81731774024;12321.753564928651;12377.62867113988;12387.380630968506;12857;4051.6150965658217;4215.641670458015;4359.956400436018;4400.845970391053;4496.303073023687;108565;110108.34837477365;111307.75614682378;111531;112137.87862121356;8726.345524085718;10542.947285263524;11034.668959931054;11073.50169242386;11207.775844483065;21511.892440537697;21665.56668866614;21698.674519882214;21975.780242197692;21978.89010554937;7546.811329716691;7548.207438218908;7570.394368450511;7588.696452141963;7676.501027433199;3790.3556395412293;4143.875683729493;4216.810243539048;4254.234237837219;4389.122175564836;3091.8144911304944;3108.4249413858056;3168.730657894059;3174.6349169845303;3175.7459403247685;637.1525870592102;637.1844039629282;645.1806206118204;651.4007113455538;656.3600489522772;626.9373062693694;627.8681476889813;642.1844257792577;644.486335507936;677.376813331736;8819.955900220459;8902.499751020763;8996.460212387277;9154.084591540926;9712.660056897974;591.1457943272017;608.5557542993639;615.1572345886075;661.2858113237692;667.2526770017612;3740.9625903741157;4324.56754324565;4496.303073023687;4648.930266046012;4661.696989695659;101865.3041430654;105764.47117764362;105786;105953.17257550909;106333;72066.63966680133;74768.62615686886;88070.55964720136;89158;89333;77088.61455692798;77844.61077694688;78419.60790196013;78695;81474.59262703649;8963.05887881763;9036.23192028685;9099.636014559343;9100;9302.02328755471;45963.54036459726;51627;52185.217221740946;53200.73399632977;53478;63545.36454635394;68023;68379.65810170917;70299.64850175717;74419.13952151239;12312.322822244863;12884.871151288367;12938.223706577635;13471.528496502575;13694.863051369359;13711.245881476216;14793.408263669333;14805.333759981042;15119.848801511844;15309.08145511273;13211;13938.759226012287;14092.577222683336;14158.929205353907;14420.206888621227;11451.370174640142;13092.083554151119;13211.405486753312;13332.2667253302;14223.928880355532;12534.435950382072;12872.292023938773;13635.386407611879;13665.590032299047;13705.177689338672;10649.787004259717;10749.62376316825;11210.83183752228;11522.76954460923;11819.645410637695;9956.402615843073;10359.533820977924;10719.571217151226;10897;10999.285046471954 20:20:46 INFO - PROCESS | 1637 | __end_tp_report 20:20:46 INFO - PROCESS | 1637 | __start_cc_report 20:20:46 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1500 20:20:46 INFO - PROCESS | 1637 | __end_cc_report 20:20:46 INFO - PROCESS | 1637 | __startTimestamp1486700446292__endTimestamp 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | ------- Summary: start ------- 20:20:46 INFO - PROCESS | 1637 | Number of tests: 6 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5583.10 Median:5720.17 stddev:630.26 (11.0%) stddev-sans-first:604.41 20:20:46 INFO - PROCESS | 1637 | Values: 3223.8 3234.0 3273.1 3298.3 3313.6 4519.2 5493.9 5513.7 5517.7 5545.3 4558.2 5499.6 5512.6 5526.0 5529.1 4785.0 5017.8 5056.3 5117.7 5127.6 4997.6 5008.6 5008.8 5052.5 5123.0 5062.3 5079.5 5086.2 5086.6 5094.8 5051.2 5057.0 5065.2 5069.2 5080.8 5035.0 5035.1 5035.3 5045.2 5046.5 5420.0 5553.8 5555.3 5559.6 5568.1 5947.9 5992.1 6055.8 6090.4 6098.0 6174.4 6176.2 6177.4 6178.8 6184.0 5563.9 5615.3 5624.4 5633.7 5651.0 6104.7 6162.7 6168.8 6173.3 6266.6 5938.0 5942.9 5950.5 5971.3 6020.0 6071.9 6092.0 6095.6 6102.8 6106.0 5831.0 5887.4 6007.1 6042.5 6044.7 5986.9 6045.5 6061.4 6114.0 6118.7 4903.9 4908.3 4909.2 4910.0 4925.4 4324.9 4336.1 4351.5 4351.8 4369.9 5468.1 5601.2 5610.9 5650.4 5656.2 5873.2 6098.6 6129.8 6139.5 6184.2 5645.9 5664.9 5689.5 5693.5 5695.4 5295.9 5339.0 5344.8 5349.4 5379.9 6138.4 6188.3 6199.1 6265.2 6276.6 5989.4 6051.0 6055.9 6089.9 6091.4 6130.8 6206.4 6208.8 6214.9 6250.4 5924.7 5942.2 5983.1 6025.8 6063.2 5949.1 6135.2 6154.6 6168.2 6177.8 5362.2 5731.1 5940.6 5967.5 5977.3 5768.8 5771.9 5812.3 5823.8 5905.8 5703.3 5707.8 5717.4 5720.2 5720.9 5812.4 5843.7 5866.3 5870.5 5898.7 5696.9 5714.9 5717.4 5753.7 5814.6 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:71834.88 Median:36979.54 stddev:158177.96 (427.7%) stddev-sans-first:158530.92 20:20:46 INFO - PROCESS | 1637 | Values: 462.7 484.3 497.2 522.6 525.2 28128.0 32637.8 41029.8 42557.0 42626.8 43719.8 44264.3 44266.7 44269.6 44343.3 9214.9 9438.2 9448.1 9461.7 9491.2 8412.6 8657.7 11106.9 11402.2 11419.0 11431.4 11468.2 11476.3 11496.2 11499.0 11354.8 11409.4 11417.8 11424.3 11431.9 8367.1 8641.3 11004.1 11284.6 11295.7 41456.4 41758.0 41776.6 41882.6 42005.8 3926.0 3998.2 4009.3 4049.4 4071.2 29528.9 29705.0 29752.4 31253.7 31696.8 3141.1 3255.1 3261.6 3293.9 3301.6 510380.0 511944.0 511979.0 511988.0 512688.0 66631.7 66838.3 66961.0 67058.3 67073.7 58474.4 70553.0 70976.3 71014.0 71134.0 16719.9 16896.2 17212.9 17221.2 17240.6 11697.7 13030.7 13032.8 13090.3 13111.0 16304.8 16818.8 19748.9 21981.0 22038.7 7352.9 7403.8 8691.7 8729.3 8849.2 750.3 770.3 878.9 891.8 924.7 24874.6 29752.4 30439.7 30756.5 31398.7 992.5 1019.1 1056.2 1140.8 1199.4 14212.0 14624.3 14686.5 14979.0 15022.0 667711.0 672862.0 672973.0 673266.0 673641.0 55005.0 55530.7 55766.4 55947.2 56101.4 1398.8 1416.4 1454.4 1457.1 1459.5 27418.5 27951.6 27980.9 28601.0 28643.6 48160.5 49051.5 49071.5 49174.0 49216.0 577507.0 578540.0 579022.0 579895.0 581172.0 22988.0 26223.6 26440.3 26448.2 26556.9 37197.4 42722.8 44862.0 46485.5 47214.8 34359.5 36911.6 37011.3 37095.4 37429.8 35778.3 36947.8 37549.1 37822.2 38028.9 35056.9 35347.8 35711.3 35896.8 36029.6 30833.7 32414.5 32666.0 32928.2 33023.7 24178.6 24496.9 24551.0 24955.1 24970.6 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:39135.13 Median:21114.13 stddev:118486.94 (561.2%) stddev-sans-first:118783.57 20:20:46 INFO - PROCESS | 1637 | Values: 365.2 385.8 392.1 396.1 416.5 14822.1 15314.8 18348.4 20830.4 21255.4 17815.7 19455.0 21271.0 21892.5 21923.7 5283.1 5293.3 5439.0 5470.2 5500.1 5290.9 5408.2 5420.2 5420.4 5428.6 3879.6 4071.0 5836.5 6082.7 6105.9 6058.0 6147.4 6159.3 6174.9 6617.1 5918.4 5965.3 5992.4 6001.2 6012.4 10561.5 20949.4 25589.9 25754.0 25855.4 2609.2 2672.6 2701.3 2727.3 2731.1 9614.4 10162.2 10208.3 10328.5 10458.8 1791.7 1827.4 1841.0 1846.7 1848.3 130064.3 131292.3 137606.0 138732.3 143038.0 11757.9 11845.5 11918.9 11939.6 11941.3 15452.5 15676.2 15701.5 15729.6 15745.0 8608.4 8725.3 8766.2 8785.9 8843.6 8535.0 8552.8 8560.6 8657.4 8790.7 4734.5 4735.2 4736.8 4747.9 4807.0 1720.9 1974.7 2017.6 2023.7 2025.7 1002.8 1004.7 1004.9 1013.3 1048.7 22217.9 22478.7 22665.0 22778.0 22993.2 1031.9 1036.0 1046.3 1059.2 1061.3 11163.7 11671.0 11712.7 11790.3 11804.2 527752.0 657620.0 753034.0 777298.0 798698.0 109769.5 140701.3 141751.0 165047.3 166059.2 1006.4 1025.2 1044.5 1052.7 1054.9 19073.9 19567.2 20356.4 20624.7 20972.9 53739.5 55433.7 55629.3 57128.0 57402.7 78537.0 82157.2 82687.6 82782.0 82920.6 8092.3 8138.3 8426.0 8529.7 8782.9 11282.8 11905.7 13178.5 13569.5 13570.4 11177.0 11281.3 11337.9 11741.4 11752.9 10981.8 11227.2 11280.5 11384.4 11405.7 11385.7 11418.9 11713.2 11969.3 12013.9 8345.4 8376.3 8415.7 8590.4 8627.0 8922.2 11165.9 11267.6 11272.8 11552.2 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5245.80 Median:5220.83 stddev:2880.55 (55.2%) stddev-sans-first:2874.34 20:20:46 INFO - PROCESS | 1637 | Values: 1428.6 1431.7 1437.8 1447.9 1451.5 7845.6 8169.9 8180.1 8195.2 8201.8 7209.6 7513.0 7518.4 7560.7 7569.5 2031.5 2087.9 2102.7 2289.8 2290.3 2251.3 2284.7 2291.9 2294.9 2301.6 1982.6 2255.8 2273.2 2274.2 2281.2 2019.4 2186.4 2269.3 2270.4 2272.5 2212.5 2272.3 2277.4 2281.9 2286.6 8007.2 8080.4 8085.8 8106.1 8119.1 4873.0 5028.6 5028.7 5030.3 5030.7 2928.1 3239.6 3366.2 3377.2 3443.5 1082.8 1208.3 1212.5 1240.6 1265.8 10334.9 10412.6 10433.0 10434.0 10434.6 4240.3 4452.3 4526.5 4527.8 4552.8 9183.8 9185.6 9205.8 9221.5 9244.0 5045.1 5046.5 5048.5 5049.9 5050.5 4462.4 4531.5 4568.4 4618.1 4625.6 3359.7 3386.8 3642.4 3648.3 3692.4 1096.7 1106.4 1108.8 1109.4 1115.3 734.7 749.3 775.7 783.3 794.9 5336.3 5421.5 5449.2 5466.9 5529.5 534.1 539.9 566.6 571.3 572.5 3358.6 3416.8 3724.9 3734.8 3746.6 9462.2 9581.3 9795.9 9811.9 9827.5 9549.5 9731.8 9733.6 9742.0 9755.3 7462.9 7639.6 7658.0 7666.5 7672.2 5206.7 5234.9 5263.8 5435.2 5582.6 7895.4 8548.3 8692.5 8882.2 8926.8 9008.7 9136.0 9140.0 9243.9 9264.6 6467.5 6669.5 6947.7 7114.9 7118.4 6824.7 7762.5 7791.0 7803.5 7845.6 6518.3 6862.2 6909.2 6984.4 7081.6 6760.6 6868.7 6872.0 6876.5 6880.1 6170.7 6195.5 6290.2 6310.3 6311.8 4821.7 4927.4 4963.6 4971.4 4978.4 4815.8 4881.1 4891.3 5022.6 5113.8 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4387.66 Median:4895.94 stddev:1353.72 (27.6%) stddev-sans-first:1322.34 20:20:46 INFO - PROCESS | 1637 | Values: 302.7 346.3 354.9 358.6 360.3 5282.6 5298.4 5311.6 5312.7 5368.8 4335.3 4961.6 5028.3 5080.9 5269.1 4027.4 4080.2 4098.6 4107.8 4151.7 3365.7 4071.0 4073.4 4088.9 4103.9 3174.2 3540.9 4072.7 4084.8 4104.9 3913.5 3927.7 3928.3 3956.3 3963.2 2995.8 3372.3 3460.7 3470.7 3471.9 5006.4 5105.7 5124.9 5147.7 5165.3 3681.8 3750.1 4415.0 4506.4 4516.2 5278.8 5531.9 5541.1 5545.7 5591.5 3311.3 3722.9 3817.0 3817.7 3848.9 4870.5 4965.4 5634.5 5652.7 5795.8 3554.9 3563.3 3612.9 3821.9 3862.4 3013.9 3381.7 3443.9 3874.8 3921.1 4001.6 4151.7 4307.0 4570.7 4578.8 4510.5 4536.2 4729.0 5007.9 5085.4 1141.9 1219.4 1222.3 1268.2 1274.6 700.4 768.0 806.6 809.7 836.5 4847.4 4855.9 4861.6 4864.5 4913.0 4793.7 4893.1 5092.2 5326.7 5346.8 4479.3 4701.9 4808.5 4818.8 4898.8 2435.0 2636.7 2796.7 2809.5 2854.2 5414.4 5464.8 5526.1 5534.2 5599.8 4672.6 5165.1 5198.5 5337.7 5907.4 5396.6 5645.3 5839.3 5935.7 5970.0 5270.7 5320.8 5671.9 5684.9 5814.8 5334.8 5544.7 5673.9 5677.3 5735.8 4925.6 5804.5 5905.9 5912.3 5954.0 3979.6 4060.6 4075.8 4099.7 4140.3 4665.1 4919.2 5600.9 5625.8 5630.9 4601.0 5446.8 5488.0 5585.5 5618.7 4322.6 5301.4 5405.8 5412.5 5498.8 4735.7 5002.8 5076.4 5086.0 5332.4 4954.7 5247.3 5325.6 5524.0 5536.4 4132.7 4988.1 5158.1 5387.0 5438.0 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20447.95 Median:4374.54 stddev:29781.71 (680.8%) stddev-sans-first:29828.38 20:20:46 INFO - PROCESS | 1637 | Values: 710.8 762.8 815.1 822.9 828.0 15251.9 15773.7 15784.9 15803.9 15819.4 14273.2 14398.6 14426.1 14429.4 14446.6 667.7 688.9 692.8 817.4 835.3 849.5 862.3 863.9 864.0 868.3 904.0 915.8 916.7 916.7 919.0 907.3 908.8 910.7 910.9 911.0 523.1 542.8 652.4 677.9 680.1 14709.2 15197.8 15217.2 15238.7 15247.8 8773.6 10527.4 10556.2 10648.0 11041.3 12178.8 12321.8 12377.6 12387.4 12857.0 4051.6 4215.6 4360.0 4400.8 4496.3 108565.0 110108.3 111307.8 111531.0 112137.9 8726.3 10542.9 11034.7 11073.5 11207.8 21511.9 21665.6 21698.7 21975.8 21978.9 7546.8 7548.2 7570.4 7588.7 7676.5 3790.4 4143.9 4216.8 4254.2 4389.1 3091.8 3108.4 3168.7 3174.6 3175.7 637.2 637.2 645.2 651.4 656.4 626.9 627.9 642.2 644.5 677.4 8820.0 8902.5 8996.5 9154.1 9712.7 591.1 608.6 615.2 661.3 667.3 3741.0 4324.6 4496.3 4648.9 4661.7 101865.3 105764.5 105786.0 105953.2 106333.0 72066.6 74768.6 88070.6 89158.0 89333.0 77088.6 77844.6 78419.6 78695.0 81474.6 8963.1 9036.2 9099.6 9100.0 9302.0 45963.5 51627.0 52185.2 53200.7 53478.0 63545.4 68023.0 68379.7 70299.6 74419.1 12312.3 12884.9 12938.2 13471.5 13694.9 13711.2 14793.4 14805.3 15119.8 15309.1 13211.0 13938.8 14092.6 14158.9 14420.2 11451.4 13092.1 13211.4 13332.3 14223.9 12534.4 12872.3 13635.4 13665.6 13705.2 10649.8 10749.6 11210.8 11522.8 11819.6 9956.4 10359.5 10719.6 10897.0 10999.3 20:20:46 INFO - PROCESS | 1637 | -------- Summary: end -------- 20:20:46 INFO - PROCESS | 1637 | 20:20:46 INFO - TEST-INFO | 1637: exit 0 20:20:46 INFO - TEST-OK | dromaeo_css | took 1119048ms 20:20:46 INFO - TEST-START | kraken 20:20:46 INFO - operating with platform_type : mac_ 20:20:46 INFO - Initialising browser for kraken test... 20:20:46 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpqw1TLw/profile http://localhost:49244/getInfo.html) 20:20:49 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 20:20:49 INFO - PROCESS | 1646 | colorDepth:24 20:20:49 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 20:20:49 INFO - PROCESS | 1646 | __metrics 20:20:49 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:20:49 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:50 INFO - TEST-INFO | 1646: exit 0 20:20:50 INFO - Browser initialized. 20:20:50 INFO - Running cycle 1/1 for kraken test... 20:20:50 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpqw1TLw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:02 INFO - PROCESS | 1647 | RSS: Main: 213135360 20:21:02 INFO - PROCESS | 1647 | 20:21:05 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:06 INFO - PROCESS | 1647 | RSS: Main: 265568256 20:21:06 INFO - PROCESS | 1647 | 20:21:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 20:21:09 INFO - PROCESS | 1647 | RSS: Main: 275906560 20:21:09 INFO - PROCESS | 1647 | 20:21:12 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 20:21:13 INFO - PROCESS | 1647 | RSS: Main: 373243904 20:21:13 INFO - PROCESS | 1647 | 20:21:15 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 20:21:15 INFO - PROCESS | 1647 | RSS: Main: 276549632 20:21:15 INFO - PROCESS | 1647 | 20:21:17 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:18 INFO - PROCESS | 1647 | RSS: Main: 278298624 20:21:18 INFO - PROCESS | 1647 | 20:21:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:21 INFO - PROCESS | 1647 | RSS: Main: 317956096 20:21:21 INFO - PROCESS | 1647 | 20:21:24 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:25 INFO - PROCESS | 1647 | RSS: Main: 318906368 20:21:25 INFO - PROCESS | 1647 | 20:21:28 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 20:21:28 INFO - PROCESS | 1647 | RSS: Main: 314753024 20:21:28 INFO - PROCESS | 1647 | 20:21:30 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:21:31 INFO - PROCESS | 1647 | RSS: Main: 293609472 20:21:31 INFO - PROCESS | 1647 | 20:21:32 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:21:33 INFO - PROCESS | 1647 | RSS: Main: 295690240 20:21:33 INFO - PROCESS | 1647 | 20:21:35 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:21:36 INFO - PROCESS | 1647 | RSS: Main: 298233856 20:21:36 INFO - PROCESS | 1647 | 20:21:39 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:21:40 INFO - PROCESS | 1647 | RSS: Main: 317095936 20:21:40 INFO - PROCESS | 1647 | 20:21:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:21:43 INFO - PROCESS | 1647 | RSS: Main: 310816768 20:21:43 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 20:21:45 INFO - PROCESS | 1647 | RSS: Main: 355864576 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | __start_tp_report 20:21:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 20:21:45 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 20:21:45 INFO - PROCESS | 1647 | |i|pagename|runs| 20:21:45 INFO - PROCESS | 1647 | |0;ai-astar;116;115;116;114;116;115;114;115;114;116 20:21:45 INFO - PROCESS | 1647 | |1;audio-beat-detection;177;124;111;143;111;111;111;116;155;113 20:21:45 INFO - PROCESS | 1647 | |2;audio-dft;185;188;184;184;185;180;183;185;185;185 20:21:45 INFO - PROCESS | 1647 | |3;audio-fft;81;59;75;113;84;63;58;58;74;58 20:21:45 INFO - PROCESS | 1647 | |4;audio-oscillator;87;70;86;70;69;69;82;67;68;82 20:21:45 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;92;88;91;88;91;87;92;88;91;86 20:21:45 INFO - PROCESS | 1647 | |6;imaging-darkroom;96;96;97;97;97;96;96;97;97;97 20:21:45 INFO - PROCESS | 1647 | |7;imaging-desaturate;88;96;131;86;87;86;84;89;89;85 20:21:45 INFO - PROCESS | 1647 | |8;json-parse-financial;57;53;53;55;55;57;56;57;57;57 20:21:45 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;66;77;68;76;72;68;68;69;69;70 20:21:45 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;84;83;83;87;83;86;83;84;84;84 20:21:45 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;134;138;138;135;139;153;150;137;179;141 20:21:45 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;168;169;167;165;213;183;168;169;169;167 20:21:45 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;66;65;67;66;65;66;65;64;66;65 20:21:45 INFO - PROCESS | 1647 | __end_tp_report 20:21:45 INFO - PROCESS | 1647 | __start_cc_report 20:21:45 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2118 20:21:45 INFO - PROCESS | 1647 | __end_cc_report 20:21:45 INFO - PROCESS | 1647 | __startTimestamp1486700505705__endTimestamp 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | ------- Summary: start ------- 20:21:45 INFO - PROCESS | 1647 | Number of tests: 14 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.50 stddev:0.88 (0.8%) stddev-sans-first:0.87 20:21:45 INFO - PROCESS | 1647 | Values: 116.0 115.0 116.0 114.0 116.0 115.0 114.0 115.0 114.0 116.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:120.00 stddev:23.31 (19.4%) stddev-sans-first:16.33 20:21:45 INFO - PROCESS | 1647 | Values: 177.0 124.0 111.0 143.0 111.0 111.0 111.0 116.0 155.0 113.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:2.01 (1.1%) stddev-sans-first:2.12 20:21:45 INFO - PROCESS | 1647 | Values: 185.0 188.0 184.0 184.0 185.0 180.0 183.0 185.0 185.0 185.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:72.30 Median:68.50 stddev:17.50 (25.5%) stddev-sans-first:18.28 20:21:45 INFO - PROCESS | 1647 | Values: 81.0 59.0 75.0 113.0 84.0 63.0 58.0 58.0 74.0 58.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:8.15 (10.7%) stddev-sans-first:7.40 20:21:45 INFO - PROCESS | 1647 | Values: 87.0 70.0 86.0 70.0 69.0 69.0 82.0 67.0 68.0 82.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:91.00 stddev:2.22 (2.4%) stddev-sans-first:2.15 20:21:45 INFO - PROCESS | 1647 | Values: 92.0 88.0 91.0 88.0 91.0 87.0 92.0 88.0 91.0 86.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:21:45 INFO - PROCESS | 1647 | Values: 96.0 96.0 97.0 97.0 97.0 96.0 96.0 97.0 97.0 97.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:87.50 stddev:14.07 (16.1%) stddev-sans-first:14.84 20:21:45 INFO - PROCESS | 1647 | Values: 88.0 96.0 131.0 86.0 87.0 86.0 84.0 89.0 89.0 85.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:57.00 stddev:1.64 (2.9%) stddev-sans-first:1.67 20:21:45 INFO - PROCESS | 1647 | Values: 57.0 53.0 53.0 55.0 55.0 57.0 56.0 57.0 57.0 57.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:69.50 stddev:3.62 (5.2%) stddev-sans-first:3.49 20:21:45 INFO - PROCESS | 1647 | Values: 66.0 77.0 68.0 76.0 72.0 68.0 68.0 69.0 69.0 70.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:1.37 (1.6%) stddev-sans-first:1.45 20:21:45 INFO - PROCESS | 1647 | Values: 84.0 83.0 83.0 87.0 83.0 86.0 83.0 84.0 84.0 84.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:140.00 stddev:13.65 (9.7%) stddev-sans-first:13.95 20:21:45 INFO - PROCESS | 1647 | Values: 134.0 138.0 138.0 135.0 139.0 153.0 150.0 137.0 179.0 141.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:169.00 stddev:14.63 (8.7%) stddev-sans-first:15.37 20:21:45 INFO - PROCESS | 1647 | Values: 168.0 169.0 167.0 165.0 213.0 183.0 168.0 169.0 169.0 167.0 20:21:45 INFO - PROCESS | 1647 | 20:21:45 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 20:21:45 INFO - PROCESS | 1647 | Values: 66.0 65.0 67.0 66.0 65.0 66.0 65.0 64.0 66.0 65.0 20:21:45 INFO - PROCESS | 1647 | -------- Summary: end -------- 20:21:45 INFO - PROCESS | 1647 | 20:21:46 INFO - TEST-INFO | 1647: exit 0 20:21:46 INFO - TEST-OK | kraken | took 59635ms 20:21:46 INFO - SUITE-END | took 1178s 20:21:46 INFO - Completed test suite (00:19:38) 20:21:46 INFO - javascript benchmark 20:21:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3223.7904536205147, 3234.0297910626837, 3273.1162586101755, 3298.3073554553544, 3313.5526703894975, 4519.163954668385, 5493.862653433666, 5513.727204100281, 5517.668939863606, 5545.279113715222, 4558.247889098295, 5499.560035197184, 5512.5589952803775, 5525.972370138154, 5529.060059789836, 4785.0, 5017.774200160983, 5056.342675452186, 5117.7185254810975, 5127.615428842833, 4997.575206107485, 5008.574271186953, 5008.824691135811, 5052.494750524955, 5123.026624941249, 5062.316587260728, 5079.542841144296, 5086.211637196222, 5086.593072554187, 5094.847154585368, 5051.242313652945, 5056.974715126401, 5065.1642478990925, 5069.214271787879, 5080.822171223989, 5035.018171456568, 5035.144025515671, 5035.345405097314, 5045.243213517965, 5046.495350464961, 5420.0, 5553.805616803393, 5555.30558680165, 5559.610827242094, 5568.136938774496, 5947.910781338283, 5992.131140984577, 6055.848603784896, 6090.421409966046, 6097.963346231151, 6174.413430724074, 6176.197094377702, 6177.351378105324, 6178.814635560941, 6184.041473571604, 5563.860903477405, 5615.2700148980775, 5624.409437009137, 5633.718314084279, 5651.011073062197, 6104.701693046543, 6162.691865406712, 6168.753249869955, 6173.259208894961, 6266.561340706106, 5938.020226662552, 5942.910856337158, 5950.464458198783, 5971.28344598651, 6019.969900150559, 6071.908921366183, 6091.994820854598, 6095.573309868355, 6102.8169154924535, 6106.0, 5831.0, 5887.411258874078, 6007.06890431975, 6042.486388656926, 6044.667543285162, 5986.850328741816, 6045.455908968214, 6061.424164704346, 6114.032425763494, 6118.663473508911, 4903.901921961612, 4908.312836202935, 4909.189983652729, 4909.950900491021, 4925.38432695913, 4324.870253892388, 4336.067745434747, 4351.521332653406, 4351.825926962886, 4369.868903932887, 5468.0977638689965, 5601.159826026047, 5610.915836262459, 5650.378458369576, 5656.208130861683, 5873.20711703923, 6098.573099883054, 6129.785457508966, 6139.522803442322, 6184.165137706352, 5645.858853528613, 5664.915026274609, 5689.516391106802, 5693.4875861172695, 5695.430456954355, 5295.867603309871, 5339.038972984822, 5344.812931547377, 5349.384820745664, 5379.946200538023, 6138.38839838597, 6188.288346840171, 6199.132121502903, 6265.185525881606, 6276.592021518587, 5989.431004054608, 6050.969745151246, 6055.878882422238, 6089.878202436015, 6091.360407157184, 6130.816075517741, 6206.441420272197, 6208.751649934133, 6214.937850621436, 6250.4374606285655, 5924.674142922181, 5942.168096466412, 5983.072623743326, 6025.78909738157, 6063.242094738158, 5949.1076338549565, 6135.195258262415, 6154.599951003171, 6168.19813424252, 6177.84555386119, 5362.249285100167, 5731.140328950691, 5940.55445841555, 5967.46292833647, 5977.252843394575, 5768.826935191951, 5771.94228057714, 5812.331581868139, 5823.7670493181495, 5905.763769449174, 5703.287089113861, 5707.800226992035, 5717.371089180104, 5720.17057526648, 5720.885582288414, 5812.360640329645, 5843.737031833492, 5866.325372582037, 5870.5010074144175, 5898.705064746831, 5696.914546281892, 5714.9142762857755, 5717.42825717425, 5753.741081651252, 5814.592978491465], "value": 5542.617321778622, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.7223665800518, 484.30985845170636, 497.19454483736354, 522.6210997027156, 525.2016934259927, 28128.0, 32637.83681081597, 41029.79485102574, 42557.0, 42626.786866065704, 43719.78140109303, 44264.3360349595, 44266.67199984006, 44269.55730442695, 44343.33484997728, 9214.861777073349, 9438.150566449018, 9448.102430269113, 9461.716148515521, 9491.240700743923, 8412.579371031454, 8657.740267791976, 11106.944465277662, 11402.201845870792, 11419.0, 11431.42842857858, 11468.19722619417, 11476.254043487188, 11496.19526633136, 11499.0, 11354.772904541904, 11409.42952852354, 11417.771644567061, 11424.257423267461, 11431.885681143207, 8367.121452247547, 8641.308695304424, 11004.119670426428, 11284.605038823684, 11295.717607059807, 41456.37815432771, 41758.0, 41776.58223417757, 41882.58117418817, 42005.78997105025, 3925.9607403926166, 3998.2203470323298, 4009.258287216845, 4049.4330793688614, 4071.2264669712954, 29528.852355738083, 29705.0, 29752.40495190084, 31253.687463125534, 31696.841515792272, 3141.104785136225, 3255.0560337502334, 3261.59230096238, 3293.8517766700556, 3301.636819949804, 510380.0, 511944.0, 511979.0, 511988.0, 512688.0, 66631.66684166549, 66838.33161668418, 66961.0, 67058.32941670618, 67073.66463167653, 58474.41525584775, 70553.0, 70976.29023709697, 71014.0, 71134.0, 16719.913205641595, 16896.239669214916, 17212.913935430242, 17221.225044873012, 17240.568985775455, 11697.707557310965, 13030.674233144247, 13032.80450793239, 13090.280034597998, 13111.016673749507, 16304.755428668579, 16818.813554238117, 19748.901255493918, 21981.010854511584, 22038.669419958715, 7352.926470735331, 7403.8149046274275, 8691.652333906699, 8729.254149170192, 8849.247813935759, 750.2984709296716, 770.2528547309101, 878.9428687135315, 891.7636826241052, 924.6578765856676, 24874.626880596807, 29752.404951901273, 30439.695603043685, 30756.53865192024, 31398.68601314003, 992.4938281476499, 1019.0675531888387, 1056.1761825775907, 1140.7602409157867, 1199.4422593493894, 14212.0, 14624.26878656063, 14686.485972991108, 14978.951473396975, 15022.0, 667711.0, 672862.0, 672973.0, 673266.0, 673641.0, 55005.0, 55530.722346388815, 55766.44233557694, 55947.16079258815, 56101.43898561044, 1398.8321401431892, 1416.3909518906762, 1454.4255019267541, 1457.1038811130866, 1459.4745891479058, 27418.45163096687, 27951.58072628953, 27980.880764769994, 28601.0, 28643.570346445238, 48160.518394815605, 49051.509484904695, 49071.50928490669, 49174.0, 49216.0, 577507.0, 578540.0, 579022.0, 579895.0, 581172.0, 22988.0, 26223.606645899945, 26440.338991525365, 26448.20655380342, 26556.8672156638, 37197.44203836999, 42722.78638606787, 44862.0, 46485.53514464812, 47214.81962950954, 34359.48460773141, 36911.63088369082, 37011.259774804894, 37095.44356834596, 37429.812850935574, 35778.28443431065, 36947.815260923526, 37549.06127346838, 37822.243555129295, 38028.85913422602, 35056.94829155129, 35347.82326088353, 35711.28577428489, 35896.820515897256, 36029.63970360263, 30833.691663083082, 32414.513782293758, 32666.0, 32928.18894960704, 33023.66976330302, 24178.637320439855, 24496.897639606617, 24550.972747145013, 24955.126570569944, 24970.62544061877], "value": 20232.008763476122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1510238695035, 385.8283064036503, 392.11577891853875, 396.1127075351214, 416.475241196093, 14822.110673359592, 15314.846851531482, 18348.44954651361, 20830.37508874736, 21255.362339129813, 17815.73276400855, 19455.027248637547, 21271.0, 21892.45268868275, 21923.6711449328, 5283.07546179419, 5293.338332708421, 5438.967706129248, 5470.234167216593, 5500.119980803072, 5290.867728306785, 5408.242846001563, 5420.186971954199, 5420.430854760252, 5428.565714742811, 3879.5926427725108, 4071.043304823364, 5836.474717275444, 6082.695865206744, 6105.938940610604, 6058.0, 6147.446729794317, 6159.260888693363, 6174.876502469971, 6617.106690596756, 5918.437748413894, 5965.254343207099, 5992.400759924017, 6001.1898393717165, 6012.398760123996, 10561.524731387106, 20949.428792840597, 25589.872050639628, 25753.96984120633, 25855.35361615956, 2609.178108895692, 2672.5590277604174, 2701.2706569226198, 2727.2500062482777, 2731.05778506415, 9614.352983250854, 10162.18702503798, 10208.336458130272, 10328.535215915303, 10458.843117353246, 1791.7222830461299, 1827.3969590035256, 1840.9907950460163, 1846.676831554486, 1848.2514581594476, 130064.34967825195, 131292.34353828264, 137606.0, 138732.30633846868, 143038.0, 11757.88242117585, 11845.466953987092, 11918.88081119195, 11939.641810745692, 11941.343226122646, 15452.5364239073, 15676.216189190724, 15701.450449234222, 15729.606759830867, 15745.0, 8608.440451370767, 8725.301975841918, 8766.167214114648, 8785.868211976825, 8843.646254149891, 8535.0, 8552.786180345542, 8560.61477233526, 8657.437266577652, 8790.692325768696, 4734.479207287196, 4735.171345014609, 4736.8105275788585, 4747.928781068286, 4807.038592281558, 1720.931162753501, 1974.7235387045826, 2017.6280129511779, 2023.716679664848, 2025.7163997040427, 1002.7894142230214, 1004.7186787699455, 1004.9045340692622, 1013.3160116921049, 1048.6696690542456, 22217.888910555343, 22478.66282005771, 22665.0, 22778.0, 22993.195238166583, 1031.9226058045676, 1035.9896401035894, 1046.2937517175876, 1059.2320567588438, 1061.341967979842, 11163.665090047312, 11671.007964323127, 11712.70718232034, 11790.292582445081, 11804.232724872856, 527752.0, 657620.0, 753034.0, 777298.0, 798698.0, 109769.45115274373, 140701.2964935169, 141751.0, 165047.3495265032, 166059.16970415312, 1006.3760468509424, 1025.1593693171528, 1044.5404022230193, 1052.6578861869923, 1054.8681414823147, 19073.904630476758, 19567.180321687665, 20356.389308320773, 20624.690629640867, 20972.895135524224, 53739.46260537345, 55433.7228313872, 55629.33112006646, 57128.0, 57402.7129864348, 78537.0, 82157.17842821495, 82687.5865620692, 82782.0, 82920.58539707263, 8092.271695547429, 8138.3082437993435, 8425.95787021061, 8529.74410767678, 8782.868256976022, 11282.774344513227, 11905.749896260768, 13178.472861085449, 13569.52506662262, 13570.389332479865, 11177.0, 11281.32312061279, 11337.886621133683, 11741.354225517336, 11752.941235293769, 10981.83527247076, 11227.21409501327, 11280.49237784318, 11384.37385943781, 11405.714857128638, 11385.658430247106, 11418.942905285421, 11713.238639488405, 11969.281843089442, 12013.939930300292, 8345.374096942875, 8376.329893608376, 8415.747527574182, 8590.398672092893, 8627.00789409226, 8922.241609463008, 11165.88834111681, 11267.605633802777, 11272.83090753623, 11552.191346605992], "value": 9873.958152029078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.5500067478742, 1431.7494438473263, 1437.7987081808542, 1447.9348429320687, 1451.5064877941502, 7845.607719614018, 8169.87745183822, 8180.100188979222, 8195.22145396188, 8201.753947381589, 7209.603471809049, 7512.9624351878165, 7518.436117291198, 7560.735374261902, 7569.470137090406, 2031.5124370151168, 2087.8747275163464, 2102.67531455183, 2289.7595752446005, 2290.278562252885, 2251.268337790225, 2284.737255215655, 2291.9083236670513, 2294.8737819419925, 2301.6432452969816, 1982.5638359560946, 2255.8308126890465, 2273.238465114189, 2274.1699279762934, 2281.23578601168, 2019.4345583236718, 2186.3987403464093, 2269.296518079401, 2270.4437412833795, 2272.522770218256, 2212.524307273944, 2272.306946381353, 2277.36233854521, 2281.885905704708, 2286.5769832581027, 8007.159248278905, 8080.353571714249, 8085.757427277191, 8106.148854370324, 8119.066307374668, 4872.951270487285, 5028.647994640377, 5028.748562571856, 5030.320906677625, 5030.673006254582, 2928.136199821037, 3239.5950506186728, 3366.1584603849037, 3377.155711072232, 3443.500692399613, 1082.8429877667695, 1208.299186471853, 1212.5089338817793, 1240.584404224577, 1265.7848165811833, 10334.948325258325, 10412.635557755519, 10433.017726631992, 10434.0, 10434.582616695323, 4240.257954857888, 4452.265376212953, 4526.502084770673, 4527.818887244539, 4552.840650577214, 9183.770405739777, 9185.586648600829, 9205.81588368229, 9221.53892305382, 9244.029376915461, 5045.066662667345, 5046.495350464924, 5048.469910659402, 5049.899002020013, 5050.520200580939, 4462.3752674625575, 4531.478879928851, 4568.446728112392, 4618.122556714214, 4625.560571745679, 3359.714424273915, 3386.797686821143, 3642.4354225095153, 3648.288583726148, 3692.409214525663, 1096.6655170173015, 1106.3748981825404, 1108.83921831334, 1109.4120116338354, 1115.3140818396628, 734.7428400059936, 749.3256069537351, 775.6936010276022, 783.2637320918318, 794.9364050875917, 5336.306280183629, 5421.484958928974, 5449.1826226066405, 5466.890662186734, 5529.529989950899, 534.1400345443832, 539.9001184780828, 566.5892228134569, 571.3144226927703, 572.4590262202179, 3358.6137594176494, 3416.787040600551, 3724.8882533523497, 3734.8319325630414, 3746.625337466286, 9462.195713364303, 9581.281403894596, 9795.9020409795, 9811.901880981242, 9827.508624568743, 9549.474778887088, 9731.805363892825, 9733.56198971048, 9742.0, 9755.317127801127, 7462.85074298511, 7639.579823109671, 7657.961710191525, 7666.5050315188, 7672.194419585975, 5206.713630750345, 5234.947650523598, 5263.841954769944, 5435.157550579666, 5582.581306401955, 7895.368370530458, 8548.273396761097, 8692.478451292942, 8882.15619516145, 8926.776830579287, 9008.684696035607, 9136.0, 9140.0, 9243.907560924305, 9264.629414823601, 6467.547271690936, 6669.53313268086, 6947.7220911162985, 7114.893276600752, 7118.430525557839, 6824.727010919508, 7762.456628035983, 7791.0, 7803.531788092732, 7845.6077196141105, 6518.315576864361, 6862.245153033262, 6909.205441374306, 6984.371406573433, 7081.6459177039915, 6760.594364338155, 6868.690908909211, 6872.037914691847, 6876.484263680344, 6880.071190389233, 6170.7223174958135, 6195.473384762166, 6290.2451705793765, 6310.305866354605, 6311.779087731908, 4821.686590371755, 4927.359443272351, 4963.5780958618925, 4971.353724015855, 4978.4274808397495, 4815.783289752039, 4881.096997055556, 4891.315215869852, 5022.623303252198, 5113.846584602468], "value": 4201.657949619747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6867192455808, 346.32639516141114, 354.9006278242093, 358.58404251068765, 360.27225005488896, 5282.600110970591, 5298.443663415339, 5311.62818602698, 5312.707801070939, 5368.8389348319515, 4335.28756141324, 4961.6278779091535, 5028.321176641161, 5080.882205914702, 5269.129459042042, 4027.3556231003045, 4080.2043601497644, 4098.5901409858925, 4107.774072426016, 4151.730137541065, 3365.747568932328, 4070.979645101785, 4073.388991651261, 4088.9182216355657, 4103.886498453299, 3174.1907112945514, 3540.8583656653705, 4072.7149099563044, 4084.83660653575, 4104.8973775655695, 3913.4716813230134, 3927.6857851371965, 3928.2732694451333, 3956.347202711549, 3963.1677347757004, 2995.7603391728608, 3372.285310325212, 3460.653934606519, 3470.6746479858557, 3471.9341991515007, 5006.374203224597, 5105.719185444799, 5124.92312615311, 5147.6911385317, 5165.328507294065, 3681.834317455721, 3750.0874553977396, 4414.977925110386, 4506.436695413074, 4516.18708632446, 5278.788848446057, 5531.925527927027, 5541.088324528031, 5545.667259964415, 5591.548240465554, 3311.3211791582667, 3722.9069273268115, 3816.9809150954347, 3817.675497582709, 3848.903777405559, 4870.488598697157, 4965.379327584016, 5634.549236061187, 5652.717364131777, 5795.797147099831, 3554.91112722184, 3563.2695297463956, 3612.9277414451562, 3821.904452388657, 3862.3820188770223, 3013.8643761030808, 3381.746369022284, 3443.913902152416, 3874.791368919745, 3921.117748506563, 4001.579834117434, 4151.733721214998, 4307.028150576155, 4570.748608826547, 4578.771061446914, 4510.466980684391, 4536.160810250114, 4729.0, 5007.923296491272, 5085.389753229636, 1141.948612312448, 1219.4329636718792, 1222.2910711787142, 1268.192825224052, 1274.5730180389487, 700.4116542104555, 768.0092680442278, 806.6329819931917, 809.7246936041774, 836.5402372859278, 4847.442544107403, 4855.878603034952, 4861.586765124934, 4864.537868902448, 4912.96112113476, 4793.736344501086, 4893.119238537098, 5092.185250359925, 5326.733663316819, 5346.796970681643, 4479.3057076153245, 4701.882452938636, 4808.471068182497, 4818.807247710122, 4898.755062246873, 2434.975650243475, 2636.7231440698833, 2796.7203279672276, 2809.5083360411845, 2854.24362543926, 5414.377346605112, 5464.754086066137, 5526.115821468546, 5534.225208470817, 5599.776008959596, 4672.6215766349005, 5165.096108181053, 5198.480151984847, 5337.653052551572, 5907.438793314628, 5396.64921780083, 5645.322561292671, 5839.328477225174, 5935.687559634103, 5969.95532278541, 5270.736463176902, 5320.787168513371, 5671.8865622688145, 5684.914726279192, 5814.825555233349, 5334.786608535615, 5544.695041772741, 5673.858153546194, 5677.31872175325, 5735.763052409647, 4925.605951523941, 5804.5356371491025, 5905.881882362242, 5912.320083190316, 5954.0, 3979.582143874851, 4060.6193894076155, 4075.8165882534763, 4099.672026237834, 4140.3168477200925, 4665.090307390162, 4919.196058246765, 5600.85997850057, 5625.79045505202, 5630.85922851932, 4600.976995115003, 5446.836594902159, 5488.0, 5585.497305242548, 5618.747156378055, 4322.5677432256525, 5301.4168441472175, 5405.837824865261, 5412.539934105487, 5498.780048798003, 4735.7395343255075, 5002.774875130701, 5076.36545431821, 5085.999260436361, 5332.440093790251, 4954.702717836942, 5247.317848679647, 5325.627206095691, 5524.0, 5536.366771802247, 4132.669386449137, 4988.12707776145, 5158.09733296664, 5386.973065134649, 5437.972810135924], "value": 3961.522825984625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8009757267963, 762.7749813804927, 815.1440986963687, 822.8518866604011, 827.9921191111555, 15251.923740381297, 15773.684526309467, 15784.92107539462, 15803.92098039511, 15819.446319378823, 14273.214973176471, 14398.568042958701, 14426.134431934091, 14429.422823087063, 14446.566603001927, 667.7462564225588, 688.8725585766649, 692.7956252905379, 817.3747083481142, 835.3233880556738, 849.4945507423073, 862.3101518784947, 863.8617821148617, 864.0495454999514, 868.2793281576309, 904.023654453189, 915.7756349694334, 916.6791622931987, 916.724982505249, 919.0441940381995, 907.2605826251616, 908.8318661047662, 910.7358865928873, 910.8815853938979, 911.0252030327553, 523.123767689123, 542.7503348459713, 652.3639451534763, 677.8779819632464, 680.0852852912824, 14709.190994495299, 15197.848021519754, 15217.163056031914, 15238.695226095417, 15247.771283430757, 8773.561321933877, 10527.420991845445, 10556.208284378703, 10648.041676249175, 11041.282316649473, 12178.81731774024, 12321.753564928651, 12377.62867113988, 12387.380630968506, 12857.0, 4051.6150965658217, 4215.641670458015, 4359.956400436018, 4400.845970391053, 4496.303073023687, 108565.0, 110108.34837477365, 111307.75614682378, 111531.0, 112137.87862121356, 8726.345524085718, 10542.947285263524, 11034.668959931054, 11073.50169242386, 11207.775844483065, 21511.892440537697, 21665.56668866614, 21698.674519882214, 21975.780242197692, 21978.89010554937, 7546.811329716691, 7548.207438218908, 7570.394368450511, 7588.696452141963, 7676.501027433199, 3790.3556395412293, 4143.875683729493, 4216.810243539048, 4254.234237837219, 4389.122175564836, 3091.8144911304944, 3108.4249413858056, 3168.730657894059, 3174.6349169845303, 3175.7459403247685, 637.1525870592102, 637.1844039629282, 645.1806206118204, 651.4007113455538, 656.3600489522772, 626.9373062693694, 627.8681476889813, 642.1844257792577, 644.486335507936, 677.376813331736, 8819.955900220459, 8902.499751020763, 8996.460212387277, 9154.084591540926, 9712.660056897974, 591.1457943272017, 608.5557542993639, 615.1572345886075, 661.2858113237692, 667.2526770017612, 3740.9625903741157, 4324.56754324565, 4496.303073023687, 4648.930266046012, 4661.696989695659, 101865.3041430654, 105764.47117764362, 105786.0, 105953.17257550909, 106333.0, 72066.63966680133, 74768.62615686886, 88070.55964720136, 89158.0, 89333.0, 77088.61455692798, 77844.61077694688, 78419.60790196013, 78695.0, 81474.59262703649, 8963.05887881763, 9036.23192028685, 9099.636014559343, 9100.0, 9302.02328755471, 45963.54036459726, 51627.0, 52185.217221740946, 53200.73399632977, 53478.0, 63545.36454635394, 68023.0, 68379.65810170917, 70299.64850175717, 74419.13952151239, 12312.322822244863, 12884.871151288367, 12938.223706577635, 13471.528496502575, 13694.863051369359, 13711.245881476216, 14793.408263669333, 14805.333759981042, 15119.848801511844, 15309.08145511273, 13211.0, 13938.759226012287, 14092.577222683336, 14158.929205353907, 14420.206888621227, 11451.370174640142, 13092.083554151119, 13211.405486753312, 13332.2667253302, 14223.928880355532, 12534.435950382072, 12872.292023938773, 13635.386407611879, 13665.590032299047, 13705.177689338672, 10649.787004259717, 10749.62376316825, 11210.83183752228, 11522.76954460923, 11819.645410637695, 9956.402615843073, 10359.533820977924, 10719.571217151226, 10897.0, 10999.285046471954], "value": 7353.133899788887, "unit": "score"}], "name": "dromaeo_css", "value": 7167.07798966831, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 116.0, 114.0, 116.0, 115.0, 114.0, 115.0, 114.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 124.0, 111.0, 143.0, 111.0, 111.0, 111.0, 116.0, 155.0, 113.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 184.0, 184.0, 185.0, 180.0, 183.0, 185.0, 185.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 75.0, 113.0, 84.0, 63.0, 58.0, 58.0, 74.0, 58.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 86.0, 70.0, 69.0, 69.0, 82.0, 67.0, 68.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 91.0, 88.0, 91.0, 87.0, 92.0, 88.0, 91.0, 86.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 96.0, 131.0, 86.0, 87.0, 86.0, 84.0, 89.0, 89.0, 85.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 55.0, 55.0, 57.0, 56.0, 57.0, 57.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 68.0, 76.0, 72.0, 68.0, 68.0, 69.0, 69.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 87.0, 83.0, 86.0, 83.0, 84.0, 84.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 138.0, 135.0, 139.0, 153.0, 150.0, 137.0, 179.0, 141.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 167.0, 165.0, 213.0, 183.0, 168.0, 169.0, 169.0, 167.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 64.0, 66.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1445.9, "alertThreshold": 2.0}]} 20:21:46 INFO - Return code: 0 20:21:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:21:47 ERROR - # TBPL SUCCESS # 20:21:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:21:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:21:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:21:47 INFO - 2017-02-09 20:21:47.054 screenresolution[1651:9938] starting screenresolution argv=screenresolution get 20:21:47 INFO - 2017-02-09 20:21:47.056 screenresolution[1651:9938] Display 0: 1600x1200x32@60 20:21:47 INFO - 2017-02-09 20:21:47.062 screenresolution[1652:9941] starting screenresolution argv=screenresolution list 20:21:47 INFO - Available Modes on Display 0 20:21:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:21:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:21:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:21:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:21:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:21:47 INFO - Intel Iris: 20:21:47 INFO - Chipset Model: Intel Iris 20:21:47 INFO - Type: GPU 20:21:47 INFO - Bus: Built-In 20:21:47 INFO - VRAM (Dynamic, Max): 1536 MB 20:21:47 INFO - Vendor: Intel (0x8086) 20:21:47 INFO - Device ID: 0x0a2e 20:21:47 INFO - Revision ID: 0x0009 20:21:47 INFO - Displays: 20:21:47 INFO - Display: 20:21:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:21:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:21:47 INFO - Display Serial Number: 1600x1200 60 20:21:47 INFO - Main Display: Yes 20:21:47 INFO - Mirror: Off 20:21:47 INFO - Online: Yes 20:21:47 INFO - Rotation: Supported 20:21:47 INFO - Return code: 0 20:21:47 INFO - Running post-action listener: _resource_record_post_action 20:21:47 INFO - [mozharness: 2017-02-10 04:21:47.301262Z] Finished run-tests step (success) 20:21:47 INFO - Running post-run listener: _resource_record_post_run 20:21:47 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39134208; Write bytes: 508759552; Read time: 378; Write time: 2427 20:21:47 INFO - TinderboxPrint: CPU usage
53.6% 20:21:47 INFO - TinderboxPrint: I/O read bytes / time
39,134,208 / 378 20:21:47 INFO - TinderboxPrint: I/O write bytes / time
508,759,552 / 2,427 20:21:47 INFO - TinderboxPrint: CPU idle
2,229.2 (46.4%) 20:21:47 INFO - TinderboxPrint: CPU system
964.9 (20.1%) 20:21:47 INFO - TinderboxPrint: CPU user
1,607.6 (33.5%) 20:21:47 INFO - TinderboxPrint: Swap in / out
246,407,168 / 0 20:21:47 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 199330304; Write bytes: 198840320; Read time: 15953; Write time: 363 20:21:47 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 38237184; Write bytes: 299055104; Read time: 364; Write time: 2015 20:21:47 INFO - Running post-run listener: _upload_blobber_files 20:21:47 INFO - Blob upload gear active. 20:21:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:21:47 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 20:21:47 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:21:47 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:21:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:49 INFO - (blobuploader) - INFO - Done attempting. 20:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:50 INFO - (blobuploader) - INFO - Done attempting. 20:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:51 INFO - (blobuploader) - INFO - Done attempting. 20:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:21:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:53 INFO - (blobuploader) - INFO - Done attempting. 20:21:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:53 INFO - Return code: 0 20:21:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:21:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21acf9f1d4bf4b0fe9c9c45488c08c8a4e157c77ce35760f6f1f278d3c7d8d0d18f0145fce460e28e36088e13f09d77b821f5d8f8beca1a0c3815e7aacc0ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/056e06048536c39ef439b59e75e09061bd8eda54ec286a3c04d4793be0abe6fb706a8955546e39300090c7b73e098978ce9d8203ed017a52b7ac69f0680efc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d145ffc405c68c409e653c750f5462921c096a3c10e33401486e282581d603190ae6ed696d8cd025908207ba50ceb9594c80075116596d4dbc59d88b42128de6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c57f36480fe4b952e2f15be534846f97f1646e23ce66da3e03af17d299b658706313f53b4f24662f5b2d3145f31e1e30eaffce5d05bc41e9a693896c481d0ee2"} 20:21:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:21:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:21:53 INFO - Contents: 20:21:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21acf9f1d4bf4b0fe9c9c45488c08c8a4e157c77ce35760f6f1f278d3c7d8d0d18f0145fce460e28e36088e13f09d77b821f5d8f8beca1a0c3815e7aacc0ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/056e06048536c39ef439b59e75e09061bd8eda54ec286a3c04d4793be0abe6fb706a8955546e39300090c7b73e098978ce9d8203ed017a52b7ac69f0680efc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d145ffc405c68c409e653c750f5462921c096a3c10e33401486e282581d603190ae6ed696d8cd025908207ba50ceb9594c80075116596d4dbc59d88b42128de6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c57f36480fe4b952e2f15be534846f97f1646e23ce66da3e03af17d299b658706313f53b4f24662f5b2d3145f31e1e30eaffce5d05bc41e9a693896c481d0ee2"} 20:21:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:21:53 INFO - Copying logs to upload dir... 20:21:53 INFO - mkdir: /builds/slave/test/build/upload/logs 20:21:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.763104 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-09 20:21:53.635905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:53.640335) ========= 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.14Nor6MInd/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.If4bzDNmLE/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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/Mozilla-Aurora/sha512/21acf9f1d4bf4b0fe9c9c45488c08c8a4e157c77ce35760f6f1f278d3c7d8d0d18f0145fce460e28e36088e13f09d77b821f5d8f8beca1a0c3815e7aacc0ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/056e06048536c39ef439b59e75e09061bd8eda54ec286a3c04d4793be0abe6fb706a8955546e39300090c7b73e098978ce9d8203ed017a52b7ac69f0680efc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d145ffc405c68c409e653c750f5462921c096a3c10e33401486e282581d603190ae6ed696d8cd025908207ba50ceb9594c80075116596d4dbc59d88b42128de6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c57f36480fe4b952e2f15be534846f97f1646e23ce66da3e03af17d299b658706313f53b4f24662f5b2d3145f31e1e30eaffce5d05bc41e9a693896c481d0ee2"} build_url:https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010842 build_url: 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21acf9f1d4bf4b0fe9c9c45488c08c8a4e157c77ce35760f6f1f278d3c7d8d0d18f0145fce460e28e36088e13f09d77b821f5d8f8beca1a0c3815e7aacc0ba91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/056e06048536c39ef439b59e75e09061bd8eda54ec286a3c04d4793be0abe6fb706a8955546e39300090c7b73e098978ce9d8203ed017a52b7ac69f0680efc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d145ffc405c68c409e653c750f5462921c096a3c10e33401486e282581d603190ae6ed696d8cd025908207ba50ceb9594c80075116596d4dbc59d88b42128de6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c57f36480fe4b952e2f15be534846f97f1646e23ce66da3e03af17d299b658706313f53b4f24662f5b2d3145f31e1e30eaffce5d05bc41e9a693896c481d0ee2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:53.676050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:53.676383) ========= 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.14Nor6MInd/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.If4bzDNmLE/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.005152 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:53.724875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 20:21:53.725261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 20:21:53.725616) ========= ========= Total master_lag: 0.19 =========