builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0325 starttime: 1481805762.91 results: success (0) buildid: 20161215030215 builduid: 804a2738feba4f7f8d90de161e9e2950 revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:42.912708) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:42.913193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:42.913482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:42.940989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:42.941575) ========= 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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-15 04:42:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-12-15 04:42:43 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098019 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:43.066320) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:43.066724) ========= 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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.021481 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:43.116012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-15 04:42:43.116405) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7652a58efa46f1c57c94bba26efc5d53b6184e83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-15 04:42:43,210 truncating revision to first 12 chars 2016-12-15 04:42:43,210 Setting DEBUG logging. 2016-12-15 04:42:43,210 attempt 1/10 2016-12-15 04:42:43,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7652a58efa46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 04:42:45,153 unpacking tar archive at: mozilla-central-7652a58efa46/testing/mozharness/ program finished with exit code 0 elapsedTime=2.216455 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-15 04:42:45.358710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:45.359338) ========= script_repo_revision: 7652a58efa46f1c57c94bba26efc5d53b6184e83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:45.360020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:45.360493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:42:45.382415) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-15 04:42:45.383079) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:42:45 INFO - MultiFileLogger online at 20161215 04:42:45 in /builds/slave/test 04:42:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:42:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:45 INFO - {'append_to_log': False, 04:42:45 INFO - 'base_work_dir': '/builds/slave/test', 04:42:45 INFO - 'blob_upload_branch': 'Firefox', 04:42:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:45 INFO - 'branch': 'Firefox', 04:42:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:45 INFO - 'config_files': ('talos/mac_config.py',), 04:42:45 INFO - 'default_actions': ('clobber', 04:42:45 INFO - 'read-buildbot-config', 04:42:45 INFO - 'download-and-extract', 04:42:45 INFO - 'populate-webroot', 04:42:45 INFO - 'create-virtualenv', 04:42:45 INFO - 'install', 04:42:45 INFO - 'run-tests'), 04:42:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:45 INFO - 'download_minidump_stackwalk': True, 04:42:45 INFO - 'download_symbols': 'ondemand', 04:42:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:45 INFO - 'installer_path': 'installer.exe', 04:42:45 INFO - 'log_level': 'info', 04:42:45 INFO - 'log_name': 'talos', 04:42:45 INFO - 'log_to_console': True, 04:42:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:45 INFO - 'opt_config_files': (), 04:42:45 INFO - 'pip_index': False, 04:42:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:45 INFO - 'cmd': ('bash', 04:42:45 INFO - '-c', 04:42:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:45 INFO - 'enabled': True, 04:42:45 INFO - 'halt_on_failure': False, 04:42:45 INFO - 'name': 'check_screen_resolution'},), 04:42:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:45 INFO - 'cmd': ('bash', 04:42:45 INFO - '-c', 04:42:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:45 INFO - 'enabled': True, 04:42:45 INFO - 'halt_on_failure': False, 04:42:45 INFO - 'name': 'check_screen_resolution'},), 04:42:45 INFO - 'run_cmd_checks_enabled': True, 04:42:45 INFO - 'sps_profile': False, 04:42:45 INFO - 'sps_profile_interval': 0, 04:42:45 INFO - 'suite': 'dromaeojs', 04:42:45 INFO - 'system_bits': '32', 04:42:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:45 INFO - 'title': 't-yosemite-r7-0325', 04:42:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:45 INFO - 'use_talos_json': True, 04:42:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:45 INFO - 'work_dir': 'build'} 04:42:45 INFO - [mozharness: 2016-12-15 12:42:45.591471Z] Running clobber step. 04:42:45 INFO - Running pre-action listener: _resource_record_pre_action 04:42:45 INFO - Running main action method: clobber 04:42:45 INFO - rmtree: /builds/slave/test/build 04:42:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:47 INFO - Running post-action listener: _resource_record_post_action 04:42:47 INFO - [mozharness: 2016-12-15 12:42:47.852859Z] Finished clobber step (success) 04:42:47 INFO - [mozharness: 2016-12-15 12:42:47.853016Z] Running read-buildbot-config step. 04:42:47 INFO - Running pre-action listener: _resource_record_pre_action 04:42:47 INFO - Running main action method: read_buildbot_config 04:42:47 INFO - Using buildbot properties: 04:42:47 INFO - { 04:42:47 INFO - "project": "", 04:42:47 INFO - "product": "firefox", 04:42:47 INFO - "script_repo_revision": "production", 04:42:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:42:47 INFO - "repository": "", 04:42:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:42:47 INFO - "buildid": "20161215030215", 04:42:47 INFO - "stage_platform": "macosx64", 04:42:47 INFO - "basedir": "/builds/slave/test", 04:42:47 INFO - "nightly_build": "True", 04:42:47 INFO - "buildnumber": 11, 04:42:47 INFO - "slavename": "t-yosemite-r7-0325", 04:42:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:42:47 INFO - "platform": "yosemite_r7", 04:42:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:42:47 INFO - "branch": "mozilla-central", 04:42:47 INFO - "repo_path": "mozilla-central", 04:42:47 INFO - "revision": "7652a58efa46f1c57c94bba26efc5d53b6184e83", 04:42:47 INFO - "pgo_build": "False", 04:42:47 INFO - "builduid": "804a2738feba4f7f8d90de161e9e2950", 04:42:47 INFO - "slavebuilddir": "test" 04:42:47 INFO - } 04:42:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:42:47 INFO - Running post-action listener: _resource_record_post_action 04:42:47 INFO - [mozharness: 2016-12-15 12:42:47.856395Z] Finished read-buildbot-config step (success) 04:42:47 INFO - [mozharness: 2016-12-15 12:42:47.856539Z] Running download-and-extract step. 04:42:47 INFO - Running pre-action listener: _resource_record_pre_action 04:42:47 INFO - Running main action method: download_and_extract 04:42:47 INFO - mkdir: /builds/slave/test/build/tests 04:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:47 INFO - trying https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:42:49 INFO - Downloaded 1199 bytes. 04:42:49 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:42:49 INFO - Using the following test package requirements: 04:42:49 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:42:49 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:49 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:42:49 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'jsshell-mac.zip'], 04:42:49 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:42:49 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:42:49 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:42:49 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:42:49 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:42:49 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:49 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:49 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:42:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:49 INFO - Fetch https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:42:50 INFO - Expected file size: 16276332 04:42:50 INFO - Obtained file size: 16276332 04:42:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:42:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:56 INFO - Fetch https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:42:57 INFO - Expected file size: 16276332 04:42:57 INFO - Obtained file size: 16276332 04:43:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:43:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:43:03 INFO - Fetch https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:43:05 INFO - Expected file size: 14409734 04:43:05 INFO - Obtained file size: 14409734 04:43: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')]} 04:43:05 INFO - trying https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:43:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:43:07 INFO - Downloaded 69743623 bytes. 04:43:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:43:07 INFO - mkdir: /builds/slave/test/properties 04:43:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:43:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:43:07 INFO - Contents: 04:43:07 INFO - build_url:https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:43:08 INFO - Running post-action listener: _resource_record_post_action 04:43:08 INFO - Running post-action listener: set_extra_try_arguments 04:43:08 INFO - [mozharness: 2016-12-15 12:43:08.370799Z] Finished download-and-extract step (success) 04:43:08 INFO - [mozharness: 2016-12-15 12:43:08.370920Z] Running populate-webroot step. 04:43:08 INFO - Running pre-action listener: _resource_record_pre_action 04:43:08 INFO - Running main action method: populate_webroot 04:43:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:08 INFO - '--tppagecycles', 04:43:08 INFO - '7'], 04:43:08 INFO - 'tests': ['tsvgm']}}, 04:43:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:43:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:43:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:43:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:43:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:43:08 INFO - 'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:43:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:43:08 INFO - 'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['damp', 'tps']}, 04:43:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:43:08 INFO - 'tests': ['damp', 'tps']}, 04:43:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['dromaeo_dom']}, 04:43:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['basic_compositor_video']}, 04:43:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:43:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['a11yr', 04:43:08 INFO - 'ts_paint', 04:43:08 INFO - 'tpaint', 04:43:08 INFO - 'sessionrestore', 04:43:08 INFO - 'sessionrestore_no_auto_restore', 04:43:08 INFO - 'tabpaint']}, 04:43:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:43:08 INFO - 'ts_paint', 04:43:08 INFO - 'tpaint', 04:43:08 INFO - 'sessionrestore', 04:43:08 INFO - 'sessionrestore_no_auto_restore', 04:43:08 INFO - 'tabpaint']}, 04:43:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:43:08 INFO - 'ts_paint', 04:43:08 INFO - 'tpaint', 04:43:08 INFO - 'sessionrestore', 04:43:08 INFO - 'sessionrestore_no_auto_restore', 04:43:08 INFO - 'tabpaint']}, 04:43:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:43:08 INFO - 'ts_paint', 04:43:08 INFO - 'tpaint', 04:43:08 INFO - 'sessionrestore', 04:43:08 INFO - 'sessionrestore_no_auto_restore', 04:43:08 INFO - 'tabpaint']}, 04:43:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['a11yr', 04:43:08 INFO - 'ts_paint', 04:43:08 INFO - 'tpaint', 04:43:08 INFO - 'sessionrestore', 04:43:08 INFO - 'sessionrestore_no_auto_restore', 04:43:08 INFO - 'tabpaint']}, 04:43:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['a11yr', 04:43:08 INFO - 'ts_paint', 04:43:08 INFO - 'tpaint', 04:43:08 INFO - 'sessionrestore', 04:43:08 INFO - 'sessionrestore_no_auto_restore', 04:43:08 INFO - 'tabpaint']}, 04:43:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['tsvgx', 04:43:08 INFO - 'tsvgr_opacity', 04:43:08 INFO - 'tart', 04:43:08 INFO - 'tscrollx', 04:43:08 INFO - 'cart', 04:43:08 INFO - 'tsvg_static']}, 04:43:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:43:08 INFO - 'tsvgr_opacity', 04:43:08 INFO - 'tart', 04:43:08 INFO - 'tscrollx', 04:43:08 INFO - 'cart', 04:43:08 INFO - 'tsvg_static']}, 04:43:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:43:08 INFO - 'talos_options': ['--disable-e10s'], 04:43:08 INFO - 'tests': ['tp5o']}, 04:43:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:43:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:43:08 INFO - 'talos_options': ['--disable-e10s', 04:43:08 INFO - '--xperf_path', 04:43:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:08 INFO - 'tests': ['tp5n']}, 04:43:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:43:08 INFO - 'talos_options': ['--xperf_path', 04:43:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:08 INFO - 'tests': ['tp5n']}}, 04:43:08 INFO - 'talos.zip': {'path': '', 04:43:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:08 INFO - Running post-action listener: _resource_record_post_action 04:43:08 INFO - [mozharness: 2016-12-15 12:43:08.388949Z] Finished populate-webroot step (success) 04:43:08 INFO - [mozharness: 2016-12-15 12:43:08.389079Z] Running create-virtualenv step. 04:43:08 INFO - Running pre-action listener: _resource_record_pre_action 04:43:08 INFO - Running main action method: create_virtualenv 04:43:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:43:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:08 INFO - Using real prefix '/tools/python27' 04:43:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:09 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:12 INFO - Installing pip.................done. 04:43:12 INFO - Return code: 0 04:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:43:12 INFO - Reading from file tmpfile_stdout 04:43:12 INFO - Output received: 04:43:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:43:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:12 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:12 INFO - 'HOME': '/Users/cltbld', 04:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:12 INFO - 'LOGNAME': 'cltbld', 04:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:12 INFO - 'MOZ_NO_REMOTE': '1', 04:43:12 INFO - 'NO_EM_RESTART': '1', 04:43:12 INFO - 'PAGER': '/bin/cat', 04:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:12 INFO - 'PWD': '/builds/slave/test', 04:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:12 INFO - 'SHELL': '/bin/bash', 04:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:12 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:12 INFO - 'USER': 'cltbld', 04:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:12 INFO - 'XPC_FLAGS': '0x0', 04:43:12 INFO - 'XPC_SERVICE_NAME': '0', 04:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:43:12 INFO - Cleaning up... 04:43:12 INFO - Return code: 0 04:43:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:12 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:12 INFO - 'HOME': '/Users/cltbld', 04:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:12 INFO - 'LOGNAME': 'cltbld', 04:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:12 INFO - 'MOZ_NO_REMOTE': '1', 04:43:12 INFO - 'NO_EM_RESTART': '1', 04:43:12 INFO - 'PAGER': '/bin/cat', 04:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:12 INFO - 'PWD': '/builds/slave/test', 04:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:12 INFO - 'SHELL': '/bin/bash', 04:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:12 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:12 INFO - 'USER': 'cltbld', 04:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:12 INFO - 'XPC_FLAGS': '0x0', 04:43:12 INFO - 'XPC_SERVICE_NAME': '0', 04:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:12 INFO - Downloading/unpacking psutil>=3.1.1 04:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:16 INFO - Installing collected packages: psutil 04:43:16 INFO - Running setup.py install for psutil 04:43:16 INFO - building 'psutil._psutil_osx' extension 04:43:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:43:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:43:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:43:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:43:17 INFO - building 'psutil._psutil_posix' extension 04:43:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:43:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:43:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:43:17 INFO - ^ 04:43:17 INFO - 1 warning generated. 04:43:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:43:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:17 INFO - Successfully installed psutil 04:43:17 INFO - Cleaning up... 04:43:17 INFO - Return code: 0 04:43:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:17 INFO - 'HOME': '/Users/cltbld', 04:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:17 INFO - 'LOGNAME': 'cltbld', 04:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:17 INFO - 'MOZ_NO_REMOTE': '1', 04:43:17 INFO - 'NO_EM_RESTART': '1', 04:43:17 INFO - 'PAGER': '/bin/cat', 04:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:17 INFO - 'PWD': '/builds/slave/test', 04:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:17 INFO - 'SHELL': '/bin/bash', 04:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:17 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:17 INFO - 'USER': 'cltbld', 04:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:17 INFO - 'XPC_FLAGS': '0x0', 04:43:17 INFO - 'XPC_SERVICE_NAME': '0', 04:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:43:20 INFO - Installing collected packages: mozsystemmonitor 04:43:20 INFO - Running setup.py install for mozsystemmonitor 04:43:20 INFO - Successfully installed mozsystemmonitor 04:43:20 INFO - Cleaning up... 04:43:20 INFO - Return code: 0 04:43:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:43:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:20 INFO - 'HOME': '/Users/cltbld', 04:43:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:20 INFO - 'LOGNAME': 'cltbld', 04:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:20 INFO - 'MOZ_NO_REMOTE': '1', 04:43:20 INFO - 'NO_EM_RESTART': '1', 04:43:20 INFO - 'PAGER': '/bin/cat', 04:43:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:20 INFO - 'PWD': '/builds/slave/test', 04:43:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:20 INFO - 'SHELL': '/bin/bash', 04:43:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:20 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:20 INFO - 'USER': 'cltbld', 04:43:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:20 INFO - 'XPC_FLAGS': '0x0', 04:43:20 INFO - 'XPC_SERVICE_NAME': '0', 04:43:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:20 INFO - Downloading/unpacking jsonschema==2.5.1 04:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:23 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:23 INFO - warning: no files found matching '*.txt' 04:43:23 INFO - no previously-included directories found matching 'build' 04:43:23 INFO - no previously-included directories found matching 'dist' 04:43:23 INFO - no previously-included directories found matching '.git*' 04:43:23 INFO - Installing collected packages: jsonschema, functools32 04:43:24 INFO - Running setup.py install for functools32 04:43:24 INFO - warning: no files found matching '*.txt' 04:43:24 INFO - no previously-included directories found matching 'build' 04:43:24 INFO - no previously-included directories found matching 'dist' 04:43:24 INFO - no previously-included directories found matching '.git*' 04:43:24 INFO - Successfully installed jsonschema functools32 04:43:24 INFO - Cleaning up... 04:43:24 INFO - Return code: 0 04:43:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:24 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:43:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:24 INFO - 'HOME': '/Users/cltbld', 04:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:24 INFO - 'LOGNAME': 'cltbld', 04:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:24 INFO - 'MOZ_NO_REMOTE': '1', 04:43:24 INFO - 'NO_EM_RESTART': '1', 04:43:24 INFO - 'PAGER': '/bin/cat', 04:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:24 INFO - 'PWD': '/builds/slave/test', 04:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:24 INFO - 'SHELL': '/bin/bash', 04:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:24 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:24 INFO - 'USER': 'cltbld', 04:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:24 INFO - 'XPC_FLAGS': '0x0', 04:43:24 INFO - 'XPC_SERVICE_NAME': '0', 04:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:43:24 INFO - Cleaning up... 04:43:24 INFO - Return code: 0 04:43:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:24 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:43:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:24 INFO - 'HOME': '/Users/cltbld', 04:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:24 INFO - 'LOGNAME': 'cltbld', 04:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:24 INFO - 'MOZ_NO_REMOTE': '1', 04:43:24 INFO - 'NO_EM_RESTART': '1', 04:43:24 INFO - 'PAGER': '/bin/cat', 04:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:24 INFO - 'PWD': '/builds/slave/test', 04:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:24 INFO - 'SHELL': '/bin/bash', 04:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:24 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:24 INFO - 'USER': 'cltbld', 04:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:24 INFO - 'XPC_FLAGS': '0x0', 04:43:24 INFO - 'XPC_SERVICE_NAME': '0', 04:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:28 INFO - Downloading docopt-0.6.1.tar.gz 04:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:43:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:43:28 INFO - Running setup.py install for blobuploader 04:43:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:43:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:43:28 INFO - Running setup.py install for requests 04:43:29 INFO - Running setup.py install for docopt 04:43:29 INFO - Successfully installed blobuploader requests docopt 04:43:29 INFO - Cleaning up... 04:43:29 INFO - Return code: 0 04:43:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:29 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:29 INFO - 'HOME': '/Users/cltbld', 04:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:29 INFO - 'LOGNAME': 'cltbld', 04:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:29 INFO - 'MOZ_NO_REMOTE': '1', 04:43:29 INFO - 'NO_EM_RESTART': '1', 04:43:29 INFO - 'PAGER': '/bin/cat', 04:43:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:29 INFO - 'PWD': '/builds/slave/test', 04:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:29 INFO - 'SHELL': '/bin/bash', 04:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:29 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:29 INFO - 'USER': 'cltbld', 04:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:29 INFO - 'XPC_FLAGS': '0x0', 04:43:29 INFO - 'XPC_SERVICE_NAME': '0', 04:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:29 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-J937MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:29 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Auxwfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ueWuYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-R8MiDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-kLvsXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-EAdgdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-zllHQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-CJB90D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-4augRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-2___et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:30 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-J0VjHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:31 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-q9LBLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:31 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-z18KAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:31 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-kcyx8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:31 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-vabegb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:31 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-uJEuKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:31 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Yi9JF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:31 INFO - Running setup.py install for manifestparser 04:43:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:31 INFO - Running setup.py install for mozcrash 04:43:31 INFO - Running setup.py install for mozdebug 04:43:32 INFO - Running setup.py install for mozdevice 04:43:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Running setup.py install for mozfile 04:43:32 INFO - Running setup.py install for mozhttpd 04:43:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Running setup.py install for mozinfo 04:43:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Running setup.py install for mozInstall 04:43:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:32 INFO - Running setup.py install for mozleak 04:43:32 INFO - Running setup.py install for mozlog 04:43:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:33 INFO - Running setup.py install for moznetwork 04:43:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:33 INFO - Running setup.py install for mozprocess 04:43:33 INFO - Running setup.py install for mozprofile 04:43:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:43:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:43:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:43:33 INFO - Running setup.py install for mozrunner 04:43:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:43:33 INFO - Running setup.py install for mozscreenshot 04:43:33 INFO - Running setup.py install for moztest 04:43:34 INFO - Running setup.py install for mozversion 04:43:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:34 INFO - Cleaning up... 04:43:34 INFO - Return code: 0 04:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:34 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:34 INFO - 'HOME': '/Users/cltbld', 04:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:34 INFO - 'LOGNAME': 'cltbld', 04:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:34 INFO - 'MOZ_NO_REMOTE': '1', 04:43:34 INFO - 'NO_EM_RESTART': '1', 04:43:34 INFO - 'PAGER': '/bin/cat', 04:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:34 INFO - 'PWD': '/builds/slave/test', 04:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:34 INFO - 'SHELL': '/bin/bash', 04:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:34 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:34 INFO - 'USER': 'cltbld', 04:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:34 INFO - 'XPC_FLAGS': '0x0', 04:43:34 INFO - 'XPC_SERVICE_NAME': '0', 04:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:34 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-imFPpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:34 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-MJqWSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:34 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-YphlwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:34 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-fx3jmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:34 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-vQBBnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-4rYfpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Fj860a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-lTjF68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-nieh25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-OrryHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Q6UdfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-OL3Bqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Xv4Avx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:35 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-zqTSvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:36 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-YehBoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:36 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ZINnhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:36 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ePnkmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:38 INFO - Downloading blessings-1.6.tar.gz 04:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:38 INFO - Installing collected packages: blessings 04:43:38 INFO - Running setup.py install for blessings 04:43:39 INFO - Successfully installed blessings 04:43:39 INFO - Cleaning up... 04:43:39 INFO - Return code: 0 04:43:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:39 INFO - Reading from file tmpfile_stdout 04:43:39 INFO - Current package versions: 04:43:39 INFO - blessings == 1.6 04:43:39 INFO - blobuploader == 1.2.4 04:43:39 INFO - docopt == 0.6.1 04:43:39 INFO - functools32 == 3.2.3-2 04:43:39 INFO - jsonschema == 2.5.1 04:43:39 INFO - manifestparser == 1.1 04:43:39 INFO - mozInstall == 1.12 04:43:39 INFO - mozcrash == 1.0 04:43:39 INFO - mozdebug == 0.1 04:43:39 INFO - mozdevice == 0.49 04:43:39 INFO - mozfile == 1.2 04:43:39 INFO - mozhttpd == 0.7 04:43:39 INFO - mozinfo == 0.9 04:43:39 INFO - mozleak == 0.1 04:43:39 INFO - mozlog == 3.4 04:43:39 INFO - moznetwork == 0.27 04:43:39 INFO - mozprocess == 0.23 04:43:39 INFO - mozprofile == 0.28 04:43:39 INFO - mozrunner == 6.13 04:43:39 INFO - mozscreenshot == 0.1 04:43:39 INFO - mozsystemmonitor == 0.3 04:43:39 INFO - moztest == 0.7 04:43:39 INFO - mozversion == 1.4 04:43:39 INFO - psutil == 3.1.1 04:43:39 INFO - requests == 1.2.3 04:43:39 INFO - wsgiref == 0.1.2 04:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:40 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:40 INFO - 'HOME': '/Users/cltbld', 04:43:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:40 INFO - 'LOGNAME': 'cltbld', 04:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:40 INFO - 'MOZ_NO_REMOTE': '1', 04:43:40 INFO - 'NO_EM_RESTART': '1', 04:43:40 INFO - 'PAGER': '/bin/cat', 04:43:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:40 INFO - 'PWD': '/builds/slave/test', 04:43:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:40 INFO - 'SHELL': '/bin/bash', 04:43:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:40 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:40 INFO - 'USER': 'cltbld', 04:43:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:40 INFO - 'XPC_FLAGS': '0x0', 04:43:40 INFO - 'XPC_SERVICE_NAME': '0', 04:43:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:40 INFO - Cleaning up... 04:43:40 INFO - Return code: 0 04:43:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:40 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 0x103b383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c34ade80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, '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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:43:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:43:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:40 INFO - 'HOME': '/Users/cltbld', 04:43:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:40 INFO - 'LOGNAME': 'cltbld', 04:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:40 INFO - 'MOZ_NO_REMOTE': '1', 04:43:40 INFO - 'NO_EM_RESTART': '1', 04:43:40 INFO - 'PAGER': '/bin/cat', 04:43:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:40 INFO - 'PWD': '/builds/slave/test', 04:43:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:40 INFO - 'SHELL': '/bin/bash', 04:43:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:43:40 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:43:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:40 INFO - 'USER': 'cltbld', 04:43:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:40 INFO - 'XPC_FLAGS': '0x0', 04:43:40 INFO - 'XPC_SERVICE_NAME': '0', 04:43:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:43:41 INFO - Cleaning up... 04:43:41 INFO - Return code: 0 04:43:41 INFO - Running post-action listener: _resource_record_post_action 04:43:41 INFO - Running post-action listener: _start_resource_monitoring 04:43:41 INFO - Starting resource monitoring. 04:43:41 INFO - [mozharness: 2016-12-15 12:43:41.112459Z] Finished create-virtualenv step (success) 04:43:41 INFO - [mozharness: 2016-12-15 12:43:41.113432Z] Running install step. 04:43:41 INFO - Running pre-action listener: _resource_record_pre_action 04:43:41 INFO - Running main action method: install 04:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:41 INFO - Reading from file tmpfile_stdout 04:43:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:41 INFO - Reading from file tmpfile_stdout 04:43:41 INFO - Output received: 04:43:41 INFO - Usage: mozinstall [options] installer 04:43:41 INFO - Options: 04:43:41 INFO - -h, --help show this help message and exit 04:43:41 INFO - -d DEST, --destination=DEST 04:43:41 INFO - Directory to install application into. [default: 04:43:41 INFO - "/builds/slave/test"] 04:43:41 INFO - --app=APP Application being installed. [default: firefox] 04:43:41 INFO - mkdir: /builds/slave/test/build/application 04:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:44:03 INFO - Reading from file tmpfile_stdout 04:44:03 INFO - Output received: 04:44:03 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:44:03 INFO - Running post-action listener: _resource_record_post_action 04:44:03 INFO - [mozharness: 2016-12-15 12:44:03.381861Z] Finished install step (success) 04:44:03 INFO - [mozharness: 2016-12-15 12:44:03.381993Z] Running run-tests step. 04:44:03 INFO - Running pre-action listener: _resource_record_pre_action 04:44:03 INFO - Running main action method: run_tests 04:44:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:03 INFO - 2016-12-15 04:44:03.396 screenresolution[1622:7296] starting screenresolution argv=screenresolution get 04:44:03 INFO - 2016-12-15 04:44:03.398 screenresolution[1622:7296] Display 0: 1600x1200x32@60 04:44:03 INFO - 2016-12-15 04:44:03.404 screenresolution[1623:7298] starting screenresolution argv=screenresolution list 04:44:03 INFO - Available Modes on Display 0 04:44:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:03 INFO - Intel Iris: 04:44:03 INFO - Chipset Model: Intel Iris 04:44:03 INFO - Type: GPU 04:44:03 INFO - Bus: Built-In 04:44:03 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:03 INFO - Vendor: Intel (0x8086) 04:44:03 INFO - Device ID: 0x0a2e 04:44:03 INFO - Revision ID: 0x0009 04:44:03 INFO - Displays: 04:44:03 INFO - Display: 04:44:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:03 INFO - Display Serial Number: 1600x1200 60 04:44:03 INFO - Main Display: Yes 04:44:03 INFO - Mirror: Off 04:44:03 INFO - Online: Yes 04:44:03 INFO - Rotation: Supported 04:44:03 INFO - Return code: 0 04:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:03 INFO - Python 2.7.3 04:44:03 INFO - Return code: 0 04:44:03 INFO - grabbing minidump binary from tooltool 04:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:03 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 0x10394dd30>, '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 0x1037b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103945b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:44:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:44:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:44:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:03 INFO - Return code: 0 04:44:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:44:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:44:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0325 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:44:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xoQ4u4QDVV/Render', 04:44:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:03 INFO - 'HOME': '/Users/cltbld', 04:44:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:03 INFO - 'LOGNAME': 'cltbld', 04:44:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:03 INFO - 'MOZ_NO_REMOTE': '1', 04:44:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:03 INFO - 'NO_EM_RESTART': '1', 04:44:03 INFO - 'PAGER': '/bin/cat', 04:44:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:03 INFO - 'PWD': '/builds/slave/test', 04:44:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:03 INFO - 'SHELL': '/bin/bash', 04:44:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fhpt0tA7Bi/Listeners', 04:44:03 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 04:44:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:03 INFO - 'USER': 'cltbld', 04:44:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:03 INFO - 'XPC_FLAGS': '0x0', 04:44:03 INFO - 'XPC_SERVICE_NAME': '0', 04:44:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:44:03 INFO - mozversion application_buildid: 20161215030215 04:44:03 INFO - mozversion application_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 04:44:03 INFO - mozversion application_display_name: Nightly 04:44:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:03 INFO - mozversion application_name: Firefox 04:44:03 INFO - mozversion application_remotingname: firefox 04:44:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:44:03 INFO - mozversion application_vendor: Mozilla 04:44:03 INFO - mozversion application_version: 53.0a1 04:44:03 INFO - mozversion platform_buildid: 20161215030215 04:44:03 INFO - mozversion platform_changeset: 7652a58efa46f1c57c94bba26efc5d53b6184e83 04:44:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:44:03 INFO - mozversion platform_version: 53.0a1 04:44:03 INFO - using testdate: 1481805843 04:44:03 INFO - actual date: 1481805843 04:44:03 INFO - starting webserver on 'localhost:49241' 04:44:03 INFO - SUITE-START | Running 2 tests 04:44:03 INFO - TEST-START | dromaeo_css 04:44:03 INFO - operating with platform_type : mac_ 04:44:03 INFO - Initialising browser for dromaeo_css test... 04:44:04 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpoN31zg/profile http://localhost:49241/getInfo.html) 04:44:06 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 04:44:06 INFO - PROCESS | 1633 | colorDepth:24 04:44:06 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 04:44:06 INFO - PROCESS | 1633 | __metrics 04:44:06 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:44:06 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:44:07 INFO - TEST-INFO | 1633: exit 0 04:44:07 INFO - Browser initialized. 04:44:07 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:07 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpoN31zg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:19 INFO - PROCESS | 1636 | RSS: Main: 255967232 04:44:19 INFO - PROCESS | 1636 | 04:45:11 INFO - PROCESS | 1636 | 1481805911215 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:47:23 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:47:26 INFO - PROCESS | 1636 | RSS: Main: 421613568 04:47:26 INFO - PROCESS | 1636 | 04:50:29 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:50:29 INFO - PROCESS | 1636 | RSS: Main: 388771840 04:50:29 INFO - PROCESS | 1636 | 04:53:32 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:53:32 INFO - PROCESS | 1636 | RSS: Main: 373772288 04:53:32 INFO - PROCESS | 1636 | 04:56:35 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:56:36 INFO - PROCESS | 1636 | RSS: Main: 382427136 04:56:36 INFO - PROCESS | 1636 | 04:59:39 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:59:40 INFO - PROCESS | 1636 | RSS: Main: 341479424 04:59:40 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:02:43 INFO - PROCESS | 1636 | RSS: Main: 398995456 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | __start_tp_report 05:02:43 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 05:02:43 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 05:02:43 INFO - PROCESS | 1636 | |i|pagename|runs| 05:02:43 INFO - PROCESS | 1636 | |0;dojo.html;3061.785675002751;3315.1214928044074;3319.137024373663;3320.9538995216503;3366.6633336666323;5444.455554444558;5584.664920104797;5646.887062258752;5685.630434021786;5708.628939118955;5606.775728970836;5623.156526521014;5652.491275785179;5656.179853921179;5670.914936275959;4238.427812245353;5124.103281925657;5160;5187.714675692835;5241.449647786984;5158.535731784139;5228.294180285651;5235.738213089349;5235.764390602432;5240.633155679104;5154.74226288686;5184.248283998818;5188.247704082905;5212.791488340481;5242.18746094356;5210.739463026853;5243.082460569423;5243.318368612094;5246.291750613656;5246.449122842123;5028.879400021783;5057.924131138036;5098.980203959186;5175.974120129413;5185.766640501187;4424.469063712343;5551.333839939192;5614;5647;5688.146777983295;6179.4129557692395;6200.255969283715;6200.751969921198;6210.130581718563;6231.283402408736;6141.170941922828;6204.038374052029;6220.68896555175;6282.591631543981;6300.716467758916;5697.259356283698;5709.229254050733;5721.370649228582;5728.226689396962;5787.536997040227;6295.716692748837;6297.874042519124;6306.842328941813;6316.968415157987;6328.6519241442165;5915.1718759373725;6072.967595508774;6086.326984047714;6107.8034768261505;6111.956402836248;6134.4172303631085;6144.72645121308;6151.738893526816;6173.722182501798;6260.5617606768;6175.783847565313;6179.412955769195;6190.3190649028575;6192.442680158807;6200.193974783249;6183.041628547582;6192.938070619326;6193.1329613854095;6208.4722798561725;6217.564770466024;4775.403074615673;4843.685160464559;4875.19559272716;4875.975620121877;4878.780454879539;4301.548337424588;4361.542038086019;4381.452318460192;4385.144896745104;4399.186150562092;5594.748236329375;5619.325680918234;5636.436356364413;5655.406182350876;5656.971715141398;6094.634321940698;6107.389261073857;6124.747127467769;6148.569600128038;6161.168242287324;5632.971835140798;5673.659580425187;5709.7716091356715;5711.514521265656;5748.5688573357165;5326.9467305327225;5340.813071542478;5347.171188465794;5355.625106242525;5356.8660783479945;6223.657698826608;6301.149344838388;6325.082862984934;6327.462165715873;6336.6831658416895;6104.4200800923845;6169.629822210682;6171.691415429301;6184.567080304336;6185.752569897154;6263.96868015657;6269.247690277196;6294.464970477377;6296.716647750954;6306.65313407767;6087.726052327745;6151.569390142647;6163.599366041193;6172.629642221481;6185.474234690102;6115.388461154027;6119.197913140417;6139.461473530676;6239.282482514569;6273.592216505913;6029.125776762433;6033.818985430444;6051.0923361496125;6058.666773327509;6116.214037636738;5701.629394089537;6058.485028772604;6065.302490213682;6078.57449978515;6092.817215483543;5775.48020678141;5817.505512031525;5855.3266374365785;5931.9406805931385;5948.791792287249;5951.821445356473;6028.0355143176885;6029.246344206974;6049.334573197033;6052.485538729257;5755.1367294906095;5887.970560147171;5901.940980590139;5925.733341999707;5945 05:02:43 INFO - PROCESS | 1636 | |1;ext.html;465.825315506685;471.9334304471894;493.07302271729145;503.16976987969866;508.3772378835924;29492;31532.36935261296;38463;40271.798641006826;40570.30589952662;41441.58558414415;41912.58087419125;41958.58041419592;42050.369244461355;42067.94830129248;9235.538223088852;9454.101860323259;9457.432554046745;9473.38423002506;9477.81044379112;8424.241818236358;8683.392162548624;11029.61396351128;11340.716482087932;11349.943250283737;11280.323180609148;11329.886701132966;11336.603218887341;11381.601643942464;11390.487428065757;8467.195616416431;11270.549178032868;11337.886621133766;11344.886551134465;11355.772884542346;8407.8318433631;10942.617008404668;11221.326720396803;11274.774504509864;11419.657410277621;39081.609183908084;39393.80303098495;39474;39476.60523394758;39592.20815583672;3299.670032996681;3405.7105146062368;3455.378031954247;3524.4713293006;3748.887533374003;30071.69928300733;30329.696703032907;30331.696683033108;31491;31552.895648652186;3181.5068664357063;3201.823899685516;3202.743780497578;3205.5191721241767;3327.9833600832085;465212;479561;480086;480617.5969120167;481431;64063.679681601294;65000.899874017676;65002.524709658996;65183.67408163023;65245.347546523924;67511.32488675149;69115;69261;69298.65350673214;69419;15855;16341.18294085291;16360.263788129563;16368;16370.427035053715;11246.156538259664;11557.942210289062;12397.442115104843;12520.686982825502;12522.248665080124;17718.645627087386;17819.287228510715;17823.73264401035;17840.28638854431;19644.803551964582;8321.292690121407;8411.747647570583;8467.915320846712;8497.40518163735;8498.447600906045;808.9999999999882;814.6334149632689;925.3106435705308;937.0816599732301;952.5951470625096;25107.748922510906;27242.5913611296;27897.60511974393;28404.289892752848;28677.28306792305;1080.5245691895698;1092.2463500184847;1105.5135740274413;1112.404863398078;1125.9324440533594;15053.838380318439;15059.397624095132;15091.396344146111;15193.392264309525;15485.535433937;586929;590475;591823;592320;592634;58026;58656.70671646614;58788.412115879146;58818.70590647105;58922.41077589255;1347.8517363090052;1375.3742047368423;1398.4685819388567;1399.874011338964;1404.1715387920972;22568;28933.710662893944;29084.854575726986;29100;30664.84667576648;49602.503974959785;50145.74927125341;50153.24770128524;50300.24549631832;50317.49682503128;462525;464090;467505;468212;468759;39863.60136398599;40481;40802.591974081064;41458.79270603628;41533.37699934564;40454.39318410285;40831.38752918768;41515.7924210377;44981.32528012017;45751.08497830091;34713.65286347104;34750.47874281837;35075.82462087776;35264.29471410609;35732.64267357397;34336.48495272623;34476.79331223395;34611;35198.472022919166;35405;33982.66017339795;34496.827515862264;34928.82535587306;35112.122196944256;35185;27811.860940695165;30582.694173057986;31174.376512470077;31281.274525977024;31374;23350;23606.881965590062;23782.88108559446;23981.280561583182;23987.28038158858 05:02:43 INFO - PROCESS | 1636 | |2;jquery.html;351.1467134862285;353.66755250064955;368.8708951866847;379.84438312576134;399.38694104549523;14395.496157634485;14891.702165956687;15328.846711532882;19047.714284285747;19678.11448484818;18153.546161345974;18484.44546663602;18681.692281540298;18738.625227495442;19392.321268755597;6299.118123462719;6606.570572912769;6608.669566521655;6680.164979377578;6693.966530167342;4937.382827146606;6525.314841941599;6538.7384504619995;6538.803835884931;6548.672566371686;6223.626582405071;6432.228132624092;6530.6408147551865;6537.084808126866;6547.377999090078;6438.259600145996;6486.221653401575;6493.448056915168;6501.772437964649;6523.967380163116;5945.346011938684;6338.746450141989;6626;6981.4291784348625;7125.39434148098;26956;27189.048383306686;27285;27732.861335693393;27897.58153627697;2544.631028500857;2633.4864701383044;2702.2433718558837;2973.271548470617;3022.304869879918;15099.698006039818;15487.767683484757;15765.684686306324;16969.23638436273;17131.828681713272;1578.2242744979374;1774.6450709857952;1916.5400303926958;1972.921083156672;2000.8999550022586;97482.025179748;102177.38024408654;104031;134072;135663;19186.80813191878;19745.308914187935;19858.00709964496;20604.587908241752;20714.171433142506;33618.495722564185;33670.326593467995;33773.49339759906;33822.49266261008;33887.83056084753;9044.869391326085;9325.580348884316;10129.189664826943;10240.539175737109;10589.470526473646;8555.529445880411;8564.229219370287;8589.355798315151;8726.607302671395;8726.956365218133;9053.366264361432;9093.545322733837;9219.95390023059;9221.354505184572;9230.16928476427;2943.3524624582556;3113.844307784647;3554.453812591531;3660.926781464356;3680.068707931385;361.5480649188514;395.39701954519586;823.1480417767582;912.8585069314267;1007.8135544924066;10936;11391.772164556662;11596.260560915931;11946.581869634694;11962.581309654295;402.44261697549103;440.2669555190636;440.3241025026569;454.72410585021754;456.47049422669545;5748.281464816898;5894.850504151649;6041.848953776191;6121.969390153021;6150.231221097363;501572;507960.46019770403;508089.45955270727;520217;552549;109047.45476272568;120977;122205;127975;128045;436.4348169120996;452.5519735461869;454.2527542193074;455.18294661083434;459.3844248706682;10652.946735266583;10820.080293175168;16353.836461635232;18091.457256282334;19141.808581914003;41236.196027656304;54995.72502137464;55070.44929550814;55803;58302.12546811886;60065;68891.65554172196;75729.62135189289;77445.83831242648;78557.60721196586;5385.703786291791;7586.734464293723;7763.844723105393;7882.054153501616;7983.560904150328;7146.9285307146265;8829.911700882909;9508.33441659105;12489.93755031219;12569.245845249314;10131.392116473035;10552.366857988545;10782.24524283324;10801.945990269998;11007.944960275147;10301.330413523097;10546.789064218827;10549.103326217357;10910.127189824636;11086.501107450345;10575.894241057491;10646;10955.233133680566;11206.551737930391;11321.264117832314;6475.838104047437;7012.193597736122;7779.338756205786;7824.64789084504;8139.75580732579;9321.533923303672;10369.74075648115;10773.407462589634;10860;11000.834987475355 05:02:43 INFO - PROCESS | 1636 | |3;mootools.html;1462.3931068606528;1498.8576085271902;1697.1853510315048;1839.2275244397351;1881.5766452548178;7853.80365490863;8261.91738082619;8274.586270686472;8282.62728177232;8289.626966786494;7289.161746399166;7482.40140788737;7485.0269464969615;7822.765317040484;8057;1880.2948894164688;2247.797698207161;2292.7248730152323;2300.9884950575224;2304.677345171677;2275.6927814745045;2300.7584203658625;2318.5247024359965;2323.4307594639336;2328.604137296664;2265.422317309084;2271.3980795089233;2289.828262880282;2300.6779050932882;2308;2227.5433536125056;2247.404437823978;2262.838988765725;2270.693456383384;2295.7015587973624;1940.7962163972861;2203.468589330416;2219.5006123622215;2241.2491815241915;2246.4159318577126;8017.278444939983;8087.676492940275;8128.715494957648;8131.878021829677;8157.796055098611;4819.373481447389;5003.374578177728;5005.89988200234;5014.473480284554;5017.448080711119;3283.9343213135844;3453.0504111369323;3513.1568423578415;3515.8945231643092;3517.718582513393;1002.4837208837455;1027.4297764740566;1069.844872493492;1076.4079756134174;1078.2129045796612;9631.903680963242;9892.862320833125;10169.440680762555;10493.265471417004;10647.84028239577;4176.77027763476;4187.874363769091;4365.934510982274;4392.494863090722;4397.054633253866;8323.625436855356;8360.28937540316;8385.161483851689;8388.11924747905;8389.412741108064;4966.701997880066;4968.006398720198;4972.129877271463;4976.5023497649945;4980.377452818398;4068.613481719232;4149.460570125924;4672.392588963413;4678.929816052762;4682.391289132391;3496.8601255949984;3545.5213546170935;3610.5667319921777;3625.927481450356;3644.5079914211774;1093.8787742563936;1104.1111904916459;1122.270524159303;1129.9265547739371;1131.2759833706434;650.6258901131868;752.5860776572863;760.9162992070868;873.4759144513241;910.267234875918;4986.401631804207;5176.938727560841;5300.946990530122;5588.189712491666;5621.662700237999;858.5578427110044;868.3877866104381;868.5917618719318;899.6941040046415;904.9411788233743;3485.8431370588382;3551.2897420515483;3652.5069115669576;3701.352263353956;3730.2324652101574;8088.272055515032;9082.273418126666;9540.61837526505;9691.612335506501;9705.611775529042;9453.76365590852;9665.516724163763;9687.079727425884;9691;9700.27247956406;7372.59450730215;7639.503432276884;7657.463977521631;7671.5397076174495;7671.619108560512;5230.97384513075;5271.947280527145;5275.657082289639;5347.411784703757;5549.334079910436;8790.648374064966;8987.281017518451;9015.098490150933;9164.770880727769;9168.770780730536;9126.954365228132;9147.496887671243;9275.118863708207;9281.953590232006;9366.110219529133;6168.0439531872635;6355.586886852339;6425.1968503937005;6660.2673705893285;6676.732930682719;7297.452691048299;7326.047613810384;7421.888671669822;7444;7738.380929525511;6844.623545705034;6935.653217339213;6940.41006514452;6971.755988540377;7115.786526404217;6787.626680532618;6795.7961261162245;6817.761378351734;6860.382565569123;6888.207856096413;6257.8748425030335;6272.529560283088;6278.246610406781;6340.175777148941;6354.4281014708895;4181.832726690898;4235.877492464438;4598.655100867515;4655.487896331469;4839.879003024953;3772.2832661794173;4449.199144154083;4620.330052142353;4738.691985020962;4831 05:02:43 INFO - PROCESS | 1636 | |4;prototype.html;343.277401070746;348.6757315696401;354.4492843808338;365.3332667881114;367.24531088612906;4149.771762553059;4801.822414499382;5233.717739153908;5240.37115546135;5272.73636318184;3911.4915061042025;4542.591166794988;4950.351561914367;5051;5102.591792656588;4012.678985681153;4031.7984100794843;4079.7552146871135;4089.3865920111925;4089.7750623715683;3312.2713003139393;4023.919521609566;4028.5367182773916;4045.038156494098;4057.6753859691303;3508.5263489428985;3662.9450558241647;3932.134930315326;4043.8786836394806;4052.4529188559463;3439.4840773883866;3600.8739694110714;3918.8236529355963;3929.1945151243926;3933.5083114610675;3404.225556171737;3404.3361544498835;3412.8328511395193;3414.7633300188418;3426.811525366104;4659.673822832403;5094.974525127388;5103.8356219144;5103.872403189913;5111.309973153614;4334.219840428722;4385.51759306476;4445.644348452116;4447.5552444755585;4452.971979054242;5424.945750542523;5425.430329815392;5431.402545719968;5437.193964225019;5440.483154100354;3437.8745505393626;3713.20166164276;3713.9071523212137;3729.384651532494;3731.7574357666663;5517.503424691797;5703.372629010805;5741.253637027202;5800.200868431184;5804.796832110856;2922.459345021178;3214.726748226427;3775.320442320354;3782.3380908340932;3782.432635104701;3266.1508007917637;3436.914077148091;3553.36039512885;3678.576963649161;3847.961050516345;4234.70357075008;4428.402165707588;4486.407325399501;4492.348609451611;4510.752258373966;5169.844904652867;5237.423883372826;5487.64330318528;5495.104189054769;5516.448355164452;1243.3783108445778;1255.215490318551;1256.9504463772853;1257.6352857671172;1261.9684507887375;796.6934227866304;816.9673213071411;823.4565186976566;831.2020460358003;852.8251708399763;4577.610903073276;4606.825259558858;4904.828331008398;4928.433230178575;4946.975265123651;4601.953980460219;4863.805447782049;5385.922815436928;5430.348358197041;5431.37539182999;4416.80124394403;4551.337467581436;4669.486356500782;4691.34075421172;4934.199017358638;2813.706828934453;2821.7460428561117;2833.773298136144;2837.5743638454396;2846.914592562185;4770.662375436012;4917.852464426073;5462.73296581914;5491.945080549143;5547.694876781816;4856.417229932431;4956.306117143603;5207;5256.342957130359;5487.176923461513;5528.834134975958;5540.501354878081;5546;5559.053072318699;5595.328560572757;4685.8594242172785;4773;4826.8069277228515;5358.383785864519;5370.428664937773;4963;5196.9346284012445;5222.791088356423;5322.840314790563;5624.89066600025;4953.975230123826;5502.5597952164535;5903.557233207613;5910.822675319747;5934.851628709144;3699.426588878728;3799.335116354682;3847.6537111660086;3849.9230015400094;3851.1334949636107;5100.18943275132;5378.650387724785;5717.283765552258;5763.884722305446;5825.2135961644635;5513.4713783177995;5540.501354878081;5541;5558.8036878795665;5568.638038527482;4205.600467955539;4561.384213131185;4943.085529177114;5435.526835290013;5444.067356088532;4597.827553973715;4875.393297707665;4990.176620857518;5151.655996521498;5345.732713364394;4500.662450316305;4603.953960460486;5379.81644038311;5426.372088373551;5524.530414914617;5411.269478620493;5445.646033007842;5456.836294911159;5468.468828727962;5470.72646367672 05:02:43 INFO - PROCESS | 1636 | |5;yui.html;720.2653293640487;732.3262598409466;748.7678819565934;785.7839094249084;814.771863878114;14084.507042253523;14616.853831461682;14630.829533637323;14632.414703411863;14635.853641463582;12369.381530923463;12467.750644987094;12477.812832807514;12488.000959923207;12496.18774779641;678.4945215814225;679.123930130134;701.2811867835459;701.6596950479013;842.6376658037042;845.0324378586515;860.389123722158;862.5730263519566;863.3697400897348;867.2584939876409;928.8978212396664;931.683227702581;934.4953724988499;934.8457504511747;936.0031566381815;925.4447331601053;925.7639301977986;926.36081104038;926.8424367857447;926.8934072581671;456.37476656979817;523.1603276740814;643.584887747405;663.9070530125787;687.2714922182503;13656.726865462635;13715.245661488614;13762;13766.93116534411;13780.862191378059;9656.37233579815;11147.331160130418;12500;12524.436400362005;12534.435950382254;11498.597549085825;11984.17969330807;12122.454489547992;12223.14437989341;12314.322712250823;4325.243082460588;4332.458442694663;4332.91334173318;4520.570545798144;4534.047849951514;79902;100485.49271760929;102369;103140;106066.46966765194;10066.345687530287;10106.494675266207;10126.240531960133;10134.391936483835;10481.842772358421;20593.691094633592;20783.792162078185;20862.06120724571;20891.58216835655;21078.57842843165;7210.351068403764;7249.420046396381;7277.272272772786;7300.160481544584;7369.263073692588;4139.110091330378;4193.685473589493;4197.643200327945;4209.978950105291;4226.598473145046;3292.7201187899295;3346.0798280473064;3357.9496307555405;3394.6605339465855;3411.9488207676904;523.70410717945;524.8451706746519;530.6179550723473;643.4016364780705;682.3449488491005;557.5706705836565;577.9739911703983;625.0343219725535;637.1971316141602;655.3675702946584;8528.147185281547;8909.73618246348;9162.725118246462;9417.434953902788;9461.668841590512;575.2406822993609;634.6160572853449;647.5628950458422;674.2381109346408;678.8302924268933;4280.935785963213;4554.749488778083;4572.08558288337;4583.129205450954;4639.141758774637;97133;106111;106168;106252.93747062585;107000;83123.99999999879;84868.57565712131;88395;89869.55065224633;90071.09928900628;78224;78933;79424;82786.17213827785;85750.71373929396;8504.957475212585;8849.646014159362;8856.380053396459;9016.413933094327;9129.277319654546;51543.48456515537;51742;51928.48071519237;53804.730976344865;54578.181327280916;70424.64787676028;74452;76675.23324766681;77296;77397;9684.70945871625;10886.836697449386;10961.835572466578;11007.449627518752;11123.666290011313;12524.436400361823;12696.492140314283;12744.299063551594;12748.235105893677;13325.067245292736;11123.83314250303;12038.050508468054;12053.096017798525;12054;12334.444949977093;11996.520139194334;12068.396580171131;12070.215435996632;12101.757964840477;12284.938575307066;11898.821517677416;11949.940250298692;12024.579139730067;12104.031677465957;12105.092118091003;9833.4099954003;10065.647702330383;10068.496575171066;10575.947120264656;10579.206559507913;10135.391876487434;10424.843627345748;10438.478076096317;10478.790424191626;10494.895051049392 05:02:43 INFO - PROCESS | 1636 | __end_tp_report 05:02:43 INFO - PROCESS | 1636 | __start_cc_report 05:02:43 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1928 05:02:43 INFO - PROCESS | 1636 | __end_cc_report 05:02:43 INFO - PROCESS | 1636 | __startTimestamp1481806963599__endTimestamp 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | ------- Summary: start ------- 05:02:43 INFO - PROCESS | 1636 | Number of tests: 6 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5687.54 Median:5915.17 stddev:660.01 (11.2%) stddev-sans-first:629.07 05:02:43 INFO - PROCESS | 1636 | Values: 3061.8 3315.1 3319.1 3321.0 3366.7 5444.5 5584.7 5646.9 5685.6 5708.6 5606.8 5623.2 5652.5 5656.2 5670.9 4238.4 5124.1 5160.0 5187.7 5241.4 5158.5 5228.3 5235.7 5235.8 5240.6 5154.7 5184.2 5188.2 5212.8 5242.2 5210.7 5243.1 5243.3 5246.3 5246.4 5028.9 5057.9 5099.0 5176.0 5185.8 4424.5 5551.3 5614.0 5647.0 5688.1 6179.4 6200.3 6200.8 6210.1 6231.3 6141.2 6204.0 6220.7 6282.6 6300.7 5697.3 5709.2 5721.4 5728.2 5787.5 6295.7 6297.9 6306.8 6317.0 6328.7 5915.2 6073.0 6086.3 6107.8 6112.0 6134.4 6144.7 6151.7 6173.7 6260.6 6175.8 6179.4 6190.3 6192.4 6200.2 6183.0 6192.9 6193.1 6208.5 6217.6 4775.4 4843.7 4875.2 4876.0 4878.8 4301.5 4361.5 4381.5 4385.1 4399.2 5594.7 5619.3 5636.4 5655.4 5657.0 6094.6 6107.4 6124.7 6148.6 6161.2 5633.0 5673.7 5709.8 5711.5 5748.6 5326.9 5340.8 5347.2 5355.6 5356.9 6223.7 6301.1 6325.1 6327.5 6336.7 6104.4 6169.6 6171.7 6184.6 6185.8 6264.0 6269.2 6294.5 6296.7 6306.7 6087.7 6151.6 6163.6 6172.6 6185.5 6115.4 6119.2 6139.5 6239.3 6273.6 6029.1 6033.8 6051.1 6058.7 6116.2 5701.6 6058.5 6065.3 6078.6 6092.8 5775.5 5817.5 5855.3 5931.9 5948.8 5951.8 6028.0 6029.2 6049.3 6052.5 5755.1 5888.0 5901.9 5925.7 5945.0 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:65445.31 Median:35148.56 stddev:137058.02 (389.9%) stddev-sans-first:137355.67 05:02:43 INFO - PROCESS | 1636 | Values: 465.8 471.9 493.1 503.2 508.4 29492.0 31532.4 38463.0 40271.8 40570.3 41441.6 41912.6 41958.6 42050.4 42067.9 9235.5 9454.1 9457.4 9473.4 9477.8 8424.2 8683.4 11029.6 11340.7 11349.9 11280.3 11329.9 11336.6 11381.6 11390.5 8467.2 11270.5 11337.9 11344.9 11355.8 8407.8 10942.6 11221.3 11274.8 11419.7 39081.6 39393.8 39474.0 39476.6 39592.2 3299.7 3405.7 3455.4 3524.5 3748.9 30071.7 30329.7 30331.7 31491.0 31552.9 3181.5 3201.8 3202.7 3205.5 3328.0 465212.0 479561.0 480086.0 480617.6 481431.0 64063.7 65000.9 65002.5 65183.7 65245.3 67511.3 69115.0 69261.0 69298.7 69419.0 15855.0 16341.2 16360.3 16368.0 16370.4 11246.2 11557.9 12397.4 12520.7 12522.2 17718.6 17819.3 17823.7 17840.3 19644.8 8321.3 8411.7 8467.9 8497.4 8498.4 809.0 814.6 925.3 937.1 952.6 25107.7 27242.6 27897.6 28404.3 28677.3 1080.5 1092.2 1105.5 1112.4 1125.9 15053.8 15059.4 15091.4 15193.4 15485.5 586929.0 590475.0 591823.0 592320.0 592634.0 58026.0 58656.7 58788.4 58818.7 58922.4 1347.9 1375.4 1398.5 1399.9 1404.2 22568.0 28933.7 29084.9 29100.0 30664.8 49602.5 50145.7 50153.2 50300.2 50317.5 462525.0 464090.0 467505.0 468212.0 468759.0 39863.6 40481.0 40802.6 41458.8 41533.4 40454.4 40831.4 41515.8 44981.3 45751.1 34713.7 34750.5 35075.8 35264.3 35732.6 34336.5 34476.8 34611.0 35198.5 35405.0 33982.7 34496.8 34928.8 35112.1 35185.0 27811.9 30582.7 31174.4 31281.3 31374.0 23350.0 23606.9 23782.9 23981.3 23987.3 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:32845.41 Median:2014.90 stddev:87010.96 (4318.4%) stddev-sans-first:87220.85 05:02:43 INFO - PROCESS | 1636 | Values: 351.1 353.7 368.9 379.8 399.4 14395.5 14891.7 15328.8 19047.7 19678.1 18153.5 18484.4 18681.7 18738.6 19392.3 6299.1 6606.6 6608.7 6680.2 6694.0 4937.4 6525.3 6538.7 6538.8 6548.7 6223.6 6432.2 6530.6 6537.1 6547.4 6438.3 6486.2 6493.4 6501.8 6524.0 5945.3 6338.7 6626.0 6981.4 7125.4 26956.0 27189.0 27285.0 27732.9 27897.6 2544.6 2633.5 2702.2 2973.3 3022.3 15099.7 15487.8 15765.7 16969.2 17131.8 1578.2 1774.6 1916.5 1972.9 2000.9 97482.0 102177.4 104031.0 134072.0 135663.0 19186.8 19745.3 19858.0 20604.6 20714.2 33618.5 33670.3 33773.5 33822.5 33887.8 9044.9 9325.6 10129.2 10240.5 10589.5 8555.5 8564.2 8589.4 8726.6 8727.0 9053.4 9093.5 9220.0 9221.4 9230.2 2943.4 3113.8 3554.5 3660.9 3680.1 361.5 395.4 823.1 912.9 1007.8 10936.0 11391.8 11596.3 11946.6 11962.6 402.4 440.3 440.3 454.7 456.5 5748.3 5894.9 6041.8 6122.0 6150.2 501572.0 507960.5 508089.5 520217.0 552549.0 109047.5 120977.0 122205.0 127975.0 128045.0 436.4 452.6 454.3 455.2 459.4 10652.9 10820.1 16353.8 18091.5 19141.8 41236.2 54995.7 55070.4 55803.0 58302.1 60065.0 68891.7 75729.6 77445.8 78557.6 5385.7 7586.7 7763.8 7882.1 7983.6 7146.9 8829.9 9508.3 12489.9 12569.2 10131.4 10552.4 10782.2 10801.9 11007.9 10301.3 10546.8 10549.1 10910.1 11086.5 10575.9 10646.0 10955.2 11206.6 11321.3 6475.8 7012.2 7779.3 7824.6 8139.8 9321.5 10369.7 10773.4 10860.0 11000.8 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5193.04 Median:5251.46 stddev:2817.06 (53.6%) stddev-sans-first:2811.01 05:02:43 INFO - PROCESS | 1636 | Values: 1462.4 1498.9 1697.2 1839.2 1881.6 7853.8 8261.9 8274.6 8282.6 8289.6 7289.2 7482.4 7485.0 7822.8 8057.0 1880.3 2247.8 2292.7 2301.0 2304.7 2275.7 2300.8 2318.5 2323.4 2328.6 2265.4 2271.4 2289.8 2300.7 2308.0 2227.5 2247.4 2262.8 2270.7 2295.7 1940.8 2203.5 2219.5 2241.2 2246.4 8017.3 8087.7 8128.7 8131.9 8157.8 4819.4 5003.4 5005.9 5014.5 5017.4 3283.9 3453.1 3513.2 3515.9 3517.7 1002.5 1027.4 1069.8 1076.4 1078.2 9631.9 9892.9 10169.4 10493.3 10647.8 4176.8 4187.9 4365.9 4392.5 4397.1 8323.6 8360.3 8385.2 8388.1 8389.4 4966.7 4968.0 4972.1 4976.5 4980.4 4068.6 4149.5 4672.4 4678.9 4682.4 3496.9 3545.5 3610.6 3625.9 3644.5 1093.9 1104.1 1122.3 1129.9 1131.3 650.6 752.6 760.9 873.5 910.3 4986.4 5176.9 5300.9 5588.2 5621.7 858.6 868.4 868.6 899.7 904.9 3485.8 3551.3 3652.5 3701.4 3730.2 8088.3 9082.3 9540.6 9691.6 9705.6 9453.8 9665.5 9687.1 9691.0 9700.3 7372.6 7639.5 7657.5 7671.5 7671.6 5231.0 5271.9 5275.7 5347.4 5549.3 8790.6 8987.3 9015.1 9164.8 9168.8 9127.0 9147.5 9275.1 9282.0 9366.1 6168.0 6355.6 6425.2 6660.3 6676.7 7297.5 7326.0 7421.9 7444.0 7738.4 6844.6 6935.7 6940.4 6971.8 7115.8 6787.6 6795.8 6817.8 6860.4 6888.2 6257.9 6272.5 6278.2 6340.2 6354.4 4181.8 4235.9 4598.7 4655.5 4839.9 3772.3 4449.2 4620.3 4738.7 4831.0 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4355.35 Median:4841.61 stddev:1329.72 (27.5%) stddev-sans-first:1298.91 05:02:43 INFO - PROCESS | 1636 | Values: 343.3 348.7 354.4 365.3 367.2 4149.8 4801.8 5233.7 5240.4 5272.7 3911.5 4542.6 4950.4 5051.0 5102.6 4012.7 4031.8 4079.8 4089.4 4089.8 3312.3 4023.9 4028.5 4045.0 4057.7 3508.5 3662.9 3932.1 4043.9 4052.5 3439.5 3600.9 3918.8 3929.2 3933.5 3404.2 3404.3 3412.8 3414.8 3426.8 4659.7 5095.0 5103.8 5103.9 5111.3 4334.2 4385.5 4445.6 4447.6 4453.0 5424.9 5425.4 5431.4 5437.2 5440.5 3437.9 3713.2 3713.9 3729.4 3731.8 5517.5 5703.4 5741.3 5800.2 5804.8 2922.5 3214.7 3775.3 3782.3 3782.4 3266.2 3436.9 3553.4 3678.6 3848.0 4234.7 4428.4 4486.4 4492.3 4510.8 5169.8 5237.4 5487.6 5495.1 5516.4 1243.4 1255.2 1257.0 1257.6 1262.0 796.7 817.0 823.5 831.2 852.8 4577.6 4606.8 4904.8 4928.4 4947.0 4602.0 4863.8 5385.9 5430.3 5431.4 4416.8 4551.3 4669.5 4691.3 4934.2 2813.7 2821.7 2833.8 2837.6 2846.9 4770.7 4917.9 5462.7 5491.9 5547.7 4856.4 4956.3 5207.0 5256.3 5487.2 5528.8 5540.5 5546.0 5559.1 5595.3 4685.9 4773.0 4826.8 5358.4 5370.4 4963.0 5196.9 5222.8 5322.8 5624.9 4954.0 5502.6 5903.6 5910.8 5934.9 3699.4 3799.3 3847.7 3849.9 3851.1 5100.2 5378.7 5717.3 5763.9 5825.2 5513.5 5540.5 5541.0 5558.8 5568.6 4205.6 4561.4 4943.1 5435.5 5444.1 4597.8 4875.4 4990.2 5151.7 5345.7 4500.7 4604.0 5379.8 5426.4 5524.5 5411.3 5445.6 5456.8 5468.5 5470.7 05:02:43 INFO - PROCESS | 1636 | 05:02:43 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20088.70 Median:4544.40 stddev:29624.34 (651.9%) stddev-sans-first:29671.74 05:02:43 INFO - PROCESS | 1636 | Values: 720.3 732.3 748.8 785.8 814.8 14084.5 14616.9 14630.8 14632.4 14635.9 12369.4 12467.8 12477.8 12488.0 12496.2 678.5 679.1 701.3 701.7 842.6 845.0 860.4 862.6 863.4 867.3 928.9 931.7 934.5 934.8 936.0 925.4 925.8 926.4 926.8 926.9 456.4 523.2 643.6 663.9 687.3 13656.7 13715.2 13762.0 13766.9 13780.9 9656.4 11147.3 12500.0 12524.4 12534.4 11498.6 11984.2 12122.5 12223.1 12314.3 4325.2 4332.5 4332.9 4520.6 4534.0 79902.0 100485.5 102369.0 103140.0 106066.5 10066.3 10106.5 10126.2 10134.4 10481.8 20593.7 20783.8 20862.1 20891.6 21078.6 7210.4 7249.4 7277.3 7300.2 7369.3 4139.1 4193.7 4197.6 4210.0 4226.6 3292.7 3346.1 3357.9 3394.7 3411.9 523.7 524.8 530.6 643.4 682.3 557.6 578.0 625.0 637.2 655.4 8528.1 8909.7 9162.7 9417.4 9461.7 575.2 634.6 647.6 674.2 678.8 4280.9 4554.7 4572.1 4583.1 4639.1 97133.0 106111.0 106168.0 106252.9 107000.0 83124.0 84868.6 88395.0 89869.6 90071.1 78224.0 78933.0 79424.0 82786.2 85750.7 8505.0 8849.6 8856.4 9016.4 9129.3 51543.5 51742.0 51928.5 53804.7 54578.2 70424.6 74452.0 76675.2 77296.0 77397.0 9684.7 10886.8 10961.8 11007.4 11123.7 12524.4 12696.5 12744.3 12748.2 13325.1 11123.8 12038.1 12053.1 12054.0 12334.4 11996.5 12068.4 12070.2 12101.8 12284.9 11898.8 11949.9 12024.6 12104.0 12105.1 9833.4 10065.6 10068.5 10575.9 10579.2 10135.4 10424.8 10438.5 10478.8 10494.9 05:02:43 INFO - PROCESS | 1636 | -------- Summary: end -------- 05:02:43 INFO - PROCESS | 1636 | 05:02:44 INFO - TEST-INFO | 1636: exit 0 05:02:44 INFO - TEST-OK | dromaeo_css | took 1120364ms 05:02:44 INFO - TEST-START | kraken 05:02:44 INFO - operating with platform_type : mac_ 05:02:44 INFO - Initialising browser for kraken test... 05:02:44 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpIxihlt/profile http://localhost:49241/getInfo.html) 05:02:46 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 05:02:46 INFO - PROCESS | 1646 | colorDepth:24 05:02:46 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 05:02:46 INFO - PROCESS | 1646 | __metrics 05:02:46 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:02:46 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:47 INFO - TEST-INFO | 1646: exit 0 05:02:47 INFO - Browser initialized. 05:02:47 INFO - Running cycle 1/1 for kraken test... 05:02:47 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpIxihlt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:59 INFO - PROCESS | 1648 | RSS: Main: 250642432 05:02:59 INFO - PROCESS | 1648 | 05:03:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:03 INFO - PROCESS | 1648 | RSS: Main: 306724864 05:03:03 INFO - PROCESS | 1648 | 05:03:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:03:06 INFO - PROCESS | 1648 | RSS: Main: 308768768 05:03:06 INFO - PROCESS | 1648 | 05:03:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:03:10 INFO - PROCESS | 1648 | RSS: Main: 399273984 05:03:10 INFO - PROCESS | 1648 | 05:03:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:03:13 INFO - PROCESS | 1648 | RSS: Main: 301346816 05:03:13 INFO - PROCESS | 1648 | 05:03:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:15 INFO - PROCESS | 1648 | RSS: Main: 303468544 05:03:15 INFO - PROCESS | 1648 | 05:03:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:19 INFO - PROCESS | 1648 | RSS: Main: 346705920 05:03:19 INFO - PROCESS | 1648 | 05:03:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:23 INFO - PROCESS | 1648 | RSS: Main: 346017792 05:03:23 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:03:26 INFO - PROCESS | 1648 | RSS: Main: 343859200 05:03:26 INFO - PROCESS | 1648 | 05:03:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:28 INFO - PROCESS | 1648 | RSS: Main: 319631360 05:03:28 INFO - PROCESS | 1648 | 05:03:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:31 INFO - PROCESS | 1648 | RSS: Main: 324481024 05:03:31 INFO - PROCESS | 1648 | 05:03:33 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:34 INFO - PROCESS | 1648 | RSS: Main: 324321280 05:03:34 INFO - PROCESS | 1648 | 05:03:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:38 INFO - PROCESS | 1648 | RSS: Main: 340553728 05:03:38 INFO - PROCESS | 1648 | 05:03:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:41 INFO - PROCESS | 1648 | RSS: Main: 335085568 05:03:41 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:03:43 INFO - PROCESS | 1648 | RSS: Main: 378830848 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | __start_tp_report 05:03:43 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 05:03:43 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 05:03:43 INFO - PROCESS | 1648 | |i|pagename|runs| 05:03:43 INFO - PROCESS | 1648 | |0;ai-astar;102;113;113;114;114;115;113;113;112;113 05:03:43 INFO - PROCESS | 1648 | |1;audio-beat-detection;144;121;114;146;115;115;114;113;136;114 05:03:43 INFO - PROCESS | 1648 | |2;audio-dft;185;186;183;185;186;183;185;178;183;184 05:03:43 INFO - PROCESS | 1648 | |3;audio-fft;81;59;59;86;62;58;59;59;77;79 05:03:43 INFO - PROCESS | 1648 | |4;audio-oscillator;84;56;102;94;101;86;83;70;68;85 05:03:43 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;109;109;119;135;92;150;166;109;106;109 05:03:43 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;93;92;93;93;94;95;94;112;149 05:03:43 INFO - PROCESS | 1648 | |7;imaging-desaturate;88;94;135;87;85;86;87;85;86;84 05:03:43 INFO - PROCESS | 1648 | |8;json-parse-financial;56;55;54;53;55;54;55;55;55;54 05:03:43 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;64;73;71;81;75;73;69;73;71;71 05:03:43 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;89;89;89;87;89;90;90;91;97;108 05:03:43 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;145;161;161;151;145;148;149;147;190;147 05:03:43 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;178;175;179;174;177;179;184;234;175;181 05:03:43 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;60;68;74;63;57;60;80;62;59;75 05:03:43 INFO - PROCESS | 1648 | __end_tp_report 05:03:43 INFO - PROCESS | 1648 | __start_cc_report 05:03:43 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2067 05:03:43 INFO - PROCESS | 1648 | __end_cc_report 05:03:43 INFO - PROCESS | 1648 | __startTimestamp1481807023887__endTimestamp 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | ------- Summary: start ------- 05:03:43 INFO - PROCESS | 1648 | Number of tests: 14 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.68 (3.3%) stddev-sans-first:0.87 05:03:43 INFO - PROCESS | 1648 | Values: 102.0 113.0 113.0 114.0 114.0 115.0 113.0 113.0 112.0 113.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:118.00 stddev:13.39 (11.3%) stddev-sans-first:11.90 05:03:43 INFO - PROCESS | 1648 | Values: 144.0 121.0 114.0 146.0 115.0 115.0 114.0 113.0 136.0 114.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.80 Median:185.00 stddev:2.35 (1.3%) stddev-sans-first:2.45 05:03:43 INFO - PROCESS | 1648 | Values: 185.0 186.0 183.0 185.0 186.0 183.0 185.0 178.0 183.0 184.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:67.90 Median:69.50 stddev:11.33 (16.3%) stddev-sans-first:10.98 05:03:43 INFO - PROCESS | 1648 | Values: 81.0 59.0 59.0 86.0 62.0 58.0 59.0 59.0 77.0 79.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:83.50 stddev:14.69 (17.6%) stddev-sans-first:15.58 05:03:43 INFO - PROCESS | 1648 | Values: 84.0 56.0 102.0 94.0 101.0 86.0 83.0 70.0 68.0 85.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:120.40 Median:127.00 stddev:22.86 (18.0%) stddev-sans-first:23.87 05:03:43 INFO - PROCESS | 1648 | Values: 109.0 109.0 119.0 135.0 92.0 150.0 166.0 109.0 106.0 109.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:93.00 stddev:17.94 (19.3%) stddev-sans-first:18.80 05:03:43 INFO - PROCESS | 1648 | Values: 93.0 93.0 92.0 93.0 93.0 94.0 95.0 94.0 112.0 149.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:86.50 stddev:15.46 (17.9%) stddev-sans-first:16.34 05:03:43 INFO - PROCESS | 1648 | Values: 88.0 94.0 135.0 87.0 85.0 86.0 87.0 85.0 86.0 84.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.84 (1.5%) stddev-sans-first:0.73 05:03:43 INFO - PROCESS | 1648 | Values: 56.0 55.0 54.0 53.0 55.0 54.0 55.0 55.0 55.0 54.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:73.00 stddev:4.33 (5.9%) stddev-sans-first:3.46 05:03:43 INFO - PROCESS | 1648 | Values: 64.0 73.0 71.0 81.0 75.0 73.0 69.0 73.0 71.0 71.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:89.50 stddev:6.24 (7.0%) stddev-sans-first:6.53 05:03:43 INFO - PROCESS | 1648 | Values: 89.0 89.0 89.0 87.0 89.0 90.0 90.0 91.0 97.0 108.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:154.40 Median:150.00 stddev:13.83 (9.2%) stddev-sans-first:14.25 05:03:43 INFO - PROCESS | 1648 | Values: 145.0 161.0 161.0 151.0 145.0 148.0 149.0 147.0 190.0 147.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:179.00 stddev:17.96 (10.0%) stddev-sans-first:18.94 05:03:43 INFO - PROCESS | 1648 | Values: 178.0 175.0 179.0 174.0 177.0 179.0 184.0 234.0 175.0 181.0 05:03:43 INFO - PROCESS | 1648 | 05:03:43 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:7.97 (12.2%) stddev-sans-first:8.17 05:03:43 INFO - PROCESS | 1648 | Values: 60.0 68.0 74.0 63.0 57.0 60.0 80.0 62.0 59.0 75.0 05:03:43 INFO - PROCESS | 1648 | -------- Summary: end -------- 05:03:43 INFO - PROCESS | 1648 | 05:03:44 INFO - TEST-INFO | 1648: exit 0 05:03:44 INFO - TEST-OK | kraken | took 60508ms 05:03:44 INFO - SUITE-END | took 1180s 05:03:45 INFO - Completed test suite (00:19:41) 05:03:45 INFO - javascript benchmark 05:03:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.785675002751, 3315.1214928044074, 3319.137024373663, 3320.9538995216503, 3366.6633336666323, 5444.455554444558, 5584.664920104797, 5646.887062258752, 5685.630434021786, 5708.628939118955, 5606.775728970836, 5623.156526521014, 5652.491275785179, 5656.179853921179, 5670.914936275959, 4238.427812245353, 5124.103281925657, 5160.0, 5187.714675692835, 5241.449647786984, 5158.535731784139, 5228.294180285651, 5235.738213089349, 5235.764390602432, 5240.633155679104, 5154.74226288686, 5184.248283998818, 5188.247704082905, 5212.791488340481, 5242.18746094356, 5210.739463026853, 5243.082460569423, 5243.318368612094, 5246.291750613656, 5246.449122842123, 5028.879400021783, 5057.924131138036, 5098.980203959186, 5175.974120129413, 5185.766640501187, 4424.469063712343, 5551.333839939192, 5614.0, 5647.0, 5688.146777983295, 6179.4129557692395, 6200.255969283715, 6200.751969921198, 6210.130581718563, 6231.283402408736, 6141.170941922828, 6204.038374052029, 6220.68896555175, 6282.591631543981, 6300.716467758916, 5697.259356283698, 5709.229254050733, 5721.370649228582, 5728.226689396962, 5787.536997040227, 6295.716692748837, 6297.874042519124, 6306.842328941813, 6316.968415157987, 6328.6519241442165, 5915.1718759373725, 6072.967595508774, 6086.326984047714, 6107.8034768261505, 6111.956402836248, 6134.4172303631085, 6144.72645121308, 6151.738893526816, 6173.722182501798, 6260.5617606768, 6175.783847565313, 6179.412955769195, 6190.3190649028575, 6192.442680158807, 6200.193974783249, 6183.041628547582, 6192.938070619326, 6193.1329613854095, 6208.4722798561725, 6217.564770466024, 4775.403074615673, 4843.685160464559, 4875.19559272716, 4875.975620121877, 4878.780454879539, 4301.548337424588, 4361.542038086019, 4381.452318460192, 4385.144896745104, 4399.186150562092, 5594.748236329375, 5619.325680918234, 5636.436356364413, 5655.406182350876, 5656.971715141398, 6094.634321940698, 6107.389261073857, 6124.747127467769, 6148.569600128038, 6161.168242287324, 5632.971835140798, 5673.659580425187, 5709.7716091356715, 5711.514521265656, 5748.5688573357165, 5326.9467305327225, 5340.813071542478, 5347.171188465794, 5355.625106242525, 5356.8660783479945, 6223.657698826608, 6301.149344838388, 6325.082862984934, 6327.462165715873, 6336.6831658416895, 6104.4200800923845, 6169.629822210682, 6171.691415429301, 6184.567080304336, 6185.752569897154, 6263.96868015657, 6269.247690277196, 6294.464970477377, 6296.716647750954, 6306.65313407767, 6087.726052327745, 6151.569390142647, 6163.599366041193, 6172.629642221481, 6185.474234690102, 6115.388461154027, 6119.197913140417, 6139.461473530676, 6239.282482514569, 6273.592216505913, 6029.125776762433, 6033.818985430444, 6051.0923361496125, 6058.666773327509, 6116.214037636738, 5701.629394089537, 6058.485028772604, 6065.302490213682, 6078.57449978515, 6092.817215483543, 5775.48020678141, 5817.505512031525, 5855.3266374365785, 5931.9406805931385, 5948.791792287249, 5951.821445356473, 6028.0355143176885, 6029.246344206974, 6049.334573197033, 6052.485538729257, 5755.1367294906095, 5887.970560147171, 5901.940980590139, 5925.733341999707, 5945.0], "value": 5643.566495404644, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.825315506685, 471.9334304471894, 493.07302271729145, 503.16976987969866, 508.3772378835924, 29492.0, 31532.36935261296, 38463.0, 40271.798641006826, 40570.30589952662, 41441.58558414415, 41912.58087419125, 41958.58041419592, 42050.369244461355, 42067.94830129248, 9235.538223088852, 9454.101860323259, 9457.432554046745, 9473.38423002506, 9477.81044379112, 8424.241818236358, 8683.392162548624, 11029.61396351128, 11340.716482087932, 11349.943250283737, 11280.323180609148, 11329.886701132966, 11336.603218887341, 11381.601643942464, 11390.487428065757, 8467.195616416431, 11270.549178032868, 11337.886621133766, 11344.886551134465, 11355.772884542346, 8407.8318433631, 10942.617008404668, 11221.326720396803, 11274.774504509864, 11419.657410277621, 39081.609183908084, 39393.80303098495, 39474.0, 39476.60523394758, 39592.20815583672, 3299.670032996681, 3405.7105146062368, 3455.378031954247, 3524.4713293006, 3748.887533374003, 30071.69928300733, 30329.696703032907, 30331.696683033108, 31491.0, 31552.895648652186, 3181.5068664357063, 3201.823899685516, 3202.743780497578, 3205.5191721241767, 3327.9833600832085, 465212.0, 479561.0, 480086.0, 480617.5969120167, 481431.0, 64063.679681601294, 65000.899874017676, 65002.524709658996, 65183.67408163023, 65245.347546523924, 67511.32488675149, 69115.0, 69261.0, 69298.65350673214, 69419.0, 15855.0, 16341.18294085291, 16360.263788129563, 16368.0, 16370.427035053715, 11246.156538259664, 11557.942210289062, 12397.442115104843, 12520.686982825502, 12522.248665080124, 17718.645627087386, 17819.287228510715, 17823.73264401035, 17840.28638854431, 19644.803551964582, 8321.292690121407, 8411.747647570583, 8467.915320846712, 8497.40518163735, 8498.447600906045, 808.9999999999882, 814.6334149632689, 925.3106435705308, 937.0816599732301, 952.5951470625096, 25107.748922510906, 27242.5913611296, 27897.60511974393, 28404.289892752848, 28677.28306792305, 1080.5245691895698, 1092.2463500184847, 1105.5135740274413, 1112.404863398078, 1125.9324440533594, 15053.838380318439, 15059.397624095132, 15091.396344146111, 15193.392264309525, 15485.535433937, 586929.0, 590475.0, 591823.0, 592320.0, 592634.0, 58026.0, 58656.70671646614, 58788.412115879146, 58818.70590647105, 58922.41077589255, 1347.8517363090052, 1375.3742047368423, 1398.4685819388567, 1399.874011338964, 1404.1715387920972, 22568.0, 28933.710662893944, 29084.854575726986, 29100.0, 30664.84667576648, 49602.503974959785, 50145.74927125341, 50153.24770128524, 50300.24549631832, 50317.49682503128, 462525.0, 464090.0, 467505.0, 468212.0, 468759.0, 39863.60136398599, 40481.0, 40802.591974081064, 41458.79270603628, 41533.37699934564, 40454.39318410285, 40831.38752918768, 41515.7924210377, 44981.32528012017, 45751.08497830091, 34713.65286347104, 34750.47874281837, 35075.82462087776, 35264.29471410609, 35732.64267357397, 34336.48495272623, 34476.79331223395, 34611.0, 35198.472022919166, 35405.0, 33982.66017339795, 34496.827515862264, 34928.82535587306, 35112.122196944256, 35185.0, 27811.860940695165, 30582.694173057986, 31174.376512470077, 31281.274525977024, 31374.0, 23350.0, 23606.881965590062, 23782.88108559446, 23981.280561583182, 23987.28038158858], "value": 19881.02151608932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1467134862285, 353.66755250064955, 368.8708951866847, 379.84438312576134, 399.38694104549523, 14395.496157634485, 14891.702165956687, 15328.846711532882, 19047.714284285747, 19678.11448484818, 18153.546161345974, 18484.44546663602, 18681.692281540298, 18738.625227495442, 19392.321268755597, 6299.118123462719, 6606.570572912769, 6608.669566521655, 6680.164979377578, 6693.966530167342, 4937.382827146606, 6525.314841941599, 6538.7384504619995, 6538.803835884931, 6548.672566371686, 6223.626582405071, 6432.228132624092, 6530.6408147551865, 6537.084808126866, 6547.377999090078, 6438.259600145996, 6486.221653401575, 6493.448056915168, 6501.772437964649, 6523.967380163116, 5945.346011938684, 6338.746450141989, 6626.0, 6981.4291784348625, 7125.39434148098, 26956.0, 27189.048383306686, 27285.0, 27732.861335693393, 27897.58153627697, 2544.631028500857, 2633.4864701383044, 2702.2433718558837, 2973.271548470617, 3022.304869879918, 15099.698006039818, 15487.767683484757, 15765.684686306324, 16969.23638436273, 17131.828681713272, 1578.2242744979374, 1774.6450709857952, 1916.5400303926958, 1972.921083156672, 2000.8999550022586, 97482.025179748, 102177.38024408654, 104031.0, 134072.0, 135663.0, 19186.80813191878, 19745.308914187935, 19858.00709964496, 20604.587908241752, 20714.171433142506, 33618.495722564185, 33670.326593467995, 33773.49339759906, 33822.49266261008, 33887.83056084753, 9044.869391326085, 9325.580348884316, 10129.189664826943, 10240.539175737109, 10589.470526473646, 8555.529445880411, 8564.229219370287, 8589.355798315151, 8726.607302671395, 8726.956365218133, 9053.366264361432, 9093.545322733837, 9219.95390023059, 9221.354505184572, 9230.16928476427, 2943.3524624582556, 3113.844307784647, 3554.453812591531, 3660.926781464356, 3680.068707931385, 361.5480649188514, 395.39701954519586, 823.1480417767582, 912.8585069314267, 1007.8135544924066, 10936.0, 11391.772164556662, 11596.260560915931, 11946.581869634694, 11962.581309654295, 402.44261697549103, 440.2669555190636, 440.3241025026569, 454.72410585021754, 456.47049422669545, 5748.281464816898, 5894.850504151649, 6041.848953776191, 6121.969390153021, 6150.231221097363, 501572.0, 507960.46019770403, 508089.45955270727, 520217.0, 552549.0, 109047.45476272568, 120977.0, 122205.0, 127975.0, 128045.0, 436.4348169120996, 452.5519735461869, 454.2527542193074, 455.18294661083434, 459.3844248706682, 10652.946735266583, 10820.080293175168, 16353.836461635232, 18091.457256282334, 19141.808581914003, 41236.196027656304, 54995.72502137464, 55070.44929550814, 55803.0, 58302.12546811886, 60065.0, 68891.65554172196, 75729.62135189289, 77445.83831242648, 78557.60721196586, 5385.703786291791, 7586.734464293723, 7763.844723105393, 7882.054153501616, 7983.560904150328, 7146.9285307146265, 8829.911700882909, 9508.33441659105, 12489.93755031219, 12569.245845249314, 10131.392116473035, 10552.366857988545, 10782.24524283324, 10801.945990269998, 11007.944960275147, 10301.330413523097, 10546.789064218827, 10549.103326217357, 10910.127189824636, 11086.501107450345, 10575.894241057491, 10646.0, 10955.233133680566, 11206.551737930391, 11321.264117832314, 6475.838104047437, 7012.193597736122, 7779.338756205786, 7824.64789084504, 8139.75580732579, 9321.533923303672, 10369.74075648115, 10773.407462589634, 10860.0, 11000.834987475355], "value": 9491.628659802693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.3931068606528, 1498.8576085271902, 1697.1853510315048, 1839.2275244397351, 1881.5766452548178, 7853.80365490863, 8261.91738082619, 8274.586270686472, 8282.62728177232, 8289.626966786494, 7289.161746399166, 7482.40140788737, 7485.0269464969615, 7822.765317040484, 8057.0, 1880.2948894164688, 2247.797698207161, 2292.7248730152323, 2300.9884950575224, 2304.677345171677, 2275.6927814745045, 2300.7584203658625, 2318.5247024359965, 2323.4307594639336, 2328.604137296664, 2265.422317309084, 2271.3980795089233, 2289.828262880282, 2300.6779050932882, 2308.0, 2227.5433536125056, 2247.404437823978, 2262.838988765725, 2270.693456383384, 2295.7015587973624, 1940.7962163972861, 2203.468589330416, 2219.5006123622215, 2241.2491815241915, 2246.4159318577126, 8017.278444939983, 8087.676492940275, 8128.715494957648, 8131.878021829677, 8157.796055098611, 4819.373481447389, 5003.374578177728, 5005.89988200234, 5014.473480284554, 5017.448080711119, 3283.9343213135844, 3453.0504111369323, 3513.1568423578415, 3515.8945231643092, 3517.718582513393, 1002.4837208837455, 1027.4297764740566, 1069.844872493492, 1076.4079756134174, 1078.2129045796612, 9631.903680963242, 9892.862320833125, 10169.440680762555, 10493.265471417004, 10647.84028239577, 4176.77027763476, 4187.874363769091, 4365.934510982274, 4392.494863090722, 4397.054633253866, 8323.625436855356, 8360.28937540316, 8385.161483851689, 8388.11924747905, 8389.412741108064, 4966.701997880066, 4968.006398720198, 4972.129877271463, 4976.5023497649945, 4980.377452818398, 4068.613481719232, 4149.460570125924, 4672.392588963413, 4678.929816052762, 4682.391289132391, 3496.8601255949984, 3545.5213546170935, 3610.5667319921777, 3625.927481450356, 3644.5079914211774, 1093.8787742563936, 1104.1111904916459, 1122.270524159303, 1129.9265547739371, 1131.2759833706434, 650.6258901131868, 752.5860776572863, 760.9162992070868, 873.4759144513241, 910.267234875918, 4986.401631804207, 5176.938727560841, 5300.946990530122, 5588.189712491666, 5621.662700237999, 858.5578427110044, 868.3877866104381, 868.5917618719318, 899.6941040046415, 904.9411788233743, 3485.8431370588382, 3551.2897420515483, 3652.5069115669576, 3701.352263353956, 3730.2324652101574, 8088.272055515032, 9082.273418126666, 9540.61837526505, 9691.612335506501, 9705.611775529042, 9453.76365590852, 9665.516724163763, 9687.079727425884, 9691.0, 9700.27247956406, 7372.59450730215, 7639.503432276884, 7657.463977521631, 7671.5397076174495, 7671.619108560512, 5230.97384513075, 5271.947280527145, 5275.657082289639, 5347.411784703757, 5549.334079910436, 8790.648374064966, 8987.281017518451, 9015.098490150933, 9164.770880727769, 9168.770780730536, 9126.954365228132, 9147.496887671243, 9275.118863708207, 9281.953590232006, 9366.110219529133, 6168.0439531872635, 6355.586886852339, 6425.1968503937005, 6660.2673705893285, 6676.732930682719, 7297.452691048299, 7326.047613810384, 7421.888671669822, 7444.0, 7738.380929525511, 6844.623545705034, 6935.653217339213, 6940.41006514452, 6971.755988540377, 7115.786526404217, 6787.626680532618, 6795.7961261162245, 6817.761378351734, 6860.382565569123, 6888.207856096413, 6257.8748425030335, 6272.529560283088, 6278.246610406781, 6340.175777148941, 6354.4281014708895, 4181.832726690898, 4235.877492464438, 4598.655100867515, 4655.487896331469, 4839.879003024953, 3772.2832661794173, 4449.199144154083, 4620.330052142353, 4738.691985020962, 4831.0], "value": 4223.58294918519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.277401070746, 348.6757315696401, 354.4492843808338, 365.3332667881114, 367.24531088612906, 4149.771762553059, 4801.822414499382, 5233.717739153908, 5240.37115546135, 5272.73636318184, 3911.4915061042025, 4542.591166794988, 4950.351561914367, 5051.0, 5102.591792656588, 4012.678985681153, 4031.7984100794843, 4079.7552146871135, 4089.3865920111925, 4089.7750623715683, 3312.2713003139393, 4023.919521609566, 4028.5367182773916, 4045.038156494098, 4057.6753859691303, 3508.5263489428985, 3662.9450558241647, 3932.134930315326, 4043.8786836394806, 4052.4529188559463, 3439.4840773883866, 3600.8739694110714, 3918.8236529355963, 3929.1945151243926, 3933.5083114610675, 3404.225556171737, 3404.3361544498835, 3412.8328511395193, 3414.7633300188418, 3426.811525366104, 4659.673822832403, 5094.974525127388, 5103.8356219144, 5103.872403189913, 5111.309973153614, 4334.219840428722, 4385.51759306476, 4445.644348452116, 4447.5552444755585, 4452.971979054242, 5424.945750542523, 5425.430329815392, 5431.402545719968, 5437.193964225019, 5440.483154100354, 3437.8745505393626, 3713.20166164276, 3713.9071523212137, 3729.384651532494, 3731.7574357666663, 5517.503424691797, 5703.372629010805, 5741.253637027202, 5800.200868431184, 5804.796832110856, 2922.459345021178, 3214.726748226427, 3775.320442320354, 3782.3380908340932, 3782.432635104701, 3266.1508007917637, 3436.914077148091, 3553.36039512885, 3678.576963649161, 3847.961050516345, 4234.70357075008, 4428.402165707588, 4486.407325399501, 4492.348609451611, 4510.752258373966, 5169.844904652867, 5237.423883372826, 5487.64330318528, 5495.104189054769, 5516.448355164452, 1243.3783108445778, 1255.215490318551, 1256.9504463772853, 1257.6352857671172, 1261.9684507887375, 796.6934227866304, 816.9673213071411, 823.4565186976566, 831.2020460358003, 852.8251708399763, 4577.610903073276, 4606.825259558858, 4904.828331008398, 4928.433230178575, 4946.975265123651, 4601.953980460219, 4863.805447782049, 5385.922815436928, 5430.348358197041, 5431.37539182999, 4416.80124394403, 4551.337467581436, 4669.486356500782, 4691.34075421172, 4934.199017358638, 2813.706828934453, 2821.7460428561117, 2833.773298136144, 2837.5743638454396, 2846.914592562185, 4770.662375436012, 4917.852464426073, 5462.73296581914, 5491.945080549143, 5547.694876781816, 4856.417229932431, 4956.306117143603, 5207.0, 5256.342957130359, 5487.176923461513, 5528.834134975958, 5540.501354878081, 5546.0, 5559.053072318699, 5595.328560572757, 4685.8594242172785, 4773.0, 4826.8069277228515, 5358.383785864519, 5370.428664937773, 4963.0, 5196.9346284012445, 5222.791088356423, 5322.840314790563, 5624.89066600025, 4953.975230123826, 5502.5597952164535, 5903.557233207613, 5910.822675319747, 5934.851628709144, 3699.426588878728, 3799.335116354682, 3847.6537111660086, 3849.9230015400094, 3851.1334949636107, 5100.18943275132, 5378.650387724785, 5717.283765552258, 5763.884722305446, 5825.2135961644635, 5513.4713783177995, 5540.501354878081, 5541.0, 5558.8036878795665, 5568.638038527482, 4205.600467955539, 4561.384213131185, 4943.085529177114, 5435.526835290013, 5444.067356088532, 4597.827553973715, 4875.393297707665, 4990.176620857518, 5151.655996521498, 5345.732713364394, 4500.662450316305, 4603.953960460486, 5379.81644038311, 5426.372088373551, 5524.530414914617, 5411.269478620493, 5445.646033007842, 5456.836294911159, 5468.468828727962, 5470.72646367672], "value": 3945.7767488568884, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.2653293640487, 732.3262598409466, 748.7678819565934, 785.7839094249084, 814.771863878114, 14084.507042253523, 14616.853831461682, 14630.829533637323, 14632.414703411863, 14635.853641463582, 12369.381530923463, 12467.750644987094, 12477.812832807514, 12488.000959923207, 12496.18774779641, 678.4945215814225, 679.123930130134, 701.2811867835459, 701.6596950479013, 842.6376658037042, 845.0324378586515, 860.389123722158, 862.5730263519566, 863.3697400897348, 867.2584939876409, 928.8978212396664, 931.683227702581, 934.4953724988499, 934.8457504511747, 936.0031566381815, 925.4447331601053, 925.7639301977986, 926.36081104038, 926.8424367857447, 926.8934072581671, 456.37476656979817, 523.1603276740814, 643.584887747405, 663.9070530125787, 687.2714922182503, 13656.726865462635, 13715.245661488614, 13762.0, 13766.93116534411, 13780.862191378059, 9656.37233579815, 11147.331160130418, 12500.0, 12524.436400362005, 12534.435950382254, 11498.597549085825, 11984.17969330807, 12122.454489547992, 12223.14437989341, 12314.322712250823, 4325.243082460588, 4332.458442694663, 4332.91334173318, 4520.570545798144, 4534.047849951514, 79902.0, 100485.49271760929, 102369.0, 103140.0, 106066.46966765194, 10066.345687530287, 10106.494675266207, 10126.240531960133, 10134.391936483835, 10481.842772358421, 20593.691094633592, 20783.792162078185, 20862.06120724571, 20891.58216835655, 21078.57842843165, 7210.351068403764, 7249.420046396381, 7277.272272772786, 7300.160481544584, 7369.263073692588, 4139.110091330378, 4193.685473589493, 4197.643200327945, 4209.978950105291, 4226.598473145046, 3292.7201187899295, 3346.0798280473064, 3357.9496307555405, 3394.6605339465855, 3411.9488207676904, 523.70410717945, 524.8451706746519, 530.6179550723473, 643.4016364780705, 682.3449488491005, 557.5706705836565, 577.9739911703983, 625.0343219725535, 637.1971316141602, 655.3675702946584, 8528.147185281547, 8909.73618246348, 9162.725118246462, 9417.434953902788, 9461.668841590512, 575.2406822993609, 634.6160572853449, 647.5628950458422, 674.2381109346408, 678.8302924268933, 4280.935785963213, 4554.749488778083, 4572.08558288337, 4583.129205450954, 4639.141758774637, 97133.0, 106111.0, 106168.0, 106252.93747062585, 107000.0, 83123.99999999879, 84868.57565712131, 88395.0, 89869.55065224633, 90071.09928900628, 78224.0, 78933.0, 79424.0, 82786.17213827785, 85750.71373929396, 8504.957475212585, 8849.646014159362, 8856.380053396459, 9016.413933094327, 9129.277319654546, 51543.48456515537, 51742.0, 51928.48071519237, 53804.730976344865, 54578.181327280916, 70424.64787676028, 74452.0, 76675.23324766681, 77296.0, 77397.0, 9684.70945871625, 10886.836697449386, 10961.835572466578, 11007.449627518752, 11123.666290011313, 12524.436400361823, 12696.492140314283, 12744.299063551594, 12748.235105893677, 13325.067245292736, 11123.83314250303, 12038.050508468054, 12053.096017798525, 12054.0, 12334.444949977093, 11996.520139194334, 12068.396580171131, 12070.215435996632, 12101.757964840477, 12284.938575307066, 11898.821517677416, 11949.940250298692, 12024.579139730067, 12104.031677465957, 12105.092118091003, 9833.4099954003, 10065.647702330383, 10068.496575171066, 10575.947120264656, 10579.206559507913, 10135.391876487434, 10424.843627345748, 10438.478076096317, 10478.790424191626, 10494.895051049392], "value": 7123.7926522463895, "unit": "score"}], "name": "dromaeo_css", "value": 7084.644779725328, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 114.0, 114.0, 115.0, 113.0, 113.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 114.0, 146.0, 115.0, 115.0, 114.0, 113.0, 136.0, 114.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 183.0, 185.0, 186.0, 183.0, 185.0, 178.0, 183.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 86.0, 62.0, 58.0, 59.0, 59.0, 77.0, 79.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 56.0, 102.0, 94.0, 101.0, 86.0, 83.0, 70.0, 68.0, 85.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 119.0, 135.0, 92.0, 150.0, 166.0, 109.0, 106.0, 109.0], "value": 120.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 93.0, 94.0, 95.0, 94.0, 112.0, 149.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 94.0, 135.0, 87.0, 85.0, 86.0, 87.0, 85.0, 86.0, 84.0], "value": 91.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 53.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 71.0, 81.0, 75.0, 73.0, 69.0, 73.0, 71.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 87.0, 89.0, 90.0, 90.0, 91.0, 97.0, 108.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 161.0, 161.0, 151.0, 145.0, 148.0, 149.0, 147.0, 190.0, 147.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 179.0, 174.0, 177.0, 179.0, 184.0, 234.0, 175.0, 181.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 68.0, 74.0, 63.0, 57.0, 60.0, 80.0, 62.0, 59.0, 75.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1505.3, "alertThreshold": 2.0}]} 05:03:45 INFO - Return code: 0 05:03:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:03:45 INFO - # TBPL SUCCESS # 05:03:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:45 INFO - 2016-12-15 05:03:45.192 screenresolution[1652:9709] starting screenresolution argv=screenresolution get 05:03:45 INFO - 2016-12-15 05:03:45.195 screenresolution[1652:9709] Display 0: 1600x1200x32@60 05:03:45 INFO - 2016-12-15 05:03:45.202 screenresolution[1653:9712] starting screenresolution argv=screenresolution list 05:03:45 INFO - Available Modes on Display 0 05:03:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:45 INFO - Intel Iris: 05:03:45 INFO - Chipset Model: Intel Iris 05:03:45 INFO - Type: GPU 05:03:45 INFO - Bus: Built-In 05:03:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:45 INFO - Vendor: Intel (0x8086) 05:03:45 INFO - Device ID: 0x0a2e 05:03:45 INFO - Revision ID: 0x0009 05:03:45 INFO - Displays: 05:03:45 INFO - Display: 05:03:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:45 INFO - Display Serial Number: 1600x1200 60 05:03:45 INFO - Main Display: Yes 05:03:45 INFO - Mirror: Off 05:03:45 INFO - Online: Yes 05:03:45 INFO - Rotation: Supported 05:03:45 INFO - Return code: 0 05:03:45 INFO - Running post-action listener: _resource_record_post_action 05:03:45 INFO - [mozharness: 2016-12-15 13:03:45.443040Z] Finished run-tests step (success) 05:03:45 INFO - Running post-run listener: _resource_record_post_run 05:03:45 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 37749760; Write bytes: 549804032; Read time: 239; Write time: 1679 05:03:45 INFO - TinderboxPrint: CPU usage
53.7% 05:03:45 INFO - TinderboxPrint: I/O read bytes / time
37,749,760 / 239 05:03:45 INFO - TinderboxPrint: I/O write bytes / time
549,804,032 / 1,679 05:03:45 INFO - TinderboxPrint: CPU idle
2,229.0 (46.3%) 05:03:45 INFO - TinderboxPrint: CPU system
963.6 (20.0%) 05:03:45 INFO - TinderboxPrint: CPU user
1,621.1 (33.7%) 05:03:45 INFO - TinderboxPrint: Swap in / out
287,301,632 / 0 05:03:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247665152; Write bytes: 237785088; Read time: 18087; Write time: 516 05:03:45 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35578880; Write bytes: 298358784; Read time: 218; Write time: 1127 05:03:45 INFO - Running post-run listener: _upload_blobber_files 05:03:45 INFO - Blob upload gear active. 05:03:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:03:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:47 INFO - (blobuploader) - INFO - Done attempting. 05:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:48 INFO - (blobuploader) - INFO - Done attempting. 05:03:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:50 INFO - (blobuploader) - INFO - Done attempting. 05:03:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:50 INFO - Return code: 0 05:03:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c74b809e3e42424aea1e1cbc22b94bd4f24b3a8bf09ff0ab9d00cc3ea60f1f934a05c7624e039ea1e9babcd75518244ce7b7c3454ea8a46536b05226b37a995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8a3ccc1358fbecde4dbdb7a7b717c91960a3c7518a97c888113cbc9025cf335367b9d151108bab4a9bfa3b14b2823233e6a4c0e67210797f3fedcfbae8593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b84e265e6d063bde26d7ecc528c6609ba3e6d7240085c021ddb8b3f969bddbf9c30d97ba83f0de61ccf32625f64f7a13998424adc08df4d966ac36c9afec85"} 05:03:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:50 INFO - Contents: 05:03:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c74b809e3e42424aea1e1cbc22b94bd4f24b3a8bf09ff0ab9d00cc3ea60f1f934a05c7624e039ea1e9babcd75518244ce7b7c3454ea8a46536b05226b37a995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8a3ccc1358fbecde4dbdb7a7b717c91960a3c7518a97c888113cbc9025cf335367b9d151108bab4a9bfa3b14b2823233e6a4c0e67210797f3fedcfbae8593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b84e265e6d063bde26d7ecc528c6609ba3e6d7240085c021ddb8b3f969bddbf9c30d97ba83f0de61ccf32625f64f7a13998424adc08df4d966ac36c9afec85"} 05:03:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:50 INFO - Copying logs to upload dir... 05:03:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.012949 ========= master_lag: 1.51 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-15 05:03:51.907190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:03:51.911180) ========= 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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c74b809e3e42424aea1e1cbc22b94bd4f24b3a8bf09ff0ab9d00cc3ea60f1f934a05c7624e039ea1e9babcd75518244ce7b7c3454ea8a46536b05226b37a995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8a3ccc1358fbecde4dbdb7a7b717c91960a3c7518a97c888113cbc9025cf335367b9d151108bab4a9bfa3b14b2823233e6a4c0e67210797f3fedcfbae8593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b84e265e6d063bde26d7ecc528c6609ba3e6d7240085c021ddb8b3f969bddbf9c30d97ba83f0de61ccf32625f64f7a13998424adc08df4d966ac36c9afec85"} build_url:https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/KEZYeQSwRuGzoJE5AN8GIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c74b809e3e42424aea1e1cbc22b94bd4f24b3a8bf09ff0ab9d00cc3ea60f1f934a05c7624e039ea1e9babcd75518244ce7b7c3454ea8a46536b05226b37a995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be8a3ccc1358fbecde4dbdb7a7b717c91960a3c7518a97c888113cbc9025cf335367b9d151108bab4a9bfa3b14b2823233e6a4c0e67210797f3fedcfbae8593a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60b84e265e6d063bde26d7ecc528c6609ba3e6d7240085c021ddb8b3f969bddbf9c30d97ba83f0de61ccf32625f64f7a13998424adc08df4d966ac36c9afec85"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:03:51.954781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-12-15 05:03:51.955077) ========= 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.xoQ4u4QDVV/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.Fhpt0tA7Bi/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.005248 ========= master_lag: 3.76 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-12-15 05:03:55.718453) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-12-15 05:03:55.718793) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-12-15 05:03:56.929659) ========= ========= Total master_lag: 5.38 =========