builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0278 starttime: 1484053395.62 results: success (0) buildid: 20170110031508 builduid: 4ab7ebda39eb4d799009e2836fff97bc revision: 7011ed1427de2b6f075c46cc6f4618d3e9fcd2a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.620866) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.621352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.621768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.649215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.649791) ========= 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.zt8kfHkAxk/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.hYQCMniSk6/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-10 05:03:15-- 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 2017-01-10 05:03:15 (8.11 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114717 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.791774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.792481) ========= 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.zt8kfHkAxk/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.hYQCMniSk6/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.019057 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:15.842515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-10 05:03:15.842907) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7011ed1427de2b6f075c46cc6f4618d3e9fcd2a4 --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 7011ed1427de2b6f075c46cc6f4618d3e9fcd2a4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zt8kfHkAxk/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.hYQCMniSk6/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-10 05:03:15,922 truncating revision to first 12 chars 2017-01-10 05:03:15,922 Setting DEBUG logging. 2017-01-10 05:03:15,922 attempt 1/10 2017-01-10 05:03:15,922 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7011ed1427de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 05:03:16,964 unpacking tar archive at: mozilla-central-7011ed1427de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.305418 ========= master_lag: 1.91 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-10 05:03:19.057196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:19.057527) ========= script_repo_revision: 7011ed1427de2b6f075c46cc6f4618d3e9fcd2a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:19.057940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:19.058275) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 05:03:19.080071) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-10 05:03:19.080510) ========= /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.zt8kfHkAxk/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.hYQCMniSk6/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:03:19 INFO - MultiFileLogger online at 20170110 05:03:19 in /builds/slave/test 05:03:19 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 05:03:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:03:19 INFO - {'append_to_log': False, 05:03:19 INFO - 'base_work_dir': '/builds/slave/test', 05:03:19 INFO - 'blob_upload_branch': 'Firefox', 05:03:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:03:19 INFO - 'branch': 'Firefox', 05:03:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:19 INFO - 'config_files': ('talos/mac_config.py',), 05:03:19 INFO - 'default_actions': ('clobber', 05:03:19 INFO - 'read-buildbot-config', 05:03:19 INFO - 'download-and-extract', 05:03:19 INFO - 'populate-webroot', 05:03:19 INFO - 'create-virtualenv', 05:03:19 INFO - 'install', 05:03:19 INFO - 'run-tests'), 05:03:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:19 INFO - 'download_minidump_stackwalk': True, 05:03:19 INFO - 'download_symbols': 'ondemand', 05:03:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:19 INFO - 'installer_path': 'installer.exe', 05:03:19 INFO - 'log_level': 'info', 05:03:19 INFO - 'log_name': 'talos', 05:03:19 INFO - 'log_to_console': True, 05:03:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:03:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:03:19 INFO - 'opt_config_files': (), 05:03:19 INFO - 'pip_index': False, 05:03:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:03:19 INFO - 'cmd': ('bash', 05:03:19 INFO - '-c', 05:03:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:03:19 INFO - 'enabled': True, 05:03:19 INFO - 'halt_on_failure': False, 05:03:19 INFO - 'name': 'check_screen_resolution'},), 05:03:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:03:19 INFO - 'cmd': ('bash', 05:03:19 INFO - '-c', 05:03:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:03:19 INFO - 'enabled': True, 05:03:19 INFO - 'halt_on_failure': False, 05:03:19 INFO - 'name': 'check_screen_resolution'},), 05:03:19 INFO - 'run_cmd_checks_enabled': True, 05:03:19 INFO - 'sps_profile': False, 05:03:19 INFO - 'sps_profile_interval': 0, 05:03:19 INFO - 'suite': 'dromaeojs', 05:03:19 INFO - 'system_bits': '32', 05:03:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:19 INFO - 'title': 't-yosemite-r7-0278', 05:03:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:19 INFO - 'use_talos_json': True, 05:03:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:03:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:19 INFO - 'work_dir': 'build'} 05:03:19 INFO - [mozharness: 2017-01-10 13:03:19.280335Z] Running clobber step. 05:03:19 INFO - Running pre-action listener: _resource_record_pre_action 05:03:19 INFO - Running main action method: clobber 05:03:19 INFO - rmtree: /builds/slave/test/build 05:03:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:03:20 INFO - Running post-action listener: _resource_record_post_action 05:03:20 INFO - [mozharness: 2017-01-10 13:03:20.833556Z] Finished clobber step (success) 05:03:20 INFO - [mozharness: 2017-01-10 13:03:20.833749Z] Running read-buildbot-config step. 05:03:20 INFO - Running pre-action listener: _resource_record_pre_action 05:03:20 INFO - Running main action method: read_buildbot_config 05:03:20 INFO - Using buildbot properties: 05:03:20 INFO - { 05:03:20 INFO - "project": "", 05:03:20 INFO - "product": "firefox", 05:03:20 INFO - "script_repo_revision": "production", 05:03:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:03:20 INFO - "repository": "", 05:03:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:03:20 INFO - "buildid": "20170110031508", 05:03:20 INFO - "pgo_build": "False", 05:03:20 INFO - "basedir": "/builds/slave/test", 05:03:20 INFO - "buildnumber": 1, 05:03:20 INFO - "slavename": "t-yosemite-r7-0278", 05:03:20 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:03:20 INFO - "platform": "yosemite_r7", 05:03:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:03:20 INFO - "branch": "mozilla-central", 05:03:20 INFO - "repo_path": "mozilla-central", 05:03:20 INFO - "revision": "7011ed1427de2b6f075c46cc6f4618d3e9fcd2a4", 05:03:20 INFO - "stage_platform": "macosx64", 05:03:20 INFO - "builduid": "4ab7ebda39eb4d799009e2836fff97bc", 05:03:20 INFO - "slavebuilddir": "test" 05:03:20 INFO - } 05:03:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:03:20 INFO - Running post-action listener: _resource_record_post_action 05:03:20 INFO - [mozharness: 2017-01-10 13:03:20.837320Z] Finished read-buildbot-config step (success) 05:03:20 INFO - [mozharness: 2017-01-10 13:03:20.837442Z] Running download-and-extract step. 05:03:20 INFO - Running pre-action listener: _resource_record_pre_action 05:03:20 INFO - Running main action method: download_and_extract 05:03:20 INFO - mkdir: /builds/slave/test/build/tests 05:03: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')]} 05:03:20 INFO - trying https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:03:20 INFO - Downloading https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/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 05:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/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 05:03:22 INFO - Downloaded 1199 bytes. 05:03:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:03:22 INFO - Using the following test package requirements: 05:03:22 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:03:22 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:03:22 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:03:22 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'jsshell-mac.zip'], 05:03:22 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:03:22 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:03:22 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:03:22 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:03:22 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:03:22 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:03:22 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:03:22 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:03:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:03:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:03:22 INFO - Fetch https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:03:23 INFO - Expected file size: 16310017 05:03:23 INFO - Obtained file size: 16310017 05:03:29 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 05:03:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:03:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:03:29 INFO - Fetch https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:03:31 INFO - Expected file size: 16310017 05:03:31 INFO - Obtained file size: 16310017 05:03:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:03:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:03:37 INFO - Fetch https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:03:38 INFO - Expected file size: 14403529 05:03:38 INFO - Obtained file size: 14403529 05:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:39 INFO - trying https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:03:39 INFO - Downloading https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:03:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/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 05:03:41 INFO - Downloaded 69715694 bytes. 05:03:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:03:41 INFO - mkdir: /builds/slave/test/properties 05:03:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:41 INFO - Contents: 05:03:41 INFO - build_url:https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:03:42 INFO - Running post-action listener: _resource_record_post_action 05:03:42 INFO - Running post-action listener: set_extra_try_arguments 05:03:42 INFO - [mozharness: 2017-01-10 13:03:42.762066Z] Finished download-and-extract step (success) 05:03:42 INFO - [mozharness: 2017-01-10 13:03:42.762222Z] Running populate-webroot step. 05:03:42 INFO - Running pre-action listener: _resource_record_pre_action 05:03:42 INFO - Running main action method: populate_webroot 05:03:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:42 INFO - '--tppagecycles', 05:03:42 INFO - '7'], 05:03:42 INFO - 'tests': ['tsvgm']}}, 05:03:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:03:42 INFO - 'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:03:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:03:42 INFO - 'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['damp', 'tps']}, 05:03:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:03:42 INFO - 'tests': ['damp', 'tps']}, 05:03:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['dromaeo_dom']}, 05:03:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['basic_compositor_video']}, 05:03:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:03:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore', 05:03:42 INFO - 'tabpaint']}, 05:03:42 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore', 05:03:42 INFO - 'tabpaint']}, 05:03:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore', 05:03:42 INFO - 'tabpaint']}, 05:03:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore', 05:03:42 INFO - 'tabpaint']}, 05:03:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore', 05:03:42 INFO - 'tabpaint']}, 05:03:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['a11yr', 05:03:42 INFO - 'ts_paint', 05:03:42 INFO - 'tpaint', 05:03:42 INFO - 'sessionrestore', 05:03:42 INFO - 'sessionrestore_no_auto_restore', 05:03:42 INFO - 'tabpaint']}, 05:03:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['tsvgx', 05:03:42 INFO - 'tsvgr_opacity', 05:03:42 INFO - 'tart', 05:03:42 INFO - 'tscrollx', 05:03:42 INFO - 'cart', 05:03:42 INFO - 'tsvg_static']}, 05:03:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:42 INFO - 'tsvgr_opacity', 05:03:42 INFO - 'tart', 05:03:42 INFO - 'tscrollx', 05:03:42 INFO - 'cart', 05:03:42 INFO - 'tsvg_static']}, 05:03:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:03:42 INFO - 'talos_options': ['--disable-e10s'], 05:03:42 INFO - 'tests': ['tp5o']}, 05:03:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:03:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:03:42 INFO - 'talos_options': ['--disable-e10s', 05:03:42 INFO - '--xperf_path', 05:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:42 INFO - 'tests': ['tp5n']}, 05:03:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:03:42 INFO - 'talos_options': ['--xperf_path', 05:03:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:42 INFO - 'tests': ['tp5n']}}, 05:03:42 INFO - 'talos.zip': {'path': '', 05:03:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:42 INFO - Running post-action listener: _resource_record_post_action 05:03:42 INFO - [mozharness: 2017-01-10 13:03:42.779364Z] Finished populate-webroot step (success) 05:03:42 INFO - [mozharness: 2017-01-10 13:03:42.779463Z] Running create-virtualenv step. 05:03:42 INFO - Running pre-action listener: _resource_record_pre_action 05:03:42 INFO - Running main action method: create_virtualenv 05:03:42 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:42 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 05:03:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:42 INFO - Using real prefix '/tools/python27' 05:03:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:46 INFO - Installing pip.................done. 05:03:46 INFO - Return code: 0 05:03:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:03:46 INFO - Reading from file tmpfile_stdout 05:03:46 INFO - Output received: 05:03:46 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) 05:03:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:03:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:03:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:46 INFO - 'HOME': '/Users/cltbld', 05:03:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:46 INFO - 'LOGNAME': 'cltbld', 05:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:46 INFO - 'MOZ_NO_REMOTE': '1', 05:03:46 INFO - 'NO_EM_RESTART': '1', 05:03:46 INFO - 'PAGER': '/bin/cat', 05:03:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:46 INFO - 'PWD': '/builds/slave/test', 05:03:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:46 INFO - 'SHELL': '/bin/bash', 05:03:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:03:46 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:03:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:46 INFO - 'USER': 'cltbld', 05:03:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:46 INFO - 'XPC_FLAGS': '0x0', 05:03:46 INFO - 'XPC_SERVICE_NAME': '0', 05:03:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:46 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 05:03:46 INFO - Cleaning up... 05:03:46 INFO - Return code: 0 05:03:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:03:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:03:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:46 INFO - 'HOME': '/Users/cltbld', 05:03:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:46 INFO - 'LOGNAME': 'cltbld', 05:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:46 INFO - 'MOZ_NO_REMOTE': '1', 05:03:46 INFO - 'NO_EM_RESTART': '1', 05:03:46 INFO - 'PAGER': '/bin/cat', 05:03:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:46 INFO - 'PWD': '/builds/slave/test', 05:03:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:46 INFO - 'SHELL': '/bin/bash', 05:03:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:03:46 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:03:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:46 INFO - 'USER': 'cltbld', 05:03:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:46 INFO - 'XPC_FLAGS': '0x0', 05:03:46 INFO - 'XPC_SERVICE_NAME': '0', 05:03:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:47 INFO - Downloading/unpacking psutil>=3.1.1 05:03:47 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 05:03:47 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 05:03:47 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 05:03:47 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 05:03:47 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 05:03:47 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 05:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:50 INFO - Installing collected packages: psutil 05:03:50 INFO - Running setup.py install for psutil 05:03:50 INFO - building 'psutil._psutil_osx' extension 05:03:50 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 05:03:51 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 05:03:51 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 05:03:51 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 05:03:51 INFO - building 'psutil._psutil_posix' extension 05:03:51 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 05:03:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:03:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:03:51 INFO - ^ 05:03:51 INFO - 1 warning generated. 05:03:51 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 05:03:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:51 INFO - Successfully installed psutil 05:03:51 INFO - Cleaning up... 05:03:51 INFO - Return code: 0 05:03:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:03:51 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')]} 05:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:51 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')]} 05:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:51 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:03:51 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 05:03:51 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 05:03:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:03:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:51 INFO - 'HOME': '/Users/cltbld', 05:03:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:51 INFO - 'LOGNAME': 'cltbld', 05:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:51 INFO - 'MOZ_NO_REMOTE': '1', 05:03:51 INFO - 'NO_EM_RESTART': '1', 05:03:51 INFO - 'PAGER': '/bin/cat', 05:03:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:51 INFO - 'PWD': '/builds/slave/test', 05:03:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:51 INFO - 'SHELL': '/bin/bash', 05:03:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:03:51 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:03:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:51 INFO - 'USER': 'cltbld', 05:03:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:51 INFO - 'XPC_FLAGS': '0x0', 05:03:51 INFO - 'XPC_SERVICE_NAME': '0', 05:03:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:03:54 INFO - Installing collected packages: mozsystemmonitor 05:03:54 INFO - Running setup.py install for mozsystemmonitor 05:03:54 INFO - Successfully installed mozsystemmonitor 05:03:54 INFO - Cleaning up... 05:03:54 INFO - Return code: 0 05:03:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:03:54 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')]} 05:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:54 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')]} 05:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:54 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:03:54 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 05:03:54 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 05:03:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:03:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:54 INFO - 'HOME': '/Users/cltbld', 05:03:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:54 INFO - 'LOGNAME': 'cltbld', 05:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:54 INFO - 'MOZ_NO_REMOTE': '1', 05:03:54 INFO - 'NO_EM_RESTART': '1', 05:03:54 INFO - 'PAGER': '/bin/cat', 05:03:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:54 INFO - 'PWD': '/builds/slave/test', 05:03:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:54 INFO - 'SHELL': '/bin/bash', 05:03:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:03:54 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:03:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:54 INFO - 'USER': 'cltbld', 05:03:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:54 INFO - 'XPC_FLAGS': '0x0', 05:03:54 INFO - 'XPC_SERVICE_NAME': '0', 05:03:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:55 INFO - Downloading/unpacking jsonschema==2.5.1 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:03:57 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 05:03:57 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 05:03:57 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 05:03:57 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 05:03:57 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 05:03:57 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 05:03:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:58 INFO - warning: no files found matching '*.txt' 05:03:58 INFO - no previously-included directories found matching 'build' 05:03:58 INFO - no previously-included directories found matching 'dist' 05:03:58 INFO - no previously-included directories found matching '.git*' 05:03:58 INFO - Installing collected packages: jsonschema, functools32 05:03:58 INFO - Running setup.py install for functools32 05:03:58 INFO - warning: no files found matching '*.txt' 05:03:58 INFO - no previously-included directories found matching 'build' 05:03:58 INFO - no previously-included directories found matching 'dist' 05:03:58 INFO - no previously-included directories found matching '.git*' 05:03:58 INFO - Successfully installed jsonschema functools32 05:03:58 INFO - Cleaning up... 05:03:58 INFO - Return code: 0 05:03:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:58 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:03:58 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 05:03:58 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 05:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:58 INFO - 'HOME': '/Users/cltbld', 05:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:58 INFO - 'LOGNAME': 'cltbld', 05:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:58 INFO - 'MOZ_NO_REMOTE': '1', 05:03:58 INFO - 'NO_EM_RESTART': '1', 05:03:58 INFO - 'PAGER': '/bin/cat', 05:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:58 INFO - 'PWD': '/builds/slave/test', 05:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:58 INFO - 'SHELL': '/bin/bash', 05:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:03:58 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:58 INFO - 'USER': 'cltbld', 05:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:58 INFO - 'XPC_FLAGS': '0x0', 05:03:58 INFO - 'XPC_SERVICE_NAME': '0', 05:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:03:58 INFO - Cleaning up... 05:03:58 INFO - Return code: 0 05:03:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:58 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:03:58 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 05:03:58 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 05:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:58 INFO - 'HOME': '/Users/cltbld', 05:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:58 INFO - 'LOGNAME': 'cltbld', 05:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:58 INFO - 'MOZ_NO_REMOTE': '1', 05:03:58 INFO - 'NO_EM_RESTART': '1', 05:03:58 INFO - 'PAGER': '/bin/cat', 05:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:58 INFO - 'PWD': '/builds/slave/test', 05:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:58 INFO - 'SHELL': '/bin/bash', 05:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:03:58 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:58 INFO - 'USER': 'cltbld', 05:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:58 INFO - 'XPC_FLAGS': '0x0', 05:03:58 INFO - 'XPC_SERVICE_NAME': '0', 05:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:59 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 05:03:59 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 05:03:59 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 05:03:59 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 05:03:59 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 05:03:59 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 05:04:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:01 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 05:04:01 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 05:04:01 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 05:04:01 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 05:04:01 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 05:04:01 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 05:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:04:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:02 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 05:04:02 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 05:04:02 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 05:04:02 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 05:04:02 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 05:04:02 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 05:04:02 INFO - Downloading docopt-0.6.1.tar.gz 05:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:03 INFO - Running setup.py install for blobuploader 05:04:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:04:03 INFO - Running setup.py install for requests 05:04:03 INFO - Running setup.py install for docopt 05:04:03 INFO - Successfully installed blobuploader requests docopt 05:04:03 INFO - Cleaning up... 05:04:03 INFO - Return code: 0 05:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:03 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')]} 05:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:03 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')]} 05:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:03 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:04:03 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 05:04:03 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 05:04:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:04:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:03 INFO - 'HOME': '/Users/cltbld', 05:04:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:03 INFO - 'LOGNAME': 'cltbld', 05:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:03 INFO - 'MOZ_NO_REMOTE': '1', 05:04:03 INFO - 'NO_EM_RESTART': '1', 05:04:03 INFO - 'PAGER': '/bin/cat', 05:04:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:03 INFO - 'PWD': '/builds/slave/test', 05:04:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:03 INFO - 'SHELL': '/bin/bash', 05:04:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:04:03 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:04:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:03 INFO - 'USER': 'cltbld', 05:04:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:03 INFO - 'XPC_FLAGS': '0x0', 05:04:03 INFO - 'XPC_SERVICE_NAME': '0', 05:04:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-g3FtgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-QtWcsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-K6hF3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-yREvGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vLAwQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-DExd1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-dMmOxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-lMmH00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-WD06Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-wH4U_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-PdLbVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-IpKsY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-qRbkDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-tkae20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-IPIaBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-bGtrhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-i8MsDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:05 INFO - Running setup.py install for manifestparser 05:04:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:04:06 INFO - Running setup.py install for mozcrash 05:04:06 INFO - Running setup.py install for mozdebug 05:04:06 INFO - Running setup.py install for mozdevice 05:04:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:04:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:04:06 INFO - Running setup.py install for mozfile 05:04:06 INFO - Running setup.py install for mozhttpd 05:04:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:04:06 INFO - Running setup.py install for mozinfo 05:04:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:04:06 INFO - Running setup.py install for mozInstall 05:04:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Running setup.py install for mozleak 05:04:07 INFO - Running setup.py install for mozlog 05:04:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Running setup.py install for moznetwork 05:04:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Running setup.py install for mozprocess 05:04:07 INFO - Running setup.py install for mozprofile 05:04:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:07 INFO - Running setup.py install for mozrunner 05:04:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:08 INFO - Running setup.py install for mozscreenshot 05:04:08 INFO - Running setup.py install for moztest 05:04:08 INFO - Running setup.py install for mozversion 05:04:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:08 INFO - Cleaning up... 05:04:08 INFO - Return code: 0 05:04:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:08 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:04:08 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 05:04:08 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 05:04:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:04:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:08 INFO - 'HOME': '/Users/cltbld', 05:04:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:08 INFO - 'LOGNAME': 'cltbld', 05:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:08 INFO - 'MOZ_NO_REMOTE': '1', 05:04:08 INFO - 'NO_EM_RESTART': '1', 05:04:08 INFO - 'PAGER': '/bin/cat', 05:04:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:08 INFO - 'PWD': '/builds/slave/test', 05:04:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:08 INFO - 'SHELL': '/bin/bash', 05:04:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:04:08 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:04:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:08 INFO - 'USER': 'cltbld', 05:04:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:08 INFO - 'XPC_FLAGS': '0x0', 05:04:08 INFO - 'XPC_SERVICE_NAME': '0', 05:04:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:08 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-UyNijG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:08 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)) 05:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:08 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-CjUxkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-BAAxEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_PifLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-tVfKgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vzJUhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-VtCgqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Gi9ift-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-x5tvOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-1X2r0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-74BFbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:09 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)) 05:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-In4PAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Xfv0rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:10 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)) 05:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-EZzv_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:10 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)) 05:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6TCX7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:10 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)) 05:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Hsf3If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-mkfXz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:10 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)) 05:04:10 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)) 05:04:10 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)) 05:04:10 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)) 05:04:10 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)) 05:04:10 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)) 05:04:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:10 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 05:04:10 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 05:04:10 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 05:04:10 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 05:04:10 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 05:04:10 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 05:04:13 INFO - Downloading blessings-1.6.tar.gz 05:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:13 INFO - Installing collected packages: blessings 05:04:13 INFO - Running setup.py install for blessings 05:04:13 INFO - Successfully installed blessings 05:04:13 INFO - Cleaning up... 05:04:13 INFO - Return code: 0 05:04:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:13 INFO - Reading from file tmpfile_stdout 05:04:13 INFO - Current package versions: 05:04:13 INFO - blessings == 1.6 05:04:13 INFO - blobuploader == 1.2.4 05:04:13 INFO - docopt == 0.6.1 05:04:13 INFO - functools32 == 3.2.3-2 05:04:13 INFO - jsonschema == 2.5.1 05:04:13 INFO - manifestparser == 1.1 05:04:13 INFO - mozInstall == 1.12 05:04:13 INFO - mozcrash == 1.0 05:04:13 INFO - mozdebug == 0.1 05:04:13 INFO - mozdevice == 0.49 05:04:13 INFO - mozfile == 1.2 05:04:13 INFO - mozhttpd == 0.7 05:04:13 INFO - mozinfo == 0.9 05:04:13 INFO - mozleak == 0.1 05:04:13 INFO - mozlog == 3.4 05:04:13 INFO - moznetwork == 0.27 05:04:13 INFO - mozprocess == 0.24 05:04:13 INFO - mozprofile == 0.28 05:04:13 INFO - mozrunner == 6.13 05:04:13 INFO - mozscreenshot == 0.1 05:04:13 INFO - mozsystemmonitor == 0.3 05:04:13 INFO - moztest == 0.8 05:04:13 INFO - mozversion == 1.4 05:04:13 INFO - psutil == 3.1.1 05:04:13 INFO - requests == 1.2.3 05:04:13 INFO - wsgiref == 0.1.2 05:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:14 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:04:14 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 05:04:14 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 05:04:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:04:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:14 INFO - 'HOME': '/Users/cltbld', 05:04:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:14 INFO - 'LOGNAME': 'cltbld', 05:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:14 INFO - 'MOZ_NO_REMOTE': '1', 05:04:14 INFO - 'NO_EM_RESTART': '1', 05:04:14 INFO - 'PAGER': '/bin/cat', 05:04:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:14 INFO - 'PWD': '/builds/slave/test', 05:04:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:14 INFO - 'SHELL': '/bin/bash', 05:04:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:04:14 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:04:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:14 INFO - 'USER': 'cltbld', 05:04:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:14 INFO - 'XPC_FLAGS': '0x0', 05:04:14 INFO - 'XPC_SERVICE_NAME': '0', 05:04:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 INFO - Cleaning up... 05:04:14 INFO - Return code: 0 05:04:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:15 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 0x10e9d6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff9550dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, '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.zt8kfHkAxk/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.hYQCMniSk6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 05:04:15 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 05:04:15 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 05:04:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:04:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:15 INFO - 'HOME': '/Users/cltbld', 05:04:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:15 INFO - 'LOGNAME': 'cltbld', 05:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:15 INFO - 'MOZ_NO_REMOTE': '1', 05:04:15 INFO - 'NO_EM_RESTART': '1', 05:04:15 INFO - 'PAGER': '/bin/cat', 05:04:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:15 INFO - 'PWD': '/builds/slave/test', 05:04:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:15 INFO - 'SHELL': '/bin/bash', 05:04:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:04:15 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:04:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:15 INFO - 'USER': 'cltbld', 05:04:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:15 INFO - 'XPC_FLAGS': '0x0', 05:04:15 INFO - 'XPC_SERVICE_NAME': '0', 05:04:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:04:15 INFO - Cleaning up... 05:04:15 INFO - Return code: 0 05:04:15 INFO - Running post-action listener: _resource_record_post_action 05:04:15 INFO - Running post-action listener: _start_resource_monitoring 05:04:15 INFO - Starting resource monitoring. 05:04:15 INFO - [mozharness: 2017-01-10 13:04:15.599003Z] Finished create-virtualenv step (success) 05:04:15 INFO - [mozharness: 2017-01-10 13:04:15.599987Z] Running install step. 05:04:15 INFO - Running pre-action listener: _resource_record_pre_action 05:04:15 INFO - Running main action method: install 05:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:15 INFO - Reading from file tmpfile_stdout 05:04:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:04:15 INFO - Reading from file tmpfile_stdout 05:04:15 INFO - Output received: 05:04:15 INFO - Usage: mozinstall [options] installer 05:04:15 INFO - Options: 05:04:15 INFO - -h, --help show this help message and exit 05:04:15 INFO - -d DEST, --destination=DEST 05:04:15 INFO - Directory to install application into. [default: 05:04:15 INFO - "/builds/slave/test"] 05:04:15 INFO - --app=APP Application being installed. [default: firefox] 05:04:15 INFO - mkdir: /builds/slave/test/build/application 05:04:15 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'] 05:04:15 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 05:04:37 INFO - Reading from file tmpfile_stdout 05:04:37 INFO - Output received: 05:04:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:04:37 INFO - Running post-action listener: _resource_record_post_action 05:04:37 INFO - [mozharness: 2017-01-10 13:04:37.947479Z] Finished install step (success) 05:04:37 INFO - [mozharness: 2017-01-10 13:04:37.947616Z] Running run-tests step. 05:04:37 INFO - Running pre-action listener: _resource_record_pre_action 05:04:37 INFO - Running main action method: run_tests 05:04:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:37 INFO - 2017-01-10 05:04:37.962 screenresolution[2106:16689] starting screenresolution argv=screenresolution get 05:04:37 INFO - 2017-01-10 05:04:37.964 screenresolution[2106:16689] Display 0: 1600x1200x32@60 05:04:37 INFO - 2017-01-10 05:04:37.970 screenresolution[2107:16691] starting screenresolution argv=screenresolution list 05:04:37 INFO - Available Modes on Display 0 05:04:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:38 INFO - Intel Iris: 05:04:38 INFO - Chipset Model: Intel Iris 05:04:38 INFO - Type: GPU 05:04:38 INFO - Bus: Built-In 05:04:38 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:38 INFO - Vendor: Intel (0x8086) 05:04:38 INFO - Device ID: 0x0a2e 05:04:38 INFO - Revision ID: 0x0009 05:04:38 INFO - Displays: 05:04:38 INFO - Display: 05:04:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:38 INFO - Display Serial Number: 1600x1200 60 05:04:38 INFO - Main Display: Yes 05:04:38 INFO - Mirror: Off 05:04:38 INFO - Online: Yes 05:04:38 INFO - Rotation: Supported 05:04:38 INFO - Return code: 0 05:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:38 INFO - Python 2.7.3 05:04:38 INFO - Return code: 0 05:04:38 INFO - grabbing minidump binary from tooltool 05:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:38 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 0x10e7b4d30>, '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 0x10e6dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:38 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 05:04:38 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 05:04:38 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 05:04:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:38 INFO - Return code: 0 05:04:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:04:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:04:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 05:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --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 05:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zt8kfHkAxk/Render', 05:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:38 INFO - 'HOME': '/Users/cltbld', 05:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:38 INFO - 'LOGNAME': 'cltbld', 05:04:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:38 INFO - 'MOZ_NO_REMOTE': '1', 05:04:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:38 INFO - 'NO_EM_RESTART': '1', 05:04:38 INFO - 'PAGER': '/bin/cat', 05:04:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:38 INFO - 'PWD': '/builds/slave/test', 05:04:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:38 INFO - 'SHELL': '/bin/bash', 05:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hYQCMniSk6/Listeners', 05:04:38 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 05:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:38 INFO - 'USER': 'cltbld', 05:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:38 INFO - 'XPC_FLAGS': '0x0', 05:04:38 INFO - 'XPC_SERVICE_NAME': '0', 05:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 05:04:38 INFO - mozversion application_buildid: 20170110031508 05:04:38 INFO - mozversion application_changeset: 7011ed1427de2b6f075c46cc6f4618d3e9fcd2a4 05:04:38 INFO - mozversion application_display_name: Nightly 05:04:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:38 INFO - mozversion application_name: Firefox 05:04:38 INFO - mozversion application_remotingname: firefox 05:04:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:04:38 INFO - mozversion application_vendor: Mozilla 05:04:38 INFO - mozversion application_version: 53.0a1 05:04:38 INFO - mozversion platform_buildid: 20170110031508 05:04:38 INFO - mozversion platform_changeset: 7011ed1427de2b6f075c46cc6f4618d3e9fcd2a4 05:04:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:04:38 INFO - mozversion platform_version: 53.0a1 05:04:38 INFO - using testdate: 1484053478 05:04:38 INFO - actual date: 1484053478 05:04:38 INFO - starting webserver on 'localhost:53255' 05:04:38 INFO - SUITE-START | Running 2 tests 05:04:38 INFO - TEST-START | dromaeo_css 05:04:38 INFO - operating with platform_type : mac_ 05:04:38 INFO - Initialising browser for dromaeo_css test... 05:04:38 INFO - TEST-INFO | started process 2117 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpCNIWMV/profile http://localhost:53255/getInfo.html) 05:04:40 INFO - PROCESS | 2117 | __metrics Screen width/height:1600/1200 05:04:40 INFO - PROCESS | 2117 | colorDepth:24 05:04:40 INFO - PROCESS | 2117 | Browser inner width/height: 1024/689 05:04:40 INFO - PROCESS | 2117 | __metrics 05:04:40 INFO - PROCESS | 2117 | 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" 05:04:40 INFO - PROCESS | 2117 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:41 INFO - TEST-INFO | 2117: exit 0 05:04:41 INFO - Browser initialized. 05:04:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:41 INFO - TEST-INFO | started process 2119 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpCNIWMV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:53 INFO - PROCESS | 2119 | RSS: Main: 234639360 05:04:53 INFO - PROCESS | 2119 | 05:07:59 INFO - PROCESS | 2119 | Cycle 1(1): loaded http://localhost:53255/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53255/tests/dromaeo/cssquery-ext.html) 05:08:01 INFO - PROCESS | 2119 | RSS: Main: 405393408 05:08:01 INFO - PROCESS | 2119 | 05:09:43 INFO - PROCESS | 2119 | ************************* 05:09:43 INFO - PROCESS | 2119 | A coding exception was thrown and uncaught in a Task. 05:09:43 INFO - PROCESS | 2119 | 05:09:43 INFO - PROCESS | 2119 | Full message: ReferenceError: fetch is not defined 05:09:43 INFO - PROCESS | 2119 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 05:09:43 INFO - PROCESS | 2119 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 05:09:43 INFO - PROCESS | 2119 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 05:09:43 INFO - PROCESS | 2119 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 05:09:43 INFO - PROCESS | 2119 | TaskImpl@resource://gre/modules/Task.jsm:277:3 05:09:43 INFO - PROCESS | 2119 | asyncFunction@resource://gre/modules/Task.jsm:252:14 05:09:43 INFO - PROCESS | 2119 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 05:09:43 INFO - PROCESS | 2119 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 05:09:43 INFO - PROCESS | 2119 | TaskImpl@resource://gre/modules/Task.jsm:277:3 05:09:43 INFO - PROCESS | 2119 | asyncFunction@resource://gre/modules/Task.jsm:252:14 05:09:43 INFO - PROCESS | 2119 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 05:09:43 INFO - PROCESS | 2119 | 05:09:43 INFO - PROCESS | 2119 | ************************* 05:11:03 INFO - PROCESS | 2119 | Cycle 1(1): loaded http://localhost:53255/tests/dromaeo/cssquery-ext.html (next: http://localhost:53255/tests/dromaeo/cssquery-jquery.html) 05:11:04 INFO - PROCESS | 2119 | RSS: Main: 366804992 05:11:04 INFO - PROCESS | 2119 | 05:14:06 INFO - PROCESS | 2119 | Cycle 1(1): loaded http://localhost:53255/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53255/tests/dromaeo/cssquery-mootools.html) 05:14:07 INFO - PROCESS | 2119 | RSS: Main: 341786624 05:14:07 INFO - PROCESS | 2119 | 05:17:09 INFO - PROCESS | 2119 | Cycle 1(1): loaded http://localhost:53255/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53255/tests/dromaeo/cssquery-prototype.html) 05:17:10 INFO - PROCESS | 2119 | RSS: Main: 351338496 05:17:10 INFO - PROCESS | 2119 | 05:20:13 INFO - PROCESS | 2119 | Cycle 1(1): loaded http://localhost:53255/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53255/tests/dromaeo/cssquery-yui.html) 05:20:14 INFO - PROCESS | 2119 | RSS: Main: 328671232 05:20:14 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | Cycle 1(1): loaded http://localhost:53255/tests/dromaeo/cssquery-yui.html (next: http://localhost:53255/tests/dromaeo/cssquery-dojo.html) 05:23:18 INFO - PROCESS | 2119 | RSS: Main: 376696832 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | __start_tp_report 05:23:18 INFO - PROCESS | 2119 | _x_x_mozilla_page_load 05:23:18 INFO - PROCESS | 2119 | _x_x_mozilla_page_load_details 05:23:18 INFO - PROCESS | 2119 | |i|pagename|runs| 05:23:18 INFO - PROCESS | 2119 | |0;dojo.html;3318.6349501554832;3330.0675810772987;3343.314620502797;3351.2627222011147;3381.9661803381973;5660.094384898417;5741.712914354276;5765.942340576598;5769.278840144982;5830.679312637809;5670.518005969498;5719.113537401699;5720;5727.11229759388;5751.741171647275;5137.58899288057;5173.922391164136;5178.275041494194;5207.323048003755;5213.6089793265655;5245.370555533342;5253.395859476171;5253.816116435906;5258.421573626898;5265.526102650761;5228.111221092405;5231.659942103751;5232.764525596338;5235.424103348629;5246.658967167141;5243.868903277429;5244.108501554726;5253.106971814801;5253.343332083489;5257.421683614799;5131.102057139986;5133.178691409356;5204.063268611649;5214.983078299733;5216.634835561512;5700.743466544015;5737.3975732548315;5795;5801.883962320772;5862.237909071836;6230.2523697156175;6269.780557680459;6272.2159730033745;6282.4974002079725;6290.056491526262;4751.691140075884;5945.691947771526;6138.57232748375;6153.046277826944;6182.319944806068;5863.413658634103;5880.147378630075;5886.735096920649;5907.2911250650195;5922.822315330547;6242.1261023456755;6247.437730604267;6253.7185826637915;6254.186955695731;6272.1219029335925;5484.862878427992;5877.882442351129;6089.086637004485;6108.767064740488;6130.122981477994;6198.6280823150755;6244.250689917239;6248.812535623939;6276.717547710364;6277.278113016971;6137.877242455126;6233.812985610439;6240.906386404207;6256.74973001084;6267.561270711098;6267.435930766253;6269.655168965751;6275.780347687901;6280.685965701697;6287.779927702509;4879.072976134523;4906.190478570996;4914.926276105862;4962.60299176065;4987.700737955734;4447.577480139382;4450.6884518083425;4478.104379124188;4490.887727806766;4491.842785502492;5742.9949758792045;5745.1382292656435;5753.395893431213;5766.077427611562;5817.360090390053;6155.322914479404;6183.350748171467;6201.1938448002375;6235.282942461584;6267.71795269214;5684.459976302244;5692.288463942007;5722.456366645162;5733.283339582552;5799.536037117021;5350.91973620396;5409.486098820606;5423.593230507728;5455.863603409867;5492.945070549324;6190.845228869314;6211.16149319836;6213.689315534296;6229.470495007975;6270.874582508233;5809.970950145223;6190.628562286277;6234.844128896814;6293.433590976834;6306.117143599808;6216.813495595139;6217.937820621736;6225.221847269091;6256.468200202851;6271;6215.595986260879;6219.906701399392;6225.159603453476;6231.470325022424;6251.71867265965;5348.57507655779;6013.338532761305;6261.843453913506;6268.404501572343;6273.121762953281;5997.0404735242155;6026.819195423969;6034.487068599218;6034.879302414015;6177.351378105234;6075.787347442818;6108.675989703;6136.386361363828;6139.4001448444;6164.568480206342;5969.283685957713;6028.788992385245;6043.75824967014;6059.363766804422;6062.151298818258;6147.600405973598;6163.96918015407;6177.6911154443;6184.690765461619;6215.720292586935;5767.221425107557;5798.420157984167;5807.245058142415;5957.582969192288;6043.00290452088 05:23:18 INFO - PROCESS | 2119 | |1;ext.html;456.68032377335834;467.0845143518703;492.608376340809;495.6901936289821;499.32840329756476;29853;41316.58683413169;42714.572854271406;42904.71285861421;42972.925676858096;42914.57085429145;43300;43415;43459;43499.912502187384;9284.675036373728;9390.605395624107;9392.201662858632;9394.389364691273;9398.765030874214;8452.366072544584;8686.522241276758;11117.777644447106;11319.547218111265;11403.828942565868;11200.271982321165;11301.321920684744;11301.830472542919;11323.980841724244;11334.433278336091;11324.60363887264;11393.715157121056;11397.202195846294;11414.885851141466;11424.942875285611;8381.916180838174;8633.870491942625;10989.395583242998;11260.04289635382;11299;40606.796966015274;41066.38400423966;41639.375409368884;41651.7917410411;41821.79089104565;4024.2756303865294;4026.5973402659793;4062.9187416251807;4070.5318888327924;4072.0634254121424;30428.032602529947;30747.385052299054;31307.373852522822;31341.373172536423;31344.843275783704;3201.103690966533;3216.099492142204;3232.886848960275;3306.173456635841;3339.282054358325;472494;473124;474622;474884.62557687337;477007;61338.69330653318;61751.69124154351;61797.382026180065;61831;61937.690311548155;64648.67675661592;66637;66833;66962.66074678577;67077.32922670808;15770.842291576937;16343.427980020642;16379.262933168036;16408;16420.589485262964;11274.323540587591;12406.317652529198;12480.43838027291;12510.562130325396;12557.874421255854;15696.529104126666;16208.675826483404;16237.51287461378;16250;16258.268377923021;7169.211386747454;7536.107820789709;7730.845383092306;7764.650590723431;7831;703.2756261051126;748.8389996150854;860.6987554355925;880.3529405886668;892.2014796756996;25216.747832521807;29845.894653387193;29889.40221195564;29899.03819812816;29981.400371992873;889.2841262783392;972.1930797438109;1049.5959055763585;1083.5286650307141;1088.689723428819;14720.190389528465;14992.47526336573;15421.614459638375;15511.5346539604;15839.604009899615;582102;584004;584486;584933;586475;60812.08781868187;60947;61069.08396374058;61248.46878827976;61360;1410.92945352734;1452.9200893950722;1460.5545308680955;1466.2888499077726;1473.2707309881464;28098.71901280961;28844.64461562288;29214.415711686073;29549.409011820073;29977;51855.962880742925;51974;51996.74001629968;52041;52232.21651675304;485171;511838;513275;515616;518468;40173.39739903962;40886;40992.79503602463;41021.58978410297;41122.794386029076;37880.24239515249;45825.77087114543;47271.52728472671;48071;50288.74855625845;37031.814840925625;38763.41854872123;39051;40170;40566.79716601398;30923.2269193263;38708.03229919162;39039.41440878446;39980.600193997685;40278.597214028654;37355.879323620335;37357.62642373541;37478.62521374752;38070.23859522738;38268.04329891664;32483.350332992733;33391;34086.829565852015;34174;34209.65790342164;23487.530249394575;24679.80443324603;24820.875895620407;25159.371015724755;25494.235172944842 05:23:18 INFO - PROCESS | 2119 | |2;jquery.html;384.3581219363664;388.66380580797613;392.3017029687158;396.0889953107852;420.44291314008944;14120.71758564828;20701.275455359064;20757.16971321149;21411.036503357365;21452.785472145293;20944.581108377824;20992.16031358744;21934.670979935312;22061.33815985523;22436.990335434904;5375.193720941851;5647.265855438787;6141.938580614204;6142.3550527194675;6146.848602988963;4988.102141614508;5139.768710408022;5989.341172471025;6113;6113.32753397126;6083.695815209222;6086.539230584672;6095.116208149816;6096.35988221237;6101.847453813646;5853.941460585404;6004.849878753044;6067.9696601516935;6075.934182377969;6093.086037094427;4544.431946006749;5322.9620224056325;5324.227986941911;5339.5461385782255;5348.598855085846;26070;26365.868170659025;26820.86589567059;26912;26974.325641858915;2499.962500562493;2616.2282126772457;3052.6947305269296;3137.796043257181;3143.7327827134723;8469.110743371919;10193.592256309812;10534.26260161789;10547.525361358681;10612.257142000062;1780.6616742818824;1862.3481781376545;1870.672632289344;1873.9386476260443;1894.4222012286248;135721.3213933934;138495.30752346275;139540;140810.59189408078;144811;11232.887671123348;11630;11833.940830295793;11888.583899563473;12084.335361555022;12704.80942785859;14429.639259018608;15234.771478427832;15675.608109797118;15687.372505099896;8020.077691065486;8260.669573217125;8266.586670666442;8579.65681372738;8580.442271252474;6711.6979735912;6954.4436445084275;8311.33509319265;8466.872996905051;8474.872876906851;4401.2517871961845;4566.833933758337;4755.001449695534;4816.4220293564995;4826.879328016757;1786.4819202431408;2016.163292233736;2017.3760123101044;2017.7982201779705;2020.8585399022222;1000.214831357381;1038.0294424712768;1044.3499271151713;1054.667779649408;1055.6358056470506;16867;21702.456665419628;21959.15479624734;21994.330997864094;22014.37914374669;1038.8026275007724;1049.511976930731;1067.6156583629886;1068.3322923173016;1075.7471994081384;9182.827283717497;10595.682129536126;11230.606928757454;11413.771724565462;11521.942390287995;698327;703889.416587516;710231;710827;711709.4414527895;113041.78289690608;130472;152517;156215.43784562236;156598.6510202348;979.4319294808994;1061.3419679798574;1062.5377960587016;1072.1904961753826;1073.9087177589836;15825.208739563206;17763;19463.221471140994;20154.684041680255;20336.898315508326;46337;58623.70688146532;59429.51426214206;60226.39773602208;60969.69515152573;69538.87075081532;81753.59123204346;88618;88732;90431;7309.488335816654;8337.708180213664;8527.786805329917;8634;8684.43551169172;11549;13047.478100876238;13322.86677133255;13509.189448633113;13669.453221871014;11263.380514071805;11290.096792256763;11508.251963622337;11575.189736718348;11690.532378704756;11238.494267757807;11300.321980681185;11308.321500709984;11639.709007274885;11678;9750.951245243728;11384.14618903602;11435.428228588371;11770.76458470843;11772.175947683923;5800.9419905800405;6982;7369.63151842395;7574.734884279244;7703.152653208031;4783.1390349737385;5635.154726791015;8282;10730.570777169138;11251.69340285256 05:23:18 INFO - PROCESS | 2119 | |3;mootools.html;1274.9872501274986;1436.4397884824916;1440.77667961466;1457.133005861512;1460.0947412604173;7991.84016319674;8398.49609023459;8406.83186336273;8421.031581368145;8427.494350338977;7336.449766267525;7677.884831727514;7714.575698336589;7769.961150194241;7778.144404115557;2073.720047793551;2240.204727321802;2301.160076572056;2312.028947841902;2322.616768233248;2326.4881726020335;2326.523062772136;2326.6277395616703;2329.312852708447;2334.171369163948;2241.081156725743;2266.9433264168365;2288.496530763229;2301.4821665125382;2307.1463558483383;2017.9596408071902;2086.3845165676084;2226.265332440291;2299.5975704251855;2305.6887320211727;2290.9656355154684;2310.191432998454;2313.236631911482;2321.454458202321;2322.88385580722;8352.290055345304;8409.159084091541;8424.578771061422;8433.74698759032;8462.2383985441;5050.797968081272;5204.557612602934;5212.895742085175;5215.973920130413;5223.08595995703;3267.232200432896;3348.631650518441;3515.1915059536195;3523.3305671922253;3524.4184709522897;1186.9703257418548;1243.3161761031397;1244.2907542700664;1246.8566114896812;1260.212367270456;10725.624603138931;10787.406692631823;10801.621943231949;10838.078763305128;10849.566017359297;3700.481932529448;4596.080783843245;4652.441706995182;4654.185517534418;4664.766761661904;9449.858252126223;9492.525373731285;9501.192398646193;9519.857202141973;9538.761530961781;5118.820841270612;5206.297149884717;5214.0875346814155;5215.16557350822;5218.034663587173;4602.723836569817;4742.928856067162;4769.236922092448;4774.809007639725;4779.163646361872;3553.964460355415;3639.4358874374516;3704.833282502294;3771.358868992223;3844.154286057063;1051.673981065872;1146.7075895646724;1159.4202898550725;1239.39269757818;1258.7734207842677;910.7723069232692;924.2190349154953;935.4247138010074;935.6865450074301;998.5057396588735;4811.735354555463;5646.040173170571;5934.317553481319;5941.494972927349;5997.190379298826;840.4999025579771;1002.5238011944414;1034.4103860799273;1041.1410586266209;1058.9576416943237;3680.8527658893345;3787.398311052085;3902.434147048662;3939.4681717967705;3975.3241948868185;9638.084381983701;10019.649312274036;10026.047525485068;10052.497375131214;10060.39637621745;9392.765180870396;9653.855192172123;9869.75325616851;9959.302848800658;9966.451845148442;7651.808704782314;7728.304452599181;7751.961240193763;7855.960720196363;7857.1357150713375;5827.446392592697;5834.212381328466;5877.617954832922;5925.40745925404;5961.225040744675;8961.641534338554;9182.586783594621;9207.907920920705;9317.953410232905;9338.673146439842;9292.535373231176;9392.154706076486;9466.05339466048;9477.763055923382;9485.146336829443;7236.529625574321;7278.818029549304;7287.089113860768;7371.852562948819;7378.225286345071;7864;7869.6458659361615;7952.284294413299;7952.880706789287;7958.602069896598;7161;7172.49792514519;7189.604571748395;7256.564606123649;7336.339729424378;6719.731210751515;7082.5396349237135;7084.326988936043;7142.785716428515;7171.713131474683;5615.354234262949;6237.251529816451;6322.873542529215;6382.936170638234;6388.584741991755;5058.3929928408825;5064.366954130734;5123.231515272739;5167;5211.2704221409795;4962.429320628174;4977.850664480072;5038.294638750651;5268.841934741964;5313.814016509404 05:23:18 INFO - PROCESS | 2119 | |4;prototype.html;348.84302064071164;350.6475991628413;359.335229824824;368.9557253129625;370.5979012771145;5120.411152717429;5344.0494219609855;5414.593905457087;5479.534239589635;5494.313210848644;4646.4191976003;5207.270982062514;5285.229448134879;5295.682259064459;5315.787368505265;3864.613663491929;4023.577524359944;4038.848928055505;4131.586841315874;4182.79086045698;3532.858685652571;3781.3362120666957;3830.4062870255157;3930.921381572367;4165.33354663254;3428.177237463016;3575.1240945968275;4009.619086186822;4019.3970904364432;4050.2102090092444;3656.9085772855624;3998.180373023538;4055.3511438170044;4071.470708807836;4073.635332163729;3495.667911548399;3496.6328535503662;3499.5100685903994;3502.579690437138;3506.1760486285702;4584.472785629662;4625.674993880699;4920.3111564381015;4944.3572335596145;5335.626506144571;3901.3757798752063;4615.861524154281;4617.746023968681;4636.907261854778;4647.279671650899;5609.859753506154;5640.351359593658;5658.7647879087945;5673.773049078032;5680.289963754531;3189.04328701391;3479.5128681984543;3783.883754292463;3828.889622009614;3870.7290489665734;5801.477866991991;5900.291964964189;5916.852078698024;5931.406859314077;5950.107483877367;3553.982230088833;3812.980935095307;3906.921861562753;3921.647051765298;3939.330313846653;3819.7708137511836;3826.9858487500833;3952.4861767970556;3976.005998500375;3998.1608460108096;3832.9041773955873;4601.332806743004;4616.676832621752;4629.032661119011;4635.860924172212;4991.675541089818;5694.316681998187;5705.62913410627;5706.3152421709665;5737.393529811659;1069.764651776608;1086.9510872010778;1195.3784032303154;1246.4827096754746;1257.5472829781272;811.7077851973285;847.2332539052168;871.2202578692035;872.4459967920416;876.3033388456192;4458.286674132188;4542.250528662799;5023.136812017188;5048.646594738333;5111.591072714174;4801.95198048022;5369.973150134224;5526.58550608706;5594.776208951596;5613.989481893298;4209.97895010523;4294.420253265769;4349.541719737294;4913.31213630092;5009.323741294878;2621.6460777795137;2640.5379058664657;2874.4107457971068;2906.229849089993;2906.8401237932117;5148.841510660071;5460.426655201226;5500.312460942382;5637.408072152447;5690.874116265674;4511.691609433293;5424.83725488236;5613.803516876971;5721.799737009184;5735.254416925773;4743.644226683013;5692.658440493501;5720.027595308724;5740.655560666373;5785.30576330843;4889.973105647854;5153.665011774223;5288.867778305573;5547.084731019337;5580.665160090408;5078.21287700407;5123.436421993503;5456.809011684572;5467.5669327149035;5480.780768769205;4847.34560834297;5071.036503064406;5361.651492652965;5707.746584446825;5728.455796699307;3065.7547396207806;3092.829894355832;3638.909027274339;3681.950644066428;3727.944080838844;4610.372087909859;4817.807287708452;4868.075065737498;5192.754528419738;5571.4428557143965;4325.6755743318745;4594.954050459452;4803.975980120217;5049.545540901337;5469.972650136724;4185.769782661982;4986.429274778433;5026.170681837456;5324.9467505326;5360.865978350416;3980.7611543307494;4592.828828648673;4662.254039353823;5216.321878155815;5329.333833270841;5593.384727680033;5650.660960342392;5651.6043876928225;5678;5700.515456186271;5071.594272458121;5487.972560137174;5499.9175012375645;5505.587080968863;5510 05:23:18 INFO - PROCESS | 2119 | |5;yui.html;715.4955756191886;754.826389930316;765.609539135041;815.2214635023553;842.8609279468888;14994.625134371632;15369;15600.375984960601;15724.195712127026;15744;14195.432182712704;14256.928715356435;14439.63900902478;14470.782938255934;14472.204028778413;656.6683824668547;873.2664561768114;875.0942774228674;875.3609864798701;875.5272153037353;562.3701454371089;709.1561042359601;709.4218212157101;834.9332053435711;866.2074202105098;905.6965916417975;908.5094049213417;918.347972939214;920.7606022434181;921.7004473546091;755.9886601700979;911.9772005699845;912.8219997100568;913.5386629751932;914.4558987402485;530.5596355025358;548.7009579778991;642.7204166187723;686.9695456814778;688.8071340024801;14683.412663493447;15154.014989025678;15186.696266074727;15198;15209.61975950599;13548.254845983467;13728.039037267396;13762.931185344109;13827.861721382758;13875.722485550334;12408.069394795337;12504.937475312656;12608.873911260953;12684.809727853997;13080.476780928751;4384.758838263894;4448.955510444886;4485.102979404132;4492.303692927601;4601.217792975202;108488.91511084946;112281;112801.30798038036;113067.43466282699;113266.86733132646;9186.40288381253;10443.94778026105;10875.782484350428;11079.279846809932;11159.330440173615;17125.22936467862;20404.897975510026;21437.67843482349;21489.89255053746;22112.00495977685;7616.619169041636;7890.408219383569;7905.130435652074;7948.483348582324;7998.600069996477;4317.140739782857;4392.692511524227;4395.692301538862;4508.81964721414;4557.225271703818;3639.6724294813066;3697.556293244774;3703.8888833335045;3724.15654251142;3731.9067023324633;675.3651567526509;680.1022650101818;682.0996284903879;694.4652617484509;698.1831257428719;546.771904489208;646.2342124582291;695.7634404302562;699.3985172751429;703.7396163419568;7931.365490760725;8275.668973241123;10042.548085336177;10124.987501249816;10268.845967310497;685.7394190207789;690.1959217511643;711.772232885482;713.8322494213855;721.7762493626992;4113.362428823537;4573.588377046081;4995.100881841304;5001.9499805002215;5002.1496345621335;90617.23581137511;100476;102402.48798755958;103082;106907.46546267219;70227.94658080133;73479.63260183771;81088.97277568108;83561.58219208865;95516.52241738747;80643.59678201689;82321;82881;83265.58367208125;84694.15305846863;7808.7657370278985;9656.420614763138;9690.12788849007;9706.913013702087;9788.804223915624;41820.58179418289;43846.12307753891;46685.533144668116;47925;49848.50454486371;54659.72670136624;56516;57645.423545764;58863.70568147132;59474;11628.88371116278;11648.242864213798;11700.204604596569;11798.174127810971;11962.70093247641;12913.741725165632;13005.349732513525;13341.799873001719;13499.595012149652;13521.797173042609;11911.52353905834;12036.217645852992;12213.38933053326;12554.937225314181;12563.560275390317;11802.763944720886;12028.27830330183;12179.817302740288;12384.56654017105;12464.5014199431;11902.345371004678;11995.520179193083;12110.51557937708;12448.190867593577;12514.499420023461;10302.948485257526;10314.845277320695;10339.741506462098;10770.838437423601;10865.293755905841;9403.717888463358;9925.205983521157;9942.701718948443;9948.602055917681;9983.301168918397 05:23:18 INFO - PROCESS | 2119 | __end_tp_report 05:23:18 INFO - PROCESS | 2119 | __start_cc_report 05:23:18 INFO - PROCESS | 2119 | _x_x_mozilla_cycle_collect,1688 05:23:18 INFO - PROCESS | 2119 | __end_cc_report 05:23:18 INFO - PROCESS | 2119 | __startTimestamp1484054598324__endTimestamp 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | ------- Summary: start ------- 05:23:18 INFO - PROCESS | 2119 | Number of tests: 6 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | [#0] dojo.html Cycles:165 Average:5737.00 Median:5922.82 stddev:633.57 (10.7%) stddev-sans-first:606.45 05:23:18 INFO - PROCESS | 2119 | Values: 3318.6 3330.1 3343.3 3351.3 3382.0 5660.1 5741.7 5765.9 5769.3 5830.7 5670.5 5719.1 5720.0 5727.1 5751.7 5137.6 5173.9 5178.3 5207.3 5213.6 5245.4 5253.4 5253.8 5258.4 5265.5 5228.1 5231.7 5232.8 5235.4 5246.7 5243.9 5244.1 5253.1 5253.3 5257.4 5131.1 5133.2 5204.1 5215.0 5216.6 5700.7 5737.4 5795.0 5801.9 5862.2 6230.3 6269.8 6272.2 6282.5 6290.1 4751.7 5945.7 6138.6 6153.0 6182.3 5863.4 5880.1 5886.7 5907.3 5922.8 6242.1 6247.4 6253.7 6254.2 6272.1 5484.9 5877.9 6089.1 6108.8 6130.1 6198.6 6244.3 6248.8 6276.7 6277.3 6137.9 6233.8 6240.9 6256.7 6267.6 6267.4 6269.7 6275.8 6280.7 6287.8 4879.1 4906.2 4914.9 4962.6 4987.7 4447.6 4450.7 4478.1 4490.9 4491.8 5743.0 5745.1 5753.4 5766.1 5817.4 6155.3 6183.4 6201.2 6235.3 6267.7 5684.5 5692.3 5722.5 5733.3 5799.5 5350.9 5409.5 5423.6 5455.9 5492.9 6190.8 6211.2 6213.7 6229.5 6270.9 5810.0 6190.6 6234.8 6293.4 6306.1 6216.8 6217.9 6225.2 6256.5 6271.0 6215.6 6219.9 6225.2 6231.5 6251.7 5348.6 6013.3 6261.8 6268.4 6273.1 5997.0 6026.8 6034.5 6034.9 6177.4 6075.8 6108.7 6136.4 6139.4 6164.6 5969.3 6028.8 6043.8 6059.4 6062.2 6147.6 6164.0 6177.7 6184.7 6215.7 5767.2 5798.4 5807.2 5957.6 6043.0 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | [#1] ext.html Cycles:180 Average:67039.86 Median:4025.44 stddev:139624.28 (3468.6%) stddev-sans-first:139926.47 05:23:18 INFO - PROCESS | 2119 | Values: 456.7 467.1 492.6 495.7 499.3 29853.0 41316.6 42714.6 42904.7 42972.9 42914.6 43300.0 43415.0 43459.0 43499.9 9284.7 9390.6 9392.2 9394.4 9398.8 8452.4 8686.5 11117.8 11319.5 11403.8 11200.3 11301.3 11301.8 11324.0 11334.4 11324.6 11393.7 11397.2 11414.9 11424.9 8381.9 8633.9 10989.4 11260.0 11299.0 40606.8 41066.4 41639.4 41651.8 41821.8 4024.3 4026.6 4062.9 4070.5 4072.1 30428.0 30747.4 31307.4 31341.4 31344.8 3201.1 3216.1 3232.9 3306.2 3339.3 472494.0 473124.0 474622.0 474884.6 477007.0 61338.7 61751.7 61797.4 61831.0 61937.7 64648.7 66637.0 66833.0 66962.7 67077.3 15770.8 16343.4 16379.3 16408.0 16420.6 11274.3 12406.3 12480.4 12510.6 12557.9 15696.5 16208.7 16237.5 16250.0 16258.3 7169.2 7536.1 7730.8 7764.7 7831.0 703.3 748.8 860.7 880.4 892.2 25216.7 29845.9 29889.4 29899.0 29981.4 889.3 972.2 1049.6 1083.5 1088.7 14720.2 14992.5 15421.6 15511.5 15839.6 582102.0 584004.0 584486.0 584933.0 586475.0 60812.1 60947.0 61069.1 61248.5 61360.0 1410.9 1452.9 1460.6 1466.3 1473.3 28098.7 28844.6 29214.4 29549.4 29977.0 51856.0 51974.0 51996.7 52041.0 52232.2 485171.0 511838.0 513275.0 515616.0 518468.0 40173.4 40886.0 40992.8 41021.6 41122.8 37880.2 45825.8 47271.5 48071.0 50288.7 37031.8 38763.4 39051.0 40170.0 40566.8 30923.2 38708.0 39039.4 39980.6 40278.6 37355.9 37357.6 37478.6 38070.2 38268.0 32483.4 33391.0 34086.8 34174.0 34209.7 23487.5 24679.8 24820.9 25159.4 25494.2 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | [#2] jquery.html Cycles:180 Average:39308.12 Median:22037.86 stddev:118017.92 (535.5%) stddev-sans-first:118312.80 05:23:18 INFO - PROCESS | 2119 | Values: 384.4 388.7 392.3 396.1 420.4 14120.7 20701.3 20757.2 21411.0 21452.8 20944.6 20992.2 21934.7 22061.3 22437.0 5375.2 5647.3 6141.9 6142.4 6146.8 4988.1 5139.8 5989.3 6113.0 6113.3 6083.7 6086.5 6095.1 6096.4 6101.8 5853.9 6004.8 6068.0 6075.9 6093.1 4544.4 5323.0 5324.2 5339.5 5348.6 26070.0 26365.9 26820.9 26912.0 26974.3 2500.0 2616.2 3052.7 3137.8 3143.7 8469.1 10193.6 10534.3 10547.5 10612.3 1780.7 1862.3 1870.7 1873.9 1894.4 135721.3 138495.3 139540.0 140810.6 144811.0 11232.9 11630.0 11833.9 11888.6 12084.3 12704.8 14429.6 15234.8 15675.6 15687.4 8020.1 8260.7 8266.6 8579.7 8580.4 6711.7 6954.4 8311.3 8466.9 8474.9 4401.3 4566.8 4755.0 4816.4 4826.9 1786.5 2016.2 2017.4 2017.8 2020.9 1000.2 1038.0 1044.3 1054.7 1055.6 16867.0 21702.5 21959.2 21994.3 22014.4 1038.8 1049.5 1067.6 1068.3 1075.7 9182.8 10595.7 11230.6 11413.8 11521.9 698327.0 703889.4 710231.0 710827.0 711709.4 113041.8 130472.0 152517.0 156215.4 156598.7 979.4 1061.3 1062.5 1072.2 1073.9 15825.2 17763.0 19463.2 20154.7 20336.9 46337.0 58623.7 59429.5 60226.4 60969.7 69538.9 81753.6 88618.0 88732.0 90431.0 7309.5 8337.7 8527.8 8634.0 8684.4 11549.0 13047.5 13322.9 13509.2 13669.5 11263.4 11290.1 11508.3 11575.2 11690.5 11238.5 11300.3 11308.3 11639.7 11678.0 9751.0 11384.1 11435.4 11770.8 11772.2 5800.9 6982.0 7369.6 7574.7 7703.2 4783.1 5635.2 8282.0 10730.6 11251.7 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | [#3] mootools.html Cycles:180 Average:5443.60 Median:5212.08 stddev:2954.57 (56.7%) stddev-sans-first:2946.24 05:23:18 INFO - PROCESS | 2119 | Values: 1275.0 1436.4 1440.8 1457.1 1460.1 7991.8 8398.5 8406.8 8421.0 8427.5 7336.4 7677.9 7714.6 7770.0 7778.1 2073.7 2240.2 2301.2 2312.0 2322.6 2326.5 2326.5 2326.6 2329.3 2334.2 2241.1 2266.9 2288.5 2301.5 2307.1 2018.0 2086.4 2226.3 2299.6 2305.7 2291.0 2310.2 2313.2 2321.5 2322.9 8352.3 8409.2 8424.6 8433.7 8462.2 5050.8 5204.6 5212.9 5216.0 5223.1 3267.2 3348.6 3515.2 3523.3 3524.4 1187.0 1243.3 1244.3 1246.9 1260.2 10725.6 10787.4 10801.6 10838.1 10849.6 3700.5 4596.1 4652.4 4654.2 4664.8 9449.9 9492.5 9501.2 9519.9 9538.8 5118.8 5206.3 5214.1 5215.2 5218.0 4602.7 4742.9 4769.2 4774.8 4779.2 3554.0 3639.4 3704.8 3771.4 3844.2 1051.7 1146.7 1159.4 1239.4 1258.8 910.8 924.2 935.4 935.7 998.5 4811.7 5646.0 5934.3 5941.5 5997.2 840.5 1002.5 1034.4 1041.1 1059.0 3680.9 3787.4 3902.4 3939.5 3975.3 9638.1 10019.6 10026.0 10052.5 10060.4 9392.8 9653.9 9869.8 9959.3 9966.5 7651.8 7728.3 7752.0 7856.0 7857.1 5827.4 5834.2 5877.6 5925.4 5961.2 8961.6 9182.6 9207.9 9318.0 9338.7 9292.5 9392.2 9466.1 9477.8 9485.1 7236.5 7278.8 7287.1 7371.9 7378.2 7864.0 7869.6 7952.3 7952.9 7958.6 7161.0 7172.5 7189.6 7256.6 7336.3 6719.7 7082.5 7084.3 7142.8 7171.7 5615.4 6237.3 6322.9 6382.9 6388.6 5058.4 5064.4 5123.2 5167.0 5211.3 4962.4 4977.9 5038.3 5268.8 5313.8 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | [#4] prototype.html Cycles:180 Average:4401.76 Median:4857.71 stddev:1356.73 (27.9%) stddev-sans-first:1325.99 05:23:18 INFO - PROCESS | 2119 | Values: 348.8 350.6 359.3 369.0 370.6 5120.4 5344.0 5414.6 5479.5 5494.3 4646.4 5207.3 5285.2 5295.7 5315.8 3864.6 4023.6 4038.8 4131.6 4182.8 3532.9 3781.3 3830.4 3930.9 4165.3 3428.2 3575.1 4009.6 4019.4 4050.2 3656.9 3998.2 4055.4 4071.5 4073.6 3495.7 3496.6 3499.5 3502.6 3506.2 4584.5 4625.7 4920.3 4944.4 5335.6 3901.4 4615.9 4617.7 4636.9 4647.3 5609.9 5640.4 5658.8 5673.8 5680.3 3189.0 3479.5 3783.9 3828.9 3870.7 5801.5 5900.3 5916.9 5931.4 5950.1 3554.0 3813.0 3906.9 3921.6 3939.3 3819.8 3827.0 3952.5 3976.0 3998.2 3832.9 4601.3 4616.7 4629.0 4635.9 4991.7 5694.3 5705.6 5706.3 5737.4 1069.8 1087.0 1195.4 1246.5 1257.5 811.7 847.2 871.2 872.4 876.3 4458.3 4542.3 5023.1 5048.6 5111.6 4802.0 5370.0 5526.6 5594.8 5614.0 4210.0 4294.4 4349.5 4913.3 5009.3 2621.6 2640.5 2874.4 2906.2 2906.8 5148.8 5460.4 5500.3 5637.4 5690.9 4511.7 5424.8 5613.8 5721.8 5735.3 4743.6 5692.7 5720.0 5740.7 5785.3 4890.0 5153.7 5288.9 5547.1 5580.7 5078.2 5123.4 5456.8 5467.6 5480.8 4847.3 5071.0 5361.7 5707.7 5728.5 3065.8 3092.8 3638.9 3682.0 3727.9 4610.4 4817.8 4868.1 5192.8 5571.4 4325.7 4595.0 4804.0 5049.5 5470.0 4185.8 4986.4 5026.2 5324.9 5360.9 3980.8 4592.8 4662.3 5216.3 5329.3 5593.4 5650.7 5651.6 5678.0 5700.5 5071.6 5488.0 5499.9 5505.6 5510.0 05:23:18 INFO - PROCESS | 2119 | 05:23:18 INFO - PROCESS | 2119 | [#5] yui.html Cycles:180 Average:19854.48 Median:4500.56 stddev:29068.21 (645.9%) stddev-sans-first:29114.23 05:23:18 INFO - PROCESS | 2119 | Values: 715.5 754.8 765.6 815.2 842.9 14994.6 15369.0 15600.4 15724.2 15744.0 14195.4 14256.9 14439.6 14470.8 14472.2 656.7 873.3 875.1 875.4 875.5 562.4 709.2 709.4 834.9 866.2 905.7 908.5 918.3 920.8 921.7 756.0 912.0 912.8 913.5 914.5 530.6 548.7 642.7 687.0 688.8 14683.4 15154.0 15186.7 15198.0 15209.6 13548.3 13728.0 13762.9 13827.9 13875.7 12408.1 12504.9 12608.9 12684.8 13080.5 4384.8 4449.0 4485.1 4492.3 4601.2 108488.9 112281.0 112801.3 113067.4 113266.9 9186.4 10443.9 10875.8 11079.3 11159.3 17125.2 20404.9 21437.7 21489.9 22112.0 7616.6 7890.4 7905.1 7948.5 7998.6 4317.1 4392.7 4395.7 4508.8 4557.2 3639.7 3697.6 3703.9 3724.2 3731.9 675.4 680.1 682.1 694.5 698.2 546.8 646.2 695.8 699.4 703.7 7931.4 8275.7 10042.5 10125.0 10268.8 685.7 690.2 711.8 713.8 721.8 4113.4 4573.6 4995.1 5001.9 5002.1 90617.2 100476.0 102402.5 103082.0 106907.5 70227.9 73479.6 81089.0 83561.6 95516.5 80643.6 82321.0 82881.0 83265.6 84694.2 7808.8 9656.4 9690.1 9706.9 9788.8 41820.6 43846.1 46685.5 47925.0 49848.5 54659.7 56516.0 57645.4 58863.7 59474.0 11628.9 11648.2 11700.2 11798.2 11962.7 12913.7 13005.3 13341.8 13499.6 13521.8 11911.5 12036.2 12213.4 12554.9 12563.6 11802.8 12028.3 12179.8 12384.6 12464.5 11902.3 11995.5 12110.5 12448.2 12514.5 10302.9 10314.8 10339.7 10770.8 10865.3 9403.7 9925.2 9942.7 9948.6 9983.3 05:23:18 INFO - PROCESS | 2119 | -------- Summary: end -------- 05:23:18 INFO - PROCESS | 2119 | 05:23:19 INFO - TEST-INFO | 2119: exit 0 05:23:19 INFO - TEST-OK | dromaeo_css | took 1120480ms 05:23:19 INFO - TEST-START | kraken 05:23:19 INFO - operating with platform_type : mac_ 05:23:19 INFO - Initialising browser for kraken test... 05:23:19 INFO - TEST-INFO | started process 2234 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpqPpAHG/profile http://localhost:53255/getInfo.html) 05:23:21 INFO - PROCESS | 2234 | __metrics Screen width/height:1600/1200 05:23:21 INFO - PROCESS | 2234 | colorDepth:24 05:23:21 INFO - PROCESS | 2234 | Browser inner width/height: 1024/689 05:23:21 INFO - PROCESS | 2234 | __metrics 05:23:21 INFO - PROCESS | 2234 | 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" 05:23:21 INFO - PROCESS | 2234 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:22 INFO - TEST-INFO | 2234: exit 0 05:23:22 INFO - Browser initialized. 05:23:22 INFO - Running cycle 1/1 for kraken test... 05:23:22 INFO - TEST-INFO | started process 2235 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpqPpAHG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:34 INFO - PROCESS | 2235 | RSS: Main: 235143168 05:23:34 INFO - PROCESS | 2235 | 05:23:37 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53255/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:38 INFO - PROCESS | 2235 | RSS: Main: 289210368 05:23:38 INFO - PROCESS | 2235 | 05:23:40 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53255/tests/kraken/driver.html?testName=audio-dft) 05:23:41 INFO - PROCESS | 2235 | RSS: Main: 288223232 05:23:41 INFO - PROCESS | 2235 | 05:23:44 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53255/tests/kraken/driver.html?testName=audio-fft) 05:23:45 INFO - PROCESS | 2235 | RSS: Main: 379662336 05:23:45 INFO - PROCESS | 2235 | 05:23:47 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53255/tests/kraken/driver.html?testName=audio-oscillator) 05:23:47 INFO - PROCESS | 2235 | RSS: Main: 281640960 05:23:47 INFO - PROCESS | 2235 | 05:23:49 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53255/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:50 INFO - PROCESS | 2235 | RSS: Main: 286445568 05:23:50 INFO - PROCESS | 2235 | 05:23:53 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53255/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:54 INFO - PROCESS | 2235 | RSS: Main: 328855552 05:23:54 INFO - PROCESS | 2235 | 05:23:56 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53255/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:57 INFO - PROCESS | 2235 | RSS: Main: 331104256 05:23:57 INFO - PROCESS | 2235 | 05:24:00 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53255/tests/kraken/driver.html?testName=json-parse-financial) 05:24:01 INFO - PROCESS | 2235 | RSS: Main: 327712768 05:24:01 INFO - PROCESS | 2235 | 05:24:02 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53255/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:03 INFO - PROCESS | 2235 | RSS: Main: 303550464 05:24:03 INFO - PROCESS | 2235 | 05:24:05 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:05 INFO - PROCESS | 2235 | RSS: Main: 306606080 05:24:05 INFO - PROCESS | 2235 | 05:24:08 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:08 INFO - PROCESS | 2235 | RSS: Main: 307703808 05:24:08 INFO - PROCESS | 2235 | 05:24:11 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:12 INFO - PROCESS | 2235 | RSS: Main: 325775360 05:24:12 INFO - PROCESS | 2235 | 05:24:15 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:16 INFO - PROCESS | 2235 | RSS: Main: 319610880 05:24:16 INFO - PROCESS | 2235 | 05:24:17 INFO - PROCESS | 2235 | Cycle 1(1): loaded http://localhost:53255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53255/tests/kraken/driver.html?testName=ai-astar) 05:24:18 INFO - PROCESS | 2235 | RSS: Main: 363462656 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | __start_tp_report 05:24:18 INFO - PROCESS | 2235 | _x_x_mozilla_page_load 05:24:18 INFO - PROCESS | 2235 | _x_x_mozilla_page_load_details 05:24:18 INFO - PROCESS | 2235 | |i|pagename|runs| 05:24:18 INFO - PROCESS | 2235 | |0;ai-astar;114;114;116;159;171;114;114;115;115;114 05:24:18 INFO - PROCESS | 2235 | |1;audio-beat-detection;179;134;109;141;111;110;110;109;129;111 05:24:18 INFO - PROCESS | 2235 | |2;audio-dft;185;185;186;182;192;181;181;183;184;185 05:24:18 INFO - PROCESS | 2235 | |3;audio-fft;81;59;60;87;62;59;59;58;74;59 05:24:18 INFO - PROCESS | 2235 | |4;audio-oscillator;89;74;88;72;69;69;83;68;66;83 05:24:18 INFO - PROCESS | 2235 | |5;imaging-gaussian-blur;89;86;90;88;90;87;91;132;90;86 05:24:18 INFO - PROCESS | 2235 | |6;imaging-darkroom;95;95;96;95;94;95;96;96;95;95 05:24:18 INFO - PROCESS | 2235 | |7;imaging-desaturate;128;137;92;86;86;84;85;88;86;112 05:24:18 INFO - PROCESS | 2235 | |8;json-parse-financial;56;56;56;55;57;57;57;57;56;56 05:24:18 INFO - PROCESS | 2235 | |9;json-stringify-tinderbox;67;76;77;76;72;72;71;72;73;77 05:24:18 INFO - PROCESS | 2235 | |10;stanford-crypto-aes;87;87;88;95;107;88;86;86;88;88 05:24:18 INFO - PROCESS | 2235 | |11;stanford-crypto-ccm;144;148;152;154;143;142;141;152;216;170 05:24:18 INFO - PROCESS | 2235 | |12;stanford-crypto-pbkdf2;174;176;173;175;176;173;171;172;170;173 05:24:18 INFO - PROCESS | 2235 | |13;stanford-crypto-sha256-iterative;69;67;67;67;67;67;68;67;68;66 05:24:18 INFO - PROCESS | 2235 | __end_tp_report 05:24:18 INFO - PROCESS | 2235 | __start_cc_report 05:24:18 INFO - PROCESS | 2235 | _x_x_mozilla_cycle_collect,1979 05:24:18 INFO - PROCESS | 2235 | __end_cc_report 05:24:18 INFO - PROCESS | 2235 | __startTimestamp1484054658064__endTimestamp 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | ------- Summary: start ------- 05:24:18 INFO - PROCESS | 2235 | Number of tests: 14 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#0] ai-astar Cycles:10 Average:124.60 Median:115.00 stddev:21.49 (18.7%) stddev-sans-first:22.45 05:24:18 INFO - PROCESS | 2235 | Values: 114.0 114.0 116.0 159.0 171.0 114.0 114.0 115.0 115.0 114.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:120.00 stddev:22.65 (18.9%) stddev-sans-first:12.72 05:24:18 INFO - PROCESS | 2235 | Values: 179.0 134.0 109.0 141.0 111.0 110.0 110.0 109.0 129.0 111.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:3.20 (1.7%) stddev-sans-first:3.39 05:24:18 INFO - PROCESS | 2235 | Values: 185.0 185.0 186.0 182.0 192.0 181.0 181.0 183.0 184.0 185.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#3] audio-fft Cycles:10 Average:65.80 Median:61.00 stddev:10.76 (17.6%) stddev-sans-first:9.91 05:24:18 INFO - PROCESS | 2235 | Values: 81.0 59.0 60.0 87.0 62.0 59.0 59.0 58.0 74.0 59.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:78.50 stddev:8.77 (11.2%) stddev-sans-first:7.97 05:24:18 INFO - PROCESS | 2235 | Values: 89.0 74.0 88.0 72.0 69.0 69.0 83.0 68.0 66.0 83.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:89.50 stddev:13.85 (15.5%) stddev-sans-first:14.62 05:24:18 INFO - PROCESS | 2235 | Values: 89.0 86.0 90.0 88.0 90.0 87.0 91.0 132.0 90.0 86.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:24:18 INFO - PROCESS | 2235 | Values: 95.0 95.0 96.0 95.0 94.0 95.0 96.0 96.0 95.0 95.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:86.00 stddev:19.86 (23.1%) stddev-sans-first:17.94 05:24:18 INFO - PROCESS | 2235 | Values: 128.0 137.0 92.0 86.0 86.0 84.0 85.0 88.0 86.0 112.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 05:24:18 INFO - PROCESS | 2235 | Values: 56.0 56.0 56.0 55.0 57.0 57.0 57.0 57.0 56.0 56.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:74.50 stddev:3.20 (4.3%) stddev-sans-first:2.45 05:24:18 INFO - PROCESS | 2235 | Values: 67.0 76.0 77.0 76.0 72.0 72.0 71.0 72.0 73.0 77.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:88.00 stddev:6.50 (7.4%) stddev-sans-first:6.80 05:24:18 INFO - PROCESS | 2235 | Values: 87.0 87.0 88.0 95.0 107.0 88.0 86.0 86.0 88.0 88.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:152.00 stddev:22.68 (14.9%) stddev-sans-first:23.62 05:24:18 INFO - PROCESS | 2235 | Values: 144.0 148.0 152.0 154.0 143.0 142.0 141.0 152.0 216.0 170.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:173.50 stddev:2.00 (1.2%) stddev-sans-first:2.11 05:24:18 INFO - PROCESS | 2235 | Values: 174.0 176.0 173.0 175.0 176.0 173.0 171.0 172.0 170.0 173.0 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - PROCESS | 2235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.60 05:24:18 INFO - PROCESS | 2235 | Values: 69.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 66.0 05:24:18 INFO - PROCESS | 2235 | -------- Summary: end -------- 05:24:18 INFO - PROCESS | 2235 | 05:24:18 INFO - TEST-INFO | 2235: exit 0 05:24:18 INFO - TEST-OK | kraken | took 59953ms 05:24:18 INFO - SUITE-END | took 1180s 05:24:19 INFO - Completed test suite (00:19:40) 05:24:19 INFO - javascript benchmark 05:24:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.6349501554832, 3330.0675810772987, 3343.314620502797, 3351.2627222011147, 3381.9661803381973, 5660.094384898417, 5741.712914354276, 5765.942340576598, 5769.278840144982, 5830.679312637809, 5670.518005969498, 5719.113537401699, 5720.0, 5727.11229759388, 5751.741171647275, 5137.58899288057, 5173.922391164136, 5178.275041494194, 5207.323048003755, 5213.6089793265655, 5245.370555533342, 5253.395859476171, 5253.816116435906, 5258.421573626898, 5265.526102650761, 5228.111221092405, 5231.659942103751, 5232.764525596338, 5235.424103348629, 5246.658967167141, 5243.868903277429, 5244.108501554726, 5253.106971814801, 5253.343332083489, 5257.421683614799, 5131.102057139986, 5133.178691409356, 5204.063268611649, 5214.983078299733, 5216.634835561512, 5700.743466544015, 5737.3975732548315, 5795.0, 5801.883962320772, 5862.237909071836, 6230.2523697156175, 6269.780557680459, 6272.2159730033745, 6282.4974002079725, 6290.056491526262, 4751.691140075884, 5945.691947771526, 6138.57232748375, 6153.046277826944, 6182.319944806068, 5863.413658634103, 5880.147378630075, 5886.735096920649, 5907.2911250650195, 5922.822315330547, 6242.1261023456755, 6247.437730604267, 6253.7185826637915, 6254.186955695731, 6272.1219029335925, 5484.862878427992, 5877.882442351129, 6089.086637004485, 6108.767064740488, 6130.122981477994, 6198.6280823150755, 6244.250689917239, 6248.812535623939, 6276.717547710364, 6277.278113016971, 6137.877242455126, 6233.812985610439, 6240.906386404207, 6256.74973001084, 6267.561270711098, 6267.435930766253, 6269.655168965751, 6275.780347687901, 6280.685965701697, 6287.779927702509, 4879.072976134523, 4906.190478570996, 4914.926276105862, 4962.60299176065, 4987.700737955734, 4447.577480139382, 4450.6884518083425, 4478.104379124188, 4490.887727806766, 4491.842785502492, 5742.9949758792045, 5745.1382292656435, 5753.395893431213, 5766.077427611562, 5817.360090390053, 6155.322914479404, 6183.350748171467, 6201.1938448002375, 6235.282942461584, 6267.71795269214, 5684.459976302244, 5692.288463942007, 5722.456366645162, 5733.283339582552, 5799.536037117021, 5350.91973620396, 5409.486098820606, 5423.593230507728, 5455.863603409867, 5492.945070549324, 6190.845228869314, 6211.16149319836, 6213.689315534296, 6229.470495007975, 6270.874582508233, 5809.970950145223, 6190.628562286277, 6234.844128896814, 6293.433590976834, 6306.117143599808, 6216.813495595139, 6217.937820621736, 6225.221847269091, 6256.468200202851, 6271.0, 6215.595986260879, 6219.906701399392, 6225.159603453476, 6231.470325022424, 6251.71867265965, 5348.57507655779, 6013.338532761305, 6261.843453913506, 6268.404501572343, 6273.121762953281, 5997.0404735242155, 6026.819195423969, 6034.487068599218, 6034.879302414015, 6177.351378105234, 6075.787347442818, 6108.675989703, 6136.386361363828, 6139.4001448444, 6164.568480206342, 5969.283685957713, 6028.788992385245, 6043.75824967014, 6059.363766804422, 6062.151298818258, 6147.600405973598, 6163.96918015407, 6177.6911154443, 6184.690765461619, 6215.720292586935, 5767.221425107557, 5798.420157984167, 5807.245058142415, 5957.582969192288, 6043.00290452088], "value": 5696.931147323427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.68032377335834, 467.0845143518703, 492.608376340809, 495.6901936289821, 499.32840329756476, 29853.0, 41316.58683413169, 42714.572854271406, 42904.71285861421, 42972.925676858096, 42914.57085429145, 43300.0, 43415.0, 43459.0, 43499.912502187384, 9284.675036373728, 9390.605395624107, 9392.201662858632, 9394.389364691273, 9398.765030874214, 8452.366072544584, 8686.522241276758, 11117.777644447106, 11319.547218111265, 11403.828942565868, 11200.271982321165, 11301.321920684744, 11301.830472542919, 11323.980841724244, 11334.433278336091, 11324.60363887264, 11393.715157121056, 11397.202195846294, 11414.885851141466, 11424.942875285611, 8381.916180838174, 8633.870491942625, 10989.395583242998, 11260.04289635382, 11299.0, 40606.796966015274, 41066.38400423966, 41639.375409368884, 41651.7917410411, 41821.79089104565, 4024.2756303865294, 4026.5973402659793, 4062.9187416251807, 4070.5318888327924, 4072.0634254121424, 30428.032602529947, 30747.385052299054, 31307.373852522822, 31341.373172536423, 31344.843275783704, 3201.103690966533, 3216.099492142204, 3232.886848960275, 3306.173456635841, 3339.282054358325, 472494.0, 473124.0, 474622.0, 474884.62557687337, 477007.0, 61338.69330653318, 61751.69124154351, 61797.382026180065, 61831.0, 61937.690311548155, 64648.67675661592, 66637.0, 66833.0, 66962.66074678577, 67077.32922670808, 15770.842291576937, 16343.427980020642, 16379.262933168036, 16408.0, 16420.589485262964, 11274.323540587591, 12406.317652529198, 12480.43838027291, 12510.562130325396, 12557.874421255854, 15696.529104126666, 16208.675826483404, 16237.51287461378, 16250.0, 16258.268377923021, 7169.211386747454, 7536.107820789709, 7730.845383092306, 7764.650590723431, 7831.0, 703.2756261051126, 748.8389996150854, 860.6987554355925, 880.3529405886668, 892.2014796756996, 25216.747832521807, 29845.894653387193, 29889.40221195564, 29899.03819812816, 29981.400371992873, 889.2841262783392, 972.1930797438109, 1049.5959055763585, 1083.5286650307141, 1088.689723428819, 14720.190389528465, 14992.47526336573, 15421.614459638375, 15511.5346539604, 15839.604009899615, 582102.0, 584004.0, 584486.0, 584933.0, 586475.0, 60812.08781868187, 60947.0, 61069.08396374058, 61248.46878827976, 61360.0, 1410.92945352734, 1452.9200893950722, 1460.5545308680955, 1466.2888499077726, 1473.2707309881464, 28098.71901280961, 28844.64461562288, 29214.415711686073, 29549.409011820073, 29977.0, 51855.962880742925, 51974.0, 51996.74001629968, 52041.0, 52232.21651675304, 485171.0, 511838.0, 513275.0, 515616.0, 518468.0, 40173.39739903962, 40886.0, 40992.79503602463, 41021.58978410297, 41122.794386029076, 37880.24239515249, 45825.77087114543, 47271.52728472671, 48071.0, 50288.74855625845, 37031.814840925625, 38763.41854872123, 39051.0, 40170.0, 40566.79716601398, 30923.2269193263, 38708.03229919162, 39039.41440878446, 39980.600193997685, 40278.597214028654, 37355.879323620335, 37357.62642373541, 37478.62521374752, 38070.23859522738, 38268.04329891664, 32483.350332992733, 33391.0, 34086.829565852015, 34174.0, 34209.65790342164, 23487.530249394575, 24679.80443324603, 24820.875895620407, 25159.371015724755, 25494.235172944842], "value": 20250.269909303865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3581219363664, 388.66380580797613, 392.3017029687158, 396.0889953107852, 420.44291314008944, 14120.71758564828, 20701.275455359064, 20757.16971321149, 21411.036503357365, 21452.785472145293, 20944.581108377824, 20992.16031358744, 21934.670979935312, 22061.33815985523, 22436.990335434904, 5375.193720941851, 5647.265855438787, 6141.938580614204, 6142.3550527194675, 6146.848602988963, 4988.102141614508, 5139.768710408022, 5989.341172471025, 6113.0, 6113.32753397126, 6083.695815209222, 6086.539230584672, 6095.116208149816, 6096.35988221237, 6101.847453813646, 5853.941460585404, 6004.849878753044, 6067.9696601516935, 6075.934182377969, 6093.086037094427, 4544.431946006749, 5322.9620224056325, 5324.227986941911, 5339.5461385782255, 5348.598855085846, 26070.0, 26365.868170659025, 26820.86589567059, 26912.0, 26974.325641858915, 2499.962500562493, 2616.2282126772457, 3052.6947305269296, 3137.796043257181, 3143.7327827134723, 8469.110743371919, 10193.592256309812, 10534.26260161789, 10547.525361358681, 10612.257142000062, 1780.6616742818824, 1862.3481781376545, 1870.672632289344, 1873.9386476260443, 1894.4222012286248, 135721.3213933934, 138495.30752346275, 139540.0, 140810.59189408078, 144811.0, 11232.887671123348, 11630.0, 11833.940830295793, 11888.583899563473, 12084.335361555022, 12704.80942785859, 14429.639259018608, 15234.771478427832, 15675.608109797118, 15687.372505099896, 8020.077691065486, 8260.669573217125, 8266.586670666442, 8579.65681372738, 8580.442271252474, 6711.6979735912, 6954.4436445084275, 8311.33509319265, 8466.872996905051, 8474.872876906851, 4401.2517871961845, 4566.833933758337, 4755.001449695534, 4816.4220293564995, 4826.879328016757, 1786.4819202431408, 2016.163292233736, 2017.3760123101044, 2017.7982201779705, 2020.8585399022222, 1000.214831357381, 1038.0294424712768, 1044.3499271151713, 1054.667779649408, 1055.6358056470506, 16867.0, 21702.456665419628, 21959.15479624734, 21994.330997864094, 22014.37914374669, 1038.8026275007724, 1049.511976930731, 1067.6156583629886, 1068.3322923173016, 1075.7471994081384, 9182.827283717497, 10595.682129536126, 11230.606928757454, 11413.771724565462, 11521.942390287995, 698327.0, 703889.416587516, 710231.0, 710827.0, 711709.4414527895, 113041.78289690608, 130472.0, 152517.0, 156215.43784562236, 156598.6510202348, 979.4319294808994, 1061.3419679798574, 1062.5377960587016, 1072.1904961753826, 1073.9087177589836, 15825.208739563206, 17763.0, 19463.221471140994, 20154.684041680255, 20336.898315508326, 46337.0, 58623.70688146532, 59429.51426214206, 60226.39773602208, 60969.69515152573, 69538.87075081532, 81753.59123204346, 88618.0, 88732.0, 90431.0, 7309.488335816654, 8337.708180213664, 8527.786805329917, 8634.0, 8684.43551169172, 11549.0, 13047.478100876238, 13322.86677133255, 13509.189448633113, 13669.453221871014, 11263.380514071805, 11290.096792256763, 11508.251963622337, 11575.189736718348, 11690.532378704756, 11238.494267757807, 11300.321980681185, 11308.321500709984, 11639.709007274885, 11678.0, 9750.951245243728, 11384.14618903602, 11435.428228588371, 11770.76458470843, 11772.175947683923, 5800.9419905800405, 6982.0, 7369.63151842395, 7574.734884279244, 7703.152653208031, 4783.1390349737385, 5635.154726791015, 8282.0, 10730.570777169138, 11251.69340285256], "value": 9799.255484461753, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1274.9872501274986, 1436.4397884824916, 1440.77667961466, 1457.133005861512, 1460.0947412604173, 7991.84016319674, 8398.49609023459, 8406.83186336273, 8421.031581368145, 8427.494350338977, 7336.449766267525, 7677.884831727514, 7714.575698336589, 7769.961150194241, 7778.144404115557, 2073.720047793551, 2240.204727321802, 2301.160076572056, 2312.028947841902, 2322.616768233248, 2326.4881726020335, 2326.523062772136, 2326.6277395616703, 2329.312852708447, 2334.171369163948, 2241.081156725743, 2266.9433264168365, 2288.496530763229, 2301.4821665125382, 2307.1463558483383, 2017.9596408071902, 2086.3845165676084, 2226.265332440291, 2299.5975704251855, 2305.6887320211727, 2290.9656355154684, 2310.191432998454, 2313.236631911482, 2321.454458202321, 2322.88385580722, 8352.290055345304, 8409.159084091541, 8424.578771061422, 8433.74698759032, 8462.2383985441, 5050.797968081272, 5204.557612602934, 5212.895742085175, 5215.973920130413, 5223.08595995703, 3267.232200432896, 3348.631650518441, 3515.1915059536195, 3523.3305671922253, 3524.4184709522897, 1186.9703257418548, 1243.3161761031397, 1244.2907542700664, 1246.8566114896812, 1260.212367270456, 10725.624603138931, 10787.406692631823, 10801.621943231949, 10838.078763305128, 10849.566017359297, 3700.481932529448, 4596.080783843245, 4652.441706995182, 4654.185517534418, 4664.766761661904, 9449.858252126223, 9492.525373731285, 9501.192398646193, 9519.857202141973, 9538.761530961781, 5118.820841270612, 5206.297149884717, 5214.0875346814155, 5215.16557350822, 5218.034663587173, 4602.723836569817, 4742.928856067162, 4769.236922092448, 4774.809007639725, 4779.163646361872, 3553.964460355415, 3639.4358874374516, 3704.833282502294, 3771.358868992223, 3844.154286057063, 1051.673981065872, 1146.7075895646724, 1159.4202898550725, 1239.39269757818, 1258.7734207842677, 910.7723069232692, 924.2190349154953, 935.4247138010074, 935.6865450074301, 998.5057396588735, 4811.735354555463, 5646.040173170571, 5934.317553481319, 5941.494972927349, 5997.190379298826, 840.4999025579771, 1002.5238011944414, 1034.4103860799273, 1041.1410586266209, 1058.9576416943237, 3680.8527658893345, 3787.398311052085, 3902.434147048662, 3939.4681717967705, 3975.3241948868185, 9638.084381983701, 10019.649312274036, 10026.047525485068, 10052.497375131214, 10060.39637621745, 9392.765180870396, 9653.855192172123, 9869.75325616851, 9959.302848800658, 9966.451845148442, 7651.808704782314, 7728.304452599181, 7751.961240193763, 7855.960720196363, 7857.1357150713375, 5827.446392592697, 5834.212381328466, 5877.617954832922, 5925.40745925404, 5961.225040744675, 8961.641534338554, 9182.586783594621, 9207.907920920705, 9317.953410232905, 9338.673146439842, 9292.535373231176, 9392.154706076486, 9466.05339466048, 9477.763055923382, 9485.146336829443, 7236.529625574321, 7278.818029549304, 7287.089113860768, 7371.852562948819, 7378.225286345071, 7864.0, 7869.6458659361615, 7952.284294413299, 7952.880706789287, 7958.602069896598, 7161.0, 7172.49792514519, 7189.604571748395, 7256.564606123649, 7336.339729424378, 6719.731210751515, 7082.5396349237135, 7084.326988936043, 7142.785716428515, 7171.713131474683, 5615.354234262949, 6237.251529816451, 6322.873542529215, 6382.936170638234, 6388.584741991755, 5058.3929928408825, 5064.366954130734, 5123.231515272739, 5167.0, 5211.2704221409795, 4962.429320628174, 4977.850664480072, 5038.294638750651, 5268.841934741964, 5313.814016509404], "value": 4429.62137582742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.84302064071164, 350.6475991628413, 359.335229824824, 368.9557253129625, 370.5979012771145, 5120.411152717429, 5344.0494219609855, 5414.593905457087, 5479.534239589635, 5494.313210848644, 4646.4191976003, 5207.270982062514, 5285.229448134879, 5295.682259064459, 5315.787368505265, 3864.613663491929, 4023.577524359944, 4038.848928055505, 4131.586841315874, 4182.79086045698, 3532.858685652571, 3781.3362120666957, 3830.4062870255157, 3930.921381572367, 4165.33354663254, 3428.177237463016, 3575.1240945968275, 4009.619086186822, 4019.3970904364432, 4050.2102090092444, 3656.9085772855624, 3998.180373023538, 4055.3511438170044, 4071.470708807836, 4073.635332163729, 3495.667911548399, 3496.6328535503662, 3499.5100685903994, 3502.579690437138, 3506.1760486285702, 4584.472785629662, 4625.674993880699, 4920.3111564381015, 4944.3572335596145, 5335.626506144571, 3901.3757798752063, 4615.861524154281, 4617.746023968681, 4636.907261854778, 4647.279671650899, 5609.859753506154, 5640.351359593658, 5658.7647879087945, 5673.773049078032, 5680.289963754531, 3189.04328701391, 3479.5128681984543, 3783.883754292463, 3828.889622009614, 3870.7290489665734, 5801.477866991991, 5900.291964964189, 5916.852078698024, 5931.406859314077, 5950.107483877367, 3553.982230088833, 3812.980935095307, 3906.921861562753, 3921.647051765298, 3939.330313846653, 3819.7708137511836, 3826.9858487500833, 3952.4861767970556, 3976.005998500375, 3998.1608460108096, 3832.9041773955873, 4601.332806743004, 4616.676832621752, 4629.032661119011, 4635.860924172212, 4991.675541089818, 5694.316681998187, 5705.62913410627, 5706.3152421709665, 5737.393529811659, 1069.764651776608, 1086.9510872010778, 1195.3784032303154, 1246.4827096754746, 1257.5472829781272, 811.7077851973285, 847.2332539052168, 871.2202578692035, 872.4459967920416, 876.3033388456192, 4458.286674132188, 4542.250528662799, 5023.136812017188, 5048.646594738333, 5111.591072714174, 4801.95198048022, 5369.973150134224, 5526.58550608706, 5594.776208951596, 5613.989481893298, 4209.97895010523, 4294.420253265769, 4349.541719737294, 4913.31213630092, 5009.323741294878, 2621.6460777795137, 2640.5379058664657, 2874.4107457971068, 2906.229849089993, 2906.8401237932117, 5148.841510660071, 5460.426655201226, 5500.312460942382, 5637.408072152447, 5690.874116265674, 4511.691609433293, 5424.83725488236, 5613.803516876971, 5721.799737009184, 5735.254416925773, 4743.644226683013, 5692.658440493501, 5720.027595308724, 5740.655560666373, 5785.30576330843, 4889.973105647854, 5153.665011774223, 5288.867778305573, 5547.084731019337, 5580.665160090408, 5078.21287700407, 5123.436421993503, 5456.809011684572, 5467.5669327149035, 5480.780768769205, 4847.34560834297, 5071.036503064406, 5361.651492652965, 5707.746584446825, 5728.455796699307, 3065.7547396207806, 3092.829894355832, 3638.909027274339, 3681.950644066428, 3727.944080838844, 4610.372087909859, 4817.807287708452, 4868.075065737498, 5192.754528419738, 5571.4428557143965, 4325.6755743318745, 4594.954050459452, 4803.975980120217, 5049.545540901337, 5469.972650136724, 4185.769782661982, 4986.429274778433, 5026.170681837456, 5324.9467505326, 5360.865978350416, 3980.7611543307494, 4592.828828648673, 4662.254039353823, 5216.321878155815, 5329.333833270841, 5593.384727680033, 5650.660960342392, 5651.6043876928225, 5678.0, 5700.515456186271, 5071.594272458121, 5487.972560137174, 5499.9175012375645, 5505.587080968863, 5510.0], "value": 3982.6370129523984, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.4955756191886, 754.826389930316, 765.609539135041, 815.2214635023553, 842.8609279468888, 14994.625134371632, 15369.0, 15600.375984960601, 15724.195712127026, 15744.0, 14195.432182712704, 14256.928715356435, 14439.63900902478, 14470.782938255934, 14472.204028778413, 656.6683824668547, 873.2664561768114, 875.0942774228674, 875.3609864798701, 875.5272153037353, 562.3701454371089, 709.1561042359601, 709.4218212157101, 834.9332053435711, 866.2074202105098, 905.6965916417975, 908.5094049213417, 918.347972939214, 920.7606022434181, 921.7004473546091, 755.9886601700979, 911.9772005699845, 912.8219997100568, 913.5386629751932, 914.4558987402485, 530.5596355025358, 548.7009579778991, 642.7204166187723, 686.9695456814778, 688.8071340024801, 14683.412663493447, 15154.014989025678, 15186.696266074727, 15198.0, 15209.61975950599, 13548.254845983467, 13728.039037267396, 13762.931185344109, 13827.861721382758, 13875.722485550334, 12408.069394795337, 12504.937475312656, 12608.873911260953, 12684.809727853997, 13080.476780928751, 4384.758838263894, 4448.955510444886, 4485.102979404132, 4492.303692927601, 4601.217792975202, 108488.91511084946, 112281.0, 112801.30798038036, 113067.43466282699, 113266.86733132646, 9186.40288381253, 10443.94778026105, 10875.782484350428, 11079.279846809932, 11159.330440173615, 17125.22936467862, 20404.897975510026, 21437.67843482349, 21489.89255053746, 22112.00495977685, 7616.619169041636, 7890.408219383569, 7905.130435652074, 7948.483348582324, 7998.600069996477, 4317.140739782857, 4392.692511524227, 4395.692301538862, 4508.81964721414, 4557.225271703818, 3639.6724294813066, 3697.556293244774, 3703.8888833335045, 3724.15654251142, 3731.9067023324633, 675.3651567526509, 680.1022650101818, 682.0996284903879, 694.4652617484509, 698.1831257428719, 546.771904489208, 646.2342124582291, 695.7634404302562, 699.3985172751429, 703.7396163419568, 7931.365490760725, 8275.668973241123, 10042.548085336177, 10124.987501249816, 10268.845967310497, 685.7394190207789, 690.1959217511643, 711.772232885482, 713.8322494213855, 721.7762493626992, 4113.362428823537, 4573.588377046081, 4995.100881841304, 5001.9499805002215, 5002.1496345621335, 90617.23581137511, 100476.0, 102402.48798755958, 103082.0, 106907.46546267219, 70227.94658080133, 73479.63260183771, 81088.97277568108, 83561.58219208865, 95516.52241738747, 80643.59678201689, 82321.0, 82881.0, 83265.58367208125, 84694.15305846863, 7808.7657370278985, 9656.420614763138, 9690.12788849007, 9706.913013702087, 9788.804223915624, 41820.58179418289, 43846.12307753891, 46685.533144668116, 47925.0, 49848.50454486371, 54659.72670136624, 56516.0, 57645.423545764, 58863.70568147132, 59474.0, 11628.88371116278, 11648.242864213798, 11700.204604596569, 11798.174127810971, 11962.70093247641, 12913.741725165632, 13005.349732513525, 13341.799873001719, 13499.595012149652, 13521.797173042609, 11911.52353905834, 12036.217645852992, 12213.38933053326, 12554.937225314181, 12563.560275390317, 11802.763944720886, 12028.27830330183, 12179.817302740288, 12384.56654017105, 12464.5014199431, 11902.345371004678, 11995.520179193083, 12110.51557937708, 12448.190867593577, 12514.499420023461, 10302.948485257526, 10314.845277320695, 10339.741506462098, 10770.838437423601, 10865.293755905841, 9403.717888463358, 9925.205983521157, 9942.701718948443, 9948.602055917681, 9983.301168918397], "value": 7323.689576615636, "unit": "score"}], "name": "dromaeo_css", "value": 7257.107778873573, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 159.0, 171.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 124.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 134.0, 109.0, 141.0, 111.0, 110.0, 110.0, 109.0, 129.0, 111.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 186.0, 182.0, 192.0, 181.0, 181.0, 183.0, 184.0, 185.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 87.0, 62.0, 59.0, 59.0, 58.0, 74.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 74.0, 88.0, 72.0, 69.0, 69.0, 83.0, 68.0, 66.0, 83.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 88.0, 90.0, 87.0, 91.0, 132.0, 90.0, 86.0], "value": 92.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 137.0, 92.0, 86.0, 86.0, 84.0, 85.0, 88.0, 86.0, 112.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 57.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 77.0, 76.0, 72.0, 72.0, 71.0, 72.0, 73.0, 77.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 95.0, 107.0, 88.0, 86.0, 86.0, 88.0, 88.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 148.0, 152.0, 154.0, 143.0, 142.0, 141.0, 152.0, 216.0, 170.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 173.0, 175.0, 176.0, 173.0, 171.0, 172.0, 170.0, 173.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1478.0999999999997, "alertThreshold": 2.0}]} 05:24:19 INFO - Return code: 0 05:24:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:24:19 INFO - # TBPL SUCCESS # 05:24:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:24:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:24:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:24:19 INFO - 2017-01-10 05:24:19.356 screenresolution[2245:18806] starting screenresolution argv=screenresolution get 05:24:19 INFO - 2017-01-10 05:24:19.359 screenresolution[2245:18806] Display 0: 1600x1200x32@60 05:24:19 INFO - 2017-01-10 05:24:19.366 screenresolution[2246:18809] starting screenresolution argv=screenresolution list 05:24:19 INFO - Available Modes on Display 0 05:24:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:24:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:24:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:24:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:24:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:24:19 INFO - Intel Iris: 05:24:19 INFO - Chipset Model: Intel Iris 05:24:19 INFO - Type: GPU 05:24:19 INFO - Bus: Built-In 05:24:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:24:19 INFO - Vendor: Intel (0x8086) 05:24:19 INFO - Device ID: 0x0a2e 05:24:19 INFO - Revision ID: 0x0009 05:24:19 INFO - Displays: 05:24:19 INFO - Display: 05:24:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:24:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:24:19 INFO - Display Serial Number: 1600x1200 60 05:24:19 INFO - Main Display: Yes 05:24:19 INFO - Mirror: Off 05:24:19 INFO - Online: Yes 05:24:19 INFO - Rotation: Supported 05:24:19 INFO - Return code: 0 05:24:19 INFO - Running post-action listener: _resource_record_post_action 05:24:19 INFO - [mozharness: 2017-01-10 13:24:19.601875Z] Finished run-tests step (success) 05:24:19 INFO - Running post-run listener: _resource_record_post_run 05:24:19 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 520192; Write bytes: 552819200; Read time: 5; Write time: 1697 05:24:19 INFO - TinderboxPrint: CPU usage
54.0% 05:24:19 INFO - TinderboxPrint: I/O read bytes / time
520,192 / 5 05:24:19 INFO - TinderboxPrint: I/O write bytes / time
552,819,200 / 1,697 05:24:19 INFO - TinderboxPrint: CPU idle
2,215.9 (46.0%) 05:24:19 INFO - TinderboxPrint: CPU system
972.4 (20.2%) 05:24:19 INFO - TinderboxPrint: CPU user
1,625.2 (33.8%) 05:24:19 INFO - TinderboxPrint: Swap in / out
249,802,752 / 0 05:24:19 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243816960; Write bytes: 236331008; Read time: 17743; Write time: 504 05:24:19 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 483328; Write bytes: 300931584; Read time: 5; Write time: 1148 05:24:20 INFO - Running post-run listener: _upload_blobber_files 05:24:20 INFO - Blob upload gear active. 05:24:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:20 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 05:24:20 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'] 05:24:20 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 05:24:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:24:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:21 INFO - (blobuploader) - INFO - Done attempting. 05:24:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:24:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:24:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:22 INFO - (blobuploader) - INFO - Done attempting. 05:24:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:24:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:23 INFO - (blobuploader) - INFO - Done attempting. 05:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:25 INFO - (blobuploader) - INFO - Done attempting. 05:24:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:25 INFO - Return code: 0 05:24:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a16842f747ffc9a5050356cf84718f83421d897616493d297f9cc491749a84d397912060b66ad09982d54bba3eeeb9e696951ac962349c35689ea251769520d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04ebc5eba26416ede5a62a8f8a3f05a39b56bdbad23007d9ea77ac9363bac9bdf80e6660970e200fc0a8fbe89e9bc926594de837d22ad4815e3a26a8312ca51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64701f7554e4ed4fa25a135334e8bc7ce1794ae05fc369fa760b1b469d1d7bcdda76d31230dde92da709eb6e69eb855e4c73dae048fe51e19de11578e366c3cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37374bd47fca6d9140094ff535a162c34f70f205c1880c7d60c05f4a485d9c337a4331242467b4a902af8df6b74c3cf474b196be5a67d786943ca1b47913fb76"} 05:24:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:25 INFO - Contents: 05:24:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a16842f747ffc9a5050356cf84718f83421d897616493d297f9cc491749a84d397912060b66ad09982d54bba3eeeb9e696951ac962349c35689ea251769520d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04ebc5eba26416ede5a62a8f8a3f05a39b56bdbad23007d9ea77ac9363bac9bdf80e6660970e200fc0a8fbe89e9bc926594de837d22ad4815e3a26a8312ca51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64701f7554e4ed4fa25a135334e8bc7ce1794ae05fc369fa760b1b469d1d7bcdda76d31230dde92da709eb6e69eb855e4c73dae048fe51e19de11578e366c3cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37374bd47fca6d9140094ff535a162c34f70f205c1880c7d60c05f4a485d9c337a4331242467b4a902af8df6b74c3cf474b196be5a67d786943ca1b47913fb76"} 05:24:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:25 INFO - Copying logs to upload dir... 05:24:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.435548 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-10 05:24:25.554652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 05:24:25.558138) ========= 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.zt8kfHkAxk/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.hYQCMniSk6/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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/a16842f747ffc9a5050356cf84718f83421d897616493d297f9cc491749a84d397912060b66ad09982d54bba3eeeb9e696951ac962349c35689ea251769520d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04ebc5eba26416ede5a62a8f8a3f05a39b56bdbad23007d9ea77ac9363bac9bdf80e6660970e200fc0a8fbe89e9bc926594de837d22ad4815e3a26a8312ca51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64701f7554e4ed4fa25a135334e8bc7ce1794ae05fc369fa760b1b469d1d7bcdda76d31230dde92da709eb6e69eb855e4c73dae048fe51e19de11578e366c3cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37374bd47fca6d9140094ff535a162c34f70f205c1880c7d60c05f4a485d9c337a4331242467b4a902af8df6b74c3cf474b196be5a67d786943ca1b47913fb76"} build_url:https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/RpPhdMLYS_64CJJds1gRXA/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/a16842f747ffc9a5050356cf84718f83421d897616493d297f9cc491749a84d397912060b66ad09982d54bba3eeeb9e696951ac962349c35689ea251769520d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04ebc5eba26416ede5a62a8f8a3f05a39b56bdbad23007d9ea77ac9363bac9bdf80e6660970e200fc0a8fbe89e9bc926594de837d22ad4815e3a26a8312ca51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64701f7554e4ed4fa25a135334e8bc7ce1794ae05fc369fa760b1b469d1d7bcdda76d31230dde92da709eb6e69eb855e4c73dae048fe51e19de11578e366c3cb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37374bd47fca6d9140094ff535a162c34f70f205c1880c7d60c05f4a485d9c337a4331242467b4a902af8df6b74c3cf474b196be5a67d786943ca1b47913fb76"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 05:24:25.593070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 05:24:25.593420) ========= 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.zt8kfHkAxk/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.hYQCMniSk6/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.004539 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 05:24:25.641815) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 05:24:25.642160) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 05:24:25.642495) ========= ========= Total master_lag: 2.07 =========