builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0017 starttime: 1475114971.06 results: success (0) buildid: 20160928171520 builduid: 494e4e01e38848c58425f5ee904efab7 revision: 84ef54451749188462d6b97c6b668508893ece47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.060057) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.060554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.060834) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.084235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.084623) ========= 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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-09-28 19:09:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-09-28 19:09:31 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141872 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.351546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.351880) ========= 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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.020908 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:31.392779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 19:09:31.393148) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 84ef54451749188462d6b97c6b668508893ece47 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 84ef54451749188462d6b97c6b668508893ece47 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BeFfqMN1Zp/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.uUbn1wuu95/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-09-28 19:09:31,466 truncating revision to first 12 chars 2016-09-28 19:09:31,466 Setting DEBUG logging. 2016-09-28 19:09:31,466 attempt 1/10 2016-09-28 19:09:31,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/84ef54451749?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 19:09:33,014 unpacking tar archive at: mozilla-aurora-84ef54451749/testing/mozharness/ program finished with exit code 0 elapsedTime=1.829104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 19:09:33.243827) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:33.244168) ========= script_repo_revision: 84ef54451749188462d6b97c6b668508893ece47 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:33.244612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:33.244877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 19:09:33.262942) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-09-28 19:09:33.263286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BeFfqMN1Zp/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.uUbn1wuu95/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:09:33 INFO - MultiFileLogger online at 20160928 19:09:33 in /builds/slave/test 19:09:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:09:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:33 INFO - {'append_to_log': False, 19:09:33 INFO - 'base_work_dir': '/builds/slave/test', 19:09:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:09:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:33 INFO - 'branch': 'Mozilla-Aurora', 19:09:33 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:33 INFO - 'config_files': ('talos/mac_config.py',), 19:09:33 INFO - 'default_actions': ('clobber', 19:09:33 INFO - 'read-buildbot-config', 19:09:33 INFO - 'download-and-extract', 19:09:33 INFO - 'populate-webroot', 19:09:33 INFO - 'create-virtualenv', 19:09:33 INFO - 'install', 19:09:33 INFO - 'run-tests'), 19:09:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:33 INFO - 'download_minidump_stackwalk': True, 19:09:33 INFO - 'download_symbols': 'ondemand', 19:09:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:33 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:33 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:33 INFO - 'installer_path': 'installer.exe', 19:09:33 INFO - 'log_level': 'info', 19:09:33 INFO - 'log_name': 'talos', 19:09:33 INFO - 'log_to_console': True, 19:09:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:09:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:09:33 INFO - 'opt_config_files': (), 19:09:33 INFO - 'pip_index': False, 19:09:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:33 INFO - 'cmd': ('bash', 19:09:33 INFO - '-c', 19:09:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:33 INFO - 'enabled': True, 19:09:33 INFO - 'halt_on_failure': False, 19:09:33 INFO - 'name': 'check_screen_resolution'},), 19:09:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:33 INFO - 'cmd': ('bash', 19:09:33 INFO - '-c', 19:09:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:33 INFO - 'enabled': True, 19:09:33 INFO - 'halt_on_failure': False, 19:09:33 INFO - 'name': 'check_screen_resolution'},), 19:09:33 INFO - 'run_cmd_checks_enabled': True, 19:09:33 INFO - 'sps_profile': False, 19:09:33 INFO - 'sps_profile_interval': 0, 19:09:33 INFO - 'suite': 'dromaeojs', 19:09:33 INFO - 'system_bits': '32', 19:09:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:33 INFO - 'title': 't-yosemite-r7-0017', 19:09:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:33 INFO - 'use_talos_json': True, 19:09:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:33 INFO - 'work_dir': 'build'} 19:09:33 INFO - [mozharness: 2016-09-29 02:09:33.457096Z] Running clobber step. 19:09:33 INFO - Running pre-action listener: _resource_record_pre_action 19:09:33 INFO - Running main action method: clobber 19:09:33 INFO - rmtree: /builds/slave/test/build 19:09:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:34 INFO - Running post-action listener: _resource_record_post_action 19:09:34 INFO - [mozharness: 2016-09-29 02:09:34.473292Z] Finished clobber step (success) 19:09:34 INFO - [mozharness: 2016-09-29 02:09:34.473426Z] Running read-buildbot-config step. 19:09:34 INFO - Running pre-action listener: _resource_record_pre_action 19:09:34 INFO - Running main action method: read_buildbot_config 19:09:34 INFO - Using buildbot properties: 19:09:34 INFO - { 19:09:34 INFO - "project": "", 19:09:34 INFO - "product": "firefox", 19:09:34 INFO - "script_repo_revision": "production", 19:09:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 19:09:34 INFO - "repository": "", 19:09:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 19:09:34 INFO - "buildid": "20160928171520", 19:09:34 INFO - "pgo_build": "False", 19:09:34 INFO - "basedir": "/builds/slave/test", 19:09:34 INFO - "buildnumber": 58, 19:09:34 INFO - "slavename": "t-yosemite-r7-0017", 19:09:34 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:09:34 INFO - "platform": "yosemite_r7", 19:09:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:09:34 INFO - "branch": "mozilla-aurora", 19:09:34 INFO - "repo_path": "releases/mozilla-aurora", 19:09:34 INFO - "revision": "84ef54451749188462d6b97c6b668508893ece47", 19:09:34 INFO - "stage_platform": "macosx64", 19:09:34 INFO - "builduid": "494e4e01e38848c58425f5ee904efab7", 19:09:34 INFO - "slavebuilddir": "test" 19:09:34 INFO - } 19:09:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:09:34 INFO - Running post-action listener: _resource_record_post_action 19:09:34 INFO - [mozharness: 2016-09-29 02:09:34.476906Z] Finished read-buildbot-config step (success) 19:09:34 INFO - [mozharness: 2016-09-29 02:09:34.477014Z] Running download-and-extract step. 19:09:34 INFO - Running pre-action listener: _resource_record_pre_action 19:09:34 INFO - Running main action method: download_and_extract 19:09:34 INFO - mkdir: /builds/slave/test/build/tests 19:09: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')]} 19:09:34 INFO - trying https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:09:34 INFO - Downloading https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 19:09:35 INFO - Downloaded 1199 bytes. 19:09:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:09:35 INFO - Using the following test package requirements: 19:09:35 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:09:35 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:09:35 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:09:35 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'jsshell-mac.zip'], 19:09:35 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:09:35 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:09:35 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:09:35 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:09:35 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:09:35 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:09:35 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:09:35 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:09:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:09:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:09:35 INFO - Fetch https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:09:36 INFO - Expected file size: 16432350 19:09:43 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 19:09:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:09:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:09:43 INFO - Fetch https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:09:43 INFO - Expected file size: 16432350 19:09:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 19:09:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:09:50 INFO - Fetch https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:09:50 INFO - Expected file size: 14414059 19:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:51 INFO - trying https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:09:51 INFO - Downloading https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 19:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 19:09:54 INFO - Downloaded 115278899 bytes. 19:09:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:09:54 INFO - mkdir: /builds/slave/test/properties 19:09:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:54 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:54 INFO - Contents: 19:09:54 INFO - build_url:https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:09:54 INFO - Running post-action listener: _resource_record_post_action 19:09:54 INFO - Running post-action listener: set_extra_try_arguments 19:09:54 INFO - [mozharness: 2016-09-29 02:09:54.970297Z] Finished download-and-extract step (success) 19:09:54 INFO - [mozharness: 2016-09-29 02:09:54.970402Z] Running populate-webroot step. 19:09:54 INFO - Running pre-action listener: _resource_record_pre_action 19:09:54 INFO - Running main action method: populate_webroot 19:09:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:54 INFO - '--tppagecycles', 19:09:54 INFO - '7'], 19:09:54 INFO - 'tests': ['tsvgm']}}, 19:09:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:09:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:09:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:09:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['damp', 'tps']}, 19:09:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'tests': ['damp', 'tps']}, 19:09:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['dromaeo_dom']}, 19:09:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['basic_compositor_video']}, 19:09:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:09:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['a11yr', 19:09:54 INFO - 'ts_paint', 19:09:54 INFO - 'tpaint', 19:09:54 INFO - 'sessionrestore', 19:09:54 INFO - 'sessionrestore_no_auto_restore', 19:09:54 INFO - 'tabpaint']}, 19:09:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:09:54 INFO - 'ts_paint', 19:09:54 INFO - 'tpaint', 19:09:54 INFO - 'sessionrestore', 19:09:54 INFO - 'sessionrestore_no_auto_restore', 19:09:54 INFO - 'tabpaint']}, 19:09:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:09:54 INFO - 'ts_paint', 19:09:54 INFO - 'tpaint', 19:09:54 INFO - 'sessionrestore', 19:09:54 INFO - 'sessionrestore_no_auto_restore', 19:09:54 INFO - 'tabpaint']}, 19:09:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:09:54 INFO - 'ts_paint', 19:09:54 INFO - 'tpaint', 19:09:54 INFO - 'sessionrestore', 19:09:54 INFO - 'sessionrestore_no_auto_restore', 19:09:54 INFO - 'tabpaint']}, 19:09:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['a11yr', 19:09:54 INFO - 'ts_paint', 19:09:54 INFO - 'tpaint', 19:09:54 INFO - 'sessionrestore', 19:09:54 INFO - 'sessionrestore_no_auto_restore', 19:09:54 INFO - 'tabpaint']}, 19:09:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['a11yr', 19:09:54 INFO - 'ts_paint', 19:09:54 INFO - 'tpaint', 19:09:54 INFO - 'sessionrestore', 19:09:54 INFO - 'sessionrestore_no_auto_restore', 19:09:54 INFO - 'tabpaint']}, 19:09:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['tsvgx', 19:09:54 INFO - 'tsvgr_opacity', 19:09:54 INFO - 'tart', 19:09:54 INFO - 'tscrollx', 19:09:54 INFO - 'cart']}, 19:09:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:09:54 INFO - 'tsvgr_opacity', 19:09:54 INFO - 'tart', 19:09:54 INFO - 'tscrollx', 19:09:54 INFO - 'cart']}, 19:09:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'talos_options': ['--disable-e10s'], 19:09:54 INFO - 'tests': ['tp5o']}, 19:09:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'tests': ['tp5o']}, 19:09:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'talos_options': ['--disable-e10s', 19:09:54 INFO - '--xperf_path', 19:09:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:54 INFO - 'tests': ['tp5n']}, 19:09:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:54 INFO - 'talos_options': ['--xperf_path', 19:09:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:54 INFO - 'tests': ['tp5n']}}, 19:09:54 INFO - 'talos.zip': {'path': '', 19:09:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:54 INFO - Running post-action listener: _resource_record_post_action 19:09:54 INFO - [mozharness: 2016-09-29 02:09:54.988972Z] Finished populate-webroot step (success) 19:09:54 INFO - [mozharness: 2016-09-29 02:09:54.989105Z] Running create-virtualenv step. 19:09:54 INFO - Running pre-action listener: _resource_record_pre_action 19:09:54 INFO - Running main action method: create_virtualenv 19:09:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:54 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 19:09:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:55 INFO - Using real prefix '/tools/python27' 19:09:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:55 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:58 INFO - Installing pip.................done. 19:09:58 INFO - Return code: 0 19:09:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:58 INFO - 'HOME': '/Users/cltbld', 19:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:58 INFO - 'LOGNAME': 'cltbld', 19:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:58 INFO - 'MOZ_NO_REMOTE': '1', 19:09:58 INFO - 'NO_EM_RESTART': '1', 19:09:58 INFO - 'PAGER': '/bin/cat', 19:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:58 INFO - 'PWD': '/builds/slave/test', 19:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:58 INFO - 'SHELL': '/bin/bash', 19:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:09:58 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:58 INFO - 'USER': 'cltbld', 19:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:58 INFO - 'XPC_FLAGS': '0x0', 19:09:58 INFO - 'XPC_SERVICE_NAME': '0', 19:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:58 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 19:09:58 INFO - Cleaning up... 19:09:58 INFO - Return code: 0 19:09:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:58 INFO - 'HOME': '/Users/cltbld', 19:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:58 INFO - 'LOGNAME': 'cltbld', 19:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:58 INFO - 'MOZ_NO_REMOTE': '1', 19:09:58 INFO - 'NO_EM_RESTART': '1', 19:09:58 INFO - 'PAGER': '/bin/cat', 19:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:58 INFO - 'PWD': '/builds/slave/test', 19:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:58 INFO - 'SHELL': '/bin/bash', 19:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:09:58 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:58 INFO - 'USER': 'cltbld', 19:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:58 INFO - 'XPC_FLAGS': '0x0', 19:09:58 INFO - 'XPC_SERVICE_NAME': '0', 19:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:59 INFO - Downloading/unpacking psutil>=3.1.1 19:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:02 INFO - Installing collected packages: psutil 19:10:02 INFO - Running setup.py install for psutil 19:10:02 INFO - building 'psutil._psutil_osx' extension 19:10:02 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 19:10:02 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 19:10:03 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 19:10:03 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 19:10:03 INFO - building 'psutil._psutil_posix' extension 19:10:03 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 19:10:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:10:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:10:03 INFO - ^ 19:10:03 INFO - 1 warning generated. 19:10:03 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 19:10:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:03 INFO - Successfully installed psutil 19:10:03 INFO - Cleaning up... 19:10:03 INFO - Return code: 0 19:10:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:03 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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:03 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 19:10:03 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 19:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:03 INFO - 'HOME': '/Users/cltbld', 19:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:03 INFO - 'LOGNAME': 'cltbld', 19:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:03 INFO - 'MOZ_NO_REMOTE': '1', 19:10:03 INFO - 'NO_EM_RESTART': '1', 19:10:03 INFO - 'PAGER': '/bin/cat', 19:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:03 INFO - 'PWD': '/builds/slave/test', 19:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:03 INFO - 'SHELL': '/bin/bash', 19:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:03 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:03 INFO - 'USER': 'cltbld', 19:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:03 INFO - 'XPC_FLAGS': '0x0', 19:10:03 INFO - 'XPC_SERVICE_NAME': '0', 19:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10:03 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 19:10:03 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 19:10:03 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 19:10:03 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 19:10:03 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 19:10:03 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 19:10:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:06 INFO - Installing collected packages: mozsystemmonitor 19:10:06 INFO - Running setup.py install for mozsystemmonitor 19:10:06 INFO - Successfully installed mozsystemmonitor 19:10:06 INFO - Cleaning up... 19:10:06 INFO - Return code: 0 19:10:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:10:06 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')]} 19:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:06 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')]} 19:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:06 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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:06 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 19:10:06 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 19:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:06 INFO - 'HOME': '/Users/cltbld', 19:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:06 INFO - 'LOGNAME': 'cltbld', 19:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:06 INFO - 'MOZ_NO_REMOTE': '1', 19:10:06 INFO - 'NO_EM_RESTART': '1', 19:10:06 INFO - 'PAGER': '/bin/cat', 19:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:06 INFO - 'PWD': '/builds/slave/test', 19:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:06 INFO - 'SHELL': '/bin/bash', 19:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:06 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:06 INFO - 'USER': 'cltbld', 19:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:06 INFO - 'XPC_FLAGS': '0x0', 19:10:06 INFO - 'XPC_SERVICE_NAME': '0', 19:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:06 INFO - Downloading/unpacking jsonschema==2.5.1 19:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:09 INFO - warning: no files found matching '*.txt' 19:10:09 INFO - no previously-included directories found matching 'build' 19:10:09 INFO - no previously-included directories found matching 'dist' 19:10:09 INFO - no previously-included directories found matching '.git*' 19:10:09 INFO - Installing collected packages: jsonschema, functools32 19:10:09 INFO - Running setup.py install for functools32 19:10:09 INFO - warning: no files found matching '*.txt' 19:10:09 INFO - no previously-included directories found matching 'build' 19:10:09 INFO - no previously-included directories found matching 'dist' 19:10:09 INFO - no previously-included directories found matching '.git*' 19:10:09 INFO - Successfully installed jsonschema functools32 19:10:09 INFO - Cleaning up... 19:10:09 INFO - Return code: 0 19:10:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:10:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:09 INFO - 'HOME': '/Users/cltbld', 19:10:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:09 INFO - 'LOGNAME': 'cltbld', 19:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:09 INFO - 'MOZ_NO_REMOTE': '1', 19:10:09 INFO - 'NO_EM_RESTART': '1', 19:10:09 INFO - 'PAGER': '/bin/cat', 19:10:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:09 INFO - 'PWD': '/builds/slave/test', 19:10:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:09 INFO - 'SHELL': '/bin/bash', 19:10:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:09 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:09 INFO - 'USER': 'cltbld', 19:10:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:09 INFO - 'XPC_FLAGS': '0x0', 19:10:09 INFO - 'XPC_SERVICE_NAME': '0', 19:10:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:10:10 INFO - Cleaning up... 19:10:10 INFO - Return code: 0 19:10:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10:10 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')]} 19:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:10 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')]} 19:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:10 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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:10 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 19:10:10 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 19:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:10 INFO - 'HOME': '/Users/cltbld', 19:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:10 INFO - 'LOGNAME': 'cltbld', 19:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:10 INFO - 'MOZ_NO_REMOTE': '1', 19:10:10 INFO - 'NO_EM_RESTART': '1', 19:10:10 INFO - 'PAGER': '/bin/cat', 19:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:10 INFO - 'PWD': '/builds/slave/test', 19:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:10 INFO - 'SHELL': '/bin/bash', 19:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:10 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:10 INFO - 'USER': 'cltbld', 19:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:10 INFO - 'XPC_FLAGS': '0x0', 19:10:10 INFO - 'XPC_SERVICE_NAME': '0', 19:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:10 INFO - Downloading/unpacking blobuploader==1.2.4 19:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:12 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:13 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 19:10:13 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 19:10:13 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 19:10:13 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 19:10:13 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 19:10:13 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 19:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10:13 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 19:10:13 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 19:10:13 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 19:10:13 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 19:10:13 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 19:10:13 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 19:10:14 INFO - Downloading docopt-0.6.1.tar.gz 19:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:14 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:14 INFO - Running setup.py install for blobuploader 19:10:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:14 INFO - Running setup.py install for requests 19:10:14 INFO - Running setup.py install for docopt 19:10:15 INFO - Successfully installed blobuploader requests docopt 19:10:15 INFO - Cleaning up... 19:10:15 INFO - Return code: 0 19:10:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:15 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')]} 19:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:15 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')]} 19:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:15 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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:15 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 19:10:15 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 19:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:15 INFO - 'HOME': '/Users/cltbld', 19:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:15 INFO - 'LOGNAME': 'cltbld', 19:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:15 INFO - 'MOZ_NO_REMOTE': '1', 19:10:15 INFO - 'NO_EM_RESTART': '1', 19:10:15 INFO - 'PAGER': '/bin/cat', 19:10:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:15 INFO - 'PWD': '/builds/slave/test', 19:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:15 INFO - 'SHELL': '/bin/bash', 19:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:15 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:15 INFO - 'USER': 'cltbld', 19:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:15 INFO - 'XPC_FLAGS': '0x0', 19:10:15 INFO - 'XPC_SERVICE_NAME': '0', 19:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ulYCDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-JPPoWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-TDKlk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-EHhEB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-2QPaSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:15 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-gna8QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-4B6BL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-SNtvm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ID8kIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-_edbt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-T_Td1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-D3eulE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-F9Qg_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-DcWMzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-C4m5gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:16 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-nqI7Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:17 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-GrGJn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:17 INFO - Running setup.py install for manifestparser 19:10:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:17 INFO - Running setup.py install for mozcrash 19:10:17 INFO - Running setup.py install for mozdebug 19:10:17 INFO - Running setup.py install for mozdevice 19:10:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:17 INFO - Running setup.py install for mozfile 19:10:17 INFO - Running setup.py install for mozhttpd 19:10:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Running setup.py install for mozinfo 19:10:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Running setup.py install for mozInstall 19:10:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Running setup.py install for mozleak 19:10:18 INFO - Running setup.py install for mozlog 19:10:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Running setup.py install for moznetwork 19:10:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:18 INFO - Running setup.py install for mozprocess 19:10:18 INFO - Running setup.py install for mozprofile 19:10:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:19 INFO - Running setup.py install for mozrunner 19:10:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:19 INFO - Running setup.py install for mozscreenshot 19:10:19 INFO - Running setup.py install for moztest 19:10:19 INFO - Running setup.py install for mozversion 19:10:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:19 INFO - Cleaning up... 19:10:19 INFO - Return code: 0 19:10:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:19 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')]} 19:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:19 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')]} 19:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:19 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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:19 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 19:10:19 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 19:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:19 INFO - 'HOME': '/Users/cltbld', 19:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:19 INFO - 'LOGNAME': 'cltbld', 19:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:19 INFO - 'MOZ_NO_REMOTE': '1', 19:10:19 INFO - 'NO_EM_RESTART': '1', 19:10:19 INFO - 'PAGER': '/bin/cat', 19:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:19 INFO - 'PWD': '/builds/slave/test', 19:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:19 INFO - 'SHELL': '/bin/bash', 19:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:19 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:19 INFO - 'USER': 'cltbld', 19:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:19 INFO - 'XPC_FLAGS': '0x0', 19:10:19 INFO - 'XPC_SERVICE_NAME': '0', 19:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-r7DdwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:20 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-v5h_uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-32nTJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:20 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-6nc82t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-lhJNdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:20 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-rLWuy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:20 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-XswUF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:20 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-i2wA0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:20 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-6LdSel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:20 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)) 19:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-l21GIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:21 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)) 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-El0o2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:21 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)) 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-5GgXtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:21 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)) 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ONUfZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:21 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)) 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-xYzKg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-J4EsqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:21 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)) 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-xkXiE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:21 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)) 19:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-whCUAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:21 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)) 19:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:21 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)) 19:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:24 INFO - Downloading blessings-1.6.tar.gz 19:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:24 INFO - Installing collected packages: blessings 19:10:24 INFO - Running setup.py install for blessings 19:10:24 INFO - Successfully installed blessings 19:10:24 INFO - Cleaning up... 19:10:24 INFO - Return code: 0 19:10:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:24 INFO - Reading from file tmpfile_stdout 19:10:24 INFO - Current package versions: 19:10:24 INFO - blessings == 1.6 19:10:24 INFO - blobuploader == 1.2.4 19:10:24 INFO - docopt == 0.6.1 19:10:24 INFO - functools32 == 3.2.3-2 19:10:24 INFO - jsonschema == 2.5.1 19:10:24 INFO - manifestparser == 1.1 19:10:24 INFO - mozInstall == 1.12 19:10:24 INFO - mozcrash == 0.17 19:10:24 INFO - mozdebug == 0.1 19:10:24 INFO - mozdevice == 0.48 19:10:24 INFO - mozfile == 1.2 19:10:24 INFO - mozhttpd == 0.7 19:10:24 INFO - mozinfo == 0.9 19:10:24 INFO - mozleak == 0.1 19:10:24 INFO - mozlog == 3.4 19:10:24 INFO - moznetwork == 0.27 19:10:24 INFO - mozprocess == 0.23 19:10:24 INFO - mozprofile == 0.28 19:10:24 INFO - mozrunner == 6.12 19:10:24 INFO - mozscreenshot == 0.1 19:10:24 INFO - mozsystemmonitor == 0.3 19:10:24 INFO - moztest == 0.7 19:10:24 INFO - mozversion == 1.4 19:10:24 INFO - psutil == 3.1.1 19:10:24 INFO - requests == 1.2.3 19:10:24 INFO - wsgiref == 0.1.2 19:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:24 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 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:24 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 19:10:24 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 19:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:24 INFO - 'HOME': '/Users/cltbld', 19:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:24 INFO - 'LOGNAME': 'cltbld', 19:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:24 INFO - 'MOZ_NO_REMOTE': '1', 19:10:24 INFO - 'NO_EM_RESTART': '1', 19:10:24 INFO - 'PAGER': '/bin/cat', 19:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:24 INFO - 'PWD': '/builds/slave/test', 19:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:24 INFO - 'SHELL': '/bin/bash', 19:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:24 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:24 INFO - 'USER': 'cltbld', 19:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:24 INFO - 'XPC_FLAGS': '0x0', 19:10:24 INFO - 'XPC_SERVICE_NAME': '0', 19:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 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)) 19:10:25 INFO - Cleaning up... 19:10:25 INFO - Return code: 0 19:10:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d98c1e140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, '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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 19:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:25 INFO - 'HOME': '/Users/cltbld', 19:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:25 INFO - 'LOGNAME': 'cltbld', 19:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:25 INFO - 'MOZ_NO_REMOTE': '1', 19:10:25 INFO - 'NO_EM_RESTART': '1', 19:10:25 INFO - 'PAGER': '/bin/cat', 19:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:25 INFO - 'PWD': '/builds/slave/test', 19:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:25 INFO - 'SHELL': '/bin/bash', 19:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:25 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:25 INFO - 'USER': 'cltbld', 19:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:25 INFO - 'XPC_FLAGS': '0x0', 19:10:25 INFO - 'XPC_SERVICE_NAME': '0', 19:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:10:25 INFO - Cleaning up... 19:10:25 INFO - Return code: 0 19:10:25 INFO - Running post-action listener: _resource_record_post_action 19:10:25 INFO - Running post-action listener: _start_resource_monitoring 19:10:25 INFO - Starting resource monitoring. 19:10:25 INFO - [mozharness: 2016-09-29 02:10:25.454668Z] Finished create-virtualenv step (success) 19:10:25 INFO - [mozharness: 2016-09-29 02:10:25.455651Z] Running install step. 19:10:25 INFO - Running pre-action listener: _resource_record_pre_action 19:10:25 INFO - Running main action method: install 19:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:25 INFO - Reading from file tmpfile_stdout 19:10:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:25 INFO - Reading from file tmpfile_stdout 19:10:25 INFO - Output received: 19:10:25 INFO - Usage: mozinstall [options] installer 19:10:25 INFO - Options: 19:10:25 INFO - -h, --help show this help message and exit 19:10:25 INFO - -d DEST, --destination=DEST 19:10:25 INFO - Directory to install application into. [default: 19:10:25 INFO - "/builds/slave/test"] 19:10:25 INFO - --app=APP Application being installed. [default: firefox] 19:10:25 INFO - mkdir: /builds/slave/test/build/application 19:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 19:10:58 INFO - Reading from file tmpfile_stdout 19:10:58 INFO - Output received: 19:10:58 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:10:58 INFO - Running post-action listener: _resource_record_post_action 19:10:58 INFO - [mozharness: 2016-09-29 02:10:58.344466Z] Finished install step (success) 19:10:58 INFO - [mozharness: 2016-09-29 02:10:58.344624Z] Running run-tests step. 19:10:58 INFO - Running pre-action listener: _resource_record_pre_action 19:10:58 INFO - Running main action method: run_tests 19:10:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:10:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:10:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:10:58 INFO - 2016-09-28 19:10:58.359 screenresolution[1969:14089] starting screenresolution argv=screenresolution get 19:10:58 INFO - 2016-09-28 19:10:58.362 screenresolution[1969:14089] Display 0: 1600x1200x32@50 19:10:58 INFO - 2016-09-28 19:10:58.367 screenresolution[1970:14092] starting screenresolution argv=screenresolution list 19:10:58 INFO - Available Modes on Display 0 19:10:58 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 19:10:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:10:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:10:58 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 19:10:58 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 19:10:58 INFO - Graphics/Displays: 19:10:58 INFO - Intel Iris: 19:10:58 INFO - Chipset Model: Intel Iris 19:10:58 INFO - Type: GPU 19:10:58 INFO - Bus: Built-In 19:10:58 INFO - VRAM (Dynamic, Max): 1536 MB 19:10:58 INFO - Vendor: Intel (0x8086) 19:10:58 INFO - Device ID: 0x0a2e 19:10:58 INFO - Revision ID: 0x0009 19:10:58 INFO - Displays: 19:10:58 INFO - Display: 19:10:58 INFO - Resolution: 1600 x 1200 @ 50 Hz 19:10:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:10:58 INFO - Display Serial Number: 1600x1200 50 19:10:58 INFO - Main Display: Yes 19:10:58 INFO - Mirror: Off 19:10:58 INFO - Online: Yes 19:10:58 INFO - Rotation: Supported 19:10:58 INFO - Return code: 0 19:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:58 INFO - Python 2.7.3 19:10:58 INFO - Return code: 0 19:10:58 INFO - grabbing minidump binary from tooltool 19:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d8d30>, '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 0x10073edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:10:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:10:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:10:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:58 INFO - Return code: 0 19:10:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:10:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:10:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--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 19:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0017 --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 19:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BeFfqMN1Zp/Render', 19:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:58 INFO - 'HOME': '/Users/cltbld', 19:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:58 INFO - 'LOGNAME': 'cltbld', 19:10:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:58 INFO - 'MOZ_NO_REMOTE': '1', 19:10:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:58 INFO - 'NO_EM_RESTART': '1', 19:10:58 INFO - 'PAGER': '/bin/cat', 19:10:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:58 INFO - 'PWD': '/builds/slave/test', 19:10:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:58 INFO - 'SHELL': '/bin/bash', 19:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uUbn1wuu95/Listeners', 19:10:58 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 19:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:58 INFO - 'USER': 'cltbld', 19:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:58 INFO - 'XPC_FLAGS': '0x0', 19:10:58 INFO - 'XPC_SERVICE_NAME': '0', 19:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--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 19:10:58 INFO - mozversion application_buildid: 20160928171520 19:10:58 INFO - mozversion application_changeset: 84ef54451749188462d6b97c6b668508893ece47 19:10:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:10:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:58 INFO - mozversion application_name: Firefox 19:10:58 INFO - mozversion application_remotingname: firefox-dev 19:10:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:10:58 INFO - mozversion application_vendor: Mozilla 19:10:58 INFO - mozversion application_version: 51.0a2 19:10:58 INFO - mozversion platform_buildid: 20160928171520 19:10:58 INFO - mozversion platform_changeset: 84ef54451749188462d6b97c6b668508893ece47 19:10:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:10:58 INFO - mozversion platform_version: 51.0a2 19:10:58 INFO - using testdate: 1475115058 19:10:58 INFO - actual date: 1475115058 19:10:58 INFO - starting webserver on 'localhost:51354' 19:10:58 INFO - SUITE-START | Running 2 tests 19:10:58 INFO - TEST-START | dromaeo_css 19:10:58 INFO - operating with platform_type : mac_ 19:10:58 INFO - Initialising browser for dromaeo_css test... 19:10:58 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpevnYno/profile http://localhost:51354/getInfo.html) 19:11:01 INFO - PROCESS | 1980 | __metrics Screen width/height:1600/1200 19:11:01 INFO - PROCESS | 1980 | colorDepth:24 19:11:01 INFO - PROCESS | 1980 | Browser inner width/height: 1024/689 19:11:01 INFO - PROCESS | 1980 | __metrics 19:11:01 INFO - PROCESS | 1980 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:11:01 INFO - PROCESS | 1980 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:11:01 INFO - TEST-INFO | 1980: exit 0 19:11:01 INFO - Browser initialized. 19:11:01 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:01 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpevnYno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:14 INFO - PROCESS | 1982 | RSS: Main: 219656192 19:11:14 INFO - PROCESS | 1982 | 19:12:05 INFO - PROCESS | 1982 | 1475115125187 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] 19:14:17 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51354/tests/dromaeo/cssquery-ext.html) 19:14:18 INFO - PROCESS | 1982 | RSS: Main: 344756224 19:14:18 INFO - PROCESS | 1982 | 19:17:21 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-ext.html (next: http://localhost:51354/tests/dromaeo/cssquery-jquery.html) 19:17:22 INFO - PROCESS | 1982 | RSS: Main: 351793152 19:17:22 INFO - PROCESS | 1982 | 19:20:24 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51354/tests/dromaeo/cssquery-mootools.html) 19:20:25 INFO - PROCESS | 1982 | RSS: Main: 321896448 19:20:25 INFO - PROCESS | 1982 | 19:23:27 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51354/tests/dromaeo/cssquery-prototype.html) 19:23:28 INFO - PROCESS | 1982 | RSS: Main: 325607424 19:23:28 INFO - PROCESS | 1982 | 19:26:31 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51354/tests/dromaeo/cssquery-yui.html) 19:26:32 INFO - PROCESS | 1982 | RSS: Main: 309653504 19:26:32 INFO - PROCESS | 1982 | 19:29:34 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:51354/tests/dromaeo/cssquery-yui.html (next: http://localhost:51354/tests/dromaeo/cssquery-dojo.html) 19:29:35 INFO - PROCESS | 1982 | RSS: Main: 358309888 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | __start_tp_report 19:29:35 INFO - PROCESS | 1982 | _x_x_mozilla_page_load 19:29:35 INFO - PROCESS | 1982 | _x_x_mozilla_page_load_details 19:29:35 INFO - PROCESS | 1982 | |i|pagename|runs| 19:29:35 INFO - PROCESS | 1982 | |0;dojo.html;3260.152360386299;3263.363644089403;3302.55415518905;3315.237495376062;3351.681590248927;5640.097584386499;5685.204071430003;5704.058830293002;5742.167385729067;5771.134329850524;5646.350669672989;5723.771049158028;5731.312242530892;5734;5747.827565173041;5196.350456192976;5207.583393328544;5221.321228240333;5252.894942101156;5264.39459462161;5129.384473863123;5151.845444636667;5320.989012087691;5328.120860058105;5371.623986320959;5193.428722840485;5252.737363131828;5254.81608143715;5262.868428289305;5305.867353316179;5235.450277720842;5258.316418865523;5267.920981185247;5287.259783630295;5327.121025030904;5152.201408781645;5225;5233.319668443078;5265.210218467222;5268.894622107575;5567.832965011056;5600.131979543177;5603.327600687943;5615.634983726086;5704.315482142128;6144.3103146634585;6198.845028874269;6235.625862448268;6243.531735119839;6249.500039996789;6213.347598502138;6260.937390626126;6276.811695649138;6289.937100628981;6293.370662933716;4840.515948405131;5644.491995720405;5656.2929633795775;5791.478766910998;5829.213056237439;6189.381061893775;6272.623642581369;6284.748610055638;6291.591046581958;6308.7476500940365;6152.415520525543;6154.984427569401;6161.106639537242;6170.660613666291;6187.041008643668;6141.692915354214;6209.751609935552;6215.285242197205;6278.560500764994;6293.2762732285455;6105.936962636841;6160.322364539897;6164.969175154096;6172.259328880473;6173.69131543421;6119.136988619962;6162.969185154046;6176.4441200292185;6182.69086545671;6238.500919926395;4885.438174609894;4943.3573635427165;4952.108620448354;4954.727489988085;4975.527324904128;4327.76197309151;4423.314386270134;4439.4228750262255;4439.64482841372;4447.510773814943;5686.488216060575;5744.913826292609;5759.65442073477;5761.135829625506;5773.88452230953;6179.536534759911;6209.0996805462955;6256.718447669866;6260;6261.405166509266;5764.798232061858;5785.334686511021;5800.506956908625;5811.15738217956;5832.445917637818;5435.809746658848;5436.456354364532;5439.809606663827;5440.755166017539;5443.836684899459;6229.626222426669;6230.158928544589;6255.46828519581;6300.621962682254;6309.1167236586;6250.843728906813;6292.968535157295;6298.0552917062805;6314.147590075465;6317.30509643948;5296.761645725875;6237.064440333987;6280.0893870389455;6303.905441418291;6312.210973628296;6051.1830902829315;6101.420365065312;6105.694715264308;6168.629882207082;6176.289726681489;6197.318294987638;6253.78111766086;6275.403836635513;6282.277538083179;6314.905276420765;6212.254529456494;6213.782517611862;6218.315985241529;6222.502199823913;6223.595466294676;5338.54622357104;5733.795902860279;5951.137085122719;6169.598976066542;6206.10011548332;5855.970720146372;5907.763689452374;5973.761049557969;5977.103434484862;6049.939500605114;6160.7535698571555;6168.876622467616;6179.783707570214;6183.3816618337805;6190.938090619036;5909.674967876808;5919.911201331897;5939.851503712269;5967.785315124084;6001.189839371629 19:29:35 INFO - PROCESS | 1982 | |1;ext.html;478.1799214347396;500.21216583880397;514.3365059073795;521.9478052194781;528.3554064041867;29709.851450742743;30358;31625.525617115763;31692;31770;39967.80016099923;41909.533166339184;42037.94905127373;44118;44168;9754.804903901917;9907.653232136876;9915.909249982496;9918.702438926808;9927.503624818766;8707.25988290996;9627.759306017335;9711.562979665896;9725.12473877351;9729.270304727173;8710.782230444258;11930.105242106833;12093.972012378958;12224.327661978588;12346.506139754443;12068.698282542962;12144.878551214551;12156.878431215662;12159;12174.817377739297;8647.524386158759;8862.379633425662;11905.28568285897;12016.459259333351;12016.519339226421;38786.61213387858;39218.803905980574;39244.80377598122;41050.9737256568;41108.38337424941;3388.5594872666643;3392.881249156292;3454.378211921853;3600.981995090034;4033.3546632538946;30734.538981915288;30889.227769305948;31001;31191;31245.843770781226;2744.5059889219933;3210.6307774605752;3215.5980502437196;3267.6895694908944;3294.6540613235506;512066;514487;516442;516757;518358;47804.7609761949;49055.58499735041;55668;56954.430455694914;57030.15243704332;59331.40668593345;60130.69934650299;60453.697731511944;60539.091913621334;60659;16439.753403698953;16517.256723447474;16569.502914912573;16573.585660358345;16579.6684066318;12814.038947079007;12916.741665166644;12950;12951.352432378531;12989.545365912149;12919.935400322938;13307.467701292033;14966.40134394612;15012.024218425768;15077.924610376878;5306.62853600252;6032.306284777219;6189.6286222825875;6250.343713910065;6291.905621415683;874.4185116897193;946.2524605561667;946.8011717539393;1017.5777052523268;1091.3779145886767;29253.561196582068;29293.707062929523;29336.413271734447;29868.253293667833;29878.551821722693;1074.7635520185547;1108.9611863584735;1114.2868564118971;1130.6551501792032;1161.7792619402287;14682;15090.17004064787;15147.469838555598;15368;15388.923055384652;698702;711334;712219.8778012258;956897;961220;49006.26490602644;49745.75127124414;52197.95604087897;56483.71758141265;57030;1394.135635905745;1411.943522259098;1423.0394483723446;1424.7221791750924;1428.071753360324;28951.420971580872;29578.556321654763;29964.850175748983;30412.239694007825;30491.54262686017;48270.758646206545;53441.465585345206;54880;54886;58189;577478;614541;642407;642527;880021;24792.008319667733;24981.375465613506;25066;25254.368640784127;25366.49267014686;44880.87797805081;44890;45058.774706126256;45181;45374.31938520991;36136.27727445384;37041.62958370382;37161.88514344574;37331.64015238642;37333.81333093317;35020.82489587536;36386.63613363833;36678.63321366752;36719;36965.71582830979;36280.45579316365;36593.81703091467;36750.63249367472;36917;36986.075348116516;30575.089585191443;32388.676113238565;32590.51114233241;32593.674063260012;32847.34305313928;24031.63952540748;24721.258362249162;24741.62887556652;25215.243542693748;25305 19:29:35 INFO - PROCESS | 1982 | |2;jquery.html;351.346495518336;370.6867696796208;371.6543614438572;380.94666746655463;399.47469078162214;15140.62148446288;15617.531474055782;16356.509304720848;20655.586888262227;21229.893850530727;20220.89889550554;20814.479638009056;21453.67819482709;21454;21611.45971350717;5874;5943.583949123563;6211.4720248778685;6220.066989951521;6224.595401298901;6102.450779429851;6237.968810155943;6239.625622462667;6240.937590624104;6268.153799237113;3934.5868683788076;4032.4757781488365;5911;6168.938310616882;6216.47159991399;6238.625682459045;6240.937590624081;6242.0948962400425;6331.366863313678;6830.282820303846;5091.541761241506;6057.182280392135;6063.393660633946;6064.241969753781;6068.029115341524;12916.677083072904;21405.250816221513;24019;26135.215943521725;26299.816508257176;2074.917003319865;2273.624851899435;2403.567357875582;2503.3616427810975;2591.494658541585;9031.45811251327;9932.90067099327;9956.900430995669;10367.170626349875;10477.9476102619;1859.2562974810048;1887.7168424736262;1903.1245627011592;1915.7605299337583;1932.2464238946823;125860.37069814684;131693;132713.33643331818;134364.32817835847;139199;9328.160465558132;9769.267304952156;9882.456464894356;9908.405495670282;10033.588579882875;12404.379781010914;12477.812832807514;12487.562935297403;12495.312757798227;12496.312702801433;8058.113607503287;8144.5520496373265;8146.881810729253;8243.711470098639;8268.710595129141;7842.607869606497;7952.562609056442;8632.352573556882;8651;8804.955975220082;3810.352240119131;3898.96101038986;3900.356441187229;3942.014496375906;3943.1127996200626;1865.869389142747;1910.2836436336374;1911.684572045597;1913.9234430622898;1916.317155981637;852.9317654587618;908.2688435809237;911.6854685133751;934.1732566678403;965.358036905464;17664.823351766318;20669.58660826775;21991.450213744465;21995.120195192332;22044.228452004103;910.7022492947523;928.5450129436663;959.1511512311655;977.6138425321958;988.5205675247499;10960.177986651033;11052.944735276273;11380.837640848213;11407.942960285145;11569.363684997237;589397;597467;632028;644455;650042;101786.47320290054;108292.45853770681;122617.38691306664;123109.38445307895;148109.25945370205;929.4934260827865;946.4747065378781;979.8530220466987;981.1856159387692;981.7692842182081;19257.037148142816;20057.997100145225;20125.496862577966;20156.193752250332;20224.797752022292;44925.42761003349;56577.15134272907;58235.70882145562;59020.1146982787;60083.699581501816;79729.60135199287;79913.20086799057;80562;88003;88964;6054.940385432444;7569.318761311509;7995.2804247618;8241.464304820167;8436.072032076589;11731.706707332385;12817.743645127232;13180.736385272432;13224.404901779251;13324.933375333061;8720.476771393736;11181.217314787888;11461.770764584828;11655.53377864876;11676;10852.565897364017;11054.281471704313;11091.667249982513;11480.94259528697;11866.584669536871;11251.21241513119;11523.711907202387;11831.526738930346;11874.406279686154;11934.22427542207;7915.802104947192;7995.440319177835;8027.237412445808;8285.83428331418;8375.288100511281;8258.25675689191;11045.723856903642;11167.162462815159;11411.858814118521;11626.01178899803 19:29:35 INFO - PROCESS | 1982 | |3;mootools.html;1499.227897632719;1526.7328217561926;1715.7340612205112;1877.14589861613;1893.3941138835569;8716.782080447992;9230.400023998436;9231.723048308562;9232.67685631003;9234.722958311244;8133.959330203355;8338.791530211747;8397.874031889527;8488.618012189467;8747;2236.825666525071;2394.114177754229;2434.732179460258;2436.6954130733657;2438.17102185257;2247.4718441166315;2391.5695174868515;2427.4295540547955;2430.3559556717482;2437.6465412515176;2403.0748161957686;2426.2721183644926;2433.0024689877155;2433.634954756783;2434.050720219116;2391.091385273602;2398.736139024706;2399.748026457214;2399.880005999693;2401.9399515012265;2365.491419344849;2388.4625959159225;2411.240459255329;2411.7105947286263;2414.3843319953476;7837.843243135106;8916.643334266622;9053.954730226307;9153.450792952444;9192.724218273463;5355.357357117132;5526.778928842841;5533.861653458655;5533.861653458655;5546;3593.4070878305047;3674.8530058797614;3798.810059497014;3810.733248672594;3831.8275677594297;1080.573173596425;1086.5490821309147;1088.0425225801323;1108.562117963408;1108.8891110888928;12150.33173175475;12306.953908917752;12310;12313.44589493475;12318.384080796013;4784.210605250164;4838.95161048385;4839.903201935942;4946.975265123651;4968.22992436173;10410.635627752992;10425.165986721044;10429.374237545771;10429.843552346721;10436.321639093434;4673.299005149255;5521.365043020024;5524.309461317335;5528.695921724263;5529.225908372831;4985;5018.824341148115;5029.2958985742025;5038.496150385005;5050.621203409759;4044.4742183515955;4096.836126554964;4097.467329247238;4139.730917490354;4161.271777438936;1299.330844615024;1308.8756568126014;1310.1353106949368;1323.8477575078796;1327.4889167670324;803.2128514056258;908.418612088264;912.5026860361119;932.7947851472801;948.3172116076414;5328.786848526093;5946.67293298864;6048.183495228176;6167.259928808572;6384.361563843579;416.3733580960635;433.34564807140816;437.78110944527737;454.218743760731;454.2731629392945;3971.702122340836;4039.5354534228354;4097.815598298083;4144.564820693844;4153.961509622594;8252.876206856901;11064.05955493776;11064.557417703363;11198.552057917592;11213.439328033566;11173.441327933571;11185.776284474428;11193.99254067138;11200.663980080612;11208.327500350006;8194.344452443791;8316.168383161636;8329.125441828643;8492.278156356655;8497.532635704973;5924.437178468039;5992.280926288873;6074.362191969956;6075.574709770273;6149.661768602769;10220.284580079324;10291.22815788804;10422.895771042497;10429.843552346569;10461.947690261804;10116.29185956976;10475.004874537211;10522.053015228359;10703.839442408525;10709.250352475563;7160.248173941661;7363.484556081023;7379;7586.506877053194;7657.34912532441;8619.913800862161;8663.436876603;8666.869996949925;8758.430702004349;8762.299016078827;7671.424643151674;7692.7692169235015;7720.691172353043;7764.728234511765;7765.650545725569;7603.65783539731;7682.500637458771;7686.346660533917;7745.92254077452;7797.220277972157;6959.547629404073;7108.786736397917;7233.168185658506;7236.674349654173;7247.275272472711;5098.056859481007;5145.819896303611;5184.870378240424;5229.320188375486;5291.7354132294;5120.923186152285;5148.4851514848215;5250.868728281824;5268.710220937885;5409 19:29:35 INFO - PROCESS | 1982 | |4;prototype.html;299.3608645541768;305.0649758490226;309.1190108191654;315.90364938693705;317.8792059017576;4722.890120821608;5341.385740639827;5547.944520554794;5550.833474995751;5558.722063896809;4256.658523059391;5223.37319521657;5382.354117505895;5397.811076612319;5478.342598888139;4148.419221309019;4183.2430379240795;4183.686223533247;4194.622483976442;4198.223328684188;3475.200703838119;4093.1404405074823;4140.503139623234;4160.791960401983;4193.391958166064;3411.522386865841;3823.2353529294114;4071.5724848890736;4129.112240868213;4131.5455299916985;3416.5729283839396;4103.97948010261;4115.92985823685;4132.73137246078;4143.792810359485;3514.1199458289693;3535.3636345457808;3546.219831637036;3554.4668299754985;3558.6975107115927;4047.817848196809;4791.904161916742;4958.339161188472;5166.5866730661455;5339.225812257201;3943.585923478051;4711.4346278446465;4720.12677654635;4733.692309999873;4742.596879265267;5222.138347172712;5738.282714660668;5742.2247996520355;5760.687604627356;5793.826185214451;3330.967400105975;3854.8265328060024;3876.592957739425;3891.4122108797615;3892.260470510594;5051.570616497565;5103.928175083237;5704.172894930211;6028.97507423739;6167.321594624543;3881.3207688654375;3926.3901800261756;3927.7643341399034;3929.1159489115294;3961;3720.1213387239272;3953;4001.6998725095737;4010.6189911958318;4016.477857878457;3872.4191371294532;4521.8191272349395;4697.0840686065885;4704.529547045337;4714.010057887814;5759.971200143972;5769.711514424262;5790.478856902815;5805.506531944832;5852.94147058524;1274.4838340472124;1341.195282830294;1348.9325533723274;1351.986480135186;1354.9322533873465;846.9661213551512;862.6894318045498;872.7163671806688;896.1979028769215;917.9036201198911;5000.774965126578;5420.322459692538;5422.240886275925;5430.8099216527235;5430.972845135749;5018.874528136826;5533.972330138324;5920.875033743575;5942;5964.642121472725;4657.720536767737;5200.075971890425;5531.751071201725;5554.805581804618;5571.498565129158;2654.601809728556;3024.4102400031784;3136.431784107946;3147.1660010097344;3168.8574014169417;5931.614445061057;6173.438023220313;6241.937580624136;6259.499240060784;6290.659444983038;5294.876023146362;6129.854550907146;6139.140520327158;6142.6314421134875;6143.740533190685;5628.577856660767;5929.9110513341475;6243.500519958392;6253.843653908689;6277.591956522811;5942.405759424023;5981.401859813984;5998.050633544203;6018.969905150446;6036.947437871145;4560.6807523473035;5653.349864765604;5895.94104058954;5915.53940944535;5965.940340596539;5691.8979156359055;5872.5025118594485;5907.84796964605;6215.751369945152;6231.2522497300615;3571.7321200910555;3903.5510916244993;3949.4470774091074;4006.138680183658;4009.0378309205;5018.322526458881;5564;5688.77244910199;6114.266288045463;6137.171481849893;4885.5358740919555;5464.672119672832;5820.526276332457;5863.824085277449;5866.853328666817;4913.287573301923;5625.578081643975;5781.971090144522;5835.2494251723465;5849.356570777126;4402.427684401007;4730.840943968749;5400.9459905400445;5556.277683901067;5641.689707066151;5830.970845145747;5834.766609335579;5865.560082993878;5872.295324560909;5884;5474.974259524001;5702.315722113207;5708.429157084258;5711.029125048834;5722.942770572241 19:29:35 INFO - PROCESS | 1982 | |5;yui.html;715.5027256057041;757.5871150223128;761.7143571160815;780.3756994404475;827.482823235478;15122.017068890515;16339.264733087024;16404.851660383778;17408.042557659322;17732.556686082855;16554.83445165548;16772.161391930415;16779.496615101536;16782;16787;664.833791552112;683.4361651637395;817.4890693316677;844.0883845446903;848.4951453884929;674.349252970883;821.322409012564;828.5939889454185;841.0748177005306;854.8333075050367;894.5482531321705;898.2185498616213;898.8921329440443;899.3569597737617;900.3517467423477;689.862027594478;891.6032365597312;893.2764460786751;894.8970868350158;895.3866601378077;527.5410392958113;640.2668944059026;653.5229282623663;653.7973228299195;660.2143449295323;15472.45846395382;15542.766858497132;15546.067235965766;15548.844511554853;15597.766033509506;13488.932555337258;13774.173549586956;13774.311284435838;13890;14013.579592612135;12247.632571022883;12547;12549.435275412538;12689.302088385135;12834.935825320907;4500.909981800379;4547.931781023287;4552.248878934972;4579.925207467351;4728.1252968201;120211;120236;120293.79706202913;124635;125020;10715.089217416451;10846.837297440545;10877.510512026978;10892.455377231106;11333.546658133582;21413.892930535247;21464.678029829563;21499.67750483744;21509.354719358445;21555.137794488357;7834.960825195952;7868.173841746534;7911.011123609549;7938.682452701827;8005.199480051948;4372.912541749147;4415.183191109655;4456.62118719906;4546.727196368229;4703.858884233478;3646.4712616670963;3813.142043040349;3814.8855534334016;3816.0459885028745;3828.0812604974603;612.9693515324306;690.4200471603876;696.5576858694766;708.6350529477323;714.1287629092499;558.7988324203284;581.4853854338941;670.4636290967206;671.6910221298258;685.8559702462439;8788.780280493038;9645.469499177612;9731.075547822946;9738.415695058318;9853.901460985298;627.5481653209682;677.2719326723792;681.3016657925567;686.7459040155175;688.2291833146908;4455.554444555519;4558.566936141061;4773.904521909542;4799.592034677022;4833.419989601271;164076;166435;167509.8122546946;169723;169736;133421;134980.65019349876;136969;138852;139547;84615;103375.4831225839;120689.79310206785;122787;124875.75124248641;8996.093187651128;9128.863067054132;9233.907660923573;9246.815063698554;9383.530823458663;64617.5333582741;64854.67572662106;65292.67353663201;67702;68403.97394038994;90426.28721138377;93270.53364733132;94756.63108422345;95685;95938;11607.941960290145;11654.650360489199;11970.521179152736;11996.880031199926;12004.819927700917;12364.752704945671;12401.503939842305;12404;14669.926650367106;14868.702625947637;12065.155439119528;13243.337833108499;14370.3533341002;14429.134251944917;15159.242037898282;13193.670158245737;13811;13825.308734563432;14172.29138543048;14596.197209153599;13634.522791702242;13814.792778108136;13871.791923121364;13993.790093148407;14146.858531414555;11419.60031398897;11421.257618254787;11608.361540115375;11612.593559225386;12151.817722734342;11519.963203311741;11681.474333654836;11826;11854.881451185378;11926.165168438472 19:29:35 INFO - PROCESS | 1982 | __end_tp_report 19:29:35 INFO - PROCESS | 1982 | __start_cc_report 19:29:35 INFO - PROCESS | 1982 | _x_x_mozilla_cycle_collect,1207 19:29:35 INFO - PROCESS | 1982 | __end_cc_report 19:29:35 INFO - PROCESS | 1982 | __startTimestamp1475116175184__endTimestamp 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | ------- Summary: start ------- 19:29:35 INFO - PROCESS | 1982 | Number of tests: 6 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | [#0] dojo.html Cycles:165 Average:5739.31 Median:5939.85 stddev:643.86 (10.8%) stddev-sans-first:615.76 19:29:35 INFO - PROCESS | 1982 | Values: 3260.2 3263.4 3302.6 3315.2 3351.7 5640.1 5685.2 5704.1 5742.2 5771.1 5646.4 5723.8 5731.3 5734.0 5747.8 5196.4 5207.6 5221.3 5252.9 5264.4 5129.4 5151.8 5321.0 5328.1 5371.6 5193.4 5252.7 5254.8 5262.9 5305.9 5235.5 5258.3 5267.9 5287.3 5327.1 5152.2 5225.0 5233.3 5265.2 5268.9 5567.8 5600.1 5603.3 5615.6 5704.3 6144.3 6198.8 6235.6 6243.5 6249.5 6213.3 6260.9 6276.8 6289.9 6293.4 4840.5 5644.5 5656.3 5791.5 5829.2 6189.4 6272.6 6284.7 6291.6 6308.7 6152.4 6155.0 6161.1 6170.7 6187.0 6141.7 6209.8 6215.3 6278.6 6293.3 6105.9 6160.3 6165.0 6172.3 6173.7 6119.1 6163.0 6176.4 6182.7 6238.5 4885.4 4943.4 4952.1 4954.7 4975.5 4327.8 4423.3 4439.4 4439.6 4447.5 5686.5 5744.9 5759.7 5761.1 5773.9 6179.5 6209.1 6256.7 6260.0 6261.4 5764.8 5785.3 5800.5 5811.2 5832.4 5435.8 5436.5 5439.8 5440.8 5443.8 6229.6 6230.2 6255.5 6300.6 6309.1 6250.8 6293.0 6298.1 6314.1 6317.3 5296.8 6237.1 6280.1 6303.9 6312.2 6051.2 6101.4 6105.7 6168.6 6176.3 6197.3 6253.8 6275.4 6282.3 6314.9 6212.3 6213.8 6218.3 6222.5 6223.6 5338.5 5733.8 5951.1 6169.6 6206.1 5856.0 5907.8 5973.8 5977.1 6049.9 6160.8 6168.9 6179.8 6183.4 6190.9 5909.7 5919.9 5939.9 5967.8 6001.2 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | [#1] ext.html Cycles:180 Average:77381.35 Median:36333.55 stddev:183837.84 (506.0%) stddev-sans-first:184262.87 19:29:35 INFO - PROCESS | 1982 | Values: 478.2 500.2 514.3 521.9 528.4 29709.9 30358.0 31625.5 31692.0 31770.0 39967.8 41909.5 42037.9 44118.0 44168.0 9754.8 9907.7 9915.9 9918.7 9927.5 8707.3 9627.8 9711.6 9725.1 9729.3 8710.8 11930.1 12094.0 12224.3 12346.5 12068.7 12144.9 12156.9 12159.0 12174.8 8647.5 8862.4 11905.3 12016.5 12016.5 38786.6 39218.8 39244.8 41051.0 41108.4 3388.6 3392.9 3454.4 3601.0 4033.4 30734.5 30889.2 31001.0 31191.0 31245.8 2744.5 3210.6 3215.6 3267.7 3294.7 512066.0 514487.0 516442.0 516757.0 518358.0 47804.8 49055.6 55668.0 56954.4 57030.2 59331.4 60130.7 60453.7 60539.1 60659.0 16439.8 16517.3 16569.5 16573.6 16579.7 12814.0 12916.7 12950.0 12951.4 12989.5 12919.9 13307.5 14966.4 15012.0 15077.9 5306.6 6032.3 6189.6 6250.3 6291.9 874.4 946.3 946.8 1017.6 1091.4 29253.6 29293.7 29336.4 29868.3 29878.6 1074.8 1109.0 1114.3 1130.7 1161.8 14682.0 15090.2 15147.5 15368.0 15388.9 698702.0 711334.0 712219.9 956897.0 961220.0 49006.3 49745.8 52198.0 56483.7 57030.0 1394.1 1411.9 1423.0 1424.7 1428.1 28951.4 29578.6 29964.9 30412.2 30491.5 48270.8 53441.5 54880.0 54886.0 58189.0 577478.0 614541.0 642407.0 642527.0 880021.0 24792.0 24981.4 25066.0 25254.4 25366.5 44880.9 44890.0 45058.8 45181.0 45374.3 36136.3 37041.6 37161.9 37331.6 37333.8 35020.8 36386.6 36678.6 36719.0 36965.7 36280.5 36593.8 36750.6 36917.0 36986.1 30575.1 32388.7 32590.5 32593.7 32847.3 24031.6 24721.3 24741.6 25215.2 25305.0 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | [#2] jquery.html Cycles:180 Average:35935.64 Median:3854.66 stddev:104131.97 (2701.5%) stddev-sans-first:104389.81 19:29:35 INFO - PROCESS | 1982 | Values: 351.3 370.7 371.7 380.9 399.5 15140.6 15617.5 16356.5 20655.6 21229.9 20220.9 20814.5 21453.7 21454.0 21611.5 5874.0 5943.6 6211.5 6220.1 6224.6 6102.5 6238.0 6239.6 6240.9 6268.2 3934.6 4032.5 5911.0 6168.9 6216.5 6238.6 6240.9 6242.1 6331.4 6830.3 5091.5 6057.2 6063.4 6064.2 6068.0 12916.7 21405.3 24019.0 26135.2 26299.8 2074.9 2273.6 2403.6 2503.4 2591.5 9031.5 9932.9 9956.9 10367.2 10477.9 1859.3 1887.7 1903.1 1915.8 1932.2 125860.4 131693.0 132713.3 134364.3 139199.0 9328.2 9769.3 9882.5 9908.4 10033.6 12404.4 12477.8 12487.6 12495.3 12496.3 8058.1 8144.6 8146.9 8243.7 8268.7 7842.6 7952.6 8632.4 8651.0 8805.0 3810.4 3899.0 3900.4 3942.0 3943.1 1865.9 1910.3 1911.7 1913.9 1916.3 852.9 908.3 911.7 934.2 965.4 17664.8 20669.6 21991.5 21995.1 22044.2 910.7 928.5 959.2 977.6 988.5 10960.2 11052.9 11380.8 11407.9 11569.4 589397.0 597467.0 632028.0 644455.0 650042.0 101786.5 108292.5 122617.4 123109.4 148109.3 929.5 946.5 979.9 981.2 981.8 19257.0 20058.0 20125.5 20156.2 20224.8 44925.4 56577.2 58235.7 59020.1 60083.7 79729.6 79913.2 80562.0 88003.0 88964.0 6054.9 7569.3 7995.3 8241.5 8436.1 11731.7 12817.7 13180.7 13224.4 13324.9 8720.5 11181.2 11461.8 11655.5 11676.0 10852.6 11054.3 11091.7 11480.9 11866.6 11251.2 11523.7 11831.5 11874.4 11934.2 7915.8 7995.4 8027.2 8285.8 8375.3 8258.3 11045.7 11167.2 11411.9 11626.0 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | [#3] mootools.html Cycles:180 Average:5871.24 Median:4811.58 stddev:3326.47 (69.1%) stddev-sans-first:3319.58 19:29:35 INFO - PROCESS | 1982 | Values: 1499.2 1526.7 1715.7 1877.1 1893.4 8716.8 9230.4 9231.7 9232.7 9234.7 8134.0 8338.8 8397.9 8488.6 8747.0 2236.8 2394.1 2434.7 2436.7 2438.2 2247.5 2391.6 2427.4 2430.4 2437.6 2403.1 2426.3 2433.0 2433.6 2434.1 2391.1 2398.7 2399.7 2399.9 2401.9 2365.5 2388.5 2411.2 2411.7 2414.4 7837.8 8916.6 9054.0 9153.5 9192.7 5355.4 5526.8 5533.9 5533.9 5546.0 3593.4 3674.9 3798.8 3810.7 3831.8 1080.6 1086.5 1088.0 1108.6 1108.9 12150.3 12307.0 12310.0 12313.4 12318.4 4784.2 4839.0 4839.9 4947.0 4968.2 10410.6 10425.2 10429.4 10429.8 10436.3 4673.3 5521.4 5524.3 5528.7 5529.2 4985.0 5018.8 5029.3 5038.5 5050.6 4044.5 4096.8 4097.5 4139.7 4161.3 1299.3 1308.9 1310.1 1323.8 1327.5 803.2 908.4 912.5 932.8 948.3 5328.8 5946.7 6048.2 6167.3 6384.4 416.4 433.3 437.8 454.2 454.3 3971.7 4039.5 4097.8 4144.6 4154.0 8252.9 11064.1 11064.6 11198.6 11213.4 11173.4 11185.8 11194.0 11200.7 11208.3 8194.3 8316.2 8329.1 8492.3 8497.5 5924.4 5992.3 6074.4 6075.6 6149.7 10220.3 10291.2 10422.9 10429.8 10461.9 10116.3 10475.0 10522.1 10703.8 10709.3 7160.2 7363.5 7379.0 7586.5 7657.3 8619.9 8663.4 8666.9 8758.4 8762.3 7671.4 7692.8 7720.7 7764.7 7765.7 7603.7 7682.5 7686.3 7745.9 7797.2 6959.5 7108.8 7233.2 7236.7 7247.3 5098.1 5145.8 5184.9 5229.3 5291.7 5120.9 5148.5 5250.9 5268.7 5409.0 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | [#4] prototype.html Cycles:180 Average:4662.65 Median:5317.05 stddev:1465.83 (27.6%) stddev-sans-first:1432.89 19:29:35 INFO - PROCESS | 1982 | Values: 299.4 305.1 309.1 315.9 317.9 4722.9 5341.4 5547.9 5550.8 5558.7 4256.7 5223.4 5382.4 5397.8 5478.3 4148.4 4183.2 4183.7 4194.6 4198.2 3475.2 4093.1 4140.5 4160.8 4193.4 3411.5 3823.2 4071.6 4129.1 4131.5 3416.6 4104.0 4115.9 4132.7 4143.8 3514.1 3535.4 3546.2 3554.5 3558.7 4047.8 4791.9 4958.3 5166.6 5339.2 3943.6 4711.4 4720.1 4733.7 4742.6 5222.1 5738.3 5742.2 5760.7 5793.8 3331.0 3854.8 3876.6 3891.4 3892.3 5051.6 5103.9 5704.2 6029.0 6167.3 3881.3 3926.4 3927.8 3929.1 3961.0 3720.1 3953.0 4001.7 4010.6 4016.5 3872.4 4521.8 4697.1 4704.5 4714.0 5760.0 5769.7 5790.5 5805.5 5852.9 1274.5 1341.2 1348.9 1352.0 1354.9 847.0 862.7 872.7 896.2 917.9 5000.8 5420.3 5422.2 5430.8 5431.0 5018.9 5534.0 5920.9 5942.0 5964.6 4657.7 5200.1 5531.8 5554.8 5571.5 2654.6 3024.4 3136.4 3147.2 3168.9 5931.6 6173.4 6241.9 6259.5 6290.7 5294.9 6129.9 6139.1 6142.6 6143.7 5628.6 5929.9 6243.5 6253.8 6277.6 5942.4 5981.4 5998.1 6019.0 6036.9 4560.7 5653.3 5895.9 5915.5 5965.9 5691.9 5872.5 5907.8 6215.8 6231.3 3571.7 3903.6 3949.4 4006.1 4009.0 5018.3 5564.0 5688.8 6114.3 6137.2 4885.5 5464.7 5820.5 5863.8 5866.9 4913.3 5625.6 5782.0 5835.2 5849.4 4402.4 4730.8 5400.9 5556.3 5641.7 5831.0 5834.8 5865.6 5872.3 5884.0 5475.0 5702.3 5708.4 5711.0 5722.9 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - PROCESS | 1982 | [#5] yui.html Cycles:180 Average:26295.28 Median:3814.01 stddev:42886.95 (1124.5%) stddev-sans-first:42964.26 19:29:35 INFO - PROCESS | 1982 | Values: 715.5 757.6 761.7 780.4 827.5 15122.0 16339.3 16404.9 17408.0 17732.6 16554.8 16772.2 16779.5 16782.0 16787.0 664.8 683.4 817.5 844.1 848.5 674.3 821.3 828.6 841.1 854.8 894.5 898.2 898.9 899.4 900.4 689.9 891.6 893.3 894.9 895.4 527.5 640.3 653.5 653.8 660.2 15472.5 15542.8 15546.1 15548.8 15597.8 13488.9 13774.2 13774.3 13890.0 14013.6 12247.6 12547.0 12549.4 12689.3 12834.9 4500.9 4547.9 4552.2 4579.9 4728.1 120211.0 120236.0 120293.8 124635.0 125020.0 10715.1 10846.8 10877.5 10892.5 11333.5 21413.9 21464.7 21499.7 21509.4 21555.1 7835.0 7868.2 7911.0 7938.7 8005.2 4372.9 4415.2 4456.6 4546.7 4703.9 3646.5 3813.1 3814.9 3816.0 3828.1 613.0 690.4 696.6 708.6 714.1 558.8 581.5 670.5 671.7 685.9 8788.8 9645.5 9731.1 9738.4 9853.9 627.5 677.3 681.3 686.7 688.2 4455.6 4558.6 4773.9 4799.6 4833.4 164076.0 166435.0 167509.8 169723.0 169736.0 133421.0 134980.7 136969.0 138852.0 139547.0 84615.0 103375.5 120689.8 122787.0 124875.8 8996.1 9128.9 9233.9 9246.8 9383.5 64617.5 64854.7 65292.7 67702.0 68404.0 90426.3 93270.5 94756.6 95685.0 95938.0 11607.9 11654.7 11970.5 11996.9 12004.8 12364.8 12401.5 12404.0 14669.9 14868.7 12065.2 13243.3 14370.4 14429.1 15159.2 13193.7 13811.0 13825.3 14172.3 14596.2 13634.5 13814.8 13871.8 13993.8 14146.9 11419.6 11421.3 11608.4 11612.6 12151.8 11520.0 11681.5 11826.0 11854.9 11926.2 19:29:35 INFO - PROCESS | 1982 | -------- Summary: end -------- 19:29:35 INFO - PROCESS | 1982 | 19:29:35 INFO - TEST-INFO | 1982: exit 0 19:29:35 INFO - TEST-OK | dromaeo_css | took 1116837ms 19:29:35 INFO - TEST-START | kraken 19:29:35 INFO - operating with platform_type : mac_ 19:29:35 INFO - Initialising browser for kraken test... 19:29:35 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpwiaujF/profile http://localhost:51354/getInfo.html) 19:29:38 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 19:29:38 INFO - PROCESS | 1985 | colorDepth:24 19:29:38 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 19:29:38 INFO - PROCESS | 1985 | __metrics 19:29:38 INFO - PROCESS | 1985 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:29:38 INFO - PROCESS | 1985 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:29:38 INFO - TEST-INFO | 1985: exit 0 19:29:38 INFO - Browser initialized. 19:29:38 INFO - Running cycle 1/1 for kraken test... 19:29:38 INFO - TEST-INFO | started process 1986 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpwiaujF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:50 INFO - PROCESS | 1986 | RSS: Main: 219746304 19:29:50 INFO - PROCESS | 1986 | 19:29:53 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:54 INFO - PROCESS | 1986 | RSS: Main: 269099008 19:29:54 INFO - PROCESS | 1986 | 19:29:57 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-dft) 19:29:57 INFO - PROCESS | 1986 | RSS: Main: 279298048 19:29:57 INFO - PROCESS | 1986 | 19:30:00 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-fft) 19:30:01 INFO - PROCESS | 1986 | RSS: Main: 375808000 19:30:01 INFO - PROCESS | 1986 | 19:30:03 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51354/tests/kraken/driver.html?testName=audio-oscillator) 19:30:04 INFO - PROCESS | 1986 | RSS: Main: 278261760 19:30:04 INFO - PROCESS | 1986 | 19:30:06 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:06 INFO - PROCESS | 1986 | RSS: Main: 279273472 19:30:06 INFO - PROCESS | 1986 | 19:30:09 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51354/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:10 INFO - PROCESS | 1986 | RSS: Main: 316530688 19:30:10 INFO - PROCESS | 1986 | 19:30:13 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51354/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:13 INFO - PROCESS | 1986 | RSS: Main: 317358080 19:30:13 INFO - PROCESS | 1986 | 19:30:16 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51354/tests/kraken/driver.html?testName=json-parse-financial) 19:30:17 INFO - PROCESS | 1986 | RSS: Main: 315072512 19:30:17 INFO - PROCESS | 1986 | 19:30:18 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:19 INFO - PROCESS | 1986 | RSS: Main: 288407552 19:30:19 INFO - PROCESS | 1986 | 19:30:21 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:21 INFO - PROCESS | 1986 | RSS: Main: 293609472 19:30:21 INFO - PROCESS | 1986 | 19:30:23 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:24 INFO - PROCESS | 1986 | RSS: Main: 295845888 19:30:24 INFO - PROCESS | 1986 | 19:30:27 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:28 INFO - PROCESS | 1986 | RSS: Main: 311631872 19:30:28 INFO - PROCESS | 1986 | 19:30:30 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:31 INFO - PROCESS | 1986 | RSS: Main: 307785728 19:30:31 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:51354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51354/tests/kraken/driver.html?testName=ai-astar) 19:30:33 INFO - PROCESS | 1986 | RSS: Main: 351334400 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | __start_tp_report 19:30:33 INFO - PROCESS | 1986 | _x_x_mozilla_page_load 19:30:33 INFO - PROCESS | 1986 | _x_x_mozilla_page_load_details 19:30:33 INFO - PROCESS | 1986 | |i|pagename|runs| 19:30:33 INFO - PROCESS | 1986 | |0;ai-astar;116;116;115;115;115;115;115;114;118;162 19:30:33 INFO - PROCESS | 1986 | |1;audio-beat-detection;144;109;110;142;109;109;108;107;138;110 19:30:33 INFO - PROCESS | 1986 | |2;audio-dft;182;182;186;184;183;184;184;185;185;184 19:30:33 INFO - PROCESS | 1986 | |3;audio-fft;83;60;60;87;62;58;59;58;83;60 19:30:33 INFO - PROCESS | 1986 | |4;audio-oscillator;93;71;95;70;69;70;94;69;68;91 19:30:33 INFO - PROCESS | 1986 | |5;imaging-gaussian-blur;89;85;89;88;88;85;89;86;87;130 19:30:33 INFO - PROCESS | 1986 | |6;imaging-darkroom;95;94;94;95;116;151;149;95;94;93 19:30:33 INFO - PROCESS | 1986 | |7;imaging-desaturate;85;84;83;85;86;84;87;91;84;86 19:30:33 INFO - PROCESS | 1986 | |8;json-parse-financial;56;53;51;53;54;57;56;56;57;57 19:30:33 INFO - PROCESS | 1986 | |9;json-stringify-tinderbox;69;69;71;78;72;69;72;71;71;72 19:30:33 INFO - PROCESS | 1986 | |10;stanford-crypto-aes;84;99;103;100;87;84;85;85;90;85 19:30:33 INFO - PROCESS | 1986 | |11;stanford-crypto-ccm;139;137;139;139;137;139;144;141;176;137 19:30:33 INFO - PROCESS | 1986 | |12;stanford-crypto-pbkdf2;164;162;165;162;164;162;164;164;163;162 19:30:33 INFO - PROCESS | 1986 | |13;stanford-crypto-sha256-iterative;66;67;67;66;67;68;66;66;66;66 19:30:33 INFO - PROCESS | 1986 | __end_tp_report 19:30:33 INFO - PROCESS | 1986 | __start_cc_report 19:30:33 INFO - PROCESS | 1986 | _x_x_mozilla_cycle_collect,1960 19:30:33 INFO - PROCESS | 1986 | __end_cc_report 19:30:33 INFO - PROCESS | 1986 | __startTimestamp1475116233462__endTimestamp 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | ------- Summary: start ------- 19:30:33 INFO - PROCESS | 1986 | Number of tests: 14 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#0] ai-astar Cycles:10 Average:120.10 Median:115.50 stddev:14.76 (12.8%) stddev-sans-first:15.58 19:30:33 INFO - PROCESS | 1986 | Values: 116.0 116.0 115.0 115.0 115.0 115.0 115.0 114.0 118.0 162.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:110.00 stddev:15.78 (14.3%) stddev-sans-first:13.80 19:30:33 INFO - PROCESS | 1986 | Values: 144.0 109.0 110.0 142.0 109.0 109.0 108.0 107.0 138.0 110.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.29 (0.7%) stddev-sans-first:1.17 19:30:33 INFO - PROCESS | 1986 | Values: 182.0 182.0 186.0 184.0 183.0 184.0 184.0 185.0 185.0 184.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.00 stddev:12.06 (19.8%) stddev-sans-first:11.32 19:30:33 INFO - PROCESS | 1986 | Values: 83.0 60.0 60.0 87.0 62.0 58.0 59.0 58.0 83.0 60.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:81.00 stddev:12.33 (15.2%) stddev-sans-first:11.99 19:30:33 INFO - PROCESS | 1986 | Values: 93.0 71.0 95.0 70.0 69.0 70.0 94.0 69.0 68.0 91.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:88.00 stddev:13.58 (15.4%) stddev-sans-first:14.37 19:30:33 INFO - PROCESS | 1986 | Values: 89.0 85.0 89.0 88.0 88.0 85.0 89.0 86.0 87.0 130.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#6] imaging-darkroom Cycles:10 Average:107.60 Median:94.00 stddev:23.36 (24.9%) stddev-sans-first:24.33 19:30:33 INFO - PROCESS | 1986 | Values: 95.0 94.0 94.0 95.0 116.0 151.0 149.0 95.0 94.0 93.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:2.27 (2.7%) stddev-sans-first:2.40 19:30:33 INFO - PROCESS | 1986 | Values: 85.0 84.0 83.0 85.0 86.0 84.0 87.0 91.0 84.0 86.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:2.11 (3.8%) stddev-sans-first:2.20 19:30:33 INFO - PROCESS | 1986 | Values: 56.0 53.0 51.0 53.0 54.0 57.0 56.0 56.0 57.0 57.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:2.63 (3.7%) stddev-sans-first:2.65 19:30:33 INFO - PROCESS | 1986 | Values: 69.0 69.0 71.0 78.0 72.0 69.0 72.0 71.0 71.0 72.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:85.00 stddev:7.50 (8.8%) stddev-sans-first:7.61 19:30:33 INFO - PROCESS | 1986 | Values: 84.0 99.0 103.0 100.0 87.0 84.0 85.0 85.0 90.0 85.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:139.00 stddev:11.86 (8.5%) stddev-sans-first:12.50 19:30:33 INFO - PROCESS | 1986 | Values: 139.0 137.0 139.0 139.0 137.0 139.0 144.0 141.0 176.0 137.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 19:30:33 INFO - PROCESS | 1986 | Values: 164.0 162.0 165.0 162.0 164.0 162.0 164.0 164.0 163.0 162.0 19:30:33 INFO - PROCESS | 1986 | 19:30:33 INFO - PROCESS | 1986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 19:30:33 INFO - PROCESS | 1986 | Values: 66.0 67.0 67.0 66.0 67.0 68.0 66.0 66.0 66.0 66.0 19:30:33 INFO - PROCESS | 1986 | -------- Summary: end -------- 19:30:33 INFO - PROCESS | 1986 | 19:30:34 INFO - TEST-INFO | 1986: exit 0 19:30:34 INFO - TEST-OK | kraken | took 58531ms 19:30:34 INFO - SUITE-END | took 1175s 19:30:34 INFO - Completed test suite (00:19:35) 19:30:34 INFO - javascript benchmark 19:30:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3260.152360386299, 3263.363644089403, 3302.55415518905, 3315.237495376062, 3351.681590248927, 5640.097584386499, 5685.204071430003, 5704.058830293002, 5742.167385729067, 5771.134329850524, 5646.350669672989, 5723.771049158028, 5731.312242530892, 5734.0, 5747.827565173041, 5196.350456192976, 5207.583393328544, 5221.321228240333, 5252.894942101156, 5264.39459462161, 5129.384473863123, 5151.845444636667, 5320.989012087691, 5328.120860058105, 5371.623986320959, 5193.428722840485, 5252.737363131828, 5254.81608143715, 5262.868428289305, 5305.867353316179, 5235.450277720842, 5258.316418865523, 5267.920981185247, 5287.259783630295, 5327.121025030904, 5152.201408781645, 5225.0, 5233.319668443078, 5265.210218467222, 5268.894622107575, 5567.832965011056, 5600.131979543177, 5603.327600687943, 5615.634983726086, 5704.315482142128, 6144.3103146634585, 6198.845028874269, 6235.625862448268, 6243.531735119839, 6249.500039996789, 6213.347598502138, 6260.937390626126, 6276.811695649138, 6289.937100628981, 6293.370662933716, 4840.515948405131, 5644.491995720405, 5656.2929633795775, 5791.478766910998, 5829.213056237439, 6189.381061893775, 6272.623642581369, 6284.748610055638, 6291.591046581958, 6308.7476500940365, 6152.415520525543, 6154.984427569401, 6161.106639537242, 6170.660613666291, 6187.041008643668, 6141.692915354214, 6209.751609935552, 6215.285242197205, 6278.560500764994, 6293.2762732285455, 6105.936962636841, 6160.322364539897, 6164.969175154096, 6172.259328880473, 6173.69131543421, 6119.136988619962, 6162.969185154046, 6176.4441200292185, 6182.69086545671, 6238.500919926395, 4885.438174609894, 4943.3573635427165, 4952.108620448354, 4954.727489988085, 4975.527324904128, 4327.76197309151, 4423.314386270134, 4439.4228750262255, 4439.64482841372, 4447.510773814943, 5686.488216060575, 5744.913826292609, 5759.65442073477, 5761.135829625506, 5773.88452230953, 6179.536534759911, 6209.0996805462955, 6256.718447669866, 6260.0, 6261.405166509266, 5764.798232061858, 5785.334686511021, 5800.506956908625, 5811.15738217956, 5832.445917637818, 5435.809746658848, 5436.456354364532, 5439.809606663827, 5440.755166017539, 5443.836684899459, 6229.626222426669, 6230.158928544589, 6255.46828519581, 6300.621962682254, 6309.1167236586, 6250.843728906813, 6292.968535157295, 6298.0552917062805, 6314.147590075465, 6317.30509643948, 5296.761645725875, 6237.064440333987, 6280.0893870389455, 6303.905441418291, 6312.210973628296, 6051.1830902829315, 6101.420365065312, 6105.694715264308, 6168.629882207082, 6176.289726681489, 6197.318294987638, 6253.78111766086, 6275.403836635513, 6282.277538083179, 6314.905276420765, 6212.254529456494, 6213.782517611862, 6218.315985241529, 6222.502199823913, 6223.595466294676, 5338.54622357104, 5733.795902860279, 5951.137085122719, 6169.598976066542, 6206.10011548332, 5855.970720146372, 5907.763689452374, 5973.761049557969, 5977.103434484862, 6049.939500605114, 6160.7535698571555, 6168.876622467616, 6179.783707570214, 6183.3816618337805, 6190.938090619036, 5909.674967876808, 5919.911201331897, 5939.851503712269, 5967.785315124084, 6001.189839371629], "value": 5697.330606998828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.1799214347396, 500.21216583880397, 514.3365059073795, 521.9478052194781, 528.3554064041867, 29709.851450742743, 30358.0, 31625.525617115763, 31692.0, 31770.0, 39967.80016099923, 41909.533166339184, 42037.94905127373, 44118.0, 44168.0, 9754.804903901917, 9907.653232136876, 9915.909249982496, 9918.702438926808, 9927.503624818766, 8707.25988290996, 9627.759306017335, 9711.562979665896, 9725.12473877351, 9729.270304727173, 8710.782230444258, 11930.105242106833, 12093.972012378958, 12224.327661978588, 12346.506139754443, 12068.698282542962, 12144.878551214551, 12156.878431215662, 12159.0, 12174.817377739297, 8647.524386158759, 8862.379633425662, 11905.28568285897, 12016.459259333351, 12016.519339226421, 38786.61213387858, 39218.803905980574, 39244.80377598122, 41050.9737256568, 41108.38337424941, 3388.5594872666643, 3392.881249156292, 3454.378211921853, 3600.981995090034, 4033.3546632538946, 30734.538981915288, 30889.227769305948, 31001.0, 31191.0, 31245.843770781226, 2744.5059889219933, 3210.6307774605752, 3215.5980502437196, 3267.6895694908944, 3294.6540613235506, 512066.0, 514487.0, 516442.0, 516757.0, 518358.0, 47804.7609761949, 49055.58499735041, 55668.0, 56954.430455694914, 57030.15243704332, 59331.40668593345, 60130.69934650299, 60453.697731511944, 60539.091913621334, 60659.0, 16439.753403698953, 16517.256723447474, 16569.502914912573, 16573.585660358345, 16579.6684066318, 12814.038947079007, 12916.741665166644, 12950.0, 12951.352432378531, 12989.545365912149, 12919.935400322938, 13307.467701292033, 14966.40134394612, 15012.024218425768, 15077.924610376878, 5306.62853600252, 6032.306284777219, 6189.6286222825875, 6250.343713910065, 6291.905621415683, 874.4185116897193, 946.2524605561667, 946.8011717539393, 1017.5777052523268, 1091.3779145886767, 29253.561196582068, 29293.707062929523, 29336.413271734447, 29868.253293667833, 29878.551821722693, 1074.7635520185547, 1108.9611863584735, 1114.2868564118971, 1130.6551501792032, 1161.7792619402287, 14682.0, 15090.17004064787, 15147.469838555598, 15368.0, 15388.923055384652, 698702.0, 711334.0, 712219.8778012258, 956897.0, 961220.0, 49006.26490602644, 49745.75127124414, 52197.95604087897, 56483.71758141265, 57030.0, 1394.135635905745, 1411.943522259098, 1423.0394483723446, 1424.7221791750924, 1428.071753360324, 28951.420971580872, 29578.556321654763, 29964.850175748983, 30412.239694007825, 30491.54262686017, 48270.758646206545, 53441.465585345206, 54880.0, 54886.0, 58189.0, 577478.0, 614541.0, 642407.0, 642527.0, 880021.0, 24792.008319667733, 24981.375465613506, 25066.0, 25254.368640784127, 25366.49267014686, 44880.87797805081, 44890.0, 45058.774706126256, 45181.0, 45374.31938520991, 36136.27727445384, 37041.62958370382, 37161.88514344574, 37331.64015238642, 37333.81333093317, 35020.82489587536, 36386.63613363833, 36678.63321366752, 36719.0, 36965.71582830979, 36280.45579316365, 36593.81703091467, 36750.63249367472, 36917.0, 36986.075348116516, 30575.089585191443, 32388.676113238565, 32590.51114233241, 32593.674063260012, 32847.34305313928, 24031.63952540748, 24721.258362249162, 24741.62887556652, 25215.243542693748, 25305.0], "value": 19891.128853471422, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.346495518336, 370.6867696796208, 371.6543614438572, 380.94666746655463, 399.47469078162214, 15140.62148446288, 15617.531474055782, 16356.509304720848, 20655.586888262227, 21229.893850530727, 20220.89889550554, 20814.479638009056, 21453.67819482709, 21454.0, 21611.45971350717, 5874.0, 5943.583949123563, 6211.4720248778685, 6220.066989951521, 6224.595401298901, 6102.450779429851, 6237.968810155943, 6239.625622462667, 6240.937590624104, 6268.153799237113, 3934.5868683788076, 4032.4757781488365, 5911.0, 6168.938310616882, 6216.47159991399, 6238.625682459045, 6240.937590624081, 6242.0948962400425, 6331.366863313678, 6830.282820303846, 5091.541761241506, 6057.182280392135, 6063.393660633946, 6064.241969753781, 6068.029115341524, 12916.677083072904, 21405.250816221513, 24019.0, 26135.215943521725, 26299.816508257176, 2074.917003319865, 2273.624851899435, 2403.567357875582, 2503.3616427810975, 2591.494658541585, 9031.45811251327, 9932.90067099327, 9956.900430995669, 10367.170626349875, 10477.9476102619, 1859.2562974810048, 1887.7168424736262, 1903.1245627011592, 1915.7605299337583, 1932.2464238946823, 125860.37069814684, 131693.0, 132713.33643331818, 134364.32817835847, 139199.0, 9328.160465558132, 9769.267304952156, 9882.456464894356, 9908.405495670282, 10033.588579882875, 12404.379781010914, 12477.812832807514, 12487.562935297403, 12495.312757798227, 12496.312702801433, 8058.113607503287, 8144.5520496373265, 8146.881810729253, 8243.711470098639, 8268.710595129141, 7842.607869606497, 7952.562609056442, 8632.352573556882, 8651.0, 8804.955975220082, 3810.352240119131, 3898.96101038986, 3900.356441187229, 3942.014496375906, 3943.1127996200626, 1865.869389142747, 1910.2836436336374, 1911.684572045597, 1913.9234430622898, 1916.317155981637, 852.9317654587618, 908.2688435809237, 911.6854685133751, 934.1732566678403, 965.358036905464, 17664.823351766318, 20669.58660826775, 21991.450213744465, 21995.120195192332, 22044.228452004103, 910.7022492947523, 928.5450129436663, 959.1511512311655, 977.6138425321958, 988.5205675247499, 10960.177986651033, 11052.944735276273, 11380.837640848213, 11407.942960285145, 11569.363684997237, 589397.0, 597467.0, 632028.0, 644455.0, 650042.0, 101786.47320290054, 108292.45853770681, 122617.38691306664, 123109.38445307895, 148109.25945370205, 929.4934260827865, 946.4747065378781, 979.8530220466987, 981.1856159387692, 981.7692842182081, 19257.037148142816, 20057.997100145225, 20125.496862577966, 20156.193752250332, 20224.797752022292, 44925.42761003349, 56577.15134272907, 58235.70882145562, 59020.1146982787, 60083.699581501816, 79729.60135199287, 79913.20086799057, 80562.0, 88003.0, 88964.0, 6054.940385432444, 7569.318761311509, 7995.2804247618, 8241.464304820167, 8436.072032076589, 11731.706707332385, 12817.743645127232, 13180.736385272432, 13224.404901779251, 13324.933375333061, 8720.476771393736, 11181.217314787888, 11461.770764584828, 11655.53377864876, 11676.0, 10852.565897364017, 11054.281471704313, 11091.667249982513, 11480.94259528697, 11866.584669536871, 11251.21241513119, 11523.711907202387, 11831.526738930346, 11874.406279686154, 11934.22427542207, 7915.802104947192, 7995.440319177835, 8027.237412445808, 8285.83428331418, 8375.288100511281, 8258.25675689191, 11045.723856903642, 11167.162462815159, 11411.858814118521, 11626.01178899803], "value": 9480.966653987758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.227897632719, 1526.7328217561926, 1715.7340612205112, 1877.14589861613, 1893.3941138835569, 8716.782080447992, 9230.400023998436, 9231.723048308562, 9232.67685631003, 9234.722958311244, 8133.959330203355, 8338.791530211747, 8397.874031889527, 8488.618012189467, 8747.0, 2236.825666525071, 2394.114177754229, 2434.732179460258, 2436.6954130733657, 2438.17102185257, 2247.4718441166315, 2391.5695174868515, 2427.4295540547955, 2430.3559556717482, 2437.6465412515176, 2403.0748161957686, 2426.2721183644926, 2433.0024689877155, 2433.634954756783, 2434.050720219116, 2391.091385273602, 2398.736139024706, 2399.748026457214, 2399.880005999693, 2401.9399515012265, 2365.491419344849, 2388.4625959159225, 2411.240459255329, 2411.7105947286263, 2414.3843319953476, 7837.843243135106, 8916.643334266622, 9053.954730226307, 9153.450792952444, 9192.724218273463, 5355.357357117132, 5526.778928842841, 5533.861653458655, 5533.861653458655, 5546.0, 3593.4070878305047, 3674.8530058797614, 3798.810059497014, 3810.733248672594, 3831.8275677594297, 1080.573173596425, 1086.5490821309147, 1088.0425225801323, 1108.562117963408, 1108.8891110888928, 12150.33173175475, 12306.953908917752, 12310.0, 12313.44589493475, 12318.384080796013, 4784.210605250164, 4838.95161048385, 4839.903201935942, 4946.975265123651, 4968.22992436173, 10410.635627752992, 10425.165986721044, 10429.374237545771, 10429.843552346721, 10436.321639093434, 4673.299005149255, 5521.365043020024, 5524.309461317335, 5528.695921724263, 5529.225908372831, 4985.0, 5018.824341148115, 5029.2958985742025, 5038.496150385005, 5050.621203409759, 4044.4742183515955, 4096.836126554964, 4097.467329247238, 4139.730917490354, 4161.271777438936, 1299.330844615024, 1308.8756568126014, 1310.1353106949368, 1323.8477575078796, 1327.4889167670324, 803.2128514056258, 908.418612088264, 912.5026860361119, 932.7947851472801, 948.3172116076414, 5328.786848526093, 5946.67293298864, 6048.183495228176, 6167.259928808572, 6384.361563843579, 416.3733580960635, 433.34564807140816, 437.78110944527737, 454.218743760731, 454.2731629392945, 3971.702122340836, 4039.5354534228354, 4097.815598298083, 4144.564820693844, 4153.961509622594, 8252.876206856901, 11064.05955493776, 11064.557417703363, 11198.552057917592, 11213.439328033566, 11173.441327933571, 11185.776284474428, 11193.99254067138, 11200.663980080612, 11208.327500350006, 8194.344452443791, 8316.168383161636, 8329.125441828643, 8492.278156356655, 8497.532635704973, 5924.437178468039, 5992.280926288873, 6074.362191969956, 6075.574709770273, 6149.661768602769, 10220.284580079324, 10291.22815788804, 10422.895771042497, 10429.843552346569, 10461.947690261804, 10116.29185956976, 10475.004874537211, 10522.053015228359, 10703.839442408525, 10709.250352475563, 7160.248173941661, 7363.484556081023, 7379.0, 7586.506877053194, 7657.34912532441, 8619.913800862161, 8663.436876603, 8666.869996949925, 8758.430702004349, 8762.299016078827, 7671.424643151674, 7692.7692169235015, 7720.691172353043, 7764.728234511765, 7765.650545725569, 7603.65783539731, 7682.500637458771, 7686.346660533917, 7745.92254077452, 7797.220277972157, 6959.547629404073, 7108.786736397917, 7233.168185658506, 7236.674349654173, 7247.275272472711, 5098.056859481007, 5145.819896303611, 5184.870378240424, 5229.320188375486, 5291.7354132294, 5120.923186152285, 5148.4851514848215, 5250.868728281824, 5268.710220937885, 5409.0], "value": 4625.851726811791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.3608645541768, 305.0649758490226, 309.1190108191654, 315.90364938693705, 317.8792059017576, 4722.890120821608, 5341.385740639827, 5547.944520554794, 5550.833474995751, 5558.722063896809, 4256.658523059391, 5223.37319521657, 5382.354117505895, 5397.811076612319, 5478.342598888139, 4148.419221309019, 4183.2430379240795, 4183.686223533247, 4194.622483976442, 4198.223328684188, 3475.200703838119, 4093.1404405074823, 4140.503139623234, 4160.791960401983, 4193.391958166064, 3411.522386865841, 3823.2353529294114, 4071.5724848890736, 4129.112240868213, 4131.5455299916985, 3416.5729283839396, 4103.97948010261, 4115.92985823685, 4132.73137246078, 4143.792810359485, 3514.1199458289693, 3535.3636345457808, 3546.219831637036, 3554.4668299754985, 3558.6975107115927, 4047.817848196809, 4791.904161916742, 4958.339161188472, 5166.5866730661455, 5339.225812257201, 3943.585923478051, 4711.4346278446465, 4720.12677654635, 4733.692309999873, 4742.596879265267, 5222.138347172712, 5738.282714660668, 5742.2247996520355, 5760.687604627356, 5793.826185214451, 3330.967400105975, 3854.8265328060024, 3876.592957739425, 3891.4122108797615, 3892.260470510594, 5051.570616497565, 5103.928175083237, 5704.172894930211, 6028.97507423739, 6167.321594624543, 3881.3207688654375, 3926.3901800261756, 3927.7643341399034, 3929.1159489115294, 3961.0, 3720.1213387239272, 3953.0, 4001.6998725095737, 4010.6189911958318, 4016.477857878457, 3872.4191371294532, 4521.8191272349395, 4697.0840686065885, 4704.529547045337, 4714.010057887814, 5759.971200143972, 5769.711514424262, 5790.478856902815, 5805.506531944832, 5852.94147058524, 1274.4838340472124, 1341.195282830294, 1348.9325533723274, 1351.986480135186, 1354.9322533873465, 846.9661213551512, 862.6894318045498, 872.7163671806688, 896.1979028769215, 917.9036201198911, 5000.774965126578, 5420.322459692538, 5422.240886275925, 5430.8099216527235, 5430.972845135749, 5018.874528136826, 5533.972330138324, 5920.875033743575, 5942.0, 5964.642121472725, 4657.720536767737, 5200.075971890425, 5531.751071201725, 5554.805581804618, 5571.498565129158, 2654.601809728556, 3024.4102400031784, 3136.431784107946, 3147.1660010097344, 3168.8574014169417, 5931.614445061057, 6173.438023220313, 6241.937580624136, 6259.499240060784, 6290.659444983038, 5294.876023146362, 6129.854550907146, 6139.140520327158, 6142.6314421134875, 6143.740533190685, 5628.577856660767, 5929.9110513341475, 6243.500519958392, 6253.843653908689, 6277.591956522811, 5942.405759424023, 5981.401859813984, 5998.050633544203, 6018.969905150446, 6036.947437871145, 4560.6807523473035, 5653.349864765604, 5895.94104058954, 5915.53940944535, 5965.940340596539, 5691.8979156359055, 5872.5025118594485, 5907.84796964605, 6215.751369945152, 6231.2522497300615, 3571.7321200910555, 3903.5510916244993, 3949.4470774091074, 4006.138680183658, 4009.0378309205, 5018.322526458881, 5564.0, 5688.77244910199, 6114.266288045463, 6137.171481849893, 4885.5358740919555, 5464.672119672832, 5820.526276332457, 5863.824085277449, 5866.853328666817, 4913.287573301923, 5625.578081643975, 5781.971090144522, 5835.2494251723465, 5849.356570777126, 4402.427684401007, 4730.840943968749, 5400.9459905400445, 5556.277683901067, 5641.689707066151, 5830.970845145747, 5834.766609335579, 5865.560082993878, 5872.295324560909, 5884.0, 5474.974259524001, 5702.315722113207, 5708.429157084258, 5711.029125048834, 5722.942770572241], "value": 4192.966393276154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.5027256057041, 757.5871150223128, 761.7143571160815, 780.3756994404475, 827.482823235478, 15122.017068890515, 16339.264733087024, 16404.851660383778, 17408.042557659322, 17732.556686082855, 16554.83445165548, 16772.161391930415, 16779.496615101536, 16782.0, 16787.0, 664.833791552112, 683.4361651637395, 817.4890693316677, 844.0883845446903, 848.4951453884929, 674.349252970883, 821.322409012564, 828.5939889454185, 841.0748177005306, 854.8333075050367, 894.5482531321705, 898.2185498616213, 898.8921329440443, 899.3569597737617, 900.3517467423477, 689.862027594478, 891.6032365597312, 893.2764460786751, 894.8970868350158, 895.3866601378077, 527.5410392958113, 640.2668944059026, 653.5229282623663, 653.7973228299195, 660.2143449295323, 15472.45846395382, 15542.766858497132, 15546.067235965766, 15548.844511554853, 15597.766033509506, 13488.932555337258, 13774.173549586956, 13774.311284435838, 13890.0, 14013.579592612135, 12247.632571022883, 12547.0, 12549.435275412538, 12689.302088385135, 12834.935825320907, 4500.909981800379, 4547.931781023287, 4552.248878934972, 4579.925207467351, 4728.1252968201, 120211.0, 120236.0, 120293.79706202913, 124635.0, 125020.0, 10715.089217416451, 10846.837297440545, 10877.510512026978, 10892.455377231106, 11333.546658133582, 21413.892930535247, 21464.678029829563, 21499.67750483744, 21509.354719358445, 21555.137794488357, 7834.960825195952, 7868.173841746534, 7911.011123609549, 7938.682452701827, 8005.199480051948, 4372.912541749147, 4415.183191109655, 4456.62118719906, 4546.727196368229, 4703.858884233478, 3646.4712616670963, 3813.142043040349, 3814.8855534334016, 3816.0459885028745, 3828.0812604974603, 612.9693515324306, 690.4200471603876, 696.5576858694766, 708.6350529477323, 714.1287629092499, 558.7988324203284, 581.4853854338941, 670.4636290967206, 671.6910221298258, 685.8559702462439, 8788.780280493038, 9645.469499177612, 9731.075547822946, 9738.415695058318, 9853.901460985298, 627.5481653209682, 677.2719326723792, 681.3016657925567, 686.7459040155175, 688.2291833146908, 4455.554444555519, 4558.566936141061, 4773.904521909542, 4799.592034677022, 4833.419989601271, 164076.0, 166435.0, 167509.8122546946, 169723.0, 169736.0, 133421.0, 134980.65019349876, 136969.0, 138852.0, 139547.0, 84615.0, 103375.4831225839, 120689.79310206785, 122787.0, 124875.75124248641, 8996.093187651128, 9128.863067054132, 9233.907660923573, 9246.815063698554, 9383.530823458663, 64617.5333582741, 64854.67572662106, 65292.67353663201, 67702.0, 68403.97394038994, 90426.28721138377, 93270.53364733132, 94756.63108422345, 95685.0, 95938.0, 11607.941960290145, 11654.650360489199, 11970.521179152736, 11996.880031199926, 12004.819927700917, 12364.752704945671, 12401.503939842305, 12404.0, 14669.926650367106, 14868.702625947637, 12065.155439119528, 13243.337833108499, 14370.3533341002, 14429.134251944917, 15159.242037898282, 13193.670158245737, 13811.0, 13825.308734563432, 14172.29138543048, 14596.197209153599, 13634.522791702242, 13814.792778108136, 13871.791923121364, 13993.790093148407, 14146.858531414555, 11419.60031398897, 11421.257618254787, 11608.361540115375, 11612.593559225386, 12151.817722734342, 11519.963203311741, 11681.474333654836, 11826.0, 11854.881451185378, 11926.165168438472], "value": 8009.229761183495, "unit": "score"}], "name": "dromaeo_css", "value": 7420.308270786203, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 118.0, 162.0], "value": 120.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 110.0, 142.0, 109.0, 109.0, 108.0, 107.0, 138.0, 110.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 186.0, 184.0, 183.0, 184.0, 184.0, 185.0, 185.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 60.0, 87.0, 62.0, 58.0, 59.0, 58.0, 83.0, 60.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 95.0, 70.0, 69.0, 70.0, 94.0, 69.0, 68.0, 91.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 88.0, 88.0, 85.0, 89.0, 86.0, 87.0, 130.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 116.0, 151.0, 149.0, 95.0, 94.0, 93.0], "value": 107.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 85.0, 86.0, 84.0, 87.0, 91.0, 84.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 51.0, 53.0, 54.0, 57.0, 56.0, 56.0, 57.0, 57.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 78.0, 72.0, 69.0, 72.0, 71.0, 71.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 99.0, 103.0, 100.0, 87.0, 84.0, 85.0, 85.0, 90.0, 85.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 139.0, 139.0, 137.0, 139.0, 144.0, 141.0, 176.0, 137.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 165.0, 162.0, 164.0, 162.0, 164.0, 164.0, 163.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1442.4, "alertThreshold": 2.0}]} 19:30:34 INFO - Return code: 0 19:30:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:30:34 INFO - # TBPL SUCCESS # 19:30:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:30:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:30:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:30:34 INFO - 2016-09-28 19:30:34.783 screenresolution[1991:16088] starting screenresolution argv=screenresolution get 19:30:34 INFO - 2016-09-28 19:30:34.785 screenresolution[1991:16088] Display 0: 1600x1200x32@50 19:30:34 INFO - 2016-09-28 19:30:34.791 screenresolution[1992:16091] starting screenresolution argv=screenresolution list 19:30:34 INFO - Available Modes on Display 0 19:30:34 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 19:30:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:30:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:30:34 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 19:30:34 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 19:30:35 INFO - Graphics/Displays: 19:30:35 INFO - Intel Iris: 19:30:35 INFO - Chipset Model: Intel Iris 19:30:35 INFO - Type: GPU 19:30:35 INFO - Bus: Built-In 19:30:35 INFO - VRAM (Dynamic, Max): 1536 MB 19:30:35 INFO - Vendor: Intel (0x8086) 19:30:35 INFO - Device ID: 0x0a2e 19:30:35 INFO - Revision ID: 0x0009 19:30:35 INFO - Displays: 19:30:35 INFO - Display: 19:30:35 INFO - Resolution: 1600 x 1200 @ 50 Hz 19:30:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:30:35 INFO - Display Serial Number: 1600x1200 50 19:30:35 INFO - Main Display: Yes 19:30:35 INFO - Mirror: Off 19:30:35 INFO - Online: Yes 19:30:35 INFO - Rotation: Supported 19:30:35 INFO - Return code: 0 19:30:35 INFO - Running post-action listener: _resource_record_post_action 19:30:35 INFO - [mozharness: 2016-09-29 02:30:35.028262Z] Finished run-tests step (success) 19:30:35 INFO - Running post-run listener: _resource_record_post_run 19:30:35 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 1695744; Write bytes: 659421184; Read time: 14; Write time: 2139 19:30:35 INFO - TinderboxPrint: CPU usage
53.3% 19:30:35 INFO - TinderboxPrint: I/O read bytes / time
1,695,744 / 14 19:30:35 INFO - TinderboxPrint: I/O write bytes / time
659,421,184 / 2,139 19:30:35 INFO - TinderboxPrint: CPU idle
2,257.7 (46.7%) 19:30:35 INFO - TinderboxPrint: CPU system
965.8 (20.0%) 19:30:35 INFO - TinderboxPrint: CPU user
1,614.2 (33.4%) 19:30:35 INFO - TinderboxPrint: Swap in / out
364,535,808 / 0 19:30:35 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 353901056; Write bytes: 355719168; Read time: 27484; Write time: 694 19:30:35 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1695744; Write bytes: 293519360; Read time: 14; Write time: 1409 19:30:35 INFO - Running post-run listener: _upload_blobber_files 19:30:35 INFO - Blob upload gear active. 19:30:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:35 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 19:30:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:30:35 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:36 INFO - (blobuploader) - INFO - Done attempting. 19:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:37 INFO - (blobuploader) - INFO - Done attempting. 19:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:39 INFO - (blobuploader) - INFO - Done attempting. 19:30:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:39 INFO - Return code: 0 19:30:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/271c6e783856731abdcde536a8d56eb10548f812283995cc2b3f9de517b23fce52aa00ebb338a1564044434aaafffd42b30e2e1b07c1565788f3bd935bef1622", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a5a0e6cc8eaf15722a72887b665a89c9eff299101403212656b70763a3332b968d1e164bbc4513a13da9ab0b723f8489a817157ed67a834515154b0472a8184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c786b9c4f417185ba389a1e137f8d7562da0081fb7ab4787073fab6522b1ed1deb6d8dbf615a60e47debfb780fe62dd496becdac9dfd9b514750dd0a8a1b45a"} 19:30:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:39 INFO - Contents: 19:30:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/271c6e783856731abdcde536a8d56eb10548f812283995cc2b3f9de517b23fce52aa00ebb338a1564044434aaafffd42b30e2e1b07c1565788f3bd935bef1622", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a5a0e6cc8eaf15722a72887b665a89c9eff299101403212656b70763a3332b968d1e164bbc4513a13da9ab0b723f8489a817157ed67a834515154b0472a8184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c786b9c4f417185ba389a1e137f8d7562da0081fb7ab4787073fab6522b1ed1deb6d8dbf615a60e47debfb780fe62dd496becdac9dfd9b514750dd0a8a1b45a"} 19:30:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:39 INFO - Copying logs to upload dir... 19:30:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.742632 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-09-28 19:30:40.042698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 19:30:40.048856) ========= 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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/271c6e783856731abdcde536a8d56eb10548f812283995cc2b3f9de517b23fce52aa00ebb338a1564044434aaafffd42b30e2e1b07c1565788f3bd935bef1622", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a5a0e6cc8eaf15722a72887b665a89c9eff299101403212656b70763a3332b968d1e164bbc4513a13da9ab0b723f8489a817157ed67a834515154b0472a8184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c786b9c4f417185ba389a1e137f8d7562da0081fb7ab4787073fab6522b1ed1deb6d8dbf615a60e47debfb780fe62dd496becdac9dfd9b514750dd0a8a1b45a"} build_url:https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/dkzn39puS4KuuC8xBStLmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/271c6e783856731abdcde536a8d56eb10548f812283995cc2b3f9de517b23fce52aa00ebb338a1564044434aaafffd42b30e2e1b07c1565788f3bd935bef1622", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a5a0e6cc8eaf15722a72887b665a89c9eff299101403212656b70763a3332b968d1e164bbc4513a13da9ab0b723f8489a817157ed67a834515154b0472a8184", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c786b9c4f417185ba389a1e137f8d7562da0081fb7ab4787073fab6522b1ed1deb6d8dbf615a60e47debfb780fe62dd496becdac9dfd9b514750dd0a8a1b45a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 19:30:40.081738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:30:40.082114) ========= 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.BeFfqMN1Zp/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.uUbn1wuu95/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005124 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:30:40.131672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 19:30:40.132249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 19:30:40.132736) ========= ========= Total master_lag: 0.27 =========