builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0304 starttime: 1483724743.74 results: success (0) buildid: 20170106071356 builduid: 5b954d9de179456985eca0e3652c1008 revision: d77136af6dd5f7f80bb602decfe929204c30439f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.737249) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.737750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.738051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.764932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.765339) ========= 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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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-01-06 09:45:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-01-06 09:45:44 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.917240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.917570) ========= 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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.024778 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:43.965332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 09:45:43.965684) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d77136af6dd5f7f80bb602decfe929204c30439f --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 d77136af6dd5f7f80bb602decfe929204c30439f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b8pfxkS0aS/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.QvMHoUR8FT/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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-01-06 09:45:44,197 truncating revision to first 12 chars 2017-01-06 09:45:44,197 Setting DEBUG logging. 2017-01-06 09:45:44,197 attempt 1/10 2017-01-06 09:45:44,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d77136af6dd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 09:45:45,278 unpacking tar archive at: mozilla-aurora-d77136af6dd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.354393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 09:45:45.343722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:45.344106) ========= script_repo_revision: d77136af6dd5f7f80bb602decfe929204c30439f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:45.344544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:45.344843) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 09:45:45.365108) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-06 09:45:45.365513) ========= /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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:45:45 INFO - MultiFileLogger online at 20170106 09:45:45 in /builds/slave/test 09:45:45 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 09:45:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:45 INFO - {'append_to_log': False, 09:45:45 INFO - 'base_work_dir': '/builds/slave/test', 09:45:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:45:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:45 INFO - 'branch': 'Mozilla-Aurora', 09:45:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:45 INFO - 'config_files': ('talos/mac_config.py',), 09:45:45 INFO - 'default_actions': ('clobber', 09:45:45 INFO - 'read-buildbot-config', 09:45:45 INFO - 'download-and-extract', 09:45:45 INFO - 'populate-webroot', 09:45:45 INFO - 'create-virtualenv', 09:45:45 INFO - 'install', 09:45:45 INFO - 'run-tests'), 09:45:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:45 INFO - 'download_minidump_stackwalk': True, 09:45:45 INFO - 'download_symbols': 'ondemand', 09:45:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:45 INFO - 'installer_path': 'installer.exe', 09:45:45 INFO - 'log_level': 'info', 09:45:45 INFO - 'log_name': 'talos', 09:45:45 INFO - 'log_to_console': True, 09:45:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:45:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:45:45 INFO - 'opt_config_files': (), 09:45:45 INFO - 'pip_index': False, 09:45:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:45:45 INFO - 'cmd': ('bash', 09:45:45 INFO - '-c', 09:45:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:45:45 INFO - 'enabled': True, 09:45:45 INFO - 'halt_on_failure': False, 09:45:45 INFO - 'name': 'check_screen_resolution'},), 09:45:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:45:45 INFO - 'cmd': ('bash', 09:45:45 INFO - '-c', 09:45:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:45:45 INFO - 'enabled': True, 09:45:45 INFO - 'halt_on_failure': False, 09:45:45 INFO - 'name': 'check_screen_resolution'},), 09:45:45 INFO - 'run_cmd_checks_enabled': True, 09:45:45 INFO - 'sps_profile': False, 09:45:45 INFO - 'sps_profile_interval': 0, 09:45:45 INFO - 'suite': 'dromaeojs', 09:45:45 INFO - 'system_bits': '32', 09:45:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:45 INFO - 'title': 't-yosemite-r7-0304', 09:45:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:45 INFO - 'use_talos_json': True, 09:45:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:45 INFO - 'work_dir': 'build'} 09:45:45 INFO - [mozharness: 2017-01-06 17:45:45.704413Z] Running clobber step. 09:45:45 INFO - Running pre-action listener: _resource_record_pre_action 09:45:45 INFO - Running main action method: clobber 09:45:45 INFO - rmtree: /builds/slave/test/build 09:45:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:48 INFO - Running post-action listener: _resource_record_post_action 09:45:48 INFO - [mozharness: 2017-01-06 17:45:48.041985Z] Finished clobber step (success) 09:45:48 INFO - [mozharness: 2017-01-06 17:45:48.042207Z] Running read-buildbot-config step. 09:45:48 INFO - Running pre-action listener: _resource_record_pre_action 09:45:48 INFO - Running main action method: read_buildbot_config 09:45:48 INFO - Using buildbot properties: 09:45:48 INFO - { 09:45:48 INFO - "project": "", 09:45:48 INFO - "product": "firefox", 09:45:48 INFO - "script_repo_revision": "production", 09:45:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:45:48 INFO - "repository": "", 09:45:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:45:48 INFO - "buildid": "20170106071356", 09:45:48 INFO - "pgo_build": "False", 09:45:48 INFO - "basedir": "/builds/slave/test", 09:45:48 INFO - "buildnumber": 35, 09:45:48 INFO - "slavename": "t-yosemite-r7-0304", 09:45:48 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:45:48 INFO - "platform": "yosemite_r7", 09:45:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:45:48 INFO - "branch": "mozilla-aurora", 09:45:48 INFO - "repo_path": "releases/mozilla-aurora", 09:45:48 INFO - "revision": "d77136af6dd5f7f80bb602decfe929204c30439f", 09:45:48 INFO - "stage_platform": "macosx64", 09:45:48 INFO - "builduid": "5b954d9de179456985eca0e3652c1008", 09:45:48 INFO - "slavebuilddir": "test" 09:45:48 INFO - } 09:45:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 09:45:48 INFO - Running post-action listener: _resource_record_post_action 09:45:48 INFO - [mozharness: 2017-01-06 17:45:48.047903Z] Finished read-buildbot-config step (success) 09:45:48 INFO - [mozharness: 2017-01-06 17:45:48.048128Z] Running download-and-extract step. 09:45:48 INFO - Running pre-action listener: _resource_record_pre_action 09:45:48 INFO - Running main action method: download_and_extract 09:45:48 INFO - mkdir: /builds/slave/test/build/tests 09:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:48 INFO - trying https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 09:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 09:45:49 INFO - Downloaded 1199 bytes. 09:45:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:45:49 INFO - Using the following test package requirements: 09:45:49 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:45:49 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 09:45:49 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 09:45:49 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'jsshell-mac.zip'], 09:45:49 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 09:45:49 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:45:49 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 09:45:49 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 09:45:49 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 09:45:49 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:45:49 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 09:45:49 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:45:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:45:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:45:49 INFO - Fetch https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:45:49 INFO - Http code: 200 09:45:49 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:45:49 INFO - x-amz-cf-id: W-jGKdk_oqYHf6TlOA_86pa3LIBOjX_vRe4kzEmkzazGZ_OcUmTbnA== 09:45:49 INFO - x-amz-version-id: 9gZaTgoWMGXPVo2SUzMiOqXuJrELp_UO 09:45:50 INFO - Expected file size: 16269516 09:45:50 INFO - Obtained file size: 16269516 09:45:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:45:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:45:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:45:56 INFO - Fetch https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:45:57 INFO - Http code: 200 09:45:57 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 09:45:57 INFO - x-amz-cf-id: Kkr1mWpmfbJhiuifKMWZZxSd3c3M8C1DioGp-aA33HNjXfvcu9tEzg== 09:45:57 INFO - x-amz-version-id: 9gZaTgoWMGXPVo2SUzMiOqXuJrELp_UO 09:45:57 INFO - Expected file size: 16269516 09:45:57 INFO - Obtained file size: 16269516 09:46:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 09:46:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:46:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 09:46:04 INFO - Http code: 200 09:46:04 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 09:46:04 INFO - x-amz-cf-id: 1Pk-_nkdNvTHFBHDHv4TsmuRE9PUYLfKZl_Q7Rs2ax692eIc8CpDWw== 09:46:04 INFO - x-amz-version-id: FCGOSxVIqOxSFJLpOM.0FVsiVvJONxCu 09:46:05 INFO - Expected file size: 14409038 09:46:05 INFO - Obtained file size: 14409038 09:46:05 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')]} 09:46:05 INFO - trying https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:46:05 INFO - Downloading https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 09:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 09:46:08 INFO - Downloaded 109867650 bytes. 09:46:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:46:08 INFO - mkdir: /builds/slave/test/properties 09:46:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:46:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:46:08 INFO - Contents: 09:46:08 INFO - build_url:https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:46:09 INFO - Running post-action listener: _resource_record_post_action 09:46:09 INFO - Running post-action listener: set_extra_try_arguments 09:46:09 INFO - [mozharness: 2017-01-06 17:46:09.516118Z] Finished download-and-extract step (success) 09:46:09 INFO - [mozharness: 2017-01-06 17:46:09.516248Z] Running populate-webroot step. 09:46:09 INFO - Running pre-action listener: _resource_record_pre_action 09:46:09 INFO - Running main action method: populate_webroot 09:46:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:46:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:46:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:46:09 INFO - '--tppagecycles', 09:46:09 INFO - '7'], 09:46:09 INFO - 'tests': ['tsvgm']}}, 09:46:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:46:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:46:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:46:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:46:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['damp', 'tps']}, 09:46:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'tests': ['damp', 'tps']}, 09:46:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['dromaeo_dom']}, 09:46:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:46:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['basic_compositor_video']}, 09:46:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:46:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['a11yr', 09:46:09 INFO - 'ts_paint', 09:46:09 INFO - 'tpaint', 09:46:09 INFO - 'sessionrestore', 09:46:09 INFO - 'sessionrestore_no_auto_restore', 09:46:09 INFO - 'tabpaint']}, 09:46:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:46:09 INFO - 'ts_paint', 09:46:09 INFO - 'tpaint', 09:46:09 INFO - 'sessionrestore', 09:46:09 INFO - 'sessionrestore_no_auto_restore', 09:46:09 INFO - 'tabpaint']}, 09:46:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:46:09 INFO - 'ts_paint', 09:46:09 INFO - 'tpaint', 09:46:09 INFO - 'sessionrestore', 09:46:09 INFO - 'sessionrestore_no_auto_restore', 09:46:09 INFO - 'tabpaint']}, 09:46:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:46:09 INFO - 'ts_paint', 09:46:09 INFO - 'tpaint', 09:46:09 INFO - 'sessionrestore', 09:46:09 INFO - 'sessionrestore_no_auto_restore', 09:46:09 INFO - 'tabpaint']}, 09:46:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['a11yr', 09:46:09 INFO - 'ts_paint', 09:46:09 INFO - 'tpaint', 09:46:09 INFO - 'sessionrestore', 09:46:09 INFO - 'sessionrestore_no_auto_restore', 09:46:09 INFO - 'tabpaint']}, 09:46:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['a11yr', 09:46:09 INFO - 'ts_paint', 09:46:09 INFO - 'tpaint', 09:46:09 INFO - 'sessionrestore', 09:46:09 INFO - 'sessionrestore_no_auto_restore', 09:46:09 INFO - 'tabpaint']}, 09:46:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['tsvgx', 09:46:09 INFO - 'tsvgr_opacity', 09:46:09 INFO - 'tart', 09:46:09 INFO - 'tscrollx', 09:46:09 INFO - 'cart']}, 09:46:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:46:09 INFO - 'tsvgr_opacity', 09:46:09 INFO - 'tart', 09:46:09 INFO - 'tscrollx', 09:46:09 INFO - 'cart']}, 09:46:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'talos_options': ['--disable-e10s'], 09:46:09 INFO - 'tests': ['tp5o']}, 09:46:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'tests': ['tp5o']}, 09:46:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'talos_options': ['--disable-e10s', 09:46:09 INFO - '--xperf_path', 09:46:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:09 INFO - 'tests': ['tp5n']}, 09:46:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:09 INFO - 'talos_options': ['--xperf_path', 09:46:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:09 INFO - 'tests': ['tp5n']}}, 09:46:09 INFO - 'talos.zip': {'path': '', 09:46:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:46:09 INFO - Running post-action listener: _resource_record_post_action 09:46:09 INFO - [mozharness: 2017-01-06 17:46:09.534904Z] Finished populate-webroot step (success) 09:46:09 INFO - [mozharness: 2017-01-06 17:46:09.535015Z] Running create-virtualenv step. 09:46:09 INFO - Running pre-action listener: _resource_record_pre_action 09:46:09 INFO - Running main action method: create_virtualenv 09:46:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:46:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:46:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:46:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:46:09 INFO - Using real prefix '/tools/python27' 09:46:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:46:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:13 INFO - Installing pip.................done. 09:46:13 INFO - Return code: 0 09:46:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:46:13 INFO - Reading from file tmpfile_stdout 09:46:13 INFO - Output received: 09:46:13 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) 09:46:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:13 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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:13 INFO - 'HOME': '/Users/cltbld', 09:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:13 INFO - 'LOGNAME': 'cltbld', 09:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:13 INFO - 'MOZ_NO_REMOTE': '1', 09:46:13 INFO - 'NO_EM_RESTART': '1', 09:46:13 INFO - 'PAGER': '/bin/cat', 09:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:13 INFO - 'PWD': '/builds/slave/test', 09:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:13 INFO - 'SHELL': '/bin/bash', 09:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:13 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:13 INFO - 'USER': 'cltbld', 09:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:13 INFO - 'XPC_FLAGS': '0x0', 09:46:13 INFO - 'XPC_SERVICE_NAME': '0', 09:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:46:13 INFO - Cleaning up... 09:46:13 INFO - Return code: 0 09:46:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:13 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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:13 INFO - 'HOME': '/Users/cltbld', 09:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:13 INFO - 'LOGNAME': 'cltbld', 09:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:13 INFO - 'MOZ_NO_REMOTE': '1', 09:46:13 INFO - 'NO_EM_RESTART': '1', 09:46:13 INFO - 'PAGER': '/bin/cat', 09:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:13 INFO - 'PWD': '/builds/slave/test', 09:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:13 INFO - 'SHELL': '/bin/bash', 09:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:13 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:13 INFO - 'USER': 'cltbld', 09:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:13 INFO - 'XPC_FLAGS': '0x0', 09:46:13 INFO - 'XPC_SERVICE_NAME': '0', 09:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:14 INFO - Downloading/unpacking psutil>=3.1.1 09:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:17 INFO - Installing collected packages: psutil 09:46:17 INFO - Running setup.py install for psutil 09:46:17 INFO - building 'psutil._psutil_osx' extension 09:46:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:46:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:46:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:46:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:46:18 INFO - building 'psutil._psutil_posix' extension 09:46:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:46:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:46:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:46:18 INFO - ^ 09:46:18 INFO - 1 warning generated. 09:46:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:46:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:18 INFO - Successfully installed psutil 09:46:18 INFO - Cleaning up... 09:46:18 INFO - Return code: 0 09:46:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:18 INFO - 'HOME': '/Users/cltbld', 09:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:18 INFO - 'LOGNAME': 'cltbld', 09:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:18 INFO - 'MOZ_NO_REMOTE': '1', 09:46:18 INFO - 'NO_EM_RESTART': '1', 09:46:18 INFO - 'PAGER': '/bin/cat', 09:46:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:18 INFO - 'PWD': '/builds/slave/test', 09:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:18 INFO - 'SHELL': '/bin/bash', 09:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:18 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:18 INFO - 'USER': 'cltbld', 09:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:18 INFO - 'XPC_FLAGS': '0x0', 09:46:18 INFO - 'XPC_SERVICE_NAME': '0', 09:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:46:21 INFO - Installing collected packages: mozsystemmonitor 09:46:21 INFO - Running setup.py install for mozsystemmonitor 09:46:21 INFO - Successfully installed mozsystemmonitor 09:46:21 INFO - Cleaning up... 09:46:21 INFO - Return code: 0 09:46:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:46:21 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')]} 09:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:21 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')]} 09:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:21 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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:21 INFO - 'HOME': '/Users/cltbld', 09:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:21 INFO - 'LOGNAME': 'cltbld', 09:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:21 INFO - 'MOZ_NO_REMOTE': '1', 09:46:21 INFO - 'NO_EM_RESTART': '1', 09:46:21 INFO - 'PAGER': '/bin/cat', 09:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:21 INFO - 'PWD': '/builds/slave/test', 09:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:21 INFO - 'SHELL': '/bin/bash', 09:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:21 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:21 INFO - 'USER': 'cltbld', 09:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:21 INFO - 'XPC_FLAGS': '0x0', 09:46:21 INFO - 'XPC_SERVICE_NAME': '0', 09:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:46:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:46:25 INFO - warning: no files found matching '*.txt' 09:46:25 INFO - no previously-included directories found matching 'build' 09:46:25 INFO - no previously-included directories found matching 'dist' 09:46:25 INFO - no previously-included directories found matching '.git*' 09:46:25 INFO - Installing collected packages: jsonschema, functools32 09:46:25 INFO - Running setup.py install for functools32 09:46:25 INFO - warning: no files found matching '*.txt' 09:46:25 INFO - no previously-included directories found matching 'build' 09:46:25 INFO - no previously-included directories found matching 'dist' 09:46:25 INFO - no previously-included directories found matching '.git*' 09:46:25 INFO - Successfully installed jsonschema functools32 09:46:25 INFO - Cleaning up... 09:46:25 INFO - Return code: 0 09:46:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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', '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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:46: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 functools32==3.2.3-2 09:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:25 INFO - 'HOME': '/Users/cltbld', 09:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:25 INFO - 'LOGNAME': 'cltbld', 09:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:25 INFO - 'MOZ_NO_REMOTE': '1', 09:46:25 INFO - 'NO_EM_RESTART': '1', 09:46:25 INFO - 'PAGER': '/bin/cat', 09:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:25 INFO - 'PWD': '/builds/slave/test', 09:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:25 INFO - 'SHELL': '/bin/bash', 09:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:25 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:25 INFO - 'USER': 'cltbld', 09:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:25 INFO - 'XPC_FLAGS': '0x0', 09:46:25 INFO - 'XPC_SERVICE_NAME': '0', 09:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:46:25 INFO - Cleaning up... 09:46:25 INFO - Return code: 0 09:46:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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', '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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:46: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 blobuploader==1.2.4 09:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:25 INFO - 'HOME': '/Users/cltbld', 09:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:25 INFO - 'LOGNAME': 'cltbld', 09:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:25 INFO - 'MOZ_NO_REMOTE': '1', 09:46:25 INFO - 'NO_EM_RESTART': '1', 09:46:25 INFO - 'PAGER': '/bin/cat', 09:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:25 INFO - 'PWD': '/builds/slave/test', 09:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:25 INFO - 'SHELL': '/bin/bash', 09:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:25 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:25 INFO - 'USER': 'cltbld', 09:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:25 INFO - 'XPC_FLAGS': '0x0', 09:46:25 INFO - 'XPC_SERVICE_NAME': '0', 09:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:26 INFO - Downloading/unpacking blobuploader==1.2.4 09:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:28 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:46:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:29 INFO - Downloading docopt-0.6.1.tar.gz 09:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:30 INFO - Running setup.py install for blobuploader 09:46:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:30 INFO - Running setup.py install for requests 09:46:30 INFO - Running setup.py install for docopt 09:46:30 INFO - Successfully installed blobuploader requests docopt 09:46:30 INFO - Cleaning up... 09:46:30 INFO - Return code: 0 09:46:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:30 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')]} 09:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:30 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')]} 09:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:30 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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:30 INFO - 'HOME': '/Users/cltbld', 09:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:30 INFO - 'LOGNAME': 'cltbld', 09:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:30 INFO - 'MOZ_NO_REMOTE': '1', 09:46:30 INFO - 'NO_EM_RESTART': '1', 09:46:30 INFO - 'PAGER': '/bin/cat', 09:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:30 INFO - 'PWD': '/builds/slave/test', 09:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:30 INFO - 'SHELL': '/bin/bash', 09:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:30 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:30 INFO - 'USER': 'cltbld', 09:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:30 INFO - 'XPC_FLAGS': '0x0', 09:46:30 INFO - 'XPC_SERVICE_NAME': '0', 09:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-uulGff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-nzhiJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-BBpYBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-B8XnvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-sJfrtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-niFKVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-W9ea8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:31 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Rjpln5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-wJZBxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-qLNQTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ZWJ24o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-y6kUPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-TIkXed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-ynFeM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-Bk0kUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-emwDie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:32 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-fLmb5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:33 INFO - Running setup.py install for manifestparser 09:46:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:33 INFO - Running setup.py install for mozcrash 09:46:33 INFO - Running setup.py install for mozdebug 09:46:33 INFO - Running setup.py install for mozdevice 09:46:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:46:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:46:33 INFO - Running setup.py install for mozfile 09:46:33 INFO - Running setup.py install for mozhttpd 09:46:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:46:33 INFO - Running setup.py install for mozinfo 09:46:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Running setup.py install for mozInstall 09:46:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Running setup.py install for mozleak 09:46:34 INFO - Running setup.py install for mozlog 09:46:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Running setup.py install for moznetwork 09:46:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Running setup.py install for mozprocess 09:46:34 INFO - Running setup.py install for mozprofile 09:46:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:46:34 INFO - Running setup.py install for mozrunner 09:46:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:46:35 INFO - Running setup.py install for mozscreenshot 09:46:35 INFO - Running setup.py install for moztest 09:46:35 INFO - Running setup.py install for mozversion 09:46:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:46:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:35 INFO - Cleaning up... 09:46:35 INFO - Return code: 0 09:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:35 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')]} 09:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:35 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')]} 09:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:35 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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:35 INFO - 'HOME': '/Users/cltbld', 09:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:35 INFO - 'LOGNAME': 'cltbld', 09:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:35 INFO - 'MOZ_NO_REMOTE': '1', 09:46:35 INFO - 'NO_EM_RESTART': '1', 09:46:35 INFO - 'PAGER': '/bin/cat', 09:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:35 INFO - 'PWD': '/builds/slave/test', 09:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:35 INFO - 'SHELL': '/bin/bash', 09:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:35 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:35 INFO - 'USER': 'cltbld', 09:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:35 INFO - 'XPC_FLAGS': '0x0', 09:46:35 INFO - 'XPC_SERVICE_NAME': '0', 09:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:35 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-0ZOjfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:35 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-vXTXzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:36 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)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-sldqlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-BLr92X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-TE6dVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-pzJygB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-onXNyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-2tTCJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-EVgBsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-JqMD1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:36 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)) 09:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:36 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-A9hVvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:37 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-HzN3zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:37 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-1uU9Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:37 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-qNDuG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:37 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)) 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:37 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-DgalSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:37 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-9gCv1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:37 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)) 09:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:37 INFO - Running setup.py (path:/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/pip-9c7xy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:46:37 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)) 09:46:37 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)) 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:40 INFO - Downloading blessings-1.6.tar.gz 09:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:46:40 INFO - Installing collected packages: blessings 09:46:40 INFO - Running setup.py install for blessings 09:46:40 INFO - Successfully installed blessings 09:46:40 INFO - Cleaning up... 09:46:41 INFO - Return code: 0 09:46:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:46:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:41 INFO - Reading from file tmpfile_stdout 09:46:41 INFO - Current package versions: 09:46:41 INFO - blessings == 1.6 09:46:41 INFO - blobuploader == 1.2.4 09:46:41 INFO - docopt == 0.6.1 09:46:41 INFO - functools32 == 3.2.3-2 09:46:41 INFO - jsonschema == 2.5.1 09:46:41 INFO - manifestparser == 1.1 09:46:41 INFO - mozInstall == 1.12 09:46:41 INFO - mozcrash == 1.0 09:46:41 INFO - mozdebug == 0.1 09:46:41 INFO - mozdevice == 0.48 09:46:41 INFO - mozfile == 1.2 09:46:41 INFO - mozhttpd == 0.7 09:46:41 INFO - mozinfo == 0.9 09:46:41 INFO - mozleak == 0.1 09:46:41 INFO - mozlog == 3.4 09:46:41 INFO - moznetwork == 0.27 09:46:41 INFO - mozprocess == 0.23 09:46:41 INFO - mozprofile == 0.28 09:46:41 INFO - mozrunner == 6.13 09:46:41 INFO - mozscreenshot == 0.1 09:46:41 INFO - mozsystemmonitor == 0.3 09:46:41 INFO - moztest == 0.8 09:46:41 INFO - mozversion == 1.4 09:46:41 INFO - psutil == 3.1.1 09:46:41 INFO - requests == 1.2.3 09:46:41 INFO - wsgiref == 0.1.2 09:46:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:41 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')]} 09:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:41 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')]} 09:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:41 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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:41 INFO - 'HOME': '/Users/cltbld', 09:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:41 INFO - 'LOGNAME': 'cltbld', 09:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:41 INFO - 'MOZ_NO_REMOTE': '1', 09:46:41 INFO - 'NO_EM_RESTART': '1', 09:46:41 INFO - 'PAGER': '/bin/cat', 09:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:41 INFO - 'PWD': '/builds/slave/test', 09:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:41 INFO - 'SHELL': '/bin/bash', 09:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:41 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:41 INFO - 'USER': 'cltbld', 09:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:41 INFO - 'XPC_FLAGS': '0x0', 09:46:41 INFO - 'XPC_SERVICE_NAME': '0', 09:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:46:41 INFO - Cleaning up... 09:46:41 INFO - Return code: 0 09:46:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:46:41 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')]} 09:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:41 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')]} 09:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:41 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 0x101df3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5035dc620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, '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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:41 INFO - 'HOME': '/Users/cltbld', 09:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:41 INFO - 'LOGNAME': 'cltbld', 09:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:41 INFO - 'MOZ_NO_REMOTE': '1', 09:46:41 INFO - 'NO_EM_RESTART': '1', 09:46:41 INFO - 'PAGER': '/bin/cat', 09:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:41 INFO - 'PWD': '/builds/slave/test', 09:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:41 INFO - 'SHELL': '/bin/bash', 09:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:46:41 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:41 INFO - 'USER': 'cltbld', 09:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:41 INFO - 'XPC_FLAGS': '0x0', 09:46:41 INFO - 'XPC_SERVICE_NAME': '0', 09:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:46:42 INFO - Cleaning up... 09:46:42 INFO - Return code: 0 09:46:42 INFO - Running post-action listener: _resource_record_post_action 09:46:42 INFO - Running post-action listener: _start_resource_monitoring 09:46:42 INFO - Starting resource monitoring. 09:46:42 INFO - [mozharness: 2017-01-06 17:46:42.273422Z] Finished create-virtualenv step (success) 09:46:42 INFO - [mozharness: 2017-01-06 17:46:42.274411Z] Running install step. 09:46:42 INFO - Running pre-action listener: _resource_record_pre_action 09:46:42 INFO - Running main action method: install 09:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:42 INFO - Reading from file tmpfile_stdout 09:46:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:46:42 INFO - Reading from file tmpfile_stdout 09:46:42 INFO - Output received: 09:46:42 INFO - Usage: mozinstall [options] installer 09:46:42 INFO - Options: 09:46:42 INFO - -h, --help show this help message and exit 09:46:42 INFO - -d DEST, --destination=DEST 09:46:42 INFO - Directory to install application into. [default: 09:46:42 INFO - "/builds/slave/test"] 09:46:42 INFO - --app=APP Application being installed. [default: firefox] 09:46:42 INFO - mkdir: /builds/slave/test/build/application 09:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:47:14 INFO - Reading from file tmpfile_stdout 09:47:14 INFO - Output received: 09:47:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:47:14 INFO - Running post-action listener: _resource_record_post_action 09:47:14 INFO - [mozharness: 2017-01-06 17:47:14.390495Z] Finished install step (success) 09:47:14 INFO - [mozharness: 2017-01-06 17:47:14.390625Z] Running run-tests step. 09:47:14 INFO - Running pre-action listener: _resource_record_pre_action 09:47:14 INFO - Running main action method: run_tests 09:47:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:47:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:47:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:47:14 INFO - 2017-01-06 09:47:14.405 screenresolution[1627:7401] starting screenresolution argv=screenresolution get 09:47:14 INFO - 2017-01-06 09:47:14.407 screenresolution[1627:7401] Display 0: 1600x1200x32@60 09:47:14 INFO - 2017-01-06 09:47:14.413 screenresolution[1628:7403] starting screenresolution argv=screenresolution list 09:47:14 INFO - Available Modes on Display 0 09:47:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:47:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:47:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:47:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:47:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:47:14 INFO - Intel Iris: 09:47:14 INFO - Chipset Model: Intel Iris 09:47:14 INFO - Type: GPU 09:47:14 INFO - Bus: Built-In 09:47:14 INFO - VRAM (Dynamic, Max): 1536 MB 09:47:14 INFO - Vendor: Intel (0x8086) 09:47:14 INFO - Device ID: 0x0a2e 09:47:14 INFO - Revision ID: 0x0009 09:47:14 INFO - Displays: 09:47:14 INFO - Display: 09:47:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:47:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:47:14 INFO - Display Serial Number: 1600x1200 60 09:47:14 INFO - Main Display: Yes 09:47:14 INFO - Mirror: Off 09:47:14 INFO - Online: Yes 09:47:14 INFO - Rotation: Supported 09:47:14 INFO - Return code: 0 09:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:14 INFO - Python 2.7.3 09:47:14 INFO - Return code: 0 09:47:14 INFO - grabbing minidump binary from tooltool 09:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:14 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 0x101c07d30>, '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 0x101a6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:47:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:47:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:47:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:14 INFO - Return code: 0 09:47:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:47:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:47:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:14 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/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 09:47:14 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/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0304 --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 09:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b8pfxkS0aS/Render', 09:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:14 INFO - 'HOME': '/Users/cltbld', 09:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:14 INFO - 'LOGNAME': 'cltbld', 09:47:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:14 INFO - 'MOZ_NO_REMOTE': '1', 09:47:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:14 INFO - 'NO_EM_RESTART': '1', 09:47:14 INFO - 'PAGER': '/bin/cat', 09:47:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:14 INFO - 'PWD': '/builds/slave/test', 09:47:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:14 INFO - 'SHELL': '/bin/bash', 09:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvMHoUR8FT/Listeners', 09:47:14 INFO - 'TMPDIR': '/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/', 09:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:14 INFO - 'USER': 'cltbld', 09:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:14 INFO - 'XPC_FLAGS': '0x0', 09:47:14 INFO - 'XPC_SERVICE_NAME': '0', 09:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:14 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/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0304', '--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 09:47:14 INFO - mozversion application_buildid: 20170106071356 09:47:14 INFO - mozversion application_changeset: d77136af6dd5f7f80bb602decfe929204c30439f 09:47:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:47:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:14 INFO - mozversion application_name: Firefox 09:47:14 INFO - mozversion application_remotingname: firefox-dev 09:47:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:47:14 INFO - mozversion application_vendor: Mozilla 09:47:14 INFO - mozversion application_version: 52.0a2 09:47:14 INFO - mozversion platform_buildid: 20170106071356 09:47:14 INFO - mozversion platform_changeset: d77136af6dd5f7f80bb602decfe929204c30439f 09:47:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:47:14 INFO - mozversion platform_version: 52.0a2 09:47:14 INFO - using testdate: 1483724834 09:47:14 INFO - actual date: 1483724834 09:47:14 INFO - starting webserver on 'localhost:49249' 09:47:14 INFO - SUITE-START | Running 2 tests 09:47:14 INFO - TEST-START | dromaeo_css 09:47:14 INFO - operating with platform_type : mac_ 09:47:14 INFO - Initialising browser for dromaeo_css test... 09:47:15 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpf7SiEx/profile http://localhost:49249/getInfo.html) 09:47:17 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 09:47:17 INFO - PROCESS | 1638 | colorDepth:24 09:47:17 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 09:47:17 INFO - PROCESS | 1638 | __metrics 09:47:17 INFO - PROCESS | 1638 | 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" 09:47:17 INFO - PROCESS | 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:18 INFO - TEST-INFO | 1638: exit 0 09:47:18 INFO - Browser initialized. 09:47:18 INFO - Running cycle 1/1 for dromaeo_css test... 09:47:18 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpf7SiEx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:30 INFO - PROCESS | 1640 | RSS: Main: 222662656 09:47:30 INFO - PROCESS | 1640 | 09:50:34 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 09:50:37 INFO - PROCESS | 1640 | RSS: Main: 341012480 09:50:37 INFO - PROCESS | 1640 | 09:53:40 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 09:53:40 INFO - PROCESS | 1640 | RSS: Main: 345784320 09:53:40 INFO - PROCESS | 1640 | 09:56:43 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 09:56:43 INFO - PROCESS | 1640 | RSS: Main: 313720832 09:56:43 INFO - PROCESS | 1640 | 09:59:45 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 09:59:46 INFO - PROCESS | 1640 | RSS: Main: 313794560 09:59:46 INFO - PROCESS | 1640 | 10:02:49 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 10:02:50 INFO - PROCESS | 1640 | RSS: Main: 306696192 10:02:50 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 10:05:53 INFO - PROCESS | 1640 | RSS: Main: 492843008 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | __start_tp_report 10:05:53 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 10:05:53 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 10:05:53 INFO - PROCESS | 1640 | |i|pagename|runs| 10:05:53 INFO - PROCESS | 1640 | |0;dojo.html;3322.7009569138777;3349.8492567834446;3354.245294808667;3369.376665316918;3410.6248312685602;5675.404082571327;5737.340205876326;5756.856078598032;5763.769449222036;5784.971075144624;5579.6652200867975;5634.9718251408685;5645.802396916109;5659.264295641561;5660.462256085676;5095.235714642796;5120.0527902338;5127.974360128203;5159;5162.1482455395;5201.55786758126;5203.765830537616;5208.401033881095;5246.475352464761;5266.236395722618;5102.770375333119;5113.284140220372;5170.172772356424;5182.922256166142;5191.247269145972;5086;5104.9744751276;5146.691697789149;5167.870803229912;5194.091034069061;5007.6244281678655;5096.464871188509;5102.515261050195;5109.284700141983;5132;5629;5662.745176467069;5679.772809087632;5690.971545142248;5725.541956643458;6136.938630613681;6152.815415537496;6192.9380706192815;6230.719617617173;6238.781642642486;6269.358324453009;6274.247090349141;6283.371662833726;6294.118823364733;6295.842603934892;5680.460356266148;5733.799317023884;5735.053716136874;5741.684207368551;5869.178315035899;6258.311585725566;6279.058141278753;6285.622862628257;6294.339094395114;6298.716557754912;6164.5684802064325;6166.260048794084;6173.41352571505;6186.443220110212;6189.597676151036;6108.349900596421;6121.510279177655;6162.630242185483;6169.074638804125;6271.247450305992;6196.907046394308;6250.937490625036;6262.812115636538;6270.843228919313;6275.968620156961;6205.720742566596;6236.345183755731;6274.435300822948;6274.560780745304;6283.371662833772;4854.004928989549;4858.125537403231;4877.3903262092235;4917.803287868517;4936.6297527685565;3787.223619158066;4390.363397307373;4395.450568678915;4440.644748420119;4485.551444855489;5856.326522449973;5861.706914654335;5867.413258674099;5870.178175055496;5887.970560147171;4836.226203807374;6147.508199344042;6287.748490060347;6326.778562750282;6332.68336583169;5644.8024319148635;5768.3654797972185;5770.711464426762;5781.53747700183;5782.855428614318;5338.466153384708;5378.327709036371;5385.192221166856;5386.353637563439;5404.9730551195935;6242.843928901813;6266.404691554295;6281.874362512815;6284.120223168668;6294.8111556653375;6118.174046503843;6295;6304.401081897213;6316.242050953915;6319.24169099711;6336.493080553637;6337.556371053982;6353.3011368748475;6354.714037868214;6368.42684158428;6071.757129714939;6123.2652081750475;6133.6319820810895;6233.314335423191;6241.188645476059;5365.678059316453;6142.570020098729;6204.5036397089025;6225.968870155621;6227.875442491034;6166.475849552839;6173.104899789416;6182.629042257479;6193.907091393543;6201.286852012076;6145.201123853871;6167.506599472121;6169.136320915165;6173.382661733791;6175.5677102602385;5845.590808643354;5899.38056504078;5964.522838172849;5972.25346831646;6075.848103797441;6142.191841058572;6184.783532576518;6193.783217587363;6203.96898015507;6208.658523781055;5963.194968679346;6025.909611355745;6046.244219472566;6048.322683706211;6071.089336599545 10:05:53 INFO - PROCESS | 1640 | |1;ext.html;486.8077109541729;496.1639637211299;505.4061477763629;508.14124130219926;541.7074779619006;30145.397092058145;38938.610613893856;38954.220915581674;38960.61039389609;39055.60944390555;39436.40845387321;39904.002399940015;39945.800270998676;39991.600083999154;40036.59963400365;8449.704260350889;9288.256939444846;9488.193503552171;9500.857487137699;9501.80996380072;8418.200270974248;11174.66476005717;11456.083513318914;11483.885161148406;11629.883701163008;11345.149113816455;11441.885581144206;11454.71363215922;11460.598879039235;11469.139814513903;8418.915810841874;8661.653533858638;11392.316461012324;11457.770844583103;11478.885211147948;10916.781664366668;11300.830487542693;11302.039326657245;11433.542658293658;11435.885641143648;38934;39182;39291;39375.40936885949;39412.802935985426;3196.1578209013364;3268.1829542614346;3273.851061708684;3318.6515415881468;3330.134165117087;28070.719292807014;28890.422191556052;29432.411351772844;30262.394752105054;30352;3038.468268053082;3135.435621588113;3279.262166012652;3314.221158027886;3318.1206980150278;461707;463151;464511;464706;465318;55406.445935540934;55819;55890;55914.44085559174;55924.720376397854;58280.708596456745;58415.415845841846;58440.707796460745;58442.41557584455;58462.415375845696;15601.375944962074;15817.288222030036;15831.920840395955;15852.286647100907;15858.52424427269;11078;11312.377819220023;11369.715757105972;12311.015118790476;12374.690632734253;14529.491467798576;14768.409263629335;14945.551633451014;15075.246237688072;15247.390104395921;6648.515416164486;6671.599704017677;6674.666266686743;6719;6744.325567443217;802.9839403211903;989.5547003848297;998.2114129837493;1071.983920241197;1076.8761592416815;27998;28650.283742906176;28774.856125719656;29300.853495732386;29487.115386538437;1027.50679673757;1028.4035259549444;1118.6588090632436;1149.4827327702567;1171.988280117188;14709.632259193391;14812.555623331318;14919.487676074035;15016.942929861754;15055.849441505663;617591;627735;629782;634687;638984;55026.724866376215;55161.44838551563;55182.72408637931;55252.447475525536;55397.72301138468;1336.9665758356118;1340.8726171013739;1357.8574249703836;1375.42232262448;1376.0161484538603;28087.438251234453;28383.006594769085;28710.712892870804;29460.11619651414;29480.199381058766;52209.738951305;53981.19028214501;54057.18914216368;56034.439655602924;56142;510676;513465;517139;518632.4068379785;519733;22541.21105761356;25203;25501.489970200862;25536.489270214865;25565.616515752652;36012.27975440424;37466.66858847786;39108;43997;46929.2960605598;36882;36931.07672308214;37540.62459375371;38631;38767.836964891096;36509.63490365062;37048.44427333646;37100.443493347084;37910;38149;36190.45714314235;36758.26483470369;36865.815670921475;37071;38522;30687.693123068482;32981.01056968295;33489.33021339608;33714.831425843695;33822.83088584541;24502;24915.750842491343;25032;25205.873970630764;25310.114146004802 10:05:53 INFO - PROCESS | 1640 | |2;jquery.html;352.81829857623313;373.1231605726543;373.2832960715428;382.2469734622794;400.94386785849986;13063.346832658364;13967.952403569734;15119.697606047872;17952.281908723635;20235.797642023575;18583.814161858376;19317.323893663724;19351.129199186034;19583.804161958375;19660.90169549154;5600.52395546378;5927.1998280232265;5927.288725352963;5933.910991335133;5936.168936348915;5047.64666473347;5798.507126894198;5823.126531020339;5824.650520968734;5857.414258574151;5803.390643982384;5808.2158908547435;5808.4481974212595;5810.244668193129;5810.912836307438;5545.972270138644;5749.8275051748515;5756.971215143939;5787.652740835563;5805.680687562182;5022.723750193738;5097.337346145015;5104.770285337168;5107.8212262571005;5108.923366149511;19023;24900.003999839984;25313.873430632728;25493.61759573608;25983.61024584633;2558.6801649793774;2698.5682290833374;2727.595288426462;2778.8888444462195;2824.477471667748;9903.504824758806;15242.23788810555;15272.465463708828;15290.464833730877;16069.758953615705;1684.7978242610843;1821.1440622907212;1868.7383766272596;1889.9433017009512;1903.1626084522766;126011;127960;129054.70945290521;131769.6823031767;132203;7547.735829246059;10014.098731114234;10138.594456221816;10170.288079834341;10373.481325933673;12513.812292815615;12561.623151305475;12584.874151258371;12593.93703031479;12621.558245461549;7002.684879180449;7848.568328741974;7875.803104922308;7944.721934732257;8021.358291336679;8271.255586997078;8277.420580559423;8297.12880147588;8396.454230475121;8412.990441147102;3907.667848232932;3981.0843505993785;3993.221321842213;4040.313146765057;4046.6964977626794;1914.4448110048208;1969.2418418908824;1969.3993332033867;1972.1716878910604;1975.9703604445658;840.6427268411023;892.8928528576612;922.285228947571;928.2388441478058;995.785906030207;19994.300199492947;20933.371998839753;20965.26621568238;20972.79027209739;20998.685019724715;914.3599480363772;922.7416323429451;925.9768505787409;931.1526510875207;1005.0351662404028;7931.405144614062;8313;10237.795244095076;10814.026737593655;11058.889411105785;489853;491181;491273;606504.9674751598;623269;119843;123811.38094309471;144613;144870.2756486211;149592.2520387391;956.268454632207;995.7510622344414;1006.0492834271544;1007.6523599358356;1008.7831116309882;14871.628209294855;18794.342198023005;18998.43004709861;19295.51761205981;19421.601219786196;53703;55001.72499137479;56848;57470;57739.711301443225;80698.5965070171;81896.59051704704;82596;83228;83496.58251708702;6562.654655795646;6825.761098361533;6831.4629208427705;6874.175098988154;7185.568865868065;8836.028036915806;11661.6501504955;12086.697832554257;12126.333051682243;12265.754684906431;10336.586536538454;10427.113695335982;10519.263651544625;10705.89294107049;10777.51501182433;10335;10344.637937672145;10427.582896684351;10723.356598604109;10805.891941080488;10546.630867919586;10590.558426636399;10624.468776561296;10737.946310268399;10946.45267736594;7092.6099064551945;7169.318914703095;7321.74373896911;7412.555246685216;7482.326590606872;9692.466914319499;9790.314677972474;10285.177185824967;10438.478076096317;10712.196585256293 10:05:53 INFO - PROCESS | 1640 | |3;mootools.html;1306.0922658752158;1451.7604595241783;1477.4976507987285;1621.4487074394704;1810.3120814090635;5814.505767009804;7823.491473054255;8104.716334928286;8296.419250652456;8308;8242.423030387876;8339.666413343459;8347.332213422927;8353.039400468948;8355.83288334233;2305.1931823861596;2336.8247381446376;2341.94145146371;2343.8593684378907;2346.1319311854554;2308.411355104446;2328.976710232893;2370.8340416170877;2373.2405630198346;2376.025829409942;2222.3666255117296;2228.799408053275;2254.1434254983083;2254.1434254983083;2259.8531095478743;2184.8907554622365;2296.8047715944167;2324.244620498345;2324.697789287382;2325.837191396603;2065.5765568058514;2295.473510115771;2317.9072837086496;2339.7894189523026;2343.215022967308;8156.673733050671;8285.62714677841;8373.120822313691;8376.036755773102;8387.538685372301;4601.44782626087;5038.294638750578;5161.406438259573;5206.869828254324;5232.607554433433;3421.127612458832;3550.6626870447267;3568.8215589220695;3627.1838836261895;3637.890863274106;1068.6740544134036;1083.2471432354516;1090.7763908398758;1103.2167161315476;1107.1585594947899;9294.488803115826;10867.076298514557;10984.890151098467;10999.34003959773;11001.284916480483;3669.4679271506016;4196.349565817303;4403.106664134389;4479.932801007987;4481.484629267676;8684.2184203422;8689.391742577958;8691.217790398894;8691.782705432415;8704.477731336141;5082.161443361804;5092.439831618519;5094.6688465249645;5106.897862042812;5115.846524604268;4060.918781624351;4257.595528424795;4412.580804823537;4416.977915110404;4714.151452738472;3623.329684008414;3649;3719.460678201646;3725.8509659613856;3733;1108.1578000719512;1109.1809432530656;1111.183280288987;1118.6811758648746;1118.7370967822555;788.6372268756321;852.9914700852912;877.6884206106868;881.6076845803556;883.5758835758871;5160.587153027749;5282.339707536558;5365.222042803772;5513.862153446115;5528.336599607992;450.71830106183637;452.5248489086446;456.83097254015564;976.9853452198223;987.3927534566334;2891.421715656877;3544.0962554548423;3551.1122219445137;3577.3918433866306;3639.4358874374516;9771.316007879523;10236.795264094677;10238.897611023944;10245.129164020993;10248.538815753309;9976.950115249378;10045.397276163454;10213.131883789812;10231.7442063949;10243.23175761806;7757.185495523002;7926.128125906146;7929.167437418988;7934.801629959182;7950.204979502119;4599.643105284016;5209.869753256199;5260.526552610283;5265.341832270966;5434.483724046209;9341.532923353941;9405.43567385959;9405.811883762422;9409.48247846375;9522.95238523803;8529.061803201766;8829.293656507336;9485.288603354915;9602.471864047544;9703.805923881624;6561.278259391368;6824.7952561423235;6825.317468253334;6827.2490026098085;6841.144856892888;7731.110922243789;7791.337736292252;7875.921240787518;7893;7911.367090632851;7132.536385134949;7163.534370265916;7188.5327453715345;7203.603801790951;7304.96347518259;6998.475114366544;7027.754028608974;7036.648167591702;7068.363847253772;7096.112985876765;6226.066090086523;6389.744410223539;6414.486841052798;6461.644609546332;6498.415142637185;4489.102179564165;4551.499335073073;4568.154891344979;4700.388949436689;4789.353437286061;4654.464736555339;4754.049190162051;4791.257355109963;4867.440244371801;4885.9022819544125 10:05:53 INFO - PROCESS | 1640 | |4;prototype.html;299.4101619808976;302.76989487989124;307.8645396025749;314.0719174838353;314.7560640503611;3952.6837852971767;4943.9011219775675;5223.477652234775;5276.182191760274;5297.549708274802;4333.631641310484;4455.952851080002;4751.121042607111;4781.282807578865;5029.874253143673;3250.821204833733;3970.344893092636;3977.8011099445057;4031.1333063391367;4034.8500677306974;3202.6316973548105;3991.840326386941;3998.5201775786945;4021.767918805062;4023.6982226333;3298;3499.720022398215;3514.490398892159;3914.667253283474;3937.6652984496354;2971.4948458762065;3270.9369454927246;3925.6270654287796;3947.960520394788;3968.035822267967;3444.5866496020385;3445.7243420526547;3450.551428314328;3452.8446219920165;3456.2914602506426;4586.198458949431;4857.295692124658;4980.0577774667545;5062.82280120194;5069.529836347455;3846.9613204434645;4153.771542565158;4154.626083652455;4394.384786129945;4408.9198146454;5455.618106732531;5462.825492519088;5475.808346707886;5485.890282194374;5497.340319161686;3392.5080863274934;3754.4743735877;3756.849726010956;3768.9434658480145;3769.8680546180753;4774.798177603721;5377.49430159556;5717.656940583578;5745.310562732457;5794.478496935296;3478.9478157827652;3550.573931128281;3738.345789486829;3779.5653499847867;3782.3002744492355;3639.6906262967414;3823.483829683013;3839.596842331515;3841.7729107549794;3843.0968722350226;3978.980105099456;4272.328805073752;4465.821367145278;4478.664100192498;4494.258447356215;5449.967024401914;5482.972585137129;5493.550224318315;5539.734404508506;5541.390447050821;1092.6448904106198;1233.8340268446232;1244.8858271846645;1247.7878760610718;1249.6815859268377;758.880651039712;804.8430556041516;813.8860559521672;818.8157664525553;820.4707963363597;4237.703360764778;4806.687565308243;4819.879503012453;4850.466448690641;4874.8050077997195;4993.952479483394;5127.79488820443;5347.946520534822;5384.273123128328;5408.242846001563;4073.796310184479;4474.843380481668;4708.057464084947;4756.381670382828;4779.976100119547;2389.139909632531;2756.682981457158;2764.530029894923;2769.376890199729;2779.624750658635;5309.469053094737;5453.700046497481;5499.120140777536;5499.587530935196;5520.779168833282;4331.775998744924;4394.638101852086;4718.528147185254;5437.429069947678;5470.480304371078;4658.767061646904;5059.569936555286;5484.040292948798;5485.807996720176;5493.214705220819;4328.004558951396;5166.483351664954;5180.7150606717;5300.7084610345255;5305.002673489466;4399.670024748093;4471.412648509732;4978.482491438027;5179.689218646893;5222.0678349011105;4786.329913811999;5223.973880130575;5475.6440831345835;5513.476219759116;5515.972420137874;3280.3767284215924;3494.0566047166612;3606.8818666213556;3607.549056367954;3637.5089362935664;4559.293309537027;4678.836240731558;4850.563449289581;4949.727764972817;5030;4716.3868697069165;5144.279800827812;5152.639315247897;5196.766145523537;5215.739213039409;4560.726356418625;4927.876803079952;5137.922931155961;5140.331756871583;5186.740662966912;3951.9844879111283;4568.497465278883;4700.905981880412;4723.409573803275;5005.923726398842;4998.6750861193905;5356.517913387814;5374.903787522791;5379.757910894097;5398.730063496888;4526.932096018497;4862.586680132228;5313.256144139901;5361.919571206357;5362.249285100011 10:05:53 INFO - PROCESS | 1640 | |5;yui.html;692.4529621598937;698.6925752668828;737.0455260437733;749.737591842855;777.7239080126553;14369.425222991082;14713.926430367846;14745.778813317782;14775.852241477582;14857.777133342996;11481.794411586767;12833.807492887614;12968.221906685581;14646.487372941949;15055.171965541891;669.8559809640926;793.6071644535963;817.3951276055706;817.889584906039;819.0335404223015;817.3012074676155;817.382875928673;820.4953953318695;820.7660816667251;821.9589020548979;721.7185297733888;851.3912552524944;851.8977722673288;852.2457625001887;854.581255184958;846.8899043124354;847.3560094328293;848.0628905059913;848.4781859156636;849.218718778725;629.1852051593198;629.2417636747754;630.1083966187839;630.3192552043781;631.1637080867869;14007;14008.719825603432;14013.299335033207;14020.158790472502;14033.298335083206;13289.667758306023;13611.11527750703;13816.792748108786;13846.584602461942;13846.861531384759;11316.490757915913;11362.886371136348;11495.655130346104;11496.540138394454;11543.422828858524;3548.520949671813;3612.9277414451826;3644.325799727059;3827.158025234444;3844.038990252437;86604.13395866024;90163.54918225433;92059;92895.07104928931;93439;10362.274640775224;10635.202359823044;10644.095251903675;10705.46472676363;10881.401522916316;18909.37973144051;19877.105530251174;20925.58148837045;21078.156873725187;21118.894405527873;7565.356944659656;7599.848003039909;7631.275028872248;7725.343345815556;7766.650500727481;3877.6316249956208;4250.256205164084;4298.591633794785;4299.054208074219;4376.212281789245;3400.2519445722396;3491.5810102787827;3498.5976612689356;3515.068506845688;3517.771344862576;632.8133200705803;641.3202005873788;641.5220660607783;641.6470940982534;641.6887809412431;529.6345521590091;531.8112070215095;565.7595521903174;611.6605284067297;642.1202951955757;8875;9233.630654773868;9263.980962094165;9267.907320926704;9290.210332121711;548.7612888393481;593.2051051590889;656.1863289521056;658.7826017414337;672.9528932974645;4046.8988275293354;4523.32150177476;4531.161735079021;4559.133764584718;4632.907341853144;66117.66941165263;78015.60992195117;113099;114077.42961285307;120753;54803.17795233075;68322.65838670774;72112.91830622545;89688;94531.52734236285;55264;72695.2730472699;79216;82805.58597207096;83983.58008210042;8947.59735811877;8985.550722463982;9396.671116511163;9470.457773679827;9558.23534117255;51929.48070519398;52529.73735131453;54159.45840541544;54475;55019.89960200854;70611.64694176496;75158;75828.86256706264;76057.61971190109;77361.61319193368;12000;12073.758524829278;12276.202046866925;12302.200356976768;12393.690157746129;12896.548620798227;13476.258805765778;13674.042817002713;14052;14290.714185716435;12047.879521205026;12642.936785316015;13138.474461021453;13430.664233393853;13632.113912595649;12788.296643684687;13125.081244313189;13260.403281852532;13369.131006484547;13916.4433422666;11886.762264754829;12113.255220589986;12435.067369947472;12728.936355318165;12893.935530322664;10237.812128418727;10301.9484902575;10631.521581528696;11362.784257070123;11536.307821530734;10829.729256768644;11187.496562654538;11330.320180788849;11374.20380573352;11647 10:05:53 INFO - PROCESS | 1640 | __end_tp_report 10:05:53 INFO - PROCESS | 1640 | __start_cc_report 10:05:53 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2018 10:05:53 INFO - PROCESS | 1640 | __end_cc_report 10:05:53 INFO - PROCESS | 1640 | __startTimestamp1483725953870__endTimestamp 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | ------- Summary: start ------- 10:05:53 INFO - PROCESS | 1640 | Number of tests: 6 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5736.24 Median:6025.91 stddev:667.20 (11.1%) stddev-sans-first:641.82 10:05:53 INFO - PROCESS | 1640 | Values: 3322.7 3349.8 3354.2 3369.4 3410.6 5675.4 5737.3 5756.9 5763.8 5785.0 5579.7 5635.0 5645.8 5659.3 5660.5 5095.2 5120.1 5128.0 5159.0 5162.1 5201.6 5203.8 5208.4 5246.5 5266.2 5102.8 5113.3 5170.2 5182.9 5191.2 5086.0 5105.0 5146.7 5167.9 5194.1 5007.6 5096.5 5102.5 5109.3 5132.0 5629.0 5662.7 5679.8 5691.0 5725.5 6136.9 6152.8 6192.9 6230.7 6238.8 6269.4 6274.2 6283.4 6294.1 6295.8 5680.5 5733.8 5735.1 5741.7 5869.2 6258.3 6279.1 6285.6 6294.3 6298.7 6164.6 6166.3 6173.4 6186.4 6189.6 6108.3 6121.5 6162.6 6169.1 6271.2 6196.9 6250.9 6262.8 6270.8 6276.0 6205.7 6236.3 6274.4 6274.6 6283.4 4854.0 4858.1 4877.4 4917.8 4936.6 3787.2 4390.4 4395.5 4440.6 4485.6 5856.3 5861.7 5867.4 5870.2 5888.0 4836.2 6147.5 6287.7 6326.8 6332.7 5644.8 5768.4 5770.7 5781.5 5782.9 5338.5 5378.3 5385.2 5386.4 5405.0 6242.8 6266.4 6281.9 6284.1 6294.8 6118.2 6295.0 6304.4 6316.2 6319.2 6336.5 6337.6 6353.3 6354.7 6368.4 6071.8 6123.3 6133.6 6233.3 6241.2 5365.7 6142.6 6204.5 6226.0 6227.9 6166.5 6173.1 6182.6 6193.9 6201.3 6145.2 6167.5 6169.1 6173.4 6175.6 5845.6 5899.4 5964.5 5972.3 6075.8 6142.2 6184.8 6193.8 6204.0 6208.7 5963.2 6025.9 6046.2 6048.3 6071.1 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:66667.25 Median:36101.37 stddev:144478.47 (400.2%) stddev-sans-first:144798.32 10:05:53 INFO - PROCESS | 1640 | Values: 486.8 496.2 505.4 508.1 541.7 30145.4 38938.6 38954.2 38960.6 39055.6 39436.4 39904.0 39945.8 39991.6 40036.6 8449.7 9288.3 9488.2 9500.9 9501.8 8418.2 11174.7 11456.1 11483.9 11629.9 11345.1 11441.9 11454.7 11460.6 11469.1 8418.9 8661.7 11392.3 11457.8 11478.9 10916.8 11300.8 11302.0 11433.5 11435.9 38934.0 39182.0 39291.0 39375.4 39412.8 3196.2 3268.2 3273.9 3318.7 3330.1 28070.7 28890.4 29432.4 30262.4 30352.0 3038.5 3135.4 3279.3 3314.2 3318.1 461707.0 463151.0 464511.0 464706.0 465318.0 55406.4 55819.0 55890.0 55914.4 55924.7 58280.7 58415.4 58440.7 58442.4 58462.4 15601.4 15817.3 15831.9 15852.3 15858.5 11078.0 11312.4 11369.7 12311.0 12374.7 14529.5 14768.4 14945.6 15075.2 15247.4 6648.5 6671.6 6674.7 6719.0 6744.3 803.0 989.6 998.2 1072.0 1076.9 27998.0 28650.3 28774.9 29300.9 29487.1 1027.5 1028.4 1118.7 1149.5 1172.0 14709.6 14812.6 14919.5 15016.9 15055.8 617591.0 627735.0 629782.0 634687.0 638984.0 55026.7 55161.4 55182.7 55252.4 55397.7 1337.0 1340.9 1357.9 1375.4 1376.0 28087.4 28383.0 28710.7 29460.1 29480.2 52209.7 53981.2 54057.2 56034.4 56142.0 510676.0 513465.0 517139.0 518632.4 519733.0 22541.2 25203.0 25501.5 25536.5 25565.6 36012.3 37466.7 39108.0 43997.0 46929.3 36882.0 36931.1 37540.6 38631.0 38767.8 36509.6 37048.4 37100.4 37910.0 38149.0 36190.5 36758.3 36865.8 37071.0 38522.0 30687.7 32981.0 33489.3 33714.8 33822.8 24502.0 24915.8 25032.0 25205.9 25310.1 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:33754.75 Median:2801.68 stddev:92118.70 (3288.0%) stddev-sans-first:92342.97 10:05:53 INFO - PROCESS | 1640 | Values: 352.8 373.1 373.3 382.2 400.9 13063.3 13968.0 15119.7 17952.3 20235.8 18583.8 19317.3 19351.1 19583.8 19660.9 5600.5 5927.2 5927.3 5933.9 5936.2 5047.6 5798.5 5823.1 5824.7 5857.4 5803.4 5808.2 5808.4 5810.2 5810.9 5546.0 5749.8 5757.0 5787.7 5805.7 5022.7 5097.3 5104.8 5107.8 5108.9 19023.0 24900.0 25313.9 25493.6 25983.6 2558.7 2698.6 2727.6 2778.9 2824.5 9903.5 15242.2 15272.5 15290.5 16069.8 1684.8 1821.1 1868.7 1889.9 1903.2 126011.0 127960.0 129054.7 131769.7 132203.0 7547.7 10014.1 10138.6 10170.3 10373.5 12513.8 12561.6 12584.9 12593.9 12621.6 7002.7 7848.6 7875.8 7944.7 8021.4 8271.3 8277.4 8297.1 8396.5 8413.0 3907.7 3981.1 3993.2 4040.3 4046.7 1914.4 1969.2 1969.4 1972.2 1976.0 840.6 892.9 922.3 928.2 995.8 19994.3 20933.4 20965.3 20972.8 20998.7 914.4 922.7 926.0 931.2 1005.0 7931.4 8313.0 10237.8 10814.0 11058.9 489853.0 491181.0 491273.0 606505.0 623269.0 119843.0 123811.4 144613.0 144870.3 149592.3 956.3 995.8 1006.0 1007.7 1008.8 14871.6 18794.3 18998.4 19295.5 19421.6 53703.0 55001.7 56848.0 57470.0 57739.7 80698.6 81896.6 82596.0 83228.0 83496.6 6562.7 6825.8 6831.5 6874.2 7185.6 8836.0 11661.7 12086.7 12126.3 12265.8 10336.6 10427.1 10519.3 10705.9 10777.5 10335.0 10344.6 10427.6 10723.4 10805.9 10546.6 10590.6 10624.5 10737.9 10946.5 7092.6 7169.3 7321.7 7412.6 7482.3 9692.5 9790.3 10285.2 10438.5 10712.2 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5329.84 Median:4876.67 stddev:2971.52 (60.9%) stddev-sans-first:2964.47 10:05:53 INFO - PROCESS | 1640 | Values: 1306.1 1451.8 1477.5 1621.4 1810.3 5814.5 7823.5 8104.7 8296.4 8308.0 8242.4 8339.7 8347.3 8353.0 8355.8 2305.2 2336.8 2341.9 2343.9 2346.1 2308.4 2329.0 2370.8 2373.2 2376.0 2222.4 2228.8 2254.1 2254.1 2259.9 2184.9 2296.8 2324.2 2324.7 2325.8 2065.6 2295.5 2317.9 2339.8 2343.2 8156.7 8285.6 8373.1 8376.0 8387.5 4601.4 5038.3 5161.4 5206.9 5232.6 3421.1 3550.7 3568.8 3627.2 3637.9 1068.7 1083.2 1090.8 1103.2 1107.2 9294.5 10867.1 10984.9 10999.3 11001.3 3669.5 4196.3 4403.1 4479.9 4481.5 8684.2 8689.4 8691.2 8691.8 8704.5 5082.2 5092.4 5094.7 5106.9 5115.8 4060.9 4257.6 4412.6 4417.0 4714.2 3623.3 3649.0 3719.5 3725.9 3733.0 1108.2 1109.2 1111.2 1118.7 1118.7 788.6 853.0 877.7 881.6 883.6 5160.6 5282.3 5365.2 5513.9 5528.3 450.7 452.5 456.8 977.0 987.4 2891.4 3544.1 3551.1 3577.4 3639.4 9771.3 10236.8 10238.9 10245.1 10248.5 9977.0 10045.4 10213.1 10231.7 10243.2 7757.2 7926.1 7929.2 7934.8 7950.2 4599.6 5209.9 5260.5 5265.3 5434.5 9341.5 9405.4 9405.8 9409.5 9523.0 8529.1 8829.3 9485.3 9602.5 9703.8 6561.3 6824.8 6825.3 6827.2 6841.1 7731.1 7791.3 7875.9 7893.0 7911.4 7132.5 7163.5 7188.5 7203.6 7305.0 6998.5 7027.8 7036.6 7068.4 7096.1 6226.1 6389.7 6414.5 6461.6 6498.4 4489.1 4551.5 4568.2 4700.4 4789.4 4654.5 4754.0 4791.3 4867.4 4885.9 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4243.67 Median:4712.22 stddev:1294.01 (27.5%) stddev-sans-first:1263.33 10:05:53 INFO - PROCESS | 1640 | Values: 299.4 302.8 307.9 314.1 314.8 3952.7 4943.9 5223.5 5276.2 5297.5 4333.6 4456.0 4751.1 4781.3 5029.9 3250.8 3970.3 3977.8 4031.1 4034.9 3202.6 3991.8 3998.5 4021.8 4023.7 3298.0 3499.7 3514.5 3914.7 3937.7 2971.5 3270.9 3925.6 3948.0 3968.0 3444.6 3445.7 3450.6 3452.8 3456.3 4586.2 4857.3 4980.1 5062.8 5069.5 3847.0 4153.8 4154.6 4394.4 4408.9 5455.6 5462.8 5475.8 5485.9 5497.3 3392.5 3754.5 3756.8 3768.9 3769.9 4774.8 5377.5 5717.7 5745.3 5794.5 3478.9 3550.6 3738.3 3779.6 3782.3 3639.7 3823.5 3839.6 3841.8 3843.1 3979.0 4272.3 4465.8 4478.7 4494.3 5450.0 5483.0 5493.6 5539.7 5541.4 1092.6 1233.8 1244.9 1247.8 1249.7 758.9 804.8 813.9 818.8 820.5 4237.7 4806.7 4819.9 4850.5 4874.8 4994.0 5127.8 5347.9 5384.3 5408.2 4073.8 4474.8 4708.1 4756.4 4780.0 2389.1 2756.7 2764.5 2769.4 2779.6 5309.5 5453.7 5499.1 5499.6 5520.8 4331.8 4394.6 4718.5 5437.4 5470.5 4658.8 5059.6 5484.0 5485.8 5493.2 4328.0 5166.5 5180.7 5300.7 5305.0 4399.7 4471.4 4978.5 5179.7 5222.1 4786.3 5224.0 5475.6 5513.5 5516.0 3280.4 3494.1 3606.9 3607.5 3637.5 4559.3 4678.8 4850.6 4949.7 5030.0 4716.4 5144.3 5152.6 5196.8 5215.7 4560.7 4927.9 5137.9 5140.3 5186.7 3952.0 4568.5 4700.9 4723.4 5005.9 4998.7 5356.5 5374.9 5379.8 5398.7 4526.9 4862.6 5313.3 5361.9 5362.2 10:05:53 INFO - PROCESS | 1640 | 10:05:53 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19503.51 Median:4545.15 stddev:27851.36 (612.8%) stddev-sans-first:27893.67 10:05:53 INFO - PROCESS | 1640 | Values: 692.5 698.7 737.0 749.7 777.7 14369.4 14713.9 14745.8 14775.9 14857.8 11481.8 12833.8 12968.2 14646.5 15055.2 669.9 793.6 817.4 817.9 819.0 817.3 817.4 820.5 820.8 822.0 721.7 851.4 851.9 852.2 854.6 846.9 847.4 848.1 848.5 849.2 629.2 629.2 630.1 630.3 631.2 14007.0 14008.7 14013.3 14020.2 14033.3 13289.7 13611.1 13816.8 13846.6 13846.9 11316.5 11362.9 11495.7 11496.5 11543.4 3548.5 3612.9 3644.3 3827.2 3844.0 86604.1 90163.5 92059.0 92895.1 93439.0 10362.3 10635.2 10644.1 10705.5 10881.4 18909.4 19877.1 20925.6 21078.2 21118.9 7565.4 7599.8 7631.3 7725.3 7766.7 3877.6 4250.3 4298.6 4299.1 4376.2 3400.3 3491.6 3498.6 3515.1 3517.8 632.8 641.3 641.5 641.6 641.7 529.6 531.8 565.8 611.7 642.1 8875.0 9233.6 9264.0 9267.9 9290.2 548.8 593.2 656.2 658.8 673.0 4046.9 4523.3 4531.2 4559.1 4632.9 66117.7 78015.6 113099.0 114077.4 120753.0 54803.2 68322.7 72112.9 89688.0 94531.5 55264.0 72695.3 79216.0 82805.6 83983.6 8947.6 8985.6 9396.7 9470.5 9558.2 51929.5 52529.7 54159.5 54475.0 55019.9 70611.6 75158.0 75828.9 76057.6 77361.6 12000.0 12073.8 12276.2 12302.2 12393.7 12896.5 13476.3 13674.0 14052.0 14290.7 12047.9 12642.9 13138.5 13430.7 13632.1 12788.3 13125.1 13260.4 13369.1 13916.4 11886.8 12113.3 12435.1 12728.9 12893.9 10237.8 10301.9 10631.5 11362.8 11536.3 10829.7 11187.5 11330.3 11374.2 11647.0 10:05:53 INFO - PROCESS | 1640 | -------- Summary: end -------- 10:05:53 INFO - PROCESS | 1640 | 10:05:54 INFO - TEST-INFO | 1640: exit 0 10:05:54 INFO - TEST-OK | dromaeo_css | took 1119539ms 10:05:54 INFO - TEST-START | kraken 10:05:54 INFO - operating with platform_type : mac_ 10:05:54 INFO - Initialising browser for kraken test... 10:05:54 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpxHJNrN/profile http://localhost:49249/getInfo.html) 10:05:57 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 10:05:57 INFO - PROCESS | 1650 | colorDepth:24 10:05:57 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 10:05:57 INFO - PROCESS | 1650 | __metrics 10:05:57 INFO - PROCESS | 1650 | 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" 10:05:57 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:58 INFO - TEST-INFO | 1650: exit 0 10:05:58 INFO - Browser initialized. 10:05:58 INFO - Running cycle 1/1 for kraken test... 10:05:58 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/32/8yjhndkj27bg5s40136tly8r00000w/T/tmpxHJNrN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:10 INFO - PROCESS | 1651 | RSS: Main: 222547968 10:06:10 INFO - PROCESS | 1651 | 10:06:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 10:06:14 INFO - PROCESS | 1651 | RSS: Main: 270749696 10:06:14 INFO - PROCESS | 1651 | 10:06:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 10:06:17 INFO - PROCESS | 1651 | RSS: Main: 283930624 10:06:17 INFO - PROCESS | 1651 | 10:06:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 10:06:21 INFO - PROCESS | 1651 | RSS: Main: 383287296 10:06:21 INFO - PROCESS | 1651 | 10:06:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 10:06:23 INFO - PROCESS | 1651 | RSS: Main: 284704768 10:06:23 INFO - PROCESS | 1651 | 10:06:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:26 INFO - PROCESS | 1651 | RSS: Main: 286633984 10:06:26 INFO - PROCESS | 1651 | 10:06:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:29 INFO - PROCESS | 1651 | RSS: Main: 326553600 10:06:29 INFO - PROCESS | 1651 | 10:06:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:33 INFO - PROCESS | 1651 | RSS: Main: 329273344 10:06:33 INFO - PROCESS | 1651 | 10:06:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 10:06:36 INFO - PROCESS | 1651 | RSS: Main: 327241728 10:06:36 INFO - PROCESS | 1651 | 10:06:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:38 INFO - PROCESS | 1651 | RSS: Main: 299069440 10:06:38 INFO - PROCESS | 1651 | 10:06:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:41 INFO - PROCESS | 1651 | RSS: Main: 299311104 10:06:41 INFO - PROCESS | 1651 | 10:06:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:44 INFO - PROCESS | 1651 | RSS: Main: 302370816 10:06:44 INFO - PROCESS | 1651 | 10:06:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:47 INFO - PROCESS | 1651 | RSS: Main: 320450560 10:06:47 INFO - PROCESS | 1651 | 10:06:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:51 INFO - PROCESS | 1651 | RSS: Main: 314155008 10:06:51 INFO - PROCESS | 1651 | 10:06:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 10:06:53 INFO - PROCESS | 1651 | RSS: Main: 358813696 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | __start_tp_report 10:06:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 10:06:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 10:06:53 INFO - PROCESS | 1651 | |i|pagename|runs| 10:06:53 INFO - PROCESS | 1651 | |0;ai-astar;102;115;115;115;113;115;115;115;115;115 10:06:53 INFO - PROCESS | 1651 | |1;audio-beat-detection;147;93;116;175;140;110;113;110;137;103 10:06:53 INFO - PROCESS | 1651 | |2;audio-dft;183;183;183;184;182;181;183;184;187;252 10:06:53 INFO - PROCESS | 1651 | |3;audio-fft;81;60;59;88;58;61;58;58;82;59 10:06:53 INFO - PROCESS | 1651 | |4;audio-oscillator;93;69;94;69;68;70;90;66;67;93 10:06:53 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;84;89;87;89;84;133;88;90;86 10:06:53 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;95;96;97;94;95;95;95;95;95 10:06:53 INFO - PROCESS | 1651 | |7;imaging-desaturate;84;84;83;80;84;84;86;84;84;80 10:06:53 INFO - PROCESS | 1651 | |8;json-parse-financial;56;53;54;53;56;57;58;58;57;57 10:06:53 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;68;76;74;70;70;70;71;70;75 10:06:53 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;83;83;81;84;82;83;83;86;100;102 10:06:53 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;140;134;140;139;141;143;144;141;180;138 10:06:53 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;164;165;164;165;164;164;168;165;163;164 10:06:53 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;67;67;68;67;66;66;66;68;66 10:06:53 INFO - PROCESS | 1651 | __end_tp_report 10:06:53 INFO - PROCESS | 1651 | __start_cc_report 10:06:53 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2025 10:06:53 INFO - PROCESS | 1651 | __end_cc_report 10:06:53 INFO - PROCESS | 1651 | __startTimestamp1483726013086__endTimestamp 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | ------- Summary: start ------- 10:06:53 INFO - PROCESS | 1651 | Number of tests: 14 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:4.09 (3.6%) stddev-sans-first:0.67 10:06:53 INFO - PROCESS | 1651 | Values: 102.0 115.0 115.0 115.0 113.0 115.0 115.0 115.0 115.0 115.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:138.50 stddev:24.79 (17.9%) stddev-sans-first:24.91 10:06:53 INFO - PROCESS | 1651 | Values: 147.0 93.0 116.0 175.0 140.0 110.0 113.0 110.0 137.0 103.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:190.20 Median:183.50 stddev:21.77 (11.9%) stddev-sans-first:22.93 10:06:53 INFO - PROCESS | 1651 | Values: 183.0 183.0 183.0 184.0 182.0 181.0 183.0 184.0 187.0 252.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.40 Median:60.50 stddev:12.08 (20.0%) stddev-sans-first:11.61 10:06:53 INFO - PROCESS | 1651 | Values: 81.0 60.0 59.0 88.0 58.0 61.0 58.0 58.0 82.0 59.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.00 stddev:12.65 (15.8%) stddev-sans-first:12.18 10:06:53 INFO - PROCESS | 1651 | Values: 93.0 69.0 94.0 69.0 68.0 70.0 90.0 66.0 67.0 93.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:88.00 stddev:14.62 (16.6%) stddev-sans-first:15.44 10:06:53 INFO - PROCESS | 1651 | Values: 88.0 84.0 89.0 87.0 89.0 84.0 133.0 88.0 90.0 86.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 10:06:53 INFO - PROCESS | 1651 | Values: 95.0 95.0 96.0 97.0 94.0 95.0 95.0 95.0 95.0 95.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:83.30 Median:84.00 stddev:1.89 (2.2%) stddev-sans-first:1.99 10:06:53 INFO - PROCESS | 1651 | Values: 84.0 84.0 83.0 80.0 84.0 84.0 86.0 84.0 84.0 80.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.91 (3.4%) stddev-sans-first:2.03 10:06:53 INFO - PROCESS | 1651 | Values: 56.0 53.0 54.0 53.0 56.0 57.0 58.0 58.0 57.0 57.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.50 stddev:3.52 (5.0%) stddev-sans-first:2.74 10:06:53 INFO - PROCESS | 1651 | Values: 64.0 68.0 76.0 74.0 70.0 70.0 70.0 71.0 70.0 75.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.00 stddev:7.66 (9.2%) stddev-sans-first:8.01 10:06:53 INFO - PROCESS | 1651 | Values: 83.0 83.0 81.0 84.0 82.0 83.0 83.0 86.0 100.0 102.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:141.00 stddev:12.94 (9.2%) stddev-sans-first:13.65 10:06:53 INFO - PROCESS | 1651 | Values: 140.0 134.0 140.0 139.0 141.0 143.0 144.0 141.0 180.0 138.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 10:06:53 INFO - PROCESS | 1651 | Values: 164.0 165.0 164.0 165.0 164.0 164.0 168.0 165.0 163.0 164.0 10:06:53 INFO - PROCESS | 1651 | 10:06:53 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 10:06:53 INFO - PROCESS | 1651 | Values: 66.0 67.0 67.0 68.0 67.0 66.0 66.0 66.0 68.0 66.0 10:06:53 INFO - PROCESS | 1651 | -------- Summary: end -------- 10:06:53 INFO - PROCESS | 1651 | 10:06:54 INFO - TEST-INFO | 1651: exit 0 10:06:54 INFO - TEST-OK | kraken | took 59627ms 10:06:54 INFO - SUITE-END | took 1179s 10:06:54 INFO - Completed test suite (00:19:39) 10:06:54 INFO - javascript benchmark 10:06:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3322.7009569138777, 3349.8492567834446, 3354.245294808667, 3369.376665316918, 3410.6248312685602, 5675.404082571327, 5737.340205876326, 5756.856078598032, 5763.769449222036, 5784.971075144624, 5579.6652200867975, 5634.9718251408685, 5645.802396916109, 5659.264295641561, 5660.462256085676, 5095.235714642796, 5120.0527902338, 5127.974360128203, 5159.0, 5162.1482455395, 5201.55786758126, 5203.765830537616, 5208.401033881095, 5246.475352464761, 5266.236395722618, 5102.770375333119, 5113.284140220372, 5170.172772356424, 5182.922256166142, 5191.247269145972, 5086.0, 5104.9744751276, 5146.691697789149, 5167.870803229912, 5194.091034069061, 5007.6244281678655, 5096.464871188509, 5102.515261050195, 5109.284700141983, 5132.0, 5629.0, 5662.745176467069, 5679.772809087632, 5690.971545142248, 5725.541956643458, 6136.938630613681, 6152.815415537496, 6192.9380706192815, 6230.719617617173, 6238.781642642486, 6269.358324453009, 6274.247090349141, 6283.371662833726, 6294.118823364733, 6295.842603934892, 5680.460356266148, 5733.799317023884, 5735.053716136874, 5741.684207368551, 5869.178315035899, 6258.311585725566, 6279.058141278753, 6285.622862628257, 6294.339094395114, 6298.716557754912, 6164.5684802064325, 6166.260048794084, 6173.41352571505, 6186.443220110212, 6189.597676151036, 6108.349900596421, 6121.510279177655, 6162.630242185483, 6169.074638804125, 6271.247450305992, 6196.907046394308, 6250.937490625036, 6262.812115636538, 6270.843228919313, 6275.968620156961, 6205.720742566596, 6236.345183755731, 6274.435300822948, 6274.560780745304, 6283.371662833772, 4854.004928989549, 4858.125537403231, 4877.3903262092235, 4917.803287868517, 4936.6297527685565, 3787.223619158066, 4390.363397307373, 4395.450568678915, 4440.644748420119, 4485.551444855489, 5856.326522449973, 5861.706914654335, 5867.413258674099, 5870.178175055496, 5887.970560147171, 4836.226203807374, 6147.508199344042, 6287.748490060347, 6326.778562750282, 6332.68336583169, 5644.8024319148635, 5768.3654797972185, 5770.711464426762, 5781.53747700183, 5782.855428614318, 5338.466153384708, 5378.327709036371, 5385.192221166856, 5386.353637563439, 5404.9730551195935, 6242.843928901813, 6266.404691554295, 6281.874362512815, 6284.120223168668, 6294.8111556653375, 6118.174046503843, 6295.0, 6304.401081897213, 6316.242050953915, 6319.24169099711, 6336.493080553637, 6337.556371053982, 6353.3011368748475, 6354.714037868214, 6368.42684158428, 6071.757129714939, 6123.2652081750475, 6133.6319820810895, 6233.314335423191, 6241.188645476059, 5365.678059316453, 6142.570020098729, 6204.5036397089025, 6225.968870155621, 6227.875442491034, 6166.475849552839, 6173.104899789416, 6182.629042257479, 6193.907091393543, 6201.286852012076, 6145.201123853871, 6167.506599472121, 6169.136320915165, 6173.382661733791, 6175.5677102602385, 5845.590808643354, 5899.38056504078, 5964.522838172849, 5972.25346831646, 6075.848103797441, 6142.191841058572, 6184.783532576518, 6193.783217587363, 6203.96898015507, 6208.658523781055, 5963.194968679346, 6025.909611355745, 6046.244219472566, 6048.322683706211, 6071.089336599545], "value": 5692.116921960075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.8077109541729, 496.1639637211299, 505.4061477763629, 508.14124130219926, 541.7074779619006, 30145.397092058145, 38938.610613893856, 38954.220915581674, 38960.61039389609, 39055.60944390555, 39436.40845387321, 39904.002399940015, 39945.800270998676, 39991.600083999154, 40036.59963400365, 8449.704260350889, 9288.256939444846, 9488.193503552171, 9500.857487137699, 9501.80996380072, 8418.200270974248, 11174.66476005717, 11456.083513318914, 11483.885161148406, 11629.883701163008, 11345.149113816455, 11441.885581144206, 11454.71363215922, 11460.598879039235, 11469.139814513903, 8418.915810841874, 8661.653533858638, 11392.316461012324, 11457.770844583103, 11478.885211147948, 10916.781664366668, 11300.830487542693, 11302.039326657245, 11433.542658293658, 11435.885641143648, 38934.0, 39182.0, 39291.0, 39375.40936885949, 39412.802935985426, 3196.1578209013364, 3268.1829542614346, 3273.851061708684, 3318.6515415881468, 3330.134165117087, 28070.719292807014, 28890.422191556052, 29432.411351772844, 30262.394752105054, 30352.0, 3038.468268053082, 3135.435621588113, 3279.262166012652, 3314.221158027886, 3318.1206980150278, 461707.0, 463151.0, 464511.0, 464706.0, 465318.0, 55406.445935540934, 55819.0, 55890.0, 55914.44085559174, 55924.720376397854, 58280.708596456745, 58415.415845841846, 58440.707796460745, 58442.41557584455, 58462.415375845696, 15601.375944962074, 15817.288222030036, 15831.920840395955, 15852.286647100907, 15858.52424427269, 11078.0, 11312.377819220023, 11369.715757105972, 12311.015118790476, 12374.690632734253, 14529.491467798576, 14768.409263629335, 14945.551633451014, 15075.246237688072, 15247.390104395921, 6648.515416164486, 6671.599704017677, 6674.666266686743, 6719.0, 6744.325567443217, 802.9839403211903, 989.5547003848297, 998.2114129837493, 1071.983920241197, 1076.8761592416815, 27998.0, 28650.283742906176, 28774.856125719656, 29300.853495732386, 29487.115386538437, 1027.50679673757, 1028.4035259549444, 1118.6588090632436, 1149.4827327702567, 1171.988280117188, 14709.632259193391, 14812.555623331318, 14919.487676074035, 15016.942929861754, 15055.849441505663, 617591.0, 627735.0, 629782.0, 634687.0, 638984.0, 55026.724866376215, 55161.44838551563, 55182.72408637931, 55252.447475525536, 55397.72301138468, 1336.9665758356118, 1340.8726171013739, 1357.8574249703836, 1375.42232262448, 1376.0161484538603, 28087.438251234453, 28383.006594769085, 28710.712892870804, 29460.11619651414, 29480.199381058766, 52209.738951305, 53981.19028214501, 54057.18914216368, 56034.439655602924, 56142.0, 510676.0, 513465.0, 517139.0, 518632.4068379785, 519733.0, 22541.21105761356, 25203.0, 25501.489970200862, 25536.489270214865, 25565.616515752652, 36012.27975440424, 37466.66858847786, 39108.0, 43997.0, 46929.2960605598, 36882.0, 36931.07672308214, 37540.62459375371, 38631.0, 38767.836964891096, 36509.63490365062, 37048.44427333646, 37100.443493347084, 37910.0, 38149.0, 36190.45714314235, 36758.26483470369, 36865.815670921475, 37071.0, 38522.0, 30687.693123068482, 32981.01056968295, 33489.33021339608, 33714.831425843695, 33822.83088584541, 24502.0, 24915.750842491343, 25032.0, 25205.873970630764, 25310.114146004802], "value": 19476.778678504183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.81829857623313, 373.1231605726543, 373.2832960715428, 382.2469734622794, 400.94386785849986, 13063.346832658364, 13967.952403569734, 15119.697606047872, 17952.281908723635, 20235.797642023575, 18583.814161858376, 19317.323893663724, 19351.129199186034, 19583.804161958375, 19660.90169549154, 5600.52395546378, 5927.1998280232265, 5927.288725352963, 5933.910991335133, 5936.168936348915, 5047.64666473347, 5798.507126894198, 5823.126531020339, 5824.650520968734, 5857.414258574151, 5803.390643982384, 5808.2158908547435, 5808.4481974212595, 5810.244668193129, 5810.912836307438, 5545.972270138644, 5749.8275051748515, 5756.971215143939, 5787.652740835563, 5805.680687562182, 5022.723750193738, 5097.337346145015, 5104.770285337168, 5107.8212262571005, 5108.923366149511, 19023.0, 24900.003999839984, 25313.873430632728, 25493.61759573608, 25983.61024584633, 2558.6801649793774, 2698.5682290833374, 2727.595288426462, 2778.8888444462195, 2824.477471667748, 9903.504824758806, 15242.23788810555, 15272.465463708828, 15290.464833730877, 16069.758953615705, 1684.7978242610843, 1821.1440622907212, 1868.7383766272596, 1889.9433017009512, 1903.1626084522766, 126011.0, 127960.0, 129054.70945290521, 131769.6823031767, 132203.0, 7547.735829246059, 10014.098731114234, 10138.594456221816, 10170.288079834341, 10373.481325933673, 12513.812292815615, 12561.623151305475, 12584.874151258371, 12593.93703031479, 12621.558245461549, 7002.684879180449, 7848.568328741974, 7875.803104922308, 7944.721934732257, 8021.358291336679, 8271.255586997078, 8277.420580559423, 8297.12880147588, 8396.454230475121, 8412.990441147102, 3907.667848232932, 3981.0843505993785, 3993.221321842213, 4040.313146765057, 4046.6964977626794, 1914.4448110048208, 1969.2418418908824, 1969.3993332033867, 1972.1716878910604, 1975.9703604445658, 840.6427268411023, 892.8928528576612, 922.285228947571, 928.2388441478058, 995.785906030207, 19994.300199492947, 20933.371998839753, 20965.26621568238, 20972.79027209739, 20998.685019724715, 914.3599480363772, 922.7416323429451, 925.9768505787409, 931.1526510875207, 1005.0351662404028, 7931.405144614062, 8313.0, 10237.795244095076, 10814.026737593655, 11058.889411105785, 489853.0, 491181.0, 491273.0, 606504.9674751598, 623269.0, 119843.0, 123811.38094309471, 144613.0, 144870.2756486211, 149592.2520387391, 956.268454632207, 995.7510622344414, 1006.0492834271544, 1007.6523599358356, 1008.7831116309882, 14871.628209294855, 18794.342198023005, 18998.43004709861, 19295.51761205981, 19421.601219786196, 53703.0, 55001.72499137479, 56848.0, 57470.0, 57739.711301443225, 80698.5965070171, 81896.59051704704, 82596.0, 83228.0, 83496.58251708702, 6562.654655795646, 6825.761098361533, 6831.4629208427705, 6874.175098988154, 7185.568865868065, 8836.028036915806, 11661.6501504955, 12086.697832554257, 12126.333051682243, 12265.754684906431, 10336.586536538454, 10427.113695335982, 10519.263651544625, 10705.89294107049, 10777.51501182433, 10335.0, 10344.637937672145, 10427.582896684351, 10723.356598604109, 10805.891941080488, 10546.630867919586, 10590.558426636399, 10624.468776561296, 10737.946310268399, 10946.45267736594, 7092.6099064551945, 7169.318914703095, 7321.74373896911, 7412.555246685216, 7482.326590606872, 9692.466914319499, 9790.314677972474, 10285.177185824967, 10438.478076096317, 10712.196585256293], "value": 9276.59927458452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.0922658752158, 1451.7604595241783, 1477.4976507987285, 1621.4487074394704, 1810.3120814090635, 5814.505767009804, 7823.491473054255, 8104.716334928286, 8296.419250652456, 8308.0, 8242.423030387876, 8339.666413343459, 8347.332213422927, 8353.039400468948, 8355.83288334233, 2305.1931823861596, 2336.8247381446376, 2341.94145146371, 2343.8593684378907, 2346.1319311854554, 2308.411355104446, 2328.976710232893, 2370.8340416170877, 2373.2405630198346, 2376.025829409942, 2222.3666255117296, 2228.799408053275, 2254.1434254983083, 2254.1434254983083, 2259.8531095478743, 2184.8907554622365, 2296.8047715944167, 2324.244620498345, 2324.697789287382, 2325.837191396603, 2065.5765568058514, 2295.473510115771, 2317.9072837086496, 2339.7894189523026, 2343.215022967308, 8156.673733050671, 8285.62714677841, 8373.120822313691, 8376.036755773102, 8387.538685372301, 4601.44782626087, 5038.294638750578, 5161.406438259573, 5206.869828254324, 5232.607554433433, 3421.127612458832, 3550.6626870447267, 3568.8215589220695, 3627.1838836261895, 3637.890863274106, 1068.6740544134036, 1083.2471432354516, 1090.7763908398758, 1103.2167161315476, 1107.1585594947899, 9294.488803115826, 10867.076298514557, 10984.890151098467, 10999.34003959773, 11001.284916480483, 3669.4679271506016, 4196.349565817303, 4403.106664134389, 4479.932801007987, 4481.484629267676, 8684.2184203422, 8689.391742577958, 8691.217790398894, 8691.782705432415, 8704.477731336141, 5082.161443361804, 5092.439831618519, 5094.6688465249645, 5106.897862042812, 5115.846524604268, 4060.918781624351, 4257.595528424795, 4412.580804823537, 4416.977915110404, 4714.151452738472, 3623.329684008414, 3649.0, 3719.460678201646, 3725.8509659613856, 3733.0, 1108.1578000719512, 1109.1809432530656, 1111.183280288987, 1118.6811758648746, 1118.7370967822555, 788.6372268756321, 852.9914700852912, 877.6884206106868, 881.6076845803556, 883.5758835758871, 5160.587153027749, 5282.339707536558, 5365.222042803772, 5513.862153446115, 5528.336599607992, 450.71830106183637, 452.5248489086446, 456.83097254015564, 976.9853452198223, 987.3927534566334, 2891.421715656877, 3544.0962554548423, 3551.1122219445137, 3577.3918433866306, 3639.4358874374516, 9771.316007879523, 10236.795264094677, 10238.897611023944, 10245.129164020993, 10248.538815753309, 9976.950115249378, 10045.397276163454, 10213.131883789812, 10231.7442063949, 10243.23175761806, 7757.185495523002, 7926.128125906146, 7929.167437418988, 7934.801629959182, 7950.204979502119, 4599.643105284016, 5209.869753256199, 5260.526552610283, 5265.341832270966, 5434.483724046209, 9341.532923353941, 9405.43567385959, 9405.811883762422, 9409.48247846375, 9522.95238523803, 8529.061803201766, 8829.293656507336, 9485.288603354915, 9602.471864047544, 9703.805923881624, 6561.278259391368, 6824.7952561423235, 6825.317468253334, 6827.2490026098085, 6841.144856892888, 7731.110922243789, 7791.337736292252, 7875.921240787518, 7893.0, 7911.367090632851, 7132.536385134949, 7163.534370265916, 7188.5327453715345, 7203.603801790951, 7304.96347518259, 6998.475114366544, 7027.754028608974, 7036.648167591702, 7068.363847253772, 7096.112985876765, 6226.066090086523, 6389.744410223539, 6414.486841052798, 6461.644609546332, 6498.415142637185, 4489.102179564165, 4551.499335073073, 4568.154891344979, 4700.388949436689, 4789.353437286061, 4654.464736555339, 4754.049190162051, 4791.257355109963, 4867.440244371801, 4885.9022819544125], "value": 4280.117410443252, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.4101619808976, 302.76989487989124, 307.8645396025749, 314.0719174838353, 314.7560640503611, 3952.6837852971767, 4943.9011219775675, 5223.477652234775, 5276.182191760274, 5297.549708274802, 4333.631641310484, 4455.952851080002, 4751.121042607111, 4781.282807578865, 5029.874253143673, 3250.821204833733, 3970.344893092636, 3977.8011099445057, 4031.1333063391367, 4034.8500677306974, 3202.6316973548105, 3991.840326386941, 3998.5201775786945, 4021.767918805062, 4023.6982226333, 3298.0, 3499.720022398215, 3514.490398892159, 3914.667253283474, 3937.6652984496354, 2971.4948458762065, 3270.9369454927246, 3925.6270654287796, 3947.960520394788, 3968.035822267967, 3444.5866496020385, 3445.7243420526547, 3450.551428314328, 3452.8446219920165, 3456.2914602506426, 4586.198458949431, 4857.295692124658, 4980.0577774667545, 5062.82280120194, 5069.529836347455, 3846.9613204434645, 4153.771542565158, 4154.626083652455, 4394.384786129945, 4408.9198146454, 5455.618106732531, 5462.825492519088, 5475.808346707886, 5485.890282194374, 5497.340319161686, 3392.5080863274934, 3754.4743735877, 3756.849726010956, 3768.9434658480145, 3769.8680546180753, 4774.798177603721, 5377.49430159556, 5717.656940583578, 5745.310562732457, 5794.478496935296, 3478.9478157827652, 3550.573931128281, 3738.345789486829, 3779.5653499847867, 3782.3002744492355, 3639.6906262967414, 3823.483829683013, 3839.596842331515, 3841.7729107549794, 3843.0968722350226, 3978.980105099456, 4272.328805073752, 4465.821367145278, 4478.664100192498, 4494.258447356215, 5449.967024401914, 5482.972585137129, 5493.550224318315, 5539.734404508506, 5541.390447050821, 1092.6448904106198, 1233.8340268446232, 1244.8858271846645, 1247.7878760610718, 1249.6815859268377, 758.880651039712, 804.8430556041516, 813.8860559521672, 818.8157664525553, 820.4707963363597, 4237.703360764778, 4806.687565308243, 4819.879503012453, 4850.466448690641, 4874.8050077997195, 4993.952479483394, 5127.79488820443, 5347.946520534822, 5384.273123128328, 5408.242846001563, 4073.796310184479, 4474.843380481668, 4708.057464084947, 4756.381670382828, 4779.976100119547, 2389.139909632531, 2756.682981457158, 2764.530029894923, 2769.376890199729, 2779.624750658635, 5309.469053094737, 5453.700046497481, 5499.120140777536, 5499.587530935196, 5520.779168833282, 4331.775998744924, 4394.638101852086, 4718.528147185254, 5437.429069947678, 5470.480304371078, 4658.767061646904, 5059.569936555286, 5484.040292948798, 5485.807996720176, 5493.214705220819, 4328.004558951396, 5166.483351664954, 5180.7150606717, 5300.7084610345255, 5305.002673489466, 4399.670024748093, 4471.412648509732, 4978.482491438027, 5179.689218646893, 5222.0678349011105, 4786.329913811999, 5223.973880130575, 5475.6440831345835, 5513.476219759116, 5515.972420137874, 3280.3767284215924, 3494.0566047166612, 3606.8818666213556, 3607.549056367954, 3637.5089362935664, 4559.293309537027, 4678.836240731558, 4850.563449289581, 4949.727764972817, 5030.0, 4716.3868697069165, 5144.279800827812, 5152.639315247897, 5196.766145523537, 5215.739213039409, 4560.726356418625, 4927.876803079952, 5137.922931155961, 5140.331756871583, 5186.740662966912, 3951.9844879111283, 4568.497465278883, 4700.905981880412, 4723.409573803275, 5005.923726398842, 4998.6750861193905, 5356.517913387814, 5374.903787522791, 5379.757910894097, 5398.730063496888, 4526.932096018497, 4862.586680132228, 5313.256144139901, 5361.919571206357, 5362.249285100011], "value": 3835.0399979207496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.4529621598937, 698.6925752668828, 737.0455260437733, 749.737591842855, 777.7239080126553, 14369.425222991082, 14713.926430367846, 14745.778813317782, 14775.852241477582, 14857.777133342996, 11481.794411586767, 12833.807492887614, 12968.221906685581, 14646.487372941949, 15055.171965541891, 669.8559809640926, 793.6071644535963, 817.3951276055706, 817.889584906039, 819.0335404223015, 817.3012074676155, 817.382875928673, 820.4953953318695, 820.7660816667251, 821.9589020548979, 721.7185297733888, 851.3912552524944, 851.8977722673288, 852.2457625001887, 854.581255184958, 846.8899043124354, 847.3560094328293, 848.0628905059913, 848.4781859156636, 849.218718778725, 629.1852051593198, 629.2417636747754, 630.1083966187839, 630.3192552043781, 631.1637080867869, 14007.0, 14008.719825603432, 14013.299335033207, 14020.158790472502, 14033.298335083206, 13289.667758306023, 13611.11527750703, 13816.792748108786, 13846.584602461942, 13846.861531384759, 11316.490757915913, 11362.886371136348, 11495.655130346104, 11496.540138394454, 11543.422828858524, 3548.520949671813, 3612.9277414451826, 3644.325799727059, 3827.158025234444, 3844.038990252437, 86604.13395866024, 90163.54918225433, 92059.0, 92895.07104928931, 93439.0, 10362.274640775224, 10635.202359823044, 10644.095251903675, 10705.46472676363, 10881.401522916316, 18909.37973144051, 19877.105530251174, 20925.58148837045, 21078.156873725187, 21118.894405527873, 7565.356944659656, 7599.848003039909, 7631.275028872248, 7725.343345815556, 7766.650500727481, 3877.6316249956208, 4250.256205164084, 4298.591633794785, 4299.054208074219, 4376.212281789245, 3400.2519445722396, 3491.5810102787827, 3498.5976612689356, 3515.068506845688, 3517.771344862576, 632.8133200705803, 641.3202005873788, 641.5220660607783, 641.6470940982534, 641.6887809412431, 529.6345521590091, 531.8112070215095, 565.7595521903174, 611.6605284067297, 642.1202951955757, 8875.0, 9233.630654773868, 9263.980962094165, 9267.907320926704, 9290.210332121711, 548.7612888393481, 593.2051051590889, 656.1863289521056, 658.7826017414337, 672.9528932974645, 4046.8988275293354, 4523.32150177476, 4531.161735079021, 4559.133764584718, 4632.907341853144, 66117.66941165263, 78015.60992195117, 113099.0, 114077.42961285307, 120753.0, 54803.17795233075, 68322.65838670774, 72112.91830622545, 89688.0, 94531.52734236285, 55264.0, 72695.2730472699, 79216.0, 82805.58597207096, 83983.58008210042, 8947.59735811877, 8985.550722463982, 9396.671116511163, 9470.457773679827, 9558.23534117255, 51929.48070519398, 52529.73735131453, 54159.45840541544, 54475.0, 55019.89960200854, 70611.64694176496, 75158.0, 75828.86256706264, 76057.61971190109, 77361.61319193368, 12000.0, 12073.758524829278, 12276.202046866925, 12302.200356976768, 12393.690157746129, 12896.548620798227, 13476.258805765778, 13674.042817002713, 14052.0, 14290.714185716435, 12047.879521205026, 12642.936785316015, 13138.474461021453, 13430.664233393853, 13632.113912595649, 12788.296643684687, 13125.081244313189, 13260.403281852532, 13369.131006484547, 13916.4433422666, 11886.762264754829, 12113.255220589986, 12435.067369947472, 12728.936355318165, 12893.935530322664, 10237.812128418727, 10301.9484902575, 10631.521581528696, 11362.784257070123, 11536.307821530734, 10829.729256768644, 11187.496562654538, 11330.320180788849, 11374.20380573352, 11647.0], "value": 7172.869658324638, "unit": "score"}], "name": "dromaeo_css", "value": 7033.822563727729, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 115.0, 115.0, 113.0, 115.0, 115.0, 115.0, 115.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 93.0, 116.0, 175.0, 140.0, 110.0, 113.0, 110.0, 137.0, 103.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 184.0, 182.0, 181.0, 183.0, 184.0, 187.0, 252.0], "value": 190.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 88.0, 58.0, 61.0, 58.0, 58.0, 82.0, 59.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 94.0, 69.0, 68.0, 70.0, 90.0, 66.0, 67.0, 93.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 87.0, 89.0, 84.0, 133.0, 88.0, 90.0, 86.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 80.0, 84.0, 84.0, 86.0, 84.0, 84.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 56.0, 57.0, 58.0, 58.0, 57.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 76.0, 74.0, 70.0, 70.0, 70.0, 71.0, 70.0, 75.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 84.0, 82.0, 83.0, 83.0, 86.0, 100.0, 102.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 140.0, 139.0, 141.0, 143.0, 144.0, 141.0, 180.0, 138.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 165.0, 164.0, 164.0, 168.0, 165.0, 163.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 66.0, 68.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1431.3999999999999, "alertThreshold": 2.0}]} 10:06:54 INFO - Return code: 0 10:06:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:06:54 INFO - # TBPL SUCCESS # 10:06:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:54 INFO - 2017-01-06 10:06:54.421 screenresolution[1655:9989] starting screenresolution argv=screenresolution get 10:06:54 INFO - 2017-01-06 10:06:54.424 screenresolution[1655:9989] Display 0: 1600x1200x32@60 10:06:54 INFO - 2017-01-06 10:06:54.430 screenresolution[1656:9992] starting screenresolution argv=screenresolution list 10:06:54 INFO - Available Modes on Display 0 10:06:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:54 INFO - Intel Iris: 10:06:54 INFO - Chipset Model: Intel Iris 10:06:54 INFO - Type: GPU 10:06:54 INFO - Bus: Built-In 10:06:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:54 INFO - Vendor: Intel (0x8086) 10:06:54 INFO - Device ID: 0x0a2e 10:06:54 INFO - Revision ID: 0x0009 10:06:54 INFO - Displays: 10:06:54 INFO - Display: 10:06:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:54 INFO - Display Serial Number: 1600x1200 60 10:06:54 INFO - Main Display: Yes 10:06:54 INFO - Mirror: Off 10:06:54 INFO - Online: Yes 10:06:54 INFO - Rotation: Supported 10:06:54 INFO - Return code: 0 10:06:54 INFO - Running post-action listener: _resource_record_post_action 10:06:54 INFO - [mozharness: 2017-01-06 18:06:54.674619Z] Finished run-tests step (success) 10:06:54 INFO - Running post-run listener: _resource_record_post_run 10:06:54 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37909504; Write bytes: 655234560; Read time: 237; Write time: 1893 10:06:54 INFO - TinderboxPrint: CPU usage
53.5% 10:06:54 INFO - TinderboxPrint: I/O read bytes / time
37,909,504 / 237 10:06:54 INFO - TinderboxPrint: I/O write bytes / time
655,234,560 / 1,893 10:06:54 INFO - TinderboxPrint: CPU idle
2,252.2 (46.5%) 10:06:54 INFO - TinderboxPrint: CPU system
968.1 (20.0%) 10:06:54 INFO - TinderboxPrint: CPU user
1,625.3 (33.5%) 10:06:54 INFO - TinderboxPrint: Swap in / out
386,973,696 / 0 10:06:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 350077440; Write bytes: 351971328; Read time: 27884; Write time: 729 10:06:54 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34518016; Write bytes: 301755904; Read time: 211; Write time: 1156 10:06:55 INFO - Running post-run listener: _upload_blobber_files 10:06:55 INFO - Blob upload gear active. 10:06:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:06:55 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 10:06:55 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'] 10:06:55 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 10:06:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:56 INFO - (blobuploader) - INFO - Done attempting. 10:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:06:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:58 INFO - (blobuploader) - INFO - Done attempting. 10:06:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:06:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:00 INFO - (blobuploader) - INFO - Done attempting. 10:07:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:07:00 INFO - Return code: 0 10:07:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:07:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:07:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d23f1ee0f98b3e20aabfbc1ece967927b0e166d81982e4690caaf5496e8eb563139b9f150e7e6601fbfe2ee2adca1d525feecec9d15483281e17c7ad91c31d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d900bbd56b944ae7b231e7c6c14dad7471323b4f3fe592723dfe843904f245a530988b16eb740fdd21f2dcf62a71314166d7758e77fa19ac5e87bf26c08fd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88499e8a026e3475bf413e26f3afc6a296d2e186a42f4948c48344068e150d1582cbe49ed191e1976fb20f87bca1bbe22a28bab027d24370cde9ca01cf049869"} 10:07:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:07:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:07:00 INFO - Contents: 10:07:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d23f1ee0f98b3e20aabfbc1ece967927b0e166d81982e4690caaf5496e8eb563139b9f150e7e6601fbfe2ee2adca1d525feecec9d15483281e17c7ad91c31d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d900bbd56b944ae7b231e7c6c14dad7471323b4f3fe592723dfe843904f245a530988b16eb740fdd21f2dcf62a71314166d7758e77fa19ac5e87bf26c08fd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88499e8a026e3475bf413e26f3afc6a296d2e186a42f4948c48344068e150d1582cbe49ed191e1976fb20f87bca1bbe22a28bab027d24370cde9ca01cf049869"} 10:07:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:07:00 INFO - Copying logs to upload dir... 10:07:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:07:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.946373 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-06 10:07:00.333917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 10:07:00.337021) ========= 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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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/d23f1ee0f98b3e20aabfbc1ece967927b0e166d81982e4690caaf5496e8eb563139b9f150e7e6601fbfe2ee2adca1d525feecec9d15483281e17c7ad91c31d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d900bbd56b944ae7b231e7c6c14dad7471323b4f3fe592723dfe843904f245a530988b16eb740fdd21f2dcf62a71314166d7758e77fa19ac5e87bf26c08fd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88499e8a026e3475bf413e26f3afc6a296d2e186a42f4948c48344068e150d1582cbe49ed191e1976fb20f87bca1bbe22a28bab027d24370cde9ca01cf049869"} build_url:https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009823 build_url: 'https://queue.taskcluster.net/v1/task/VTc0HHQRS6KDNsJ2RXumqQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d23f1ee0f98b3e20aabfbc1ece967927b0e166d81982e4690caaf5496e8eb563139b9f150e7e6601fbfe2ee2adca1d525feecec9d15483281e17c7ad91c31d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73d900bbd56b944ae7b231e7c6c14dad7471323b4f3fe592723dfe843904f245a530988b16eb740fdd21f2dcf62a71314166d7758e77fa19ac5e87bf26c08fd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88499e8a026e3475bf413e26f3afc6a296d2e186a42f4948c48344068e150d1582cbe49ed191e1976fb20f87bca1bbe22a28bab027d24370cde9ca01cf049869"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 10:07:00.367695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 10:07:00.367994) ========= 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.b8pfxkS0aS/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.QvMHoUR8FT/Listeners TMPDIR=/var/folders/32/8yjhndkj27bg5s40136tly8r00000w/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.004897 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 10:07:00.416767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 10:07:00.417085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 10:07:00.417429) ========= ========= Total master_lag: 0.16 =========