builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0336 starttime: 1483473523.74 results: success (0) buildid: 20170103104538 builduid: 86579733b48a42be8bdd037c918e820a revision: 51167fd9b8e4d8a3449edd0aa08f95f3257d5469 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.737482) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.737928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.738215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.763402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.763802) ========= 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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-03 11:58:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.47M=0.001s 2017-01-03 11:58:44 (8.47 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125960 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.913071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.913398) ========= 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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.019637 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:43.962277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-03 11:58:43.962638) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 51167fd9b8e4d8a3449edd0aa08f95f3257d5469 --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-beta --rev 51167fd9b8e4d8a3449edd0aa08f95f3257d5469 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8sUUbkB6XA/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.rqIFoNQjpX/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-03 11:58:44,458 truncating revision to first 12 chars 2017-01-03 11:58:44,458 Setting DEBUG logging. 2017-01-03 11:58:44,458 attempt 1/10 2017-01-03 11:58:44,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/51167fd9b8e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 11:58:46,200 unpacking tar archive at: mozilla-beta-51167fd9b8e4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.030468 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-03 11:58:46.016698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:46.017004) ========= script_repo_revision: 51167fd9b8e4d8a3449edd0aa08f95f3257d5469 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:46.017406) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:46.017672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 11:58:46.037541) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-03 11:58:46.037908) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8sUUbkB6XA/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.rqIFoNQjpX/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:58:46 INFO - MultiFileLogger online at 20170103 11:58:46 in /builds/slave/test 11:58:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:58:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:46 INFO - {'append_to_log': False, 11:58:46 INFO - 'base_work_dir': '/builds/slave/test', 11:58:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:58:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:46 INFO - 'branch': 'Mozilla-Beta', 11:58:46 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:46 INFO - 'config_files': ('talos/mac_config.py',), 11:58:46 INFO - 'default_actions': ('clobber', 11:58:46 INFO - 'read-buildbot-config', 11:58:46 INFO - 'download-and-extract', 11:58:46 INFO - 'populate-webroot', 11:58:46 INFO - 'create-virtualenv', 11:58:46 INFO - 'install', 11:58:46 INFO - 'run-tests'), 11:58:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:46 INFO - 'download_minidump_stackwalk': True, 11:58:46 INFO - 'download_symbols': 'ondemand', 11:58:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:58:46 INFO - 'tooltool.py': '/tools/tooltool.py', 11:58:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:58:46 INFO - '/tools/misc-python/virtualenv.py')}, 11:58:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:46 INFO - 'installer_path': 'installer.exe', 11:58:46 INFO - 'log_level': 'info', 11:58:46 INFO - 'log_name': 'talos', 11:58:46 INFO - 'log_to_console': True, 11:58:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:58:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:58:46 INFO - 'opt_config_files': (), 11:58:46 INFO - 'pip_index': False, 11:58:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:46 INFO - 'cmd': ('bash', 11:58:46 INFO - '-c', 11:58:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:46 INFO - 'enabled': True, 11:58:46 INFO - 'halt_on_failure': False, 11:58:46 INFO - 'name': 'check_screen_resolution'},), 11:58:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:46 INFO - 'cmd': ('bash', 11:58:46 INFO - '-c', 11:58:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:46 INFO - 'enabled': True, 11:58:46 INFO - 'halt_on_failure': False, 11:58:46 INFO - 'name': 'check_screen_resolution'},), 11:58:46 INFO - 'run_cmd_checks_enabled': True, 11:58:46 INFO - 'sps_profile': False, 11:58:46 INFO - 'sps_profile_interval': 0, 11:58:46 INFO - 'suite': 'dromaeojs', 11:58:46 INFO - 'system_bits': '32', 11:58:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:46 INFO - 'title': 't-yosemite-r7-0336', 11:58:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:46 INFO - 'use_talos_json': True, 11:58:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:46 INFO - 'work_dir': 'build'} 11:58:46 INFO - [mozharness: 2017-01-03 19:58:46.645952Z] Running clobber step. 11:58:46 INFO - Running pre-action listener: _resource_record_pre_action 11:58:46 INFO - Running main action method: clobber 11:58:46 INFO - rmtree: /builds/slave/test/build 11:58:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:48 INFO - Running post-action listener: _resource_record_post_action 11:58:48 INFO - [mozharness: 2017-01-03 19:58:48.107340Z] Finished clobber step (success) 11:58:48 INFO - [mozharness: 2017-01-03 19:58:48.107500Z] Running read-buildbot-config step. 11:58:48 INFO - Running pre-action listener: _resource_record_pre_action 11:58:48 INFO - Running main action method: read_buildbot_config 11:58:48 INFO - Using buildbot properties: 11:58:48 INFO - { 11:58:48 INFO - "project": "", 11:58:48 INFO - "product": "firefox", 11:58:48 INFO - "script_repo_revision": "production", 11:58:48 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:58:48 INFO - "repository": "", 11:58:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:58:48 INFO - "buildid": "20170103104538", 11:58:48 INFO - "pgo_build": "False", 11:58:48 INFO - "basedir": "/builds/slave/test", 11:58:48 INFO - "buildnumber": 19, 11:58:48 INFO - "slavename": "t-yosemite-r7-0336", 11:58:48 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:58:48 INFO - "platform": "yosemite_r7", 11:58:48 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:58:48 INFO - "branch": "mozilla-beta", 11:58:48 INFO - "repo_path": "releases/mozilla-beta", 11:58:48 INFO - "revision": "51167fd9b8e4d8a3449edd0aa08f95f3257d5469", 11:58:48 INFO - "stage_platform": "macosx64", 11:58:48 INFO - "builduid": "86579733b48a42be8bdd037c918e820a", 11:58:48 INFO - "slavebuilddir": "test" 11:58:48 INFO - } 11:58:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 11:58:48 INFO - Running post-action listener: _resource_record_post_action 11:58:48 INFO - [mozharness: 2017-01-03 19:58:48.110598Z] Finished read-buildbot-config step (success) 11:58:48 INFO - [mozharness: 2017-01-03 19:58:48.110717Z] Running download-and-extract step. 11:58:48 INFO - Running pre-action listener: _resource_record_pre_action 11:58:48 INFO - Running main action method: download_and_extract 11:58:48 INFO - mkdir: /builds/slave/test/build/tests 11:58:48 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')]} 11:58:48 INFO - trying https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 11:58:48 INFO - Downloading https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 11:58:49 INFO - Downloaded 1165 bytes. 11:58:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:58:49 INFO - Using the following test package requirements: 11:58:49 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:58:49 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:58:49 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 11:58:49 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:58:49 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 11:58:49 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:58:49 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:58:49 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 11:58:49 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:58:49 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:58:49 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 11:58:49 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:58:49 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 11:58:49 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:58:49 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 11:58:49 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:58:49 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 11:58:49 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 11:58:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:58:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:58:49 INFO - Fetch https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:58:50 INFO - Expected file size: 16234480 11:58:57 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:58:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:58:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:58:57 INFO - Fetch https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:58:57 INFO - Expected file size: 16234480 11:59:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 11:59:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 11:59:04 INFO - Fetch https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 11:59:04 INFO - Expected file size: 14414089 11:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:05 INFO - trying https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:59:05 INFO - Downloading https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 11:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 11:59:07 INFO - Downloaded 86086471 bytes. 11:59:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:59:07 INFO - mkdir: /builds/slave/test/properties 11:59:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:59:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:59:07 INFO - Contents: 11:59:07 INFO - build_url:https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:59:08 INFO - Running post-action listener: _resource_record_post_action 11:59:08 INFO - Running post-action listener: set_extra_try_arguments 11:59:08 INFO - [mozharness: 2017-01-03 19:59:08.378189Z] Finished download-and-extract step (success) 11:59:08 INFO - [mozharness: 2017-01-03 19:59:08.378307Z] Running populate-webroot step. 11:59:08 INFO - Running pre-action listener: _resource_record_pre_action 11:59:08 INFO - Running main action method: populate_webroot 11:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:59:08 INFO - '--tppagecycles', 11:59:08 INFO - '7'], 11:59:08 INFO - 'tests': ['tsvgm']}}, 11:59:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:59:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:59:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:59:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:59:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:59:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['damp', 'tps']}, 11:59:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'tests': ['damp', 'tps']}, 11:59:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['dromaeo_dom']}, 11:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:59:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['basic_compositor_video']}, 11:59:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:59:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['a11yr', 11:59:08 INFO - 'ts_paint', 11:59:08 INFO - 'tpaint', 11:59:08 INFO - 'sessionrestore', 11:59:08 INFO - 'sessionrestore_no_auto_restore', 11:59:08 INFO - 'tabpaint']}, 11:59:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:59:08 INFO - 'ts_paint', 11:59:08 INFO - 'tpaint', 11:59:08 INFO - 'sessionrestore', 11:59:08 INFO - 'sessionrestore_no_auto_restore', 11:59:08 INFO - 'tabpaint']}, 11:59:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:59:08 INFO - 'ts_paint', 11:59:08 INFO - 'tpaint', 11:59:08 INFO - 'sessionrestore', 11:59:08 INFO - 'sessionrestore_no_auto_restore', 11:59:08 INFO - 'tabpaint']}, 11:59:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:59:08 INFO - 'ts_paint', 11:59:08 INFO - 'tpaint', 11:59:08 INFO - 'sessionrestore', 11:59:08 INFO - 'sessionrestore_no_auto_restore', 11:59:08 INFO - 'tabpaint']}, 11:59:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['a11yr', 11:59:08 INFO - 'ts_paint', 11:59:08 INFO - 'tpaint', 11:59:08 INFO - 'sessionrestore', 11:59:08 INFO - 'sessionrestore_no_auto_restore', 11:59:08 INFO - 'tabpaint']}, 11:59:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['a11yr', 11:59:08 INFO - 'ts_paint', 11:59:08 INFO - 'tpaint', 11:59:08 INFO - 'sessionrestore', 11:59:08 INFO - 'sessionrestore_no_auto_restore', 11:59:08 INFO - 'tabpaint']}, 11:59:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['tsvgx', 11:59:08 INFO - 'tsvgr_opacity', 11:59:08 INFO - 'tart', 11:59:08 INFO - 'tscrollx', 11:59:08 INFO - 'cart']}, 11:59:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:59:08 INFO - 'tsvgr_opacity', 11:59:08 INFO - 'tart', 11:59:08 INFO - 'tscrollx', 11:59:08 INFO - 'cart']}, 11:59:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'talos_options': ['--disable-e10s'], 11:59:08 INFO - 'tests': ['tp5o']}, 11:59:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'tests': ['tp5o']}, 11:59:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'talos_options': ['--disable-e10s', 11:59:08 INFO - '--xperf_path', 11:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:08 INFO - 'tests': ['tp5n']}, 11:59:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:59:08 INFO - 'talos_options': ['--xperf_path', 11:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:59:08 INFO - 'tests': ['tp5n']}}, 11:59:08 INFO - 'talos.zip': {'path': '', 11:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:59:08 INFO - Running post-action listener: _resource_record_post_action 11:59:08 INFO - [mozharness: 2017-01-03 19:59:08.397900Z] Finished populate-webroot step (success) 11:59:08 INFO - [mozharness: 2017-01-03 19:59:08.398029Z] Running create-virtualenv step. 11:59:08 INFO - Running pre-action listener: _resource_record_pre_action 11:59:08 INFO - Running main action method: create_virtualenv 11:59:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:59:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:59:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:59:08 INFO - Using real prefix '/tools/python27' 11:59:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:59:12 INFO - Installing pip.................done. 11:59:12 INFO - Return code: 0 11:59:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:12 INFO - 'HOME': '/Users/cltbld', 11:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:12 INFO - 'LOGNAME': 'cltbld', 11:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:12 INFO - 'MOZ_NO_REMOTE': '1', 11:59:12 INFO - 'NO_EM_RESTART': '1', 11:59:12 INFO - 'PAGER': '/bin/cat', 11:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:12 INFO - 'PWD': '/builds/slave/test', 11:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:12 INFO - 'SHELL': '/bin/bash', 11:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:12 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:12 INFO - 'USER': 'cltbld', 11:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:12 INFO - 'XPC_FLAGS': '0x0', 11:59:12 INFO - 'XPC_SERVICE_NAME': '0', 11:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:59:12 INFO - Cleaning up... 11:59:12 INFO - Return code: 0 11:59:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:12 INFO - 'HOME': '/Users/cltbld', 11:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:12 INFO - 'LOGNAME': 'cltbld', 11:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:12 INFO - 'MOZ_NO_REMOTE': '1', 11:59:12 INFO - 'NO_EM_RESTART': '1', 11:59:12 INFO - 'PAGER': '/bin/cat', 11:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:12 INFO - 'PWD': '/builds/slave/test', 11:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:12 INFO - 'SHELL': '/bin/bash', 11:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:12 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:12 INFO - 'USER': 'cltbld', 11:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:12 INFO - 'XPC_FLAGS': '0x0', 11:59:12 INFO - 'XPC_SERVICE_NAME': '0', 11:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:12 INFO - Downloading/unpacking psutil>=3.1.1 11:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:59:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:16 INFO - Installing collected packages: psutil 11:59:16 INFO - Running setup.py install for psutil 11:59:16 INFO - building 'psutil._psutil_osx' extension 11:59:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:59:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:59:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:59:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:59:16 INFO - building 'psutil._psutil_posix' extension 11:59:16 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 11:59:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:59:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:59:16 INFO - ^ 11:59:16 INFO - 1 warning generated. 11:59:16 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 11:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:16 INFO - Successfully installed psutil 11:59:16 INFO - Cleaning up... 11:59:16 INFO - Return code: 0 11:59:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:59:16 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')]} 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:16 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')]} 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:16 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 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:16 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 11:59:16 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 11:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:16 INFO - 'HOME': '/Users/cltbld', 11:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:16 INFO - 'LOGNAME': 'cltbld', 11:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:16 INFO - 'MOZ_NO_REMOTE': '1', 11:59:16 INFO - 'NO_EM_RESTART': '1', 11:59:16 INFO - 'PAGER': '/bin/cat', 11:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:16 INFO - 'PWD': '/builds/slave/test', 11:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:16 INFO - 'SHELL': '/bin/bash', 11:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:16 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:16 INFO - 'USER': 'cltbld', 11:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:16 INFO - 'XPC_FLAGS': '0x0', 11:59:16 INFO - 'XPC_SERVICE_NAME': '0', 11:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:59:19 INFO - Installing collected packages: mozsystemmonitor 11:59:19 INFO - Running setup.py install for mozsystemmonitor 11:59:20 INFO - Successfully installed mozsystemmonitor 11:59:20 INFO - Cleaning up... 11:59:20 INFO - Return code: 0 11:59:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:20 INFO - 'HOME': '/Users/cltbld', 11:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:20 INFO - 'LOGNAME': 'cltbld', 11:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:20 INFO - 'MOZ_NO_REMOTE': '1', 11:59:20 INFO - 'NO_EM_RESTART': '1', 11:59:20 INFO - 'PAGER': '/bin/cat', 11:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:20 INFO - 'PWD': '/builds/slave/test', 11:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:20 INFO - 'SHELL': '/bin/bash', 11:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:20 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:20 INFO - 'USER': 'cltbld', 11:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:20 INFO - 'XPC_FLAGS': '0x0', 11:59:20 INFO - 'XPC_SERVICE_NAME': '0', 11:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:20 INFO - Downloading/unpacking jsonschema==2.5.1 11:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:59:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:59:23 INFO - warning: no files found matching '*.txt' 11:59:23 INFO - no previously-included directories found matching 'build' 11:59:23 INFO - no previously-included directories found matching 'dist' 11:59:23 INFO - no previously-included directories found matching '.git*' 11:59:23 INFO - Installing collected packages: jsonschema, functools32 11:59:23 INFO - Running setup.py install for functools32 11:59:23 INFO - warning: no files found matching '*.txt' 11:59:23 INFO - no previously-included directories found matching 'build' 11:59:23 INFO - no previously-included directories found matching 'dist' 11:59:23 INFO - no previously-included directories found matching '.git*' 11:59:23 INFO - Successfully installed jsonschema functools32 11:59:23 INFO - Cleaning up... 11:59:23 INFO - Return code: 0 11:59:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:23 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 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:23 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 11:59:23 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 11:59:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:23 INFO - 'HOME': '/Users/cltbld', 11:59:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:23 INFO - 'LOGNAME': 'cltbld', 11:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:23 INFO - 'MOZ_NO_REMOTE': '1', 11:59:23 INFO - 'NO_EM_RESTART': '1', 11:59:23 INFO - 'PAGER': '/bin/cat', 11:59:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:23 INFO - 'PWD': '/builds/slave/test', 11:59:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:23 INFO - 'SHELL': '/bin/bash', 11:59:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:23 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:23 INFO - 'USER': 'cltbld', 11:59:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:23 INFO - 'XPC_FLAGS': '0x0', 11:59:23 INFO - 'XPC_SERVICE_NAME': '0', 11:59:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:59:24 INFO - Cleaning up... 11:59:24 INFO - Return code: 0 11:59:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:24 INFO - 'HOME': '/Users/cltbld', 11:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:24 INFO - 'LOGNAME': 'cltbld', 11:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:24 INFO - 'MOZ_NO_REMOTE': '1', 11:59:24 INFO - 'NO_EM_RESTART': '1', 11:59:24 INFO - 'PAGER': '/bin/cat', 11:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:24 INFO - 'PWD': '/builds/slave/test', 11:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:24 INFO - 'SHELL': '/bin/bash', 11:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:24 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:24 INFO - 'USER': 'cltbld', 11:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:24 INFO - 'XPC_FLAGS': '0x0', 11:59:24 INFO - 'XPC_SERVICE_NAME': '0', 11:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:28 INFO - Downloading docopt-0.6.1.tar.gz 11:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:28 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:28 INFO - Running setup.py install for blobuploader 11:59:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:28 INFO - Running setup.py install for requests 11:59:28 INFO - Running setup.py install for docopt 11:59:29 INFO - Successfully installed blobuploader requests docopt 11:59:29 INFO - Cleaning up... 11:59:29 INFO - Return code: 0 11:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:29 INFO - 'HOME': '/Users/cltbld', 11:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:29 INFO - 'LOGNAME': 'cltbld', 11:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:29 INFO - 'MOZ_NO_REMOTE': '1', 11:59:29 INFO - 'NO_EM_RESTART': '1', 11:59:29 INFO - 'PAGER': '/bin/cat', 11:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:29 INFO - 'PWD': '/builds/slave/test', 11:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:29 INFO - 'SHELL': '/bin/bash', 11:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:29 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:29 INFO - 'USER': 'cltbld', 11:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:29 INFO - 'XPC_FLAGS': '0x0', 11:59:29 INFO - 'XPC_SERVICE_NAME': '0', 11:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:29 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-MyoW0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:29 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-8yfYEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:29 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-a_Il0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:29 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-6Z26Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:29 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-VA1Op6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:29 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-2whaJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-WTuPeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-J1uEoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-d3z3NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-07577Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-vgR2jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-fdddm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-bDxgbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-RgwfCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:30 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Ls7TCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:31 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-UQ4h2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:31 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-kMIliV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:31 INFO - Running setup.py install for manifestparser 11:59:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:31 INFO - Running setup.py install for mozcrash 11:59:31 INFO - Running setup.py install for mozdebug 11:59:31 INFO - Running setup.py install for mozdevice 11:59:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:59:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:31 INFO - Running setup.py install for mozfile 11:59:31 INFO - Running setup.py install for mozhttpd 11:59:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Running setup.py install for mozinfo 11:59:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Running setup.py install for mozInstall 11:59:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Running setup.py install for mozleak 11:59:32 INFO - Running setup.py install for mozlog 11:59:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Running setup.py install for moznetwork 11:59:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:32 INFO - Running setup.py install for mozprocess 11:59:33 INFO - Running setup.py install for mozprofile 11:59:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:33 INFO - Running setup.py install for mozrunner 11:59:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:33 INFO - Running setup.py install for mozscreenshot 11:59:33 INFO - Running setup.py install for moztest 11:59:33 INFO - Running setup.py install for mozversion 11:59:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:33 INFO - Cleaning up... 11:59:33 INFO - Return code: 0 11:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:33 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 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:33 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 11:59:33 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 11:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:33 INFO - 'HOME': '/Users/cltbld', 11:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:33 INFO - 'LOGNAME': 'cltbld', 11:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:33 INFO - 'MOZ_NO_REMOTE': '1', 11:59:33 INFO - 'NO_EM_RESTART': '1', 11:59:33 INFO - 'PAGER': '/bin/cat', 11:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:33 INFO - 'PWD': '/builds/slave/test', 11:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:33 INFO - 'SHELL': '/bin/bash', 11:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:33 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:33 INFO - 'USER': 'cltbld', 11:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:33 INFO - 'XPC_FLAGS': '0x0', 11:59:33 INFO - 'XPC_SERVICE_NAME': '0', 11:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-TJ_Gj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Syx4lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:34 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)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-o09xB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-c6v5e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:34 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)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-J_qbus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:34 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)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-DSvXEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:34 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)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-8johoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:34 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)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-DmtUUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:34 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)) 11:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:34 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-OfHT1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-HrNjx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-OLpQKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-EzuyN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-uq78wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-tciSdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:35 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)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-5JrFCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:35 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)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-ND97vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:35 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)) 11:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:35 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-94RUsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:35 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)) 11:59:35 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)) 11:59:35 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)) 11:59:35 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)) 11:59:35 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)) 11:59:35 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)) 11:59:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:35 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 11:59:35 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 11:59:35 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 11:59:35 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 11:59:35 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 11:59:35 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 11:59:38 INFO - Downloading blessings-1.6.tar.gz 11:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:38 INFO - Installing collected packages: blessings 11:59:38 INFO - Running setup.py install for blessings 11:59:38 INFO - Successfully installed blessings 11:59:38 INFO - Cleaning up... 11:59:38 INFO - Return code: 0 11:59:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:39 INFO - Reading from file tmpfile_stdout 11:59:39 INFO - Current package versions: 11:59:39 INFO - blessings == 1.6 11:59:39 INFO - blobuploader == 1.2.4 11:59:39 INFO - docopt == 0.6.1 11:59:39 INFO - functools32 == 3.2.3-2 11:59:39 INFO - jsonschema == 2.5.1 11:59:39 INFO - manifestparser == 1.1 11:59:39 INFO - mozInstall == 1.12 11:59:39 INFO - mozcrash == 0.17 11:59:39 INFO - mozdebug == 0.1 11:59:39 INFO - mozdevice == 0.48 11:59:39 INFO - mozfile == 1.2 11:59:39 INFO - mozhttpd == 0.7 11:59:39 INFO - mozinfo == 0.9 11:59:39 INFO - mozleak == 0.1 11:59:39 INFO - mozlog == 3.4 11:59:39 INFO - moznetwork == 0.27 11:59:39 INFO - mozprocess == 0.23 11:59:39 INFO - mozprofile == 0.28 11:59:39 INFO - mozrunner == 6.12 11:59:39 INFO - mozscreenshot == 0.1 11:59:39 INFO - mozsystemmonitor == 0.3 11:59:39 INFO - moztest == 0.7 11:59:39 INFO - mozversion == 1.4 11:59:39 INFO - psutil == 3.1.1 11:59:39 INFO - requests == 1.2.3 11:59:39 INFO - wsgiref == 0.1.2 11:59:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:40 INFO - 'HOME': '/Users/cltbld', 11:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:40 INFO - 'LOGNAME': 'cltbld', 11:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:40 INFO - 'MOZ_NO_REMOTE': '1', 11:59:40 INFO - 'NO_EM_RESTART': '1', 11:59:40 INFO - 'PAGER': '/bin/cat', 11:59:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:40 INFO - 'PWD': '/builds/slave/test', 11:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:40 INFO - 'SHELL': '/bin/bash', 11:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:40 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:40 INFO - 'USER': 'cltbld', 11:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:40 INFO - 'XPC_FLAGS': '0x0', 11:59:40 INFO - 'XPC_SERVICE_NAME': '0', 11:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:59:40 INFO - Cleaning up... 11:59:40 INFO - Return code: 0 11:59:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a77490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ed570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff723d66560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, '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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 11:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:40 INFO - 'HOME': '/Users/cltbld', 11:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:40 INFO - 'LOGNAME': 'cltbld', 11:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:40 INFO - 'MOZ_NO_REMOTE': '1', 11:59:40 INFO - 'NO_EM_RESTART': '1', 11:59:40 INFO - 'PAGER': '/bin/cat', 11:59:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:40 INFO - 'PWD': '/builds/slave/test', 11:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:40 INFO - 'SHELL': '/bin/bash', 11:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 11:59:40 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:40 INFO - 'USER': 'cltbld', 11:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:40 INFO - 'XPC_FLAGS': '0x0', 11:59:40 INFO - 'XPC_SERVICE_NAME': '0', 11:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:59:40 INFO - Cleaning up... 11:59:40 INFO - Return code: 0 11:59:40 INFO - Running post-action listener: _resource_record_post_action 11:59:40 INFO - Running post-action listener: _start_resource_monitoring 11:59:40 INFO - Starting resource monitoring. 11:59:40 INFO - [mozharness: 2017-01-03 19:59:40.587267Z] Finished create-virtualenv step (success) 11:59:40 INFO - [mozharness: 2017-01-03 19:59:40.588255Z] Running install step. 11:59:40 INFO - Running pre-action listener: _resource_record_pre_action 11:59:40 INFO - Running main action method: install 11:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:40 INFO - Reading from file tmpfile_stdout 11:59:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:40 INFO - Reading from file tmpfile_stdout 11:59:40 INFO - Output received: 11:59:40 INFO - Usage: mozinstall [options] installer 11:59:40 INFO - Options: 11:59:40 INFO - -h, --help show this help message and exit 11:59:40 INFO - -d DEST, --destination=DEST 11:59:40 INFO - Directory to install application into. [default: 11:59:40 INFO - "/builds/slave/test"] 11:59:40 INFO - --app=APP Application being installed. [default: firefox] 11:59:40 INFO - mkdir: /builds/slave/test/build/application 11:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:00:02 INFO - Reading from file tmpfile_stdout 12:00:02 INFO - Output received: 12:00:02 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:00:02 INFO - Running post-action listener: _resource_record_post_action 12:00:02 INFO - [mozharness: 2017-01-03 20:00:02.613249Z] Finished install step (success) 12:00:02 INFO - [mozharness: 2017-01-03 20:00:02.613388Z] Running run-tests step. 12:00:02 INFO - Running pre-action listener: _resource_record_pre_action 12:00:02 INFO - Running main action method: run_tests 12:00:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:00:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:00:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:00:02 INFO - 2017-01-03 12:00:02.627 screenresolution[1905:15066] starting screenresolution argv=screenresolution get 12:00:02 INFO - 2017-01-03 12:00:02.630 screenresolution[1905:15066] Display 0: 1600x1200x32@60 12:00:02 INFO - 2017-01-03 12:00:02.636 screenresolution[1906:15069] starting screenresolution argv=screenresolution list 12:00:02 INFO - Available Modes on Display 0 12:00:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:00:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:00:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:00:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:00:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:00:02 INFO - Intel Iris: 12:00:02 INFO - Chipset Model: Intel Iris 12:00:02 INFO - Type: GPU 12:00:02 INFO - Bus: Built-In 12:00:02 INFO - VRAM (Dynamic, Max): 1536 MB 12:00:02 INFO - Vendor: Intel (0x8086) 12:00:02 INFO - Device ID: 0x0a2e 12:00:02 INFO - Revision ID: 0x0009 12:00:02 INFO - Displays: 12:00:02 INFO - Display: 12:00:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:00:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:00:02 INFO - Display Serial Number: 1600x1200 60 12:00:02 INFO - Main Display: Yes 12:00:02 INFO - Mirror: Off 12:00:02 INFO - Online: Yes 12:00:02 INFO - Rotation: Supported 12:00:02 INFO - Return code: 0 12:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:00:02 INFO - Python 2.7.3 12:00:02 INFO - Return code: 0 12:00:02 INFO - grabbing minidump binary from tooltool 12:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:00:02 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 0x10988bd30>, '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 0x1096f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109883b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:00:02 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 12:00:02 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 12:00:02 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 12:00:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:00:02 INFO - Return code: 0 12:00:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:00:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:00:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:00:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:00:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--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 12:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0336 --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 12:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8sUUbkB6XA/Render', 12:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:02 INFO - 'HOME': '/Users/cltbld', 12:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:02 INFO - 'LOGNAME': 'cltbld', 12:00:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:02 INFO - 'MOZ_NO_REMOTE': '1', 12:00:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:02 INFO - 'NO_EM_RESTART': '1', 12:00:02 INFO - 'PAGER': '/bin/cat', 12:00:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:02 INFO - 'PWD': '/builds/slave/test', 12:00:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:02 INFO - 'SHELL': '/bin/bash', 12:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqIFoNQjpX/Listeners', 12:00:03 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 12:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:03 INFO - 'USER': 'cltbld', 12:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:03 INFO - 'XPC_FLAGS': '0x0', 12:00:03 INFO - 'XPC_SERVICE_NAME': '0', 12:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:00:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--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 12:00:03 INFO - mozversion application_buildid: 20170103104538 12:00:03 INFO - mozversion application_changeset: 51167fd9b8e4d8a3449edd0aa08f95f3257d5469 12:00:03 INFO - mozversion application_display_name: Firefox 12:00:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:00:03 INFO - mozversion application_name: Firefox 12:00:03 INFO - mozversion application_remotingname: firefox 12:00:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:00:03 INFO - mozversion application_vendor: Mozilla 12:00:03 INFO - mozversion application_version: 51.0 12:00:03 INFO - mozversion platform_buildid: 20170103104538 12:00:03 INFO - mozversion platform_changeset: 51167fd9b8e4d8a3449edd0aa08f95f3257d5469 12:00:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:00:03 INFO - mozversion platform_version: 51.0 12:00:03 INFO - using testdate: 1483473603 12:00:03 INFO - actual date: 1483473603 12:00:03 INFO - starting webserver on 'localhost:53532' 12:00:03 INFO - SUITE-START | Running 2 tests 12:00:03 INFO - TEST-START | dromaeo_css 12:00:03 INFO - operating with platform_type : mac_ 12:00:03 INFO - Initialising browser for dromaeo_css test... 12:00:03 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpMFXAem/profile http://localhost:53532/getInfo.html) Process Process-1: Traceback (most recent call last): File "/tools/python27/lib/python2.7/multiprocessing/process.py", line 258, in _bootstrap self.run() File "/tools/python27/lib/python2.7/multiprocessing/process.py", line 114, in run self._target(*self._args, **self._kwargs) File "/builds/slave/test/build/venv/lib/python2.7/site-packages/mozsystemmonitor/resourcemonitor.py", line 100, in _collect io_diff = [v - io_last[i] for i, v in enumerate(io)] IndexError: list index out of range 12:00:05 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 12:00:05 INFO - PROCESS | 1916 | colorDepth:24 12:00:05 INFO - PROCESS | 1916 | Browser inner width/height: 1024/689 12:00:05 INFO - PROCESS | 1916 | __metrics 12:00:05 INFO - PROCESS | 1916 | 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" 12:00:05 INFO - PROCESS | 1916 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:06 INFO - TEST-INFO | 1916: exit 0 12:00:06 INFO - Browser initialized. 12:00:06 INFO - Running cycle 1/1 for dromaeo_css test... 12:00:06 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpMFXAem/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:18 INFO - PROCESS | 1919 | RSS: Main: 168374272 12:00:18 INFO - PROCESS | 1919 | 12:01:09 INFO - PROCESS | 1919 | 1483473669405 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] 12:03:20 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:53532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53532/tests/dromaeo/cssquery-ext.html) 12:03:21 INFO - PROCESS | 1919 | RSS: Main: 296517632 12:03:21 INFO - PROCESS | 1919 | 12:06:24 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:53532/tests/dromaeo/cssquery-ext.html (next: http://localhost:53532/tests/dromaeo/cssquery-jquery.html) 12:06:25 INFO - PROCESS | 1919 | RSS: Main: 299102208 12:06:25 INFO - PROCESS | 1919 | 12:09:27 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:53532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53532/tests/dromaeo/cssquery-mootools.html) 12:09:28 INFO - PROCESS | 1919 | RSS: Main: 272338944 12:09:28 INFO - PROCESS | 1919 | 12:12:30 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:53532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53532/tests/dromaeo/cssquery-prototype.html) 12:12:30 INFO - PROCESS | 1919 | RSS: Main: 273240064 12:12:30 INFO - PROCESS | 1919 | 12:15:34 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:53532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53532/tests/dromaeo/cssquery-yui.html) 12:15:34 INFO - PROCESS | 1919 | RSS: Main: 267603968 12:15:34 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:53532/tests/dromaeo/cssquery-yui.html (next: http://localhost:53532/tests/dromaeo/cssquery-dojo.html) 12:18:37 INFO - PROCESS | 1919 | RSS: Main: 311848960 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | __start_tp_report 12:18:37 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 12:18:37 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 12:18:37 INFO - PROCESS | 1919 | |i|pagename|runs| 12:18:37 INFO - PROCESS | 1919 | |0;dojo.html;3382.9323413531724;3404.625491195968;3434.7291502144194;3440.3463341965007;3478.0783092480483;5578.525825304849;5608.270924779783;5669.829905102843;5674.829755107348;5677.517411020063;5706.115552089423;5769.596128271022;5811.535077193825;5814.4766970972605;5814.883702325951;4588.885277868063;5225.16397376418;5237.73811309433;5253.369595648527;5255.894882102365;5207.270982062495;5213.765380557865;5345.732713364336;5351.25082488452;5403.135498320269;5279.155335146377;5337.199420086979;5339.546138578206;5345;5350.170723537858;5322.600804939645;5337.946620533784;5343.145096784496;5345.1447768356875;5358.901425207823;5189.117849965477;5294.814681486129;5295.391030031518;5299.390570084451;5314.7608357624;4771.618270538349;5819.0689489681445;5820.767169313222;5831.9416805831825;5832.562557808182;6105.884339886945;6131.381032942593;6146.508279337642;6161.876762464771;6183.567150299481;6236.532260080512;6251.937480625181;6252.3435039320675;6285.120083188357;6289.213848268966;5811.912821307684;5814.97092514539;5856.483214775989;5865.325487568942;5873.618214816023;6156.876862462816;6219.875602487925;6220.813375598739;6276.372362763778;6284.994400895926;5086.186210206423;6111.591738512148;6151.96924015377;6183.258009038944;6191.071339299051;5025.648204625714;5266.3943646480375;6275.215598050244;6286.402791734778;6288.52836037299;6108.3292684140915;6109.053096770008;6139.982816839433;6197.25632924052;6241.96879015602;6247.718852651642;6258.499320054385;6259.280182778948;6259.561830671901;6265.216847894013;5012.649114562018;5014.674046186986;5019.121653710586;5021.07110184617;5036;4392.341148827638;4426.22541055314;4441.844535441309;4450.354698568754;4466.665000125004;5947.078202878561;5956.404359564096;5960.731767070492;5961.254843144607;6002.909956350658;6213.5339849510565;6223.066540018943;6260.499160067184;6267;6277.089821975879;4842.927356089662;5764.365919748824;5800.680962547016;5902.144189092557;5953.077273022688;5384.461553844584;5425.83722488326;5434.429384914527;5441.727913604304;5441.755121019563;6203.2556093268195;6249.6562689052535;6263.906041409291;6304.873902521924;6319.842003949938;6281.246250449975;6285.59143655661;6285.842853928505;6291.716872740646;6294.496440284858;6282.748690052529;6304.495640348669;6307;6322.589031712924;6325.936740632535;6131.141640170291;6151.876962460815;6176.536759742948;6219.253689557282;6232.345603711545;6170.7223174958135;6227.844303892439;6244.344343844013;6276.654783986742;6283.842903927255;5989.2812862456785;6163.7842675506145;6173.660448675366;6190.071489276645;6204.348543403058;6004.729787159501;6177.320494745484;6180;6189.226346706661;6195.597286176384;5911.527077833849;5959.523238140851;6022.698865056642;6071.423214794588;6098.237720284965;6160.3223645398075;6164.969175154096;6182.938170618416;6191.628502289877;6193.1329613855;6040.184575082308;6045.365236650088;6077.4834139098675;6096.420840020191;6097.713357490941 12:18:37 INFO - PROCESS | 1919 | |1;ext.html;470.05753464304075;478.163214374844;487.2155829115125;527.0907684244678;542.6147435320922;26288;41941.580584194184;43299.78350108253;43549.7822510887;45118.54881451184;44733.32900006494;44981.77509112458;45198.096038079304;45251.32123018149;45414.318785218245;9958.452285124333;10177.134943529809;10185.59257629694;10188.949055254714;10199.796004079913;9342.766430839216;9566.426014439121;12275.815862762021;12524.749505009895;12538.059645526622;12489.687757806081;12560.623181304576;12577.371131443437;12579.182353147062;12589.559365422212;12517.561885334015;12583.49666013363;12592.748145037049;12597.937010314981;12598.937005314914;12321.507139714491;12400.317982510958;12404.441800119017;12411.379431028412;12421.75156496865;42244.57755422437;42443;42479.150416991484;42501.149977000285;42586.361204581954;3366.0406784066668;3433.4334834752235;3453.913652158691;3489.4416893296952;3509.94735078974;32446.6755332446;32527.837360813046;32558.674413256038;32583;32893.500469821316;3316.93366132676;3346.0631023313513;3360.8823691170937;3461.273132642148;3474.9305013899834;481052;485126;486935;487318.56340718427;487887;61483;61711;61866.0720089199;61885;62008.68995655083;36232.63767362293;36949.076273093386;37008;37865;38006.80996594999;17464.47606571805;17632.030238337014;17644.735328970077;17666.823331766518;17692.823071769373;12373.93813030929;12795.680107997188;13260.53588124411;13383.598492045254;13388.799168012487;19441.2043540197;19967.700484492743;20235.79764202339;20248.89875550613;20693.482662933548;8156.306713929383;8258.917410825936;8268.462549934235;8278.586070696441;8392.916070839214;742.3986570877606;961.9855702164473;984.818218138237;1031.298716872519;1072.035168348477;31049;31758;31779;31927.521087183246;32373.838130809196;995.6515219673201;1120.803859324615;1129.2998341028451;1149.804533229353;1179.0803173524664;13733.931330343485;15790.763138552931;16544.83455165433;16660.00039997604;16771.413000544922;588800;712294;717791;718501;719473;61927.38072619306;62331.688341558;62342;62448.687756561834;62490.687546561974;1221.1635030004475;1312.343828085957;1414.9504767333094;1419.3683810704345;1459.1026518691142;31392;32813.01560953175;33063.66936330606;33134.502982454804;33680.98957031293;52067.47932520627;52675.736621316646;52754;52787;52851.47148528465;554527;556177;558198;813203;833710;28000;28623.284417889718;28641.7086633073;29310.97411590584;29376.11871643854;48964.020719584696;49553.75223123861;49614.75192624014;50331.231782252326;50407.747961259956;40326.798366007984;40919.795401022806;41977.370339445544;43095.35356969585;43186;35710.4643430354;36033.198340083414;39983.40024899687;41305.58694413018;42572.57427425686;38484.037899052746;40275.194496109325;40813.1837363257;41018.79490602528;41101.383479248434;34576.30847382988;36054.27891442104;36236.81881590575;36438.60827177974;36951.70669026571;23394.415139621644;26717.7328226723;26755.46489070169;26814.06150784713;26835.32911677224 12:18:37 INFO - PROCESS | 1919 | |2;jquery.html;378.5438546551406;380.37618305978197;389.1768908757977;400.1976038043722;409.1265148907082;19486.928218947953;20933.581328373442;20971.266005689802;21246.256381026647;21382.572348553018;20910.16359345628;21196;21503.924803759826;22007.779922200774;22276.443088922784;5887.205227294314;6198.349173336803;6210.378962103776;6266.498680105604;6291.685415729218;4373.650107991369;4473.9776301118445;5915.763369465216;6298.716557754889;6308.306086330523;5516.531094856942;6966.79099627012;6990.126234220723;7056.894146587805;7060.894086588705;6782.152230971154;6990.741666500028;7050.272683192599;7059.011738356634;7059.823504412379;6138.17134686816;6145.3547377525165;6147;6149.446549810538;6151.323354431009;22640.77359226403;26276.343091422677;26354.341141471617;26618.86690566554;26758.732412675818;2291.713535808024;2324.6745455636224;2333.4399744061475;2475.4677744285063;2492.501499700067;15900.212802094047;16596.58508537284;16656;16669;16865.662686746196;1855.4619160443456;1938.0503553258943;1940.1560321260156;1988.5724569217687;2031.817136457711;130486;135047;135504;136351.999999999;137048;8998.685046023358;10766.093154848148;11069.280496767684;11434.199606027498;11623.941880290713;14286.928565357315;14288.357023933948;14290.928545357207;14293.427722950468;14312.85687143136;8908.331875109392;9141.314401419788;9147.908520914838;9179.127982841619;9270.35107542479;9341.626334946526;9368.625254989724;9373.48445835472;9493.382930109521;9563.61745530185;6782.864342713118;6938.757143499954;6939.09328648713;6950.756723514653;6995.965020174866;1802.5854053567753;1843.8340549350355;1845.2157832920955;1855.740196372509;1882.5575989642423;817.8037271054905;820.4402264933445;867.9305655547668;870.4864130163234;925.6991477769752;19169.52076198106;19372.80627193738;23568.528629427314;23876.761232387453;24879.004839806206;930.4556834251903;981.4356744871727;990.3117333453325;997.7206382212992;1041.1358572384902;10063.540786585903;10896.237263391646;11192;11449.313041217554;11693.88306116945;547497;549494;552591;655414;658694;139650;140583;145962;148087;148505;970.3789574672215;1012.372329155928;1073.7530368015243;1074.4788777442934;1075.2903083964545;17766.75632705698;18424.631507370046;20446.69329960022;20992.68510972306;21014.57970840605;57853.84292314215;58869;59034.40965590289;60028;60363.69818151057;87376;89331.66002509838;90492;91516;91591;7896.565688887166;8119.106898241071;8329.50022998622;8557;8642.22220000203;9247.676331328372;9638.722834236394;12950.546730864751;12964.22214667123;13023.869761302645;8685;11285.548578057114;11361.204715669825;11404.315741055563;11424.371659558805;9724.95137524308;11211.943940280247;11224.719382015188;11268.323900565993;11309.264897781617;11727.706807329885;11779.646610601696;11789.82101789814;11925.940370298093;12049.638510844688;7091.219965803861;7537.698492060256;7724.343430808444;8114.823350614246;8587.441816281922;8434.03008653988;10631.362118272928;11894.34581098048;11911.52353905834;11923.422973108207 12:18:37 INFO - PROCESS | 1919 | |3;mootools.html;1398.9650258743525;1525.5499627609854;1547.6827250413662;1766.302310587318;1928.4985903665051;8053.315468185204;8590.355723320752;8733.083026282236;9028;9036.638534458614;8909.46543207408;8973.641054357819;8975.281977441806;8981.371304008722;8983.91016089839;2415.7705018023303;2447.645091461737;2449.363165576945;2451.1788550835404;2454.214651311581;2254.323702889135;2257.616205245104;2389.3429306940643;2419.5402873454077;2428.6964129483813;2396.664466974625;2417.105670901769;2427.5023620157826;2428.2715185444385;2428.441458464554;2353.917612883558;2376.239603326936;2385.7852793248603;2386.6539351793895;2397.1010870923405;2364.219807463533;2395.0419832067137;2403.87980600971;2404.0984630763464;2406.133791834938;8907.73276801697;8939.597718102701;8943.418677785989;9043.593038313225;9052.77368065797;5433.239346491494;5610.971945140289;5612.07400778871;5617.606767526275;5626.493615574577;3645.3073915955883;3659.9085022874374;3692.5753538343165;3717.442383642448;3720.2559488102215;1089.1613457637654;1093.6117678224275;1096.3641088168843;1103.834424836273;1114.6878873915316;11998.640040798702;12047.879521204763;12114.757704845853;12128.9690376319;12139.575114871026;3965.7025723070883;4170.436991006175;4488.640908727294;4630;4751.64362672801;9389.530523473799;9397.436153830791;9402.717918462457;9420.764480887896;9423.10480504351;5382.461753824665;5384.19237114436;5398.91901621476;5404.675719456845;5453.972730136324;4585.266357382803;4673.719576825401;4893.510648935078;5040.36995375578;5070.721110338966;3415.590129184514;3905.9609403906165;3922.156736301709;4027.7180597357906;4031.213913286881;996.6445633937839;1112.933224006562;1149.1036991146918;1177.0583533173426;1194.098455665984;763.9579823109672;897.9371443998857;925.7824411263348;930;945.4610871803144;5628.774849005994;5778.248827652463;5918.94140485718;5941.910871336933;5943.197668314809;441.2322558747756;447.1704987248672;453.838887195041;454.4750812811208;462.64607575204997;3278.8852390166708;3836.3503693411544;3870.9225815484097;3931.6658084063174;4023.4166045923175;10586.57653693859;10815.297005694605;11001.504932278067;11003.009729124256;11049.447527623748;10913.890861091446;10927.726806829734;10933.507992140372;10960;10995.175361847734;8239.794005149919;8273.793155171168;8412.495250285003;8425.873611895826;8470.915290847013;5653.293338332708;5676.971615141898;5684.346300175533;5857.384974577779;5924.348321684525;9983.251256155963;10017.449040302854;10208.540615672164;10229.795404092025;10322.2258330624;8641.438306510057;10197.9490102549;10477.9476102619;10483.842742359024;10546.68359949172;5716.971415142898;6695.129633147854;7101.715931362688;7196.460265480006;7295.197528271992;8573.74278771638;8642.43824151428;8646.481211127353;8647.04882462916;8649.783755406164;7489.176190619137;7517.924820751941;7615.390768738598;7646.350060244941;7735.574543399942;7336.853262934818;7450.403967682681;7461.216572259835;7617.5048621839405;7640.541567505968;6961.6171110587375;7108.609026503385;7121.465890058163;7122.6438678066925;7124.216336203117;4983.127952608206;5038.571721403575;5059.392872855281;5084.3644544431945;5199.428062913152;4959.628027897994;5008.874778130576;5099.413567439792;5174.870628234325;5190.480951904779 12:18:37 INFO - PROCESS | 1919 | |4;prototype.html;312.6061162934702;314.8504460381319;322.6982771109013;327.05644216435576;329.73456367624055;5302.57579393648;5336.519713225809;5353.544948679362;5377.623566350352;5433.538149257318;4242.38485419614;5027.296178534999;5040.942041656474;5212.687238765677;5375.274337964373;3637.836297366625;3653.83557739901;4036.4550785643855;4036.475258216428;4123.505179378479;4001.4397984282077;4070.3080476319096;4081.2245673322122;4092.4679791627045;4128.277551428488;3853.84584616615;3865.381538953768;4016.1365306459106;4049.190161967618;4056.71602987791;3309.420851351028;4013.6686550163586;4018.859339923118;4057.5333836608875;4071.2061148076136;3538.4161613333767;3544.929101417983;3553.3603951288756;3556.608773034964;3575.535180426554;3929.646331830149;4469.776511174428;5061.721605311706;5157.329547158883;5171.0692075426405;4300.569943005706;4608.746518941457;4635.559621835921;4672.229082201433;4688;5620.4098569650005;5628.439060227586;5644.020965219552;5648.63283886546;5653.971730141364;3881.204353107606;3882.7087968402484;3890.2414029264023;3909.648131668135;3924.941125883114;5551.361593416768;5809.390014048507;5838.649681019152;5894.764209431618;5963.121616690729;3897.4543563901075;3900.6684431823614;3910.902227444337;3923.3330333843314;3980.7412518186225;3681.9079523012138;3719.739618226698;3784.299904517673;3785.1104990327253;3981.402789581586;3852.6725228355344;3892.9416058759143;4327.071911481291;4622.907541849144;4676.462206846256;5113.667611605309;5318.25544423781;5628.324601047819;5658.207850900877;5675;1214.3442541027923;1317.2162563274835;1347.2186132043391;1347.3936728472227;1368.6578355411148;849.7068511363569;881.8623975072213;885.4156256870564;903.4940433357341;918.5912269040347;4297.720648157922;5232.2413250078525;5238.030964271622;5243.764030618631;5258.342707161605;5029.937725532514;5669.716514174274;5686.715664216773;5710.030039636319;5762.567807414461;4929.950700493021;5189.325387699575;5211.9478805211465;5244.5279924806955;5250.816221432232;2806.22828722099;2948.985255073711;2958.541426078961;2966.0127714431383;2966.8664910079096;5369.328833895763;5401.810936617199;5558.86102847424;5837.824865254049;5866.853328666817;5321.228421878806;5488.862778430571;5694.152923538231;5743.971280143573;5835.824925252249;5050.772715227824;5077.466865979093;5494;5631.324241091095;5813.912791308134;5361.651492652965;5541.445855414427;5597.412271711411;5653.886922261614;5678.971605141948;4412.646988240997;4859.00390419956;5187.559057480156;5315.2292917525965;5525.309336332958;4974.701517908937;5297.337832770903;5834.854128646818;5854.677992710272;5878.823635290948;3552.928941421209;3709.0727318170457;3728.179800443898;3853.7302388832513;3853.899624704599;5510.504054635102;5547.0585295146375;5606.607537472338;5637.46444087811;5652.123920792284;5438.274781774498;5441.183822426668;5441.183822426668;5501.972490137524;5506.449355064461;4565;5251.921221181762;5412.702301373462;5443.346798384219;5546.528545073714;4392;4804;5188.936268064962;5363.988504310883;5451.846520624411;5440.551751711667;5595.972020139873;5611.438856114356;5624.043912534797;5679.496975962417;4412.4705035395955;4801.719183387863;5358.177640123919;5456.236126942152;5518.724063796874 12:18:37 INFO - PROCESS | 1919 | |5;yui.html;686.7880025172316;714.6712512244368;750.9186771049684;799.2287442617873;830.9946059990845;15390.769138462918;17092.48722538323;17113.743293850603;17132.657346853055;17141.914290428547;15295.541133765977;15325.310361033753;15333;15361.15513646749;15456.459023934165;613.4080612209217;720.2905138438633;721.6860665610476;865.5282870835409;867.5271976772642;843.1315744782884;879.0857508191473;886.9866951995725;887.104024934814;888.7644774134859;948.4498990585479;949.1694767078806;950.078423928788;950.8145911547251;953.0945601678399;939.1125386509751;940.219617717293;942.820864035831;943.9757862718958;946.1673727120125;698.4866123399297;700.5061431690646;702.367868917978;703.0859882153231;705.4779463197198;16297.59256018597;16328.510144695678;16511.587210319718;16519.256633451525;16527.50417487477;11059.778804423866;12034.037277017818;13612.455501780016;13699.178049317074;15214.087154770748;11466.484690599196;13150.934245328712;13830.723385532234;14032.71934561303;14301.28493575317;4649.349091127245;4661.277501987197;4727.101850648366;4764.595009424169;4865.6594038417325;107473;108501;111301.44349278201;115565.84434155635;116582.41708791401;11086.667399978014;11430.599929002445;11511.251768635011;11641.47613357401;11645.941770291263;18279.72580411295;20793.376198714064;22263.998120084634;22419.887900560392;22436.439089022904;7356.190819009905;8220.547869867096;8234.217749313806;8312.625931832961;8322.62548185321;4480.596746292784;4549.408576884984;4646.303054541778;4671.27595222741;4674.6026587740425;3506.8947931562093;3606.3688854450365;3606.855725770992;3610.6208848070573;3613.439916812898;651.0494677770414;654.7184710574498;655.2137435077925;669.8492839111161;684.3020119478105;580.8228490310496;592.6562593695646;635.8251480842805;649.4869053447724;650.5641220382355;8629.69796057135;9119.284964030267;9460.668876589287;9561.378510396802;9591.712248632552;549.7855836223875;568.5934556791914;647.6413735559615;658.4633523678187;666.0389513851053;4569.268916973335;4756.21545249487;4926.45808961014;4939.580135688507;5007.874803129878;110371;151220.2438987798;154123;164954.17522912548;171325;135527;135873;143043;143521;146814.2659286718;111175;122042.38978805227;125456.37271813765;126618;127439;9487.857682134636;9622.326437149612;9626.711198664052;9654.565544550653;9679;66975;67336;67368.66315668587;68175.97736033864;69742.3025769756;83995.16004839873;92059.53970230106;99492;100602.49698751459;103356;11966.760664786829;12254.20347677398;12335;12480;12765.93617031909;11637.418129093681;13282.335883205607;14263.358148883533;14677.045992010912;14753.852461475248;10570.788584228427;12847.550335738204;12880.35598220104;13002.154859934075;13013;12561.623151305475;12576.748465030465;12635.747285054063;13105.737885242052;13718.862811372157;12628.87371126277;12743.93628031854;12833.486660533474;12907.225566466042;13090.280034598189;10458.895411045793;10661.466926653482;10694.839577406501;10735.892641073802;11015.449227538751;10734.624288149877;10898.400587967737;11014.889851101387;11055.22613417053;11142.331460112418 12:18:37 INFO - PROCESS | 1919 | __end_tp_report 12:18:37 INFO - PROCESS | 1919 | __start_cc_report 12:18:37 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,1202 12:18:37 INFO - PROCESS | 1919 | __end_cc_report 12:18:37 INFO - PROCESS | 1919 | __startTimestamp1483474717787__endTimestamp 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | ------- Summary: start ------- 12:18:37 INFO - PROCESS | 1919 | Number of tests: 6 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | [#0] dojo.html Cycles:165 Average:5760.71 Median:6022.70 stddev:637.22 (10.6%) stddev-sans-first:611.26 12:18:37 INFO - PROCESS | 1919 | Values: 3382.9 3404.6 3434.7 3440.3 3478.1 5578.5 5608.3 5669.8 5674.8 5677.5 5706.1 5769.6 5811.5 5814.5 5814.9 4588.9 5225.2 5237.7 5253.4 5255.9 5207.3 5213.8 5345.7 5351.3 5403.1 5279.2 5337.2 5339.5 5345.0 5350.2 5322.6 5337.9 5343.1 5345.1 5358.9 5189.1 5294.8 5295.4 5299.4 5314.8 4771.6 5819.1 5820.8 5831.9 5832.6 6105.9 6131.4 6146.5 6161.9 6183.6 6236.5 6251.9 6252.3 6285.1 6289.2 5811.9 5815.0 5856.5 5865.3 5873.6 6156.9 6219.9 6220.8 6276.4 6285.0 5086.2 6111.6 6152.0 6183.3 6191.1 5025.6 5266.4 6275.2 6286.4 6288.5 6108.3 6109.1 6140.0 6197.3 6242.0 6247.7 6258.5 6259.3 6259.6 6265.2 5012.6 5014.7 5019.1 5021.1 5036.0 4392.3 4426.2 4441.8 4450.4 4466.7 5947.1 5956.4 5960.7 5961.3 6002.9 6213.5 6223.1 6260.5 6267.0 6277.1 4842.9 5764.4 5800.7 5902.1 5953.1 5384.5 5425.8 5434.4 5441.7 5441.8 6203.3 6249.7 6263.9 6304.9 6319.8 6281.2 6285.6 6285.8 6291.7 6294.5 6282.7 6304.5 6307.0 6322.6 6325.9 6131.1 6151.9 6176.5 6219.3 6232.3 6170.7 6227.8 6244.3 6276.7 6283.8 5989.3 6163.8 6173.7 6190.1 6204.3 6004.7 6177.3 6180.0 6189.2 6195.6 5911.5 5959.5 6022.7 6071.4 6098.2 6160.3 6165.0 6182.9 6191.6 6193.1 6040.2 6045.4 6077.5 6096.4 6097.7 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | [#1] ext.html Cycles:180 Average:74602.00 Median:35871.83 stddev:167611.70 (467.3%) stddev-sans-first:167989.48 12:18:37 INFO - PROCESS | 1919 | Values: 470.1 478.2 487.2 527.1 542.6 26288.0 41941.6 43299.8 43549.8 45118.5 44733.3 44981.8 45198.1 45251.3 45414.3 9958.5 10177.1 10185.6 10188.9 10199.8 9342.8 9566.4 12275.8 12524.7 12538.1 12489.7 12560.6 12577.4 12579.2 12589.6 12517.6 12583.5 12592.7 12597.9 12598.9 12321.5 12400.3 12404.4 12411.4 12421.8 42244.6 42443.0 42479.2 42501.1 42586.4 3366.0 3433.4 3453.9 3489.4 3509.9 32446.7 32527.8 32558.7 32583.0 32893.5 3316.9 3346.1 3360.9 3461.3 3474.9 481052.0 485126.0 486935.0 487318.6 487887.0 61483.0 61711.0 61866.1 61885.0 62008.7 36232.6 36949.1 37008.0 37865.0 38006.8 17464.5 17632.0 17644.7 17666.8 17692.8 12373.9 12795.7 13260.5 13383.6 13388.8 19441.2 19967.7 20235.8 20248.9 20693.5 8156.3 8258.9 8268.5 8278.6 8392.9 742.4 962.0 984.8 1031.3 1072.0 31049.0 31758.0 31779.0 31927.5 32373.8 995.7 1120.8 1129.3 1149.8 1179.1 13733.9 15790.8 16544.8 16660.0 16771.4 588800.0 712294.0 717791.0 718501.0 719473.0 61927.4 62331.7 62342.0 62448.7 62490.7 1221.2 1312.3 1415.0 1419.4 1459.1 31392.0 32813.0 33063.7 33134.5 33681.0 52067.5 52675.7 52754.0 52787.0 52851.5 554527.0 556177.0 558198.0 813203.0 833710.0 28000.0 28623.3 28641.7 29311.0 29376.1 48964.0 49553.8 49614.8 50331.2 50407.7 40326.8 40919.8 41977.4 43095.4 43186.0 35710.5 36033.2 39983.4 41305.6 42572.6 38484.0 40275.2 40813.2 41018.8 41101.4 34576.3 36054.3 36236.8 36438.6 36951.7 23394.4 26717.7 26755.5 26814.1 26835.3 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | [#2] jquery.html Cycles:180 Average:36746.54 Median:26315.34 stddev:100362.05 (381.4%) stddev-sans-first:100606.45 12:18:37 INFO - PROCESS | 1919 | Values: 378.5 380.4 389.2 400.2 409.1 19486.9 20933.6 20971.3 21246.3 21382.6 20910.2 21196.0 21503.9 22007.8 22276.4 5887.2 6198.3 6210.4 6266.5 6291.7 4373.7 4474.0 5915.8 6298.7 6308.3 5516.5 6966.8 6990.1 7056.9 7060.9 6782.2 6990.7 7050.3 7059.0 7059.8 6138.2 6145.4 6147.0 6149.4 6151.3 22640.8 26276.3 26354.3 26618.9 26758.7 2291.7 2324.7 2333.4 2475.5 2492.5 15900.2 16596.6 16656.0 16669.0 16865.7 1855.5 1938.1 1940.2 1988.6 2031.8 130486.0 135047.0 135504.0 136352.0 137048.0 8998.7 10766.1 11069.3 11434.2 11623.9 14286.9 14288.4 14290.9 14293.4 14312.9 8908.3 9141.3 9147.9 9179.1 9270.4 9341.6 9368.6 9373.5 9493.4 9563.6 6782.9 6938.8 6939.1 6950.8 6996.0 1802.6 1843.8 1845.2 1855.7 1882.6 817.8 820.4 867.9 870.5 925.7 19169.5 19372.8 23568.5 23876.8 24879.0 930.5 981.4 990.3 997.7 1041.1 10063.5 10896.2 11192.0 11449.3 11693.9 547497.0 549494.0 552591.0 655414.0 658694.0 139650.0 140583.0 145962.0 148087.0 148505.0 970.4 1012.4 1073.8 1074.5 1075.3 17766.8 18424.6 20446.7 20992.7 21014.6 57853.8 58869.0 59034.4 60028.0 60363.7 87376.0 89331.7 90492.0 91516.0 91591.0 7896.6 8119.1 8329.5 8557.0 8642.2 9247.7 9638.7 12950.5 12964.2 13023.9 8685.0 11285.5 11361.2 11404.3 11424.4 9725.0 11211.9 11224.7 11268.3 11309.3 11727.7 11779.6 11789.8 11925.9 12049.6 7091.2 7537.7 7724.3 8114.8 8587.4 8434.0 10631.4 11894.3 11911.5 11923.4 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | [#3] mootools.html Cycles:180 Average:5741.57 Median:4971.38 stddev:3272.92 (65.8%) stddev-sans-first:3265.83 12:18:37 INFO - PROCESS | 1919 | Values: 1399.0 1525.5 1547.7 1766.3 1928.5 8053.3 8590.4 8733.1 9028.0 9036.6 8909.5 8973.6 8975.3 8981.4 8983.9 2415.8 2447.6 2449.4 2451.2 2454.2 2254.3 2257.6 2389.3 2419.5 2428.7 2396.7 2417.1 2427.5 2428.3 2428.4 2353.9 2376.2 2385.8 2386.7 2397.1 2364.2 2395.0 2403.9 2404.1 2406.1 8907.7 8939.6 8943.4 9043.6 9052.8 5433.2 5611.0 5612.1 5617.6 5626.5 3645.3 3659.9 3692.6 3717.4 3720.3 1089.2 1093.6 1096.4 1103.8 1114.7 11998.6 12047.9 12114.8 12129.0 12139.6 3965.7 4170.4 4488.6 4630.0 4751.6 9389.5 9397.4 9402.7 9420.8 9423.1 5382.5 5384.2 5398.9 5404.7 5454.0 4585.3 4673.7 4893.5 5040.4 5070.7 3415.6 3906.0 3922.2 4027.7 4031.2 996.6 1112.9 1149.1 1177.1 1194.1 764.0 897.9 925.8 930.0 945.5 5628.8 5778.2 5918.9 5941.9 5943.2 441.2 447.2 453.8 454.5 462.6 3278.9 3836.4 3870.9 3931.7 4023.4 10586.6 10815.3 11001.5 11003.0 11049.4 10913.9 10927.7 10933.5 10960.0 10995.2 8239.8 8273.8 8412.5 8425.9 8470.9 5653.3 5677.0 5684.3 5857.4 5924.3 9983.3 10017.4 10208.5 10229.8 10322.2 8641.4 10197.9 10477.9 10483.8 10546.7 5717.0 6695.1 7101.7 7196.5 7295.2 8573.7 8642.4 8646.5 8647.0 8649.8 7489.2 7517.9 7615.4 7646.4 7735.6 7336.9 7450.4 7461.2 7617.5 7640.5 6961.6 7108.6 7121.5 7122.6 7124.2 4983.1 5038.6 5059.4 5084.4 5199.4 4959.6 5008.9 5099.4 5174.9 5190.5 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | [#4] prototype.html Cycles:180 Average:4492.86 Median:5164.20 stddev:1360.95 (26.4%) stddev-sans-first:1328.10 12:18:37 INFO - PROCESS | 1919 | Values: 312.6 314.9 322.7 327.1 329.7 5302.6 5336.5 5353.5 5377.6 5433.5 4242.4 5027.3 5040.9 5212.7 5375.3 3637.8 3653.8 4036.5 4036.5 4123.5 4001.4 4070.3 4081.2 4092.5 4128.3 3853.8 3865.4 4016.1 4049.2 4056.7 3309.4 4013.7 4018.9 4057.5 4071.2 3538.4 3544.9 3553.4 3556.6 3575.5 3929.6 4469.8 5061.7 5157.3 5171.1 4300.6 4608.7 4635.6 4672.2 4688.0 5620.4 5628.4 5644.0 5648.6 5654.0 3881.2 3882.7 3890.2 3909.6 3924.9 5551.4 5809.4 5838.6 5894.8 5963.1 3897.5 3900.7 3910.9 3923.3 3980.7 3681.9 3719.7 3784.3 3785.1 3981.4 3852.7 3892.9 4327.1 4622.9 4676.5 5113.7 5318.3 5628.3 5658.2 5675.0 1214.3 1317.2 1347.2 1347.4 1368.7 849.7 881.9 885.4 903.5 918.6 4297.7 5232.2 5238.0 5243.8 5258.3 5029.9 5669.7 5686.7 5710.0 5762.6 4930.0 5189.3 5211.9 5244.5 5250.8 2806.2 2949.0 2958.5 2966.0 2966.9 5369.3 5401.8 5558.9 5837.8 5866.9 5321.2 5488.9 5694.2 5744.0 5835.8 5050.8 5077.5 5494.0 5631.3 5813.9 5361.7 5541.4 5597.4 5653.9 5679.0 4412.6 4859.0 5187.6 5315.2 5525.3 4974.7 5297.3 5834.9 5854.7 5878.8 3552.9 3709.1 3728.2 3853.7 3853.9 5510.5 5547.1 5606.6 5637.5 5652.1 5438.3 5441.2 5441.2 5502.0 5506.4 4565.0 5251.9 5412.7 5443.3 5546.5 4392.0 4804.0 5188.9 5364.0 5451.8 5440.6 5596.0 5611.4 5624.0 5679.5 4412.5 4801.7 5358.2 5456.2 5518.7 12:18:37 INFO - PROCESS | 1919 | 12:18:37 INFO - PROCESS | 1919 | [#5] yui.html Cycles:180 Average:25971.50 Median:22428.16 stddev:42031.64 (187.4%) stddev-sans-first:42106.67 12:18:37 INFO - PROCESS | 1919 | Values: 686.8 714.7 750.9 799.2 831.0 15390.8 17092.5 17113.7 17132.7 17141.9 15295.5 15325.3 15333.0 15361.2 15456.5 613.4 720.3 721.7 865.5 867.5 843.1 879.1 887.0 887.1 888.8 948.4 949.2 950.1 950.8 953.1 939.1 940.2 942.8 944.0 946.2 698.5 700.5 702.4 703.1 705.5 16297.6 16328.5 16511.6 16519.3 16527.5 11059.8 12034.0 13612.5 13699.2 15214.1 11466.5 13150.9 13830.7 14032.7 14301.3 4649.3 4661.3 4727.1 4764.6 4865.7 107473.0 108501.0 111301.4 115565.8 116582.4 11086.7 11430.6 11511.3 11641.5 11645.9 18279.7 20793.4 22264.0 22419.9 22436.4 7356.2 8220.5 8234.2 8312.6 8322.6 4480.6 4549.4 4646.3 4671.3 4674.6 3506.9 3606.4 3606.9 3610.6 3613.4 651.0 654.7 655.2 669.8 684.3 580.8 592.7 635.8 649.5 650.6 8629.7 9119.3 9460.7 9561.4 9591.7 549.8 568.6 647.6 658.5 666.0 4569.3 4756.2 4926.5 4939.6 5007.9 110371.0 151220.2 154123.0 164954.2 171325.0 135527.0 135873.0 143043.0 143521.0 146814.3 111175.0 122042.4 125456.4 126618.0 127439.0 9487.9 9622.3 9626.7 9654.6 9679.0 66975.0 67336.0 67368.7 68176.0 69742.3 83995.2 92059.5 99492.0 100602.5 103356.0 11966.8 12254.2 12335.0 12480.0 12765.9 11637.4 13282.3 14263.4 14677.0 14753.9 10570.8 12847.6 12880.4 13002.2 13013.0 12561.6 12576.7 12635.7 13105.7 13718.9 12628.9 12743.9 12833.5 12907.2 13090.3 10458.9 10661.5 10694.8 10735.9 11015.4 10734.6 10898.4 11014.9 11055.2 11142.3 12:18:37 INFO - PROCESS | 1919 | -------- Summary: end -------- 12:18:37 INFO - PROCESS | 1919 | 12:18:38 INFO - TEST-INFO | 1919: exit 0 12:18:38 INFO - TEST-OK | dromaeo_css | took 1115190ms 12:18:38 INFO - TEST-START | kraken 12:18:38 INFO - operating with platform_type : mac_ 12:18:38 INFO - Initialising browser for kraken test... 12:18:38 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpbEl2Cx/profile http://localhost:53532/getInfo.html) 12:18:40 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 12:18:40 INFO - PROCESS | 1922 | colorDepth:24 12:18:40 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 12:18:40 INFO - PROCESS | 1922 | __metrics 12:18:40 INFO - PROCESS | 1922 | 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" 12:18:40 INFO - PROCESS | 1922 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:18:41 INFO - TEST-INFO | 1922: exit 0 12:18:41 INFO - Browser initialized. 12:18:41 INFO - Running cycle 1/1 for kraken test... 12:18:41 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpbEl2Cx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:53 INFO - PROCESS | 1924 | RSS: Main: 168534016 12:18:53 INFO - PROCESS | 1924 | 12:18:55 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53532/tests/kraken/driver.html?testName=audio-beat-detection) 12:18:56 INFO - PROCESS | 1924 | RSS: Main: 218689536 12:18:56 INFO - PROCESS | 1924 | 12:18:59 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53532/tests/kraken/driver.html?testName=audio-dft) 12:19:00 INFO - PROCESS | 1924 | RSS: Main: 232357888 12:19:00 INFO - PROCESS | 1924 | 12:19:03 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53532/tests/kraken/driver.html?testName=audio-fft) 12:19:03 INFO - PROCESS | 1924 | RSS: Main: 328466432 12:19:03 INFO - PROCESS | 1924 | 12:19:05 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53532/tests/kraken/driver.html?testName=audio-oscillator) 12:19:06 INFO - PROCESS | 1924 | RSS: Main: 229105664 12:19:06 INFO - PROCESS | 1924 | 12:19:08 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:19:08 INFO - PROCESS | 1924 | RSS: Main: 229822464 12:19:08 INFO - PROCESS | 1924 | 12:19:11 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53532/tests/kraken/driver.html?testName=imaging-darkroom) 12:19:12 INFO - PROCESS | 1924 | RSS: Main: 268570624 12:19:12 INFO - PROCESS | 1924 | 12:19:14 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53532/tests/kraken/driver.html?testName=imaging-desaturate) 12:19:15 INFO - PROCESS | 1924 | RSS: Main: 267517952 12:19:15 INFO - PROCESS | 1924 | 12:19:18 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53532/tests/kraken/driver.html?testName=json-parse-financial) 12:19:18 INFO - PROCESS | 1924 | RSS: Main: 265437184 12:19:18 INFO - PROCESS | 1924 | 12:19:20 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:21 INFO - PROCESS | 1924 | RSS: Main: 244187136 12:19:21 INFO - PROCESS | 1924 | 12:19:22 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:23 INFO - PROCESS | 1924 | RSS: Main: 247316480 12:19:23 INFO - PROCESS | 1924 | 12:19:25 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:26 INFO - PROCESS | 1924 | RSS: Main: 250884096 12:19:26 INFO - PROCESS | 1924 | 12:19:29 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:29 INFO - PROCESS | 1924 | RSS: Main: 261390336 12:19:29 INFO - PROCESS | 1924 | 12:19:32 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:33 INFO - PROCESS | 1924 | RSS: Main: 261345280 12:19:33 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:53532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53532/tests/kraken/driver.html?testName=ai-astar) 12:19:35 INFO - PROCESS | 1924 | RSS: Main: 305029120 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | __start_tp_report 12:19:35 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 12:19:35 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 12:19:35 INFO - PROCESS | 1924 | |i|pagename|runs| 12:19:35 INFO - PROCESS | 1924 | |0;ai-astar;114;113;114;112;112;114;112;112;116;161 12:19:35 INFO - PROCESS | 1924 | |1;audio-beat-detection;145;109;114;176;146;109;106;109;137;107 12:19:35 INFO - PROCESS | 1924 | |2;audio-dft;183;179;185;183;179;182;185;181;182;186 12:19:35 INFO - PROCESS | 1924 | |3;audio-fft;80;57;60;89;61;59;58;58;81;58 12:19:35 INFO - PROCESS | 1924 | |4;audio-oscillator;87;70;95;70;67;68;91;68;69;93 12:19:35 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;87;85;87;84;90;86;88;85;87;84 12:19:35 INFO - PROCESS | 1924 | |6;imaging-darkroom;94;92;93;94;94;94;94;93;92;92 12:19:35 INFO - PROCESS | 1924 | |7;imaging-desaturate;84;84;86;83;83;83;88;122;84;86 12:19:35 INFO - PROCESS | 1924 | |8;json-parse-financial;57;54;53;52;56;56;58;58;57;57 12:19:35 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;63;71;72;74;72;67;68;69;68;69 12:19:35 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;80;85;83;79;86;80;65;95;90;100 12:19:35 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;149;145;140;133;134;135;137;139;167;148 12:19:35 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;204;215;162;163;139;167;219;184;160;161 12:19:35 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;67;66;69;73;80 12:19:35 INFO - PROCESS | 1924 | __end_tp_report 12:19:35 INFO - PROCESS | 1924 | __start_cc_report 12:19:35 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,1910 12:19:35 INFO - PROCESS | 1924 | __end_cc_report 12:19:35 INFO - PROCESS | 1924 | __startTimestamp1483474775519__endTimestamp 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | ------- Summary: start ------- 12:19:35 INFO - PROCESS | 1924 | Number of tests: 14 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:118.00 Median:114.00 stddev:15.17 (13.3%) stddev-sans-first:16.02 12:19:35 INFO - PROCESS | 1924 | Values: 114.0 113.0 114.0 112.0 112.0 114.0 112.0 112.0 116.0 161.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:125.50 stddev:23.93 (19.1%) stddev-sans-first:24.35 12:19:35 INFO - PROCESS | 1924 | Values: 145.0 109.0 114.0 176.0 146.0 109.0 106.0 109.0 137.0 107.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:2.42 (1.3%) stddev-sans-first:2.55 12:19:35 INFO - PROCESS | 1924 | Values: 183.0 179.0 185.0 183.0 179.0 182.0 185.0 181.0 182.0 186.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:12.17 (20.1%) stddev-sans-first:11.82 12:19:35 INFO - PROCESS | 1924 | Values: 80.0 57.0 60.0 89.0 61.0 59.0 58.0 58.0 81.0 58.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.50 stddev:11.99 (15.3%) stddev-sans-first:12.25 12:19:35 INFO - PROCESS | 1924 | Values: 87.0 70.0 95.0 70.0 67.0 68.0 91.0 68.0 69.0 93.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.89 (2.2%) stddev-sans-first:1.99 12:19:35 INFO - PROCESS | 1924 | Values: 87.0 85.0 87.0 84.0 90.0 86.0 88.0 85.0 87.0 84.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 12:19:35 INFO - PROCESS | 1924 | Values: 94.0 92.0 93.0 94.0 94.0 94.0 94.0 93.0 92.0 92.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:88.30 Median:84.00 stddev:11.95 (14.2%) stddev-sans-first:12.58 12:19:35 INFO - PROCESS | 1924 | Values: 84.0 84.0 86.0 83.0 83.0 83.0 88.0 122.0 84.0 86.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:2.10 (3.7%) stddev-sans-first:2.18 12:19:35 INFO - PROCESS | 1924 | Values: 57.0 54.0 53.0 52.0 56.0 56.0 58.0 58.0 57.0 57.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.00 stddev:3.13 (4.5%) stddev-sans-first:2.35 12:19:35 INFO - PROCESS | 1924 | Values: 63.0 71.0 72.0 74.0 72.0 67.0 68.0 69.0 68.0 69.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:9.64 (11.5%) stddev-sans-first:10.10 12:19:35 INFO - PROCESS | 1924 | Values: 80.0 85.0 83.0 79.0 86.0 80.0 65.0 95.0 90.0 100.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:142.50 stddev:10.25 (7.2%) stddev-sans-first:10.62 12:19:35 INFO - PROCESS | 1924 | Values: 149.0 145.0 140.0 133.0 134.0 135.0 137.0 139.0 167.0 148.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:175.50 stddev:26.86 (15.3%) stddev-sans-first:26.71 12:19:35 INFO - PROCESS | 1924 | Values: 204.0 215.0 162.0 163.0 139.0 167.0 219.0 184.0 160.0 161.0 12:19:35 INFO - PROCESS | 1924 | 12:19:35 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:66.50 stddev:4.62 (7.0%) stddev-sans-first:4.82 12:19:35 INFO - PROCESS | 1924 | Values: 66.0 66.0 66.0 66.0 66.0 67.0 66.0 69.0 73.0 80.0 12:19:35 INFO - PROCESS | 1924 | -------- Summary: end -------- 12:19:35 INFO - PROCESS | 1924 | 12:19:36 INFO - TEST-INFO | 1924: exit 0 12:19:36 INFO - TEST-OK | kraken | took 58054ms 12:19:36 INFO - SUITE-END | took 1173s 12:19:36 INFO - Completed test suite (00:19:33) 12:19:36 INFO - javascript benchmark 12:19:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.9323413531724, 3404.625491195968, 3434.7291502144194, 3440.3463341965007, 3478.0783092480483, 5578.525825304849, 5608.270924779783, 5669.829905102843, 5674.829755107348, 5677.517411020063, 5706.115552089423, 5769.596128271022, 5811.535077193825, 5814.4766970972605, 5814.883702325951, 4588.885277868063, 5225.16397376418, 5237.73811309433, 5253.369595648527, 5255.894882102365, 5207.270982062495, 5213.765380557865, 5345.732713364336, 5351.25082488452, 5403.135498320269, 5279.155335146377, 5337.199420086979, 5339.546138578206, 5345.0, 5350.170723537858, 5322.600804939645, 5337.946620533784, 5343.145096784496, 5345.1447768356875, 5358.901425207823, 5189.117849965477, 5294.814681486129, 5295.391030031518, 5299.390570084451, 5314.7608357624, 4771.618270538349, 5819.0689489681445, 5820.767169313222, 5831.9416805831825, 5832.562557808182, 6105.884339886945, 6131.381032942593, 6146.508279337642, 6161.876762464771, 6183.567150299481, 6236.532260080512, 6251.937480625181, 6252.3435039320675, 6285.120083188357, 6289.213848268966, 5811.912821307684, 5814.97092514539, 5856.483214775989, 5865.325487568942, 5873.618214816023, 6156.876862462816, 6219.875602487925, 6220.813375598739, 6276.372362763778, 6284.994400895926, 5086.186210206423, 6111.591738512148, 6151.96924015377, 6183.258009038944, 6191.071339299051, 5025.648204625714, 5266.3943646480375, 6275.215598050244, 6286.402791734778, 6288.52836037299, 6108.3292684140915, 6109.053096770008, 6139.982816839433, 6197.25632924052, 6241.96879015602, 6247.718852651642, 6258.499320054385, 6259.280182778948, 6259.561830671901, 6265.216847894013, 5012.649114562018, 5014.674046186986, 5019.121653710586, 5021.07110184617, 5036.0, 4392.341148827638, 4426.22541055314, 4441.844535441309, 4450.354698568754, 4466.665000125004, 5947.078202878561, 5956.404359564096, 5960.731767070492, 5961.254843144607, 6002.909956350658, 6213.5339849510565, 6223.066540018943, 6260.499160067184, 6267.0, 6277.089821975879, 4842.927356089662, 5764.365919748824, 5800.680962547016, 5902.144189092557, 5953.077273022688, 5384.461553844584, 5425.83722488326, 5434.429384914527, 5441.727913604304, 5441.755121019563, 6203.2556093268195, 6249.6562689052535, 6263.906041409291, 6304.873902521924, 6319.842003949938, 6281.246250449975, 6285.59143655661, 6285.842853928505, 6291.716872740646, 6294.496440284858, 6282.748690052529, 6304.495640348669, 6307.0, 6322.589031712924, 6325.936740632535, 6131.141640170291, 6151.876962460815, 6176.536759742948, 6219.253689557282, 6232.345603711545, 6170.7223174958135, 6227.844303892439, 6244.344343844013, 6276.654783986742, 6283.842903927255, 5989.2812862456785, 6163.7842675506145, 6173.660448675366, 6190.071489276645, 6204.348543403058, 6004.729787159501, 6177.320494745484, 6180.0, 6189.226346706661, 6195.597286176384, 5911.527077833849, 5959.523238140851, 6022.698865056642, 6071.423214794588, 6098.237720284965, 6160.3223645398075, 6164.969175154096, 6182.938170618416, 6191.628502289877, 6193.1329613855, 6040.184575082308, 6045.365236650088, 6077.4834139098675, 6096.420840020191, 6097.713357490941], "value": 5721.9371438011685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.05753464304075, 478.163214374844, 487.2155829115125, 527.0907684244678, 542.6147435320922, 26288.0, 41941.580584194184, 43299.78350108253, 43549.7822510887, 45118.54881451184, 44733.32900006494, 44981.77509112458, 45198.096038079304, 45251.32123018149, 45414.318785218245, 9958.452285124333, 10177.134943529809, 10185.59257629694, 10188.949055254714, 10199.796004079913, 9342.766430839216, 9566.426014439121, 12275.815862762021, 12524.749505009895, 12538.059645526622, 12489.687757806081, 12560.623181304576, 12577.371131443437, 12579.182353147062, 12589.559365422212, 12517.561885334015, 12583.49666013363, 12592.748145037049, 12597.937010314981, 12598.937005314914, 12321.507139714491, 12400.317982510958, 12404.441800119017, 12411.379431028412, 12421.75156496865, 42244.57755422437, 42443.0, 42479.150416991484, 42501.149977000285, 42586.361204581954, 3366.0406784066668, 3433.4334834752235, 3453.913652158691, 3489.4416893296952, 3509.94735078974, 32446.6755332446, 32527.837360813046, 32558.674413256038, 32583.0, 32893.500469821316, 3316.93366132676, 3346.0631023313513, 3360.8823691170937, 3461.273132642148, 3474.9305013899834, 481052.0, 485126.0, 486935.0, 487318.56340718427, 487887.0, 61483.0, 61711.0, 61866.0720089199, 61885.0, 62008.68995655083, 36232.63767362293, 36949.076273093386, 37008.0, 37865.0, 38006.80996594999, 17464.47606571805, 17632.030238337014, 17644.735328970077, 17666.823331766518, 17692.823071769373, 12373.93813030929, 12795.680107997188, 13260.53588124411, 13383.598492045254, 13388.799168012487, 19441.2043540197, 19967.700484492743, 20235.79764202339, 20248.89875550613, 20693.482662933548, 8156.306713929383, 8258.917410825936, 8268.462549934235, 8278.586070696441, 8392.916070839214, 742.3986570877606, 961.9855702164473, 984.818218138237, 1031.298716872519, 1072.035168348477, 31049.0, 31758.0, 31779.0, 31927.521087183246, 32373.838130809196, 995.6515219673201, 1120.803859324615, 1129.2998341028451, 1149.804533229353, 1179.0803173524664, 13733.931330343485, 15790.763138552931, 16544.83455165433, 16660.00039997604, 16771.413000544922, 588800.0, 712294.0, 717791.0, 718501.0, 719473.0, 61927.38072619306, 62331.688341558, 62342.0, 62448.687756561834, 62490.687546561974, 1221.1635030004475, 1312.343828085957, 1414.9504767333094, 1419.3683810704345, 1459.1026518691142, 31392.0, 32813.01560953175, 33063.66936330606, 33134.502982454804, 33680.98957031293, 52067.47932520627, 52675.736621316646, 52754.0, 52787.0, 52851.47148528465, 554527.0, 556177.0, 558198.0, 813203.0, 833710.0, 28000.0, 28623.284417889718, 28641.7086633073, 29310.97411590584, 29376.11871643854, 48964.020719584696, 49553.75223123861, 49614.75192624014, 50331.231782252326, 50407.747961259956, 40326.798366007984, 40919.795401022806, 41977.370339445544, 43095.35356969585, 43186.0, 35710.4643430354, 36033.198340083414, 39983.40024899687, 41305.58694413018, 42572.57427425686, 38484.037899052746, 40275.194496109325, 40813.1837363257, 41018.79490602528, 41101.383479248434, 34576.30847382988, 36054.27891442104, 36236.81881590575, 36438.60827177974, 36951.70669026571, 23394.415139621644, 26717.7328226723, 26755.46489070169, 26814.06150784713, 26835.32911677224], "value": 21079.030589346847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5438546551406, 380.37618305978197, 389.1768908757977, 400.1976038043722, 409.1265148907082, 19486.928218947953, 20933.581328373442, 20971.266005689802, 21246.256381026647, 21382.572348553018, 20910.16359345628, 21196.0, 21503.924803759826, 22007.779922200774, 22276.443088922784, 5887.205227294314, 6198.349173336803, 6210.378962103776, 6266.498680105604, 6291.685415729218, 4373.650107991369, 4473.9776301118445, 5915.763369465216, 6298.716557754889, 6308.306086330523, 5516.531094856942, 6966.79099627012, 6990.126234220723, 7056.894146587805, 7060.894086588705, 6782.152230971154, 6990.741666500028, 7050.272683192599, 7059.011738356634, 7059.823504412379, 6138.17134686816, 6145.3547377525165, 6147.0, 6149.446549810538, 6151.323354431009, 22640.77359226403, 26276.343091422677, 26354.341141471617, 26618.86690566554, 26758.732412675818, 2291.713535808024, 2324.6745455636224, 2333.4399744061475, 2475.4677744285063, 2492.501499700067, 15900.212802094047, 16596.58508537284, 16656.0, 16669.0, 16865.662686746196, 1855.4619160443456, 1938.0503553258943, 1940.1560321260156, 1988.5724569217687, 2031.817136457711, 130486.0, 135047.0, 135504.0, 136351.999999999, 137048.0, 8998.685046023358, 10766.093154848148, 11069.280496767684, 11434.199606027498, 11623.941880290713, 14286.928565357315, 14288.357023933948, 14290.928545357207, 14293.427722950468, 14312.85687143136, 8908.331875109392, 9141.314401419788, 9147.908520914838, 9179.127982841619, 9270.35107542479, 9341.626334946526, 9368.625254989724, 9373.48445835472, 9493.382930109521, 9563.61745530185, 6782.864342713118, 6938.757143499954, 6939.09328648713, 6950.756723514653, 6995.965020174866, 1802.5854053567753, 1843.8340549350355, 1845.2157832920955, 1855.740196372509, 1882.5575989642423, 817.8037271054905, 820.4402264933445, 867.9305655547668, 870.4864130163234, 925.6991477769752, 19169.52076198106, 19372.80627193738, 23568.528629427314, 23876.761232387453, 24879.004839806206, 930.4556834251903, 981.4356744871727, 990.3117333453325, 997.7206382212992, 1041.1358572384902, 10063.540786585903, 10896.237263391646, 11192.0, 11449.313041217554, 11693.88306116945, 547497.0, 549494.0, 552591.0, 655414.0, 658694.0, 139650.0, 140583.0, 145962.0, 148087.0, 148505.0, 970.3789574672215, 1012.372329155928, 1073.7530368015243, 1074.4788777442934, 1075.2903083964545, 17766.75632705698, 18424.631507370046, 20446.69329960022, 20992.68510972306, 21014.57970840605, 57853.84292314215, 58869.0, 59034.40965590289, 60028.0, 60363.69818151057, 87376.0, 89331.66002509838, 90492.0, 91516.0, 91591.0, 7896.565688887166, 8119.106898241071, 8329.50022998622, 8557.0, 8642.22220000203, 9247.676331328372, 9638.722834236394, 12950.546730864751, 12964.22214667123, 13023.869761302645, 8685.0, 11285.548578057114, 11361.204715669825, 11404.315741055563, 11424.371659558805, 9724.95137524308, 11211.943940280247, 11224.719382015188, 11268.323900565993, 11309.264897781617, 11727.706807329885, 11779.646610601696, 11789.82101789814, 11925.940370298093, 12049.638510844688, 7091.219965803861, 7537.698492060256, 7724.343430808444, 8114.823350614246, 8587.441816281922, 8434.03008653988, 10631.362118272928, 11894.34581098048, 11911.52353905834, 11923.422973108207], "value": 10159.000153583871, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.9650258743525, 1525.5499627609854, 1547.6827250413662, 1766.302310587318, 1928.4985903665051, 8053.315468185204, 8590.355723320752, 8733.083026282236, 9028.0, 9036.638534458614, 8909.46543207408, 8973.641054357819, 8975.281977441806, 8981.371304008722, 8983.91016089839, 2415.7705018023303, 2447.645091461737, 2449.363165576945, 2451.1788550835404, 2454.214651311581, 2254.323702889135, 2257.616205245104, 2389.3429306940643, 2419.5402873454077, 2428.6964129483813, 2396.664466974625, 2417.105670901769, 2427.5023620157826, 2428.2715185444385, 2428.441458464554, 2353.917612883558, 2376.239603326936, 2385.7852793248603, 2386.6539351793895, 2397.1010870923405, 2364.219807463533, 2395.0419832067137, 2403.87980600971, 2404.0984630763464, 2406.133791834938, 8907.73276801697, 8939.597718102701, 8943.418677785989, 9043.593038313225, 9052.77368065797, 5433.239346491494, 5610.971945140289, 5612.07400778871, 5617.606767526275, 5626.493615574577, 3645.3073915955883, 3659.9085022874374, 3692.5753538343165, 3717.442383642448, 3720.2559488102215, 1089.1613457637654, 1093.6117678224275, 1096.3641088168843, 1103.834424836273, 1114.6878873915316, 11998.640040798702, 12047.879521204763, 12114.757704845853, 12128.9690376319, 12139.575114871026, 3965.7025723070883, 4170.436991006175, 4488.640908727294, 4630.0, 4751.64362672801, 9389.530523473799, 9397.436153830791, 9402.717918462457, 9420.764480887896, 9423.10480504351, 5382.461753824665, 5384.19237114436, 5398.91901621476, 5404.675719456845, 5453.972730136324, 4585.266357382803, 4673.719576825401, 4893.510648935078, 5040.36995375578, 5070.721110338966, 3415.590129184514, 3905.9609403906165, 3922.156736301709, 4027.7180597357906, 4031.213913286881, 996.6445633937839, 1112.933224006562, 1149.1036991146918, 1177.0583533173426, 1194.098455665984, 763.9579823109672, 897.9371443998857, 925.7824411263348, 930.0, 945.4610871803144, 5628.774849005994, 5778.248827652463, 5918.94140485718, 5941.910871336933, 5943.197668314809, 441.2322558747756, 447.1704987248672, 453.838887195041, 454.4750812811208, 462.64607575204997, 3278.8852390166708, 3836.3503693411544, 3870.9225815484097, 3931.6658084063174, 4023.4166045923175, 10586.57653693859, 10815.297005694605, 11001.504932278067, 11003.009729124256, 11049.447527623748, 10913.890861091446, 10927.726806829734, 10933.507992140372, 10960.0, 10995.175361847734, 8239.794005149919, 8273.793155171168, 8412.495250285003, 8425.873611895826, 8470.915290847013, 5653.293338332708, 5676.971615141898, 5684.346300175533, 5857.384974577779, 5924.348321684525, 9983.251256155963, 10017.449040302854, 10208.540615672164, 10229.795404092025, 10322.2258330624, 8641.438306510057, 10197.9490102549, 10477.9476102619, 10483.842742359024, 10546.68359949172, 5716.971415142898, 6695.129633147854, 7101.715931362688, 7196.460265480006, 7295.197528271992, 8573.74278771638, 8642.43824151428, 8646.481211127353, 8647.04882462916, 8649.783755406164, 7489.176190619137, 7517.924820751941, 7615.390768738598, 7646.350060244941, 7735.574543399942, 7336.853262934818, 7450.403967682681, 7461.216572259835, 7617.5048621839405, 7640.541567505968, 6961.6171110587375, 7108.609026503385, 7121.465890058163, 7122.6438678066925, 7124.216336203117, 4983.127952608206, 5038.571721403575, 5059.392872855281, 5084.3644544431945, 5199.428062913152, 4959.628027897994, 5008.874778130576, 5099.413567439792, 5174.870628234325, 5190.480951904779], "value": 4517.1497099969065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.6061162934702, 314.8504460381319, 322.6982771109013, 327.05644216435576, 329.73456367624055, 5302.57579393648, 5336.519713225809, 5353.544948679362, 5377.623566350352, 5433.538149257318, 4242.38485419614, 5027.296178534999, 5040.942041656474, 5212.687238765677, 5375.274337964373, 3637.836297366625, 3653.83557739901, 4036.4550785643855, 4036.475258216428, 4123.505179378479, 4001.4397984282077, 4070.3080476319096, 4081.2245673322122, 4092.4679791627045, 4128.277551428488, 3853.84584616615, 3865.381538953768, 4016.1365306459106, 4049.190161967618, 4056.71602987791, 3309.420851351028, 4013.6686550163586, 4018.859339923118, 4057.5333836608875, 4071.2061148076136, 3538.4161613333767, 3544.929101417983, 3553.3603951288756, 3556.608773034964, 3575.535180426554, 3929.646331830149, 4469.776511174428, 5061.721605311706, 5157.329547158883, 5171.0692075426405, 4300.569943005706, 4608.746518941457, 4635.559621835921, 4672.229082201433, 4688.0, 5620.4098569650005, 5628.439060227586, 5644.020965219552, 5648.63283886546, 5653.971730141364, 3881.204353107606, 3882.7087968402484, 3890.2414029264023, 3909.648131668135, 3924.941125883114, 5551.361593416768, 5809.390014048507, 5838.649681019152, 5894.764209431618, 5963.121616690729, 3897.4543563901075, 3900.6684431823614, 3910.902227444337, 3923.3330333843314, 3980.7412518186225, 3681.9079523012138, 3719.739618226698, 3784.299904517673, 3785.1104990327253, 3981.402789581586, 3852.6725228355344, 3892.9416058759143, 4327.071911481291, 4622.907541849144, 4676.462206846256, 5113.667611605309, 5318.25544423781, 5628.324601047819, 5658.207850900877, 5675.0, 1214.3442541027923, 1317.2162563274835, 1347.2186132043391, 1347.3936728472227, 1368.6578355411148, 849.7068511363569, 881.8623975072213, 885.4156256870564, 903.4940433357341, 918.5912269040347, 4297.720648157922, 5232.2413250078525, 5238.030964271622, 5243.764030618631, 5258.342707161605, 5029.937725532514, 5669.716514174274, 5686.715664216773, 5710.030039636319, 5762.567807414461, 4929.950700493021, 5189.325387699575, 5211.9478805211465, 5244.5279924806955, 5250.816221432232, 2806.22828722099, 2948.985255073711, 2958.541426078961, 2966.0127714431383, 2966.8664910079096, 5369.328833895763, 5401.810936617199, 5558.86102847424, 5837.824865254049, 5866.853328666817, 5321.228421878806, 5488.862778430571, 5694.152923538231, 5743.971280143573, 5835.824925252249, 5050.772715227824, 5077.466865979093, 5494.0, 5631.324241091095, 5813.912791308134, 5361.651492652965, 5541.445855414427, 5597.412271711411, 5653.886922261614, 5678.971605141948, 4412.646988240997, 4859.00390419956, 5187.559057480156, 5315.2292917525965, 5525.309336332958, 4974.701517908937, 5297.337832770903, 5834.854128646818, 5854.677992710272, 5878.823635290948, 3552.928941421209, 3709.0727318170457, 3728.179800443898, 3853.7302388832513, 3853.899624704599, 5510.504054635102, 5547.0585295146375, 5606.607537472338, 5637.46444087811, 5652.123920792284, 5438.274781774498, 5441.183822426668, 5441.183822426668, 5501.972490137524, 5506.449355064461, 4565.0, 5251.921221181762, 5412.702301373462, 5443.346798384219, 5546.528545073714, 4392.0, 4804.0, 5188.936268064962, 5363.988504310883, 5451.846520624411, 5440.551751711667, 5595.972020139873, 5611.438856114356, 5624.043912534797, 5679.496975962417, 4412.4705035395955, 4801.719183387863, 5358.177640123919, 5456.236126942152, 5518.724063796874], "value": 4064.174431437092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.7880025172316, 714.6712512244368, 750.9186771049684, 799.2287442617873, 830.9946059990845, 15390.769138462918, 17092.48722538323, 17113.743293850603, 17132.657346853055, 17141.914290428547, 15295.541133765977, 15325.310361033753, 15333.0, 15361.15513646749, 15456.459023934165, 613.4080612209217, 720.2905138438633, 721.6860665610476, 865.5282870835409, 867.5271976772642, 843.1315744782884, 879.0857508191473, 886.9866951995725, 887.104024934814, 888.7644774134859, 948.4498990585479, 949.1694767078806, 950.078423928788, 950.8145911547251, 953.0945601678399, 939.1125386509751, 940.219617717293, 942.820864035831, 943.9757862718958, 946.1673727120125, 698.4866123399297, 700.5061431690646, 702.367868917978, 703.0859882153231, 705.4779463197198, 16297.59256018597, 16328.510144695678, 16511.587210319718, 16519.256633451525, 16527.50417487477, 11059.778804423866, 12034.037277017818, 13612.455501780016, 13699.178049317074, 15214.087154770748, 11466.484690599196, 13150.934245328712, 13830.723385532234, 14032.71934561303, 14301.28493575317, 4649.349091127245, 4661.277501987197, 4727.101850648366, 4764.595009424169, 4865.6594038417325, 107473.0, 108501.0, 111301.44349278201, 115565.84434155635, 116582.41708791401, 11086.667399978014, 11430.599929002445, 11511.251768635011, 11641.47613357401, 11645.941770291263, 18279.72580411295, 20793.376198714064, 22263.998120084634, 22419.887900560392, 22436.439089022904, 7356.190819009905, 8220.547869867096, 8234.217749313806, 8312.625931832961, 8322.62548185321, 4480.596746292784, 4549.408576884984, 4646.303054541778, 4671.27595222741, 4674.6026587740425, 3506.8947931562093, 3606.3688854450365, 3606.855725770992, 3610.6208848070573, 3613.439916812898, 651.0494677770414, 654.7184710574498, 655.2137435077925, 669.8492839111161, 684.3020119478105, 580.8228490310496, 592.6562593695646, 635.8251480842805, 649.4869053447724, 650.5641220382355, 8629.69796057135, 9119.284964030267, 9460.668876589287, 9561.378510396802, 9591.712248632552, 549.7855836223875, 568.5934556791914, 647.6413735559615, 658.4633523678187, 666.0389513851053, 4569.268916973335, 4756.21545249487, 4926.45808961014, 4939.580135688507, 5007.874803129878, 110371.0, 151220.2438987798, 154123.0, 164954.17522912548, 171325.0, 135527.0, 135873.0, 143043.0, 143521.0, 146814.2659286718, 111175.0, 122042.38978805227, 125456.37271813765, 126618.0, 127439.0, 9487.857682134636, 9622.326437149612, 9626.711198664052, 9654.565544550653, 9679.0, 66975.0, 67336.0, 67368.66315668587, 68175.97736033864, 69742.3025769756, 83995.16004839873, 92059.53970230106, 99492.0, 100602.49698751459, 103356.0, 11966.760664786829, 12254.20347677398, 12335.0, 12480.0, 12765.93617031909, 11637.418129093681, 13282.335883205607, 14263.358148883533, 14677.045992010912, 14753.852461475248, 10570.788584228427, 12847.550335738204, 12880.35598220104, 13002.154859934075, 13013.0, 12561.623151305475, 12576.748465030465, 12635.747285054063, 13105.737885242052, 13718.862811372157, 12628.87371126277, 12743.93628031854, 12833.486660533474, 12907.225566466042, 13090.280034598189, 10458.895411045793, 10661.466926653482, 10694.839577406501, 10735.892641073802, 11015.449227538751, 10734.624288149877, 10898.400587967737, 11014.889851101387, 11055.22613417053, 11142.331460112418], "value": 7992.033789050969, "unit": "score"}], "name": "dromaeo_css", "value": 7512.735388959798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 112.0, 112.0, 114.0, 112.0, 112.0, 116.0, 161.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 114.0, 176.0, 146.0, 109.0, 106.0, 109.0, 137.0, 107.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 185.0, 183.0, 179.0, 182.0, 185.0, 181.0, 182.0, 186.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 60.0, 89.0, 61.0, 59.0, 58.0, 58.0, 81.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 95.0, 70.0, 67.0, 68.0, 91.0, 68.0, 69.0, 93.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 90.0, 86.0, 88.0, 85.0, 87.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 92.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 83.0, 83.0, 83.0, 88.0, 122.0, 84.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 52.0, 56.0, 56.0, 58.0, 58.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 72.0, 74.0, 72.0, 67.0, 68.0, 69.0, 68.0, 69.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 83.0, 79.0, 86.0, 80.0, 65.0, 95.0, 90.0, 100.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 145.0, 140.0, 133.0, 134.0, 135.0, 137.0, 139.0, 167.0, 148.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 215.0, 162.0, 163.0, 139.0, 167.0, 219.0, 184.0, 160.0, 161.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 69.0, 73.0, 80.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1436.0, "alertThreshold": 2.0}]} 12:19:36 INFO - Return code: 0 12:19:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:36 INFO - # TBPL SUCCESS # 12:19:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:36 INFO - 2017-01-03 12:19:36.817 screenresolution[1928:17061] starting screenresolution argv=screenresolution get 12:19:36 INFO - 2017-01-03 12:19:36.820 screenresolution[1928:17061] Display 0: 1600x1200x32@60 12:19:36 INFO - 2017-01-03 12:19:36.826 screenresolution[1929:17064] starting screenresolution argv=screenresolution list 12:19:36 INFO - Available Modes on Display 0 12:19:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:19:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:19:37 INFO - Intel Iris: 12:19:37 INFO - Chipset Model: Intel Iris 12:19:37 INFO - Type: GPU 12:19:37 INFO - Bus: Built-In 12:19:37 INFO - VRAM (Dynamic, Max): 1536 MB 12:19:37 INFO - Vendor: Intel (0x8086) 12:19:37 INFO - Device ID: 0x0a2e 12:19:37 INFO - Revision ID: 0x0009 12:19:37 INFO - Displays: 12:19:37 INFO - Display: 12:19:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:19:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:19:37 INFO - Display Serial Number: 1600x1200 60 12:19:37 INFO - Main Display: Yes 12:19:37 INFO - Mirror: Off 12:19:37 INFO - Online: Yes 12:19:37 INFO - Rotation: Supported 12:19:37 INFO - Return code: 0 12:19:37 INFO - Running post-action listener: _resource_record_post_action 12:19:37 INFO - [mozharness: 2017-01-03 20:19:37.066468Z] Finished run-tests step (success) 12:19:37 INFO - Running post-run listener: _resource_record_post_run 12:19:38 WARNING - Exception when reporting resource usage: Traceback (most recent call last): 12:19:38 WARNING - File "/builds/slave/test/scripts/mozharness/base/python.py", line 526, in _resource_record_post_run 12:19:38 WARNING - self._resource_monitor.stop() 12:19:38 WARNING - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/mozsystemmonitor/resourcemonitor.py", line 325, in stop 12:19:38 WARNING - assert done 12:19:38 WARNING - AssertionError 12:19:38 INFO - Running post-run listener: _upload_blobber_files 12:19:38 INFO - Blob upload gear active. 12:19:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:38 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 12:19:38 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:19:38 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:19:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:19:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:19:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:39 INFO - (blobuploader) - INFO - Done attempting. 12:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:40 INFO - (blobuploader) - INFO - Done attempting. 12:19:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:19:40 INFO - Return code: 0 12:19:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:19:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:19:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e4f21e8b2a69fbc91903bc2fb59d0e09b3ab2734d1ab06d2f593c5e1fc13e76f83325cd37a743b127f402b2beab75606d53262d174feb196ea1973b6861ad6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e19d41273bb0a3382b40af5c0bfaf9c16bb9bf173e15c0d04c7df70c060e8017c92f0ece190be0342ca75c9f42beb60348e641d2784465795136827c63f2a577"} 12:19:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:19:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:19:40 INFO - Contents: 12:19:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e4f21e8b2a69fbc91903bc2fb59d0e09b3ab2734d1ab06d2f593c5e1fc13e76f83325cd37a743b127f402b2beab75606d53262d174feb196ea1973b6861ad6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e19d41273bb0a3382b40af5c0bfaf9c16bb9bf173e15c0d04c7df70c060e8017c92f0ece190be0342ca75c9f42beb60348e641d2784465795136827c63f2a577"} 12:19:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:19:40 INFO - Copying logs to upload dir... 12:19:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:19:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.140870 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-03 12:19:40.613100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 12:19:40.617250) ========= 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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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-Beta/sha512/3e4f21e8b2a69fbc91903bc2fb59d0e09b3ab2734d1ab06d2f593c5e1fc13e76f83325cd37a743b127f402b2beab75606d53262d174feb196ea1973b6861ad6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e19d41273bb0a3382b40af5c0bfaf9c16bb9bf173e15c0d04c7df70c060e8017c92f0ece190be0342ca75c9f42beb60348e641d2784465795136827c63f2a577"} build_url:https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/CyWgh6uRSpGxMWqYU8HsSw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e4f21e8b2a69fbc91903bc2fb59d0e09b3ab2734d1ab06d2f593c5e1fc13e76f83325cd37a743b127f402b2beab75606d53262d174feb196ea1973b6861ad6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e19d41273bb0a3382b40af5c0bfaf9c16bb9bf173e15c0d04c7df70c060e8017c92f0ece190be0342ca75c9f42beb60348e641d2784465795136827c63f2a577"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 12:19:40.652790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 12:19:40.653169) ========= 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.8sUUbkB6XA/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.rqIFoNQjpX/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.005342 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 12:19:40.702442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 12:19:40.702908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 12:19:40.703317) ========= ========= Total master_lag: 0.58 =========