builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0323 starttime: 1488754356.43 results: success (0) buildid: 20170305112323 builduid: 53f3f4be66ed4f63a3b03dc10c60263d revision: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.427534) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.427989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.428544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.478153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.478734) ========= 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.LKGvFgSMwt/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.03CXckBHO5/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-05 14:52:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 184M=0s 2017-03-05 14:52:36 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120307 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.628350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.628929) ========= 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.LKGvFgSMwt/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.03CXckBHO5/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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.026705 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:36.678052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-05 14:52:36.678417) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LKGvFgSMwt/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.03CXckBHO5/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-05 14:52:36,782 truncating revision to first 12 chars 2017-03-05 14:52:36,783 Setting DEBUG logging. 2017-03-05 14:52:36,783 attempt 1/10 2017-03-05 14:52:36,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a94edff8355a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 14:52:37,715 unpacking tar archive at: mozilla-aurora-a94edff8355a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.195139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-05 14:52:37.897213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:37.897534) ========= script_repo_revision: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:37.897940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:37.898217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 14:52:37.918620) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-05 14:52:37.918906) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LKGvFgSMwt/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.03CXckBHO5/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:52:38 INFO - MultiFileLogger online at 20170305 14:52:38 in /builds/slave/test 14:52:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:52:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:52:38 INFO - {'append_to_log': False, 14:52:38 INFO - 'base_work_dir': '/builds/slave/test', 14:52:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:52:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:52:38 INFO - 'branch': 'Mozilla-Aurora', 14:52:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:52:38 INFO - 'config_files': ('talos/mac_config.py',), 14:52:38 INFO - 'default_actions': ('clobber', 14:52:38 INFO - 'read-buildbot-config', 14:52:38 INFO - 'download-and-extract', 14:52:38 INFO - 'populate-webroot', 14:52:38 INFO - 'create-virtualenv', 14:52:38 INFO - 'install', 14:52:38 INFO - 'run-tests'), 14:52:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:52:38 INFO - 'download_minidump_stackwalk': True, 14:52:38 INFO - 'download_symbols': 'ondemand', 14:52:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:52:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:52:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:52:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:52:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:52:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:52:38 INFO - 'installer_path': 'installer.exe', 14:52:38 INFO - 'log_level': 'info', 14:52:38 INFO - 'log_name': 'talos', 14:52:38 INFO - 'log_to_console': True, 14:52:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:52:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:52:38 INFO - 'opt_config_files': (), 14:52:38 INFO - 'pip_index': False, 14:52:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:52:38 INFO - 'cmd': ('bash', 14:52:38 INFO - '-c', 14:52:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:52:38 INFO - 'enabled': True, 14:52:38 INFO - 'halt_on_failure': False, 14:52:38 INFO - 'name': 'check_screen_resolution'},), 14:52:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:52:38 INFO - 'cmd': ('bash', 14:52:38 INFO - '-c', 14:52:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:52:38 INFO - 'enabled': True, 14:52:38 INFO - 'halt_on_failure': False, 14:52:38 INFO - 'name': 'check_screen_resolution'},), 14:52:38 INFO - 'run_cmd_checks_enabled': True, 14:52:38 INFO - 'sps_profile': False, 14:52:38 INFO - 'sps_profile_interval': 0, 14:52:38 INFO - 'suite': 'dromaeojs', 14:52:38 INFO - 'system_bits': '32', 14:52:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:52:38 INFO - 'title': 't-yosemite-r7-0323', 14:52:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:52:38 INFO - 'use_talos_json': True, 14:52:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:52:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:52:38 INFO - 'work_dir': 'build'} 14:52:38 INFO - [mozharness: 2017-03-05 22:52:38.131887Z] Running clobber step. 14:52:38 INFO - Running pre-action listener: _resource_record_pre_action 14:52:38 INFO - Running main action method: clobber 14:52:38 INFO - rmtree: /builds/slave/test/build 14:52:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:52:40 INFO - Running post-action listener: _resource_record_post_action 14:52:40 INFO - [mozharness: 2017-03-05 22:52:40.609297Z] Finished clobber step (success) 14:52:40 INFO - [mozharness: 2017-03-05 22:52:40.609449Z] Running read-buildbot-config step. 14:52:40 INFO - Running pre-action listener: _resource_record_pre_action 14:52:40 INFO - Running main action method: read_buildbot_config 14:52:40 INFO - Using buildbot properties: 14:52:40 INFO - { 14:52:40 INFO - "project": "", 14:52:40 INFO - "product": "firefox", 14:52:40 INFO - "script_repo_revision": "production", 14:52:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:52:40 INFO - "repository": "", 14:52:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:52:40 INFO - "buildid": "20170305112323", 14:52:40 INFO - "pgo_build": "False", 14:52:40 INFO - "basedir": "/builds/slave/test", 14:52:40 INFO - "buildnumber": 8, 14:52:40 INFO - "slavename": "t-yosemite-r7-0323", 14:52:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:52:40 INFO - "platform": "yosemite_r7", 14:52:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:52:40 INFO - "branch": "mozilla-aurora", 14:52:40 INFO - "repo_path": "releases/mozilla-aurora", 14:52:40 INFO - "revision": "a94edff8355a1c83ad2bfad80d48540a3cfdfcf6", 14:52:40 INFO - "stage_platform": "macosx64", 14:52:40 INFO - "builduid": "53f3f4be66ed4f63a3b03dc10c60263d", 14:52:40 INFO - "slavebuilddir": "test" 14:52:40 INFO - } 14:52:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 14:52:40 INFO - Running post-action listener: _resource_record_post_action 14:52:40 INFO - [mozharness: 2017-03-05 22:52:40.612811Z] Finished read-buildbot-config step (success) 14:52:40 INFO - [mozharness: 2017-03-05 22:52:40.612924Z] Running download-and-extract step. 14:52:40 INFO - Running pre-action listener: _resource_record_pre_action 14:52:40 INFO - Running main action method: download_and_extract 14:52:40 INFO - mkdir: /builds/slave/test/build/tests 14:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:40 INFO - trying https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 14:52:40 INFO - Downloading https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 14:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 14:52:41 INFO - Downloaded 1199 bytes. 14:52:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 14:52:41 INFO - Using the following test package requirements: 14:52:41 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 14:52:41 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 14:52:41 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 14:52:41 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'jsshell-mac.zip'], 14:52:41 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 14:52:41 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 14:52:41 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 14:52:41 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 14:52:41 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 14:52:41 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:52:41 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 14:52:41 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:52:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 14:52:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:52:41 INFO - Fetch https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 14:52:42 INFO - Expected file size: 16358040 14:52:42 INFO - Obtained file size: 16358040 14:52:49 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:52:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 14:52:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:52:49 INFO - Fetch https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 14:52:50 INFO - Expected file size: 16358040 14:52:50 INFO - Obtained file size: 16358040 14:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 14:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 14:52:58 INFO - Expected file size: 14403650 14:52:58 INFO - Obtained file size: 14403650 14:52: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')]} 14:52:58 INFO - trying https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:52:58 INFO - Downloading https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 14:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 14:53:00 INFO - Downloaded 73950865 bytes. 14:53:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:53:00 INFO - mkdir: /builds/slave/test/properties 14:53:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:00 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:00 INFO - Contents: 14:53:00 INFO - build_url:https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:53:01 INFO - Running post-action listener: _resource_record_post_action 14:53:01 INFO - Running post-action listener: set_extra_try_arguments 14:53:01 INFO - [mozharness: 2017-03-05 22:53:01.408125Z] Finished download-and-extract step (success) 14:53:01 INFO - [mozharness: 2017-03-05 22:53:01.408251Z] Running populate-webroot step. 14:53:01 INFO - Running pre-action listener: _resource_record_pre_action 14:53:01 INFO - Running main action method: populate_webroot 14:53:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:01 INFO - '--tppagecycles', 14:53:01 INFO - '7'], 14:53:01 INFO - 'tests': ['tsvgm']}}, 14:53:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:53:01 INFO - 'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:53:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:53:01 INFO - 'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['damp', 'tps']}, 14:53:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:53:01 INFO - 'tests': ['damp', 'tps']}, 14:53:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['dromaeo_dom']}, 14:53:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['basic_compositor_video']}, 14:53:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:53:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['a11yr', 14:53:01 INFO - 'ts_paint', 14:53:01 INFO - 'tpaint', 14:53:01 INFO - 'sessionrestore', 14:53:01 INFO - 'sessionrestore_no_auto_restore', 14:53:01 INFO - 'tabpaint']}, 14:53:01 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:01 INFO - 'ts_paint', 14:53:01 INFO - 'tpaint', 14:53:01 INFO - 'sessionrestore', 14:53:01 INFO - 'sessionrestore_no_auto_restore', 14:53:01 INFO - 'tabpaint']}, 14:53:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:01 INFO - 'ts_paint', 14:53:01 INFO - 'tpaint', 14:53:01 INFO - 'sessionrestore', 14:53:01 INFO - 'sessionrestore_no_auto_restore', 14:53:01 INFO - 'tabpaint']}, 14:53:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:01 INFO - 'ts_paint', 14:53:01 INFO - 'tpaint', 14:53:01 INFO - 'sessionrestore', 14:53:01 INFO - 'sessionrestore_no_auto_restore', 14:53:01 INFO - 'tabpaint']}, 14:53:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['a11yr', 14:53:01 INFO - 'ts_paint', 14:53:01 INFO - 'tpaint', 14:53:01 INFO - 'sessionrestore', 14:53:01 INFO - 'sessionrestore_no_auto_restore', 14:53:01 INFO - 'tabpaint']}, 14:53:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['a11yr', 14:53:01 INFO - 'ts_paint', 14:53:01 INFO - 'tpaint', 14:53:01 INFO - 'sessionrestore', 14:53:01 INFO - 'sessionrestore_no_auto_restore', 14:53:01 INFO - 'tabpaint']}, 14:53:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['tsvgx', 14:53:01 INFO - 'tsvgr_opacity', 14:53:01 INFO - 'tart', 14:53:01 INFO - 'tscrollx', 14:53:01 INFO - 'cart', 14:53:01 INFO - 'tsvg_static']}, 14:53:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:01 INFO - 'tsvgr_opacity', 14:53:01 INFO - 'tart', 14:53:01 INFO - 'tscrollx', 14:53:01 INFO - 'cart', 14:53:01 INFO - 'tsvg_static']}, 14:53:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:53:01 INFO - 'talos_options': ['--disable-e10s'], 14:53:01 INFO - 'tests': ['tp5o']}, 14:53:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:53:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:53:01 INFO - 'talos_options': ['--disable-e10s', 14:53:01 INFO - '--xperf_path', 14:53:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:01 INFO - 'tests': ['tp5n']}, 14:53:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:53:01 INFO - 'talos_options': ['--xperf_path', 14:53:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:01 INFO - 'tests': ['tp5n']}}, 14:53:01 INFO - 'talos.zip': {'path': '', 14:53:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:01 INFO - Running post-action listener: _resource_record_post_action 14:53:01 INFO - [mozharness: 2017-03-05 22:53:01.427378Z] Finished populate-webroot step (success) 14:53:01 INFO - [mozharness: 2017-03-05 22:53:01.427489Z] Running create-virtualenv step. 14:53:01 INFO - Running pre-action listener: _resource_record_pre_action 14:53:01 INFO - Running main action method: create_virtualenv 14:53:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:01 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 14:53:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:01 INFO - Using real prefix '/tools/python27' 14:53:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:05 INFO - Installing pip.................done. 14:53:05 INFO - Return code: 0 14:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:53:05 INFO - Reading from file tmpfile_stdout 14:53:05 INFO - Output received: 14:53:05 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) 14:53:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:05 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 14:53:05 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 14:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:05 INFO - 'HOME': '/Users/cltbld', 14:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:05 INFO - 'LOGNAME': 'cltbld', 14:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:05 INFO - 'MOZ_NO_REMOTE': '1', 14:53:05 INFO - 'NO_EM_RESTART': '1', 14:53:05 INFO - 'PAGER': '/bin/cat', 14:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:05 INFO - 'PWD': '/builds/slave/test', 14:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:05 INFO - 'SHELL': '/bin/bash', 14:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:05 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:05 INFO - 'USER': 'cltbld', 14:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:05 INFO - 'XPC_FLAGS': '0x0', 14:53:05 INFO - 'XPC_SERVICE_NAME': '0', 14:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:05 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 14:53:05 INFO - Cleaning up... 14:53:05 INFO - Return code: 0 14:53:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:05 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 14:53:05 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 14:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:05 INFO - 'HOME': '/Users/cltbld', 14:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:05 INFO - 'LOGNAME': 'cltbld', 14:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:05 INFO - 'MOZ_NO_REMOTE': '1', 14:53:05 INFO - 'NO_EM_RESTART': '1', 14:53:05 INFO - 'PAGER': '/bin/cat', 14:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:05 INFO - 'PWD': '/builds/slave/test', 14:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:05 INFO - 'SHELL': '/bin/bash', 14:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:05 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:05 INFO - 'USER': 'cltbld', 14:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:05 INFO - 'XPC_FLAGS': '0x0', 14:53:05 INFO - 'XPC_SERVICE_NAME': '0', 14:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:06 INFO - Downloading/unpacking psutil>=3.1.1 14:53:06 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 14:53:06 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 14:53:06 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 14:53:06 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 14:53:06 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 14:53:06 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 14:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:53:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:10 INFO - Installing collected packages: psutil 14:53:10 INFO - Running setup.py install for psutil 14:53:10 INFO - building 'psutil._psutil_osx' extension 14:53:10 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 14:53:10 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 14:53:10 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 14:53:11 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 14:53:11 INFO - building 'psutil._psutil_posix' extension 14:53:11 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 14:53:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:53:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:53:11 INFO - ^ 14:53:11 INFO - 1 warning generated. 14:53:11 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 14:53:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:11 INFO - Successfully installed psutil 14:53:11 INFO - Cleaning up... 14:53:11 INFO - Return code: 0 14:53:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:53:11 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')]} 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:11 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')]} 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:11 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:11 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 14:53:11 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 14:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:11 INFO - 'HOME': '/Users/cltbld', 14:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:11 INFO - 'LOGNAME': 'cltbld', 14:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:11 INFO - 'MOZ_NO_REMOTE': '1', 14:53:11 INFO - 'NO_EM_RESTART': '1', 14:53:11 INFO - 'PAGER': '/bin/cat', 14:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:11 INFO - 'PWD': '/builds/slave/test', 14:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:11 INFO - 'SHELL': '/bin/bash', 14:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:11 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:11 INFO - 'USER': 'cltbld', 14:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:11 INFO - 'XPC_FLAGS': '0x0', 14:53:11 INFO - 'XPC_SERVICE_NAME': '0', 14:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:53:11 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 14:53:11 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 14:53:11 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 14:53:11 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 14:53:11 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 14:53:11 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 14:53:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:53:14 INFO - Installing collected packages: mozsystemmonitor 14:53:14 INFO - Running setup.py install for mozsystemmonitor 14:53:14 INFO - Successfully installed mozsystemmonitor 14:53:14 INFO - Cleaning up... 14:53:14 INFO - Return code: 0 14:53:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:53: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')]} 14:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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')]} 14:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:14 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:14 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 14:53:14 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 14:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:14 INFO - 'HOME': '/Users/cltbld', 14:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:14 INFO - 'LOGNAME': 'cltbld', 14:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:14 INFO - 'MOZ_NO_REMOTE': '1', 14:53:14 INFO - 'NO_EM_RESTART': '1', 14:53:14 INFO - 'PAGER': '/bin/cat', 14:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:14 INFO - 'PWD': '/builds/slave/test', 14:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:14 INFO - 'SHELL': '/bin/bash', 14:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:14 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:14 INFO - 'USER': 'cltbld', 14:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:14 INFO - 'XPC_FLAGS': '0x0', 14:53:14 INFO - 'XPC_SERVICE_NAME': '0', 14:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:14 INFO - Downloading/unpacking jsonschema==2.5.1 14:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:53:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:17 INFO - Downloading functools32-3.2.3-2.tar.gz 14:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:53:18 INFO - warning: no files found matching '*.txt' 14:53:18 INFO - no previously-included directories found matching 'build' 14:53:18 INFO - no previously-included directories found matching 'dist' 14:53:18 INFO - no previously-included directories found matching '.git*' 14:53:18 INFO - Installing collected packages: jsonschema, functools32 14:53:18 INFO - Running setup.py install for functools32 14:53:18 INFO - warning: no files found matching '*.txt' 14:53:18 INFO - no previously-included directories found matching 'build' 14:53:18 INFO - no previously-included directories found matching 'dist' 14:53:18 INFO - no previously-included directories found matching '.git*' 14:53:18 INFO - Successfully installed jsonschema functools32 14:53:18 INFO - Cleaning up... 14:53:18 INFO - Return code: 0 14:53:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:18 INFO - 'HOME': '/Users/cltbld', 14:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:18 INFO - 'LOGNAME': 'cltbld', 14:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:18 INFO - 'MOZ_NO_REMOTE': '1', 14:53:18 INFO - 'NO_EM_RESTART': '1', 14:53:18 INFO - 'PAGER': '/bin/cat', 14:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:18 INFO - 'PWD': '/builds/slave/test', 14:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:18 INFO - 'SHELL': '/bin/bash', 14:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:18 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:18 INFO - 'USER': 'cltbld', 14:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:18 INFO - 'XPC_FLAGS': '0x0', 14:53:18 INFO - 'XPC_SERVICE_NAME': '0', 14:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:53:18 INFO - Cleaning up... 14:53:18 INFO - Return code: 0 14:53:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:18 INFO - 'HOME': '/Users/cltbld', 14:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:18 INFO - 'LOGNAME': 'cltbld', 14:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:18 INFO - 'MOZ_NO_REMOTE': '1', 14:53:18 INFO - 'NO_EM_RESTART': '1', 14:53:18 INFO - 'PAGER': '/bin/cat', 14:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:18 INFO - 'PWD': '/builds/slave/test', 14:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:18 INFO - 'SHELL': '/bin/bash', 14:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:18 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:18 INFO - 'USER': 'cltbld', 14:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:18 INFO - 'XPC_FLAGS': '0x0', 14:53:18 INFO - 'XPC_SERVICE_NAME': '0', 14:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:18 INFO - Downloading/unpacking blobuploader==1.2.4 14:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:53:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:53:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:22 INFO - Downloading docopt-0.6.1.tar.gz 14:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:53:22 INFO - Installing collected packages: blobuploader, requests, docopt 14:53:22 INFO - Running setup.py install for blobuploader 14:53:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:53:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:53:23 INFO - Running setup.py install for requests 14:53:23 INFO - Running setup.py install for docopt 14:53:23 INFO - Successfully installed blobuploader requests docopt 14:53:23 INFO - Cleaning up... 14:53:23 INFO - Return code: 0 14:53:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:23 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')]} 14:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:23 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')]} 14:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:23 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:23 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 14:53:23 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 14:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:23 INFO - 'HOME': '/Users/cltbld', 14:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:23 INFO - 'LOGNAME': 'cltbld', 14:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:23 INFO - 'MOZ_NO_REMOTE': '1', 14:53:23 INFO - 'NO_EM_RESTART': '1', 14:53:23 INFO - 'PAGER': '/bin/cat', 14:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:23 INFO - 'PWD': '/builds/slave/test', 14:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:23 INFO - 'SHELL': '/bin/bash', 14:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:23 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:23 INFO - 'USER': 'cltbld', 14:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:23 INFO - 'XPC_FLAGS': '0x0', 14:53:23 INFO - 'XPC_SERVICE_NAME': '0', 14:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-SNzJDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-tpCwIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-yAwf9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-Gb9e2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-N8A70G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-bjbobc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-kqoqCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-BpxEBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-VFuYUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:24 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-eSD2Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:25 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-mTNDup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:25 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-cSEnLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:25 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-T0OH5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:25 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-XteDA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:25 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-qzjn5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:25 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-3BZMPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:25 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-8wanZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:53:25 INFO - Running setup.py install for manifestparser 14:53:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:53:25 INFO - Running setup.py install for mozcrash 14:53:26 INFO - Running setup.py install for mozdebug 14:53:26 INFO - Running setup.py install for mozdevice 14:53:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Running setup.py install for mozfile 14:53:26 INFO - Running setup.py install for mozhttpd 14:53:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Running setup.py install for mozinfo 14:53:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Running setup.py install for mozInstall 14:53:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:53:26 INFO - Running setup.py install for mozleak 14:53:27 INFO - Running setup.py install for mozlog 14:53:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:53:27 INFO - Running setup.py install for moznetwork 14:53:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:53:27 INFO - Running setup.py install for mozprocess 14:53:27 INFO - Running setup.py install for mozprofile 14:53:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:53:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:53:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:53:27 INFO - Running setup.py install for mozrunner 14:53:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:53:27 INFO - Running setup.py install for mozscreenshot 14:53:28 INFO - Running setup.py install for moztest 14:53:28 INFO - Running setup.py install for mozversion 14:53:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:53:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:53:28 INFO - Cleaning up... 14:53:28 INFO - Return code: 0 14:53:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:28 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')]} 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:28 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')]} 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:28 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:28 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 14:53:28 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 14:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:28 INFO - 'HOME': '/Users/cltbld', 14:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:28 INFO - 'LOGNAME': 'cltbld', 14:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:28 INFO - 'MOZ_NO_REMOTE': '1', 14:53:28 INFO - 'NO_EM_RESTART': '1', 14:53:28 INFO - 'PAGER': '/bin/cat', 14:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:28 INFO - 'PWD': '/builds/slave/test', 14:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:28 INFO - 'SHELL': '/bin/bash', 14:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:28 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:28 INFO - 'USER': 'cltbld', 14:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:28 INFO - 'XPC_FLAGS': '0x0', 14:53:28 INFO - 'XPC_SERVICE_NAME': '0', 14:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-seRp_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:28 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)) 14:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-c9jAd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:28 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)) 14:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-giWNZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:28 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)) 14:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-w4MkhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-72nF4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-1WXMSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-xSMt_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-mkWmCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-vbgDzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-LA0n_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-aN363T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-UMYH1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:29 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-vXylcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:29 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)) 14:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:30 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-uQvclv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:30 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)) 14:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:30 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-xmVmqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:30 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)) 14:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:30 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-xw0VQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:30 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)) 14:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:30 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-oitSlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:30 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)) 14:53:30 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)) 14:53:30 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)) 14:53:30 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)) 14:53:30 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)) 14:53:30 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)) 14:53:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:33 INFO - Downloading blessings-1.6.tar.gz 14:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:53:33 INFO - Installing collected packages: blessings 14:53:33 INFO - Running setup.py install for blessings 14:53:33 INFO - Successfully installed blessings 14:53:33 INFO - Cleaning up... 14:53:33 INFO - Return code: 0 14:53:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:33 INFO - Reading from file tmpfile_stdout 14:53:33 INFO - Current package versions: 14:53:33 INFO - blessings == 1.6 14:53:33 INFO - blobuploader == 1.2.4 14:53:33 INFO - docopt == 0.6.1 14:53:33 INFO - functools32 == 3.2.3-2 14:53:33 INFO - jsonschema == 2.5.1 14:53:33 INFO - manifestparser == 1.1 14:53:33 INFO - mozInstall == 1.12 14:53:33 INFO - mozcrash == 1.0 14:53:33 INFO - mozdebug == 0.1 14:53:33 INFO - mozdevice == 0.49 14:53:33 INFO - mozfile == 1.2 14:53:33 INFO - mozhttpd == 0.7 14:53:33 INFO - mozinfo == 0.9 14:53:33 INFO - mozleak == 0.1 14:53:33 INFO - mozlog == 3.4 14:53:33 INFO - moznetwork == 0.27 14:53:33 INFO - mozprocess == 0.24 14:53:33 INFO - mozprofile == 0.28 14:53:33 INFO - mozrunner == 6.13 14:53:33 INFO - mozscreenshot == 0.1 14:53:33 INFO - mozsystemmonitor == 0.3 14:53:33 INFO - moztest == 0.8 14:53:33 INFO - mozversion == 1.4 14:53:33 INFO - psutil == 3.1.1 14:53:33 INFO - requests == 1.2.3 14:53:33 INFO - wsgiref == 0.1.2 14:53:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:33 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')]} 14:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:33 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')]} 14:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:33 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:33 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 14:53:33 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 14:53:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:33 INFO - 'HOME': '/Users/cltbld', 14:53:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:33 INFO - 'LOGNAME': 'cltbld', 14:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:33 INFO - 'MOZ_NO_REMOTE': '1', 14:53:33 INFO - 'NO_EM_RESTART': '1', 14:53:33 INFO - 'PAGER': '/bin/cat', 14:53:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:33 INFO - 'PWD': '/builds/slave/test', 14:53:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:33 INFO - 'SHELL': '/bin/bash', 14:53:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:33 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:33 INFO - 'USER': 'cltbld', 14:53:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:33 INFO - 'XPC_FLAGS': '0x0', 14:53:33 INFO - 'XPC_SERVICE_NAME': '0', 14:53:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 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)) 14:53:33 INFO - Cleaning up... 14:53:34 INFO - Return code: 0 14:53:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:34 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 0x104612b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104615768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff26b4842d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, '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.LKGvFgSMwt/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.03CXckBHO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 14:53:34 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 14:53:34 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 14:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:34 INFO - 'HOME': '/Users/cltbld', 14:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:34 INFO - 'LOGNAME': 'cltbld', 14:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:34 INFO - 'MOZ_NO_REMOTE': '1', 14:53:34 INFO - 'NO_EM_RESTART': '1', 14:53:34 INFO - 'PAGER': '/bin/cat', 14:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:34 INFO - 'PWD': '/builds/slave/test', 14:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:34 INFO - 'SHELL': '/bin/bash', 14:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:34 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:34 INFO - 'USER': 'cltbld', 14:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:34 INFO - 'XPC_FLAGS': '0x0', 14:53:34 INFO - 'XPC_SERVICE_NAME': '0', 14:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:53:34 INFO - Cleaning up... 14:53:34 INFO - Return code: 0 14:53:34 INFO - Running post-action listener: _resource_record_post_action 14:53:34 INFO - Running post-action listener: _start_resource_monitoring 14:53:34 INFO - Starting resource monitoring. 14:53:34 INFO - [mozharness: 2017-03-05 22:53:34.305239Z] Finished create-virtualenv step (success) 14:53:34 INFO - [mozharness: 2017-03-05 22:53:34.306146Z] Running install step. 14:53:34 INFO - Running pre-action listener: _resource_record_pre_action 14:53:34 INFO - Running main action method: install 14:53:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:34 INFO - Reading from file tmpfile_stdout 14:53:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:53:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:53:34 INFO - Reading from file tmpfile_stdout 14:53:34 INFO - Output received: 14:53:34 INFO - Usage: mozinstall [options] installer 14:53:34 INFO - Options: 14:53:34 INFO - -h, --help show this help message and exit 14:53:34 INFO - -d DEST, --destination=DEST 14:53:34 INFO - Directory to install application into. [default: 14:53:34 INFO - "/builds/slave/test"] 14:53:34 INFO - --app=APP Application being installed. [default: firefox] 14:53:34 INFO - mkdir: /builds/slave/test/build/application 14:53:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:53:54 INFO - Reading from file tmpfile_stdout 14:53:54 INFO - Output received: 14:53:54 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:53:54 INFO - Running post-action listener: _resource_record_post_action 14:53:54 INFO - [mozharness: 2017-03-05 22:53:54.640296Z] Finished install step (success) 14:53:54 INFO - [mozharness: 2017-03-05 22:53:54.640462Z] Running run-tests step. 14:53:54 INFO - Running pre-action listener: _resource_record_pre_action 14:53:54 INFO - Running main action method: run_tests 14:53:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:54 INFO - 2017-03-05 14:53:54.654 screenresolution[1628:8615] starting screenresolution argv=screenresolution get 14:53:54 INFO - 2017-03-05 14:53:54.657 screenresolution[1628:8615] Display 0: 1600x1200x32@60 14:53:54 INFO - 2017-03-05 14:53:54.663 screenresolution[1629:8617] starting screenresolution argv=screenresolution list 14:53:54 INFO - Available Modes on Display 0 14:53:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:54 INFO - Intel Iris: 14:53:54 INFO - Chipset Model: Intel Iris 14:53:54 INFO - Type: GPU 14:53:54 INFO - Bus: Built-In 14:53:54 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:54 INFO - Vendor: Intel (0x8086) 14:53:54 INFO - Device ID: 0x0a2e 14:53:54 INFO - Revision ID: 0x0009 14:53:54 INFO - Displays: 14:53:54 INFO - Display: 14:53:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:54 INFO - Display Serial Number: 1600x1200 60 14:53:54 INFO - Main Display: Yes 14:53:54 INFO - Mirror: Off 14:53:54 INFO - Online: Yes 14:53:54 INFO - Rotation: Supported 14:53:54 INFO - Return code: 0 14:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:53:54 INFO - Python 2.7.3 14:53:54 INFO - Return code: 0 14:53:54 INFO - grabbing minidump binary from tooltool 14:53: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')]} 14:53:54 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 0x1043f0d30>, '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 0x104317db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043e5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:53:54 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 14:53:54 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 14:53:54 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 14:53:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:53:55 INFO - Return code: 0 14:53:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:53:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:53:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:53:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:53:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0323', '--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 14:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0323 --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 14:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKGvFgSMwt/Render', 14:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:55 INFO - 'HOME': '/Users/cltbld', 14:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:55 INFO - 'LOGNAME': 'cltbld', 14:53:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:53:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:55 INFO - 'MOZ_NO_REMOTE': '1', 14:53:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:53:55 INFO - 'NO_EM_RESTART': '1', 14:53:55 INFO - 'PAGER': '/bin/cat', 14:53:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:55 INFO - 'PWD': '/builds/slave/test', 14:53:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:55 INFO - 'SHELL': '/bin/bash', 14:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03CXckBHO5/Listeners', 14:53:55 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 14:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:55 INFO - 'USER': 'cltbld', 14:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:55 INFO - 'XPC_FLAGS': '0x0', 14:53:55 INFO - 'XPC_SERVICE_NAME': '0', 14:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0323', '--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 14:53:55 INFO - mozversion application_buildid: 20170305112323 14:53:55 INFO - mozversion application_changeset: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 14:53:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:53:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:53:55 INFO - mozversion application_name: Firefox 14:53:55 INFO - mozversion application_remotingname: firefox-dev 14:53:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:53:55 INFO - mozversion application_vendor: Mozilla 14:53:55 INFO - mozversion application_version: 53.0a2 14:53:55 INFO - mozversion platform_buildid: 20170305112323 14:53:55 INFO - mozversion platform_changeset: a94edff8355a1c83ad2bfad80d48540a3cfdfcf6 14:53:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:53:55 INFO - mozversion platform_version: 53.0a2 14:53:55 INFO - using testdate: 1488754435 14:53:55 INFO - actual date: 1488754435 14:53:55 INFO - starting webserver on 'localhost:49244' 14:53:55 INFO - SUITE-START | Running 2 tests 14:53:55 INFO - TEST-START | dromaeo_css 14:53:55 INFO - operating with platform_type : mac_ 14:53:55 INFO - Initialising browser for dromaeo_css test... 14:53:55 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmpq_mz0S/profile http://localhost:49244/getInfo.html) 14:53:57 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 14:53:57 INFO - PROCESS | 1639 | colorDepth:24 14:53:57 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 14:53:57 INFO - PROCESS | 1639 | __metrics 14:53:57 INFO - PROCESS | 1639 | 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" 14:53:57 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:53:58 INFO - TEST-INFO | 1639: exit 0 14:53:58 INFO - Browser initialized. 14:53:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:53:58 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmpq_mz0S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:10 INFO - PROCESS | 1642 | RSS: Main: 212455424 14:54:10 INFO - PROCESS | 1642 | 14:57:14 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 14:57:15 INFO - PROCESS | 1642 | RSS: Main: 346296320 14:57:15 INFO - PROCESS | 1642 | 14:59:00 INFO - PROCESS | 1642 | ************************* 14:59:00 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 14:59:00 INFO - PROCESS | 1642 | 14:59:00 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:59:00 INFO - PROCESS | 1642 | Full stack: 14:59:00 INFO - PROCESS | 1642 | ************************* 15:00:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 15:00:19 INFO - PROCESS | 1642 | RSS: Main: 350560256 15:00:19 INFO - PROCESS | 1642 | 15:03:21 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 15:03:22 INFO - PROCESS | 1642 | RSS: Main: 334090240 15:03:22 INFO - PROCESS | 1642 | 15:06:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 15:06:25 INFO - PROCESS | 1642 | RSS: Main: 336793600 15:06:25 INFO - PROCESS | 1642 | 15:09:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 15:09:29 INFO - PROCESS | 1642 | RSS: Main: 316493824 15:09:29 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 15:12:33 INFO - PROCESS | 1642 | RSS: Main: 401035264 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | __start_tp_report 15:12:33 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 15:12:33 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 15:12:33 INFO - PROCESS | 1642 | |i|pagename|runs| 15:12:33 INFO - PROCESS | 1642 | |0;dojo.html;2894.1751600793777;3393.100828280506;3403.42141835888;3422.57217847769;3452.4303489924164;5815.592908496402;5825.242718446607;5839.270091238595;5848.532117430606;5860.413958604137;5587.469190426903;5663.1505274208785;5699.287589051369;5703.173039909221;5710.114932185518;5196.168613021917;5240.03059434004;5241.868953276179;5252.8424147275455;5302.390225124122;5263.894722105556;5271.130263506517;5284.8150314739;5292.020976119411;5293.814716484924;5332.173513105475;5348.786048558053;5363.490468405495;5379.139337705968;5402.702851343194;5355.009323275207;5363.865903352408;5376.569874410038;5379.838604841861;5420.6747595144025;5200;5205.609579281569;5254.816081437131;5306.204069389584;5315.3621565412395;4625.190591646448;5780;5805.274340707411;5831.795887143972;5871.677057761822;5553.333599967989;6089.269287685506;6297.1813664223355;6344.206974128234;6353.30113687494;6244.6253224806205;6281.24625044993;6310.9684451577905;6320.083587879778;6330.87338253237;5748.798792042258;5909.674967876765;5929.377415371324;5955.34491205967;6039.124326972565;6404.071409645575;6453.45145662624;6469.417752402306;6472.805815825533;6478.643674597848;6245.406686364788;6282.654454004982;6297.086922396227;6299.055141728686;6307;6264.874702505925;6270.31026587075;6274.2784579773;6287.9056814147825;6304.338044505353;6331.588446750947;6342.651154186564;6353.4599559038;6353.904691429632;6367;6341.904871426932;6345.49236061114;6355.269144048493;6358.586691865014;6360.332165122688;4986.6758660687665;5045.520675535819;5056;5060.114479965991;5094;4521.480029796549;4539.72761634303;4556.270996640588;4572.971081506635;4589.403377560896;5733.197352370671;6015.127806468037;6021.458068773832;6052.394760523913;6054.8183554493435;6259.311475737665;6264.060390941395;6270.9372906270355;6308.873822523616;6322.083297921776;6021.0968354746265;6021.969890150609;6030.155778191057;6056.545759068087;6080.361562035922;5581.972090139523;5583.218349431083;5586.35756887955;5587.38538760736;5594.328680558359;6339.841503962438;6400.103985441949;6409.166808315075;6478;6504.837379065467;6247.31279559239;6286.748530058747;6298.11826344303;6299.275583307978;6301.936980630318;6504.73981040772;6510.21877374718;6510.544261901621;6512.511561632991;6553.2136143663065;6167.5682702210415;6193.318734939063;6231.376862313732;6327;6339.524535659752;6190.133381326708;6266.811995639956;6302.369763023661;6313.43179113882;6329.145565348803;6265;6274.121622972879;6277.717502712298;6285.96857015712;6293.433590976834;6067.4539291462215;6141.117811339906;6271.059341098689;6271.96864015677;6274.027525733519;4955.281484184845;6068.423499767515;6118.296395914527;6128.295246046761;6130.355969004488;6283.497320214463;6293.811185664437;6303.275123360872;6305.716242768995;6317.7157027932935;5854;6164.568480206342;6166;6173.290071641819;6179.660118693515 15:12:33 INFO - PROCESS | 1642 | |1;ext.html;455.84956964201814;460.9469910960241;502.9421616514102;507.48490282363406;512.5131125430842;30953.38093238134;40618.781436556914;42072.36891446631;42263.57736422635;42297.57702422975;42225.7888710556;43473.565264347344;43490.34764478527;43607;43751.12497750051;8297.917020829806;9154.130357616032;9392.295577831655;9408.905910940906;9414.670486532972;8377.916220837806;11239.494222759955;11488.483018264198;11507.769844603103;11706.7658646827;11260.662180134608;11333.15001374896;11348.60279890204;11440.48517816696;11444.256123351997;8440.788980275482;11373.488193031291;11430.028447581966;11461.312321260752;11479.483423245974;8068.193180681944;11015.559377624886;11301.604443844508;11307.604233851776;11484.94257528707;41227.175456491;41551.7922410389;41597.96005099897;41626;41674.37488437676;3934.4819315638015;3954.564997850263;3964.7422917510557;3973.205358928226;4010.2581022510635;29397.85301073481;29446.558301625493;29458.410831783458;29751.70248297511;30213.640386182673;3064.264576501646;3119.4540955332727;3212.1648371423366;3238.951415728742;3242.91892702682;375238;375451;375491;376295;378627;65248.67375663186;65543;65561.6721916397;65689.67155164194;65745.67127164429;62788.68605656942;65219;65310.67344663342;65585.34414655888;65687.67156164188;16551.337946482006;16786;16817.83182168187;16825.915870420813;16838.663226735396;11696;12012.339321337235;12824.23054616726;12907.870921290854;12927;15717.371305147666;17647.205875735624;17873.821261787216;17912.55218619519;18423.802452840522;6574.5397822152945;6893.655317234118;6935.930640693528;7003;7036.577805331696;860.5869182792295;863.1521442228949;868.2316150207113;869.2871845086968;901.9278457723366;25273.873630632097;29609.40781184364;29769.40461190764;29926.40147197044;30616.08151755451;706.5689929143218;1039.4023436524028;1072.3940973350032;1082.5020490574266;1206.8896615114115;13801.861981380258;14195.077319974169;14466.132032078109;14482.275886205647;14613.561593152222;402187;403599;404538;404954.975225122;405720;53439;53474;53587.73206133944;53772.73113634407;53830.73084634552;1385.736710025092;1435.2680133132178;1446.4503488674236;1449.992750036243;1452.2158034661377;26474.470510589294;27484;27509.724902750717;27569;27698.86150569234;46472.302915456974;46807.53192468168;46849.76575117103;46937.53062469332;46994.53005469902;346826;348554;348882;349722;350574.2471287729;36174.63825361713;36687;36822.44766328454;36874.44688329731;37052;36038;36148.81925590355;38037;40904.77285681434;42716.93207669833;31053.534196986613;33341.83329083339;35412;36460.45309320415;37012.81493592515;32346.676533235306;34320.25437965007;34568.65431345654;35023.824880876455;36132.09669758277;26051.218463446126;34725.9582212534;35001.29997399987;35211.94364169079;35216;29178.70821291845;31352;32000.67999319977;32033.67966320307;32260;23564.528709426057;23817.52364952726;23880;23931.641025384983;24427.38931526726 15:12:33 INFO - PROCESS | 1642 | |2;jquery.html;368.3278017617847;372.76515795049113;391.5438514131036;399.2414412616028;419.1637682822769;14655.900807439444;15297.464588739396;15929.681406371865;21005.739655620673;21533.892330538325;18751.3437029704;22213.555728885414;22266.093909661806;22278.55442891145;22506.88746556265;5787.739551720183;5833.941660583393;6014.578979471439;6096.634201947875;6110.20567326247;5668.064769313059;5922.822315330547;5968.4329988651225;5974.4324289192455;6028.246469191351;4214.431051807997;4421.557844215568;6368.681565921708;6640.501962352819;6704.363085506869;6431.292557818636;6566.441852442548;6741.629210393427;6750.1562304711915;6760.425363844054;5806.535477161817;5813.418658134153;5813.79651712188;5824.24284842972;5826.47561719443;26372.340691482867;26405.075822346127;27055.729442705517;27474.313142171406;27503.86248068767;2701.6352792372973;2750.174947515757;2752.518309295865;2754.2838861895852;2760.5721113227482;11356.886431135665;12285.38573071343;14761;14859.925700371428;15430;1745.7905051393786;1793.901335426551;1813.8809100215594;1836.6969450040726;1941.2041063164177;111437;135426;138547.30726346304;141991;142123;10828.675139745821;11312.547498100148;11879.465424055938;12007.219530730474;12128.272303661808;15399.307031183624;15817.762733559006;15828.76256856148;15837.208139592974;15864.603384915239;7259.455540834459;7427.62861856905;8762.211400973943;8929.464232146092;9009.594568244445;8726.607302671395;8735.039145693969;8750.299976001905;8899.510526921082;8928.10718928102;3928.8035598219976;4811.4707382187935;4815.662903596714;4821.373221481255;4872.098661747517;1688.0884322465731;1952.6973319135557;2004.3986803958753;2007.8092581204762;2008.1766475744873;889.5552223888056;999.9650012249537;1000.9749756256006;1027.6865556005341;1037.1547189040907;22140;22658.773412265997;22682.092716291165;22829.429264268525;23160.42098947506;1038.2472707287307;1045;1067.4289255248405;1071.137734124022;1074.5003573338436;10926.453677316102;11600.071994240441;11878.821817672742;11893;11921.761564768656;537472;597296;692945;696294;719969;117604;129074;146404;148957.25521372323;149881.50118498676;944.9858252126223;950.8050849575959;982.6806287956442;983.1299300119302;983.7638966647953;17257.654846903242;20981;21157.576848463254;21261.787382125982;21437.142514299878;44611.330830036924;60589.788204234785;62363;62846;62988.37011629825;87860.56069719866;88217;89951;91507;92073.53963230141;6163.075538669235;8554.72263868066;8635.654573816977;8635.654573816977;8882.245009174292;12588.559400420942;13668.24824634615;13707.657308567366;14097.929510352382;14107.788383174055;11731.530738770354;11755.706107347385;11780.587679431179;11963.940180299043;11987.40062996864;6873.656317184221;10456.529456174338;11609.535618575163;11747.882521174679;11856;11319.830202546804;11424.371659558472;11439.771204576029;11660.650180494598;12064.517419303129;7243.384312333511;8361;8361.832763344577;8628.913710863062;8656.48061116335;9545.952270238882;11535.134864885;11771.058315334923;11793.646190614296;11808.114391420506 15:12:33 INFO - PROCESS | 1642 | |3;mootools.html;1428.2858570714643;1436.0809082187398;1443.9278036098192;1452.2883786944394;1452.9636759081022;7965.72119975801;8343.791405214874;8355.331573474123;8360.540170290631;8378.539180345078;7433.702651893931;7678.155402905676;7692.961535192316;7959.243871832181;8167.224113709188;2285.5200407914317;2293.1286111277773;2323.9767602324014;2328.313147621447;2329.860208387494;2300.884955752214;2335.8481698689616;2339.87130707811;2340.157543284416;2341.906323747048;2039.2964427272568;2119.395972147938;2246.7753224677485;2287.7025986621716;2301.919432819852;2305.8270629702756;2321.338418550705;2323.918662846809;2327.487952650423;2329.464223228667;2268.750437451879;2315.7221133463922;2320.4082958845556;2346.7301260355107;2353.670486131926;8299.83400331996;8374.916250837474;8383.538905360203;8387.496750194947;8390.03514595817;5087.414947281073;5234.790608375661;5239.633225674204;5244.737763111829;5246.921296180561;3292;3465.2722928184858;3538.433850583894;3539.132912436444;3546.8758593449106;1145.4730823821053;1192.8389667394877;1230.6246594788586;1231.9753604927942;1240.5782034108356;10403.635872744419;10771.892281077246;10831.241813073088;10908.890911090866;10928.289661171999;4004.379321205218;4260.850870219528;4561.794719237576;4576.222042252825;4587.747673877902;8619.267362274277;8745.606447709868;8753.299736021103;8761.605727742266;8796.47221166732;5098;5178.378594568676;5178.6116041297055;5193.948060519422;5211.869703257373;4717.080169367009;4849.854504364875;4877.341558889504;4885.389326334208;4890.608751299887;3650.3064417760543;3716.349638813197;3737.028372623083;3813.6758375537834;3815.618438156162;1146.1174895330716;1146.1862077924766;1152.2395219155485;1158.223989926751;1163.8836116388293;775.765059701048;870.2515836380708;894.7584152278848;907.3059109781022;923.9630414783468;5548.223248745179;5559.555235581144;5706.686132262683;5774.307083150049;5899.292084949833;971.1114330387758;977.7408986618552;997.5112195024531;1032.8708911386077;1037.7976294622626;3606.4590311452966;3616.692581130581;3804.1821008483307;3804.4293355996824;3868.6324799144036;9747.951260243653;9780.95109524462;10007.49962501872;10043.4476103815;10058.29591928558;9735;9767.413955162712;10040.899591004143;10060.446675432775;10073.848892266622;7472.028636277358;7541.585212813348;7663.118741344705;7676.040494938133;7695.576743279174;5576.414476479911;5748.252727145445;5810.94189058104;5830;5864.06175011996;8924.419912705653;8943.508107054175;9118.772030699285;9288.11762882525;9434.245260379015;7905.644246008828;8538.40231183836;9425.670101546413;9501.28740344463;9563.952180239054;6670.966645166744;7066.57600543969;7298.598577078312;7319.048523691886;7342.229065947999;7491.850162996819;7912.208779122042;7988;8082.797930051795;8094.473859199134;7115.288471152843;7182.102237220348;7239.927600723925;7309.159446663702;7379.667914943948;7104.8987406952;7117.572945623279;7122.287771222836;7164.570125792469;7220.494565380373;6307.526935479766;6390.169277994017;6469.482441404771;6475.870482590416;6482.060101285193;4919.0407870464915;4964.230544265644;4976.651634385558;5042.067217564616;5081.8475445736685;4896.565754804429;4961.950380496149;4985.725785081855;5163.767630456714;5202.765875535686 15:12:33 INFO - PROCESS | 1642 | |4;prototype.html;348.95289135966635;353.1894302575589;361.8154741082048;375.3843696338006;376.6045652065331;4375.299952007679;4455.2871540553515;5052.545270925616;5283.445238249977;5478.150886612577;4449.755263460508;5142.640015198937;5242.6330156889035;5291.629585928977;5310.300703774794;3836.923261534768;3992.802159352197;4070.3690927906223;4076.9015548183297;4147.585241475851;2961.496545587245;3933.704972127088;4002.859899903504;4010.2781499330254;4070;3959.2477429288488;3966.2464131814863;3983.9044262827665;3991.4811074560266;3991.6806655467494;3505.614382417932;3542.3092496962972;3791.9241615167816;3841.654251117385;3996.660283875874;3092.6134233220846;3344.9498257526157;3419.46998215277;3463.9480407793903;3483.3207524532727;4148.419221309019;4814.951850481485;5116;5117.513836185556;5141.408737995141;4004.7985604318587;4355.040231895628;4504.459464864237;4548.476925153616;4549.337783084616;5329.973350133225;5562.888742225133;5562.972185139089;5563.944360556424;5595.509998050869;3015.9849200754074;3792.5259342582176;3807.733458657895;3808.695304375671;3843.5195600549932;4566.538707613565;5767.134929760486;5796.246487956623;5808.82573522795;5842.766289348421;2923.751481124086;3470;3485.7734247273847;3765.811709414518;3766.924661506809;3075.861586228625;3218.3080637663015;3782.735208535376;3786.261678972629;3879.786611736325;3753.7560058596105;4355.455568053993;4481.395011673382;4507.414036175276;4536.432945881765;5090.4655011223285;5343.465653434625;5658.490735833795;5666.716664166775;5693.914591281134;1016.7458135466134;1141.5890279499374;1147.3746807989667;1189.304257009659;1231.7967535356745;731.8499707559937;734.7612026091541;833.3749687734199;847.6016272351985;876.2070326354659;4466.798994045275;4585.403897493305;4961.139572660252;4998.775055122528;5015.14742493777;5020.560915772708;5098.974505127525;5348.636097795037;5447.509724124848;5505.862353441196;4313.654907607384;4820.807167713322;4950.0694729055695;4963.677360971526;4999.65002449825;2494.4013436775044;2724.4551089781726;2786.4845003674386;2844.40267543814;2924;4798.95201047992;5750.64223668294;5769.74036168365;5773.191753154561;5780.768769249183;4435.778211089432;5163.096458119814;5717.714114294352;5732.598718089694;5851.268591426072;5961.344252132262;5968.612040217372;5972.552058595623;5983.563944653252;5990.341062483123;4876.341693871282;5204.271402003798;5749.131532251951;5757.913631295618;5770.192173095854;4857.769583227115;5067.569256613229;5500.752466138953;5713.571482138773;5753.597248192586;4662.906741865211;5420.322459692538;5562.082256427644;5949.007082627369;5998.640081595118;3757.1358587524473;3777.792221427738;3803.790791506494;3918.9810649231977;3922.450856880096;4598.747068911108;4916.803327866845;5758.654480731169;5800.187973683604;5819.6508209507565;5501.972490137524;5599.328080630187;5667.234923285304;5681.261436013292;5719.342275638189;5332.626716129989;5574.191742197278;5594.797118619354;5611.214429979887;5617.129344951539;5118.692878427158;5167.83723662173;5504.7522861470525;5523.530499907392;5530.281063461724;5079;5229.26790249373;5580.748866301107;5584.609077364708;5588.497035266845;4992.400911890451;5479.369872464717;5491.615586908878;5525.392206857323;5546.916796247979 15:12:33 INFO - PROCESS | 1642 | |5;yui.html;703.1210986267166;726.3571739010973;760.980975475613;813.2639960835444;825.1995564302626;14613.415463381465;15562.610934726637;15614.219289035545;15627.984181028225;15653.373865045398;14121.29393530322;14145.009849310552;14148.50480233192;14310.928445357784;14342.282885855691;679.9184097908234;702.2661318921713;843.6077224090811;856.2080075929771;859.5186695450536;689.941354984827;827.8096037911284;846.1115828380176;851.8126012277289;861.3066481482405;767.48578452437;904.7466709321401;908.1145882764285;915.4461550761794;916.2990312410977;906.4515967839461;907.2197909797569;908.6910450446879;909.1953621045357;909.8680691299725;528.3659608469814;541.9756110975015;621.2886245249165;645;658.1739916404929;14522.564323070324;14559.563213103624;14575.979681422305;14594.781078283835;14601.269936503133;13441.865581344256;13496.595102146952;13497.392617332243;13498.797518037238;13596.796048059286;12047.277163370138;12200.450979705935;12244.142909996304;12421.44103515344;12908.806367904488;4197.97901010496;4365.410669559632;4439;4507.864764057083;4527.275635898273;106640.99999999923;108411.66257558519;111154.88845111526;113643;113646.29530556966;10056.497175141214;10344.482775861177;10633.73415664599;10846.29499082557;10891.564337426415;20751.8962405187;20923.47691307699;21243.150273989177;21313.68029479559;21317.61435506687;7460.0674915635545;7523.0972283326355;7549.584772837547;7551.811204719926;7715.652795624211;4147.937780933288;4206.3480160574545;4206.705530612828;4228.851990180329;4233.386159006926;3379.2396710739886;3440.1055725511046;3472.131967008248;3477.547918770594;3481.686648201674;613.1691557939017;622.8723111762077;697.8360085379932;722.9746958856415;735.4925101679823;663.8174502011889;691.8201267670341;694.9235584085746;702.7715992302523;705.8588282343552;9514.143727064597;9768.804623907625;9881.456519891475;10141.2394070445;10223.897761022294;656.5043392238829;678.3149019490351;679.5718697220719;693.9757108501279;700.6232752641084;4556.567126123013;4850.83022094225;4910.091633047898;4912.680675756064;4935.827246046371;105567;107925.92074079158;111017;111375;111555;94353.5282323584;96421;96789.5160524207;98591;100957.49521252347;69534.65232673906;74412;83519;84158.15841841749;84950.57524712337;9178.954105229432;9534.570944307661;9541.809163816546;9575.90424095778;9577.924486313961;37368.43947340846;45293.09413811771;47932.36371999574;49988.25017624811;56652;71268.5746285061;72143.91784123138;72506.27493724995;73543.63228184039;75670;12846.678833028875;12983.41574629125;13063.150895191782;13180.27508487004;13490.662733431744;13957.302134893418;14090.718185636435;14502.274886255856;14554.708905821613;15008.174550399834;12337.876621233672;12817;13075.150115242479;13451.175253196547;13751.381187846771;12860;13243;13500.45998160102;13545.187288762705;13564.72870542564;12780.488780448677;12821.743565128832;13101.571014117926;13169.473221071434;13306.534271300457;11279.830802537805;11365.602203922823;11367.772644547229;11443.656690299304;11477.770444590895;10601.840972385266;10672.89327106719;10795;10845.891541084804;10859.131269498579 15:12:33 INFO - PROCESS | 1642 | __end_tp_report 15:12:33 INFO - PROCESS | 1642 | __start_cc_report 15:12:33 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1499 15:12:33 INFO - PROCESS | 1642 | __end_cc_report 15:12:33 INFO - PROCESS | 1642 | __startTimestamp1488755553435__endTimestamp 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | ------- Summary: start ------- 15:12:33 INFO - PROCESS | 1642 | Number of tests: 6 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5849.41 Median:6128.30 stddev:670.33 (10.9%) stddev-sans-first:631.03 15:12:33 INFO - PROCESS | 1642 | Values: 2894.2 3393.1 3403.4 3422.6 3452.4 5815.6 5825.2 5839.3 5848.5 5860.4 5587.5 5663.2 5699.3 5703.2 5710.1 5196.2 5240.0 5241.9 5252.8 5302.4 5263.9 5271.1 5284.8 5292.0 5293.8 5332.2 5348.8 5363.5 5379.1 5402.7 5355.0 5363.9 5376.6 5379.8 5420.7 5200.0 5205.6 5254.8 5306.2 5315.4 4625.2 5780.0 5805.3 5831.8 5871.7 5553.3 6089.3 6297.2 6344.2 6353.3 6244.6 6281.2 6311.0 6320.1 6330.9 5748.8 5909.7 5929.4 5955.3 6039.1 6404.1 6453.5 6469.4 6472.8 6478.6 6245.4 6282.7 6297.1 6299.1 6307.0 6264.9 6270.3 6274.3 6287.9 6304.3 6331.6 6342.7 6353.5 6353.9 6367.0 6341.9 6345.5 6355.3 6358.6 6360.3 4986.7 5045.5 5056.0 5060.1 5094.0 4521.5 4539.7 4556.3 4573.0 4589.4 5733.2 6015.1 6021.5 6052.4 6054.8 6259.3 6264.1 6270.9 6308.9 6322.1 6021.1 6022.0 6030.2 6056.5 6080.4 5582.0 5583.2 5586.4 5587.4 5594.3 6339.8 6400.1 6409.2 6478.0 6504.8 6247.3 6286.7 6298.1 6299.3 6301.9 6504.7 6510.2 6510.5 6512.5 6553.2 6167.6 6193.3 6231.4 6327.0 6339.5 6190.1 6266.8 6302.4 6313.4 6329.1 6265.0 6274.1 6277.7 6286.0 6293.4 6067.5 6141.1 6271.1 6272.0 6274.0 4955.3 6068.4 6118.3 6128.3 6130.4 6283.5 6293.8 6303.3 6305.7 6317.7 5854.0 6164.6 6166.0 6173.3 6179.7 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:53768.64 Median:192893.10 stddev:99349.05 (51.5%) stddev-sans-first:99547.12 15:12:33 INFO - PROCESS | 1642 | Values: 455.8 460.9 502.9 507.5 512.5 30953.4 40618.8 42072.4 42263.6 42297.6 42225.8 43473.6 43490.3 43607.0 43751.1 8297.9 9154.1 9392.3 9408.9 9414.7 8377.9 11239.5 11488.5 11507.8 11706.8 11260.7 11333.2 11348.6 11440.5 11444.3 8440.8 11373.5 11430.0 11461.3 11479.5 8068.2 11015.6 11301.6 11307.6 11484.9 41227.2 41551.8 41598.0 41626.0 41674.4 3934.5 3954.6 3964.7 3973.2 4010.3 29397.9 29446.6 29458.4 29751.7 30213.6 3064.3 3119.5 3212.2 3239.0 3242.9 375238.0 375451.0 375491.0 376295.0 378627.0 65248.7 65543.0 65561.7 65689.7 65745.7 62788.7 65219.0 65310.7 65585.3 65687.7 16551.3 16786.0 16817.8 16825.9 16838.7 11696.0 12012.3 12824.2 12907.9 12927.0 15717.4 17647.2 17873.8 17912.6 18423.8 6574.5 6893.7 6935.9 7003.0 7036.6 860.6 863.2 868.2 869.3 901.9 25273.9 29609.4 29769.4 29926.4 30616.1 706.6 1039.4 1072.4 1082.5 1206.9 13801.9 14195.1 14466.1 14482.3 14613.6 402187.0 403599.0 404538.0 404955.0 405720.0 53439.0 53474.0 53587.7 53772.7 53830.7 1385.7 1435.3 1446.5 1450.0 1452.2 26474.5 27484.0 27509.7 27569.0 27698.9 46472.3 46807.5 46849.8 46937.5 46994.5 346826.0 348554.0 348882.0 349722.0 350574.2 36174.6 36687.0 36822.4 36874.4 37052.0 36038.0 36148.8 38037.0 40904.8 42716.9 31053.5 33341.8 35412.0 36460.5 37012.8 32346.7 34320.3 34568.7 35023.8 36132.1 26051.2 34726.0 35001.3 35211.9 35216.0 29178.7 31352.0 32000.7 32033.7 32260.0 23564.5 23817.5 23880.0 23931.6 24427.4 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:38021.15 Median:24766.38 stddev:109223.69 (441.0%) stddev-sans-first:109493.50 15:12:33 INFO - PROCESS | 1642 | Values: 368.3 372.8 391.5 399.2 419.2 14655.9 15297.5 15929.7 21005.7 21533.9 18751.3 22213.6 22266.1 22278.6 22506.9 5787.7 5833.9 6014.6 6096.6 6110.2 5668.1 5922.8 5968.4 5974.4 6028.2 4214.4 4421.6 6368.7 6640.5 6704.4 6431.3 6566.4 6741.6 6750.2 6760.4 5806.5 5813.4 5813.8 5824.2 5826.5 26372.3 26405.1 27055.7 27474.3 27503.9 2701.6 2750.2 2752.5 2754.3 2760.6 11356.9 12285.4 14761.0 14859.9 15430.0 1745.8 1793.9 1813.9 1836.7 1941.2 111437.0 135426.0 138547.3 141991.0 142123.0 10828.7 11312.5 11879.5 12007.2 12128.3 15399.3 15817.8 15828.8 15837.2 15864.6 7259.5 7427.6 8762.2 8929.5 9009.6 8726.6 8735.0 8750.3 8899.5 8928.1 3928.8 4811.5 4815.7 4821.4 4872.1 1688.1 1952.7 2004.4 2007.8 2008.2 889.6 1000.0 1001.0 1027.7 1037.2 22140.0 22658.8 22682.1 22829.4 23160.4 1038.2 1045.0 1067.4 1071.1 1074.5 10926.5 11600.1 11878.8 11893.0 11921.8 537472.0 597296.0 692945.0 696294.0 719969.0 117604.0 129074.0 146404.0 148957.3 149881.5 945.0 950.8 982.7 983.1 983.8 17257.7 20981.0 21157.6 21261.8 21437.1 44611.3 60589.8 62363.0 62846.0 62988.4 87860.6 88217.0 89951.0 91507.0 92073.5 6163.1 8554.7 8635.7 8635.7 8882.2 12588.6 13668.2 13707.7 14097.9 14107.8 11731.5 11755.7 11780.6 11963.9 11987.4 6873.7 10456.5 11609.5 11747.9 11856.0 11319.8 11424.4 11439.8 11660.7 12064.5 7243.4 8361.0 8361.8 8628.9 8656.5 9546.0 11535.1 11771.1 11793.6 11808.1 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5407.44 Median:5186.28 stddev:2912.47 (56.2%) stddev-sans-first:2905.28 15:12:33 INFO - PROCESS | 1642 | Values: 1428.3 1436.1 1443.9 1452.3 1453.0 7965.7 8343.8 8355.3 8360.5 8378.5 7433.7 7678.2 7693.0 7959.2 8167.2 2285.5 2293.1 2324.0 2328.3 2329.9 2300.9 2335.8 2339.9 2340.2 2341.9 2039.3 2119.4 2246.8 2287.7 2301.9 2305.8 2321.3 2323.9 2327.5 2329.5 2268.8 2315.7 2320.4 2346.7 2353.7 8299.8 8374.9 8383.5 8387.5 8390.0 5087.4 5234.8 5239.6 5244.7 5246.9 3292.0 3465.3 3538.4 3539.1 3546.9 1145.5 1192.8 1230.6 1232.0 1240.6 10403.6 10771.9 10831.2 10908.9 10928.3 4004.4 4260.9 4561.8 4576.2 4587.7 8619.3 8745.6 8753.3 8761.6 8796.5 5098.0 5178.4 5178.6 5193.9 5211.9 4717.1 4849.9 4877.3 4885.4 4890.6 3650.3 3716.3 3737.0 3813.7 3815.6 1146.1 1146.2 1152.2 1158.2 1163.9 775.8 870.3 894.8 907.3 924.0 5548.2 5559.6 5706.7 5774.3 5899.3 971.1 977.7 997.5 1032.9 1037.8 3606.5 3616.7 3804.2 3804.4 3868.6 9748.0 9781.0 10007.5 10043.4 10058.3 9735.0 9767.4 10040.9 10060.4 10073.8 7472.0 7541.6 7663.1 7676.0 7695.6 5576.4 5748.3 5810.9 5830.0 5864.1 8924.4 8943.5 9118.8 9288.1 9434.2 7905.6 8538.4 9425.7 9501.3 9564.0 6671.0 7066.6 7298.6 7319.0 7342.2 7491.9 7912.2 7988.0 8082.8 8094.5 7115.3 7182.1 7239.9 7309.2 7379.7 7104.9 7117.6 7122.3 7164.6 7220.5 6307.5 6390.2 6469.5 6475.9 6482.1 4919.0 4964.2 4976.7 5042.1 5081.8 4896.6 4962.0 4985.7 5163.8 5202.8 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4433.42 Median:4995.59 stddev:1407.43 (28.2%) stddev-sans-first:1377.58 15:12:33 INFO - PROCESS | 1642 | Values: 349.0 353.2 361.8 375.4 376.6 4375.3 4455.3 5052.5 5283.4 5478.2 4449.8 5142.6 5242.6 5291.6 5310.3 3836.9 3992.8 4070.4 4076.9 4147.6 2961.5 3933.7 4002.9 4010.3 4070.0 3959.2 3966.2 3983.9 3991.5 3991.7 3505.6 3542.3 3791.9 3841.7 3996.7 3092.6 3344.9 3419.5 3463.9 3483.3 4148.4 4815.0 5116.0 5117.5 5141.4 4004.8 4355.0 4504.5 4548.5 4549.3 5330.0 5562.9 5563.0 5563.9 5595.5 3016.0 3792.5 3807.7 3808.7 3843.5 4566.5 5767.1 5796.2 5808.8 5842.8 2923.8 3470.0 3485.8 3765.8 3766.9 3075.9 3218.3 3782.7 3786.3 3879.8 3753.8 4355.5 4481.4 4507.4 4536.4 5090.5 5343.5 5658.5 5666.7 5693.9 1016.7 1141.6 1147.4 1189.3 1231.8 731.8 734.8 833.4 847.6 876.2 4466.8 4585.4 4961.1 4998.8 5015.1 5020.6 5099.0 5348.6 5447.5 5505.9 4313.7 4820.8 4950.1 4963.7 4999.7 2494.4 2724.5 2786.5 2844.4 2924.0 4799.0 5750.6 5769.7 5773.2 5780.8 4435.8 5163.1 5717.7 5732.6 5851.3 5961.3 5968.6 5972.6 5983.6 5990.3 4876.3 5204.3 5749.1 5757.9 5770.2 4857.8 5067.6 5500.8 5713.6 5753.6 4662.9 5420.3 5562.1 5949.0 5998.6 3757.1 3777.8 3803.8 3919.0 3922.5 4598.7 4916.8 5758.7 5800.2 5819.7 5502.0 5599.3 5667.2 5681.3 5719.3 5332.6 5574.2 5594.8 5611.2 5617.1 5118.7 5167.8 5504.8 5523.5 5530.3 5079.0 5229.3 5580.7 5584.6 5588.5 4992.4 5479.4 5491.6 5525.4 5546.9 15:12:33 INFO - PROCESS | 1642 | 15:12:33 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:21081.36 Median:4202.16 stddev:31142.21 (741.1%) stddev-sans-first:31191.98 15:12:33 INFO - PROCESS | 1642 | Values: 703.1 726.4 761.0 813.3 825.2 14613.4 15562.6 15614.2 15628.0 15653.4 14121.3 14145.0 14148.5 14310.9 14342.3 679.9 702.3 843.6 856.2 859.5 689.9 827.8 846.1 851.8 861.3 767.5 904.7 908.1 915.4 916.3 906.5 907.2 908.7 909.2 909.9 528.4 542.0 621.3 645.0 658.2 14522.6 14559.6 14576.0 14594.8 14601.3 13441.9 13496.6 13497.4 13498.8 13596.8 12047.3 12200.5 12244.1 12421.4 12908.8 4198.0 4365.4 4439.0 4507.9 4527.3 106641.0 108411.7 111154.9 113643.0 113646.3 10056.5 10344.5 10633.7 10846.3 10891.6 20751.9 20923.5 21243.2 21313.7 21317.6 7460.1 7523.1 7549.6 7551.8 7715.7 4147.9 4206.3 4206.7 4228.9 4233.4 3379.2 3440.1 3472.1 3477.5 3481.7 613.2 622.9 697.8 723.0 735.5 663.8 691.8 694.9 702.8 705.9 9514.1 9768.8 9881.5 10141.2 10223.9 656.5 678.3 679.6 694.0 700.6 4556.6 4850.8 4910.1 4912.7 4935.8 105567.0 107925.9 111017.0 111375.0 111555.0 94353.5 96421.0 96789.5 98591.0 100957.5 69534.7 74412.0 83519.0 84158.2 84950.6 9179.0 9534.6 9541.8 9575.9 9577.9 37368.4 45293.1 47932.4 49988.3 56652.0 71268.6 72143.9 72506.3 73543.6 75670.0 12846.7 12983.4 13063.2 13180.3 13490.7 13957.3 14090.7 14502.3 14554.7 15008.2 12337.9 12817.0 13075.2 13451.2 13751.4 12860.0 13243.0 13500.5 13545.2 13564.7 12780.5 12821.7 13101.6 13169.5 13306.5 11279.8 11365.6 11367.8 11443.7 11477.8 10601.8 10672.9 10795.0 10845.9 10859.1 15:12:33 INFO - PROCESS | 1642 | -------- Summary: end -------- 15:12:33 INFO - PROCESS | 1642 | 15:12:34 INFO - TEST-INFO | 1642: exit 0 15:12:34 INFO - TEST-OK | dromaeo_css | took 1118891ms 15:12:34 INFO - TEST-START | kraken 15:12:34 INFO - operating with platform_type : mac_ 15:12:34 INFO - Initialising browser for kraken test... 15:12:34 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmpSfPdAO/profile http://localhost:49244/getInfo.html) 15:12:36 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 15:12:36 INFO - PROCESS | 1649 | colorDepth:24 15:12:36 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 15:12:36 INFO - PROCESS | 1649 | __metrics 15:12:36 INFO - PROCESS | 1649 | 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" 15:12:36 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:12:37 INFO - TEST-INFO | 1649: exit 0 15:12:37 INFO - Browser initialized. 15:12:37 INFO - Running cycle 1/1 for kraken test... 15:12:37 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmpSfPdAO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:49 INFO - PROCESS | 1650 | RSS: Main: 212869120 15:12:49 INFO - PROCESS | 1650 | 15:12:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 15:12:53 INFO - PROCESS | 1650 | RSS: Main: 267313152 15:12:53 INFO - PROCESS | 1650 | 15:12:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 15:12:56 INFO - PROCESS | 1650 | RSS: Main: 276570112 15:12:56 INFO - PROCESS | 1650 | 15:12:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 15:12:59 INFO - PROCESS | 1650 | RSS: Main: 373387264 15:12:59 INFO - PROCESS | 1650 | 15:13:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 15:13:02 INFO - PROCESS | 1650 | RSS: Main: 276385792 15:13:02 INFO - PROCESS | 1650 | 15:13:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:05 INFO - PROCESS | 1650 | RSS: Main: 278540288 15:13:05 INFO - PROCESS | 1650 | 15:13:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:08 INFO - PROCESS | 1650 | RSS: Main: 318599168 15:13:08 INFO - PROCESS | 1650 | 15:13:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:12 INFO - PROCESS | 1650 | RSS: Main: 319053824 15:13:12 INFO - PROCESS | 1650 | 15:13:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 15:13:15 INFO - PROCESS | 1650 | RSS: Main: 316555264 15:13:15 INFO - PROCESS | 1650 | 15:13:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:17 INFO - PROCESS | 1650 | RSS: Main: 294912000 15:13:17 INFO - PROCESS | 1650 | 15:13:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:20 INFO - PROCESS | 1650 | RSS: Main: 298098688 15:13:20 INFO - PROCESS | 1650 | 15:13:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:13:23 INFO - PROCESS | 1650 | RSS: Main: 307757056 15:13:23 INFO - PROCESS | 1650 | 15:13:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:13:26 INFO - PROCESS | 1650 | RSS: Main: 318763008 15:13:26 INFO - PROCESS | 1650 | 15:13:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:13:30 INFO - PROCESS | 1650 | RSS: Main: 312958976 15:13:30 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 15:13:32 INFO - PROCESS | 1650 | RSS: Main: 357371904 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | __start_tp_report 15:13:32 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 15:13:32 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 15:13:32 INFO - PROCESS | 1650 | |i|pagename|runs| 15:13:32 INFO - PROCESS | 1650 | |0;ai-astar;115;116;116;115;115;117;118;168;172;116 15:13:32 INFO - PROCESS | 1650 | |1;audio-beat-detection;142;104;108;144;111;110;109;108;129;109 15:13:32 INFO - PROCESS | 1650 | |2;audio-dft;183;182;182;184;183;184;182;181;184;183 15:13:32 INFO - PROCESS | 1650 | |3;audio-fft;81;60;59;92;60;57;59;58;73;59 15:13:32 INFO - PROCESS | 1650 | |4;audio-oscillator;84;70;86;69;68;69;81;67;68;84 15:13:32 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;88;84;88;85;88;84;88;84;88;84 15:13:32 INFO - PROCESS | 1650 | |6;imaging-darkroom;137;125;94;95;94;94;94;95;94;95 15:13:32 INFO - PROCESS | 1650 | |7;imaging-desaturate;85;85;87;84;84;86;87;91;85;128 15:13:32 INFO - PROCESS | 1650 | |8;json-parse-financial;55;54;53;55;59;57;58;58;57;58 15:13:32 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;64;83;72;74;70;68;68;92;101;102 15:13:32 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;86;86;85;85;81;83;84;82;85;88 15:13:32 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;146;146;144;136;135;133;132;135;180;134 15:13:32 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;165;165;166;167;167;168;169;166;165;177 15:13:32 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;66;66;65;65;65;66;63;65;65 15:13:32 INFO - PROCESS | 1650 | __end_tp_report 15:13:32 INFO - PROCESS | 1650 | __start_cc_report 15:13:32 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2089 15:13:32 INFO - PROCESS | 1650 | __end_cc_report 15:13:32 INFO - PROCESS | 1650 | __startTimestamp1488755612336__endTimestamp 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | ------- Summary: start ------- 15:13:32 INFO - PROCESS | 1650 | Number of tests: 14 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:126.80 Median:116.50 stddev:22.81 (19.6%) stddev-sans-first:23.79 15:13:32 INFO - PROCESS | 1650 | Values: 115.0 116.0 116.0 115.0 115.0 117.0 118.0 168.0 172.0 116.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:110.50 stddev:15.06 (13.6%) stddev-sans-first:13.08 15:13:32 INFO - PROCESS | 1650 | Values: 142.0 104.0 108.0 144.0 111.0 110.0 109.0 108.0 129.0 109.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 15:13:32 INFO - PROCESS | 1650 | Values: 183.0 182.0 182.0 184.0 183.0 184.0 182.0 181.0 184.0 183.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.00 stddev:12.08 (20.1%) stddev-sans-first:11.49 15:13:32 INFO - PROCESS | 1650 | Values: 81.0 60.0 59.0 92.0 60.0 57.0 59.0 58.0 73.0 59.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:75.50 stddev:8.00 (10.6%) stddev-sans-first:7.73 15:13:32 INFO - PROCESS | 1650 | Values: 84.0 70.0 86.0 69.0 68.0 69.0 81.0 67.0 68.0 84.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:88.00 stddev:2.02 (2.3%) stddev-sans-first:2.03 15:13:32 INFO - PROCESS | 1650 | Values: 88.0 84.0 88.0 85.0 88.0 84.0 88.0 84.0 88.0 84.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:94.00 stddev:15.71 (16.7%) stddev-sans-first:10.22 15:13:32 INFO - PROCESS | 1650 | Values: 137.0 125.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:90.20 Median:85.50 stddev:13.44 (15.7%) stddev-sans-first:14.12 15:13:32 INFO - PROCESS | 1650 | Values: 85.0 85.0 87.0 84.0 84.0 86.0 87.0 91.0 85.0 128.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.50 stddev:2.01 (3.5%) stddev-sans-first:2.07 15:13:32 INFO - PROCESS | 1650 | Values: 55.0 54.0 53.0 55.0 59.0 57.0 58.0 58.0 57.0 58.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:79.40 Median:71.00 stddev:14.21 (20.0%) stddev-sans-first:13.94 15:13:32 INFO - PROCESS | 1650 | Values: 64.0 83.0 72.0 74.0 70.0 68.0 68.0 92.0 101.0 102.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:2.07 (2.4%) stddev-sans-first:2.12 15:13:32 INFO - PROCESS | 1650 | Values: 86.0 86.0 85.0 85.0 81.0 83.0 84.0 82.0 85.0 88.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:140.00 stddev:14.37 (10.3%) stddev-sans-first:15.17 15:13:32 INFO - PROCESS | 1650 | Values: 146.0 146.0 144.0 136.0 135.0 133.0 132.0 135.0 180.0 134.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.00 stddev:3.60 (2.2%) stddev-sans-first:3.70 15:13:32 INFO - PROCESS | 1650 | Values: 165.0 165.0 166.0 167.0 167.0 168.0 169.0 166.0 165.0 177.0 15:13:32 INFO - PROCESS | 1650 | 15:13:32 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 15:13:32 INFO - PROCESS | 1650 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 66.0 63.0 65.0 65.0 15:13:32 INFO - PROCESS | 1650 | -------- Summary: end -------- 15:13:32 INFO - PROCESS | 1650 | 15:13:33 INFO - TEST-INFO | 1650: exit 0 15:13:33 INFO - TEST-OK | kraken | took 59115ms 15:13:33 INFO - SUITE-END | took 1178s 15:13:33 INFO - Completed test suite (00:19:38) 15:13:33 INFO - javascript benchmark 15:13:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2894.1751600793777, 3393.100828280506, 3403.42141835888, 3422.57217847769, 3452.4303489924164, 5815.592908496402, 5825.242718446607, 5839.270091238595, 5848.532117430606, 5860.413958604137, 5587.469190426903, 5663.1505274208785, 5699.287589051369, 5703.173039909221, 5710.114932185518, 5196.168613021917, 5240.03059434004, 5241.868953276179, 5252.8424147275455, 5302.390225124122, 5263.894722105556, 5271.130263506517, 5284.8150314739, 5292.020976119411, 5293.814716484924, 5332.173513105475, 5348.786048558053, 5363.490468405495, 5379.139337705968, 5402.702851343194, 5355.009323275207, 5363.865903352408, 5376.569874410038, 5379.838604841861, 5420.6747595144025, 5200.0, 5205.609579281569, 5254.816081437131, 5306.204069389584, 5315.3621565412395, 4625.190591646448, 5780.0, 5805.274340707411, 5831.795887143972, 5871.677057761822, 5553.333599967989, 6089.269287685506, 6297.1813664223355, 6344.206974128234, 6353.30113687494, 6244.6253224806205, 6281.24625044993, 6310.9684451577905, 6320.083587879778, 6330.87338253237, 5748.798792042258, 5909.674967876765, 5929.377415371324, 5955.34491205967, 6039.124326972565, 6404.071409645575, 6453.45145662624, 6469.417752402306, 6472.805815825533, 6478.643674597848, 6245.406686364788, 6282.654454004982, 6297.086922396227, 6299.055141728686, 6307.0, 6264.874702505925, 6270.31026587075, 6274.2784579773, 6287.9056814147825, 6304.338044505353, 6331.588446750947, 6342.651154186564, 6353.4599559038, 6353.904691429632, 6367.0, 6341.904871426932, 6345.49236061114, 6355.269144048493, 6358.586691865014, 6360.332165122688, 4986.6758660687665, 5045.520675535819, 5056.0, 5060.114479965991, 5094.0, 4521.480029796549, 4539.72761634303, 4556.270996640588, 4572.971081506635, 4589.403377560896, 5733.197352370671, 6015.127806468037, 6021.458068773832, 6052.394760523913, 6054.8183554493435, 6259.311475737665, 6264.060390941395, 6270.9372906270355, 6308.873822523616, 6322.083297921776, 6021.0968354746265, 6021.969890150609, 6030.155778191057, 6056.545759068087, 6080.361562035922, 5581.972090139523, 5583.218349431083, 5586.35756887955, 5587.38538760736, 5594.328680558359, 6339.841503962438, 6400.103985441949, 6409.166808315075, 6478.0, 6504.837379065467, 6247.31279559239, 6286.748530058747, 6298.11826344303, 6299.275583307978, 6301.936980630318, 6504.73981040772, 6510.21877374718, 6510.544261901621, 6512.511561632991, 6553.2136143663065, 6167.5682702210415, 6193.318734939063, 6231.376862313732, 6327.0, 6339.524535659752, 6190.133381326708, 6266.811995639956, 6302.369763023661, 6313.43179113882, 6329.145565348803, 6265.0, 6274.121622972879, 6277.717502712298, 6285.96857015712, 6293.433590976834, 6067.4539291462215, 6141.117811339906, 6271.059341098689, 6271.96864015677, 6274.027525733519, 4955.281484184845, 6068.423499767515, 6118.296395914527, 6128.295246046761, 6130.355969004488, 6283.497320214463, 6293.811185664437, 6303.275123360872, 6305.716242768995, 6317.7157027932935, 5854.0, 6164.568480206342, 6166.0, 6173.290071641819, 6179.660118693515], "value": 5805.1466787960335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.84956964201814, 460.9469910960241, 502.9421616514102, 507.48490282363406, 512.5131125430842, 30953.38093238134, 40618.781436556914, 42072.36891446631, 42263.57736422635, 42297.57702422975, 42225.7888710556, 43473.565264347344, 43490.34764478527, 43607.0, 43751.12497750051, 8297.917020829806, 9154.130357616032, 9392.295577831655, 9408.905910940906, 9414.670486532972, 8377.916220837806, 11239.494222759955, 11488.483018264198, 11507.769844603103, 11706.7658646827, 11260.662180134608, 11333.15001374896, 11348.60279890204, 11440.48517816696, 11444.256123351997, 8440.788980275482, 11373.488193031291, 11430.028447581966, 11461.312321260752, 11479.483423245974, 8068.193180681944, 11015.559377624886, 11301.604443844508, 11307.604233851776, 11484.94257528707, 41227.175456491, 41551.7922410389, 41597.96005099897, 41626.0, 41674.37488437676, 3934.4819315638015, 3954.564997850263, 3964.7422917510557, 3973.205358928226, 4010.2581022510635, 29397.85301073481, 29446.558301625493, 29458.410831783458, 29751.70248297511, 30213.640386182673, 3064.264576501646, 3119.4540955332727, 3212.1648371423366, 3238.951415728742, 3242.91892702682, 375238.0, 375451.0, 375491.0, 376295.0, 378627.0, 65248.67375663186, 65543.0, 65561.6721916397, 65689.67155164194, 65745.67127164429, 62788.68605656942, 65219.0, 65310.67344663342, 65585.34414655888, 65687.67156164188, 16551.337946482006, 16786.0, 16817.83182168187, 16825.915870420813, 16838.663226735396, 11696.0, 12012.339321337235, 12824.23054616726, 12907.870921290854, 12927.0, 15717.371305147666, 17647.205875735624, 17873.821261787216, 17912.55218619519, 18423.802452840522, 6574.5397822152945, 6893.655317234118, 6935.930640693528, 7003.0, 7036.577805331696, 860.5869182792295, 863.1521442228949, 868.2316150207113, 869.2871845086968, 901.9278457723366, 25273.873630632097, 29609.40781184364, 29769.40461190764, 29926.40147197044, 30616.08151755451, 706.5689929143218, 1039.4023436524028, 1072.3940973350032, 1082.5020490574266, 1206.8896615114115, 13801.861981380258, 14195.077319974169, 14466.132032078109, 14482.275886205647, 14613.561593152222, 402187.0, 403599.0, 404538.0, 404954.975225122, 405720.0, 53439.0, 53474.0, 53587.73206133944, 53772.73113634407, 53830.73084634552, 1385.736710025092, 1435.2680133132178, 1446.4503488674236, 1449.992750036243, 1452.2158034661377, 26474.470510589294, 27484.0, 27509.724902750717, 27569.0, 27698.86150569234, 46472.302915456974, 46807.53192468168, 46849.76575117103, 46937.53062469332, 46994.53005469902, 346826.0, 348554.0, 348882.0, 349722.0, 350574.2471287729, 36174.63825361713, 36687.0, 36822.44766328454, 36874.44688329731, 37052.0, 36038.0, 36148.81925590355, 38037.0, 40904.77285681434, 42716.93207669833, 31053.534196986613, 33341.83329083339, 35412.0, 36460.45309320415, 37012.81493592515, 32346.676533235306, 34320.25437965007, 34568.65431345654, 35023.824880876455, 36132.09669758277, 26051.218463446126, 34725.9582212534, 35001.29997399987, 35211.94364169079, 35216.0, 29178.70821291845, 31352.0, 32000.67999319977, 32033.67966320307, 32260.0, 23564.528709426057, 23817.52364952726, 23880.0, 23931.641025384983, 24427.38931526726], "value": 19171.01049001475, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3278017617847, 372.76515795049113, 391.5438514131036, 399.2414412616028, 419.1637682822769, 14655.900807439444, 15297.464588739396, 15929.681406371865, 21005.739655620673, 21533.892330538325, 18751.3437029704, 22213.555728885414, 22266.093909661806, 22278.55442891145, 22506.88746556265, 5787.739551720183, 5833.941660583393, 6014.578979471439, 6096.634201947875, 6110.20567326247, 5668.064769313059, 5922.822315330547, 5968.4329988651225, 5974.4324289192455, 6028.246469191351, 4214.431051807997, 4421.557844215568, 6368.681565921708, 6640.501962352819, 6704.363085506869, 6431.292557818636, 6566.441852442548, 6741.629210393427, 6750.1562304711915, 6760.425363844054, 5806.535477161817, 5813.418658134153, 5813.79651712188, 5824.24284842972, 5826.47561719443, 26372.340691482867, 26405.075822346127, 27055.729442705517, 27474.313142171406, 27503.86248068767, 2701.6352792372973, 2750.174947515757, 2752.518309295865, 2754.2838861895852, 2760.5721113227482, 11356.886431135665, 12285.38573071343, 14761.0, 14859.925700371428, 15430.0, 1745.7905051393786, 1793.901335426551, 1813.8809100215594, 1836.6969450040726, 1941.2041063164177, 111437.0, 135426.0, 138547.30726346304, 141991.0, 142123.0, 10828.675139745821, 11312.547498100148, 11879.465424055938, 12007.219530730474, 12128.272303661808, 15399.307031183624, 15817.762733559006, 15828.76256856148, 15837.208139592974, 15864.603384915239, 7259.455540834459, 7427.62861856905, 8762.211400973943, 8929.464232146092, 9009.594568244445, 8726.607302671395, 8735.039145693969, 8750.299976001905, 8899.510526921082, 8928.10718928102, 3928.8035598219976, 4811.4707382187935, 4815.662903596714, 4821.373221481255, 4872.098661747517, 1688.0884322465731, 1952.6973319135557, 2004.3986803958753, 2007.8092581204762, 2008.1766475744873, 889.5552223888056, 999.9650012249537, 1000.9749756256006, 1027.6865556005341, 1037.1547189040907, 22140.0, 22658.773412265997, 22682.092716291165, 22829.429264268525, 23160.42098947506, 1038.2472707287307, 1045.0, 1067.4289255248405, 1071.137734124022, 1074.5003573338436, 10926.453677316102, 11600.071994240441, 11878.821817672742, 11893.0, 11921.761564768656, 537472.0, 597296.0, 692945.0, 696294.0, 719969.0, 117604.0, 129074.0, 146404.0, 148957.25521372323, 149881.50118498676, 944.9858252126223, 950.8050849575959, 982.6806287956442, 983.1299300119302, 983.7638966647953, 17257.654846903242, 20981.0, 21157.576848463254, 21261.787382125982, 21437.142514299878, 44611.330830036924, 60589.788204234785, 62363.0, 62846.0, 62988.37011629825, 87860.56069719866, 88217.0, 89951.0, 91507.0, 92073.53963230141, 6163.075538669235, 8554.72263868066, 8635.654573816977, 8635.654573816977, 8882.245009174292, 12588.559400420942, 13668.24824634615, 13707.657308567366, 14097.929510352382, 14107.788383174055, 11731.530738770354, 11755.706107347385, 11780.587679431179, 11963.940180299043, 11987.40062996864, 6873.656317184221, 10456.529456174338, 11609.535618575163, 11747.882521174679, 11856.0, 11319.830202546804, 11424.371659558472, 11439.771204576029, 11660.650180494598, 12064.517419303129, 7243.384312333511, 8361.0, 8361.832763344577, 8628.913710863062, 8656.48061116335, 9545.952270238882, 11535.134864885, 11771.058315334923, 11793.646190614296, 11808.114391420506], "value": 10083.152990809342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.2858570714643, 1436.0809082187398, 1443.9278036098192, 1452.2883786944394, 1452.9636759081022, 7965.72119975801, 8343.791405214874, 8355.331573474123, 8360.540170290631, 8378.539180345078, 7433.702651893931, 7678.155402905676, 7692.961535192316, 7959.243871832181, 8167.224113709188, 2285.5200407914317, 2293.1286111277773, 2323.9767602324014, 2328.313147621447, 2329.860208387494, 2300.884955752214, 2335.8481698689616, 2339.87130707811, 2340.157543284416, 2341.906323747048, 2039.2964427272568, 2119.395972147938, 2246.7753224677485, 2287.7025986621716, 2301.919432819852, 2305.8270629702756, 2321.338418550705, 2323.918662846809, 2327.487952650423, 2329.464223228667, 2268.750437451879, 2315.7221133463922, 2320.4082958845556, 2346.7301260355107, 2353.670486131926, 8299.83400331996, 8374.916250837474, 8383.538905360203, 8387.496750194947, 8390.03514595817, 5087.414947281073, 5234.790608375661, 5239.633225674204, 5244.737763111829, 5246.921296180561, 3292.0, 3465.2722928184858, 3538.433850583894, 3539.132912436444, 3546.8758593449106, 1145.4730823821053, 1192.8389667394877, 1230.6246594788586, 1231.9753604927942, 1240.5782034108356, 10403.635872744419, 10771.892281077246, 10831.241813073088, 10908.890911090866, 10928.289661171999, 4004.379321205218, 4260.850870219528, 4561.794719237576, 4576.222042252825, 4587.747673877902, 8619.267362274277, 8745.606447709868, 8753.299736021103, 8761.605727742266, 8796.47221166732, 5098.0, 5178.378594568676, 5178.6116041297055, 5193.948060519422, 5211.869703257373, 4717.080169367009, 4849.854504364875, 4877.341558889504, 4885.389326334208, 4890.608751299887, 3650.3064417760543, 3716.349638813197, 3737.028372623083, 3813.6758375537834, 3815.618438156162, 1146.1174895330716, 1146.1862077924766, 1152.2395219155485, 1158.223989926751, 1163.8836116388293, 775.765059701048, 870.2515836380708, 894.7584152278848, 907.3059109781022, 923.9630414783468, 5548.223248745179, 5559.555235581144, 5706.686132262683, 5774.307083150049, 5899.292084949833, 971.1114330387758, 977.7408986618552, 997.5112195024531, 1032.8708911386077, 1037.7976294622626, 3606.4590311452966, 3616.692581130581, 3804.1821008483307, 3804.4293355996824, 3868.6324799144036, 9747.951260243653, 9780.95109524462, 10007.49962501872, 10043.4476103815, 10058.29591928558, 9735.0, 9767.413955162712, 10040.899591004143, 10060.446675432775, 10073.848892266622, 7472.028636277358, 7541.585212813348, 7663.118741344705, 7676.040494938133, 7695.576743279174, 5576.414476479911, 5748.252727145445, 5810.94189058104, 5830.0, 5864.06175011996, 8924.419912705653, 8943.508107054175, 9118.772030699285, 9288.11762882525, 9434.245260379015, 7905.644246008828, 8538.40231183836, 9425.670101546413, 9501.28740344463, 9563.952180239054, 6670.966645166744, 7066.57600543969, 7298.598577078312, 7319.048523691886, 7342.229065947999, 7491.850162996819, 7912.208779122042, 7988.0, 8082.797930051795, 8094.473859199134, 7115.288471152843, 7182.102237220348, 7239.927600723925, 7309.159446663702, 7379.667914943948, 7104.8987406952, 7117.572945623279, 7122.287771222836, 7164.570125792469, 7220.494565380373, 6307.526935479766, 6390.169277994017, 6469.482441404771, 6475.870482590416, 6482.060101285193, 4919.0407870464915, 4964.230544265644, 4976.651634385558, 5042.067217564616, 5081.8475445736685, 4896.565754804429, 4961.950380496149, 4985.725785081855, 5163.767630456714, 5202.765875535686], "value": 4406.440808657744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.95289135966635, 353.1894302575589, 361.8154741082048, 375.3843696338006, 376.6045652065331, 4375.299952007679, 4455.2871540553515, 5052.545270925616, 5283.445238249977, 5478.150886612577, 4449.755263460508, 5142.640015198937, 5242.6330156889035, 5291.629585928977, 5310.300703774794, 3836.923261534768, 3992.802159352197, 4070.3690927906223, 4076.9015548183297, 4147.585241475851, 2961.496545587245, 3933.704972127088, 4002.859899903504, 4010.2781499330254, 4070.0, 3959.2477429288488, 3966.2464131814863, 3983.9044262827665, 3991.4811074560266, 3991.6806655467494, 3505.614382417932, 3542.3092496962972, 3791.9241615167816, 3841.654251117385, 3996.660283875874, 3092.6134233220846, 3344.9498257526157, 3419.46998215277, 3463.9480407793903, 3483.3207524532727, 4148.419221309019, 4814.951850481485, 5116.0, 5117.513836185556, 5141.408737995141, 4004.7985604318587, 4355.040231895628, 4504.459464864237, 4548.476925153616, 4549.337783084616, 5329.973350133225, 5562.888742225133, 5562.972185139089, 5563.944360556424, 5595.509998050869, 3015.9849200754074, 3792.5259342582176, 3807.733458657895, 3808.695304375671, 3843.5195600549932, 4566.538707613565, 5767.134929760486, 5796.246487956623, 5808.82573522795, 5842.766289348421, 2923.751481124086, 3470.0, 3485.7734247273847, 3765.811709414518, 3766.924661506809, 3075.861586228625, 3218.3080637663015, 3782.735208535376, 3786.261678972629, 3879.786611736325, 3753.7560058596105, 4355.455568053993, 4481.395011673382, 4507.414036175276, 4536.432945881765, 5090.4655011223285, 5343.465653434625, 5658.490735833795, 5666.716664166775, 5693.914591281134, 1016.7458135466134, 1141.5890279499374, 1147.3746807989667, 1189.304257009659, 1231.7967535356745, 731.8499707559937, 734.7612026091541, 833.3749687734199, 847.6016272351985, 876.2070326354659, 4466.798994045275, 4585.403897493305, 4961.139572660252, 4998.775055122528, 5015.14742493777, 5020.560915772708, 5098.974505127525, 5348.636097795037, 5447.509724124848, 5505.862353441196, 4313.654907607384, 4820.807167713322, 4950.0694729055695, 4963.677360971526, 4999.65002449825, 2494.4013436775044, 2724.4551089781726, 2786.4845003674386, 2844.40267543814, 2924.0, 4798.95201047992, 5750.64223668294, 5769.74036168365, 5773.191753154561, 5780.768769249183, 4435.778211089432, 5163.096458119814, 5717.714114294352, 5732.598718089694, 5851.268591426072, 5961.344252132262, 5968.612040217372, 5972.552058595623, 5983.563944653252, 5990.341062483123, 4876.341693871282, 5204.271402003798, 5749.131532251951, 5757.913631295618, 5770.192173095854, 4857.769583227115, 5067.569256613229, 5500.752466138953, 5713.571482138773, 5753.597248192586, 4662.906741865211, 5420.322459692538, 5562.082256427644, 5949.007082627369, 5998.640081595118, 3757.1358587524473, 3777.792221427738, 3803.790791506494, 3918.9810649231977, 3922.450856880096, 4598.747068911108, 4916.803327866845, 5758.654480731169, 5800.187973683604, 5819.6508209507565, 5501.972490137524, 5599.328080630187, 5667.234923285304, 5681.261436013292, 5719.342275638189, 5332.626716129989, 5574.191742197278, 5594.797118619354, 5611.214429979887, 5617.129344951539, 5118.692878427158, 5167.83723662173, 5504.7522861470525, 5523.530499907392, 5530.281063461724, 5079.0, 5229.26790249373, 5580.748866301107, 5584.609077364708, 5588.497035266845, 4992.400911890451, 5479.369872464717, 5491.615586908878, 5525.392206857323, 5546.916796247979], "value": 3994.295620915787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1210986267166, 726.3571739010973, 760.980975475613, 813.2639960835444, 825.1995564302626, 14613.415463381465, 15562.610934726637, 15614.219289035545, 15627.984181028225, 15653.373865045398, 14121.29393530322, 14145.009849310552, 14148.50480233192, 14310.928445357784, 14342.282885855691, 679.9184097908234, 702.2661318921713, 843.6077224090811, 856.2080075929771, 859.5186695450536, 689.941354984827, 827.8096037911284, 846.1115828380176, 851.8126012277289, 861.3066481482405, 767.48578452437, 904.7466709321401, 908.1145882764285, 915.4461550761794, 916.2990312410977, 906.4515967839461, 907.2197909797569, 908.6910450446879, 909.1953621045357, 909.8680691299725, 528.3659608469814, 541.9756110975015, 621.2886245249165, 645.0, 658.1739916404929, 14522.564323070324, 14559.563213103624, 14575.979681422305, 14594.781078283835, 14601.269936503133, 13441.865581344256, 13496.595102146952, 13497.392617332243, 13498.797518037238, 13596.796048059286, 12047.277163370138, 12200.450979705935, 12244.142909996304, 12421.44103515344, 12908.806367904488, 4197.97901010496, 4365.410669559632, 4439.0, 4507.864764057083, 4527.275635898273, 106640.99999999923, 108411.66257558519, 111154.88845111526, 113643.0, 113646.29530556966, 10056.497175141214, 10344.482775861177, 10633.73415664599, 10846.29499082557, 10891.564337426415, 20751.8962405187, 20923.47691307699, 21243.150273989177, 21313.68029479559, 21317.61435506687, 7460.0674915635545, 7523.0972283326355, 7549.584772837547, 7551.811204719926, 7715.652795624211, 4147.937780933288, 4206.3480160574545, 4206.705530612828, 4228.851990180329, 4233.386159006926, 3379.2396710739886, 3440.1055725511046, 3472.131967008248, 3477.547918770594, 3481.686648201674, 613.1691557939017, 622.8723111762077, 697.8360085379932, 722.9746958856415, 735.4925101679823, 663.8174502011889, 691.8201267670341, 694.9235584085746, 702.7715992302523, 705.8588282343552, 9514.143727064597, 9768.804623907625, 9881.456519891475, 10141.2394070445, 10223.897761022294, 656.5043392238829, 678.3149019490351, 679.5718697220719, 693.9757108501279, 700.6232752641084, 4556.567126123013, 4850.83022094225, 4910.091633047898, 4912.680675756064, 4935.827246046371, 105567.0, 107925.92074079158, 111017.0, 111375.0, 111555.0, 94353.5282323584, 96421.0, 96789.5160524207, 98591.0, 100957.49521252347, 69534.65232673906, 74412.0, 83519.0, 84158.15841841749, 84950.57524712337, 9178.954105229432, 9534.570944307661, 9541.809163816546, 9575.90424095778, 9577.924486313961, 37368.43947340846, 45293.09413811771, 47932.36371999574, 49988.25017624811, 56652.0, 71268.5746285061, 72143.91784123138, 72506.27493724995, 73543.63228184039, 75670.0, 12846.678833028875, 12983.41574629125, 13063.150895191782, 13180.27508487004, 13490.662733431744, 13957.302134893418, 14090.718185636435, 14502.274886255856, 14554.708905821613, 15008.174550399834, 12337.876621233672, 12817.0, 13075.150115242479, 13451.175253196547, 13751.381187846771, 12860.0, 13243.0, 13500.45998160102, 13545.187288762705, 13564.72870542564, 12780.488780448677, 12821.743565128832, 13101.571014117926, 13169.473221071434, 13306.534271300457, 11279.830802537805, 11365.602203922823, 11367.772644547229, 11443.656690299304, 11477.770444590895, 10601.840972385266, 10672.89327106719, 10795.0, 10845.891541084804, 10859.131269498579], "value": 7514.3591613889785, "unit": "score"}], "name": "dromaeo_css", "value": 7276.463554921247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 116.0, 115.0, 115.0, 117.0, 118.0, 168.0, 172.0, 116.0], "value": 126.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 104.0, 108.0, 144.0, 111.0, 110.0, 109.0, 108.0, 129.0, 109.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 182.0, 184.0, 183.0, 184.0, 182.0, 181.0, 184.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 92.0, 60.0, 57.0, 59.0, 58.0, 73.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 86.0, 69.0, 68.0, 69.0, 81.0, 67.0, 68.0, 84.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 88.0, 84.0, 88.0, 84.0, 88.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 125.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 84.0, 84.0, 86.0, 87.0, 91.0, 85.0, 128.0], "value": 90.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 59.0, 57.0, 58.0, 58.0, 57.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 83.0, 72.0, 74.0, 70.0, 68.0, 68.0, 92.0, 101.0, 102.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 85.0, 81.0, 83.0, 84.0, 82.0, 85.0, 88.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 144.0, 136.0, 135.0, 133.0, 132.0, 135.0, 180.0, 134.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 167.0, 167.0, 168.0, 169.0, 166.0, 165.0, 177.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 63.0, 65.0, 65.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1440.3999999999999, "alertThreshold": 2.0}]} 15:13:33 INFO - Return code: 0 15:13:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:13:33 ERROR - # TBPL SUCCESS # 15:13:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:13:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:13:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:13:33 INFO - 2017-03-05 15:13:33.642 screenresolution[1654:10890] starting screenresolution argv=screenresolution get 15:13:33 INFO - 2017-03-05 15:13:33.646 screenresolution[1654:10890] Display 0: 1600x1200x32@60 15:13:33 INFO - 2017-03-05 15:13:33.653 screenresolution[1655:10894] starting screenresolution argv=screenresolution list 15:13:33 INFO - Available Modes on Display 0 15:13:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:13:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:13:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:13:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:13:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:13:33 INFO - Intel Iris: 15:13:33 INFO - Chipset Model: Intel Iris 15:13:33 INFO - Type: GPU 15:13:33 INFO - Bus: Built-In 15:13:33 INFO - VRAM (Dynamic, Max): 1536 MB 15:13:33 INFO - Vendor: Intel (0x8086) 15:13:33 INFO - Device ID: 0x0a2e 15:13:33 INFO - Revision ID: 0x0009 15:13:33 INFO - Displays: 15:13:33 INFO - Display: 15:13:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:13:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:13:33 INFO - Display Serial Number: 1600x1200 60 15:13:33 INFO - Main Display: Yes 15:13:33 INFO - Mirror: Off 15:13:33 INFO - Online: Yes 15:13:33 INFO - Rotation: Supported 15:13:33 INFO - Return code: 0 15:13:33 INFO - Running post-action listener: _resource_record_post_action 15:13:33 INFO - [mozharness: 2017-03-05 23:13:33.887074Z] Finished run-tests step (success) 15:13:33 INFO - Running post-run listener: _resource_record_post_run 15:13:33 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 31161344; Write bytes: 510090752; Read time: 194; Write time: 1581 15:13:33 INFO - TinderboxPrint: CPU usage
53.5% 15:13:33 INFO - TinderboxPrint: I/O read bytes / time
31,161,344 / 194 15:13:33 INFO - TinderboxPrint: I/O write bytes / time
510,090,752 / 1,581 15:13:33 INFO - TinderboxPrint: CPU idle
2,229.0 (46.5%) 15:13:33 INFO - TinderboxPrint: CPU system
955.4 (19.9%) 15:13:33 INFO - TinderboxPrint: CPU user
1,613.3 (33.6%) 15:13:33 INFO - TinderboxPrint: Swap in / out
235,343,872 / 0 15:13:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205709824; Write bytes: 199041024; Read time: 15902; Write time: 424 15:13:33 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29088768; Write bytes: 300076544; Read time: 175; Write time: 1124 15:13:34 INFO - Running post-run listener: _upload_blobber_files 15:13:34 INFO - Blob upload gear active. 15:13:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:13:34 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 15:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:13:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:35 INFO - (blobuploader) - INFO - Done attempting. 15:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:36 INFO - (blobuploader) - INFO - Done attempting. 15:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:37 INFO - (blobuploader) - INFO - Done attempting. 15:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:39 INFO - (blobuploader) - INFO - Done attempting. 15:13:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:13:39 INFO - Return code: 0 15:13:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:13:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:13:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/873884ce1b27a44691e68b029d47e30e775871f75e494355a6a085e83b8536afc6b86d2b7e31387811b9dbdc63f08f988d6b3a01376bef16b16efedbbdf67ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951382aa606e5b2f333691a2a0907f8d15245c8bc4f88f3ebe4033559e428b32b8a54d771ba0ebd0c3aecc48264e908d94ef08660b5b91ba1a93c0249069ac90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164228cb118293f3af7844a069afd05e8e959030cf8117897d37365844fcd51a58acd8a165151651e0f68695b196af79083cf2e280fc7563979429119e86ff93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645956aa2c4b5d1892d5ae792a073902b652599070f006891a4ec10904667db16ab64e0cbf695c7002fd867be210144d9036398a3b795f61f6b29416b47cd125"} 15:13:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:13:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:13:39 INFO - Contents: 15:13:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/873884ce1b27a44691e68b029d47e30e775871f75e494355a6a085e83b8536afc6b86d2b7e31387811b9dbdc63f08f988d6b3a01376bef16b16efedbbdf67ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951382aa606e5b2f333691a2a0907f8d15245c8bc4f88f3ebe4033559e428b32b8a54d771ba0ebd0c3aecc48264e908d94ef08660b5b91ba1a93c0249069ac90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164228cb118293f3af7844a069afd05e8e959030cf8117897d37365844fcd51a58acd8a165151651e0f68695b196af79083cf2e280fc7563979429119e86ff93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645956aa2c4b5d1892d5ae792a073902b652599070f006891a4ec10904667db16ab64e0cbf695c7002fd867be210144d9036398a3b795f61f6b29416b47cd125"} 15:13:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:13:39 INFO - Copying logs to upload dir... 15:13:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:13:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.046457 ========= master_lag: 1.68 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-05 15:13:41.643456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 15:13:41.646539) ========= 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.LKGvFgSMwt/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.03CXckBHO5/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/873884ce1b27a44691e68b029d47e30e775871f75e494355a6a085e83b8536afc6b86d2b7e31387811b9dbdc63f08f988d6b3a01376bef16b16efedbbdf67ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951382aa606e5b2f333691a2a0907f8d15245c8bc4f88f3ebe4033559e428b32b8a54d771ba0ebd0c3aecc48264e908d94ef08660b5b91ba1a93c0249069ac90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164228cb118293f3af7844a069afd05e8e959030cf8117897d37365844fcd51a58acd8a165151651e0f68695b196af79083cf2e280fc7563979429119e86ff93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645956aa2c4b5d1892d5ae792a073902b652599070f006891a4ec10904667db16ab64e0cbf695c7002fd867be210144d9036398a3b795f61f6b29416b47cd125"} build_url:https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/XEJU91OVS1ySAmS3zKN-xg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/873884ce1b27a44691e68b029d47e30e775871f75e494355a6a085e83b8536afc6b86d2b7e31387811b9dbdc63f08f988d6b3a01376bef16b16efedbbdf67ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951382aa606e5b2f333691a2a0907f8d15245c8bc4f88f3ebe4033559e428b32b8a54d771ba0ebd0c3aecc48264e908d94ef08660b5b91ba1a93c0249069ac90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164228cb118293f3af7844a069afd05e8e959030cf8117897d37365844fcd51a58acd8a165151651e0f68695b196af79083cf2e280fc7563979429119e86ff93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645956aa2c4b5d1892d5ae792a073902b652599070f006891a4ec10904667db16ab64e0cbf695c7002fd867be210144d9036398a3b795f61f6b29416b47cd125"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 15:13:41.686322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:13:41.686654) ========= 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.LKGvFgSMwt/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.03CXckBHO5/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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.005116 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 15:13:41.737923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 15:13:41.738232) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 15:13:41.738532) ========= ========= Total master_lag: 1.83 =========