builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0021 starttime: 1482236081.98 results: success (0) buildid: 20161220030215 builduid: 21a18d4cb82344178c4ddf64454bcd5f revision: 567894f026558e6dada617a3998f29aed06ac7d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:41.975908) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:41.976423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:41.976698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:42.002357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:42.002765) ========= 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.9yEDaaHgih/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.qpcKARTrJz/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-20 04:14:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.11M=0.001s 2016-12-20 04:14:42 (8.11 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:42.148281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:42.148632) ========= 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.9yEDaaHgih/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.qpcKARTrJz/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.019732 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:42.197096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 04:14:42.197502) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 567894f026558e6dada617a3998f29aed06ac7d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 567894f026558e6dada617a3998f29aed06ac7d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9yEDaaHgih/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.qpcKARTrJz/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-20 04:14:42,281 truncating revision to first 12 chars 2016-12-20 04:14:42,281 Setting DEBUG logging. 2016-12-20 04:14:42,281 attempt 1/10 2016-12-20 04:14:42,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/567894f02655?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 04:14:43,027 unpacking tar archive at: mozilla-central-567894f02655/testing/mozharness/ program finished with exit code 0 elapsedTime=1.013051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 04:14:43.233835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:43.234148) ========= script_repo_revision: 567894f026558e6dada617a3998f29aed06ac7d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:43.234615) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:43.234883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 04:14:43.254848) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-20 04:14:43.255164) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9yEDaaHgih/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.qpcKARTrJz/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:14:43 INFO - MultiFileLogger online at 20161220 04:14:43 in /builds/slave/test 04:14:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:14:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:43 INFO - {'append_to_log': False, 04:14:43 INFO - 'base_work_dir': '/builds/slave/test', 04:14:43 INFO - 'blob_upload_branch': 'Firefox', 04:14:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:43 INFO - 'branch': 'Firefox', 04:14:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:43 INFO - 'config_files': ('talos/mac_config.py',), 04:14:43 INFO - 'default_actions': ('clobber', 04:14:43 INFO - 'read-buildbot-config', 04:14:43 INFO - 'download-and-extract', 04:14:43 INFO - 'populate-webroot', 04:14:43 INFO - 'create-virtualenv', 04:14:43 INFO - 'install', 04:14:43 INFO - 'run-tests'), 04:14:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:43 INFO - 'download_minidump_stackwalk': True, 04:14:43 INFO - 'download_symbols': 'ondemand', 04:14:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:43 INFO - 'installer_path': 'installer.exe', 04:14:43 INFO - 'log_level': 'info', 04:14:43 INFO - 'log_name': 'talos', 04:14:43 INFO - 'log_to_console': True, 04:14:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:14:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:14:43 INFO - 'opt_config_files': (), 04:14:43 INFO - 'pip_index': False, 04:14:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:14:43 INFO - 'cmd': ('bash', 04:14:43 INFO - '-c', 04:14:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:14:43 INFO - 'enabled': True, 04:14:43 INFO - 'halt_on_failure': False, 04:14:43 INFO - 'name': 'check_screen_resolution'},), 04:14:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:14:43 INFO - 'cmd': ('bash', 04:14:43 INFO - '-c', 04:14:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:14:43 INFO - 'enabled': True, 04:14:43 INFO - 'halt_on_failure': False, 04:14:43 INFO - 'name': 'check_screen_resolution'},), 04:14:43 INFO - 'run_cmd_checks_enabled': True, 04:14:43 INFO - 'sps_profile': False, 04:14:43 INFO - 'sps_profile_interval': 0, 04:14:43 INFO - 'suite': 'dromaeojs', 04:14:43 INFO - 'system_bits': '32', 04:14:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:43 INFO - 'title': 't-yosemite-r7-0021', 04:14:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:43 INFO - 'use_talos_json': True, 04:14:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:43 INFO - 'work_dir': 'build'} 04:14:43 INFO - [mozharness: 2016-12-20 12:14:43.455788Z] Running clobber step. 04:14:43 INFO - Running pre-action listener: _resource_record_pre_action 04:14:43 INFO - Running main action method: clobber 04:14:43 INFO - rmtree: /builds/slave/test/build 04:14:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:44 INFO - Running post-action listener: _resource_record_post_action 04:14:44 INFO - [mozharness: 2016-12-20 12:14:44.973508Z] Finished clobber step (success) 04:14:44 INFO - [mozharness: 2016-12-20 12:14:44.973685Z] Running read-buildbot-config step. 04:14:44 INFO - Running pre-action listener: _resource_record_pre_action 04:14:44 INFO - Running main action method: read_buildbot_config 04:14:44 INFO - Using buildbot properties: 04:14:44 INFO - { 04:14:44 INFO - "project": "", 04:14:44 INFO - "product": "firefox", 04:14:44 INFO - "script_repo_revision": "production", 04:14:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:14:44 INFO - "repository": "", 04:14:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:14:44 INFO - "buildid": "20161220030215", 04:14:44 INFO - "stage_platform": "macosx64", 04:14:44 INFO - "basedir": "/builds/slave/test", 04:14:44 INFO - "nightly_build": "True", 04:14:44 INFO - "buildnumber": 88, 04:14:44 INFO - "slavename": "t-yosemite-r7-0021", 04:14:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:14:44 INFO - "platform": "yosemite_r7", 04:14:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:14:44 INFO - "branch": "mozilla-central", 04:14:44 INFO - "repo_path": "mozilla-central", 04:14:44 INFO - "revision": "567894f026558e6dada617a3998f29aed06ac7d8", 04:14:44 INFO - "pgo_build": "False", 04:14:44 INFO - "builduid": "21a18d4cb82344178c4ddf64454bcd5f", 04:14:44 INFO - "slavebuilddir": "test" 04:14:44 INFO - } 04:14:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:14:44 INFO - Running post-action listener: _resource_record_post_action 04:14:44 INFO - [mozharness: 2016-12-20 12:14:44.978508Z] Finished read-buildbot-config step (success) 04:14:44 INFO - [mozharness: 2016-12-20 12:14:44.978659Z] Running download-and-extract step. 04:14:44 INFO - Running pre-action listener: _resource_record_pre_action 04:14:44 INFO - Running main action method: download_and_extract 04:14:44 INFO - mkdir: /builds/slave/test/build/tests 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:44 INFO - trying https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:14:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:14:46 INFO - Downloaded 1199 bytes. 04:14:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:14:46 INFO - Using the following test package requirements: 04:14:46 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:14:46 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:14:46 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:14:46 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'jsshell-mac.zip'], 04:14:46 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:14:46 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:14:46 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:14:46 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:14:46 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:14:46 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:14:46 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:14:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:14:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:14:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:14:46 INFO - Fetch https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:14:47 INFO - Expected file size: 16276025 04:14:47 INFO - Obtained file size: 16276025 04:14:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:14:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:14:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:14:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:14:54 INFO - Expected file size: 16276025 04:14:54 INFO - Obtained file size: 16276025 04:15:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:15:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:15:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:15:01 INFO - Expected file size: 14409734 04:15:01 INFO - Obtained file size: 14409734 04:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:02 INFO - trying https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:15:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:15:04 INFO - Downloaded 69641043 bytes. 04:15:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:15:04 INFO - mkdir: /builds/slave/test/properties 04:15:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:15:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:15:04 INFO - Contents: 04:15:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:15:04 INFO - Running post-action listener: _resource_record_post_action 04:15:04 INFO - Running post-action listener: set_extra_try_arguments 04:15:04 INFO - [mozharness: 2016-12-20 12:15:04.759327Z] Finished download-and-extract step (success) 04:15:04 INFO - [mozharness: 2016-12-20 12:15:04.759481Z] Running populate-webroot step. 04:15:04 INFO - Running pre-action listener: _resource_record_pre_action 04:15:04 INFO - Running main action method: populate_webroot 04:15:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:15:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:15:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:15:04 INFO - '--tppagecycles', 04:15:04 INFO - '7'], 04:15:04 INFO - 'tests': ['tsvgm']}}, 04:15:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:15:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:15:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:15:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:15:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:15:04 INFO - 'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:15:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:15:04 INFO - 'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['damp', 'tps']}, 04:15:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:15:04 INFO - 'tests': ['damp', 'tps']}, 04:15:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['dromaeo_dom']}, 04:15:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:15:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['basic_compositor_video']}, 04:15:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:15:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['a11yr', 04:15:04 INFO - 'ts_paint', 04:15:04 INFO - 'tpaint', 04:15:04 INFO - 'sessionrestore', 04:15:04 INFO - 'sessionrestore_no_auto_restore', 04:15:04 INFO - 'tabpaint']}, 04:15:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:15:04 INFO - 'ts_paint', 04:15:04 INFO - 'tpaint', 04:15:04 INFO - 'sessionrestore', 04:15:04 INFO - 'sessionrestore_no_auto_restore', 04:15:04 INFO - 'tabpaint']}, 04:15:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:15:04 INFO - 'ts_paint', 04:15:04 INFO - 'tpaint', 04:15:04 INFO - 'sessionrestore', 04:15:04 INFO - 'sessionrestore_no_auto_restore', 04:15:04 INFO - 'tabpaint']}, 04:15:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:15:04 INFO - 'ts_paint', 04:15:04 INFO - 'tpaint', 04:15:04 INFO - 'sessionrestore', 04:15:04 INFO - 'sessionrestore_no_auto_restore', 04:15:04 INFO - 'tabpaint']}, 04:15:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['a11yr', 04:15:04 INFO - 'ts_paint', 04:15:04 INFO - 'tpaint', 04:15:04 INFO - 'sessionrestore', 04:15:04 INFO - 'sessionrestore_no_auto_restore', 04:15:04 INFO - 'tabpaint']}, 04:15:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['a11yr', 04:15:04 INFO - 'ts_paint', 04:15:04 INFO - 'tpaint', 04:15:04 INFO - 'sessionrestore', 04:15:04 INFO - 'sessionrestore_no_auto_restore', 04:15:04 INFO - 'tabpaint']}, 04:15:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['tsvgx', 04:15:04 INFO - 'tsvgr_opacity', 04:15:04 INFO - 'tart', 04:15:04 INFO - 'tscrollx', 04:15:04 INFO - 'cart', 04:15:04 INFO - 'tsvg_static']}, 04:15:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:15:04 INFO - 'tsvgr_opacity', 04:15:04 INFO - 'tart', 04:15:04 INFO - 'tscrollx', 04:15:04 INFO - 'cart', 04:15:04 INFO - 'tsvg_static']}, 04:15:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:15:04 INFO - 'talos_options': ['--disable-e10s'], 04:15:04 INFO - 'tests': ['tp5o']}, 04:15:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:15:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:15:04 INFO - 'talos_options': ['--disable-e10s', 04:15:04 INFO - '--xperf_path', 04:15:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:04 INFO - 'tests': ['tp5n']}, 04:15:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:15:04 INFO - 'talos_options': ['--xperf_path', 04:15:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:04 INFO - 'tests': ['tp5n']}}, 04:15:04 INFO - 'talos.zip': {'path': '', 04:15:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:15:04 INFO - Running post-action listener: _resource_record_post_action 04:15:04 INFO - [mozharness: 2016-12-20 12:15:04.777895Z] Finished populate-webroot step (success) 04:15:04 INFO - [mozharness: 2016-12-20 12:15:04.778028Z] Running create-virtualenv step. 04:15:04 INFO - Running pre-action listener: _resource_record_pre_action 04:15:04 INFO - Running main action method: create_virtualenv 04:15:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:15:04 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 04:15:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:15:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:15:04 INFO - Using real prefix '/tools/python27' 04:15:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:15:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:15:08 INFO - Installing pip.................done. 04:15:08 INFO - Return code: 0 04:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:15:08 INFO - Reading from file tmpfile_stdout 04:15:08 INFO - Output received: 04:15:08 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) 04:15:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:08 INFO - 'HOME': '/Users/cltbld', 04:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:08 INFO - 'LOGNAME': 'cltbld', 04:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:08 INFO - 'MOZ_NO_REMOTE': '1', 04:15:08 INFO - 'NO_EM_RESTART': '1', 04:15:08 INFO - 'PAGER': '/bin/cat', 04:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:08 INFO - 'PWD': '/builds/slave/test', 04:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:08 INFO - 'SHELL': '/bin/bash', 04:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:08 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:08 INFO - 'USER': 'cltbld', 04:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:08 INFO - 'XPC_FLAGS': '0x0', 04:15:08 INFO - 'XPC_SERVICE_NAME': '0', 04:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:08 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 04:15:08 INFO - Cleaning up... 04:15:09 INFO - Return code: 0 04:15:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:09 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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:09 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 04:15:09 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 04:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:09 INFO - 'HOME': '/Users/cltbld', 04:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:09 INFO - 'LOGNAME': 'cltbld', 04:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:09 INFO - 'MOZ_NO_REMOTE': '1', 04:15:09 INFO - 'NO_EM_RESTART': '1', 04:15:09 INFO - 'PAGER': '/bin/cat', 04:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:09 INFO - 'PWD': '/builds/slave/test', 04:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:09 INFO - 'SHELL': '/bin/bash', 04:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:09 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:09 INFO - 'USER': 'cltbld', 04:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:09 INFO - 'XPC_FLAGS': '0x0', 04:15:09 INFO - 'XPC_SERVICE_NAME': '0', 04:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:09 INFO - Downloading/unpacking psutil>=3.1.1 04:15:09 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 04:15:09 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 04:15:09 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 04:15:09 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 04:15:09 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 04:15:09 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 04:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:15:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:12 INFO - Installing collected packages: psutil 04:15:12 INFO - Running setup.py install for psutil 04:15:13 INFO - building 'psutil._psutil_osx' extension 04:15:13 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 04:15:13 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 04:15:13 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 04:15:13 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 04:15:13 INFO - building 'psutil._psutil_posix' extension 04:15:13 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 04:15:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:15:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:15:13 INFO - ^ 04:15:13 INFO - 1 warning generated. 04:15:13 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 04:15:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:13 INFO - Successfully installed psutil 04:15:13 INFO - Cleaning up... 04:15:13 INFO - Return code: 0 04:15:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:15: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')]} 04:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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')]} 04:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:15: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 mozsystemmonitor==0.3 04:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:13 INFO - 'HOME': '/Users/cltbld', 04:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:13 INFO - 'LOGNAME': 'cltbld', 04:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:13 INFO - 'MOZ_NO_REMOTE': '1', 04:15:13 INFO - 'NO_EM_RESTART': '1', 04:15:13 INFO - 'PAGER': '/bin/cat', 04:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:13 INFO - 'PWD': '/builds/slave/test', 04:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:13 INFO - 'SHELL': '/bin/bash', 04:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:13 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:13 INFO - 'USER': 'cltbld', 04:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:13 INFO - 'XPC_FLAGS': '0x0', 04:15:13 INFO - 'XPC_SERVICE_NAME': '0', 04:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:15:16 INFO - Installing collected packages: mozsystemmonitor 04:15:16 INFO - Running setup.py install for mozsystemmonitor 04:15:16 INFO - Successfully installed mozsystemmonitor 04:15:16 INFO - Cleaning up... 04:15:17 INFO - Return code: 0 04:15:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:17 INFO - 'HOME': '/Users/cltbld', 04:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:17 INFO - 'LOGNAME': 'cltbld', 04:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:17 INFO - 'MOZ_NO_REMOTE': '1', 04:15:17 INFO - 'NO_EM_RESTART': '1', 04:15:17 INFO - 'PAGER': '/bin/cat', 04:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:17 INFO - 'PWD': '/builds/slave/test', 04:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:17 INFO - 'SHELL': '/bin/bash', 04:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:17 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:17 INFO - 'USER': 'cltbld', 04:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:17 INFO - 'XPC_FLAGS': '0x0', 04:15:17 INFO - 'XPC_SERVICE_NAME': '0', 04:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:15:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:15:20 INFO - warning: no files found matching '*.txt' 04:15:20 INFO - no previously-included directories found matching 'build' 04:15:20 INFO - no previously-included directories found matching 'dist' 04:15:20 INFO - no previously-included directories found matching '.git*' 04:15:20 INFO - Installing collected packages: jsonschema, functools32 04:15:20 INFO - Running setup.py install for functools32 04:15:20 INFO - warning: no files found matching '*.txt' 04:15:20 INFO - no previously-included directories found matching 'build' 04:15:20 INFO - no previously-included directories found matching 'dist' 04:15:20 INFO - no previously-included directories found matching '.git*' 04:15:20 INFO - Successfully installed jsonschema functools32 04:15:20 INFO - Cleaning up... 04:15:20 INFO - Return code: 0 04:15:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:20 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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:20 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 04:15:20 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 04:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:20 INFO - 'HOME': '/Users/cltbld', 04:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:20 INFO - 'LOGNAME': 'cltbld', 04:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:20 INFO - 'MOZ_NO_REMOTE': '1', 04:15:20 INFO - 'NO_EM_RESTART': '1', 04:15:20 INFO - 'PAGER': '/bin/cat', 04:15:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:20 INFO - 'PWD': '/builds/slave/test', 04:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:20 INFO - 'SHELL': '/bin/bash', 04:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:20 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:20 INFO - 'USER': 'cltbld', 04:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:20 INFO - 'XPC_FLAGS': '0x0', 04:15:20 INFO - 'XPC_SERVICE_NAME': '0', 04:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:15:20 INFO - Cleaning up... 04:15:20 INFO - Return code: 0 04:15:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:20 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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:20 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 04:15:20 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 04:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:20 INFO - 'HOME': '/Users/cltbld', 04:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:20 INFO - 'LOGNAME': 'cltbld', 04:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:20 INFO - 'MOZ_NO_REMOTE': '1', 04:15:20 INFO - 'NO_EM_RESTART': '1', 04:15:20 INFO - 'PAGER': '/bin/cat', 04:15:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:20 INFO - 'PWD': '/builds/slave/test', 04:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:20 INFO - 'SHELL': '/bin/bash', 04:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:20 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:20 INFO - 'USER': 'cltbld', 04:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:20 INFO - 'XPC_FLAGS': '0x0', 04:15:20 INFO - 'XPC_SERVICE_NAME': '0', 04:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:15:21 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 04:15:21 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 04:15:21 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 04:15:21 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 04:15:21 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 04:15:21 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 04:15:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:15:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:15:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:24 INFO - Downloading docopt-0.6.1.tar.gz 04:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:15:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:15:25 INFO - Running setup.py install for blobuploader 04:15:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:15:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:15:25 INFO - Running setup.py install for requests 04:15:25 INFO - Running setup.py install for docopt 04:15:25 INFO - Successfully installed blobuploader requests docopt 04:15:25 INFO - Cleaning up... 04:15:25 INFO - Return code: 0 04:15:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15: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')]} 04:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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')]} 04:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:25 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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:25 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 04:15:25 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 04:15:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:25 INFO - 'HOME': '/Users/cltbld', 04:15:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:25 INFO - 'LOGNAME': 'cltbld', 04:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:25 INFO - 'MOZ_NO_REMOTE': '1', 04:15:25 INFO - 'NO_EM_RESTART': '1', 04:15:25 INFO - 'PAGER': '/bin/cat', 04:15:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:25 INFO - 'PWD': '/builds/slave/test', 04:15:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:25 INFO - 'SHELL': '/bin/bash', 04:15:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:25 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:25 INFO - 'USER': 'cltbld', 04:15:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:25 INFO - 'XPC_FLAGS': '0x0', 04:15:25 INFO - 'XPC_SERVICE_NAME': '0', 04:15:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-HzKIcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-CjRshj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-vZlNF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-yeOFDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-MLfQ1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-M9pu3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-c44DWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:26 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-g7XrLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-EAEHVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-A1j7AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Df8osU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-EgNaf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-d4EexH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-CbHrD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-at4YeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-el2DIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:27 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Wq40th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:15:27 INFO - Running setup.py install for manifestparser 04:15:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:15:28 INFO - Running setup.py install for mozcrash 04:15:28 INFO - Running setup.py install for mozdebug 04:15:28 INFO - Running setup.py install for mozdevice 04:15:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:15:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:15:28 INFO - Running setup.py install for mozfile 04:15:28 INFO - Running setup.py install for mozhttpd 04:15:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:15:28 INFO - Running setup.py install for mozinfo 04:15:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:15:28 INFO - Running setup.py install for mozInstall 04:15:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Running setup.py install for mozleak 04:15:29 INFO - Running setup.py install for mozlog 04:15:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Running setup.py install for moznetwork 04:15:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Running setup.py install for mozprocess 04:15:29 INFO - Running setup.py install for mozprofile 04:15:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:15:29 INFO - Running setup.py install for mozrunner 04:15:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:15:30 INFO - Running setup.py install for mozscreenshot 04:15:30 INFO - Running setup.py install for moztest 04:15:30 INFO - Running setup.py install for mozversion 04:15:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:15:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:15:30 INFO - Cleaning up... 04:15:30 INFO - Return code: 0 04:15:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15: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')]} 04:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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')]} 04:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:30 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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:30 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 04:15:30 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 04:15:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:30 INFO - 'HOME': '/Users/cltbld', 04:15:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:30 INFO - 'LOGNAME': 'cltbld', 04:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:30 INFO - 'MOZ_NO_REMOTE': '1', 04:15:30 INFO - 'NO_EM_RESTART': '1', 04:15:30 INFO - 'PAGER': '/bin/cat', 04:15:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:30 INFO - 'PWD': '/builds/slave/test', 04:15:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:30 INFO - 'SHELL': '/bin/bash', 04:15:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:30 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:30 INFO - 'USER': 'cltbld', 04:15:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:30 INFO - 'XPC_FLAGS': '0x0', 04:15:30 INFO - 'XPC_SERVICE_NAME': '0', 04:15:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:30 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-EoNEvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:30 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)) 04:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:30 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-2rIOeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:30 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)) 04:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:30 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-poYTyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-zSexSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-wqBQMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-0COjmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-5y_VoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-e8pDzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-CzSoTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-nyXfFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-6Ua_h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:31 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)) 04:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:31 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-6AmR4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:32 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)) 04:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:32 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-nUWNNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:32 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)) 04:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:32 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ftSeyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:32 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)) 04:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:32 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-yUbhPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:32 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)) 04:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:32 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-n0iNfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:32 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-XvWN7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:32 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)) 04:15:32 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)) 04:15:32 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)) 04:15:32 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)) 04:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:15:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:35 INFO - Downloading blessings-1.6.tar.gz 04:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:15:35 INFO - Installing collected packages: blessings 04:15:35 INFO - Running setup.py install for blessings 04:15:35 INFO - Successfully installed blessings 04:15:35 INFO - Cleaning up... 04:15:35 INFO - Return code: 0 04:15:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:35 INFO - Reading from file tmpfile_stdout 04:15:35 INFO - Current package versions: 04:15:35 INFO - blessings == 1.6 04:15:35 INFO - blobuploader == 1.2.4 04:15:35 INFO - docopt == 0.6.1 04:15:35 INFO - functools32 == 3.2.3-2 04:15:35 INFO - jsonschema == 2.5.1 04:15:35 INFO - manifestparser == 1.1 04:15:35 INFO - mozInstall == 1.12 04:15:35 INFO - mozcrash == 1.0 04:15:35 INFO - mozdebug == 0.1 04:15:35 INFO - mozdevice == 0.49 04:15:35 INFO - mozfile == 1.2 04:15:35 INFO - mozhttpd == 0.7 04:15:35 INFO - mozinfo == 0.9 04:15:35 INFO - mozleak == 0.1 04:15:35 INFO - mozlog == 3.4 04:15:35 INFO - moznetwork == 0.27 04:15:35 INFO - mozprocess == 0.23 04:15:35 INFO - mozprofile == 0.28 04:15:35 INFO - mozrunner == 6.13 04:15:35 INFO - mozscreenshot == 0.1 04:15:35 INFO - mozsystemmonitor == 0.3 04:15:35 INFO - moztest == 0.7 04:15:35 INFO - mozversion == 1.4 04:15:35 INFO - psutil == 3.1.1 04:15:35 INFO - requests == 1.2.3 04:15:35 INFO - wsgiref == 0.1.2 04:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15: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')]} 04:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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')]} 04:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:35 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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:35 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 04:15:35 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 04:15:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:35 INFO - 'HOME': '/Users/cltbld', 04:15:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:35 INFO - 'LOGNAME': 'cltbld', 04:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:35 INFO - 'MOZ_NO_REMOTE': '1', 04:15:35 INFO - 'NO_EM_RESTART': '1', 04:15:35 INFO - 'PAGER': '/bin/cat', 04:15:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:35 INFO - 'PWD': '/builds/slave/test', 04:15:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:35 INFO - 'SHELL': '/bin/bash', 04:15:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:35 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:35 INFO - 'USER': 'cltbld', 04:15:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:35 INFO - 'XPC_FLAGS': '0x0', 04:15:35 INFO - 'XPC_SERVICE_NAME': '0', 04:15:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 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)) 04:15:36 INFO - Cleaning up... 04:15:36 INFO - Return code: 0 04:15:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:15:36 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')]} 04:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:36 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')]} 04:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:36 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 0x106310b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106313768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc112c8a580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, '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.9yEDaaHgih/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.qpcKARTrJz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:15:36 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 04:15:36 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 04:15:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:36 INFO - 'HOME': '/Users/cltbld', 04:15:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:36 INFO - 'LOGNAME': 'cltbld', 04:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:36 INFO - 'MOZ_NO_REMOTE': '1', 04:15:36 INFO - 'NO_EM_RESTART': '1', 04:15:36 INFO - 'PAGER': '/bin/cat', 04:15:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:36 INFO - 'PWD': '/builds/slave/test', 04:15:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:36 INFO - 'SHELL': '/bin/bash', 04:15:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:36 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:36 INFO - 'USER': 'cltbld', 04:15:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:36 INFO - 'XPC_FLAGS': '0x0', 04:15:36 INFO - 'XPC_SERVICE_NAME': '0', 04:15:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:15:36 INFO - Cleaning up... 04:15:36 INFO - Return code: 0 04:15:36 INFO - Running post-action listener: _resource_record_post_action 04:15:36 INFO - Running post-action listener: _start_resource_monitoring 04:15:36 INFO - Starting resource monitoring. 04:15:36 INFO - [mozharness: 2016-12-20 12:15:36.459354Z] Finished create-virtualenv step (success) 04:15:36 INFO - [mozharness: 2016-12-20 12:15:36.460358Z] Running install step. 04:15:36 INFO - Running pre-action listener: _resource_record_pre_action 04:15:36 INFO - Running main action method: install 04:15:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:36 INFO - Reading from file tmpfile_stdout 04:15:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:15:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:15:36 INFO - Reading from file tmpfile_stdout 04:15:36 INFO - Output received: 04:15:36 INFO - Usage: mozinstall [options] installer 04:15:36 INFO - Options: 04:15:36 INFO - -h, --help show this help message and exit 04:15:36 INFO - -d DEST, --destination=DEST 04:15:36 INFO - Directory to install application into. [default: 04:15:36 INFO - "/builds/slave/test"] 04:15:36 INFO - --app=APP Application being installed. [default: firefox] 04:15:36 INFO - mkdir: /builds/slave/test/build/application 04:15:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:15:58 INFO - Reading from file tmpfile_stdout 04:15:58 INFO - Output received: 04:15:58 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:15:58 INFO - Running post-action listener: _resource_record_post_action 04:15:58 INFO - [mozharness: 2016-12-20 12:15:58.615852Z] Finished install step (success) 04:15:58 INFO - [mozharness: 2016-12-20 12:15:58.615992Z] Running run-tests step. 04:15:58 INFO - Running pre-action listener: _resource_record_pre_action 04:15:58 INFO - Running main action method: run_tests 04:15:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:15:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:15:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:15:58 INFO - 2016-12-20 04:15:58.630 screenresolution[2355:15187] starting screenresolution argv=screenresolution get 04:15:58 INFO - 2016-12-20 04:15:58.633 screenresolution[2355:15187] Display 0: 1600x1200x32@60 04:15:58 INFO - 2016-12-20 04:15:58.639 screenresolution[2356:15189] starting screenresolution argv=screenresolution list 04:15:58 INFO - Available Modes on Display 0 04:15:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:15:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:15:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:15:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:15:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:15:58 INFO - Intel Iris: 04:15:58 INFO - Chipset Model: Intel Iris 04:15:58 INFO - Type: GPU 04:15:58 INFO - Bus: Built-In 04:15:58 INFO - VRAM (Dynamic, Max): 1536 MB 04:15:58 INFO - Vendor: Intel (0x8086) 04:15:58 INFO - Device ID: 0x0a2e 04:15:58 INFO - Revision ID: 0x0009 04:15:58 INFO - Displays: 04:15:58 INFO - Display: 04:15:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:15:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:15:58 INFO - Display Serial Number: 1600x1200 60 04:15:58 INFO - Main Display: Yes 04:15:58 INFO - Mirror: Off 04:15:58 INFO - Online: Yes 04:15:58 INFO - Rotation: Supported 04:15:58 INFO - Return code: 0 04:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:58 INFO - Python 2.7.3 04:15:58 INFO - Return code: 0 04:15:58 INFO - grabbing minidump binary from tooltool 04:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:58 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 0x1060eed30>, '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 0x106015db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060e3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:58 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 04:15:58 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 04:15:58 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 04:15:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:58 INFO - Return code: 0 04:15:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:15:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:15:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 04:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --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 04:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9yEDaaHgih/Render', 04:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:58 INFO - 'HOME': '/Users/cltbld', 04:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:58 INFO - 'LOGNAME': 'cltbld', 04:15:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:58 INFO - 'MOZ_NO_REMOTE': '1', 04:15:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:58 INFO - 'NO_EM_RESTART': '1', 04:15:58 INFO - 'PAGER': '/bin/cat', 04:15:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:58 INFO - 'PWD': '/builds/slave/test', 04:15:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:59 INFO - 'SHELL': '/bin/bash', 04:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qpcKARTrJz/Listeners', 04:15:59 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:59 INFO - 'USER': 'cltbld', 04:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:59 INFO - 'XPC_FLAGS': '0x0', 04:15:59 INFO - 'XPC_SERVICE_NAME': '0', 04:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 04:15:59 INFO - mozversion application_buildid: 20161220030215 04:15:59 INFO - mozversion application_changeset: 567894f026558e6dada617a3998f29aed06ac7d8 04:15:59 INFO - mozversion application_display_name: Nightly 04:15:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:59 INFO - mozversion application_name: Firefox 04:15:59 INFO - mozversion application_remotingname: firefox 04:15:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:15:59 INFO - mozversion application_vendor: Mozilla 04:15:59 INFO - mozversion application_version: 53.0a1 04:15:59 INFO - mozversion platform_buildid: 20161220030215 04:15:59 INFO - mozversion platform_changeset: 567894f026558e6dada617a3998f29aed06ac7d8 04:15:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:15:59 INFO - mozversion platform_version: 53.0a1 04:15:59 INFO - using testdate: 1482236159 04:15:59 INFO - actual date: 1482236159 04:15:59 INFO - starting webserver on 'localhost:50868' 04:15:59 INFO - SUITE-START | Running 2 tests 04:15:59 INFO - TEST-START | dromaeo_css 04:15:59 INFO - operating with platform_type : mac_ 04:15:59 INFO - Initialising browser for dromaeo_css test... 04:15:59 INFO - TEST-INFO | started process 2366 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmp0hLrHK/profile http://localhost:50868/getInfo.html) 04:16:01 INFO - PROCESS | 2366 | __metrics Screen width/height:1600/1200 04:16:01 INFO - PROCESS | 2366 | colorDepth:24 04:16:01 INFO - PROCESS | 2366 | Browser inner width/height: 1024/689 04:16:01 INFO - PROCESS | 2366 | __metrics 04:16:01 INFO - PROCESS | 2366 | 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" 04:16:01 INFO - PROCESS | 2366 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:02 INFO - TEST-INFO | 2366: exit 0 04:16:02 INFO - Browser initialized. 04:16:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:16:02 INFO - TEST-INFO | started process 2370 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmp0hLrHK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:14 INFO - PROCESS | 2370 | RSS: Main: 237400064 04:16:14 INFO - PROCESS | 2370 | 04:17:05 INFO - PROCESS | 2370 | 1482236225429 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:19:18 INFO - PROCESS | 2370 | Cycle 1(1): loaded http://localhost:50868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50868/tests/dromaeo/cssquery-ext.html) 04:19:20 INFO - PROCESS | 2370 | RSS: Main: 377917440 04:19:20 INFO - PROCESS | 2370 | 04:22:23 INFO - PROCESS | 2370 | Cycle 1(1): loaded http://localhost:50868/tests/dromaeo/cssquery-ext.html (next: http://localhost:50868/tests/dromaeo/cssquery-jquery.html) 04:22:23 INFO - PROCESS | 2370 | RSS: Main: 375877632 04:22:23 INFO - PROCESS | 2370 | 04:25:26 INFO - PROCESS | 2370 | Cycle 1(1): loaded http://localhost:50868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50868/tests/dromaeo/cssquery-mootools.html) 04:25:26 INFO - PROCESS | 2370 | RSS: Main: 345051136 04:25:26 INFO - PROCESS | 2370 | 04:28:29 INFO - PROCESS | 2370 | Cycle 1(1): loaded http://localhost:50868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50868/tests/dromaeo/cssquery-prototype.html) 04:28:29 INFO - PROCESS | 2370 | RSS: Main: 342818816 04:28:29 INFO - PROCESS | 2370 | 04:31:33 INFO - PROCESS | 2370 | Cycle 1(1): loaded http://localhost:50868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50868/tests/dromaeo/cssquery-yui.html) 04:31:34 INFO - PROCESS | 2370 | RSS: Main: 332619776 04:31:34 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | Cycle 1(1): loaded http://localhost:50868/tests/dromaeo/cssquery-yui.html (next: http://localhost:50868/tests/dromaeo/cssquery-dojo.html) 04:34:37 INFO - PROCESS | 2370 | RSS: Main: 395177984 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | __start_tp_report 04:34:37 INFO - PROCESS | 2370 | _x_x_mozilla_page_load 04:34:37 INFO - PROCESS | 2370 | _x_x_mozilla_page_load_details 04:34:37 INFO - PROCESS | 2370 | |i|pagename|runs| 04:34:37 INFO - PROCESS | 2370 | |0;dojo.html;3281.1469018055304;3331.8000919944807;3333.833308334583;3369.5956485221777;3387.424137896557;5597.832065038046;5687.289088863892;5709.71451427429;5797.507211886989;5813.825585232445;5702.087665973445;5702.173184888189;5712.257406537145;5720.342160651527;5733;5121.206213036976;5133.691978481284;5147.227915812639;5168.9224661630105;5175.689458632475;5208.609354298424;5219.217117432378;5258.658187217838;5265.157574788034;5271.710055946922;5258.07983602868;5276;5279.366476022883;5299;5313.495217954288;5266.762995665185;5276.947230527703;5290.550303224192;5292.682439053669;5334.333208348957;4139.254934111858;5085.516875896784;5133.332666753336;5154.4587818278915;5179.507946745053;4292.656587472995;5714.971425142848;5786.5370770338695;5802.245708057968;5807.506361959238;6102.145699602059;6137.41694539018;6141.263048434172;6141.4472697456995;6150.446459818638;6018.548608854353;6120.877582448326;6139.058058263096;6146.801373732079;6170.19787427636;5810.506106980912;5820.563457740686;5822.505087067647;5832.679202643895;5840.503557197686;6116.284046402188;6125.876495711655;6142.468080853527;6148.815535533941;6162.198914141133;6119.837693858701;6126.754929802758;6136.048912418493;6144.8771024579255;6154.630722156685;6126.12970700902;6141.170941922873;6155.692215389213;6166.907496387557;6171.506279497629;6097.908531372033;6107.7278715418815;6112.388761123852;6120.872274143302;6123.663198524035;6118.694065296718;6134.069235337315;6145;6150;6155.692215389213;4943.283223932582;4953.975230123826;4956.207006878882;4956.851294461172;4990.426100998359;3728.906777330534;4417.160739459492;4450.5104438511735;4457.8439754608435;4494.685372023992;5665.518430933417;5747.195392645033;5747.942520574741;5799.623024503394;5896.64620122794;6127.2647282325515;6141.539384546177;6147.5553244987395;6165.938340616626;6170.043643235305;5805;5894.646321220741;5897.380775018647;5899.4985426239255;5949;5344.171653393731;5379.220013098079;5391.595630327741;5450.618456707993;5456.181572764117;6220.253569571771;6224.097505861715;6253.155823963707;6278;6348.174737284124;6233.345498722751;6236.844078897882;6238.500919926486;6245.7189426476825;6255.437010669061;5926.585139040226;6313.179286692701;6334.556581039283;6336.20797400325;6347.079673447417;6059.606125601822;6122.001753127661;6136.171616831849;6142.293636231891;6144.941444616104;6119;6126.426068710427;6182.907256391248;6246.875062498815;6247.843803904757;4896.926546101882;5999.700014999145;6132.264128304632;6152;6155.969220153871;5944.138099975566;6009.098635204754;6105.9084113737445;6115.205023346936;6119.296280927751;5924.703764811656;5940.6435613863305;5991.310999234969;6033.396660333931;6085.391460853879;6120.296165940974;6121.602095863755;6124.693765311806;6129.387061294014;6143.385661433999;5814.447627475383;5944.851378715567;5959.106134079922;5995.310539288038;6013.939860601338 04:34:37 INFO - PROCESS | 2370 | |1;ext.html;428.24414907687924;439.38924894396774;458.95639914208147;483.16171442547176;503.27025812571736;24657;34132.82933585332;38951.415728764056;41121.58878411215;41240.79379603105;41779.58220417803;42252.73241802743;42269.78865105678;42314.365284520754;42337.364939525934;8459.788505287386;9304.81390372192;9512.191463725592;9526.333156679035;9551.61793528258;8620.09489003655;11205.551777928873;11483.885161148366;11494.885051149466;11659.825102623425;11409.942950285236;11468.885311146865;11470.655880323562;11496.482658280398;11500.65498035056;11398.601048963288;11463.426828658534;11473.196876218584;11485.827712584276;11496.252743571724;11294;11299.265547739371;11337.716557086056;11354.943225283821;11373.31760094397;39357.80321098376;39733.60266397357;39747.60252397468;39780.801095994626;39813;2863.0981240909255;3342.96657033429;3408.454647256452;3436.6563343665434;3476.7566270361085;30283.697163028308;30618.38763224723;30739.538906916416;30800.38399232003;30859.845700771577;3106.8446577671025;3212.9678703212903;3248.220427097503;3253.96746032539;3323.4682450807995;474307;475332;475711;476317;477114.9999999965;48367.27449088196;57241.427585723606;57854;58314;58565.70717146387;62791.372086279465;62964.55531670286;62980.05529917055;63229;63240.367596324366;15630.218489075502;15838.049717016786;15848.76226856598;15858.60353491172;15867.12730799794;11162.832557511643;11269.09847212221;11284.605038823602;12153.270803751802;12324.383780810924;14270.286485675675;16605.67154627627;16917.407890723767;16964.83035169657;17390.739138912926;6353.475165960229;6518.608883467007;6561.606303621798;6576.572522786099;6581.86836263272;898.9460632362079;967.2927283344902;972.439284562518;997.4264797741328;1023;29345.82616695351;29584;29838.955636552615;29867.691802070487;30179.698203018128;951.8762560867043;961.4087336288133;1108.7616162525096;1109.4674556213063;1182.8994535464583;14563.344649490798;15130.697386052218;15212.771808422882;15549.30028148736;15633.452829150925;607311;611058.9447052826;611214.9439252864;611676;611721;57701.55746106381;57957.420425796045;58023;58134;58161.70919145462;1319.8350206224222;1373.8557451467452;1384.1210831122512;1388.465440805277;1391.6451304917384;28331.716682833732;29005.7099429003;29138;29606.555901661923;29850.552241715955;50480.990380191455;50947;50957;51027;51083.74458127686;530792;532361.3381933066;533324;533671;538803;33253.50119748157;33474.66525334716;34058.318833622696;39223.60776392314;39596.2080758389;38838.4464621412;42287.73136805901;47687;47715.522844772495;48845.77885552889;39165;39510.604893950695;39539.80230098831;39624.60375396209;40744;39190.2161956765;39208.80395598004;40438.59561404349;40815.77552673424;40922;37358.813205933795;38207.808960955015;38616;38652.03369915775;38821.6117838818;30523.694763052084;33600.663993359754;34161.80433684908;34952.475712864834;35249.82375088108;25553.850076746963;25651.35871603225;25658.743412565636;25697.229083127535;26141 04:34:37 INFO - PROCESS | 2370 | |2;jquery.html;356.2785359646717;371.3408699558284;372.57154272586524;382.68237362988714;405.6268233225432;14624.561263162095;14776.408943642255;15940.68118637628;19277.325293614726;20094.397168084943;19304.227830886746;19601.70597441036;20029;20513.692294615594;20525.384238472834;5491.093969495048;5790.7104644767805;5910.379410161936;5956.55325850563;5966.254218222723;5586.078297080977;5909.586328956974;5942.970285148568;5951.345352011275;6028.3067447243475;5737.7991770288045;5890.410958904118;5893.528517718572;5897.616654917438;5904.291485021803;5940.940590594082;5963.880722385549;6008.519318454557;6120.816375508742;6121.816345509664;5749.856253593652;5779.33537643168;5792.362840087587;5869.413058694096;5902.852428689274;13250.271235082068;13252.602421927357;13310.933445332712;13472.056956013083;13500;2285.5771682238837;2297.322289924476;2654.3231475973503;2699.1362763915554;2816.478951393978;10507.684769456851;15029.549113526611;15817;15981.84018159815;16031.679366412724;1830.4508647405726;1863.9720404193947;1887.981120188808;1891.1300801631266;1901.6481950839138;70174.64912675455;105074;115302;116869;120358;11099.83350249747;11333.773324533628;11382.658520244406;11482.138839587064;11635.76728465426;14374.928125359516;14392.280385980659;14397.640058998399;14416.567502974927;14418.639534011523;8103.797405064921;8373.330133589297;8406.873896891551;8486.151384861465;8552.572371381406;8227.341812654973;8235.95882020598;8245.422820402515;8380.491511527984;8412.579371031425;4453.398791163151;4480.663950203748;4492.483364413134;4498.437695288089;4596.47140578831;1856.1461727605183;1895.8862468251948;1905.7046157845557;1907.4563749331373;1923.740295060177;738.346563291491;766.5056038855018;846.124261389459;935.2798345274101;1004.834202356603;16257.593560160854;17509.98998522582;17948;18770.155343009596;20680.379588612366;881.5460038080394;894.7763059235191;938.8497840345512;952.9666461673808;974.9122578967927;7747.95402620639;8283.25450709439;10875.891241087646;10886.836697449544;10943.28868623537;318377;322881;549823;556156;567583;125230.37384813017;132137;134598.81017847205;134614.65385346216;140162;982.1749730226644;1007.9344842585208;1033.2921948465325;1033.9327943683636;1034.4103860799273;18313.633727325647;18581.90709046446;18804.623907522047;18813.623727525646;19172.424827255203;53340;53957.19064213961;55086.72456637691;55499.89000220054;55856.6035849107;74244;78444;78840.60579697065;80043.59978200072;81243;7882.960585197037;7988.720394786154;8025.5585942773705;8182;8201.13888041747;10363.854458216774;12485.687857803627;12767.680807979876;12797.936010319889;12932.547360842325;8424.213295808782;10469.895301046892;11008.944955275172;11086.057685096857;11113.611023614134;10276.486175691334;10802.67591972242;10905.945470272598;11085.833712494157;11263;8491.872621910552;8935.28517718568;10017.499125043865;10602.09882160025;10945.726356841144;7846.097698764487;7917.445778795429;7920.207979202034;7930.167332430012;8079.232472915299;10066.094051535398;10944.288621239593;10957.616483423042;11061.83407248908;11219.943900280772 04:34:37 INFO - PROCESS | 2370 | |3;mootools.html;1328.528372427788;1340.6045216661084;1513.916734579598;1677.3290683726507;1896.7818700849398;7448.36688881445;7867.763967080997;7871.685132594689;7883.487573307731;7886.250806173412;7665.540067595948;7947.602619869012;8188.54962977036;8206.876896846537;8277.503349799017;1971.5366888781125;2256.9843570393305;2265.286434773045;2295.4031951692514;2309.607366747657;2226.588081204974;2326.2788535553946;2345.3081341004445;2355.8822058896985;2359.6578496118054;2003.1786967343392;2061.5052387426986;2138.5509043100888;2245.2253972379503;2320.6519022146726;2307.377008207783;2323.94190145246;2332.8017118544944;2333.673285739998;2333.8716370599527;1868;1976.6145601607693;2314.259436980167;2326.0811979268265;2349.800266977309;8436.282915952152;8510.319174466027;8515;8523.57382130891;8538.786530336729;4200.285951388271;5207.6354655174155;5212.061828870802;5221.451747566489;5224.63427560071;3320.6015278166533;3490.965090349089;3567.23304489536;3568.7858728476117;3581.3732596795458;1006.7382480555035;1044.8537204791335;1082.5615625671537;1090.9890901090967;1092.159037541097;10758.256644555666;11048.281861678965;11060.115190784718;11081.944590277159;11100.44497775108;4331.436913201263;4550.681452298308;4617.653675974316;4626.953730462719;4674.76626168697;9416.529173541296;9429.528523573794;9437.056294370508;9449.007854175212;9469.763255918657;5144.331236939174;5217.556507696812;5242.5281724644965;5244.606654500928;5245.790168393298;4587.3807036050375;4721.929171062437;4779.378680771478;4792.808287668524;4799.304100905419;3665.6700896919406;3755.286495565834;3762.5861155272896;3765.039914821703;3856.267309211241;1268.8858002779793;1272.9490820367082;1273.0961017677553;1278.6355888571898;1281.826953361303;751.3838652305058;771.5139462138817;836.1513064239801;881.8236352729351;898.5686870302292;4852.320675105488;5241.842744717588;5361.624686271924;5585.413531579207;5709.800156994485;359.4392747314198;418.8513077857378;424.9447571815644;431.2776100032433;438.18060227375014;3593.6047034826147;3708.554973403209;3762.1535154589997;3774.358359078963;3783.754055986352;8137;10123.898761012442;10266.743331416774;10268.383896966207;10294.279400442047;9785.559649815776;9899.653512127185;9970.950145249373;10216.722909636295;10233.590656373663;7240.058792357066;7789.805254868674;7934.960325198337;7935.563544005136;7940.563269020144;5114.616403769806;5418.133098704188;5427.1316589345515;5521.585881059017;5549.833504994856;9358.251339892928;9510.286728495252;9536.33245672824;9564;9585.9041409585;9473.384230025302;9507.809843803223;9580.946095929303;9698.127168554864;9739.318247722875;7073.363397294268;7209.963950180216;7213.531120477152;7217.386522145676;7240.022596949555;6518.706658200297;7870.016247969004;7872.606369681607;7891.250331218525;7907.446478746432;6857.691403886937;7048.400885924754;7158.141023077264;7233.819154520968;7284.307990740871;6812.8978065328065;6988.860222795617;7017.543859649107;7025.683844227125;7032.753853615303;5150.613703972292;5170.302009228856;6490.350964903472;6507.609543427409;6635.469162467088;4653.604443622195;4698.624110071118;4709.5290470954005;4801.327814105958;4804.25534042224;4570.862874113782;4646.93029604563;4743.691660042086;4792.832250871203;4979.526944940225 04:34:37 INFO - PROCESS | 2370 | |4;prototype.html;296.7077428732699;352.34288052781557;356.611293689878;363.36411280259546;374.51313292719476;4637.837675681352;4839.177339852225;4952.380952380952;5314.627976041674;5463.808766693167;5186.0665080285535;5401.945980540193;5412.431694672062;5420.783168673248;5424.701641409721;3880.1075752576785;3928.0376307804486;4198.3702444633245;4242.984582323387;4265.573442655726;3586.8027258500774;3633.6003039665616;3879.72841901067;3947.822347994347;4122.299209134454;3978.542467616218;4164.729292595972;4183.686223533232;4189.392538081976;4206.768627725474;3443.741719371057;3810.0759116646054;4153.460050193486;4159.3968874513175;4189.120284740208;3372.7470439717117;3510.280392519527;3688.2623475304777;3688.354537955847;3691.446283057536;3949.6445319921345;4635.8642132677705;5162.270639335827;5262.8684282892855;5286.3392075990505;4339;4485.730856148642;4485.753283569403;4897.265410188465;4897.755112244409;4625.722456652612;4995.750212489361;5688.516476099495;5695.45893140151;5725.568607848038;4055.2497787909333;4122.299209134454;4134.193832202722;4141.7574727581605;4149.2531344358;5903.911441328383;5940.554458415593;5945.64326140433;5979.970100149515;5991.7902873399225;3987.5613682494904;4222.577742225752;4230.70385073042;4232.4286221360335;4243.787810609457;3793.79134147619;4241.109367032957;4260.573942605714;4279.572042795758;4281.565675498743;4562.384078149474;4661.743604101807;4717.5046620104395;4746.454157771831;4813.638977076734;5408.296921400193;5727.828165155052;5730.2208428911945;5734.369219385864;5739.512141468022;1300.6423233610833;1383.481194552043;1385.6674398144573;1389.4720006397706;1405.9086159399606;833.8165603567205;987.2151639446657;1003.4130033930232;1003.7490627343165;1042.8122937871103;4163.292240319092;4894.755262236945;5050.444451110375;5105.591552675852;5112.821051263262;4704.811807527729;5048.5203905628905;5436.994156081138;5655.745491452894;5695.206010106803;4259.574042595777;4448.755318457516;4852.4662287148385;5046.772895219724;5165.9225111623355;2351.4826738117586;2913.927151821179;2914.285999930031;2929.311611771232;2946.543285790706;5386.569074474032;5731.423858438962;5761.452661997104;5787.006965194003;5800.143953934785;4890.902181956412;5393.325834270716;6019.097135429721;6023.488003519662;6069.241344831896;5296;5871.324797648325;5900.380460051632;6112.7554897804475;6151.2618485781995;5126.718899904139;5538.307711536058;5886.205362276038;5916.970415147896;5958.880822383441;5177.663451875616;5418.701971391612;5817.389174136655;5854.560907931837;5855.7364918579615;5541.612087153861;5818.854528636649;6034.577579569388;6039;6112.358202388685;3663.487111804296;3795.2978698940783;3864.3623802072343;3882.650561449483;3972.245273398045;4935.481774413634;5098.113697931789;5570.693611851387;5775.170166618411;5928.584999050025;4905.99427117433;5153.778888194878;5655.236543066633;5778;5817.098349755625;4688.601468875184;4840.854774356775;5740.39725828782;5762.250907382014;5802.187693722798;5165.199394093921;5363.597730170331;5551.472610102034;5608.298522974817;5610.915836262541;5704.942950570441;5717.828465146053;5728.713564321851;5754.395788442153;5781.901438726629;4826.300186473012;5289.550388217045;5372.811951581676;5561.888762224814;5596.804111856066 04:34:37 INFO - PROCESS | 2370 | |5;yui.html;619.8698273362594;710.8329542557495;724.855028994201;734.4051318432071;843.5276245302629;13096.214227146365;14805.555833325005;15421.460248891291;15887.68224635508;16184.514464566082;13257.602271931833;13513;14727.337269822858;14739.852601473982;15046.398144074225;839.2991851803752;873.3711727556149;874.5364956573027;876.5441970175505;877.2718643525858;675.1358261425383;698.6855914838318;865.8354912566624;871.3203701113142;871.337783284705;659.1694464974144;734.4454936522944;736.4219088015908;737.2664199121881;882.6337070115894;906.5557876640431;909.3589019741099;911.7219248129318;911.8495448251031;912.0013585124278;669.1501792723263;678.762433148399;678.8065401360637;680.5950459476653;682.0723815610766;11159.776804463947;15016.624584385478;15384.538463845991;15442.150681712614;15446.304916278794;13603.863961360457;13749;13915.721685566232;14029.508967186202;14208.14751114926;11335.65436783264;11693.766124677544;11716.94141529287;11764.41177941108;12240;3313.9171520711934;3621;3653.1049892776173;3660.249648821985;3701.0932321581117;98077.5096124522;103076.48461757643;103128;103994.48002760013;104358;10444.791104177873;10496.842547361795;10518.526666300035;10743.51654175564;10800.405977671304;21118.260860869796;21190;21233.575328493345;21321.466963326042;21341.78658213429;7557.848843023219;7615.16233214346;7708.653110610036;7723.073231212291;7867.370610351159;4247.384129301234;4323.54602766705;4328.350747387917;4383.649308055348;4392.472903251631;3438.054535002894;3530.011596752913;3533.611302756695;3533.7703049301713;3542.574891013095;612.8835521250948;627.3475585391142;639.7409049334934;639.9456046236029;641.4291280760127;540.497337476151;543.8694713268866;566.8962430691929;571.2117278156118;571.7198572699348;7935.761927142195;8489.75939550604;9112;9126.680566180152;9406.670766523139;568.6076607141059;597.8804239152187;622.5579838314757;641.3105911145444;661.2825084782968;4408.25059739845;4477.485089214717;4512.842050528281;4544.590986811203;4637.559431853969;92057.87363390022;94889.05110948802;96606.03393966111;102628;112658.43670781757;87250;91018.63472047924;91262;92942.53528732313;93805;81777.18222817815;81848.59075704584;82141.58929205436;82654;89495.55252223698;8826;9395.007840826387;9863.556139973862;10033;10117.898821011695;54517.909641806145;55049.1742623869;55106;55843;56223.71888140533;62095;77061;77074.45851082835;79171.60414197893;81154.78267826105;13577.524786632815;13584.388702508608;13715.588532344045;13781.035327526977;14225.430982760574;14642.487512936996;14710.852891470948;14758.262086895398;15299.694006120038;15316.081035137928;13503.12229705066;13750.587482375544;13814.516491922734;13824.447022119002;14273.286335683382;13635.79546306826;13869.86130138726;13894.791578126538;13976.161430314214;14196.858031419553;11059.557617695524;13138;13238.735225295633;13522.93238533801;13548.32258387057;9179.541022948692;11116.833247501132;11507.136964727846;11524.308541487537;11668.90522236054;11219.2146549744;11221.438928053727;11394.544218231178;11481.196316257781;11520 04:34:37 INFO - PROCESS | 2370 | __end_tp_report 04:34:37 INFO - PROCESS | 2370 | __start_cc_report 04:34:37 INFO - PROCESS | 2370 | _x_x_mozilla_cycle_collect,1368 04:34:37 INFO - PROCESS | 2370 | __end_cc_report 04:34:37 INFO - PROCESS | 2370 | __startTimestamp1482237277876__endTimestamp 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | ------- Summary: start ------- 04:34:37 INFO - PROCESS | 2370 | Number of tests: 6 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | [#0] dojo.html Cycles:165 Average:5711.22 Median:5959.11 stddev:651.17 (10.9%) stddev-sans-first:624.64 04:34:37 INFO - PROCESS | 2370 | Values: 3281.1 3331.8 3333.8 3369.6 3387.4 5597.8 5687.3 5709.7 5797.5 5813.8 5702.1 5702.2 5712.3 5720.3 5733.0 5121.2 5133.7 5147.2 5168.9 5175.7 5208.6 5219.2 5258.7 5265.2 5271.7 5258.1 5276.0 5279.4 5299.0 5313.5 5266.8 5276.9 5290.6 5292.7 5334.3 4139.3 5085.5 5133.3 5154.5 5179.5 4292.7 5715.0 5786.5 5802.2 5807.5 6102.1 6137.4 6141.3 6141.4 6150.4 6018.5 6120.9 6139.1 6146.8 6170.2 5810.5 5820.6 5822.5 5832.7 5840.5 6116.3 6125.9 6142.5 6148.8 6162.2 6119.8 6126.8 6136.0 6144.9 6154.6 6126.1 6141.2 6155.7 6166.9 6171.5 6097.9 6107.7 6112.4 6120.9 6123.7 6118.7 6134.1 6145.0 6150.0 6155.7 4943.3 4954.0 4956.2 4956.9 4990.4 3728.9 4417.2 4450.5 4457.8 4494.7 5665.5 5747.2 5747.9 5799.6 5896.6 6127.3 6141.5 6147.6 6165.9 6170.0 5805.0 5894.6 5897.4 5899.5 5949.0 5344.2 5379.2 5391.6 5450.6 5456.2 6220.3 6224.1 6253.2 6278.0 6348.2 6233.3 6236.8 6238.5 6245.7 6255.4 5926.6 6313.2 6334.6 6336.2 6347.1 6059.6 6122.0 6136.2 6142.3 6144.9 6119.0 6126.4 6182.9 6246.9 6247.8 4896.9 5999.7 6132.3 6152.0 6156.0 5944.1 6009.1 6105.9 6115.2 6119.3 5924.7 5940.6 5991.3 6033.4 6085.4 6120.3 6121.6 6124.7 6129.4 6143.4 5814.4 5944.9 5959.1 5995.3 6013.9 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | [#1] ext.html Cycles:180 Average:67908.29 Median:38634.02 stddev:144731.89 (374.6%) stddev-sans-first:145049.22 04:34:37 INFO - PROCESS | 2370 | Values: 428.2 439.4 459.0 483.2 503.3 24657.0 34132.8 38951.4 41121.6 41240.8 41779.6 42252.7 42269.8 42314.4 42337.4 8459.8 9304.8 9512.2 9526.3 9551.6 8620.1 11205.6 11483.9 11494.9 11659.8 11409.9 11468.9 11470.7 11496.5 11500.7 11398.6 11463.4 11473.2 11485.8 11496.3 11294.0 11299.3 11337.7 11354.9 11373.3 39357.8 39733.6 39747.6 39780.8 39813.0 2863.1 3343.0 3408.5 3436.7 3476.8 30283.7 30618.4 30739.5 30800.4 30859.8 3106.8 3213.0 3248.2 3254.0 3323.5 474307.0 475332.0 475711.0 476317.0 477115.0 48367.3 57241.4 57854.0 58314.0 58565.7 62791.4 62964.6 62980.1 63229.0 63240.4 15630.2 15838.0 15848.8 15858.6 15867.1 11162.8 11269.1 11284.6 12153.3 12324.4 14270.3 16605.7 16917.4 16964.8 17390.7 6353.5 6518.6 6561.6 6576.6 6581.9 898.9 967.3 972.4 997.4 1023.0 29345.8 29584.0 29839.0 29867.7 30179.7 951.9 961.4 1108.8 1109.5 1182.9 14563.3 15130.7 15212.8 15549.3 15633.5 607311.0 611058.9 611214.9 611676.0 611721.0 57701.6 57957.4 58023.0 58134.0 58161.7 1319.8 1373.9 1384.1 1388.5 1391.6 28331.7 29005.7 29138.0 29606.6 29850.6 50481.0 50947.0 50957.0 51027.0 51083.7 530792.0 532361.3 533324.0 533671.0 538803.0 33253.5 33474.7 34058.3 39223.6 39596.2 38838.4 42287.7 47687.0 47715.5 48845.8 39165.0 39510.6 39539.8 39624.6 40744.0 39190.2 39208.8 40438.6 40815.8 40922.0 37358.8 38207.8 38616.0 38652.0 38821.6 30523.7 33600.7 34161.8 34952.5 35249.8 25553.9 25651.4 25658.7 25697.2 26141.0 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | [#2] jquery.html Cycles:180 Average:30638.03 Median:2475.82 stddev:81162.51 (3278.2%) stddev-sans-first:81358.34 04:34:37 INFO - PROCESS | 2370 | Values: 356.3 371.3 372.6 382.7 405.6 14624.6 14776.4 15940.7 19277.3 20094.4 19304.2 19601.7 20029.0 20513.7 20525.4 5491.1 5790.7 5910.4 5956.6 5966.3 5586.1 5909.6 5943.0 5951.3 6028.3 5737.8 5890.4 5893.5 5897.6 5904.3 5940.9 5963.9 6008.5 6120.8 6121.8 5749.9 5779.3 5792.4 5869.4 5902.9 13250.3 13252.6 13310.9 13472.1 13500.0 2285.6 2297.3 2654.3 2699.1 2816.5 10507.7 15029.5 15817.0 15981.8 16031.7 1830.5 1864.0 1888.0 1891.1 1901.6 70174.6 105074.0 115302.0 116869.0 120358.0 11099.8 11333.8 11382.7 11482.1 11635.8 14374.9 14392.3 14397.6 14416.6 14418.6 8103.8 8373.3 8406.9 8486.2 8552.6 8227.3 8236.0 8245.4 8380.5 8412.6 4453.4 4480.7 4492.5 4498.4 4596.5 1856.1 1895.9 1905.7 1907.5 1923.7 738.3 766.5 846.1 935.3 1004.8 16257.6 17510.0 17948.0 18770.2 20680.4 881.5 894.8 938.8 953.0 974.9 7748.0 8283.3 10875.9 10886.8 10943.3 318377.0 322881.0 549823.0 556156.0 567583.0 125230.4 132137.0 134598.8 134614.7 140162.0 982.2 1007.9 1033.3 1033.9 1034.4 18313.6 18581.9 18804.6 18813.6 19172.4 53340.0 53957.2 55086.7 55499.9 55856.6 74244.0 78444.0 78840.6 80043.6 81243.0 7883.0 7988.7 8025.6 8182.0 8201.1 10363.9 12485.7 12767.7 12797.9 12932.5 8424.2 10469.9 11008.9 11086.1 11113.6 10276.5 10802.7 10905.9 11085.8 11263.0 8491.9 8935.3 10017.5 10602.1 10945.7 7846.1 7917.4 7920.2 7930.2 8079.2 10066.1 10944.3 10957.6 11061.8 11219.9 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | [#3] mootools.html Cycles:180 Average:5374.62 Median:4828.29 stddev:3012.91 (62.4%) stddev-sans-first:3006.01 04:34:37 INFO - PROCESS | 2370 | Values: 1328.5 1340.6 1513.9 1677.3 1896.8 7448.4 7867.8 7871.7 7883.5 7886.3 7665.5 7947.6 8188.5 8206.9 8277.5 1971.5 2257.0 2265.3 2295.4 2309.6 2226.6 2326.3 2345.3 2355.9 2359.7 2003.2 2061.5 2138.6 2245.2 2320.7 2307.4 2323.9 2332.8 2333.7 2333.9 1868.0 1976.6 2314.3 2326.1 2349.8 8436.3 8510.3 8515.0 8523.6 8538.8 4200.3 5207.6 5212.1 5221.5 5224.6 3320.6 3491.0 3567.2 3568.8 3581.4 1006.7 1044.9 1082.6 1091.0 1092.2 10758.3 11048.3 11060.1 11081.9 11100.4 4331.4 4550.7 4617.7 4627.0 4674.8 9416.5 9429.5 9437.1 9449.0 9469.8 5144.3 5217.6 5242.5 5244.6 5245.8 4587.4 4721.9 4779.4 4792.8 4799.3 3665.7 3755.3 3762.6 3765.0 3856.3 1268.9 1272.9 1273.1 1278.6 1281.8 751.4 771.5 836.2 881.8 898.6 4852.3 5241.8 5361.6 5585.4 5709.8 359.4 418.9 424.9 431.3 438.2 3593.6 3708.6 3762.2 3774.4 3783.8 8137.0 10123.9 10266.7 10268.4 10294.3 9785.6 9899.7 9971.0 10216.7 10233.6 7240.1 7789.8 7935.0 7935.6 7940.6 5114.6 5418.1 5427.1 5521.6 5549.8 9358.3 9510.3 9536.3 9564.0 9585.9 9473.4 9507.8 9580.9 9698.1 9739.3 7073.4 7210.0 7213.5 7217.4 7240.0 6518.7 7870.0 7872.6 7891.3 7907.4 6857.7 7048.4 7158.1 7233.8 7284.3 6812.9 6988.9 7017.5 7025.7 7032.8 5150.6 5170.3 6490.4 6507.6 6635.5 4653.6 4698.6 4709.5 4801.3 4804.3 4570.9 4646.9 4743.7 4792.8 4979.5 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | [#4] prototype.html Cycles:180 Average:4588.98 Median:4974.07 stddev:1383.63 (27.8%) stddev-sans-first:1349.49 04:34:37 INFO - PROCESS | 2370 | Values: 296.7 352.3 356.6 363.4 374.5 4637.8 4839.2 4952.4 5314.6 5463.8 5186.1 5401.9 5412.4 5420.8 5424.7 3880.1 3928.0 4198.4 4243.0 4265.6 3586.8 3633.6 3879.7 3947.8 4122.3 3978.5 4164.7 4183.7 4189.4 4206.8 3443.7 3810.1 4153.5 4159.4 4189.1 3372.7 3510.3 3688.3 3688.4 3691.4 3949.6 4635.9 5162.3 5262.9 5286.3 4339.0 4485.7 4485.8 4897.3 4897.8 4625.7 4995.8 5688.5 5695.5 5725.6 4055.2 4122.3 4134.2 4141.8 4149.3 5903.9 5940.6 5945.6 5980.0 5991.8 3987.6 4222.6 4230.7 4232.4 4243.8 3793.8 4241.1 4260.6 4279.6 4281.6 4562.4 4661.7 4717.5 4746.5 4813.6 5408.3 5727.8 5730.2 5734.4 5739.5 1300.6 1383.5 1385.7 1389.5 1405.9 833.8 987.2 1003.4 1003.7 1042.8 4163.3 4894.8 5050.4 5105.6 5112.8 4704.8 5048.5 5437.0 5655.7 5695.2 4259.6 4448.8 4852.5 5046.8 5165.9 2351.5 2913.9 2914.3 2929.3 2946.5 5386.6 5731.4 5761.5 5787.0 5800.1 4890.9 5393.3 6019.1 6023.5 6069.2 5296.0 5871.3 5900.4 6112.8 6151.3 5126.7 5538.3 5886.2 5917.0 5958.9 5177.7 5418.7 5817.4 5854.6 5855.7 5541.6 5818.9 6034.6 6039.0 6112.4 3663.5 3795.3 3864.4 3882.7 3972.2 4935.5 5098.1 5570.7 5775.2 5928.6 4906.0 5153.8 5655.2 5778.0 5817.1 4688.6 4840.9 5740.4 5762.3 5802.2 5165.2 5363.6 5551.5 5608.3 5610.9 5704.9 5717.8 5728.7 5754.4 5781.9 4826.3 5289.6 5372.8 5561.9 5596.8 04:34:37 INFO - PROCESS | 2370 | 04:34:37 INFO - PROCESS | 2370 | [#5] yui.html Cycles:180 Average:20819.49 Median:4388.06 stddev:29937.48 (682.2%) stddev-sans-first:29983.04 04:34:37 INFO - PROCESS | 2370 | Values: 619.9 710.8 724.9 734.4 843.5 13096.2 14805.6 15421.5 15887.7 16184.5 13257.6 13513.0 14727.3 14739.9 15046.4 839.3 873.4 874.5 876.5 877.3 675.1 698.7 865.8 871.3 871.3 659.2 734.4 736.4 737.3 882.6 906.6 909.4 911.7 911.8 912.0 669.2 678.8 678.8 680.6 682.1 11159.8 15016.6 15384.5 15442.2 15446.3 13603.9 13749.0 13915.7 14029.5 14208.1 11335.7 11693.8 11716.9 11764.4 12240.0 3313.9 3621.0 3653.1 3660.2 3701.1 98077.5 103076.5 103128.0 103994.5 104358.0 10444.8 10496.8 10518.5 10743.5 10800.4 21118.3 21190.0 21233.6 21321.5 21341.8 7557.8 7615.2 7708.7 7723.1 7867.4 4247.4 4323.5 4328.4 4383.6 4392.5 3438.1 3530.0 3533.6 3533.8 3542.6 612.9 627.3 639.7 639.9 641.4 540.5 543.9 566.9 571.2 571.7 7935.8 8489.8 9112.0 9126.7 9406.7 568.6 597.9 622.6 641.3 661.3 4408.3 4477.5 4512.8 4544.6 4637.6 92057.9 94889.1 96606.0 102628.0 112658.4 87250.0 91018.6 91262.0 92942.5 93805.0 81777.2 81848.6 82141.6 82654.0 89495.6 8826.0 9395.0 9863.6 10033.0 10117.9 54517.9 55049.2 55106.0 55843.0 56223.7 62095.0 77061.0 77074.5 79171.6 81154.8 13577.5 13584.4 13715.6 13781.0 14225.4 14642.5 14710.9 14758.3 15299.7 15316.1 13503.1 13750.6 13814.5 13824.4 14273.3 13635.8 13869.9 13894.8 13976.2 14196.9 11059.6 13138.0 13238.7 13522.9 13548.3 9179.5 11116.8 11507.1 11524.3 11668.9 11219.2 11221.4 11394.5 11481.2 11520.0 04:34:37 INFO - PROCESS | 2370 | -------- Summary: end -------- 04:34:37 INFO - PROCESS | 2370 | 04:34:38 INFO - TEST-INFO | 2370: exit 0 04:34:38 INFO - TEST-OK | dromaeo_css | took 1119343ms 04:34:38 INFO - TEST-START | kraken 04:34:38 INFO - operating with platform_type : mac_ 04:34:38 INFO - Initialising browser for kraken test... 04:34:38 INFO - TEST-INFO | started process 2485 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpZAI_m7/profile http://localhost:50868/getInfo.html) 04:34:40 INFO - PROCESS | 2485 | __metrics Screen width/height:1600/1200 04:34:40 INFO - PROCESS | 2485 | colorDepth:24 04:34:40 INFO - PROCESS | 2485 | Browser inner width/height: 1024/689 04:34:40 INFO - PROCESS | 2485 | __metrics 04:34:41 INFO - PROCESS | 2485 | 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" 04:34:41 INFO - PROCESS | 2485 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:42 INFO - TEST-INFO | 2485: exit 0 04:34:42 INFO - Browser initialized. 04:34:42 INFO - Running cycle 1/1 for kraken test... 04:34:42 INFO - TEST-INFO | started process 2487 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpZAI_m7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:54 INFO - PROCESS | 2487 | RSS: Main: 237363200 04:34:54 INFO - PROCESS | 2487 | 04:34:56 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50868/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:57 INFO - PROCESS | 2487 | RSS: Main: 290811904 04:34:57 INFO - PROCESS | 2487 | 04:35:00 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50868/tests/kraken/driver.html?testName=audio-dft) 04:35:00 INFO - PROCESS | 2487 | RSS: Main: 292970496 04:35:00 INFO - PROCESS | 2487 | 04:35:04 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50868/tests/kraken/driver.html?testName=audio-fft) 04:35:04 INFO - PROCESS | 2487 | RSS: Main: 383418368 04:35:04 INFO - PROCESS | 2487 | 04:35:06 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50868/tests/kraken/driver.html?testName=audio-oscillator) 04:35:07 INFO - PROCESS | 2487 | RSS: Main: 286027776 04:35:07 INFO - PROCESS | 2487 | 04:35:09 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:10 INFO - PROCESS | 2487 | RSS: Main: 290422784 04:35:10 INFO - PROCESS | 2487 | 04:35:13 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50868/tests/kraken/driver.html?testName=imaging-darkroom) 04:35:13 INFO - PROCESS | 2487 | RSS: Main: 331661312 04:35:13 INFO - PROCESS | 2487 | 04:35:16 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50868/tests/kraken/driver.html?testName=imaging-desaturate) 04:35:17 INFO - PROCESS | 2487 | RSS: Main: 332636160 04:35:17 INFO - PROCESS | 2487 | 04:35:20 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50868/tests/kraken/driver.html?testName=json-parse-financial) 04:35:20 INFO - PROCESS | 2487 | RSS: Main: 332042240 04:35:20 INFO - PROCESS | 2487 | 04:35:22 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:35:23 INFO - PROCESS | 2487 | RSS: Main: 306737152 04:35:23 INFO - PROCESS | 2487 | 04:35:25 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:35:25 INFO - PROCESS | 2487 | RSS: Main: 310292480 04:35:25 INFO - PROCESS | 2487 | 04:35:27 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:35:28 INFO - PROCESS | 2487 | RSS: Main: 311996416 04:35:28 INFO - PROCESS | 2487 | 04:35:31 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:35:32 INFO - PROCESS | 2487 | RSS: Main: 323923968 04:35:32 INFO - PROCESS | 2487 | 04:35:35 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:35:35 INFO - PROCESS | 2487 | RSS: Main: 322719744 04:35:35 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | Cycle 1(1): loaded http://localhost:50868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50868/tests/kraken/driver.html?testName=ai-astar) 04:35:37 INFO - PROCESS | 2487 | RSS: Main: 366813184 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | __start_tp_report 04:35:37 INFO - PROCESS | 2487 | _x_x_mozilla_page_load 04:35:37 INFO - PROCESS | 2487 | _x_x_mozilla_page_load_details 04:35:37 INFO - PROCESS | 2487 | |i|pagename|runs| 04:35:37 INFO - PROCESS | 2487 | |0;ai-astar;113;115;115;113;113;114;114;113;114;114 04:35:37 INFO - PROCESS | 2487 | |1;audio-beat-detection;143;110;115;179;139;123;111;107;131;108 04:35:37 INFO - PROCESS | 2487 | |2;audio-dft;186;183;184;186;186;185;182;184;184;185 04:35:37 INFO - PROCESS | 2487 | |3;audio-fft;81;59;60;87;59;58;58;59;75;59 04:35:37 INFO - PROCESS | 2487 | |4;audio-oscillator;89;73;72;69;69;98;115;98;74;84 04:35:37 INFO - PROCESS | 2487 | |5;imaging-gaussian-blur;109;108;107;108;107;109;108;117;165;109 04:35:37 INFO - PROCESS | 2487 | |6;imaging-darkroom;96;134;97;94;93;94;94;94;93;93 04:35:37 INFO - PROCESS | 2487 | |7;imaging-desaturate;85;85;88;88;85;88;95;85;69;130 04:35:37 INFO - PROCESS | 2487 | |8;json-parse-financial;58;56;53;54;55;55;56;56;55;55 04:35:37 INFO - PROCESS | 2487 | |9;json-stringify-tinderbox;68;69;73;75;72;69;70;73;70;70 04:35:37 INFO - PROCESS | 2487 | |10;stanford-crypto-aes;91;87;97;97;106;86;88;96;105;104 04:35:37 INFO - PROCESS | 2487 | |11;stanford-crypto-ccm;139;141;152;155;142;138;141;139;229;141 04:35:37 INFO - PROCESS | 2487 | |12;stanford-crypto-pbkdf2;173;170;171;177;171;172;171;171;168;175 04:35:37 INFO - PROCESS | 2487 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;67;67;67;67;66 04:35:37 INFO - PROCESS | 2487 | __end_tp_report 04:35:37 INFO - PROCESS | 2487 | __start_cc_report 04:35:37 INFO - PROCESS | 2487 | _x_x_mozilla_cycle_collect,1996 04:35:37 INFO - PROCESS | 2487 | __end_cc_report 04:35:37 INFO - PROCESS | 2487 | __startTimestamp1482237337825__endTimestamp 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | ------- Summary: start ------- 04:35:37 INFO - PROCESS | 2487 | Number of tests: 14 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 04:35:37 INFO - PROCESS | 2487 | Values: 113.0 115.0 115.0 113.0 113.0 114.0 114.0 113.0 114.0 114.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:127.00 stddev:22.57 (17.8%) stddev-sans-first:23.15 04:35:37 INFO - PROCESS | 2487 | Values: 143.0 110.0 115.0 179.0 139.0 123.0 111.0 107.0 131.0 108.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.35 (0.7%) stddev-sans-first:1.32 04:35:37 INFO - PROCESS | 2487 | Values: 186.0 183.0 184.0 186.0 186.0 185.0 182.0 184.0 184.0 185.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#3] audio-fft Cycles:10 Average:65.50 Median:59.50 stddev:11.08 (18.6%) stddev-sans-first:10.23 04:35:37 INFO - PROCESS | 2487 | Values: 81.0 59.0 60.0 87.0 59.0 58.0 58.0 59.0 75.0 59.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:79.00 stddev:15.61 (19.8%) stddev-sans-first:16.46 04:35:37 INFO - PROCESS | 2487 | Values: 89.0 73.0 72.0 69.0 69.0 98.0 115.0 98.0 74.0 84.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:109.00 stddev:17.91 (16.4%) stddev-sans-first:18.87 04:35:37 INFO - PROCESS | 2487 | Values: 109.0 108.0 107.0 108.0 107.0 109.0 108.0 117.0 165.0 109.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:94.00 stddev:12.65 (13.5%) stddev-sans-first:13.39 04:35:37 INFO - PROCESS | 2487 | Values: 96.0 134.0 97.0 94.0 93.0 94.0 94.0 94.0 93.0 93.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#7] imaging-desaturate Cycles:10 Average:89.80 Median:86.50 stddev:15.55 (18.0%) stddev-sans-first:16.40 04:35:37 INFO - PROCESS | 2487 | Values: 85.0 85.0 88.0 88.0 85.0 88.0 95.0 85.0 69.0 130.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.34 (2.4%) stddev-sans-first:1.00 04:35:37 INFO - PROCESS | 2487 | Values: 58.0 56.0 53.0 54.0 55.0 55.0 56.0 56.0 55.0 55.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:2.23 (3.1%) stddev-sans-first:2.11 04:35:37 INFO - PROCESS | 2487 | Values: 68.0 69.0 73.0 75.0 72.0 69.0 70.0 73.0 70.0 70.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#10] stanford-crypto-aes Cycles:10 Average:95.70 Median:89.50 stddev:7.57 (8.5%) stddev-sans-first:7.84 04:35:37 INFO - PROCESS | 2487 | Values: 91.0 87.0 97.0 97.0 106.0 86.0 88.0 96.0 105.0 104.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:141.50 stddev:27.76 (19.6%) stddev-sans-first:29.06 04:35:37 INFO - PROCESS | 2487 | Values: 139.0 141.0 152.0 155.0 142.0 138.0 141.0 139.0 229.0 141.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:171.50 stddev:2.56 (1.5%) stddev-sans-first:2.68 04:35:37 INFO - PROCESS | 2487 | Values: 173.0 170.0 171.0 177.0 171.0 172.0 171.0 171.0 168.0 175.0 04:35:37 INFO - PROCESS | 2487 | 04:35:37 INFO - PROCESS | 2487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:35:37 INFO - PROCESS | 2487 | Values: 67.0 66.0 67.0 67.0 66.0 67.0 67.0 67.0 67.0 66.0 04:35:37 INFO - PROCESS | 2487 | -------- Summary: end -------- 04:35:37 INFO - PROCESS | 2487 | 04:35:38 INFO - TEST-INFO | 2487: exit 0 04:35:38 INFO - TEST-OK | kraken | took 60294ms 04:35:38 INFO - SUITE-END | took 1179s 04:35:38 INFO - Completed test suite (00:19:39) 04:35:38 INFO - javascript benchmark 04:35:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.1469018055304, 3331.8000919944807, 3333.833308334583, 3369.5956485221777, 3387.424137896557, 5597.832065038046, 5687.289088863892, 5709.71451427429, 5797.507211886989, 5813.825585232445, 5702.087665973445, 5702.173184888189, 5712.257406537145, 5720.342160651527, 5733.0, 5121.206213036976, 5133.691978481284, 5147.227915812639, 5168.9224661630105, 5175.689458632475, 5208.609354298424, 5219.217117432378, 5258.658187217838, 5265.157574788034, 5271.710055946922, 5258.07983602868, 5276.0, 5279.366476022883, 5299.0, 5313.495217954288, 5266.762995665185, 5276.947230527703, 5290.550303224192, 5292.682439053669, 5334.333208348957, 4139.254934111858, 5085.516875896784, 5133.332666753336, 5154.4587818278915, 5179.507946745053, 4292.656587472995, 5714.971425142848, 5786.5370770338695, 5802.245708057968, 5807.506361959238, 6102.145699602059, 6137.41694539018, 6141.263048434172, 6141.4472697456995, 6150.446459818638, 6018.548608854353, 6120.877582448326, 6139.058058263096, 6146.801373732079, 6170.19787427636, 5810.506106980912, 5820.563457740686, 5822.505087067647, 5832.679202643895, 5840.503557197686, 6116.284046402188, 6125.876495711655, 6142.468080853527, 6148.815535533941, 6162.198914141133, 6119.837693858701, 6126.754929802758, 6136.048912418493, 6144.8771024579255, 6154.630722156685, 6126.12970700902, 6141.170941922873, 6155.692215389213, 6166.907496387557, 6171.506279497629, 6097.908531372033, 6107.7278715418815, 6112.388761123852, 6120.872274143302, 6123.663198524035, 6118.694065296718, 6134.069235337315, 6145.0, 6150.0, 6155.692215389213, 4943.283223932582, 4953.975230123826, 4956.207006878882, 4956.851294461172, 4990.426100998359, 3728.906777330534, 4417.160739459492, 4450.5104438511735, 4457.8439754608435, 4494.685372023992, 5665.518430933417, 5747.195392645033, 5747.942520574741, 5799.623024503394, 5896.64620122794, 6127.2647282325515, 6141.539384546177, 6147.5553244987395, 6165.938340616626, 6170.043643235305, 5805.0, 5894.646321220741, 5897.380775018647, 5899.4985426239255, 5949.0, 5344.171653393731, 5379.220013098079, 5391.595630327741, 5450.618456707993, 5456.181572764117, 6220.253569571771, 6224.097505861715, 6253.155823963707, 6278.0, 6348.174737284124, 6233.345498722751, 6236.844078897882, 6238.500919926486, 6245.7189426476825, 6255.437010669061, 5926.585139040226, 6313.179286692701, 6334.556581039283, 6336.20797400325, 6347.079673447417, 6059.606125601822, 6122.001753127661, 6136.171616831849, 6142.293636231891, 6144.941444616104, 6119.0, 6126.426068710427, 6182.907256391248, 6246.875062498815, 6247.843803904757, 4896.926546101882, 5999.700014999145, 6132.264128304632, 6152.0, 6155.969220153871, 5944.138099975566, 6009.098635204754, 6105.9084113737445, 6115.205023346936, 6119.296280927751, 5924.703764811656, 5940.6435613863305, 5991.310999234969, 6033.396660333931, 6085.391460853879, 6120.296165940974, 6121.602095863755, 6124.693765311806, 6129.387061294014, 6143.385661433999, 5814.447627475383, 5944.851378715567, 5959.106134079922, 5995.310539288038, 6013.939860601338], "value": 5669.741301726782, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.24414907687924, 439.38924894396774, 458.95639914208147, 483.16171442547176, 503.27025812571736, 24657.0, 34132.82933585332, 38951.415728764056, 41121.58878411215, 41240.79379603105, 41779.58220417803, 42252.73241802743, 42269.78865105678, 42314.365284520754, 42337.364939525934, 8459.788505287386, 9304.81390372192, 9512.191463725592, 9526.333156679035, 9551.61793528258, 8620.09489003655, 11205.551777928873, 11483.885161148366, 11494.885051149466, 11659.825102623425, 11409.942950285236, 11468.885311146865, 11470.655880323562, 11496.482658280398, 11500.65498035056, 11398.601048963288, 11463.426828658534, 11473.196876218584, 11485.827712584276, 11496.252743571724, 11294.0, 11299.265547739371, 11337.716557086056, 11354.943225283821, 11373.31760094397, 39357.80321098376, 39733.60266397357, 39747.60252397468, 39780.801095994626, 39813.0, 2863.0981240909255, 3342.96657033429, 3408.454647256452, 3436.6563343665434, 3476.7566270361085, 30283.697163028308, 30618.38763224723, 30739.538906916416, 30800.38399232003, 30859.845700771577, 3106.8446577671025, 3212.9678703212903, 3248.220427097503, 3253.96746032539, 3323.4682450807995, 474307.0, 475332.0, 475711.0, 476317.0, 477114.9999999965, 48367.27449088196, 57241.427585723606, 57854.0, 58314.0, 58565.70717146387, 62791.372086279465, 62964.55531670286, 62980.05529917055, 63229.0, 63240.367596324366, 15630.218489075502, 15838.049717016786, 15848.76226856598, 15858.60353491172, 15867.12730799794, 11162.832557511643, 11269.09847212221, 11284.605038823602, 12153.270803751802, 12324.383780810924, 14270.286485675675, 16605.67154627627, 16917.407890723767, 16964.83035169657, 17390.739138912926, 6353.475165960229, 6518.608883467007, 6561.606303621798, 6576.572522786099, 6581.86836263272, 898.9460632362079, 967.2927283344902, 972.439284562518, 997.4264797741328, 1023.0, 29345.82616695351, 29584.0, 29838.955636552615, 29867.691802070487, 30179.698203018128, 951.8762560867043, 961.4087336288133, 1108.7616162525096, 1109.4674556213063, 1182.8994535464583, 14563.344649490798, 15130.697386052218, 15212.771808422882, 15549.30028148736, 15633.452829150925, 607311.0, 611058.9447052826, 611214.9439252864, 611676.0, 611721.0, 57701.55746106381, 57957.420425796045, 58023.0, 58134.0, 58161.70919145462, 1319.8350206224222, 1373.8557451467452, 1384.1210831122512, 1388.465440805277, 1391.6451304917384, 28331.716682833732, 29005.7099429003, 29138.0, 29606.555901661923, 29850.552241715955, 50480.990380191455, 50947.0, 50957.0, 51027.0, 51083.74458127686, 530792.0, 532361.3381933066, 533324.0, 533671.0, 538803.0, 33253.50119748157, 33474.66525334716, 34058.318833622696, 39223.60776392314, 39596.2080758389, 38838.4464621412, 42287.73136805901, 47687.0, 47715.522844772495, 48845.77885552889, 39165.0, 39510.604893950695, 39539.80230098831, 39624.60375396209, 40744.0, 39190.2161956765, 39208.80395598004, 40438.59561404349, 40815.77552673424, 40922.0, 37358.813205933795, 38207.808960955015, 38616.0, 38652.03369915775, 38821.6117838818, 30523.694763052084, 33600.663993359754, 34161.80433684908, 34952.475712864834, 35249.82375088108, 25553.850076746963, 25651.35871603225, 25658.743412565636, 25697.229083127535, 26141.0], "value": 20015.904222433262, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2785359646717, 371.3408699558284, 372.57154272586524, 382.68237362988714, 405.6268233225432, 14624.561263162095, 14776.408943642255, 15940.68118637628, 19277.325293614726, 20094.397168084943, 19304.227830886746, 19601.70597441036, 20029.0, 20513.692294615594, 20525.384238472834, 5491.093969495048, 5790.7104644767805, 5910.379410161936, 5956.55325850563, 5966.254218222723, 5586.078297080977, 5909.586328956974, 5942.970285148568, 5951.345352011275, 6028.3067447243475, 5737.7991770288045, 5890.410958904118, 5893.528517718572, 5897.616654917438, 5904.291485021803, 5940.940590594082, 5963.880722385549, 6008.519318454557, 6120.816375508742, 6121.816345509664, 5749.856253593652, 5779.33537643168, 5792.362840087587, 5869.413058694096, 5902.852428689274, 13250.271235082068, 13252.602421927357, 13310.933445332712, 13472.056956013083, 13500.0, 2285.5771682238837, 2297.322289924476, 2654.3231475973503, 2699.1362763915554, 2816.478951393978, 10507.684769456851, 15029.549113526611, 15817.0, 15981.84018159815, 16031.679366412724, 1830.4508647405726, 1863.9720404193947, 1887.981120188808, 1891.1300801631266, 1901.6481950839138, 70174.64912675455, 105074.0, 115302.0, 116869.0, 120358.0, 11099.83350249747, 11333.773324533628, 11382.658520244406, 11482.138839587064, 11635.76728465426, 14374.928125359516, 14392.280385980659, 14397.640058998399, 14416.567502974927, 14418.639534011523, 8103.797405064921, 8373.330133589297, 8406.873896891551, 8486.151384861465, 8552.572371381406, 8227.341812654973, 8235.95882020598, 8245.422820402515, 8380.491511527984, 8412.579371031425, 4453.398791163151, 4480.663950203748, 4492.483364413134, 4498.437695288089, 4596.47140578831, 1856.1461727605183, 1895.8862468251948, 1905.7046157845557, 1907.4563749331373, 1923.740295060177, 738.346563291491, 766.5056038855018, 846.124261389459, 935.2798345274101, 1004.834202356603, 16257.593560160854, 17509.98998522582, 17948.0, 18770.155343009596, 20680.379588612366, 881.5460038080394, 894.7763059235191, 938.8497840345512, 952.9666461673808, 974.9122578967927, 7747.95402620639, 8283.25450709439, 10875.891241087646, 10886.836697449544, 10943.28868623537, 318377.0, 322881.0, 549823.0, 556156.0, 567583.0, 125230.37384813017, 132137.0, 134598.81017847205, 134614.65385346216, 140162.0, 982.1749730226644, 1007.9344842585208, 1033.2921948465325, 1033.9327943683636, 1034.4103860799273, 18313.633727325647, 18581.90709046446, 18804.623907522047, 18813.623727525646, 19172.424827255203, 53340.0, 53957.19064213961, 55086.72456637691, 55499.89000220054, 55856.6035849107, 74244.0, 78444.0, 78840.60579697065, 80043.59978200072, 81243.0, 7882.960585197037, 7988.720394786154, 8025.5585942773705, 8182.0, 8201.13888041747, 10363.854458216774, 12485.687857803627, 12767.680807979876, 12797.936010319889, 12932.547360842325, 8424.213295808782, 10469.895301046892, 11008.944955275172, 11086.057685096857, 11113.611023614134, 10276.486175691334, 10802.67591972242, 10905.945470272598, 11085.833712494157, 11263.0, 8491.872621910552, 8935.28517718568, 10017.499125043865, 10602.09882160025, 10945.726356841144, 7846.097698764487, 7917.445778795429, 7920.207979202034, 7930.167332430012, 8079.232472915299, 10066.094051535398, 10944.288621239593, 10957.616483423042, 11061.83407248908, 11219.943900280772], "value": 9245.657300597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.528372427788, 1340.6045216661084, 1513.916734579598, 1677.3290683726507, 1896.7818700849398, 7448.36688881445, 7867.763967080997, 7871.685132594689, 7883.487573307731, 7886.250806173412, 7665.540067595948, 7947.602619869012, 8188.54962977036, 8206.876896846537, 8277.503349799017, 1971.5366888781125, 2256.9843570393305, 2265.286434773045, 2295.4031951692514, 2309.607366747657, 2226.588081204974, 2326.2788535553946, 2345.3081341004445, 2355.8822058896985, 2359.6578496118054, 2003.1786967343392, 2061.5052387426986, 2138.5509043100888, 2245.2253972379503, 2320.6519022146726, 2307.377008207783, 2323.94190145246, 2332.8017118544944, 2333.673285739998, 2333.8716370599527, 1868.0, 1976.6145601607693, 2314.259436980167, 2326.0811979268265, 2349.800266977309, 8436.282915952152, 8510.319174466027, 8515.0, 8523.57382130891, 8538.786530336729, 4200.285951388271, 5207.6354655174155, 5212.061828870802, 5221.451747566489, 5224.63427560071, 3320.6015278166533, 3490.965090349089, 3567.23304489536, 3568.7858728476117, 3581.3732596795458, 1006.7382480555035, 1044.8537204791335, 1082.5615625671537, 1090.9890901090967, 1092.159037541097, 10758.256644555666, 11048.281861678965, 11060.115190784718, 11081.944590277159, 11100.44497775108, 4331.436913201263, 4550.681452298308, 4617.653675974316, 4626.953730462719, 4674.76626168697, 9416.529173541296, 9429.528523573794, 9437.056294370508, 9449.007854175212, 9469.763255918657, 5144.331236939174, 5217.556507696812, 5242.5281724644965, 5244.606654500928, 5245.790168393298, 4587.3807036050375, 4721.929171062437, 4779.378680771478, 4792.808287668524, 4799.304100905419, 3665.6700896919406, 3755.286495565834, 3762.5861155272896, 3765.039914821703, 3856.267309211241, 1268.8858002779793, 1272.9490820367082, 1273.0961017677553, 1278.6355888571898, 1281.826953361303, 751.3838652305058, 771.5139462138817, 836.1513064239801, 881.8236352729351, 898.5686870302292, 4852.320675105488, 5241.842744717588, 5361.624686271924, 5585.413531579207, 5709.800156994485, 359.4392747314198, 418.8513077857378, 424.9447571815644, 431.2776100032433, 438.18060227375014, 3593.6047034826147, 3708.554973403209, 3762.1535154589997, 3774.358359078963, 3783.754055986352, 8137.0, 10123.898761012442, 10266.743331416774, 10268.383896966207, 10294.279400442047, 9785.559649815776, 9899.653512127185, 9970.950145249373, 10216.722909636295, 10233.590656373663, 7240.058792357066, 7789.805254868674, 7934.960325198337, 7935.563544005136, 7940.563269020144, 5114.616403769806, 5418.133098704188, 5427.1316589345515, 5521.585881059017, 5549.833504994856, 9358.251339892928, 9510.286728495252, 9536.33245672824, 9564.0, 9585.9041409585, 9473.384230025302, 9507.809843803223, 9580.946095929303, 9698.127168554864, 9739.318247722875, 7073.363397294268, 7209.963950180216, 7213.531120477152, 7217.386522145676, 7240.022596949555, 6518.706658200297, 7870.016247969004, 7872.606369681607, 7891.250331218525, 7907.446478746432, 6857.691403886937, 7048.400885924754, 7158.141023077264, 7233.819154520968, 7284.307990740871, 6812.8978065328065, 6988.860222795617, 7017.543859649107, 7025.683844227125, 7032.753853615303, 5150.613703972292, 5170.302009228856, 6490.350964903472, 6507.609543427409, 6635.469162467088, 4653.604443622195, 4698.624110071118, 4709.5290470954005, 4801.327814105958, 4804.25534042224, 4570.862874113782, 4646.93029604563, 4743.691660042086, 4792.832250871203, 4979.526944940225], "value": 4261.445387989634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.7077428732699, 352.34288052781557, 356.611293689878, 363.36411280259546, 374.51313292719476, 4637.837675681352, 4839.177339852225, 4952.380952380952, 5314.627976041674, 5463.808766693167, 5186.0665080285535, 5401.945980540193, 5412.431694672062, 5420.783168673248, 5424.701641409721, 3880.1075752576785, 3928.0376307804486, 4198.3702444633245, 4242.984582323387, 4265.573442655726, 3586.8027258500774, 3633.6003039665616, 3879.72841901067, 3947.822347994347, 4122.299209134454, 3978.542467616218, 4164.729292595972, 4183.686223533232, 4189.392538081976, 4206.768627725474, 3443.741719371057, 3810.0759116646054, 4153.460050193486, 4159.3968874513175, 4189.120284740208, 3372.7470439717117, 3510.280392519527, 3688.2623475304777, 3688.354537955847, 3691.446283057536, 3949.6445319921345, 4635.8642132677705, 5162.270639335827, 5262.8684282892855, 5286.3392075990505, 4339.0, 4485.730856148642, 4485.753283569403, 4897.265410188465, 4897.755112244409, 4625.722456652612, 4995.750212489361, 5688.516476099495, 5695.45893140151, 5725.568607848038, 4055.2497787909333, 4122.299209134454, 4134.193832202722, 4141.7574727581605, 4149.2531344358, 5903.911441328383, 5940.554458415593, 5945.64326140433, 5979.970100149515, 5991.7902873399225, 3987.5613682494904, 4222.577742225752, 4230.70385073042, 4232.4286221360335, 4243.787810609457, 3793.79134147619, 4241.109367032957, 4260.573942605714, 4279.572042795758, 4281.565675498743, 4562.384078149474, 4661.743604101807, 4717.5046620104395, 4746.454157771831, 4813.638977076734, 5408.296921400193, 5727.828165155052, 5730.2208428911945, 5734.369219385864, 5739.512141468022, 1300.6423233610833, 1383.481194552043, 1385.6674398144573, 1389.4720006397706, 1405.9086159399606, 833.8165603567205, 987.2151639446657, 1003.4130033930232, 1003.7490627343165, 1042.8122937871103, 4163.292240319092, 4894.755262236945, 5050.444451110375, 5105.591552675852, 5112.821051263262, 4704.811807527729, 5048.5203905628905, 5436.994156081138, 5655.745491452894, 5695.206010106803, 4259.574042595777, 4448.755318457516, 4852.4662287148385, 5046.772895219724, 5165.9225111623355, 2351.4826738117586, 2913.927151821179, 2914.285999930031, 2929.311611771232, 2946.543285790706, 5386.569074474032, 5731.423858438962, 5761.452661997104, 5787.006965194003, 5800.143953934785, 4890.902181956412, 5393.325834270716, 6019.097135429721, 6023.488003519662, 6069.241344831896, 5296.0, 5871.324797648325, 5900.380460051632, 6112.7554897804475, 6151.2618485781995, 5126.718899904139, 5538.307711536058, 5886.205362276038, 5916.970415147896, 5958.880822383441, 5177.663451875616, 5418.701971391612, 5817.389174136655, 5854.560907931837, 5855.7364918579615, 5541.612087153861, 5818.854528636649, 6034.577579569388, 6039.0, 6112.358202388685, 3663.487111804296, 3795.2978698940783, 3864.3623802072343, 3882.650561449483, 3972.245273398045, 4935.481774413634, 5098.113697931789, 5570.693611851387, 5775.170166618411, 5928.584999050025, 4905.99427117433, 5153.778888194878, 5655.236543066633, 5778.0, 5817.098349755625, 4688.601468875184, 4840.854774356775, 5740.39725828782, 5762.250907382014, 5802.187693722798, 5165.199394093921, 5363.597730170331, 5551.472610102034, 5608.298522974817, 5610.915836262541, 5704.942950570441, 5717.828465146053, 5728.713564321851, 5754.395788442153, 5781.901438726629, 4826.300186473012, 5289.550388217045, 5372.811951581676, 5561.888762224814, 5596.804111856066], "value": 4165.580014441817, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.8698273362594, 710.8329542557495, 724.855028994201, 734.4051318432071, 843.5276245302629, 13096.214227146365, 14805.555833325005, 15421.460248891291, 15887.68224635508, 16184.514464566082, 13257.602271931833, 13513.0, 14727.337269822858, 14739.852601473982, 15046.398144074225, 839.2991851803752, 873.3711727556149, 874.5364956573027, 876.5441970175505, 877.2718643525858, 675.1358261425383, 698.6855914838318, 865.8354912566624, 871.3203701113142, 871.337783284705, 659.1694464974144, 734.4454936522944, 736.4219088015908, 737.2664199121881, 882.6337070115894, 906.5557876640431, 909.3589019741099, 911.7219248129318, 911.8495448251031, 912.0013585124278, 669.1501792723263, 678.762433148399, 678.8065401360637, 680.5950459476653, 682.0723815610766, 11159.776804463947, 15016.624584385478, 15384.538463845991, 15442.150681712614, 15446.304916278794, 13603.863961360457, 13749.0, 13915.721685566232, 14029.508967186202, 14208.14751114926, 11335.65436783264, 11693.766124677544, 11716.94141529287, 11764.41177941108, 12240.0, 3313.9171520711934, 3621.0, 3653.1049892776173, 3660.249648821985, 3701.0932321581117, 98077.5096124522, 103076.48461757643, 103128.0, 103994.48002760013, 104358.0, 10444.791104177873, 10496.842547361795, 10518.526666300035, 10743.51654175564, 10800.405977671304, 21118.260860869796, 21190.0, 21233.575328493345, 21321.466963326042, 21341.78658213429, 7557.848843023219, 7615.16233214346, 7708.653110610036, 7723.073231212291, 7867.370610351159, 4247.384129301234, 4323.54602766705, 4328.350747387917, 4383.649308055348, 4392.472903251631, 3438.054535002894, 3530.011596752913, 3533.611302756695, 3533.7703049301713, 3542.574891013095, 612.8835521250948, 627.3475585391142, 639.7409049334934, 639.9456046236029, 641.4291280760127, 540.497337476151, 543.8694713268866, 566.8962430691929, 571.2117278156118, 571.7198572699348, 7935.761927142195, 8489.75939550604, 9112.0, 9126.680566180152, 9406.670766523139, 568.6076607141059, 597.8804239152187, 622.5579838314757, 641.3105911145444, 661.2825084782968, 4408.25059739845, 4477.485089214717, 4512.842050528281, 4544.590986811203, 4637.559431853969, 92057.87363390022, 94889.05110948802, 96606.03393966111, 102628.0, 112658.43670781757, 87250.0, 91018.63472047924, 91262.0, 92942.53528732313, 93805.0, 81777.18222817815, 81848.59075704584, 82141.58929205436, 82654.0, 89495.55252223698, 8826.0, 9395.007840826387, 9863.556139973862, 10033.0, 10117.898821011695, 54517.909641806145, 55049.1742623869, 55106.0, 55843.0, 56223.71888140533, 62095.0, 77061.0, 77074.45851082835, 79171.60414197893, 81154.78267826105, 13577.524786632815, 13584.388702508608, 13715.588532344045, 13781.035327526977, 14225.430982760574, 14642.487512936996, 14710.852891470948, 14758.262086895398, 15299.694006120038, 15316.081035137928, 13503.12229705066, 13750.587482375544, 13814.516491922734, 13824.447022119002, 14273.286335683382, 13635.79546306826, 13869.86130138726, 13894.791578126538, 13976.161430314214, 14196.858031419553, 11059.557617695524, 13138.0, 13238.735225295633, 13522.93238533801, 13548.32258387057, 9179.541022948692, 11116.833247501132, 11507.136964727846, 11524.308541487537, 11668.90522236054, 11219.2146549744, 11221.438928053727, 11394.544218231178, 11481.196316257781, 11520.0], "value": 7401.715725257396, "unit": "score"}], "name": "dromaeo_css", "value": 7187.559235817884, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 115.0, 179.0, 139.0, 123.0, 111.0, 107.0, 131.0, 108.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 184.0, 186.0, 186.0, 185.0, 182.0, 184.0, 184.0, 185.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 87.0, 59.0, 58.0, 58.0, 59.0, 75.0, 59.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 73.0, 72.0, 69.0, 69.0, 98.0, 115.0, 98.0, 74.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 108.0, 107.0, 109.0, 108.0, 117.0, 165.0, 109.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 134.0, 97.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 88.0, 85.0, 88.0, 95.0, 85.0, 69.0, 130.0], "value": 89.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 53.0, 54.0, 55.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 73.0, 75.0, 72.0, 69.0, 70.0, 73.0, 70.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 97.0, 97.0, 106.0, 86.0, 88.0, 96.0, 105.0, 104.0], "value": 95.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 152.0, 155.0, 142.0, 138.0, 141.0, 139.0, 229.0, 141.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 171.0, 177.0, 171.0, 172.0, 171.0, 171.0, 168.0, 175.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1489.4, "alertThreshold": 2.0}]} 04:35:39 INFO - Return code: 0 04:35:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:35:39 INFO - # TBPL SUCCESS # 04:35:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:39 INFO - 2016-12-20 04:35:39.138 screenresolution[2497:17343] starting screenresolution argv=screenresolution get 04:35:39 INFO - 2016-12-20 04:35:39.141 screenresolution[2497:17343] Display 0: 1600x1200x32@60 04:35:39 INFO - 2016-12-20 04:35:39.147 screenresolution[2498:17346] starting screenresolution argv=screenresolution list 04:35:39 INFO - Available Modes on Display 0 04:35:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:39 INFO - Intel Iris: 04:35:39 INFO - Chipset Model: Intel Iris 04:35:39 INFO - Type: GPU 04:35:39 INFO - Bus: Built-In 04:35:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:39 INFO - Vendor: Intel (0x8086) 04:35:39 INFO - Device ID: 0x0a2e 04:35:39 INFO - Revision ID: 0x0009 04:35:39 INFO - Displays: 04:35:39 INFO - Display: 04:35:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:39 INFO - Display Serial Number: 1600x1200 60 04:35:39 INFO - Main Display: Yes 04:35:39 INFO - Mirror: Off 04:35:39 INFO - Online: Yes 04:35:39 INFO - Rotation: Supported 04:35:39 INFO - Return code: 0 04:35:39 INFO - Running post-action listener: _resource_record_post_action 04:35:39 INFO - [mozharness: 2016-12-20 12:35:39.390610Z] Finished run-tests step (success) 04:35:39 INFO - Running post-run listener: _resource_record_post_run 04:35:39 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1503232; Write bytes: 554613248; Read time: 11; Write time: 1934 04:35:39 INFO - TinderboxPrint: CPU usage
53.8% 04:35:39 INFO - TinderboxPrint: I/O read bytes / time
1,503,232 / 11 04:35:39 INFO - TinderboxPrint: I/O write bytes / time
554,613,248 / 1,934 04:35:39 INFO - TinderboxPrint: CPU idle
2,219.7 (46.2%) 04:35:39 INFO - TinderboxPrint: CPU system
968.8 (20.1%) 04:35:39 INFO - TinderboxPrint: CPU user
1,621.0 (33.7%) 04:35:39 INFO - TinderboxPrint: Swap in / out
250,703,872 / 0 04:35:39 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249504256; Write bytes: 245502976; Read time: 18213; Write time: 556 04:35:39 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 745472; Write bytes: 299542016; Read time: 7; Write time: 1350 04:35:39 INFO - Running post-run listener: _upload_blobber_files 04:35:39 INFO - Blob upload gear active. 04:35:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:35:39 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 04:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:35:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:35:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:41 INFO - (blobuploader) - INFO - Done attempting. 04:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:42 INFO - (blobuploader) - INFO - Done attempting. 04:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:35:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:44 INFO - (blobuploader) - INFO - Done attempting. 04:35:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:35:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:46 INFO - (blobuploader) - INFO - Done attempting. 04:35:46 INFO - (blobuploader) - INFO - Iteration through files over. 04:35:46 INFO - Return code: 0 04:35:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:35:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:35:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1491fbb418f08b596ecd4a1c0c1b4a35d61d564d9766e60057a50d7d17f75672192804dca6f8a1e38c78198750bb1609e6467b7d2f61d79bc15a5d8082fc652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5521ce1a611a43ce7c2e89159e0f4a49549fc4306d6185546590521818eebaf60423a1d2a6c9bc29571f6e732c38f13d17599ea814e6f51bcf3126e1c0b9e764", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5a19a1798225da00b0b126ffced7b7c1c6e93204b58b0e9e950ad2c4bc10e6efca0c76dfe8a59d4b81c09e66cf754cee3bd161ae48fc6e909541c84ad65cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e59b5115d67c543c8e052e025819e929f703e5b3b1e8e795720c4b5a4ed0ed701f5eb8cad6cc8858610a4553fff3742f32f6d9943ca0ab27071b7b1facd4eea1"} 04:35:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:35:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:35:46 INFO - Contents: 04:35:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1491fbb418f08b596ecd4a1c0c1b4a35d61d564d9766e60057a50d7d17f75672192804dca6f8a1e38c78198750bb1609e6467b7d2f61d79bc15a5d8082fc652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5521ce1a611a43ce7c2e89159e0f4a49549fc4306d6185546590521818eebaf60423a1d2a6c9bc29571f6e732c38f13d17599ea814e6f51bcf3126e1c0b9e764", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5a19a1798225da00b0b126ffced7b7c1c6e93204b58b0e9e950ad2c4bc10e6efca0c76dfe8a59d4b81c09e66cf754cee3bd161ae48fc6e909541c84ad65cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e59b5115d67c543c8e052e025819e929f703e5b3b1e8e795720c4b5a4ed0ed701f5eb8cad6cc8858610a4553fff3742f32f6d9943ca0ab27071b7b1facd4eea1"} 04:35:46 INFO - Running post-run listener: copy_logs_to_upload_dir 04:35:46 INFO - Copying logs to upload dir... 04:35:46 INFO - mkdir: /builds/slave/test/build/upload/logs 04:35:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.411766 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-20 04:35:46.712335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 04:35:46.715820) ========= 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.9yEDaaHgih/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.qpcKARTrJz/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1491fbb418f08b596ecd4a1c0c1b4a35d61d564d9766e60057a50d7d17f75672192804dca6f8a1e38c78198750bb1609e6467b7d2f61d79bc15a5d8082fc652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5521ce1a611a43ce7c2e89159e0f4a49549fc4306d6185546590521818eebaf60423a1d2a6c9bc29571f6e732c38f13d17599ea814e6f51bcf3126e1c0b9e764", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5a19a1798225da00b0b126ffced7b7c1c6e93204b58b0e9e950ad2c4bc10e6efca0c76dfe8a59d4b81c09e66cf754cee3bd161ae48fc6e909541c84ad65cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e59b5115d67c543c8e052e025819e929f703e5b3b1e8e795720c4b5a4ed0ed701f5eb8cad6cc8858610a4553fff3742f32f6d9943ca0ab27071b7b1facd4eea1"} build_url:https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011645 build_url: 'https://queue.taskcluster.net/v1/task/ZMILrFV3TXCm5iSqrK-csQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1491fbb418f08b596ecd4a1c0c1b4a35d61d564d9766e60057a50d7d17f75672192804dca6f8a1e38c78198750bb1609e6467b7d2f61d79bc15a5d8082fc652", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5521ce1a611a43ce7c2e89159e0f4a49549fc4306d6185546590521818eebaf60423a1d2a6c9bc29571f6e732c38f13d17599ea814e6f51bcf3126e1c0b9e764", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b5a19a1798225da00b0b126ffced7b7c1c6e93204b58b0e9e950ad2c4bc10e6efca0c76dfe8a59d4b81c09e66cf754cee3bd161ae48fc6e909541c84ad65cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e59b5115d67c543c8e052e025819e929f703e5b3b1e8e795720c4b5a4ed0ed701f5eb8cad6cc8858610a4553fff3742f32f6d9943ca0ab27071b7b1facd4eea1"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 04:35:46.762491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 04:35:46.762841) ========= 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.9yEDaaHgih/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.qpcKARTrJz/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.005262 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 04:35:46.834633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 04:35:46.834999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 04:35:46.835380) ========= ========= Total master_lag: 0.22 =========