builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0116 starttime: 1492464225.48 results: success (0) buildid: 20170417125706 builduid: 0507d00f0a074ff395080681187cceb9 revision: a374c35469935a874fefe64d3e07003fc5bc8884 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.479507) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.480028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.480318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.526220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.526616) ========= 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.LKXSYDmItJ/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.LksVRpDlY3/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-04-17 14:23:45-- 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% 159M=0s 2017-04-17 14:23:46 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.589100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:46.139620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:46.139908) ========= 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.LKXSYDmItJ/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.LksVRpDlY3/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.028523 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:46.191004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 14:23:46.191333) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a374c35469935a874fefe64d3e07003fc5bc8884 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a374c35469935a874fefe64d3e07003fc5bc8884 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LKXSYDmItJ/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.LksVRpDlY3/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-04-17 14:23:46,293 truncating revision to first 12 chars 2017-04-17 14:23:46,293 Setting DEBUG logging. 2017-04-17 14:23:46,293 attempt 1/10 2017-04-17 14:23:46,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a374c3546993?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 14:23:47,066 unpacking tar archive at: mozilla-central-a374c3546993/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052961 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 14:23:47.276453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:47.276753) ========= script_repo_revision: a374c35469935a874fefe64d3e07003fc5bc8884 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:47.277117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:47.280017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:47.303853) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-17 14:23:47.304130) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LKXSYDmItJ/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.LksVRpDlY3/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:23:47 INFO - MultiFileLogger online at 20170417 14:23:47 in /builds/slave/test 14:23:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:23:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:47 INFO - {'append_to_log': False, 14:23:47 INFO - 'base_work_dir': '/builds/slave/test', 14:23:47 INFO - 'blob_upload_branch': 'Firefox', 14:23:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:47 INFO - 'branch': 'Firefox', 14:23:47 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:47 INFO - 'config_files': ('talos/mac_config.py',), 14:23:47 INFO - 'default_actions': ('clobber', 14:23:47 INFO - 'read-buildbot-config', 14:23:47 INFO - 'download-and-extract', 14:23:47 INFO - 'populate-webroot', 14:23:47 INFO - 'create-virtualenv', 14:23:47 INFO - 'install', 14:23:47 INFO - 'run-tests'), 14:23:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:47 INFO - 'download_minidump_stackwalk': True, 14:23:47 INFO - 'download_symbols': 'ondemand', 14:23:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:47 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:47 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:47 INFO - 'gecko_profile': False, 14:23:47 INFO - 'gecko_profile_interval': 0, 14:23:47 INFO - 'installer_path': 'installer.exe', 14:23:47 INFO - 'log_level': 'info', 14:23:47 INFO - 'log_name': 'talos', 14:23:47 INFO - 'log_to_console': True, 14:23:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:23:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:23:47 INFO - 'opt_config_files': (), 14:23:47 INFO - 'pip_index': False, 14:23:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:47 INFO - 'cmd': ('bash', 14:23:47 INFO - '-c', 14:23:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:47 INFO - 'enabled': True, 14:23:47 INFO - 'halt_on_failure': False, 14:23:47 INFO - 'name': 'check_screen_resolution'},), 14:23:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:47 INFO - 'cmd': ('bash', 14:23:47 INFO - '-c', 14:23:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:47 INFO - 'enabled': True, 14:23:47 INFO - 'halt_on_failure': False, 14:23:47 INFO - 'name': 'check_screen_resolution'},), 14:23:47 INFO - 'run_cmd_checks_enabled': True, 14:23:47 INFO - 'suite': 'dromaeojs', 14:23:47 INFO - 'system_bits': '32', 14:23:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:47 INFO - 'title': 't-yosemite-r7-0116', 14:23:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:47 INFO - 'use_talos_json': True, 14:23:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:47 INFO - 'work_dir': 'build'} 14:23:47 INFO - [mozharness: 2017-04-17 21:23:47.514534Z] Running clobber step. 14:23:47 INFO - Running pre-action listener: _resource_record_pre_action 14:23:47 INFO - Running main action method: clobber 14:23:47 INFO - rmtree: /builds/slave/test/build 14:23:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:49 INFO - Running post-action listener: _resource_record_post_action 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.986330Z] Finished clobber step (success) 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.986505Z] Running read-buildbot-config step. 14:23:49 INFO - Running pre-action listener: _resource_record_pre_action 14:23:49 INFO - Running main action method: read_buildbot_config 14:23:49 INFO - Using buildbot properties: 14:23:49 INFO - { 14:23:49 INFO - "project": "", 14:23:49 INFO - "product": "firefox", 14:23:49 INFO - "script_repo_revision": "production", 14:23:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:23:49 INFO - "repository": "", 14:23:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:23:49 INFO - "buildid": "20170417125706", 14:23:49 INFO - "pgo_build": "False", 14:23:49 INFO - "basedir": "/builds/slave/test", 14:23:49 INFO - "buildnumber": 8, 14:23:49 INFO - "slavename": "t-yosemite-r7-0116", 14:23:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:23:49 INFO - "platform": "yosemite_r7", 14:23:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:23:49 INFO - "branch": "mozilla-central", 14:23:49 INFO - "repo_path": "mozilla-central", 14:23:49 INFO - "revision": "a374c35469935a874fefe64d3e07003fc5bc8884", 14:23:49 INFO - "stage_platform": "macosx64", 14:23:49 INFO - "builduid": "0507d00f0a074ff395080681187cceb9", 14:23:49 INFO - "slavebuilddir": "test" 14:23:49 INFO - } 14:23:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:23:49 INFO - Running post-action listener: _resource_record_post_action 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.989783Z] Finished read-buildbot-config step (success) 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.989928Z] Running download-and-extract step. 14:23:49 INFO - Running pre-action listener: _resource_record_pre_action 14:23:49 INFO - Running main action method: download_and_extract 14:23:49 INFO - mkdir: /builds/slave/test/build/tests 14:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:49 INFO - trying https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:49 INFO - Downloading https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 14:23:51 INFO - Downloaded 1325 bytes. 14:23:51 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:51 INFO - Using the following test package requirements: 14:23:51 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:23:51 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:23:51 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:23:51 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:23:51 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'jsshell-mac.zip'], 14:23:51 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:23:51 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:23:51 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:23:51 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:23:51 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:23:51 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:51 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:23:51 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:23:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:23:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:23:51 INFO - Fetch https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:23:53 INFO - Expected file size: 52666944 14:23:53 INFO - Obtained file size: 52666944 14:24:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:24:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:24:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:24:09 INFO - Fetch https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:24:11 INFO - Expected file size: 52666944 14:24:11 INFO - Obtained file size: 52666944 14:24:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:24:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:24:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:24:28 INFO - Expected file size: 14408802 14:24:28 INFO - Obtained file size: 14408802 14:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:28 INFO - trying https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:28 INFO - Downloading https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 14:24:30 INFO - Downloaded 71419386 bytes. 14:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:30 INFO - mkdir: /builds/slave/test/properties 14:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:30 INFO - Contents: 14:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:31 INFO - Running post-action listener: _resource_record_post_action 14:24:31 INFO - Running post-action listener: set_extra_try_arguments 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.608668Z] Finished download-and-extract step (success) 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.608829Z] Running populate-webroot step. 14:24:31 INFO - Running pre-action listener: _resource_record_pre_action 14:24:31 INFO - Running main action method: populate_webroot 14:24:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:31 INFO - '--tppagecycles', 14:24:31 INFO - '7'], 14:24:31 INFO - 'tests': ['tsvgm']}}, 14:24:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['damp', 'tps']}, 14:24:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'tests': ['damp', 'tps']}, 14:24:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['dromaeo_dom']}, 14:24:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:24:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:24:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:24:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:24:31 INFO - 'bloom_basic_ref']}, 14:24:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tsvgx', 14:24:31 INFO - 'tsvgr_opacity', 14:24:31 INFO - 'tart', 14:24:31 INFO - 'tscrollx', 14:24:31 INFO - 'cart', 14:24:31 INFO - 'tsvg_static']}, 14:24:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:31 INFO - 'tsvgr_opacity', 14:24:31 INFO - 'tart', 14:24:31 INFO - 'tscrollx', 14:24:31 INFO - 'cart', 14:24:31 INFO - 'tsvg_static']}, 14:24:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tp5o']}, 14:24:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:24:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s', 14:24:31 INFO - '--xperf_path', 14:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:31 INFO - 'tests': ['tp5n']}, 14:24:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--xperf_path', 14:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:31 INFO - 'tests': ['tp5n']}}, 14:24:31 INFO - 'talos.zip': {'path': '', 14:24:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:31 INFO - Running post-action listener: _resource_record_post_action 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.627913Z] Finished populate-webroot step (success) 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.628042Z] Running create-virtualenv step. 14:24:31 INFO - Running pre-action listener: _resource_record_pre_action 14:24:31 INFO - Running main action method: create_virtualenv 14:24:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:24:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:31 INFO - Using real prefix '/tools/python27' 14:24:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:32 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:35 INFO - Installing pip.................done. 14:24:35 INFO - Return code: 0 14:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:24:35 INFO - Reading from file tmpfile_stdout 14:24:35 INFO - Output received: 14:24:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:24:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:35 INFO - 'HOME': '/Users/cltbld', 14:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:35 INFO - 'LOGNAME': 'cltbld', 14:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:35 INFO - 'MOZ_NO_REMOTE': '1', 14:24:35 INFO - 'NO_EM_RESTART': '1', 14:24:35 INFO - 'PAGER': '/bin/cat', 14:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:35 INFO - 'PWD': '/builds/slave/test', 14:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:35 INFO - 'SHELL': '/bin/bash', 14:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:35 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:35 INFO - 'USER': 'cltbld', 14:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:35 INFO - 'XPC_FLAGS': '0x0', 14:24:35 INFO - 'XPC_SERVICE_NAME': '0', 14:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:24:35 INFO - Cleaning up... 14:24:35 INFO - Return code: 0 14:24:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:35 INFO - 'HOME': '/Users/cltbld', 14:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:35 INFO - 'LOGNAME': 'cltbld', 14:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:35 INFO - 'MOZ_NO_REMOTE': '1', 14:24:35 INFO - 'NO_EM_RESTART': '1', 14:24:35 INFO - 'PAGER': '/bin/cat', 14:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:35 INFO - 'PWD': '/builds/slave/test', 14:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:35 INFO - 'SHELL': '/bin/bash', 14:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:35 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:35 INFO - 'USER': 'cltbld', 14:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:35 INFO - 'XPC_FLAGS': '0x0', 14:24:35 INFO - 'XPC_SERVICE_NAME': '0', 14:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:36 INFO - Downloading/unpacking psutil>=3.1.1 14:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:39 INFO - Installing collected packages: psutil 14:24:39 INFO - Running setup.py install for psutil 14:24:39 INFO - building 'psutil._psutil_osx' extension 14:24:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:24:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:24:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:24:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:24:40 INFO - building 'psutil._psutil_posix' extension 14:24:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:24:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:24:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:24:40 INFO - ^ 14:24:40 INFO - 1 warning generated. 14:24:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:24:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:41 INFO - Successfully installed psutil 14:24:41 INFO - Cleaning up... 14:24:41 INFO - Return code: 0 14:24:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:41 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:41 INFO - 'HOME': '/Users/cltbld', 14:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:41 INFO - 'LOGNAME': 'cltbld', 14:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:41 INFO - 'MOZ_NO_REMOTE': '1', 14:24:41 INFO - 'NO_EM_RESTART': '1', 14:24:41 INFO - 'PAGER': '/bin/cat', 14:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:41 INFO - 'PWD': '/builds/slave/test', 14:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:41 INFO - 'SHELL': '/bin/bash', 14:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:41 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:41 INFO - 'USER': 'cltbld', 14:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:41 INFO - 'XPC_FLAGS': '0x0', 14:24:41 INFO - 'XPC_SERVICE_NAME': '0', 14:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:44 INFO - Installing collected packages: mozsystemmonitor 14:24:44 INFO - Running setup.py install for mozsystemmonitor 14:24:44 INFO - Successfully installed mozsystemmonitor 14:24:44 INFO - Cleaning up... 14:24:44 INFO - Return code: 0 14:24:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:44 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:44 INFO - 'HOME': '/Users/cltbld', 14:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:44 INFO - 'LOGNAME': 'cltbld', 14:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:44 INFO - 'MOZ_NO_REMOTE': '1', 14:24:44 INFO - 'NO_EM_RESTART': '1', 14:24:44 INFO - 'PAGER': '/bin/cat', 14:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:44 INFO - 'PWD': '/builds/slave/test', 14:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:44 INFO - 'SHELL': '/bin/bash', 14:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:44 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:44 INFO - 'USER': 'cltbld', 14:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:44 INFO - 'XPC_FLAGS': '0x0', 14:24:44 INFO - 'XPC_SERVICE_NAME': '0', 14:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:47 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:47 INFO - warning: no files found matching '*.txt' 14:24:47 INFO - no previously-included directories found matching 'build' 14:24:47 INFO - no previously-included directories found matching 'dist' 14:24:47 INFO - no previously-included directories found matching '.git*' 14:24:47 INFO - Installing collected packages: jsonschema, functools32 14:24:47 INFO - Running setup.py install for functools32 14:24:47 INFO - warning: no files found matching '*.txt' 14:24:47 INFO - no previously-included directories found matching 'build' 14:24:47 INFO - no previously-included directories found matching 'dist' 14:24:47 INFO - no previously-included directories found matching '.git*' 14:24:47 INFO - Successfully installed jsonschema functools32 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:47 INFO - 'HOME': '/Users/cltbld', 14:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:47 INFO - 'LOGNAME': 'cltbld', 14:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:47 INFO - 'MOZ_NO_REMOTE': '1', 14:24:47 INFO - 'NO_EM_RESTART': '1', 14:24:47 INFO - 'PAGER': '/bin/cat', 14:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:47 INFO - 'PWD': '/builds/slave/test', 14:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:47 INFO - 'SHELL': '/bin/bash', 14:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:47 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:47 INFO - 'USER': 'cltbld', 14:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:47 INFO - 'XPC_FLAGS': '0x0', 14:24:47 INFO - 'XPC_SERVICE_NAME': '0', 14:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:48 INFO - Cleaning up... 14:24:48 INFO - Return code: 0 14:24:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:48 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:48 INFO - 'HOME': '/Users/cltbld', 14:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:48 INFO - 'LOGNAME': 'cltbld', 14:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:48 INFO - 'MOZ_NO_REMOTE': '1', 14:24:48 INFO - 'NO_EM_RESTART': '1', 14:24:48 INFO - 'PAGER': '/bin/cat', 14:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:48 INFO - 'PWD': '/builds/slave/test', 14:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:48 INFO - 'SHELL': '/bin/bash', 14:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:48 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:48 INFO - 'USER': 'cltbld', 14:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:48 INFO - 'XPC_FLAGS': '0x0', 14:24:48 INFO - 'XPC_SERVICE_NAME': '0', 14:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:52 INFO - Downloading docopt-0.6.1.tar.gz 14:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:52 INFO - Running setup.py install for blobuploader 14:24:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:52 INFO - Running setup.py install for requests 14:24:53 INFO - Running setup.py install for docopt 14:24:53 INFO - Successfully installed blobuploader requests docopt 14:24:53 INFO - Cleaning up... 14:24:53 INFO - Return code: 0 14:24:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:53 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:53 INFO - 'HOME': '/Users/cltbld', 14:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:53 INFO - 'LOGNAME': 'cltbld', 14:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:53 INFO - 'MOZ_NO_REMOTE': '1', 14:24:53 INFO - 'NO_EM_RESTART': '1', 14:24:53 INFO - 'PAGER': '/bin/cat', 14:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:53 INFO - 'PWD': '/builds/slave/test', 14:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:53 INFO - 'SHELL': '/bin/bash', 14:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:53 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:53 INFO - 'USER': 'cltbld', 14:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:53 INFO - 'XPC_FLAGS': '0x0', 14:24:53 INFO - 'XPC_SERVICE_NAME': '0', 14:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-wBlysh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-PT8b1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-lQ_9Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Se6uwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Lv1Brm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-lV9UCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-FwaSOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-o8jfxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-nXUWKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-iX4MRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-oUmY2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2GK362-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-bLVu9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:55 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-5yJRrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:55 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Se8GD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:55 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-CJJW6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:55 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-p_XX15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:55 INFO - Running setup.py install for manifestparser 14:24:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:55 INFO - Running setup.py install for mozcrash 14:24:55 INFO - Running setup.py install for mozdebug 14:24:55 INFO - Running setup.py install for mozdevice 14:24:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozfile 14:24:56 INFO - Running setup.py install for mozhttpd 14:24:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozinfo 14:24:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozInstall 14:24:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozleak 14:24:56 INFO - Running setup.py install for mozlog 14:24:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for moznetwork 14:24:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozprocess 14:24:57 INFO - Running setup.py install for mozprofile 14:24:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozrunner 14:24:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozscreenshot 14:24:57 INFO - Running setup.py install for moztest 14:24:57 INFO - Running setup.py install for mozversion 14:24:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:57 INFO - Cleaning up... 14:24:58 INFO - Return code: 0 14:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:58 INFO - 'HOME': '/Users/cltbld', 14:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:58 INFO - 'LOGNAME': 'cltbld', 14:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:58 INFO - 'MOZ_NO_REMOTE': '1', 14:24:58 INFO - 'NO_EM_RESTART': '1', 14:24:58 INFO - 'PAGER': '/bin/cat', 14:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:58 INFO - 'PWD': '/builds/slave/test', 14:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:58 INFO - 'SHELL': '/bin/bash', 14:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:24:58 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:58 INFO - 'USER': 'cltbld', 14:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:58 INFO - 'XPC_FLAGS': '0x0', 14:24:58 INFO - 'XPC_SERVICE_NAME': '0', 14:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-JuUeP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-19svNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Z5gWTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-rfFyky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-nbFUUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-yIP7Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-4wMaeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6niA4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-UAJRAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-_kIJsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-KDziL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-HBj1HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-nhqmoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-TIV8yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ONWky4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-GzDWQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9pdV8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:25:00 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:25:00 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:25:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:02 INFO - Downloading blessings-1.6.tar.gz 14:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:25:02 INFO - Installing collected packages: blessings 14:25:02 INFO - Running setup.py install for blessings 14:25:03 INFO - Successfully installed blessings 14:25:03 INFO - Cleaning up... 14:25:03 INFO - Return code: 0 14:25:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:03 INFO - Reading from file tmpfile_stdout 14:25:03 INFO - Current package versions: 14:25:03 INFO - blessings == 1.6 14:25:03 INFO - blobuploader == 1.2.4 14:25:03 INFO - docopt == 0.6.1 14:25:03 INFO - functools32 == 3.2.3-2 14:25:03 INFO - jsonschema == 2.5.1 14:25:03 INFO - manifestparser == 1.1 14:25:03 INFO - mozInstall == 1.12 14:25:03 INFO - mozcrash == 1.0 14:25:03 INFO - mozdebug == 0.1 14:25:03 INFO - mozdevice == 0.50 14:25:03 INFO - mozfile == 1.2 14:25:03 INFO - mozhttpd == 0.7 14:25:03 INFO - mozinfo == 0.9 14:25:03 INFO - mozleak == 0.1 14:25:03 INFO - mozlog == 3.4 14:25:03 INFO - moznetwork == 0.27 14:25:03 INFO - mozprocess == 0.25 14:25:03 INFO - mozprofile == 0.28 14:25:03 INFO - mozrunner == 6.13 14:25:03 INFO - mozscreenshot == 0.1 14:25:03 INFO - mozsystemmonitor == 0.3 14:25:03 INFO - moztest == 0.8 14:25:03 INFO - mozversion == 1.4 14:25:03 INFO - psutil == 3.1.1 14:25:03 INFO - requests == 1.2.3 14:25:03 INFO - wsgiref == 0.1.2 14:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:03 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 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:03 INFO - 'HOME': '/Users/cltbld', 14:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:03 INFO - 'LOGNAME': 'cltbld', 14:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:03 INFO - 'MOZ_NO_REMOTE': '1', 14:25:03 INFO - 'NO_EM_RESTART': '1', 14:25:03 INFO - 'PAGER': '/bin/cat', 14:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:03 INFO - 'PWD': '/builds/slave/test', 14:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:03 INFO - 'SHELL': '/bin/bash', 14:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:25:03 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:03 INFO - 'USER': 'cltbld', 14:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:03 INFO - 'XPC_FLAGS': '0x0', 14:25:03 INFO - 'XPC_SERVICE_NAME': '0', 14:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:25:03 INFO - Cleaning up... 14:25:03 INFO - Return code: 0 14:25:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9748585a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, '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.LKXSYDmItJ/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.LksVRpDlY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:03 INFO - 'HOME': '/Users/cltbld', 14:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:03 INFO - 'LOGNAME': 'cltbld', 14:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:03 INFO - 'MOZ_NO_REMOTE': '1', 14:25:03 INFO - 'NO_EM_RESTART': '1', 14:25:03 INFO - 'PAGER': '/bin/cat', 14:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:03 INFO - 'PWD': '/builds/slave/test', 14:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:03 INFO - 'SHELL': '/bin/bash', 14:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:25:03 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:03 INFO - 'USER': 'cltbld', 14:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:03 INFO - 'XPC_FLAGS': '0x0', 14:25:03 INFO - 'XPC_SERVICE_NAME': '0', 14:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:25:03 INFO - Cleaning up... 14:25:03 INFO - Return code: 0 14:25:03 INFO - Running post-action listener: _resource_record_post_action 14:25:03 INFO - Running post-action listener: _start_resource_monitoring 14:25:03 INFO - Starting resource monitoring. 14:25:03 INFO - [mozharness: 2017-04-17 21:25:03.967895Z] Finished create-virtualenv step (success) 14:25:03 INFO - [mozharness: 2017-04-17 21:25:03.968912Z] Running install step. 14:25:03 INFO - Running pre-action listener: _resource_record_pre_action 14:25:03 INFO - Running main action method: install 14:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:04 INFO - Reading from file tmpfile_stdout 14:25:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:25:04 INFO - Reading from file tmpfile_stdout 14:25:04 INFO - Output received: 14:25:04 INFO - Usage: mozinstall [options] installer 14:25:04 INFO - Options: 14:25:04 INFO - -h, --help show this help message and exit 14:25:04 INFO - -d DEST, --destination=DEST 14:25:04 INFO - Directory to install application into. [default: 14:25:04 INFO - "/builds/slave/test"] 14:25:04 INFO - --app=APP Application being installed. [default: firefox] 14:25:04 INFO - mkdir: /builds/slave/test/build/application 14:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:25:24 INFO - Reading from file tmpfile_stdout 14:25:24 INFO - Output received: 14:25:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:25:24 INFO - Running post-action listener: _resource_record_post_action 14:25:24 INFO - [mozharness: 2017-04-17 21:25:24.037518Z] Finished install step (success) 14:25:24 INFO - [mozharness: 2017-04-17 21:25:24.037665Z] Running run-tests step. 14:25:24 INFO - Running pre-action listener: _resource_record_pre_action 14:25:24 INFO - Running main action method: run_tests 14:25:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:24 INFO - 2017-04-17 14:25:24.052 screenresolution[1628:8117] starting screenresolution argv=screenresolution get 14:25:24 INFO - 2017-04-17 14:25:24.055 screenresolution[1628:8117] Display 0: 1600x1200x32@60 14:25:24 INFO - 2017-04-17 14:25:24.060 screenresolution[1629:8120] starting screenresolution argv=screenresolution list 14:25:24 INFO - Available Modes on Display 0 14:25:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:24 INFO - Intel Iris: 14:25:24 INFO - Chipset Model: Intel Iris 14:25:24 INFO - Type: GPU 14:25:24 INFO - Bus: Built-In 14:25:24 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:24 INFO - Vendor: Intel (0x8086) 14:25:24 INFO - Device ID: 0x0a2e 14:25:24 INFO - Revision ID: 0x0009 14:25:24 INFO - Displays: 14:25:24 INFO - Display: 14:25:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:24 INFO - Display Serial Number: 1600x1200 60 14:25:24 INFO - Main Display: Yes 14:25:24 INFO - Mirror: Off 14:25:24 INFO - Online: Yes 14:25:24 INFO - Rotation: Supported 14:25:24 INFO - Return code: 0 14:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:24 INFO - Python 2.7.3 14:25:24 INFO - Return code: 0 14:25:24 INFO - grabbing minidump binary from tooltool 14:25: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')]} 14:25:24 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 0x1045c0d30>, '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 0x1044e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045b5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:25:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:25:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:25:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:24 INFO - Return code: 0 14:25:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:25:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:24 INFO - ENV: RUST_BACKTRACE is now 1 14:25:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:25:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LKXSYDmItJ/Render', 14:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:24 INFO - 'HOME': '/Users/cltbld', 14:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:24 INFO - 'LOGNAME': 'cltbld', 14:25:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:24 INFO - 'MOZ_NO_REMOTE': '1', 14:25:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:24 INFO - 'NO_EM_RESTART': '1', 14:25:24 INFO - 'PAGER': '/bin/cat', 14:25:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:24 INFO - 'PWD': '/builds/slave/test', 14:25:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:24 INFO - 'RUST_BACKTRACE': '1', 14:25:24 INFO - 'SHELL': '/bin/bash', 14:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LksVRpDlY3/Listeners', 14:25:24 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 14:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:24 INFO - 'USER': 'cltbld', 14:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:24 INFO - 'XPC_FLAGS': '0x0', 14:25:24 INFO - 'XPC_SERVICE_NAME': '0', 14:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:25:24 INFO - mozversion application_buildid: 20170417125706 14:25:24 INFO - mozversion application_changeset: a374c35469935a874fefe64d3e07003fc5bc8884 14:25:24 INFO - mozversion application_display_name: Nightly 14:25:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:24 INFO - mozversion application_name: Firefox 14:25:24 INFO - mozversion application_remotingname: firefox 14:25:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:25:24 INFO - mozversion application_vendor: Mozilla 14:25:24 INFO - mozversion application_version: 55.0a1 14:25:24 INFO - mozversion platform_buildid: 20170417125706 14:25:24 INFO - mozversion platform_changeset: a374c35469935a874fefe64d3e07003fc5bc8884 14:25:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:25:24 INFO - mozversion platform_version: 55.0a1 14:25:24 INFO - using testdate: 1492464324 14:25:24 INFO - actual date: 1492464324 14:25:24 INFO - starting webserver on 'localhost:49244' 14:25:24 INFO - SUITE-START | Running 2 tests 14:25:24 INFO - TEST-START | dromaeo_css 14:25:24 INFO - operating with platform_type : mac_ 14:25:24 INFO - Initialising browser for dromaeo_css test... 14:25:24 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpkXJJvG/profile http://localhost:49244/getInfo.html) 14:25:27 INFO - PID 1639 | __metrics Screen width/height:1600/1200 14:25:27 INFO - PID 1639 | colorDepth:24 14:25:27 INFO - PID 1639 | Browser inner width/height: 1024/689 14:25:27 INFO - PID 1639 | __metrics 14:25:27 INFO - PID 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:25:27 INFO - PID 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:28 INFO - TEST-INFO | 1639: exit 0 14:25:28 INFO - Browser initialized. 14:25:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:28 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpkXJJvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:41 INFO - PID 1642 | RSS: Main: 242528256 14:25:41 INFO - PID 1642 | 14:28:45 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 14:28:47 INFO - PID 1642 | RSS: Main: 437809152 14:28:47 INFO - PID 1642 | 14:30:30 INFO - PID 1642 | ************************* 14:30:30 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 14:30:30 INFO - PID 1642 | 14:30:30 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:30 INFO - PID 1642 | Full stack: 14:30:30 INFO - PID 1642 | ************************* 14:30:30 INFO - PID 1642 | ************************* 14:30:30 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 14:30:30 INFO - PID 1642 | 14:30:30 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:30 INFO - PID 1642 | Full stack: 14:30:30 INFO - PID 1642 | ************************* 14:30:30 INFO - PID 1642 | ************************* 14:30:30 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 14:30:30 INFO - PID 1642 | 14:30:30 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:30 INFO - PID 1642 | Full stack: 14:30:30 INFO - PID 1642 | ************************* 14:30:30 INFO - PID 1642 | ************************* 14:30:30 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 14:30:30 INFO - PID 1642 | 14:30:30 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:30 INFO - PID 1642 | Full stack: 14:30:30 INFO - PID 1642 | ************************* 14:31:50 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 14:31:51 INFO - PID 1642 | RSS: Main: 371281920 14:31:51 INFO - PID 1642 | 14:34:53 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 14:34:53 INFO - PID 1642 | RSS: Main: 335699968 14:34:53 INFO - PID 1642 | 14:37:56 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 14:37:57 INFO - PID 1642 | RSS: Main: 334761984 14:37:57 INFO - PID 1642 | 14:41:00 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 14:41:01 INFO - PID 1642 | RSS: Main: 333828096 14:41:01 INFO - PID 1642 | 14:44:03 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 14:44:04 INFO - PID 1642 | RSS: Main: 377421824 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | __start_tp_report 14:44:04 INFO - PID 1642 | _x_x_mozilla_page_load 14:44:04 INFO - PID 1642 | _x_x_mozilla_page_load_details 14:44:04 INFO - PID 1642 | |i|pagename|runs| 14:44:04 INFO - PID 1642 | |0;dojo.html;3516.701080408165;3522.542069530961;3524;3551.1299731565764;3581.409067503862;5648.943510564893;5665.611925078357;5969.522438204944;6123.755049798014;6178.28949670788;6084.695765211733;6139.631622102677;6155.891939450897;6160.414760597736;6207.968960155193;5141.254518094874;5288.973555132238;5328.5470734987575;5338.332708411449;5370.248165256867;5390.272313237702;5448.536874365664;5449.6730196188155;5450.018996580634;5506.779728810863;5266.710330931797;5324.334458192726;5336.146216605324;5337.3061502004875;5417.83746487606;5276.419593844674;5329.573634109262;5374.865628359284;5402.675839449606;5430.8913821723345;5292.947070529284;5326.121190003645;5339;5341.198820177005;5393.217983392426;6021.698915054273;6098.32918378978;6189.783357582508;6195.070739389128;6195.380461953769;6377.426031657174;6389.4568961638315;6487.448566871822;6500.739970401179;6518.543701940866;6597.80206593803;6600.4389626881775;6601.339866013408;6609.669516524203;6627.403533681943;6090.269167699905;6239.563230573862;6243;6248.5313601480075;6252.9370007098905;6459.612423254526;6573.901391479131;6601.603903765789;6606.768763093365;6612.735490580323;6311.842203944846;6315.715792789336;6318.083877837687;6348.206474190726;6383.776567820104;6491.285958544557;6533.477321814338;6552.246491653521;6559.4752419807255;6561.639109848908;6452.0967064610995;6455.096286519891;6457.61254324742;6463.192100987377;6463.741450342028;6289.622622642564;6342.587731797418;6426.74293028283;6477.902831457532;6489.286178520359;5250.842474725764;5255.369355677267;5256.526912577886;5272.077386457355;5299.39057008449;4624.468186158568;4672.976635116803;4673.836415725501;4675.649326300541;4691.202495575761;6122.418370254819;6148.370681769335;6172.382761723792;6197.690115494207;6283.434490895841;6526;6571.441427478622;6615.4376877965915;6629.900551491732;6631.933680663132;6266.530010249249;6270.090836828635;6272.686365681698;6286.151369565142;6293.559450838489;5630.07103827872;5645.915311270334;5747.597668163188;5760.8271751847515;5765.423457654285;6537.084808126866;6603.735850565923;6689.866202676017;6712.060311556288;6719.227288861844;6378.394052564999;6613.404793568409;6638.83402914931;6640.269570347355;6644.634545100066;6468.579542329733;6505.772297969548;6671.933280667131;6725.394714475525;6808.319168083152;5411.83764487066;6495.707693153914;6508.7721929734125;6515.315891831289;6525.967370163119;5412.675239485643;6348.174737284124;6393.552451328363;6406.295307516077;6613.570117942319;6263.906041409474;6298.590591611531;6303.590266632654;6327.557071004985;6343.841403964938;6282.434580887742;6283.994560870239;6288.811335659938;6288.905666414916;6348.952422850178;6245.18812554365;6283.403076707706;6294.8111556653375;6308.873822523616;6309.747610095545;5848;6187.721552530057;6421.197350331208;6423.582467139621;6441.066045423294;6168.537359698131;6172.012478003498;6252.280987686474;6257.124002639725;6270.467010304175 14:44:04 INFO - PID 1642 | |1;ext.html;791.7783020754189;811.3752410643805;1119.5913491575577;1139.8290256461526;1152.596591193083;35376.82311588445;35851;36052.9184124476;36129.819350903206;36257.274854502924;38198.236035279275;38426.61573384266;38573;38619.613803861954;38643.22713545727;6078.057901025348;6222.12890195373;8435.325173986097;8549.401541892039;8649.437786543886;8280.04779450365;8457.66169353225;8493.490390576555;8495.915040849604;8512.446690965098;8530.104339044405;8580.227779499844;8582.098879617644;8609.95695021524;8623.95688021559;8493.787655308635;8554.52950087745;8556.272716819078;8577.52823594702;8583.184597463262;8412.200840920103;8432.578371081421;8448.746537603882;8466.78833029173;8472.237498625153;36881.70914018023;36883.44674829853;36917.07707307312;36958.260834783156;37059.44410833839;3674.6325367463305;3708.9072773180615;3714.7028237740915;3715.647013533737;3716.5168528091444;21334.573308533898;30187.547186792217;30352.84823575868;30364.937227197162;30424.93512727044;3129;3156.921076973071;3167.31902640931;3181.475056615656;3185.824779637119;296035;302320;303501.9999999978;304332;304410;39049.804750976065;39872.41148296667;40000.59999400027;48824.02351952941;48933.86194449603;48831.511684882695;49513.75243123761;49549;49615.759606009415;49655;11646.76706465866;14019.50931717385;14080.295985200699;14151.29243537819;14181.865450763915;11550.59572914944;11557.595484158013;11573.88426115745;11582.76834463306;11641.47613357401;11717.296962182127;11733;11735.354555499358;11756.823647645293;11872.168948173718;5407.756650950717;5411.161270003156;5415.972920135374;5417.5395091416885;5439.238506609078;993.2054356514903;1003.6687892995294;1010.1464262698008;1038.5430410619304;1039.8146113430696;23150;24456.633150502756;30027.39945201084;30091.398172036876;30574.54138187929;1060.6870973062964;1070.6734445994045;1096.8848270931596;1108.955641774336;1113.87190473095;12285;12368.44342004612;12379.195352302071;12379.75240495185;12381.504739810307;320308;320982;321609;321869;321905;51092;51109;51142.977140456984;51417.971640567725;51626;1491.0904348347717;1498.071195858553;1540.4993377152246;1546.4355510238906;1564.2491604030129;19443.70834437513;23300.53398932046;23590.764092359543;23615.173468928504;23669.053237870292;37447.25105497929;37651;37654.43518347172;37670.434943475324;37715.43426848545;287109;287442;288267;288777;288805;27732;28248.011319603716;31547.842260788548;32117.839410802797;32360.190995225308;41228.1754364905;42119.789401054026;42136;42365.152696945275;42381;22974.540509189388;27715.861420692767;28634.854605815533;29210.269743256587;29572.964946226777;26996;27208.863955680095;29507.409851803273;29508.262293442836;29716.95990640317;34396.48405273873;34664.480032800035;34771.65228347684;34790.13024674403;34876.12809679778;28470.43059138764;28661.28346791347;29065.854670726512;30000.549991749704;30351.544726828673;19345.51636209106;21922;22196.889015554818;23050.077996879936;23500.88249558741 14:44:04 INFO - PID 1642 | |2;jquery.html;421.94902088647666;432.3644242962844;433.49360970627095;436.9519352871184;451.8328218559134;19310.71033934492;20854.644448110863;21067.683984740223;21702.782972170273;21870.562588748235;18563.443096707088;21295.68056479154;21553.46116347092;21590.784092159072;22184.445388865286;6056.51547876171;6355.9364406356035;6356.872862542747;6359.8410039748915;6364.77723279683;6024.879502409949;6157.538184636148;6271.372862713715;6331.8417039573915;6350.047492876082;6196.132541444202;6264.21697287839;6286.088517165008;6295.559310848243;6305;5973.283206015284;6151.169592105053;6156.5998210116195;6161.445469907708;6168.87662246757;5364.329458817648;5396.946030539683;5504.504594586507;5505.256790333294;5528.55771538276;23449.76550234493;26935.383876967444;27652;27940.860295698392;28408.147755567366;2161.805437510616;2234.8100411465043;2236.2061468178886;2236.9217077402213;2237.630790919496;17887.10564471771;17913;18151.90924045371;18234.72647910269;18278.817211827845;2060.2171174953573;2096.6959790830397;2115.693224482457;2116.0689296709397;2121.140937920145;169574;170708;171737.98917037842;172016;173909;12173.817392739116;12349.93825030869;12454.190477618926;12500.624981250578;12730.23618582888;16642.16789160537;16686.916565417338;16752.664946701;16754.832451675327;16774.916125419295;8347.2021716923;8657.307415406753;8683.956580217186;8810.515421651871;8813.206811387006;7992.760217193493;8056.798580035546;8070.47541909774;8220.917790822015;8234.423590348739;6452.290248072708;7845.1762564931005;7872.212778722082;7891.58071479973;7903.56530390834;1818.0636971959452;2085.4786303424144;2091.8326533877253;2102.421833995633;2111.197744856975;804.9195080492021;918.7840857398506;925.6852670092067;933.9906600934039;974.449436068619;20569.48576285605;20574.279900203423;21180.78819211819;21248.468788280417;21479.67780483294;948.9572969216264;961.2022021721954;993.9950300248597;996.4917891875195;999.5901680311038;10592.470376481146;10889.074428673652;10932.961368669963;10952.780944381067;10961.616343427942;556334;563691;571243.1437842867;572170;572266;97880.04239915161;133218;136188.95716564258;137982.24035519233;142856;1169.7368092179192;1170.4440390814466;1180.4628893853276;1199.5082016373244;1201.585453018707;18153.818461815743;18223.81776182221;18272.451826445227;18372.632547348712;18398.632027359647;55571.77712891439;58273.543161419606;58876;59118;59212.11181832362;69023.65488172729;79161.2083879177;81944.59027704824;82317.58841205755;83996.16003839884;8361.456505327134;8658.657908024266;9040.231580315747;9076.591553380245;9143.817123657356;14499.637509062359;14530.709385812013;14718.0433271837;14881;14910.77633835515;10526.78946421052;11897.286162830258;11906.749791272137;12190.57332993341;12330.136890417585;11033.558657653924;11056.447177641247;11490.77018459643;11503.597374091867;11746.119041071783;12086.153969222421;12283.508659653513;12459.190152640049;12491.063170262085;12521.56174533887;8838.646454141763;8841.425307355;9101.044390338919;9107.408018478778;9318.347715659838;11890.643280701594;11996.700082498008;12195.878041219474;12306;12356.073294502768 14:44:04 INFO - PID 1642 | |3;mootools.html;1208.0878936403014;1398.9860101398986;1464.7949287099807;1478.4899209772625;1482.8591283828032;8378.32973362131;10384.221183411237;11742;12111.212771169869;12209.877901220985;9823.65617203398;11691.947724704774;11794.410279486034;11825.822612660795;11868.287902725842;2115.9471013224716;2472.3077538289263;2524.3562891462743;2529.001044587387;2529.53203657324;1851.3057603398724;2168.1652563762987;2198.076807740753;2199.351191398533;2461.8153638477097;2506.4485813121173;2512.1835403493847;2520.760527749861;2528.532221539021;2533.9113131040417;2454.619533972237;2468.8642124683224;2473.715522714893;2475.7771800537857;2486.8010559155223;2427.987860060706;2447.5227330670527;2463.8152138589676;2483.5902076157413;2522.6216067590008;11681.299122052704;11973.102017348734;11986.760264794742;11988;11990.520379184822;6518.445932095778;6769.289224631392;6776.932230677679;6779.254282028973;6784;4011.919761604752;4259.041715613993;4343.305071188626;4344.89137771555;4356.172327257811;1095.6055819904827;1188.8276199951044;1225.4118023348842;1276.2725246609436;1278.603632873812;16735.414260500824;16757;16771.413000545046;16798.160091995353;16819.411320603842;5371.597130215249;5765.135229715493;5797.507211887037;5978;6048.60684055535;10399.896001040044;11574.71063223426;14034.017618766793;14086.577402677936;14110.294485275695;6782.287859774751;6787.762428315084;6803.523753337219;6815.454763618898;6820.079289295981;4661.347411362412;5488.765027868698;5691.9146212806845;6118.969405152946;6201.255849298113;3729.291434627412;3772.905677358088;4131.628153466202;4151.937720934188;4603.907921841612;1219.2136072233359;1424.886009119268;1435.9066660667024;1463.5389852196524;1477.0989696285258;677.3057615943599;793.773774474272;811.1726039439739;820.5445977482435;832.6086739232551;6503.967480162569;6806.7957961261245;6950.826229344307;7006.229314775371;7027.683754231072;890.3544929925752;945.9290553208536;951.7810903492098;954.1031430455349;954.4321128928276;4053.2704113259897;4208.116295577902;4283.443152390169;4336.544662810359;4363.4763828340165;14545;15194.316255768295;15205.163715995726;15217.847821521864;15226.619334516725;14385.64035899111;15121.848781512264;15128.621784455476;15142.621434464227;15143.242837858063;8528.786780330542;8703.521306328086;8759.430637008574;8775.517346546001;8788.60451279694;6911.965440172969;6976.197737260077;7048.894266585903;7162.242536623542;7188.6046267455795;13611.11527750693;13776.862231377558;13776.93111534436;13823.930880345533;14024.929875350557;13759.518416855362;14016;14047.488127968008;14201;14218.502352417616;9514.524273786421;9827.4103553787;9828;9833.508324583885;9839.60641574329;8421.915780842113;9854.950725246328;10869.565217391215;11019.889801102207;11022.944885275523;7653.579053151907;9106.362554621113;9229.123233293096;9265.629374824932;9352.251819854258;8251;8280.461769984931;8314.168583141638;8343.874841877498;8418.536980466133;6952.965235173791;8048.235417635316;8236.794080147805;8247.546384948886;8251;5943.613665111754;6021.066734656135;6058.606190597597;6103.6032657877095;6186;5781.699117698484;5959.344472108151;6180.196574445294;6248.4688801452385;6305.653189074645 14:44:04 INFO - PID 1642 | |4;prototype.html;381.67748252726454;390.19619583657663;403.10912882529607;408.80173116038696;409.2204350711891;5527.922055199238;5649.49154576088;5755.7697692092315;5756.079027355624;5760.268532809855;5076.64463487556;5097.184450487923;5465.535429488498;5592.4407559244055;5616.241807356006;4213.325867861143;4227.915441691157;4231;4234.195502854448;4241.215375155591;4030.093229023461;4171.707980441371;4222.641075508585;4229.788510574459;4248.383984322271;3601.5858176309666;3726.881935419377;4150.294449943517;4169.478815148106;4182.247195504808;4176.1230141670285;4178.6657067434535;4182.7490350578755;4186.183694179621;4197;3377.4427219508752;3679.779213247187;3684.5578530576236;3685.9406692445204;3692.2430901665093;5324.866878328034;5448.264484294648;5452.972735136299;5454.7272636368025;5476.5355589984265;4111.465509483778;4915.680480768739;4941.9258711119;4955.504449555052;4976.104301225778;5261.473852614746;5360.678359298455;5909.852253693649;5947.613405128653;5961.403859614047;3451.637578054293;4053.3109371406636;4081.387791831249;4093.488313960755;4110.17796440713;5024.045431368065;6005.039193728982;6014.8496287592725;6158.384161583896;6237.719302631393;4114.6091121343425;4188;4196.958030419718;4204.2432362175105;4208.705390622688;4069.5726948669962;4134.772587507656;4245.936310955338;4249.235137675249;4270.765107919095;4819.831305904347;4904;4910;4939.678920870132;4940.382452193476;5956.047032474783;5966.284045914431;5972.611780234271;5974.462298393166;5979.581429299994;1390.242317936727;1429.3139293139352;1431.5562175725559;1439.6400899775056;1443.4875619155048;941.6205259295166;962.2446379591987;970.6117552978724;972.4602845420859;982.8696998451837;4580.312953057068;4823.5658790709;5620.63696557511;5666.518345940642;5673.319201695823;5461.672299662033;5841.795537156179;6118.694065296718;6138.631682099089;6168.290646575701;4595.655325850575;5239.266502689627;5614.9438505615235;5623;5697.515711164598;3184.617845858512;3187.665295144023;3222.38774632819;3222.7099561039618;3240.0235856127742;4943.876403089952;5232.581393488512;6313.77901773445;6323.399277068671;6362.850389057447;5230.660007099526;5583.944160558423;6000.909986350208;6267.6866156691985;6333.398327158912;6307.810765677037;6332.271788744261;6339.492840572835;6357.618542887441;6364.363563643691;5617.887642247214;5945.708319595477;6011.248593925759;6154.584205765843;6158.784442544489;5320.255164277081;5756.7409466574945;6049.939500605114;6053.397039273154;6057.030875059969;5618.803341883015;5629.662220266797;5779.445640930881;5851.678157701367;6311.526635502448;4143;4157.064660451374;4168.8124034417915;4170;4194.811233494439;5500.944990550203;5526.834194974157;6164.058321628672;6207.596506227262;6208.671748094464;5956.493698035542;5966.612170208922;5970.641761494324;5979.475233815349;6053;5390.110631745875;5730.398308177748;5922.703864806656;5960.284765828128;5988.550858685703;5439.4288599696465;5813.709314534171;5859.970700146472;5886.852828679317;5910.881782364415;5238.921416178837;5286.524212820865;5818.876110219824;5983.910241346471;6008.87982240344;4622.1911165545225;5105.348460291711;5191.247269146028;5794.188813566188;5933.436323549256 14:44:04 INFO - PID 1642 | |5;yui.html;698.4691634357893;818.2840014986887;864.0495454999506;868.2663149638553;885.5793498088409;13739.725205495897;17982.370617028406;18094.276228950843;18788;18840.057997100143;12552.43514041868;17539.91230043848;18079.367222147193;18080.54798630035;18115.09424528775;979.1579241852002;1008.4050410257946;1012.5899010900561;1013.9594416223342;1016.1058268723513;676.7834293026209;695.6556504530265;990.3612170150249;1023.7798873242251;1031.2317323593934;1071.1805468816362;1073.688630297213;1074.414444127952;1075.0002497677158;1079.7570546627026;1060.1306928318782;1063.8510608514775;1066.807974564578;1071.2501249125644;1073.876504202015;795.8288967871878;796.5419883566972;796.6136423834436;798.4371018432049;804.0592506767097;15820.525384238492;16141.273642686107;16161.757573636405;16738.24677889498;16850.494485165465;15098.24508774568;15773.526794196192;15781.28984195714;16013.396985678246;16287.267072981744;13821.930890345484;14005.159690418608;14141.71716565663;14240.857591424057;14311.998160128795;3361.1429085583263;3384.3062172254627;3388.3731509670542;3391.847366868497;3393.0160253526697;120584.79415205824;121301.39349303374;122758.38620806928;122834.38582807028;123253;10990.835137472945;12237.938810305892;12440.19138755978;12454.377281135907;12577.685557861127;25156.371090722514;25217.117400890882;25372.238832835046;25593.744062559137;25690;7778.844423111619;8054.395920306;8080.4343695940715;8098.392620553482;8105.351571874236;3975.542812576533;4101.52832424269;4102.159057393227;4107.876763697094;4110.34234522475;4372.1692878353015;4424.867253982386;4436.489803672554;4482.887927801831;4491.326301054868;942.8962814090445;955.2692190474293;961.5721004153085;963.7494251494662;965.1217392173229;617.4813156948185;663.5056882622381;667.7729571945465;668.9866202675919;673.2089794491453;9507.191888689538;10814.78370432587;11452.797456267139;11677.474513646906;11761.470733817;631.8689545713122;663.1180529895228;668.2715839734713;669.9732010719516;699.9370056694922;5015.824446144367;5188.714620695898;5327.227552004938;5342.118550439134;5438.966596346681;96887;104266.95733042725;104513;105523.94476055141;107176.46411767892;83108.93876903558;85987.71018434729;86073;86614;86873;83221.16778832255;83503;84804.15195848086;85470;86658.56670716732;9603.663871764455;10780;10819.242653014213;10930.836037459285;11074.889251107386;28960.13119606415;42899;42952.57047429611;42979;43083;54571.72714136404;54819.725901371836;55495;55533.72233138808;56650.15024774549;14285.64285892861;14403.135811851322;14498.130112193303;14554.27228638585;14586.124832510084;15324;15847.128407937213;15856.286467108777;15916.840831591537;15933.203339833193;14536.563903082924;14538;14568.34442450071;14615.853841461874;14761.704765904407;13076.280804555841;13121.34393280313;13212.603621891358;13344.93240540735;13377.732445350845;13639.727205455636;14163.079399838978;14260.144391336553;14272.429102836186;14589.416423342947;9573.856392153984;10285.02292282232;10555.997180267863;10562.894371056498;10952.397618131079;11314.15143864197;11450.713732156762;11469.541218351173;11709.824352634547;11768.646940591796 14:44:04 INFO - PID 1642 | __end_tp_report 14:44:04 INFO - PID 1642 | __start_cc_report 14:44:04 INFO - PID 1642 | _x_x_mozilla_cycle_collect,2103 14:44:04 INFO - PID 1642 | __end_cc_report 14:44:04 INFO - PID 1642 | __startTimestamp1492465443996__endTimestamp 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | ------- Summary: start ------- 14:44:04 INFO - PID 1642 | Number of tests: 6 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6018.06 Median:6272.69 stddev:676.78 (10.8%) stddev-sans-first:649.78 14:44:04 INFO - PID 1642 | Values: 3516.7 3522.5 3524.0 3551.1 3581.4 5648.9 5665.6 5969.5 6123.8 6178.3 6084.7 6139.6 6155.9 6160.4 6208.0 5141.3 5289.0 5328.5 5338.3 5370.2 5390.3 5448.5 5449.7 5450.0 5506.8 5266.7 5324.3 5336.1 5337.3 5417.8 5276.4 5329.6 5374.9 5402.7 5430.9 5292.9 5326.1 5339.0 5341.2 5393.2 6021.7 6098.3 6189.8 6195.1 6195.4 6377.4 6389.5 6487.4 6500.7 6518.5 6597.8 6600.4 6601.3 6609.7 6627.4 6090.3 6239.6 6243.0 6248.5 6252.9 6459.6 6573.9 6601.6 6606.8 6612.7 6311.8 6315.7 6318.1 6348.2 6383.8 6491.3 6533.5 6552.2 6559.5 6561.6 6452.1 6455.1 6457.6 6463.2 6463.7 6289.6 6342.6 6426.7 6477.9 6489.3 5250.8 5255.4 5256.5 5272.1 5299.4 4624.5 4673.0 4673.8 4675.6 4691.2 6122.4 6148.4 6172.4 6197.7 6283.4 6526.0 6571.4 6615.4 6629.9 6631.9 6266.5 6270.1 6272.7 6286.2 6293.6 5630.1 5645.9 5747.6 5760.8 5765.4 6537.1 6603.7 6689.9 6712.1 6719.2 6378.4 6613.4 6638.8 6640.3 6644.6 6468.6 6505.8 6671.9 6725.4 6808.3 5411.8 6495.7 6508.8 6515.3 6526.0 5412.7 6348.2 6393.6 6406.3 6613.6 6263.9 6298.6 6303.6 6327.6 6343.8 6282.4 6284.0 6288.8 6288.9 6349.0 6245.2 6283.4 6294.8 6308.9 6309.7 5848.0 6187.7 6421.2 6423.6 6441.1 6168.5 6172.0 6252.3 6257.1 6270.5 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:44611.83 Median:320645.00 stddev:79871.46 (24.9%) stddev-sans-first:80027.76 14:44:04 INFO - PID 1642 | Values: 791.8 811.4 1119.6 1139.8 1152.6 35376.8 35851.0 36052.9 36129.8 36257.3 38198.2 38426.6 38573.0 38619.6 38643.2 6078.1 6222.1 8435.3 8549.4 8649.4 8280.0 8457.7 8493.5 8495.9 8512.4 8530.1 8580.2 8582.1 8610.0 8624.0 8493.8 8554.5 8556.3 8577.5 8583.2 8412.2 8432.6 8448.7 8466.8 8472.2 36881.7 36883.4 36917.1 36958.3 37059.4 3674.6 3708.9 3714.7 3715.6 3716.5 21334.6 30187.5 30352.8 30364.9 30424.9 3129.0 3156.9 3167.3 3181.5 3185.8 296035.0 302320.0 303502.0 304332.0 304410.0 39049.8 39872.4 40000.6 48824.0 48933.9 48831.5 49513.8 49549.0 49615.8 49655.0 11646.8 14019.5 14080.3 14151.3 14181.9 11550.6 11557.6 11573.9 11582.8 11641.5 11717.3 11733.0 11735.4 11756.8 11872.2 5407.8 5411.2 5416.0 5417.5 5439.2 993.2 1003.7 1010.1 1038.5 1039.8 23150.0 24456.6 30027.4 30091.4 30574.5 1060.7 1070.7 1096.9 1109.0 1113.9 12285.0 12368.4 12379.2 12379.8 12381.5 320308.0 320982.0 321609.0 321869.0 321905.0 51092.0 51109.0 51143.0 51418.0 51626.0 1491.1 1498.1 1540.5 1546.4 1564.2 19443.7 23300.5 23590.8 23615.2 23669.1 37447.3 37651.0 37654.4 37670.4 37715.4 287109.0 287442.0 288267.0 288777.0 288805.0 27732.0 28248.0 31547.8 32117.8 32360.2 41228.2 42119.8 42136.0 42365.2 42381.0 22974.5 27715.9 28634.9 29210.3 29573.0 26996.0 27208.9 29507.4 29508.3 29717.0 34396.5 34664.5 34771.7 34790.1 34876.1 28470.4 28661.3 29065.9 30000.5 30351.5 19345.5 21922.0 22196.9 23050.1 23500.9 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:36584.21 Median:2235.51 stddev:96638.01 (4322.9%) stddev-sans-first:96870.96 14:44:04 INFO - PID 1642 | Values: 421.9 432.4 433.5 437.0 451.8 19310.7 20854.6 21067.7 21702.8 21870.6 18563.4 21295.7 21553.5 21590.8 22184.4 6056.5 6355.9 6356.9 6359.8 6364.8 6024.9 6157.5 6271.4 6331.8 6350.0 6196.1 6264.2 6286.1 6295.6 6305.0 5973.3 6151.2 6156.6 6161.4 6168.9 5364.3 5396.9 5504.5 5505.3 5528.6 23449.8 26935.4 27652.0 27940.9 28408.1 2161.8 2234.8 2236.2 2236.9 2237.6 17887.1 17913.0 18151.9 18234.7 18278.8 2060.2 2096.7 2115.7 2116.1 2121.1 169574.0 170708.0 171738.0 172016.0 173909.0 12173.8 12349.9 12454.2 12500.6 12730.2 16642.2 16686.9 16752.7 16754.8 16774.9 8347.2 8657.3 8684.0 8810.5 8813.2 7992.8 8056.8 8070.5 8220.9 8234.4 6452.3 7845.2 7872.2 7891.6 7903.6 1818.1 2085.5 2091.8 2102.4 2111.2 804.9 918.8 925.7 934.0 974.4 20569.5 20574.3 21180.8 21248.5 21479.7 949.0 961.2 994.0 996.5 999.6 10592.5 10889.1 10933.0 10952.8 10961.6 556334.0 563691.0 571243.1 572170.0 572266.0 97880.0 133218.0 136189.0 137982.2 142856.0 1169.7 1170.4 1180.5 1199.5 1201.6 18153.8 18223.8 18272.5 18372.6 18398.6 55571.8 58273.5 58876.0 59118.0 59212.1 69023.7 79161.2 81944.6 82317.6 83996.2 8361.5 8658.7 9040.2 9076.6 9143.8 14499.6 14530.7 14718.0 14881.0 14910.8 10526.8 11897.3 11906.7 12190.6 12330.1 11033.6 11056.4 11490.8 11503.6 11746.1 12086.2 12283.5 12459.2 12491.1 12521.6 8838.6 8841.4 9101.0 9107.4 9318.3 11890.6 11996.7 12195.9 12306.0 12356.1 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7143.51 Median:4141.78 stddev:4588.76 (110.8%) stddev-sans-first:4579.95 14:44:04 INFO - PID 1642 | Values: 1208.1 1399.0 1464.8 1478.5 1482.9 8378.3 10384.2 11742.0 12111.2 12209.9 9823.7 11691.9 11794.4 11825.8 11868.3 2115.9 2472.3 2524.4 2529.0 2529.5 1851.3 2168.2 2198.1 2199.4 2461.8 2506.4 2512.2 2520.8 2528.5 2533.9 2454.6 2468.9 2473.7 2475.8 2486.8 2428.0 2447.5 2463.8 2483.6 2522.6 11681.3 11973.1 11986.8 11988.0 11990.5 6518.4 6769.3 6776.9 6779.3 6784.0 4011.9 4259.0 4343.3 4344.9 4356.2 1095.6 1188.8 1225.4 1276.3 1278.6 16735.4 16757.0 16771.4 16798.2 16819.4 5371.6 5765.1 5797.5 5978.0 6048.6 10399.9 11574.7 14034.0 14086.6 14110.3 6782.3 6787.8 6803.5 6815.5 6820.1 4661.3 5488.8 5691.9 6119.0 6201.3 3729.3 3772.9 4131.6 4151.9 4603.9 1219.2 1424.9 1435.9 1463.5 1477.1 677.3 793.8 811.2 820.5 832.6 6504.0 6806.8 6950.8 7006.2 7027.7 890.4 945.9 951.8 954.1 954.4 4053.3 4208.1 4283.4 4336.5 4363.5 14545.0 15194.3 15205.2 15217.8 15226.6 14385.6 15121.8 15128.6 15142.6 15143.2 8528.8 8703.5 8759.4 8775.5 8788.6 6912.0 6976.2 7048.9 7162.2 7188.6 13611.1 13776.9 13776.9 13823.9 14024.9 13759.5 14016.0 14047.5 14201.0 14218.5 9514.5 9827.4 9828.0 9833.5 9839.6 8421.9 9855.0 10869.6 11019.9 11022.9 7653.6 9106.4 9229.1 9265.6 9352.3 8251.0 8280.5 8314.2 8343.9 8418.5 6953.0 8048.2 8236.8 8247.5 8251.0 5943.6 6021.1 6058.6 6103.6 6186.0 5781.7 5959.3 6180.2 6248.5 6305.7 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:4810.77 Median:5443.85 stddev:1456.21 (26.7%) stddev-sans-first:1421.84 14:44:04 INFO - PID 1642 | Values: 381.7 390.2 403.1 408.8 409.2 5527.9 5649.5 5755.8 5756.1 5760.3 5076.6 5097.2 5465.5 5592.4 5616.2 4213.3 4227.9 4231.0 4234.2 4241.2 4030.1 4171.7 4222.6 4229.8 4248.4 3601.6 3726.9 4150.3 4169.5 4182.2 4176.1 4178.7 4182.7 4186.2 4197.0 3377.4 3679.8 3684.6 3685.9 3692.2 5324.9 5448.3 5453.0 5454.7 5476.5 4111.5 4915.7 4941.9 4955.5 4976.1 5261.5 5360.7 5909.9 5947.6 5961.4 3451.6 4053.3 4081.4 4093.5 4110.2 5024.0 6005.0 6014.8 6158.4 6237.7 4114.6 4188.0 4197.0 4204.2 4208.7 4069.6 4134.8 4245.9 4249.2 4270.8 4819.8 4904.0 4910.0 4939.7 4940.4 5956.0 5966.3 5972.6 5974.5 5979.6 1390.2 1429.3 1431.6 1439.6 1443.5 941.6 962.2 970.6 972.5 982.9 4580.3 4823.6 5620.6 5666.5 5673.3 5461.7 5841.8 6118.7 6138.6 6168.3 4595.7 5239.3 5614.9 5623.0 5697.5 3184.6 3187.7 3222.4 3222.7 3240.0 4943.9 5232.6 6313.8 6323.4 6362.9 5230.7 5583.9 6000.9 6267.7 6333.4 6307.8 6332.3 6339.5 6357.6 6364.4 5617.9 5945.7 6011.2 6154.6 6158.8 5320.3 5756.7 6049.9 6053.4 6057.0 5618.8 5629.7 5779.4 5851.7 6311.5 4143.0 4157.1 4168.8 4170.0 4194.8 5500.9 5526.8 6164.1 6207.6 6208.7 5956.5 5966.6 5970.6 5979.5 6053.0 5390.1 5730.4 5922.7 5960.3 5988.6 5439.4 5813.7 5860.0 5886.9 5910.9 5238.9 5286.5 5818.9 5983.9 6008.9 4622.2 5105.3 5191.2 5794.2 5933.4 14:44:04 INFO - PID 1642 | 14:44:04 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:21083.81 Median:18030.87 stddev:30226.43 (167.6%) stddev-sans-first:30272.47 14:44:04 INFO - PID 1642 | Values: 698.5 818.3 864.0 868.3 885.6 13739.7 17982.4 18094.3 18788.0 18840.1 12552.4 17539.9 18079.4 18080.5 18115.1 979.2 1008.4 1012.6 1014.0 1016.1 676.8 695.7 990.4 1023.8 1031.2 1071.2 1073.7 1074.4 1075.0 1079.8 1060.1 1063.9 1066.8 1071.3 1073.9 795.8 796.5 796.6 798.4 804.1 15820.5 16141.3 16161.8 16738.2 16850.5 15098.2 15773.5 15781.3 16013.4 16287.3 13821.9 14005.2 14141.7 14240.9 14312.0 3361.1 3384.3 3388.4 3391.8 3393.0 120584.8 121301.4 122758.4 122834.4 123253.0 10990.8 12237.9 12440.2 12454.4 12577.7 25156.4 25217.1 25372.2 25593.7 25690.0 7778.8 8054.4 8080.4 8098.4 8105.4 3975.5 4101.5 4102.2 4107.9 4110.3 4372.2 4424.9 4436.5 4482.9 4491.3 942.9 955.3 961.6 963.7 965.1 617.5 663.5 667.8 669.0 673.2 9507.2 10814.8 11452.8 11677.5 11761.5 631.9 663.1 668.3 670.0 699.9 5015.8 5188.7 5327.2 5342.1 5439.0 96887.0 104267.0 104513.0 105523.9 107176.5 83108.9 85987.7 86073.0 86614.0 86873.0 83221.2 83503.0 84804.2 85470.0 86658.6 9603.7 10780.0 10819.2 10930.8 11074.9 28960.1 42899.0 42952.6 42979.0 43083.0 54571.7 54819.7 55495.0 55533.7 56650.2 14285.6 14403.1 14498.1 14554.3 14586.1 15324.0 15847.1 15856.3 15916.8 15933.2 14536.6 14538.0 14568.3 14615.9 14761.7 13076.3 13121.3 13212.6 13344.9 13377.7 13639.7 14163.1 14260.1 14272.4 14589.4 9573.9 10285.0 10556.0 10562.9 10952.4 11314.2 11450.7 11469.5 11709.8 11768.6 14:44:04 INFO - PID 1642 | -------- Summary: end -------- 14:44:04 INFO - PID 1642 | 14:44:04 INFO - TEST-INFO | 1642: exit 0 14:44:04 INFO - TEST-OK | dromaeo_css | took 1120120ms 14:44:04 INFO - TEST-START | kraken 14:44:04 INFO - operating with platform_type : mac_ 14:44:04 INFO - Initialising browser for kraken test... 14:44:04 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpk_AnEH/profile http://localhost:49244/getInfo.html) 14:44:07 INFO - PID 1651 | __metrics Screen width/height:1600/1200 14:44:07 INFO - PID 1651 | colorDepth:24 14:44:07 INFO - PID 1651 | Browser inner width/height: 1024/689 14:44:07 INFO - PID 1651 | __metrics 14:44:07 INFO - PID 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:44:07 INFO - PID 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:44:08 INFO - TEST-INFO | 1651: exit 0 14:44:08 INFO - Browser initialized. 14:44:08 INFO - Running cycle 1/1 for kraken test... 14:44:08 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpk_AnEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:20 INFO - PID 1652 | RSS: Main: 242393088 14:44:20 INFO - PID 1652 | 14:44:23 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:24 INFO - PID 1652 | RSS: Main: 311791616 14:44:24 INFO - PID 1652 | 14:44:26 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 14:44:27 INFO - PID 1652 | RSS: Main: 293515264 14:44:27 INFO - PID 1652 | 14:44:30 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 14:44:31 INFO - PID 1652 | RSS: Main: 386166784 14:44:31 INFO - PID 1652 | 14:44:33 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 14:44:34 INFO - PID 1652 | RSS: Main: 289398784 14:44:34 INFO - PID 1652 | 14:44:36 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:36 INFO - PID 1652 | RSS: Main: 291708928 14:44:36 INFO - PID 1652 | 14:44:39 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:40 INFO - PID 1652 | RSS: Main: 355487744 14:44:40 INFO - PID 1652 | 14:44:43 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:43 INFO - PID 1652 | RSS: Main: 378720256 14:44:43 INFO - PID 1652 | 14:44:46 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 14:44:47 INFO - PID 1652 | RSS: Main: 390062080 14:44:47 INFO - PID 1652 | 14:44:48 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:49 INFO - PID 1652 | RSS: Main: 332861440 14:44:49 INFO - PID 1652 | 14:44:51 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:51 INFO - PID 1652 | RSS: Main: 332029952 14:44:51 INFO - PID 1652 | 14:44:53 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:54 INFO - PID 1652 | RSS: Main: 334401536 14:44:54 INFO - PID 1652 | 14:44:57 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:58 INFO - PID 1652 | RSS: Main: 351911936 14:44:58 INFO - PID 1652 | 14:45:01 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:45:02 INFO - PID 1652 | RSS: Main: 333148160 14:45:02 INFO - PID 1652 | 14:45:03 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 14:45:04 INFO - PID 1652 | RSS: Main: 379707392 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | __start_tp_report 14:45:04 INFO - PID 1652 | _x_x_mozilla_page_load 14:45:04 INFO - PID 1652 | _x_x_mozilla_page_load_details 14:45:04 INFO - PID 1652 | |i|pagename|runs| 14:45:04 INFO - PID 1652 | |0;ai-astar;110;110;110;110;109;110;109;109;109;110 14:45:04 INFO - PID 1652 | |1;audio-beat-detection;141;106;109;147;110;105;110;105;133;109 14:45:04 INFO - PID 1652 | |2;audio-dft;183;183;184;183;185;185;185;187;183;178 14:45:04 INFO - PID 1652 | |3;audio-fft;81;57;59;88;57;62;87;82;86;60 14:45:04 INFO - PID 1652 | |4;audio-oscillator;89;68;85;69;71;69;90;68;74;87 14:45:04 INFO - PID 1652 | |5;imaging-gaussian-blur;87;86;88;87;87;87;90;134;87;86 14:45:04 INFO - PID 1652 | |6;imaging-darkroom;94;94;95;94;95;94;95;95;93;94 14:45:04 INFO - PID 1652 | |7;imaging-desaturate;84;84;86;86;86;85;83;83;84;86 14:45:04 INFO - PID 1652 | |8;json-parse-financial;52;47;48;49;49;50;50;49;49;49 14:45:04 INFO - PID 1652 | |9;json-stringify-tinderbox;53;54;58;62;64;59;57;58;57;58 14:45:04 INFO - PID 1652 | |10;stanford-crypto-aes;81;84;82;82;83;82;82;83;81;81 14:45:04 INFO - PID 1652 | |11;stanford-crypto-ccm;138;137;141;139;133;136;136;133;176;143 14:45:04 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;220;232;180;221;164;216;225;198;182;185 14:45:04 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;69;68;68;66;66;67;67;68;68;68 14:45:04 INFO - PID 1652 | __end_tp_report 14:45:04 INFO - PID 1652 | __start_cc_report 14:45:04 INFO - PID 1652 | _x_x_mozilla_cycle_collect,2217 14:45:04 INFO - PID 1652 | __end_cc_report 14:45:04 INFO - PID 1652 | __startTimestamp1492465504056__endTimestamp 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | ------- Summary: start ------- 14:45:04 INFO - PID 1652 | Number of tests: 14 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:45:04 INFO - PID 1652 | Values: 110.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:110.00 stddev:16.21 (14.7%) stddev-sans-first:14.79 14:45:04 INFO - PID 1652 | Values: 141.0 106.0 109.0 147.0 110.0 105.0 110.0 105.0 133.0 109.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:2.37 (1.3%) stddev-sans-first:2.50 14:45:04 INFO - PID 1652 | Values: 183.0 183.0 184.0 183.0 185.0 185.0 185.0 187.0 183.0 178.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:71.90 Median:81.50 stddev:13.83 (17.0%) stddev-sans-first:14.27 14:45:04 INFO - PID 1652 | Values: 81.0 57.0 59.0 88.0 57.0 62.0 87.0 82.0 86.0 60.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.50 stddev:9.50 (11.9%) stddev-sans-first:9.03 14:45:04 INFO - PID 1652 | Values: 89.0 68.0 85.0 69.0 71.0 69.0 90.0 68.0 74.0 87.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:87.00 stddev:14.84 (17.1%) stddev-sans-first:15.63 14:45:04 INFO - PID 1652 | Values: 87.0 86.0 88.0 87.0 87.0 87.0 90.0 134.0 87.0 86.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 14:45:04 INFO - PID 1652 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 93.0 94.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.30 14:45:04 INFO - PID 1652 | Values: 84.0 84.0 86.0 86.0 86.0 85.0 83.0 83.0 84.0 86.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:1.32 (2.7%) stddev-sans-first:0.93 14:45:04 INFO - PID 1652 | Values: 52.0 47.0 48.0 49.0 49.0 50.0 50.0 49.0 49.0 49.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:3.27 (5.6%) stddev-sans-first:2.92 14:45:04 INFO - PID 1652 | Values: 53.0 54.0 58.0 62.0 64.0 59.0 57.0 58.0 57.0 58.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:0.99 (1.2%) stddev-sans-first:0.97 14:45:04 INFO - PID 1652 | Values: 81.0 84.0 82.0 82.0 83.0 82.0 82.0 83.0 81.0 81.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:138.50 stddev:12.63 (9.1%) stddev-sans-first:13.34 14:45:04 INFO - PID 1652 | Values: 138.0 137.0 141.0 139.0 133.0 136.0 136.0 133.0 176.0 143.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.30 Median:218.00 stddev:23.43 (10.7%) stddev-sans-first:23.96 14:45:04 INFO - PID 1652 | Values: 220.0 232.0 180.0 221.0 164.0 216.0 225.0 198.0 182.0 185.0 14:45:04 INFO - PID 1652 | 14:45:04 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:0.87 14:45:04 INFO - PID 1652 | Values: 69.0 68.0 68.0 66.0 66.0 67.0 67.0 68.0 68.0 68.0 14:45:04 INFO - PID 1652 | -------- Summary: end -------- 14:45:04 INFO - PID 1652 | 14:45:05 INFO - TEST-INFO | 1652: exit 0 14:45:05 INFO - TEST-OK | kraken | took 60427ms 14:45:05 INFO - SUITE-END | took 1180s 14:45:05 INFO - Completed test suite (00:19:40) 14:45:05 INFO - javascript benchmark 14:45:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7663.1560893813385, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3516.701080408165, 3522.542069530961, 3524.0, 3551.1299731565764, 3581.409067503862, 5648.943510564893, 5665.611925078357, 5969.522438204944, 6123.755049798014, 6178.28949670788, 6084.695765211733, 6139.631622102677, 6155.891939450897, 6160.414760597736, 6207.968960155193, 5141.254518094874, 5288.973555132238, 5328.5470734987575, 5338.332708411449, 5370.248165256867, 5390.272313237702, 5448.536874365664, 5449.6730196188155, 5450.018996580634, 5506.779728810863, 5266.710330931797, 5324.334458192726, 5336.146216605324, 5337.3061502004875, 5417.83746487606, 5276.419593844674, 5329.573634109262, 5374.865628359284, 5402.675839449606, 5430.8913821723345, 5292.947070529284, 5326.121190003645, 5339.0, 5341.198820177005, 5393.217983392426, 6021.698915054273, 6098.32918378978, 6189.783357582508, 6195.070739389128, 6195.380461953769, 6377.426031657174, 6389.4568961638315, 6487.448566871822, 6500.739970401179, 6518.543701940866, 6597.80206593803, 6600.4389626881775, 6601.339866013408, 6609.669516524203, 6627.403533681943, 6090.269167699905, 6239.563230573862, 6243.0, 6248.5313601480075, 6252.9370007098905, 6459.612423254526, 6573.901391479131, 6601.603903765789, 6606.768763093365, 6612.735490580323, 6311.842203944846, 6315.715792789336, 6318.083877837687, 6348.206474190726, 6383.776567820104, 6491.285958544557, 6533.477321814338, 6552.246491653521, 6559.4752419807255, 6561.639109848908, 6452.0967064610995, 6455.096286519891, 6457.61254324742, 6463.192100987377, 6463.741450342028, 6289.622622642564, 6342.587731797418, 6426.74293028283, 6477.902831457532, 6489.286178520359, 5250.842474725764, 5255.369355677267, 5256.526912577886, 5272.077386457355, 5299.39057008449, 4624.468186158568, 4672.976635116803, 4673.836415725501, 4675.649326300541, 4691.202495575761, 6122.418370254819, 6148.370681769335, 6172.382761723792, 6197.690115494207, 6283.434490895841, 6526.0, 6571.441427478622, 6615.4376877965915, 6629.900551491732, 6631.933680663132, 6266.530010249249, 6270.090836828635, 6272.686365681698, 6286.151369565142, 6293.559450838489, 5630.07103827872, 5645.915311270334, 5747.597668163188, 5760.8271751847515, 5765.423457654285, 6537.084808126866, 6603.735850565923, 6689.866202676017, 6712.060311556288, 6719.227288861844, 6378.394052564999, 6613.404793568409, 6638.83402914931, 6640.269570347355, 6644.634545100066, 6468.579542329733, 6505.772297969548, 6671.933280667131, 6725.394714475525, 6808.319168083152, 5411.83764487066, 6495.707693153914, 6508.7721929734125, 6515.315891831289, 6525.967370163119, 5412.675239485643, 6348.174737284124, 6393.552451328363, 6406.295307516077, 6613.570117942319, 6263.906041409474, 6298.590591611531, 6303.590266632654, 6327.557071004985, 6343.841403964938, 6282.434580887742, 6283.994560870239, 6288.811335659938, 6288.905666414916, 6348.952422850178, 6245.18812554365, 6283.403076707706, 6294.8111556653375, 6308.873822523616, 6309.747610095545, 5848.0, 6187.721552530057, 6421.197350331208, 6423.582467139621, 6441.066045423294, 6168.537359698131, 6172.012478003498, 6252.280987686474, 6257.124002639725, 6270.467010304175], "value": 5974.632841270722, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.7783020754189, 811.3752410643805, 1119.5913491575577, 1139.8290256461526, 1152.596591193083, 35376.82311588445, 35851.0, 36052.9184124476, 36129.819350903206, 36257.274854502924, 38198.236035279275, 38426.61573384266, 38573.0, 38619.613803861954, 38643.22713545727, 6078.057901025348, 6222.12890195373, 8435.325173986097, 8549.401541892039, 8649.437786543886, 8280.04779450365, 8457.66169353225, 8493.490390576555, 8495.915040849604, 8512.446690965098, 8530.104339044405, 8580.227779499844, 8582.098879617644, 8609.95695021524, 8623.95688021559, 8493.787655308635, 8554.52950087745, 8556.272716819078, 8577.52823594702, 8583.184597463262, 8412.200840920103, 8432.578371081421, 8448.746537603882, 8466.78833029173, 8472.237498625153, 36881.70914018023, 36883.44674829853, 36917.07707307312, 36958.260834783156, 37059.44410833839, 3674.6325367463305, 3708.9072773180615, 3714.7028237740915, 3715.647013533737, 3716.5168528091444, 21334.573308533898, 30187.547186792217, 30352.84823575868, 30364.937227197162, 30424.93512727044, 3129.0, 3156.921076973071, 3167.31902640931, 3181.475056615656, 3185.824779637119, 296035.0, 302320.0, 303501.9999999978, 304332.0, 304410.0, 39049.804750976065, 39872.41148296667, 40000.59999400027, 48824.02351952941, 48933.86194449603, 48831.511684882695, 49513.75243123761, 49549.0, 49615.759606009415, 49655.0, 11646.76706465866, 14019.50931717385, 14080.295985200699, 14151.29243537819, 14181.865450763915, 11550.59572914944, 11557.595484158013, 11573.88426115745, 11582.76834463306, 11641.47613357401, 11717.296962182127, 11733.0, 11735.354555499358, 11756.823647645293, 11872.168948173718, 5407.756650950717, 5411.161270003156, 5415.972920135374, 5417.5395091416885, 5439.238506609078, 993.2054356514903, 1003.6687892995294, 1010.1464262698008, 1038.5430410619304, 1039.8146113430696, 23150.0, 24456.633150502756, 30027.39945201084, 30091.398172036876, 30574.54138187929, 1060.6870973062964, 1070.6734445994045, 1096.8848270931596, 1108.955641774336, 1113.87190473095, 12285.0, 12368.44342004612, 12379.195352302071, 12379.75240495185, 12381.504739810307, 320308.0, 320982.0, 321609.0, 321869.0, 321905.0, 51092.0, 51109.0, 51142.977140456984, 51417.971640567725, 51626.0, 1491.0904348347717, 1498.071195858553, 1540.4993377152246, 1546.4355510238906, 1564.2491604030129, 19443.70834437513, 23300.53398932046, 23590.764092359543, 23615.173468928504, 23669.053237870292, 37447.25105497929, 37651.0, 37654.43518347172, 37670.434943475324, 37715.43426848545, 287109.0, 287442.0, 288267.0, 288777.0, 288805.0, 27732.0, 28248.011319603716, 31547.842260788548, 32117.839410802797, 32360.190995225308, 41228.1754364905, 42119.789401054026, 42136.0, 42365.152696945275, 42381.0, 22974.540509189388, 27715.861420692767, 28634.854605815533, 29210.269743256587, 29572.964946226777, 26996.0, 27208.863955680095, 29507.409851803273, 29508.262293442836, 29716.95990640317, 34396.48405273873, 34664.480032800035, 34771.65228347684, 34790.13024674403, 34876.12809679778, 28470.43059138764, 28661.28346791347, 29065.854670726512, 30000.549991749704, 30351.544726828673, 19345.51636209106, 21922.0, 22196.889015554818, 23050.077996879936, 23500.88249558741], "value": 17084.279165341664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.94902088647666, 432.3644242962844, 433.49360970627095, 436.9519352871184, 451.8328218559134, 19310.71033934492, 20854.644448110863, 21067.683984740223, 21702.782972170273, 21870.562588748235, 18563.443096707088, 21295.68056479154, 21553.46116347092, 21590.784092159072, 22184.445388865286, 6056.51547876171, 6355.9364406356035, 6356.872862542747, 6359.8410039748915, 6364.77723279683, 6024.879502409949, 6157.538184636148, 6271.372862713715, 6331.8417039573915, 6350.047492876082, 6196.132541444202, 6264.21697287839, 6286.088517165008, 6295.559310848243, 6305.0, 5973.283206015284, 6151.169592105053, 6156.5998210116195, 6161.445469907708, 6168.87662246757, 5364.329458817648, 5396.946030539683, 5504.504594586507, 5505.256790333294, 5528.55771538276, 23449.76550234493, 26935.383876967444, 27652.0, 27940.860295698392, 28408.147755567366, 2161.805437510616, 2234.8100411465043, 2236.2061468178886, 2236.9217077402213, 2237.630790919496, 17887.10564471771, 17913.0, 18151.90924045371, 18234.72647910269, 18278.817211827845, 2060.2171174953573, 2096.6959790830397, 2115.693224482457, 2116.0689296709397, 2121.140937920145, 169574.0, 170708.0, 171737.98917037842, 172016.0, 173909.0, 12173.817392739116, 12349.93825030869, 12454.190477618926, 12500.624981250578, 12730.23618582888, 16642.16789160537, 16686.916565417338, 16752.664946701, 16754.832451675327, 16774.916125419295, 8347.2021716923, 8657.307415406753, 8683.956580217186, 8810.515421651871, 8813.206811387006, 7992.760217193493, 8056.798580035546, 8070.47541909774, 8220.917790822015, 8234.423590348739, 6452.290248072708, 7845.1762564931005, 7872.212778722082, 7891.58071479973, 7903.56530390834, 1818.0636971959452, 2085.4786303424144, 2091.8326533877253, 2102.421833995633, 2111.197744856975, 804.9195080492021, 918.7840857398506, 925.6852670092067, 933.9906600934039, 974.449436068619, 20569.48576285605, 20574.279900203423, 21180.78819211819, 21248.468788280417, 21479.67780483294, 948.9572969216264, 961.2022021721954, 993.9950300248597, 996.4917891875195, 999.5901680311038, 10592.470376481146, 10889.074428673652, 10932.961368669963, 10952.780944381067, 10961.616343427942, 556334.0, 563691.0, 571243.1437842867, 572170.0, 572266.0, 97880.04239915161, 133218.0, 136188.95716564258, 137982.24035519233, 142856.0, 1169.7368092179192, 1170.4440390814466, 1180.4628893853276, 1199.5082016373244, 1201.585453018707, 18153.818461815743, 18223.81776182221, 18272.451826445227, 18372.632547348712, 18398.632027359647, 55571.77712891439, 58273.543161419606, 58876.0, 59118.0, 59212.11181832362, 69023.65488172729, 79161.2083879177, 81944.59027704824, 82317.58841205755, 83996.16003839884, 8361.456505327134, 8658.657908024266, 9040.231580315747, 9076.591553380245, 9143.817123657356, 14499.637509062359, 14530.709385812013, 14718.0433271837, 14881.0, 14910.77633835515, 10526.78946421052, 11897.286162830258, 11906.749791272137, 12190.57332993341, 12330.136890417585, 11033.558657653924, 11056.447177641247, 11490.77018459643, 11503.597374091867, 11746.119041071783, 12086.153969222421, 12283.508659653513, 12459.190152640049, 12491.063170262085, 12521.56174533887, 8838.646454141763, 8841.425307355, 9101.044390338919, 9107.408018478778, 9318.347715659838, 11890.643280701594, 11996.700082498008, 12195.878041219474, 12306.0, 12356.073294502768], "value": 10455.681993944856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.0878936403014, 1398.9860101398986, 1464.7949287099807, 1478.4899209772625, 1482.8591283828032, 8378.32973362131, 10384.221183411237, 11742.0, 12111.212771169869, 12209.877901220985, 9823.65617203398, 11691.947724704774, 11794.410279486034, 11825.822612660795, 11868.287902725842, 2115.9471013224716, 2472.3077538289263, 2524.3562891462743, 2529.001044587387, 2529.53203657324, 1851.3057603398724, 2168.1652563762987, 2198.076807740753, 2199.351191398533, 2461.8153638477097, 2506.4485813121173, 2512.1835403493847, 2520.760527749861, 2528.532221539021, 2533.9113131040417, 2454.619533972237, 2468.8642124683224, 2473.715522714893, 2475.7771800537857, 2486.8010559155223, 2427.987860060706, 2447.5227330670527, 2463.8152138589676, 2483.5902076157413, 2522.6216067590008, 11681.299122052704, 11973.102017348734, 11986.760264794742, 11988.0, 11990.520379184822, 6518.445932095778, 6769.289224631392, 6776.932230677679, 6779.254282028973, 6784.0, 4011.919761604752, 4259.041715613993, 4343.305071188626, 4344.89137771555, 4356.172327257811, 1095.6055819904827, 1188.8276199951044, 1225.4118023348842, 1276.2725246609436, 1278.603632873812, 16735.414260500824, 16757.0, 16771.413000545046, 16798.160091995353, 16819.411320603842, 5371.597130215249, 5765.135229715493, 5797.507211887037, 5978.0, 6048.60684055535, 10399.896001040044, 11574.71063223426, 14034.017618766793, 14086.577402677936, 14110.294485275695, 6782.287859774751, 6787.762428315084, 6803.523753337219, 6815.454763618898, 6820.079289295981, 4661.347411362412, 5488.765027868698, 5691.9146212806845, 6118.969405152946, 6201.255849298113, 3729.291434627412, 3772.905677358088, 4131.628153466202, 4151.937720934188, 4603.907921841612, 1219.2136072233359, 1424.886009119268, 1435.9066660667024, 1463.5389852196524, 1477.0989696285258, 677.3057615943599, 793.773774474272, 811.1726039439739, 820.5445977482435, 832.6086739232551, 6503.967480162569, 6806.7957961261245, 6950.826229344307, 7006.229314775371, 7027.683754231072, 890.3544929925752, 945.9290553208536, 951.7810903492098, 954.1031430455349, 954.4321128928276, 4053.2704113259897, 4208.116295577902, 4283.443152390169, 4336.544662810359, 4363.4763828340165, 14545.0, 15194.316255768295, 15205.163715995726, 15217.847821521864, 15226.619334516725, 14385.64035899111, 15121.848781512264, 15128.621784455476, 15142.621434464227, 15143.242837858063, 8528.786780330542, 8703.521306328086, 8759.430637008574, 8775.517346546001, 8788.60451279694, 6911.965440172969, 6976.197737260077, 7048.894266585903, 7162.242536623542, 7188.6046267455795, 13611.11527750693, 13776.862231377558, 13776.93111534436, 13823.930880345533, 14024.929875350557, 13759.518416855362, 14016.0, 14047.488127968008, 14201.0, 14218.502352417616, 9514.524273786421, 9827.4103553787, 9828.0, 9833.508324583885, 9839.60641574329, 8421.915780842113, 9854.950725246328, 10869.565217391215, 11019.889801102207, 11022.944885275523, 7653.579053151907, 9106.362554621113, 9229.123233293096, 9265.629374824932, 9352.251819854258, 8251.0, 8280.461769984931, 8314.168583141638, 8343.874841877498, 8418.536980466133, 6952.965235173791, 8048.235417635316, 8236.794080147805, 8247.546384948886, 8251.0, 5943.613665111754, 6021.066734656135, 6058.606190597597, 6103.6032657877095, 6186.0, 5781.699117698484, 5959.344472108151, 6180.196574445294, 6248.4688801452385, 6305.653189074645], "value": 5382.294021734956, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.67748252726454, 390.19619583657663, 403.10912882529607, 408.80173116038696, 409.2204350711891, 5527.922055199238, 5649.49154576088, 5755.7697692092315, 5756.079027355624, 5760.268532809855, 5076.64463487556, 5097.184450487923, 5465.535429488498, 5592.4407559244055, 5616.241807356006, 4213.325867861143, 4227.915441691157, 4231.0, 4234.195502854448, 4241.215375155591, 4030.093229023461, 4171.707980441371, 4222.641075508585, 4229.788510574459, 4248.383984322271, 3601.5858176309666, 3726.881935419377, 4150.294449943517, 4169.478815148106, 4182.247195504808, 4176.1230141670285, 4178.6657067434535, 4182.7490350578755, 4186.183694179621, 4197.0, 3377.4427219508752, 3679.779213247187, 3684.5578530576236, 3685.9406692445204, 3692.2430901665093, 5324.866878328034, 5448.264484294648, 5452.972735136299, 5454.7272636368025, 5476.5355589984265, 4111.465509483778, 4915.680480768739, 4941.9258711119, 4955.504449555052, 4976.104301225778, 5261.473852614746, 5360.678359298455, 5909.852253693649, 5947.613405128653, 5961.403859614047, 3451.637578054293, 4053.3109371406636, 4081.387791831249, 4093.488313960755, 4110.17796440713, 5024.045431368065, 6005.039193728982, 6014.8496287592725, 6158.384161583896, 6237.719302631393, 4114.6091121343425, 4188.0, 4196.958030419718, 4204.2432362175105, 4208.705390622688, 4069.5726948669962, 4134.772587507656, 4245.936310955338, 4249.235137675249, 4270.765107919095, 4819.831305904347, 4904.0, 4910.0, 4939.678920870132, 4940.382452193476, 5956.047032474783, 5966.284045914431, 5972.611780234271, 5974.462298393166, 5979.581429299994, 1390.242317936727, 1429.3139293139352, 1431.5562175725559, 1439.6400899775056, 1443.4875619155048, 941.6205259295166, 962.2446379591987, 970.6117552978724, 972.4602845420859, 982.8696998451837, 4580.312953057068, 4823.5658790709, 5620.63696557511, 5666.518345940642, 5673.319201695823, 5461.672299662033, 5841.795537156179, 6118.694065296718, 6138.631682099089, 6168.290646575701, 4595.655325850575, 5239.266502689627, 5614.9438505615235, 5623.0, 5697.515711164598, 3184.617845858512, 3187.665295144023, 3222.38774632819, 3222.7099561039618, 3240.0235856127742, 4943.876403089952, 5232.581393488512, 6313.77901773445, 6323.399277068671, 6362.850389057447, 5230.660007099526, 5583.944160558423, 6000.909986350208, 6267.6866156691985, 6333.398327158912, 6307.810765677037, 6332.271788744261, 6339.492840572835, 6357.618542887441, 6364.363563643691, 5617.887642247214, 5945.708319595477, 6011.248593925759, 6154.584205765843, 6158.784442544489, 5320.255164277081, 5756.7409466574945, 6049.939500605114, 6053.397039273154, 6057.030875059969, 5618.803341883015, 5629.662220266797, 5779.445640930881, 5851.678157701367, 6311.526635502448, 4143.0, 4157.064660451374, 4168.8124034417915, 4170.0, 4194.811233494439, 5500.944990550203, 5526.834194974157, 6164.058321628672, 6207.596506227262, 6208.671748094464, 5956.493698035542, 5966.612170208922, 5970.641761494324, 5979.475233815349, 6053.0, 5390.110631745875, 5730.398308177748, 5922.703864806656, 5960.284765828128, 5988.550858685703, 5439.4288599696465, 5813.709314534171, 5859.970700146472, 5886.852828679317, 5910.881782364415, 5238.921416178837, 5286.524212820865, 5818.876110219824, 5983.910241346471, 6008.87982240344, 4622.1911165545225, 5105.348460291711, 5191.247269146028, 5794.188813566188, 5933.436323549256], "value": 4369.062531225397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4691634357893, 818.2840014986887, 864.0495454999506, 868.2663149638553, 885.5793498088409, 13739.725205495897, 17982.370617028406, 18094.276228950843, 18788.0, 18840.057997100143, 12552.43514041868, 17539.91230043848, 18079.367222147193, 18080.54798630035, 18115.09424528775, 979.1579241852002, 1008.4050410257946, 1012.5899010900561, 1013.9594416223342, 1016.1058268723513, 676.7834293026209, 695.6556504530265, 990.3612170150249, 1023.7798873242251, 1031.2317323593934, 1071.1805468816362, 1073.688630297213, 1074.414444127952, 1075.0002497677158, 1079.7570546627026, 1060.1306928318782, 1063.8510608514775, 1066.807974564578, 1071.2501249125644, 1073.876504202015, 795.8288967871878, 796.5419883566972, 796.6136423834436, 798.4371018432049, 804.0592506767097, 15820.525384238492, 16141.273642686107, 16161.757573636405, 16738.24677889498, 16850.494485165465, 15098.24508774568, 15773.526794196192, 15781.28984195714, 16013.396985678246, 16287.267072981744, 13821.930890345484, 14005.159690418608, 14141.71716565663, 14240.857591424057, 14311.998160128795, 3361.1429085583263, 3384.3062172254627, 3388.3731509670542, 3391.847366868497, 3393.0160253526697, 120584.79415205824, 121301.39349303374, 122758.38620806928, 122834.38582807028, 123253.0, 10990.835137472945, 12237.938810305892, 12440.19138755978, 12454.377281135907, 12577.685557861127, 25156.371090722514, 25217.117400890882, 25372.238832835046, 25593.744062559137, 25690.0, 7778.844423111619, 8054.395920306, 8080.4343695940715, 8098.392620553482, 8105.351571874236, 3975.542812576533, 4101.52832424269, 4102.159057393227, 4107.876763697094, 4110.34234522475, 4372.1692878353015, 4424.867253982386, 4436.489803672554, 4482.887927801831, 4491.326301054868, 942.8962814090445, 955.2692190474293, 961.5721004153085, 963.7494251494662, 965.1217392173229, 617.4813156948185, 663.5056882622381, 667.7729571945465, 668.9866202675919, 673.2089794491453, 9507.191888689538, 10814.78370432587, 11452.797456267139, 11677.474513646906, 11761.470733817, 631.8689545713122, 663.1180529895228, 668.2715839734713, 669.9732010719516, 699.9370056694922, 5015.824446144367, 5188.714620695898, 5327.227552004938, 5342.118550439134, 5438.966596346681, 96887.0, 104266.95733042725, 104513.0, 105523.94476055141, 107176.46411767892, 83108.93876903558, 85987.71018434729, 86073.0, 86614.0, 86873.0, 83221.16778832255, 83503.0, 84804.15195848086, 85470.0, 86658.56670716732, 9603.663871764455, 10780.0, 10819.242653014213, 10930.836037459285, 11074.889251107386, 28960.13119606415, 42899.0, 42952.57047429611, 42979.0, 43083.0, 54571.72714136404, 54819.725901371836, 55495.0, 55533.72233138808, 56650.15024774549, 14285.64285892861, 14403.135811851322, 14498.130112193303, 14554.27228638585, 14586.124832510084, 15324.0, 15847.128407937213, 15856.286467108777, 15916.840831591537, 15933.203339833193, 14536.563903082924, 14538.0, 14568.34442450071, 14615.853841461874, 14761.704765904407, 13076.280804555841, 13121.34393280313, 13212.603621891358, 13344.93240540735, 13377.732445350845, 13639.727205455636, 14163.079399838978, 14260.144391336553, 14272.429102836186, 14589.416423342947, 9573.856392153984, 10285.02292282232, 10555.997180267863, 10562.894371056498, 10952.397618131079, 11314.15143864197, 11450.713732156762, 11469.541218351173, 11709.824352634547, 11768.646940591796], "value": 8068.570296542758, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 109.0, 147.0, 110.0, 105.0, 110.0, 105.0, 133.0, 109.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 183.0, 185.0, 185.0, 185.0, 187.0, 183.0, 178.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 59.0, 88.0, 57.0, 62.0, 87.0, 82.0, 86.0, 60.0], "value": 71.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 85.0, 69.0, 71.0, 69.0, 90.0, 68.0, 74.0, 87.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 87.0, 87.0, 87.0, 90.0, 134.0, 87.0, 86.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 93.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 86.0, 86.0, 85.0, 83.0, 83.0, 84.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 47.0, 48.0, 49.0, 49.0, 50.0, 50.0, 49.0, 49.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 58.0, 62.0, 64.0, 59.0, 57.0, 58.0, 57.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 82.0, 82.0, 83.0, 82.0, 82.0, 83.0, 81.0, 81.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 141.0, 139.0, 133.0, 136.0, 136.0, 133.0, 176.0, 143.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 232.0, 180.0, 221.0, 164.0, 216.0, 225.0, 198.0, 182.0, 185.0], "value": 202.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 68.0, 68.0, 68.0], "value": 67.5, "unit": "score"}]}]} 14:45:05 INFO - Return code: 0 14:45:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:45:05 ERROR - # TBPL SUCCESS # 14:45:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:45:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:45:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:45:05 INFO - 2017-04-17 14:45:05.378 screenresolution[1657:10374] starting screenresolution argv=screenresolution get 14:45:05 INFO - 2017-04-17 14:45:05.381 screenresolution[1657:10374] Display 0: 1600x1200x32@60 14:45:05 INFO - 2017-04-17 14:45:05.388 screenresolution[1658:10377] starting screenresolution argv=screenresolution list 14:45:05 INFO - Available Modes on Display 0 14:45:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:45:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:45:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:45:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:45:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:45:05 INFO - Intel Iris: 14:45:05 INFO - Chipset Model: Intel Iris 14:45:05 INFO - Type: GPU 14:45:05 INFO - Bus: Built-In 14:45:05 INFO - VRAM (Dynamic, Max): 1536 MB 14:45:05 INFO - Vendor: Intel (0x8086) 14:45:05 INFO - Device ID: 0x0a2e 14:45:05 INFO - Revision ID: 0x0009 14:45:05 INFO - Displays: 14:45:05 INFO - Display: 14:45:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:45:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:45:05 INFO - Display Serial Number: 1600x1200 60 14:45:05 INFO - Main Display: Yes 14:45:05 INFO - Mirror: Off 14:45:05 INFO - Online: Yes 14:45:05 INFO - Rotation: Supported 14:45:05 INFO - Return code: 0 14:45:05 INFO - Running post-action listener: _resource_record_post_action 14:45:05 INFO - [mozharness: 2017-04-17 21:45:05.638101Z] Finished run-tests step (success) 14:45:05 INFO - Running post-run listener: _resource_record_post_run 14:45:05 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 34065920; Write bytes: 517043200; Read time: 319; Write time: 1910 14:45:05 INFO - TinderboxPrint: CPU usage
53.5% 14:45:05 INFO - TinderboxPrint: I/O read bytes / time
34,065,920 / 319 14:45:05 INFO - TinderboxPrint: I/O write bytes / time
517,043,200 / 1,910 14:45:05 INFO - TinderboxPrint: CPU idle
2,233.6 (46.5%) 14:45:05 INFO - TinderboxPrint: CPU system
964.3 (20.1%) 14:45:05 INFO - TinderboxPrint: CPU user
1,607.8 (33.5%) 14:45:05 INFO - TinderboxPrint: Swap in / out
238,809,088 / 0 14:45:05 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209598976; Write bytes: 210781696; Read time: 16260; Write time: 442 14:45:05 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 29072896; Write bytes: 304922112; Read time: 286; Write time: 1463 14:45:06 INFO - Running post-run listener: _upload_blobber_files 14:45:06 INFO - Blob upload gear active. 14:45:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:45:06 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 14:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:45:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:07 INFO - (blobuploader) - INFO - Done attempting. 14:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:09 INFO - (blobuploader) - INFO - Done attempting. 14:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:10 INFO - (blobuploader) - INFO - Done attempting. 14:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:12 INFO - (blobuploader) - INFO - Done attempting. 14:45:12 INFO - (blobuploader) - INFO - Iteration through files over. 14:45:12 INFO - Return code: 0 14:45:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:45:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:45:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/924070c68079231d80037fcded7fccf5b514592edc3abf3e92d3f59b21de6817e4b322d051cbaa93dc8a53b6b9cf9a93529a28717de86fc1722c9de2c507d63e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764632aacef4690985f0d529afe680c30ab0d7e05d6a967cdeeaba94bbeb2583b160bb3d0dd4528049a2ab904eee764f37b2da391dce1bfcba49f6b1755784fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84a6243a8eaa275b6df96235ff90b4ce3bc9adbae12a9738d21a3fefe198fafdc97a877d932b9d3d1b4576ebb4a79eeddf89192ef2124d4728f825a8a04cf7cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8c62e39634d02a787336e5a1da6d6700309b8de47cbcd47410ccf5643712e1415b4645341aa9118b79b8647b51544e54a71c34b7c8bbc2c9ff5468cd65047ef"} 14:45:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:45:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:45:12 INFO - Contents: 14:45:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/924070c68079231d80037fcded7fccf5b514592edc3abf3e92d3f59b21de6817e4b322d051cbaa93dc8a53b6b9cf9a93529a28717de86fc1722c9de2c507d63e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764632aacef4690985f0d529afe680c30ab0d7e05d6a967cdeeaba94bbeb2583b160bb3d0dd4528049a2ab904eee764f37b2da391dce1bfcba49f6b1755784fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84a6243a8eaa275b6df96235ff90b4ce3bc9adbae12a9738d21a3fefe198fafdc97a877d932b9d3d1b4576ebb4a79eeddf89192ef2124d4728f825a8a04cf7cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8c62e39634d02a787336e5a1da6d6700309b8de47cbcd47410ccf5643712e1415b4645341aa9118b79b8647b51544e54a71c34b7c8bbc2c9ff5468cd65047ef"} 14:45:12 INFO - Running post-run listener: copy_logs_to_upload_dir 14:45:12 INFO - Copying logs to upload dir... 14:45:12 INFO - mkdir: /builds/slave/test/build/upload/logs 14:45:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.512374 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-17 14:45:12.855818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:12.859977) ========= 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.LKXSYDmItJ/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.LksVRpDlY3/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/924070c68079231d80037fcded7fccf5b514592edc3abf3e92d3f59b21de6817e4b322d051cbaa93dc8a53b6b9cf9a93529a28717de86fc1722c9de2c507d63e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764632aacef4690985f0d529afe680c30ab0d7e05d6a967cdeeaba94bbeb2583b160bb3d0dd4528049a2ab904eee764f37b2da391dce1bfcba49f6b1755784fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84a6243a8eaa275b6df96235ff90b4ce3bc9adbae12a9738d21a3fefe198fafdc97a877d932b9d3d1b4576ebb4a79eeddf89192ef2124d4728f825a8a04cf7cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8c62e39634d02a787336e5a1da6d6700309b8de47cbcd47410ccf5643712e1415b4645341aa9118b79b8647b51544e54a71c34b7c8bbc2c9ff5468cd65047ef"} build_url:https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/924070c68079231d80037fcded7fccf5b514592edc3abf3e92d3f59b21de6817e4b322d051cbaa93dc8a53b6b9cf9a93529a28717de86fc1722c9de2c507d63e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764632aacef4690985f0d529afe680c30ab0d7e05d6a967cdeeaba94bbeb2583b160bb3d0dd4528049a2ab904eee764f37b2da391dce1bfcba49f6b1755784fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84a6243a8eaa275b6df96235ff90b4ce3bc9adbae12a9738d21a3fefe198fafdc97a877d932b9d3d1b4576ebb4a79eeddf89192ef2124d4728f825a8a04cf7cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8c62e39634d02a787336e5a1da6d6700309b8de47cbcd47410ccf5643712e1415b4645341aa9118b79b8647b51544e54a71c34b7c8bbc2c9ff5468cd65047ef"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:12.897159) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:12.897502) ========= 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.LKXSYDmItJ/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.LksVRpDlY3/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005140 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:12.946694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 14:45:12.947052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 14:45:12.947507) ========= ========= Total master_lag: 0.19 =========