builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0247 starttime: 1485371931.27 results: success (0) buildid: 20170125103331 builduid: 2743ab4aedc34f168f712b2c61417c21 revision: ec143b1f00bd49f6a540db3031cd7fe9a956768e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.273035) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.273459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.273745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.298941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.299322) ========= 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.oXyGM0zRvj/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.88iAMgWSVx/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-25 11:18:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-01-25 11:18:51 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.461787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.462108) ========= 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.oXyGM0zRvj/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.88iAMgWSVx/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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.022673 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:51.510613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:18:51.510969) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ec143b1f00bd49f6a540db3031cd7fe9a956768e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ec143b1f00bd49f6a540db3031cd7fe9a956768e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oXyGM0zRvj/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.88iAMgWSVx/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-25 11:18:51,602 truncating revision to first 12 chars 2017-01-25 11:18:51,603 Setting DEBUG logging. 2017-01-25 11:18:51,603 attempt 1/10 2017-01-25 11:18:51,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ec143b1f00bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 11:18:52,939 unpacking tar archive at: mozilla-aurora-ec143b1f00bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.589238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:18:53.123553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.123907) ========= script_repo_revision: ec143b1f00bd49f6a540db3031cd7fe9a956768e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.124306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.124571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.143978) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-25 11:18:53.144265) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oXyGM0zRvj/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.88iAMgWSVx/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:18:53 INFO - MultiFileLogger online at 20170125 11:18:53 in /builds/slave/test 11:18:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:18:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:53 INFO - {'append_to_log': False, 11:18:53 INFO - 'base_work_dir': '/builds/slave/test', 11:18:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:18:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:53 INFO - 'branch': 'Mozilla-Aurora', 11:18:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:53 INFO - 'config_files': ('talos/mac_config.py',), 11:18:53 INFO - 'default_actions': ('clobber', 11:18:53 INFO - 'read-buildbot-config', 11:18:53 INFO - 'download-and-extract', 11:18:53 INFO - 'populate-webroot', 11:18:53 INFO - 'create-virtualenv', 11:18:53 INFO - 'install', 11:18:53 INFO - 'run-tests'), 11:18:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:53 INFO - 'download_minidump_stackwalk': True, 11:18:53 INFO - 'download_symbols': 'ondemand', 11:18:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:53 INFO - 'installer_path': 'installer.exe', 11:18:53 INFO - 'log_level': 'info', 11:18:53 INFO - 'log_name': 'talos', 11:18:53 INFO - 'log_to_console': True, 11:18:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:18:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:18:53 INFO - 'opt_config_files': (), 11:18:53 INFO - 'pip_index': False, 11:18:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:18:53 INFO - 'cmd': ('bash', 11:18:53 INFO - '-c', 11:18:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:18:53 INFO - 'enabled': True, 11:18:53 INFO - 'halt_on_failure': False, 11:18:53 INFO - 'name': 'check_screen_resolution'},), 11:18:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:18:53 INFO - 'cmd': ('bash', 11:18:53 INFO - '-c', 11:18:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:18:53 INFO - 'enabled': True, 11:18:53 INFO - 'halt_on_failure': False, 11:18:53 INFO - 'name': 'check_screen_resolution'},), 11:18:53 INFO - 'run_cmd_checks_enabled': True, 11:18:53 INFO - 'sps_profile': False, 11:18:53 INFO - 'sps_profile_interval': 0, 11:18:53 INFO - 'suite': 'dromaeojs', 11:18:53 INFO - 'system_bits': '32', 11:18:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:53 INFO - 'title': 't-yosemite-r7-0247', 11:18:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:53 INFO - 'use_talos_json': True, 11:18:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:53 INFO - 'work_dir': 'build'} 11:18:53 INFO - [mozharness: 2017-01-25 19:18:53.350190Z] Running clobber step. 11:18:53 INFO - Running pre-action listener: _resource_record_pre_action 11:18:53 INFO - Running main action method: clobber 11:18:53 INFO - rmtree: /builds/slave/test/build 11:18:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:54 INFO - Running post-action listener: _resource_record_post_action 11:18:54 INFO - [mozharness: 2017-01-25 19:18:54.970348Z] Finished clobber step (success) 11:18:54 INFO - [mozharness: 2017-01-25 19:18:54.970536Z] Running read-buildbot-config step. 11:18:54 INFO - Running pre-action listener: _resource_record_pre_action 11:18:54 INFO - Running main action method: read_buildbot_config 11:18:54 INFO - Using buildbot properties: 11:18:54 INFO - { 11:18:54 INFO - "project": "", 11:18:54 INFO - "product": "firefox", 11:18:54 INFO - "script_repo_revision": "production", 11:18:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:18:54 INFO - "repository": "", 11:18:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:18:54 INFO - "buildid": "20170125103331", 11:18:54 INFO - "pgo_build": "False", 11:18:54 INFO - "basedir": "/builds/slave/test", 11:18:54 INFO - "buildnumber": 38, 11:18:54 INFO - "slavename": "t-yosemite-r7-0247", 11:18:54 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:18:54 INFO - "platform": "yosemite_r7", 11:18:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:18:54 INFO - "branch": "mozilla-aurora", 11:18:54 INFO - "repo_path": "releases/mozilla-aurora", 11:18:54 INFO - "revision": "ec143b1f00bd49f6a540db3031cd7fe9a956768e", 11:18:54 INFO - "stage_platform": "macosx64", 11:18:54 INFO - "builduid": "2743ab4aedc34f168f712b2c61417c21", 11:18:54 INFO - "slavebuilddir": "test" 11:18:54 INFO - } 11:18:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:18:54 INFO - Running post-action listener: _resource_record_post_action 11:18:54 INFO - [mozharness: 2017-01-25 19:18:54.974013Z] Finished read-buildbot-config step (success) 11:18:54 INFO - [mozharness: 2017-01-25 19:18:54.974146Z] Running download-and-extract step. 11:18:54 INFO - Running pre-action listener: _resource_record_pre_action 11:18:54 INFO - Running main action method: download_and_extract 11:18:54 INFO - mkdir: /builds/slave/test/build/tests 11:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:54 INFO - trying https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:18:54 INFO - Downloading https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 11:18:56 INFO - Downloaded 1199 bytes. 11:18:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:18:56 INFO - Using the following test package requirements: 11:18:56 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:18:56 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:18:56 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:18:56 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'jsshell-mac.zip'], 11:18:56 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:18:56 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:18:56 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:18:56 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:18:56 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:18:56 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:56 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:18:56 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:18:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:18:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:18:56 INFO - Fetch https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:18:57 INFO - Expected file size: 16349682 11:18:57 INFO - Obtained file size: 16349682 11:19:04 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:19:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:19:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:19:04 INFO - Fetch https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:19:05 INFO - Expected file size: 16349682 11:19:05 INFO - Obtained file size: 16349682 11:19:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:19:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:19:11 INFO - Fetch https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:19:12 INFO - Expected file size: 14403485 11:19:12 INFO - Obtained file size: 14403485 11:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:12 INFO - trying https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:19:12 INFO - Downloading https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 11:19:18 INFO - Downloaded 73891264 bytes. 11:19:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:19:18 INFO - mkdir: /builds/slave/test/properties 11:19:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:19:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:19:18 INFO - Contents: 11:19:18 INFO - build_url:https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:19:19 INFO - Running post-action listener: _resource_record_post_action 11:19:19 INFO - Running post-action listener: set_extra_try_arguments 11:19:19 INFO - [mozharness: 2017-01-25 19:19:19.187343Z] Finished download-and-extract step (success) 11:19:19 INFO - [mozharness: 2017-01-25 19:19:19.187500Z] Running populate-webroot step. 11:19:19 INFO - Running pre-action listener: _resource_record_pre_action 11:19:19 INFO - Running main action method: populate_webroot 11:19:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:19:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:19:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:19:19 INFO - '--tppagecycles', 11:19:19 INFO - '7'], 11:19:19 INFO - 'tests': ['tsvgm']}}, 11:19:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:19:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:19:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:19:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:19:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:19:19 INFO - 'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:19:19 INFO - 'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['damp', 'tps']}, 11:19:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:19:19 INFO - 'tests': ['damp', 'tps']}, 11:19:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['dromaeo_dom']}, 11:19:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:19:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['basic_compositor_video']}, 11:19:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:19:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['a11yr', 11:19:19 INFO - 'ts_paint', 11:19:19 INFO - 'tpaint', 11:19:19 INFO - 'sessionrestore', 11:19:19 INFO - 'sessionrestore_no_auto_restore', 11:19:19 INFO - 'tabpaint']}, 11:19:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:19:19 INFO - 'ts_paint', 11:19:19 INFO - 'tpaint', 11:19:19 INFO - 'sessionrestore', 11:19:19 INFO - 'sessionrestore_no_auto_restore', 11:19:19 INFO - 'tabpaint']}, 11:19:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:19:19 INFO - 'ts_paint', 11:19:19 INFO - 'tpaint', 11:19:19 INFO - 'sessionrestore', 11:19:19 INFO - 'sessionrestore_no_auto_restore', 11:19:19 INFO - 'tabpaint']}, 11:19:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:19:19 INFO - 'ts_paint', 11:19:19 INFO - 'tpaint', 11:19:19 INFO - 'sessionrestore', 11:19:19 INFO - 'sessionrestore_no_auto_restore', 11:19:19 INFO - 'tabpaint']}, 11:19:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['a11yr', 11:19:19 INFO - 'ts_paint', 11:19:19 INFO - 'tpaint', 11:19:19 INFO - 'sessionrestore', 11:19:19 INFO - 'sessionrestore_no_auto_restore', 11:19:19 INFO - 'tabpaint']}, 11:19:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['a11yr', 11:19:19 INFO - 'ts_paint', 11:19:19 INFO - 'tpaint', 11:19:19 INFO - 'sessionrestore', 11:19:19 INFO - 'sessionrestore_no_auto_restore', 11:19:19 INFO - 'tabpaint']}, 11:19:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['tsvgx', 11:19:19 INFO - 'tsvgr_opacity', 11:19:19 INFO - 'tart', 11:19:19 INFO - 'tscrollx', 11:19:19 INFO - 'cart', 11:19:19 INFO - 'tsvg_static']}, 11:19:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:19:19 INFO - 'tsvgr_opacity', 11:19:19 INFO - 'tart', 11:19:19 INFO - 'tscrollx', 11:19:19 INFO - 'cart', 11:19:19 INFO - 'tsvg_static']}, 11:19:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:19:19 INFO - 'talos_options': ['--disable-e10s'], 11:19:19 INFO - 'tests': ['tp5o']}, 11:19:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:19:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:19:19 INFO - 'talos_options': ['--disable-e10s', 11:19:19 INFO - '--xperf_path', 11:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:19 INFO - 'tests': ['tp5n']}, 11:19:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:19:19 INFO - 'talos_options': ['--xperf_path', 11:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:19 INFO - 'tests': ['tp5n']}}, 11:19:19 INFO - 'talos.zip': {'path': '', 11:19:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:19:19 INFO - Running post-action listener: _resource_record_post_action 11:19:19 INFO - [mozharness: 2017-01-25 19:19:19.205886Z] Finished populate-webroot step (success) 11:19:19 INFO - [mozharness: 2017-01-25 19:19:19.206006Z] Running create-virtualenv step. 11:19:19 INFO - Running pre-action listener: _resource_record_pre_action 11:19:19 INFO - Running main action method: create_virtualenv 11:19:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:19:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:19:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:19:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:19:19 INFO - Using real prefix '/tools/python27' 11:19:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:19:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:19:22 INFO - Installing pip.................done. 11:19:22 INFO - Return code: 0 11:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:19:23 INFO - Reading from file tmpfile_stdout 11:19:23 INFO - Output received: 11:19:23 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) 11:19:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:23 INFO - 'HOME': '/Users/cltbld', 11:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:23 INFO - 'LOGNAME': 'cltbld', 11:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:23 INFO - 'MOZ_NO_REMOTE': '1', 11:19:23 INFO - 'NO_EM_RESTART': '1', 11:19:23 INFO - 'PAGER': '/bin/cat', 11:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:23 INFO - 'PWD': '/builds/slave/test', 11:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:23 INFO - 'SHELL': '/bin/bash', 11:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:23 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:23 INFO - 'USER': 'cltbld', 11:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:23 INFO - 'XPC_FLAGS': '0x0', 11:19:23 INFO - 'XPC_SERVICE_NAME': '0', 11:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:19:23 INFO - Cleaning up... 11:19:23 INFO - Return code: 0 11:19:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:23 INFO - 'HOME': '/Users/cltbld', 11:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:23 INFO - 'LOGNAME': 'cltbld', 11:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:23 INFO - 'MOZ_NO_REMOTE': '1', 11:19:23 INFO - 'NO_EM_RESTART': '1', 11:19:23 INFO - 'PAGER': '/bin/cat', 11:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:23 INFO - 'PWD': '/builds/slave/test', 11:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:23 INFO - 'SHELL': '/bin/bash', 11:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:23 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:23 INFO - 'USER': 'cltbld', 11:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:23 INFO - 'XPC_FLAGS': '0x0', 11:19:23 INFO - 'XPC_SERVICE_NAME': '0', 11:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:23 INFO - Downloading/unpacking psutil>=3.1.1 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:27 INFO - Installing collected packages: psutil 11:19:27 INFO - Running setup.py install for psutil 11:19:27 INFO - building 'psutil._psutil_osx' extension 11:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:19:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:19:27 INFO - building 'psutil._psutil_posix' extension 11:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:19:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:19:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:19:27 INFO - ^ 11:19:27 INFO - 1 warning generated. 11:19:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:27 INFO - Successfully installed psutil 11:19:27 INFO - Cleaning up... 11:19:28 INFO - Return code: 0 11:19:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:28 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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:28 INFO - 'HOME': '/Users/cltbld', 11:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:28 INFO - 'LOGNAME': 'cltbld', 11:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:28 INFO - 'MOZ_NO_REMOTE': '1', 11:19:28 INFO - 'NO_EM_RESTART': '1', 11:19:28 INFO - 'PAGER': '/bin/cat', 11:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:28 INFO - 'PWD': '/builds/slave/test', 11:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:28 INFO - 'SHELL': '/bin/bash', 11:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:28 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:28 INFO - 'USER': 'cltbld', 11:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:28 INFO - 'XPC_FLAGS': '0x0', 11:19:28 INFO - 'XPC_SERVICE_NAME': '0', 11:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:19:31 INFO - Installing collected packages: mozsystemmonitor 11:19:31 INFO - Running setup.py install for mozsystemmonitor 11:19:31 INFO - Successfully installed mozsystemmonitor 11:19:31 INFO - Cleaning up... 11:19:31 INFO - Return code: 0 11:19:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:31 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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:19:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:31 INFO - 'HOME': '/Users/cltbld', 11:19:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:31 INFO - 'LOGNAME': 'cltbld', 11:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:31 INFO - 'MOZ_NO_REMOTE': '1', 11:19:31 INFO - 'NO_EM_RESTART': '1', 11:19:31 INFO - 'PAGER': '/bin/cat', 11:19:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:31 INFO - 'PWD': '/builds/slave/test', 11:19:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:31 INFO - 'SHELL': '/bin/bash', 11:19:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:31 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:31 INFO - 'USER': 'cltbld', 11:19:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:31 INFO - 'XPC_FLAGS': '0x0', 11:19:31 INFO - 'XPC_SERVICE_NAME': '0', 11:19:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:31 INFO - Downloading/unpacking jsonschema==2.5.1 11:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:34 INFO - warning: no files found matching '*.txt' 11:19:34 INFO - no previously-included directories found matching 'build' 11:19:34 INFO - no previously-included directories found matching 'dist' 11:19:34 INFO - no previously-included directories found matching '.git*' 11:19:34 INFO - Installing collected packages: jsonschema, functools32 11:19:34 INFO - Running setup.py install for functools32 11:19:34 INFO - warning: no files found matching '*.txt' 11:19:34 INFO - no previously-included directories found matching 'build' 11:19:34 INFO - no previously-included directories found matching 'dist' 11:19:34 INFO - no previously-included directories found matching '.git*' 11:19:34 INFO - Successfully installed jsonschema functools32 11:19:34 INFO - Cleaning up... 11:19:34 INFO - Return code: 0 11:19:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:34 INFO - 'HOME': '/Users/cltbld', 11:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:34 INFO - 'LOGNAME': 'cltbld', 11:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:34 INFO - 'MOZ_NO_REMOTE': '1', 11:19:34 INFO - 'NO_EM_RESTART': '1', 11:19:34 INFO - 'PAGER': '/bin/cat', 11:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:34 INFO - 'PWD': '/builds/slave/test', 11:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:34 INFO - 'SHELL': '/bin/bash', 11:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:34 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:34 INFO - 'USER': 'cltbld', 11:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:34 INFO - 'XPC_FLAGS': '0x0', 11:19:34 INFO - 'XPC_SERVICE_NAME': '0', 11:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:19:35 INFO - Cleaning up... 11:19:35 INFO - Return code: 0 11:19:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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', '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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:19: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 blobuploader==1.2.4 11:19:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:35 INFO - 'HOME': '/Users/cltbld', 11:19:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:35 INFO - 'LOGNAME': 'cltbld', 11:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:35 INFO - 'MOZ_NO_REMOTE': '1', 11:19:35 INFO - 'NO_EM_RESTART': '1', 11:19:35 INFO - 'PAGER': '/bin/cat', 11:19:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:35 INFO - 'PWD': '/builds/slave/test', 11:19:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:35 INFO - 'SHELL': '/bin/bash', 11:19:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:35 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:35 INFO - 'USER': 'cltbld', 11:19:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:35 INFO - 'XPC_FLAGS': '0x0', 11:19:35 INFO - 'XPC_SERVICE_NAME': '0', 11:19:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:38 INFO - Downloading blobuploader-1.2.4.tar.gz 11:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:19:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:19:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:39 INFO - Downloading docopt-0.6.1.tar.gz 11:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:19:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:19:39 INFO - Running setup.py install for blobuploader 11:19:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:19:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:19:39 INFO - Running setup.py install for requests 11:19:40 INFO - Running setup.py install for docopt 11:19:40 INFO - Successfully installed blobuploader requests docopt 11:19:40 INFO - Cleaning up... 11:19:40 INFO - Return code: 0 11:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:40 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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:40 INFO - 'HOME': '/Users/cltbld', 11:19:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:40 INFO - 'LOGNAME': 'cltbld', 11:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:40 INFO - 'MOZ_NO_REMOTE': '1', 11:19:40 INFO - 'NO_EM_RESTART': '1', 11:19:40 INFO - 'PAGER': '/bin/cat', 11:19:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:40 INFO - 'PWD': '/builds/slave/test', 11:19:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:40 INFO - 'SHELL': '/bin/bash', 11:19:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:40 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:40 INFO - 'USER': 'cltbld', 11:19:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:40 INFO - 'XPC_FLAGS': '0x0', 11:19:40 INFO - 'XPC_SERVICE_NAME': '0', 11:19:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:40 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-4wasQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:40 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-nQdFq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:40 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-s7gvvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:40 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-LjRQeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:40 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-juPGyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-ygF1I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-DgTPX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-GDv_PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-9vkakm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-4MvHpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-9pu7Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-oHCJSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-0h5IRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-4VmGR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-nhjG6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-svg2wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-_ZxM97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:19:42 INFO - Running setup.py install for manifestparser 11:19:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:19:42 INFO - Running setup.py install for mozcrash 11:19:42 INFO - Running setup.py install for mozdebug 11:19:42 INFO - Running setup.py install for mozdevice 11:19:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:19:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:19:42 INFO - Running setup.py install for mozfile 11:19:43 INFO - Running setup.py install for mozhttpd 11:19:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozinfo 11:19:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozInstall 11:19:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozleak 11:19:43 INFO - Running setup.py install for mozlog 11:19:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for moznetwork 11:19:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozprocess 11:19:44 INFO - Running setup.py install for mozprofile 11:19:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Running setup.py install for mozrunner 11:19:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Running setup.py install for mozscreenshot 11:19:44 INFO - Running setup.py install for moztest 11:19:44 INFO - Running setup.py install for mozversion 11:19:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:19:44 INFO - Cleaning up... 11:19:44 INFO - Return code: 0 11:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:44 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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:44 INFO - 'HOME': '/Users/cltbld', 11:19:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:44 INFO - 'LOGNAME': 'cltbld', 11:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:44 INFO - 'MOZ_NO_REMOTE': '1', 11:19:44 INFO - 'NO_EM_RESTART': '1', 11:19:44 INFO - 'PAGER': '/bin/cat', 11:19:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:44 INFO - 'PWD': '/builds/slave/test', 11:19:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:44 INFO - 'SHELL': '/bin/bash', 11:19:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:44 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:44 INFO - 'USER': 'cltbld', 11:19:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:44 INFO - 'XPC_FLAGS': '0x0', 11:19:44 INFO - 'XPC_SERVICE_NAME': '0', 11:19:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-1vcSCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-xVLBQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:45 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)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-rmTCgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-xq92ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-nHh1om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-JsZgxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-LgYUP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-qdSlcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-bUmhsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-6uXBzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-LPWzUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-opier8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-c6Z0iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-whxx5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:46 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)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-xLZuio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-wnpd6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:46 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)) 11:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-5iZmUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:19:46 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)) 11:19:46 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)) 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:49 INFO - Downloading blessings-1.6.tar.gz 11:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:50 INFO - Installing collected packages: blessings 11:19:50 INFO - Running setup.py install for blessings 11:19:50 INFO - Successfully installed blessings 11:19:50 INFO - Cleaning up... 11:19:50 INFO - Return code: 0 11:19:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:19:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:50 INFO - Reading from file tmpfile_stdout 11:19:50 INFO - Current package versions: 11:19:50 INFO - blessings == 1.6 11:19:50 INFO - blobuploader == 1.2.4 11:19:50 INFO - docopt == 0.6.1 11:19:50 INFO - functools32 == 3.2.3-2 11:19:50 INFO - jsonschema == 2.5.1 11:19:50 INFO - manifestparser == 1.1 11:19:50 INFO - mozInstall == 1.12 11:19:50 INFO - mozcrash == 1.0 11:19:50 INFO - mozdebug == 0.1 11:19:50 INFO - mozdevice == 0.49 11:19:50 INFO - mozfile == 1.2 11:19:50 INFO - mozhttpd == 0.7 11:19:50 INFO - mozinfo == 0.9 11:19:50 INFO - mozleak == 0.1 11:19:50 INFO - mozlog == 3.4 11:19:50 INFO - moznetwork == 0.27 11:19:50 INFO - mozprocess == 0.24 11:19:50 INFO - mozprofile == 0.28 11:19:50 INFO - mozrunner == 6.13 11:19:50 INFO - mozscreenshot == 0.1 11:19:50 INFO - mozsystemmonitor == 0.3 11:19:50 INFO - moztest == 0.8 11:19:50 INFO - mozversion == 1.4 11:19:50 INFO - psutil == 3.1.1 11:19:50 INFO - requests == 1.2.3 11:19:50 INFO - wsgiref == 0.1.2 11:19:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:51 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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:51 INFO - 'HOME': '/Users/cltbld', 11:19:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:51 INFO - 'LOGNAME': 'cltbld', 11:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:51 INFO - 'MOZ_NO_REMOTE': '1', 11:19:51 INFO - 'NO_EM_RESTART': '1', 11:19:51 INFO - 'PAGER': '/bin/cat', 11:19:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:51 INFO - 'PWD': '/builds/slave/test', 11:19:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:51 INFO - 'SHELL': '/bin/bash', 11:19:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:51 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:51 INFO - 'USER': 'cltbld', 11:19:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:51 INFO - 'XPC_FLAGS': '0x0', 11:19:51 INFO - 'XPC_SERVICE_NAME': '0', 11:19:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:19:51 INFO - Cleaning up... 11:19:51 INFO - Return code: 0 11:19:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:51 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 0x1059e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda684c4ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, '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.oXyGM0zRvj/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.88iAMgWSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:19:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:19:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:51 INFO - 'HOME': '/Users/cltbld', 11:19:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:51 INFO - 'LOGNAME': 'cltbld', 11:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:51 INFO - 'MOZ_NO_REMOTE': '1', 11:19:51 INFO - 'NO_EM_RESTART': '1', 11:19:51 INFO - 'PAGER': '/bin/cat', 11:19:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:51 INFO - 'PWD': '/builds/slave/test', 11:19:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:51 INFO - 'SHELL': '/bin/bash', 11:19:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:19:51 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:19:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:51 INFO - 'USER': 'cltbld', 11:19:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:51 INFO - 'XPC_FLAGS': '0x0', 11:19:51 INFO - 'XPC_SERVICE_NAME': '0', 11:19:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:19:51 INFO - Cleaning up... 11:19:51 INFO - Return code: 0 11:19:51 INFO - Running post-action listener: _resource_record_post_action 11:19:51 INFO - Running post-action listener: _start_resource_monitoring 11:19:51 INFO - Starting resource monitoring. 11:19:51 INFO - [mozharness: 2017-01-25 19:19:51.629302Z] Finished create-virtualenv step (success) 11:19:51 INFO - [mozharness: 2017-01-25 19:19:51.630278Z] Running install step. 11:19:51 INFO - Running pre-action listener: _resource_record_pre_action 11:19:51 INFO - Running main action method: install 11:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:51 INFO - Reading from file tmpfile_stdout 11:19:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:51 INFO - Reading from file tmpfile_stdout 11:19:51 INFO - Output received: 11:19:51 INFO - Usage: mozinstall [options] installer 11:19:51 INFO - Options: 11:19:51 INFO - -h, --help show this help message and exit 11:19:51 INFO - -d DEST, --destination=DEST 11:19:51 INFO - Directory to install application into. [default: 11:19:51 INFO - "/builds/slave/test"] 11:19:51 INFO - --app=APP Application being installed. [default: firefox] 11:19:51 INFO - mkdir: /builds/slave/test/build/application 11:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:20:11 INFO - Reading from file tmpfile_stdout 11:20:11 INFO - Output received: 11:20:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:20:11 INFO - Running post-action listener: _resource_record_post_action 11:20:11 INFO - [mozharness: 2017-01-25 19:20:11.864988Z] Finished install step (success) 11:20:11 INFO - [mozharness: 2017-01-25 19:20:11.865137Z] Running run-tests step. 11:20:11 INFO - Running pre-action listener: _resource_record_pre_action 11:20:11 INFO - Running main action method: run_tests 11:20:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:20:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:20:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:20:11 INFO - 2017-01-25 11:20:11.879 screenresolution[1904:11525] starting screenresolution argv=screenresolution get 11:20:11 INFO - 2017-01-25 11:20:11.882 screenresolution[1904:11525] Display 0: 1600x1200x32@60 11:20:11 INFO - 2017-01-25 11:20:11.888 screenresolution[1905:11528] starting screenresolution argv=screenresolution list 11:20:11 INFO - Available Modes on Display 0 11:20:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:20:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:20:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:20:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:20:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:20:12 INFO - Intel Iris: 11:20:12 INFO - Chipset Model: Intel Iris 11:20:12 INFO - Type: GPU 11:20:12 INFO - Bus: Built-In 11:20:12 INFO - VRAM (Dynamic, Max): 1536 MB 11:20:12 INFO - Vendor: Intel (0x8086) 11:20:12 INFO - Device ID: 0x0a2e 11:20:12 INFO - Revision ID: 0x0009 11:20:12 INFO - Displays: 11:20:12 INFO - Display: 11:20:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:20:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:20:12 INFO - Display Serial Number: 1600x1200 60 11:20:12 INFO - Main Display: Yes 11:20:12 INFO - Mirror: Off 11:20:12 INFO - Online: Yes 11:20:12 INFO - Rotation: Supported 11:20:12 INFO - Return code: 0 11:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:20:12 INFO - Python 2.7.3 11:20:12 INFO - Return code: 0 11:20:12 INFO - grabbing minidump binary from tooltool 11:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:12 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 0x1057c3d30>, '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 0x1056eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:20:12 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 11:20:12 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 11:20:12 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 11:20:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:20:12 INFO - Return code: 0 11:20:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:20:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:20:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:20:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:20:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 11:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --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 11:20:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oXyGM0zRvj/Render', 11:20:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:12 INFO - 'HOME': '/Users/cltbld', 11:20:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:12 INFO - 'LOGNAME': 'cltbld', 11:20:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:20:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:12 INFO - 'MOZ_NO_REMOTE': '1', 11:20:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:20:12 INFO - 'NO_EM_RESTART': '1', 11:20:12 INFO - 'PAGER': '/bin/cat', 11:20:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:12 INFO - 'PWD': '/builds/slave/test', 11:20:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:20:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:12 INFO - 'SHELL': '/bin/bash', 11:20:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.88iAMgWSVx/Listeners', 11:20:12 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 11:20:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:12 INFO - 'USER': 'cltbld', 11:20:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:12 INFO - 'XPC_FLAGS': '0x0', 11:20:12 INFO - 'XPC_SERVICE_NAME': '0', 11:20:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 11:20:12 INFO - mozversion application_buildid: 20170125103331 11:20:12 INFO - mozversion application_changeset: ec143b1f00bd49f6a540db3031cd7fe9a956768e 11:20:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:20:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:20:12 INFO - mozversion application_name: Firefox 11:20:12 INFO - mozversion application_remotingname: firefox-dev 11:20:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:20:12 INFO - mozversion application_vendor: Mozilla 11:20:12 INFO - mozversion application_version: 53.0a2 11:20:12 INFO - mozversion platform_buildid: 20170125103331 11:20:12 INFO - mozversion platform_changeset: ec143b1f00bd49f6a540db3031cd7fe9a956768e 11:20:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:20:12 INFO - mozversion platform_version: 53.0a2 11:20:12 INFO - using testdate: 1485372012 11:20:12 INFO - actual date: 1485372012 11:20:12 INFO - starting webserver on 'localhost:50465' 11:20:12 INFO - SUITE-START | Running 2 tests 11:20:12 INFO - TEST-START | dromaeo_css 11:20:12 INFO - operating with platform_type : mac_ 11:20:12 INFO - Initialising browser for dromaeo_css test... 11:20:12 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpNplpI9/profile http://localhost:50465/getInfo.html) 11:20:14 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 11:20:14 INFO - PROCESS | 1915 | colorDepth:24 11:20:14 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 11:20:14 INFO - PROCESS | 1915 | __metrics 11:20:14 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 11:20:15 INFO - PROCESS | 1915 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:20:15 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:15 INFO - TEST-INFO | 1915: exit 0 11:20:15 INFO - Browser initialized. 11:20:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:20:15 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpNplpI9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:27 INFO - PROCESS | 1917 | RSS: Main: 212824064 11:20:27 INFO - PROCESS | 1917 | 11:23:31 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50465/tests/dromaeo/cssquery-ext.html) 11:23:33 INFO - PROCESS | 1917 | RSS: Main: 342188032 11:23:33 INFO - PROCESS | 1917 | 11:25:17 INFO - PROCESS | 1917 | ************************* 11:25:17 INFO - PROCESS | 1917 | A coding exception was thrown and uncaught in a Task. 11:25:17 INFO - PROCESS | 1917 | 11:25:17 ERROR - PROCESS | 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:25:17 INFO - PROCESS | 1917 | Full stack: 11:25:17 INFO - PROCESS | 1917 | ************************* 11:26:36 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-ext.html (next: http://localhost:50465/tests/dromaeo/cssquery-jquery.html) 11:26:37 INFO - PROCESS | 1917 | RSS: Main: 347369472 11:26:37 INFO - PROCESS | 1917 | 11:29:39 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50465/tests/dromaeo/cssquery-mootools.html) 11:29:39 INFO - PROCESS | 1917 | RSS: Main: 327897088 11:29:39 INFO - PROCESS | 1917 | 11:32:42 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50465/tests/dromaeo/cssquery-prototype.html) 11:32:42 INFO - PROCESS | 1917 | RSS: Main: 327901184 11:32:42 INFO - PROCESS | 1917 | 11:35:46 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50465/tests/dromaeo/cssquery-yui.html) 11:35:47 INFO - PROCESS | 1917 | RSS: Main: 312238080 11:35:47 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:50465/tests/dromaeo/cssquery-yui.html (next: http://localhost:50465/tests/dromaeo/cssquery-dojo.html) 11:38:50 INFO - PROCESS | 1917 | RSS: Main: 378060800 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | __start_tp_report 11:38:50 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 11:38:50 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 11:38:50 INFO - PROCESS | 1917 | |i|pagename|runs| 11:38:50 INFO - PROCESS | 1917 | |0;dojo.html;2805.410863718619;3247.8700851965923;3266.7386609071277;3298.719608833249;3317.452620317647;5648.802291919784;5699.6580205187665;5742.741576629051;5745.511631511316;5752.7411266493;5682.17608446775;5689.345725241598;5757.366689664133;5763.423657634245;5772.509336706375;5186.247994040871;5226.634135610509;5233.267342572043;5272.340957380327;5307.867303317429;5189.221616757479;5213.9478605214035;5215.9828833377505;5311.920321195185;5333.359996800389;5276.868078298035;5305.602079844008;5310.495502927235;5318.414974352818;5318.73406329682;5279.102552566053;5291.232771248147;5295.682259064469;5299.417064122943;5305.3898801637915;5132.358455193101;5247.449017853147;5252.501012403854;5255.5795536357;5263.86840328991;5834.912476312858;5836.620619659751;5836.737346819404;5839.7664093436215;5840.970795145997;6168.907466387963;6189.628622282632;6209.59637623553;6210.565260431772;6222.937770622281;5263.86840328991;6267.5299352548745;6293.968530157365;6297.779577714758;6308.179936608258;5801.158831969341;5847.502962248214;5855.09246066856;5870.236869206976;6023.728932198062;5225.477452254782;6213.875722485525;6269.059641053878;6291.811245662638;6305.243370795534;6119.908375659848;6120.8227501369765;6153.107799369156;6166;6252.843678908063;6333.429991300805;6342.841428964312;6345.650989195547;6346.714397852108;6351.110844481776;6275.717592708248;6322;6323.588966717149;6328.968355158195;6329.208848893888;6137.910713126346;6204.689765511706;6208.379162083756;6215.782447614311;6313.715882785285;5032.547070763649;5044.243363495505;5053;5053.2420136979745;5069.1635880079375;4341.8480353188115;4348.456442944632;4448.599626033672;4487.394201782718;4491.640668746492;5584.542801167473;5616.719164041781;5692.544596432275;5695.946249943774;5702;6247.75008999644;6259.624422534663;6293.527985401113;6309;6310.274318453345;5759.376308495932;5795.362510123883;5800.651960882276;5809.622374545641;5833.766649334064;5519.779208831602;5533.6403133796175;5534.667919924736;5535;5543.6396634218645;6196.721147548281;6250.343713909974;6257.5932564383165;6312.747490100344;6330.050492426173;6235.314115447207;6251.6561589113035;6283.8114856554375;6292.685365731787;6293.590916590407;5268.367795864521;6242.531810114168;6267.905981410191;6305.243370795534;6315.526335524946;6277.623342599459;6288.622682639057;6295.527835412271;6296.464800491826;6303.212098487689;6196.0705894116245;6235.719392627252;6239.532035097295;6251.68741562911;6289;4969.428515720594;6061.454469097803;6216.875662486635;6228.688565571612;6241.188645476059;6181.690915454119;6185.597936134137;6186.133941248138;6196.349383314687;6196.597221180609;5754.625949313281;5855.94144058554;6021.608595441282;6054.515638748978;6063.666498342457;5040.949590504048;6112.449879510866;6142.959235178615;6163.476104531165;6239.376062393724;6052.394760523913;6072.876517844213;6075.058365953284;6090.184832686333;6114.327423983269 11:38:50 INFO - PROCESS | 1917 | |1;ext.html;461.8131402296099;466.8179410030091;469.18830423367575;531.10243688167;560.196118569852;30892;33281.66718332816;38951.41572876409;39606.60393396069;39721.4041789373;41304.38043429351;41606.58393416065;41613.16773664525;41705.16589668205;41855.58144418555;8461.873071903927;8746;9329.113734195258;9566.66516671913;9578.712638620818;11237.213395062348;11461.197716159872;11554.306741595488;11720.824187637192;11726.941365293162;11471;11579.305241685526;11596;11596.246243994114;11606.30362178272;8446.324294056461;8705.303575713991;8711.433756805787;11552.3646199459;11656.417179141094;8595.140485951417;8655.783605409915;9137.725868223964;11398.974092331648;11434.771304573862;40479.7976010121;40930.79534602338;40991;41014.589854101374;41045;3505.439129739255;4024.6981476389387;4093.5906409359122;4098.077932465201;4107.938380924288;29571.70428295711;30749.538756918664;31056.844715776275;31183.84408077945;31373.52939705906;3210.4542227821094;3251.7723759336855;3263.3473305339026;3276.639569647337;3280.7703460757757;379741;447150.99999999674;447626;448477.99999999674;448703;59920.10119848206;60159.09761353583;60302.69848650729;60303.49241269004;60366.39633603695;64383.678081609294;64457.67771161114;64491.67754161199;64497.67751161214;64561.677191613744;16266.268017939221;16754.664906701797;16809.747853782203;16829.990200588003;16893.408730694366;11405.771884562262;11724.765504689858;12597.874021259853;12814.35928203586;12870.871291287154;16754.4135955241;16756.413525526546;16784.992900426012;16806;17028.978261304113;7209.927900720925;7223.386012188917;7245.7826265212125;7288;7293.9635301823155;863.6440787962838;880.9427387219811;900.144862380741;914.5610107148606;924.2190349154953;28954.27614309659;29754.702452975194;29970;30332.241693957385;30422.239444014078;1072.2172813845937;1084.4469320646526;1091.2415870969758;1102.80149573076;1202.9941186954245;14780.334884930204;15328.386864525517;15391.84608153904;15699.21503924822;15713.764293535605;593516;698041;705985;706489;898241;52988.470115298354;53429;53620.73189634027;53636.46363536393;53697.46302537003;1416.872481476672;1437.324457504971;1463.0490181381974;1463.2098666720278;1468.3172324868988;28030.85984570064;28067.017654382817;28770.74431084203;28934.276643084093;29097.418051639273;45711.77144114391;46164;46248.30627540657;46287.6113716589;46582;543774;544734;545393;546779;547040;21581.676274855574;22274.220402285842;24156;24223.273301800975;24614.261572152864;39732.60267397289;40705.77882663525;40876;41648.3752743703;41846.790766045975;34326.48510272398;34843;34858.302833943686;34884.9534513965;35402.82298588491;34574.13564660904;34604.480932785526;35245.82377088098;35551;35627.75302864387;33740.66259337375;33806.830965846;34409;34432.82783586066;34502;29424.11727648174;30934.53598196074;30954.380912382076;31081.533776993816;31223;23355.948982295497;23522.411939701644;23602;23714.407139820953;23753.64369534424 11:38:50 INFO - PROCESS | 1917 | |2;jquery.html;370.59234841674146;393.10176247274984;400.3514306822946;413.2561389498902;427.2160585325927;14320.57038288853;19879.900600496996;20967;21116.472088197785;21129.260475883348;17260.568485787862;21211.257605983792;22506.21228257011;22541.661875071888;22858;6490.805275841721;6783.152105986752;6870.656467176646;6928.515003949726;6936.722531098775;5759.222504961839;6614.338566143371;6764.188297404294;6827.829304267409;6908.516403851732;6809.693563789617;6830.590164590116;6836.7607133750325;6837.589744615339;6844.178698556156;6603.900941485882;6845.110135682355;6924.930750692479;6932.445404367639;6939.375456208915;6555.44278736308;6718.093057437232;6785.6267905265195;6799.354061364163;6812.795616131474;28950.855245723847;29471.410571788445;29727.40545189084;29827.956021539358;30196.849015754782;2922.663893652236;3098.798578092439;3238.8380580971093;3472.44440889459;3496.615372309044;16097.919510402373;17020.319187232497;17042.403515876886;17148.828511714848;17263.791534592583;2007.6185524750397;2013.4563667809755;2034.6642803937332;2064.9483762905897;2182.25803226902;133602.99999999904;165473.17263413727;166050.16974915168;167179;168131.31868681402;19336.129874155697;22898.771012289995;23589.528209435714;24185.637215441784;24972;26841.328966775985;35748.642513575054;40815.77552673424;41012.97467563335;41095.7945210272;11076.556937722562;11165.94417027926;11380.260283081574;11642.24325418845;11736.530538778354;9213.696575856036;9223.815523689489;9225.677101301422;9240.676576319796;9378.390404623678;9929.056739609725;11139.001416606734;11413.942930285462;11518.654440366803;11610.477528511237;4164.437800896901;4230.398305042439;4241.130568233505;4248.85129020489;4265.829366825355;848.821747433046;895.4492986813063;897.2186222709548;899.3839220134098;923.6859467780987;18130.766941164642;21202;21891.67162492564;21963.768946091917;22089.33731988043;908.8682141089505;925.1072714830086;933.9486328252011;939.5677988125402;940.6660635474445;10904.50929708165;11381.317120972768;11429.199956003165;11457.312561246352;11457.88542114585;757737;760281;762610;767240;782039;151728;151847.24076379547;156958;158395.20802395913;165704.5144322836;1010.1968934696934;1016.4765145949842;1023.3552861697083;1045.8222102242637;1046.0324200114862;18953.810461895206;19205.32781352646;19397.61204775925;19438.708419374005;19439.70840437423;53751.92496150133;56230;57382.426175739376;58332.12501812561;59485.40514594799;74197;79208.60395698216;83202;85562;87670.56164719391;5984;8141.267285944294;8213.83572328562;8295.751127465945;8553.401261911606;9148.405353651991;11994.340311282964;12553.372331383212;12693.555725549932;12741.98064154884;9263.212626926786;10839.319905414673;11077.169212308949;11267.746450710054;11391.259568128045;7854.293113619573;11003.779924401628;11041.447927603427;11124.830717756815;11578.768424631291;9459.810803784023;11389.202755807013;11489.253198542068;11596.188266821242;11649.19437487157;8144.185581441809;8373.748787536384;8465.66137354499;8553.74338769838;8609.526476043628;8746.868796968178;10951.959563841741;11007.779844403227;11092.33445993243;11383.715407114889 11:38:50 INFO - PROCESS | 1917 | |3;mootools.html;1416.2493878244534;1449.2391494465405;1452.034397125911;1472.3374481483331;1473.4548217159645;8086.51480911145;8528.872066919;8532.957335213316;8550.657973681053;8562.357823163256;7438.070241219848;7667.769966900988;7678;8029.5182289062695;8332.791680207998;2294.3346429535454;2350.4006478347997;2350.74141844397;2354.3407845803117;2354.6468029795583;2352.0591763294733;2376.287113865842;2380.880955952204;2386.642003699442;2389.2712722619594;2303.3320337102305;2310.90756369745;2332.801711854486;2332.88335583221;2333.393317737392;1994.3518356534184;2276.635738281875;2300.769088537641;2305.7809508096702;2307.1002309099463;2257.898394572248;2337.590921588715;2342.063174730122;2342.636891281854;2345.4957184205477;8367.163283671645;8398;8426.915730842675;8443.015891265548;8459.703910363169;5057.595392368602;5090.694558326475;5091.949080509185;5161.974190129063;5198.610104242159;3264.4613638749815;3358;3481.0601137692934;3526.400511912981;3541.592716837571;1201.9338936358497;1210.4431961297814;1227.4476485581524;1240.9193402428814;1259.6598918292102;9738.123568878764;10690.946545267301;10772.353658780497;10895.346279223271;10913.83629245562;4424.867253982386;4624.95375046252;4704.294355846582;4707.7881495332795;4708.529147085333;9531.857022144673;9537.189338906272;9554.952225238969;9561.091696288842;9585.808283834283;5226.738663066832;5230.790768369223;5233.110371236899;5235.031519168966;5242.13504771716;4184.3932629768515;4518.43519560055;4642.257238841769;4733.95266047342;4742.620590352763;3824.7513911595656;3860.2279544091293;3908.8241029153187;3939.8227079781477;3941.192055628589;1267.4613289352174;1272.6500212441467;1278.7058976435471;1286.633309506786;1297.4874924404996;905.6649039855164;915.2129168914728;933.7665583604099;941.2940294778916;976.72651657536;5575.69333686643;5606.990741666539;5846.011620451593;5867.325257595346;5901.144334071536;507.76388979124886;570.4751628501788;576.3199424678919;585.493548080907;588.9970550147222;3840;3852.075501879585;3905.6875449963936;3913.2369188008065;3941.881743547698;7847.882281765778;9885.950570247103;9888.555015024342;10039.196864250842;10041.849372259421;9990.300678952404;10003.849942250872;10007.49962501872;10024.54889529973;10026.849597256047;7752.418568607377;7811.375089992787;7926.207379262143;7951.932497550679;7960.761177164694;5536.91694624589;5779.450952159538;5796.82609521715;6006.81979540597;6011.278646562266;9274.6290148396;9348.20540254086;9355.719328420158;9387.15515603599;9421.62313507452;9095.545222738969;9578.521073946136;9603.991580883907;9607.90392096098;9624.181944534794;6605.966970165118;6832.350926661959;6848.383645471732;7220.89168662481;7373.188949215475;7502.437317201123;7691.5769632670745;7981.161977992228;8091.635876385694;8107.594620268845;7045.084139062094;7158.606276654834;7257;7304.561726296439;7394.149672787698;6903.689333980084;7036.753713619999;7078.646067696697;7174.354308112295;7180.497365184387;6434.549581529248;6446.613203207822;6510.544261901811;6520.673966301761;6635.767748128792;5022.221555658879;5053.797848086036;5092.261622064706;5104.489551045014;5105.285260063668;5016.673916195582;5030.446650868328;5158.845234642967;5206;5213.322268105122 11:38:50 INFO - PROCESS | 1917 | |4;prototype.html;357.35675783589534;366.790929170373;367.3259568691451;382.1306527649595;382.9578746337904;4485.102979404116;5075.314832497612;5102.591792656593;5293.300416787437;5327.094393953028;4091.4067460218253;4356.89107772305;5025.698458092517;5068.46781087986;5322.9620224056325;3563.8574457021687;3819.1667999360325;4116.382542618601;4180.728252663567;4236.512801027875;4131.52487463941;4149.605787450188;4172.311568591179;4229.957700423002;4230.640395566381;3177.8252196129206;3416.7949923004576;3778.622137786213;4031.8912299117833;4178.749275043507;3373.797572145667;3381.9323613527836;3965.6430921217084;3982.3429134192825;4042.43405923171;2835.7306055924655;3458.187325978393;3460.602030766444;3466.324066806974;3501.8949431517094;4568.223402021665;5114.130597798383;5114.872128196787;5134.229865520165;5244.81643142492;4128.855490057834;4306.578828986427;4530.660200484944;4616.746078965655;4661.417322834645;4698.919248572847;5025.969676216367;5220.712860792655;5320.707361095138;5352.57179425645;3744.7378683492166;3817.8091095445116;3865.9226815463535;3878.1274213302063;3913.4521167036637;4692.507286734912;5139.922901156486;5274.602230408945;5301.686445971268;5744.310682718101;3304.8512816923294;3518.225990282185;3771.151490914522;3879.1078052048188;3880.262750077476;3935.2916475034194;3968.3253846846105;3974.8608798692485;3977.7812220327583;3997.32045552251;4014.558398576154;4429.335599660012;4596.862094137115;4618.237990731559;4620.283856002325;4751.907061375903;4981.975090124599;5576.6096373254295;5624.803131890364;5657.727011422479;1095.2257343104063;1137.7155711072232;1219.7255617485994;1268.5560053981033;1282.6985658370274;801.6753214947955;830.6096134816627;831.8086840026828;852.4459101584021;868.2533021601417;4144.191882582867;4216.662666986634;4434.645228381722;5001.424836143818;5014.868680810641;4916.6321070067115;5109.310243117206;5123.590112790967;5166.715830629276;5478.45215478449;4217.36739489073;4328.5022222444195;4813.855584332476;4940.728259945666;4986.90026199474;2590.2229331200565;2786.9163925081875;2841.346490307241;2859.270885924076;2878.3811480531785;4726.243800991893;4993.850184494471;5238.869028274247;5412.78348866041;5560.582956278296;4470.865874023784;5090.93090451002;5222.213894926148;5515.7242137892945;5694.743736531866;4857.951420485821;5080.034793389244;5218.7475005998285;5333.973330133324;5447.782088716565;4793.004372267333;5343.759530821045;5367.919481207863;5369.54358879484;5370.9731451342495;5184.533391994739;5622.465865742748;5653.717314134359;5677.687727175045;5753.71231438418;5025.346704928336;5904.645721256738;5924.6149000314845;5958.914379966977;5958.940410595838;2934.662513810854;3402.098443912316;3764.284785890672;3868.2843673920415;3918.9804050979565;5387.299651045339;5728.625129968861;5862.794802182074;5863.384344643751;5888.499477544457;5182.989317083133;5323.243329701267;5358.062339090566;5609.298837645294;5675.829725108253;4890.608751299958;5063.518965698253;5100.744962751922;5544;5624.74688639004;4683;5312.910853275147;5486.753096110764;5497.378273409274;5526.651173251272;4812.35033270504;4874.074740477562;5345.65253258537;5369.919451208157;5571.832845014656;4346.521882592975;5407.593216273723;5497.285352904097;5497.752601132878;5499.285092937893 11:38:50 INFO - PROCESS | 1917 | |5;yui.html;693.7363801755332;721.0770214125918;773.4817672159652;831.6631764135525;842.5660784695883;14988.400463981428;15357.462488812895;15775.368985240577;15807;15851.890367674254;12853.67865803353;12884.16252943558;12912.289824059673;15694.37222511101;16595.66808663826;855.4439614250724;883.0286684646869;885.437747030637;886.685226744506;887.3256325192867;874.1389731114847;874.7550685807984;875.374107513128;876.1457578860624;883.5405589093667;883.6156272021659;927.0636656976469;927.3925578745932;929.7675581104724;933.2207606648457;908.577511457169;923.5520772425368;925.6575067225136;926.3098991251493;928.9396189247711;690.3338278561213;691.1360799001249;692.9792106236821;693.1335830212234;694.3403766421869;15545;16063.759043614238;16276.430324938688;16278.51164465068;16289.266982985793;12095;12150.392480375946;12152.21010634306;12251.57119500822;12416.787695235971;11318.434078296135;11711.590094346657;11789;11848.703782405422;11866.466009029615;3622.6920711739535;3723.7765734056043;3731.067233191702;3739.476473293741;3765.002274397287;58283.41716582865;77752.61123694346;93870.06129938681;99951.50024249905;108230;11078.0583650389;11103.83344249837;11137.109031277478;11329.43352832355;11347.489362978686;22101.778982210293;22316.44208894758;22355.10579576831;22496.21263255778;22633.660495092587;7628.80927976805;7963.562004089831;8055.718049868226;8080.353571714249;8255.711050113217;4289.978550107229;4373.890652733707;4411.698548928074;4424.756638384855;4525.524819893863;3587.587427445877;3693.076730817296;3702.204026134394;3711.5917249102577;3824.3116239077235;713.1727196452194;720.6288761287941;721.5418209437046;734.9118105827334;746.6192241956642;616.7286393986722;617.9227596550431;626.2891618013497;637.3594537489793;663.810813918031;9541.284403669753;9768.51157442125;9967.55146018431;10246.231532635082;10432.68701938928;581.2995340614549;633.5238893378418;653.7058323754329;658.7101675262869;673.6665350651459;4184.644305234028;4718.740469274223;4885.682430641997;4947.678400903929;4958.157113290749;74912.50174996578;99846.50230246552;100576.98846023185;101942.49028754809;106820.46589767002;69855.65072174606;71215;72109;72332.27667723256;82206.17793822105;68915.3108468919;70875.2912470879;71270.28729712637;72817;74684.87972680414;10003.099721025143;10277;10445.477726113511;10480.056794888496;10496.580136794442;36674.633253667125;43087.56912430836;44149.55850441455;45013.32480012868;49032.019359613325;54751.72624136854;59921.70039149776;66261.01216963498;67204.6639766798;71488;12057.81913271284;12143.75712485763;12221.511139554319;12245.387730613256;12777.87222127804;13230;13519.256440895451;13962.650933726332;14096.08375455592;14388;12837.550685725955;12920.935395322964;13062.216267024009;13089.280089595164;13342.266175360448;13022.47910083586;13036.217826930415;13275.004374671746;13333.066685331934;13365.933170334087;12501;12811.103222774316;12842.486300548248;12975.221486710827;13442.193468391928;10650.8402373966;10675.946620266848;10943.179261555257;11087.667369978913;11301.378424186749;10158.928633451946;10365.222608304257;10435.217358697977;10440.425776582057;10478.685639430829 11:38:50 INFO - PROCESS | 1917 | __end_tp_report 11:38:50 INFO - PROCESS | 1917 | __start_cc_report 11:38:50 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,1480 11:38:50 INFO - PROCESS | 1917 | __end_cc_report 11:38:50 INFO - PROCESS | 1917 | __startTimestamp1485373130481__endTimestamp 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | ------- Summary: start ------- 11:38:50 INFO - PROCESS | 1917 | Number of tests: 6 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5759.97 Median:6023.73 stddev:664.38 (11.0%) stddev-sans-first:624.68 11:38:50 INFO - PROCESS | 1917 | Values: 2805.4 3247.9 3266.7 3298.7 3317.5 5648.8 5699.7 5742.7 5745.5 5752.7 5682.2 5689.3 5757.4 5763.4 5772.5 5186.2 5226.6 5233.3 5272.3 5307.9 5189.2 5213.9 5216.0 5311.9 5333.4 5276.9 5305.6 5310.5 5318.4 5318.7 5279.1 5291.2 5295.7 5299.4 5305.4 5132.4 5247.4 5252.5 5255.6 5263.9 5834.9 5836.6 5836.7 5839.8 5841.0 6168.9 6189.6 6209.6 6210.6 6222.9 5263.9 6267.5 6294.0 6297.8 6308.2 5801.2 5847.5 5855.1 5870.2 6023.7 5225.5 6213.9 6269.1 6291.8 6305.2 6119.9 6120.8 6153.1 6166.0 6252.8 6333.4 6342.8 6345.7 6346.7 6351.1 6275.7 6322.0 6323.6 6329.0 6329.2 6137.9 6204.7 6208.4 6215.8 6313.7 5032.5 5044.2 5053.0 5053.2 5069.2 4341.8 4348.5 4448.6 4487.4 4491.6 5584.5 5616.7 5692.5 5695.9 5702.0 6247.8 6259.6 6293.5 6309.0 6310.3 5759.4 5795.4 5800.7 5809.6 5833.8 5519.8 5533.6 5534.7 5535.0 5543.6 6196.7 6250.3 6257.6 6312.7 6330.1 6235.3 6251.7 6283.8 6292.7 6293.6 5268.4 6242.5 6267.9 6305.2 6315.5 6277.6 6288.6 6295.5 6296.5 6303.2 6196.1 6235.7 6239.5 6251.7 6289.0 4969.4 6061.5 6216.9 6228.7 6241.2 6181.7 6185.6 6186.1 6196.3 6196.6 5754.6 5855.9 6021.6 6054.5 6063.7 5040.9 6112.4 6143.0 6163.5 6239.4 6052.4 6072.9 6075.1 6090.2 6114.3 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:69091.62 Median:34871.63 stddev:156163.50 (447.8%) stddev-sans-first:156516.57 11:38:50 INFO - PROCESS | 1917 | Values: 461.8 466.8 469.2 531.1 560.2 30892.0 33281.7 38951.4 39606.6 39721.4 41304.4 41606.6 41613.2 41705.2 41855.6 8461.9 8746.0 9329.1 9566.7 9578.7 11237.2 11461.2 11554.3 11720.8 11726.9 11471.0 11579.3 11596.0 11596.2 11606.3 8446.3 8705.3 8711.4 11552.4 11656.4 8595.1 8655.8 9137.7 11399.0 11434.8 40479.8 40930.8 40991.0 41014.6 41045.0 3505.4 4024.7 4093.6 4098.1 4107.9 29571.7 30749.5 31056.8 31183.8 31373.5 3210.5 3251.8 3263.3 3276.6 3280.8 379741.0 447151.0 447626.0 448478.0 448703.0 59920.1 60159.1 60302.7 60303.5 60366.4 64383.7 64457.7 64491.7 64497.7 64561.7 16266.3 16754.7 16809.7 16830.0 16893.4 11405.8 11724.8 12597.9 12814.4 12870.9 16754.4 16756.4 16785.0 16806.0 17029.0 7209.9 7223.4 7245.8 7288.0 7294.0 863.6 880.9 900.1 914.6 924.2 28954.3 29754.7 29970.0 30332.2 30422.2 1072.2 1084.4 1091.2 1102.8 1203.0 14780.3 15328.4 15391.8 15699.2 15713.8 593516.0 698041.0 705985.0 706489.0 898241.0 52988.5 53429.0 53620.7 53636.5 53697.5 1416.9 1437.3 1463.0 1463.2 1468.3 28030.9 28067.0 28770.7 28934.3 29097.4 45711.8 46164.0 46248.3 46287.6 46582.0 543774.0 544734.0 545393.0 546779.0 547040.0 21581.7 22274.2 24156.0 24223.3 24614.3 39732.6 40705.8 40876.0 41648.4 41846.8 34326.5 34843.0 34858.3 34885.0 35402.8 34574.1 34604.5 35245.8 35551.0 35627.8 33740.7 33806.8 34409.0 34432.8 34502.0 29424.1 30934.5 30954.4 31081.5 31223.0 23355.9 23522.4 23602.0 23714.4 23753.6 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:43626.94 Median:16647.82 stddev:127828.68 (767.8%) stddev-sans-first:128146.01 11:38:50 INFO - PROCESS | 1917 | Values: 370.6 393.1 400.4 413.3 427.2 14320.6 19879.9 20967.0 21116.5 21129.3 17260.6 21211.3 22506.2 22541.7 22858.0 6490.8 6783.2 6870.7 6928.5 6936.7 5759.2 6614.3 6764.2 6827.8 6908.5 6809.7 6830.6 6836.8 6837.6 6844.2 6603.9 6845.1 6924.9 6932.4 6939.4 6555.4 6718.1 6785.6 6799.4 6812.8 28950.9 29471.4 29727.4 29828.0 30196.8 2922.7 3098.8 3238.8 3472.4 3496.6 16097.9 17020.3 17042.4 17148.8 17263.8 2007.6 2013.5 2034.7 2064.9 2182.3 133603.0 165473.2 166050.2 167179.0 168131.3 19336.1 22898.8 23589.5 24185.6 24972.0 26841.3 35748.6 40815.8 41013.0 41095.8 11076.6 11165.9 11380.3 11642.2 11736.5 9213.7 9223.8 9225.7 9240.7 9378.4 9929.1 11139.0 11413.9 11518.7 11610.5 4164.4 4230.4 4241.1 4248.9 4265.8 848.8 895.4 897.2 899.4 923.7 18130.8 21202.0 21891.7 21963.8 22089.3 908.9 925.1 933.9 939.6 940.7 10904.5 11381.3 11429.2 11457.3 11457.9 757737.0 760281.0 762610.0 767240.0 782039.0 151728.0 151847.2 156958.0 158395.2 165704.5 1010.2 1016.5 1023.4 1045.8 1046.0 18953.8 19205.3 19397.6 19438.7 19439.7 53751.9 56230.0 57382.4 58332.1 59485.4 74197.0 79208.6 83202.0 85562.0 87670.6 5984.0 8141.3 8213.8 8295.8 8553.4 9148.4 11994.3 12553.4 12693.6 12742.0 9263.2 10839.3 11077.2 11267.7 11391.3 7854.3 11003.8 11041.4 11124.8 11578.8 9459.8 11389.2 11489.3 11596.2 11649.2 8144.2 8373.7 8465.7 8553.7 8609.5 8746.9 10952.0 11007.8 11092.3 11383.7 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5456.61 Median:5220.03 stddev:2961.48 (56.7%) stddev-sans-first:2954.21 11:38:50 INFO - PROCESS | 1917 | Values: 1416.2 1449.2 1452.0 1472.3 1473.5 8086.5 8528.9 8533.0 8550.7 8562.4 7438.1 7667.8 7678.0 8029.5 8332.8 2294.3 2350.4 2350.7 2354.3 2354.6 2352.1 2376.3 2380.9 2386.6 2389.3 2303.3 2310.9 2332.8 2332.9 2333.4 1994.4 2276.6 2300.8 2305.8 2307.1 2257.9 2337.6 2342.1 2342.6 2345.5 8367.2 8398.0 8426.9 8443.0 8459.7 5057.6 5090.7 5091.9 5162.0 5198.6 3264.5 3358.0 3481.1 3526.4 3541.6 1201.9 1210.4 1227.4 1240.9 1259.7 9738.1 10690.9 10772.4 10895.3 10913.8 4424.9 4625.0 4704.3 4707.8 4708.5 9531.9 9537.2 9555.0 9561.1 9585.8 5226.7 5230.8 5233.1 5235.0 5242.1 4184.4 4518.4 4642.3 4734.0 4742.6 3824.8 3860.2 3908.8 3939.8 3941.2 1267.5 1272.7 1278.7 1286.6 1297.5 905.7 915.2 933.8 941.3 976.7 5575.7 5607.0 5846.0 5867.3 5901.1 507.8 570.5 576.3 585.5 589.0 3840.0 3852.1 3905.7 3913.2 3941.9 7847.9 9886.0 9888.6 10039.2 10041.8 9990.3 10003.8 10007.5 10024.5 10026.8 7752.4 7811.4 7926.2 7951.9 7960.8 5536.9 5779.5 5796.8 6006.8 6011.3 9274.6 9348.2 9355.7 9387.2 9421.6 9095.5 9578.5 9604.0 9607.9 9624.2 6606.0 6832.4 6848.4 7220.9 7373.2 7502.4 7691.6 7981.2 8091.6 8107.6 7045.1 7158.6 7257.0 7304.6 7394.1 6903.7 7036.8 7078.6 7174.4 7180.5 6434.5 6446.6 6510.5 6520.7 6635.8 5022.2 5053.8 5092.3 5104.5 5105.3 5016.7 5030.4 5158.8 5206.0 5213.3 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4371.75 Median:4882.34 stddev:1333.20 (27.3%) stddev-sans-first:1302.44 11:38:50 INFO - PROCESS | 1917 | Values: 357.4 366.8 367.3 382.1 383.0 4485.1 5075.3 5102.6 5293.3 5327.1 4091.4 4356.9 5025.7 5068.5 5323.0 3563.9 3819.2 4116.4 4180.7 4236.5 4131.5 4149.6 4172.3 4230.0 4230.6 3177.8 3416.8 3778.6 4031.9 4178.7 3373.8 3381.9 3965.6 3982.3 4042.4 2835.7 3458.2 3460.6 3466.3 3501.9 4568.2 5114.1 5114.9 5134.2 5244.8 4128.9 4306.6 4530.7 4616.7 4661.4 4698.9 5026.0 5220.7 5320.7 5352.6 3744.7 3817.8 3865.9 3878.1 3913.5 4692.5 5139.9 5274.6 5301.7 5744.3 3304.9 3518.2 3771.2 3879.1 3880.3 3935.3 3968.3 3974.9 3977.8 3997.3 4014.6 4429.3 4596.9 4618.2 4620.3 4751.9 4982.0 5576.6 5624.8 5657.7 1095.2 1137.7 1219.7 1268.6 1282.7 801.7 830.6 831.8 852.4 868.3 4144.2 4216.7 4434.6 5001.4 5014.9 4916.6 5109.3 5123.6 5166.7 5478.5 4217.4 4328.5 4813.9 4940.7 4986.9 2590.2 2786.9 2841.3 2859.3 2878.4 4726.2 4993.9 5238.9 5412.8 5560.6 4470.9 5090.9 5222.2 5515.7 5694.7 4858.0 5080.0 5218.7 5334.0 5447.8 4793.0 5343.8 5367.9 5369.5 5371.0 5184.5 5622.5 5653.7 5677.7 5753.7 5025.3 5904.6 5924.6 5958.9 5958.9 2934.7 3402.1 3764.3 3868.3 3919.0 5387.3 5728.6 5862.8 5863.4 5888.5 5183.0 5323.2 5358.1 5609.3 5675.8 4890.6 5063.5 5100.7 5544.0 5624.7 4683.0 5312.9 5486.8 5497.4 5526.7 4812.4 4874.1 5345.7 5369.9 5571.8 4346.5 5407.6 5497.3 5497.8 5499.3 11:38:50 INFO - PROCESS | 1917 | 11:38:50 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:18864.14 Median:3794.66 stddev:26073.67 (687.1%) stddev-sans-first:26111.12 11:38:50 INFO - PROCESS | 1917 | Values: 693.7 721.1 773.5 831.7 842.6 14988.4 15357.5 15775.4 15807.0 15851.9 12853.7 12884.2 12912.3 15694.4 16595.7 855.4 883.0 885.4 886.7 887.3 874.1 874.8 875.4 876.1 883.5 883.6 927.1 927.4 929.8 933.2 908.6 923.6 925.7 926.3 928.9 690.3 691.1 693.0 693.1 694.3 15545.0 16063.8 16276.4 16278.5 16289.3 12095.0 12150.4 12152.2 12251.6 12416.8 11318.4 11711.6 11789.0 11848.7 11866.5 3622.7 3723.8 3731.1 3739.5 3765.0 58283.4 77752.6 93870.1 99951.5 108230.0 11078.1 11103.8 11137.1 11329.4 11347.5 22101.8 22316.4 22355.1 22496.2 22633.7 7628.8 7963.6 8055.7 8080.4 8255.7 4290.0 4373.9 4411.7 4424.8 4525.5 3587.6 3693.1 3702.2 3711.6 3824.3 713.2 720.6 721.5 734.9 746.6 616.7 617.9 626.3 637.4 663.8 9541.3 9768.5 9967.6 10246.2 10432.7 581.3 633.5 653.7 658.7 673.7 4184.6 4718.7 4885.7 4947.7 4958.2 74912.5 99846.5 100577.0 101942.5 106820.5 69855.7 71215.0 72109.0 72332.3 82206.2 68915.3 70875.3 71270.3 72817.0 74684.9 10003.1 10277.0 10445.5 10480.1 10496.6 36674.6 43087.6 44149.6 45013.3 49032.0 54751.7 59921.7 66261.0 67204.7 71488.0 12057.8 12143.8 12221.5 12245.4 12777.9 13230.0 13519.3 13962.7 14096.1 14388.0 12837.6 12920.9 13062.2 13089.3 13342.3 13022.5 13036.2 13275.0 13333.1 13365.9 12501.0 12811.1 12842.5 12975.2 13442.2 10650.8 10675.9 10943.2 11087.7 11301.4 10158.9 10365.2 10435.2 10440.4 10478.7 11:38:50 INFO - PROCESS | 1917 | -------- Summary: end -------- 11:38:50 INFO - PROCESS | 1917 | 11:38:51 INFO - TEST-INFO | 1917: exit 0 11:38:51 INFO - TEST-OK | dromaeo_css | took 1118630ms 11:38:51 INFO - TEST-START | kraken 11:38:51 INFO - operating with platform_type : mac_ 11:38:51 INFO - Initialising browser for kraken test... 11:38:51 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpaeYWPY/profile http://localhost:50465/getInfo.html) 11:38:53 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 11:38:53 INFO - PROCESS | 1922 | colorDepth:24 11:38:53 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 11:38:53 INFO - PROCESS | 1922 | __metrics 11:38:53 INFO - PROCESS | 1922 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 11:38:53 INFO - PROCESS | 1922 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:38:53 INFO - PROCESS | 1922 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:38:54 INFO - TEST-INFO | 1922: exit 0 11:38:54 INFO - Browser initialized. 11:38:54 INFO - Running cycle 1/1 for kraken test... 11:38:54 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpaeYWPY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:06 INFO - PROCESS | 1923 | RSS: Main: 212983808 11:39:06 INFO - PROCESS | 1923 | 11:39:09 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-beat-detection) 11:39:10 INFO - PROCESS | 1923 | RSS: Main: 264077312 11:39:10 INFO - PROCESS | 1923 | 11:39:12 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-dft) 11:39:13 INFO - PROCESS | 1923 | RSS: Main: 276918272 11:39:13 INFO - PROCESS | 1923 | 11:39:16 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-fft) 11:39:17 INFO - PROCESS | 1923 | RSS: Main: 374321152 11:39:17 INFO - PROCESS | 1923 | 11:39:19 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50465/tests/kraken/driver.html?testName=audio-oscillator) 11:39:19 INFO - PROCESS | 1923 | RSS: Main: 278900736 11:39:19 INFO - PROCESS | 1923 | 11:39:21 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:39:22 INFO - PROCESS | 1923 | RSS: Main: 280793088 11:39:22 INFO - PROCESS | 1923 | 11:39:25 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50465/tests/kraken/driver.html?testName=imaging-darkroom) 11:39:25 INFO - PROCESS | 1923 | RSS: Main: 320565248 11:39:25 INFO - PROCESS | 1923 | 11:39:28 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50465/tests/kraken/driver.html?testName=imaging-desaturate) 11:39:29 INFO - PROCESS | 1923 | RSS: Main: 320073728 11:39:29 INFO - PROCESS | 1923 | 11:39:31 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50465/tests/kraken/driver.html?testName=json-parse-financial) 11:39:32 INFO - PROCESS | 1923 | RSS: Main: 318078976 11:39:32 INFO - PROCESS | 1923 | 11:39:34 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:39:34 INFO - PROCESS | 1923 | RSS: Main: 294879232 11:39:34 INFO - PROCESS | 1923 | 11:39:36 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:39:37 INFO - PROCESS | 1923 | RSS: Main: 298631168 11:39:37 INFO - PROCESS | 1923 | 11:39:39 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:39:40 INFO - PROCESS | 1923 | RSS: Main: 300675072 11:39:40 INFO - PROCESS | 1923 | 11:39:43 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:39:43 INFO - PROCESS | 1923 | RSS: Main: 318640128 11:39:43 INFO - PROCESS | 1923 | 11:39:46 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:39:47 INFO - PROCESS | 1923 | RSS: Main: 312045568 11:39:47 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:50465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50465/tests/kraken/driver.html?testName=ai-astar) 11:39:49 INFO - PROCESS | 1923 | RSS: Main: 356814848 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | __start_tp_report 11:39:49 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 11:39:49 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 11:39:49 INFO - PROCESS | 1923 | |i|pagename|runs| 11:39:49 INFO - PROCESS | 1923 | |0;ai-astar;112;113;116;112;114;114;110;113;113;114 11:39:49 INFO - PROCESS | 1923 | |1;audio-beat-detection;144;109;107;141;111;116;139;124;128;111 11:39:49 INFO - PROCESS | 1923 | |2;audio-dft;186;183;183;186;181;183;182;182;185;185 11:39:49 INFO - PROCESS | 1923 | |3;audio-fft;80;57;59;89;61;58;61;60;73;58 11:39:49 INFO - PROCESS | 1923 | |4;audio-oscillator;86;71;87;69;68;69;82;67;68;82 11:39:49 INFO - PROCESS | 1923 | |5;imaging-gaussian-blur;87;84;88;85;87;84;88;83;88;84 11:39:49 INFO - PROCESS | 1923 | |6;imaging-darkroom;93;93;93;94;93;94;93;94;92;93 11:39:49 INFO - PROCESS | 1923 | |7;imaging-desaturate;88;84;83;86;88;85;85;87;86;85 11:39:49 INFO - PROCESS | 1923 | |8;json-parse-financial;55;54;54;53;59;58;58;56;57;57 11:39:49 INFO - PROCESS | 1923 | |9;json-stringify-tinderbox;65;72;74;74;73;70;69;70;71;71 11:39:49 INFO - PROCESS | 1923 | |10;stanford-crypto-aes;91;93;101;99;84;83;87;86;83;88 11:39:49 INFO - PROCESS | 1923 | |11;stanford-crypto-ccm;139;139;139;135;145;146;154;141;177;141 11:39:49 INFO - PROCESS | 1923 | |12;stanford-crypto-pbkdf2;166;167;173;164;160;167;171;220;152;208 11:39:49 INFO - PROCESS | 1923 | |13;stanford-crypto-sha256-iterative;67;66;66;68;66;64;66;70;77;83 11:39:49 INFO - PROCESS | 1923 | __end_tp_report 11:39:49 INFO - PROCESS | 1923 | __start_cc_report 11:39:49 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,2007 11:39:49 INFO - PROCESS | 1923 | __end_cc_report 11:39:49 INFO - PROCESS | 1923 | __startTimestamp1485373189459__endTimestamp 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | ------- Summary: start ------- 11:39:49 INFO - PROCESS | 1923 | Number of tests: 14 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:1.60 (1.4%) stddev-sans-first:1.64 11:39:49 INFO - PROCESS | 1923 | Values: 112.0 113.0 116.0 112.0 114.0 114.0 110.0 113.0 113.0 114.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:126.00 stddev:14.28 (11.3%) stddev-sans-first:12.97 11:39:49 INFO - PROCESS | 1923 | Values: 144.0 109.0 107.0 141.0 111.0 116.0 139.0 124.0 128.0 111.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.78 (1.0%) stddev-sans-first:1.66 11:39:49 INFO - PROCESS | 1923 | Values: 186.0 183.0 183.0 186.0 181.0 183.0 182.0 182.0 185.0 185.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#3] audio-fft Cycles:10 Average:65.60 Median:61.00 stddev:11.14 (18.3%) stddev-sans-first:10.52 11:39:49 INFO - PROCESS | 1923 | Values: 80.0 57.0 59.0 89.0 61.0 58.0 61.0 60.0 73.0 58.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:76.50 stddev:8.25 (10.8%) stddev-sans-first:7.71 11:39:49 INFO - PROCESS | 1923 | Values: 86.0 71.0 87.0 69.0 68.0 69.0 82.0 67.0 68.0 82.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.99 (2.3%) stddev-sans-first:2.06 11:39:49 INFO - PROCESS | 1923 | Values: 87.0 84.0 88.0 85.0 87.0 84.0 88.0 83.0 88.0 84.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:39:49 INFO - PROCESS | 1923 | Values: 93.0 93.0 93.0 94.0 93.0 94.0 93.0 94.0 92.0 93.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.64 (1.9%) stddev-sans-first:1.51 11:39:49 INFO - PROCESS | 1923 | Values: 88.0 84.0 83.0 86.0 88.0 85.0 85.0 87.0 86.0 85.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:2.02 (3.6%) stddev-sans-first:2.11 11:39:49 INFO - PROCESS | 1923 | Values: 55.0 54.0 54.0 53.0 59.0 58.0 58.0 56.0 57.0 57.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:2.69 (3.8%) stddev-sans-first:1.81 11:39:49 INFO - PROCESS | 1923 | Values: 65.0 72.0 74.0 74.0 73.0 70.0 69.0 70.0 71.0 71.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:87.50 stddev:6.43 (7.4%) stddev-sans-first:6.80 11:39:49 INFO - PROCESS | 1923 | Values: 91.0 93.0 101.0 99.0 84.0 83.0 87.0 86.0 83.0 88.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:143.00 stddev:12.21 (8.5%) stddev-sans-first:12.72 11:39:49 INFO - PROCESS | 1923 | Values: 139.0 139.0 139.0 135.0 145.0 146.0 154.0 141.0 177.0 141.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:169.00 stddev:21.65 (12.8%) stddev-sans-first:22.73 11:39:49 INFO - PROCESS | 1923 | Values: 166.0 167.0 173.0 164.0 160.0 167.0 171.0 220.0 152.0 208.0 11:39:49 INFO - PROCESS | 1923 | 11:39:49 INFO - PROCESS | 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:67.50 stddev:6.02 (8.9%) stddev-sans-first:6.33 11:39:49 INFO - PROCESS | 1923 | Values: 67.0 66.0 66.0 68.0 66.0 64.0 66.0 70.0 77.0 83.0 11:39:49 INFO - PROCESS | 1923 | -------- Summary: end -------- 11:39:49 INFO - PROCESS | 1923 | 11:39:50 INFO - TEST-INFO | 1923: exit 0 11:39:50 INFO - TEST-OK | kraken | took 59316ms 11:39:50 INFO - SUITE-END | took 1177s 11:39:50 INFO - Completed test suite (00:19:38) 11:39:50 INFO - javascript benchmark 11:39:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2805.410863718619, 3247.8700851965923, 3266.7386609071277, 3298.719608833249, 3317.452620317647, 5648.802291919784, 5699.6580205187665, 5742.741576629051, 5745.511631511316, 5752.7411266493, 5682.17608446775, 5689.345725241598, 5757.366689664133, 5763.423657634245, 5772.509336706375, 5186.247994040871, 5226.634135610509, 5233.267342572043, 5272.340957380327, 5307.867303317429, 5189.221616757479, 5213.9478605214035, 5215.9828833377505, 5311.920321195185, 5333.359996800389, 5276.868078298035, 5305.602079844008, 5310.495502927235, 5318.414974352818, 5318.73406329682, 5279.102552566053, 5291.232771248147, 5295.682259064469, 5299.417064122943, 5305.3898801637915, 5132.358455193101, 5247.449017853147, 5252.501012403854, 5255.5795536357, 5263.86840328991, 5834.912476312858, 5836.620619659751, 5836.737346819404, 5839.7664093436215, 5840.970795145997, 6168.907466387963, 6189.628622282632, 6209.59637623553, 6210.565260431772, 6222.937770622281, 5263.86840328991, 6267.5299352548745, 6293.968530157365, 6297.779577714758, 6308.179936608258, 5801.158831969341, 5847.502962248214, 5855.09246066856, 5870.236869206976, 6023.728932198062, 5225.477452254782, 6213.875722485525, 6269.059641053878, 6291.811245662638, 6305.243370795534, 6119.908375659848, 6120.8227501369765, 6153.107799369156, 6166.0, 6252.843678908063, 6333.429991300805, 6342.841428964312, 6345.650989195547, 6346.714397852108, 6351.110844481776, 6275.717592708248, 6322.0, 6323.588966717149, 6328.968355158195, 6329.208848893888, 6137.910713126346, 6204.689765511706, 6208.379162083756, 6215.782447614311, 6313.715882785285, 5032.547070763649, 5044.243363495505, 5053.0, 5053.2420136979745, 5069.1635880079375, 4341.8480353188115, 4348.456442944632, 4448.599626033672, 4487.394201782718, 4491.640668746492, 5584.542801167473, 5616.719164041781, 5692.544596432275, 5695.946249943774, 5702.0, 6247.75008999644, 6259.624422534663, 6293.527985401113, 6309.0, 6310.274318453345, 5759.376308495932, 5795.362510123883, 5800.651960882276, 5809.622374545641, 5833.766649334064, 5519.779208831602, 5533.6403133796175, 5534.667919924736, 5535.0, 5543.6396634218645, 6196.721147548281, 6250.343713909974, 6257.5932564383165, 6312.747490100344, 6330.050492426173, 6235.314115447207, 6251.6561589113035, 6283.8114856554375, 6292.685365731787, 6293.590916590407, 5268.367795864521, 6242.531810114168, 6267.905981410191, 6305.243370795534, 6315.526335524946, 6277.623342599459, 6288.622682639057, 6295.527835412271, 6296.464800491826, 6303.212098487689, 6196.0705894116245, 6235.719392627252, 6239.532035097295, 6251.68741562911, 6289.0, 4969.428515720594, 6061.454469097803, 6216.875662486635, 6228.688565571612, 6241.188645476059, 6181.690915454119, 6185.597936134137, 6186.133941248138, 6196.349383314687, 6196.597221180609, 5754.625949313281, 5855.94144058554, 6021.608595441282, 6054.515638748978, 6063.666498342457, 5040.949590504048, 6112.449879510866, 6142.959235178615, 6163.476104531165, 6239.376062393724, 6052.394760523913, 6072.876517844213, 6075.058365953284, 6090.184832686333, 6114.327423983269], "value": 5716.117667481133, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.8131402296099, 466.8179410030091, 469.18830423367575, 531.10243688167, 560.196118569852, 30892.0, 33281.66718332816, 38951.41572876409, 39606.60393396069, 39721.4041789373, 41304.38043429351, 41606.58393416065, 41613.16773664525, 41705.16589668205, 41855.58144418555, 8461.873071903927, 8746.0, 9329.113734195258, 9566.66516671913, 9578.712638620818, 11237.213395062348, 11461.197716159872, 11554.306741595488, 11720.824187637192, 11726.941365293162, 11471.0, 11579.305241685526, 11596.0, 11596.246243994114, 11606.30362178272, 8446.324294056461, 8705.303575713991, 8711.433756805787, 11552.3646199459, 11656.417179141094, 8595.140485951417, 8655.783605409915, 9137.725868223964, 11398.974092331648, 11434.771304573862, 40479.7976010121, 40930.79534602338, 40991.0, 41014.589854101374, 41045.0, 3505.439129739255, 4024.6981476389387, 4093.5906409359122, 4098.077932465201, 4107.938380924288, 29571.70428295711, 30749.538756918664, 31056.844715776275, 31183.84408077945, 31373.52939705906, 3210.4542227821094, 3251.7723759336855, 3263.3473305339026, 3276.639569647337, 3280.7703460757757, 379741.0, 447150.99999999674, 447626.0, 448477.99999999674, 448703.0, 59920.10119848206, 60159.09761353583, 60302.69848650729, 60303.49241269004, 60366.39633603695, 64383.678081609294, 64457.67771161114, 64491.67754161199, 64497.67751161214, 64561.677191613744, 16266.268017939221, 16754.664906701797, 16809.747853782203, 16829.990200588003, 16893.408730694366, 11405.771884562262, 11724.765504689858, 12597.874021259853, 12814.35928203586, 12870.871291287154, 16754.4135955241, 16756.413525526546, 16784.992900426012, 16806.0, 17028.978261304113, 7209.927900720925, 7223.386012188917, 7245.7826265212125, 7288.0, 7293.9635301823155, 863.6440787962838, 880.9427387219811, 900.144862380741, 914.5610107148606, 924.2190349154953, 28954.27614309659, 29754.702452975194, 29970.0, 30332.241693957385, 30422.239444014078, 1072.2172813845937, 1084.4469320646526, 1091.2415870969758, 1102.80149573076, 1202.9941186954245, 14780.334884930204, 15328.386864525517, 15391.84608153904, 15699.21503924822, 15713.764293535605, 593516.0, 698041.0, 705985.0, 706489.0, 898241.0, 52988.470115298354, 53429.0, 53620.73189634027, 53636.46363536393, 53697.46302537003, 1416.872481476672, 1437.324457504971, 1463.0490181381974, 1463.2098666720278, 1468.3172324868988, 28030.85984570064, 28067.017654382817, 28770.74431084203, 28934.276643084093, 29097.418051639273, 45711.77144114391, 46164.0, 46248.30627540657, 46287.6113716589, 46582.0, 543774.0, 544734.0, 545393.0, 546779.0, 547040.0, 21581.676274855574, 22274.220402285842, 24156.0, 24223.273301800975, 24614.261572152864, 39732.60267397289, 40705.77882663525, 40876.0, 41648.3752743703, 41846.790766045975, 34326.48510272398, 34843.0, 34858.302833943686, 34884.9534513965, 35402.82298588491, 34574.13564660904, 34604.480932785526, 35245.82377088098, 35551.0, 35627.75302864387, 33740.66259337375, 33806.830965846, 34409.0, 34432.82783586066, 34502.0, 29424.11727648174, 30934.53598196074, 30954.380912382076, 31081.533776993816, 31223.0, 23355.948982295497, 23522.411939701644, 23602.0, 23714.407139820953, 23753.64369534424], "value": 19594.732798635498, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.59234841674146, 393.10176247274984, 400.3514306822946, 413.2561389498902, 427.2160585325927, 14320.57038288853, 19879.900600496996, 20967.0, 21116.472088197785, 21129.260475883348, 17260.568485787862, 21211.257605983792, 22506.21228257011, 22541.661875071888, 22858.0, 6490.805275841721, 6783.152105986752, 6870.656467176646, 6928.515003949726, 6936.722531098775, 5759.222504961839, 6614.338566143371, 6764.188297404294, 6827.829304267409, 6908.516403851732, 6809.693563789617, 6830.590164590116, 6836.7607133750325, 6837.589744615339, 6844.178698556156, 6603.900941485882, 6845.110135682355, 6924.930750692479, 6932.445404367639, 6939.375456208915, 6555.44278736308, 6718.093057437232, 6785.6267905265195, 6799.354061364163, 6812.795616131474, 28950.855245723847, 29471.410571788445, 29727.40545189084, 29827.956021539358, 30196.849015754782, 2922.663893652236, 3098.798578092439, 3238.8380580971093, 3472.44440889459, 3496.615372309044, 16097.919510402373, 17020.319187232497, 17042.403515876886, 17148.828511714848, 17263.791534592583, 2007.6185524750397, 2013.4563667809755, 2034.6642803937332, 2064.9483762905897, 2182.25803226902, 133602.99999999904, 165473.17263413727, 166050.16974915168, 167179.0, 168131.31868681402, 19336.129874155697, 22898.771012289995, 23589.528209435714, 24185.637215441784, 24972.0, 26841.328966775985, 35748.642513575054, 40815.77552673424, 41012.97467563335, 41095.7945210272, 11076.556937722562, 11165.94417027926, 11380.260283081574, 11642.24325418845, 11736.530538778354, 9213.696575856036, 9223.815523689489, 9225.677101301422, 9240.676576319796, 9378.390404623678, 9929.056739609725, 11139.001416606734, 11413.942930285462, 11518.654440366803, 11610.477528511237, 4164.437800896901, 4230.398305042439, 4241.130568233505, 4248.85129020489, 4265.829366825355, 848.821747433046, 895.4492986813063, 897.2186222709548, 899.3839220134098, 923.6859467780987, 18130.766941164642, 21202.0, 21891.67162492564, 21963.768946091917, 22089.33731988043, 908.8682141089505, 925.1072714830086, 933.9486328252011, 939.5677988125402, 940.6660635474445, 10904.50929708165, 11381.317120972768, 11429.199956003165, 11457.312561246352, 11457.88542114585, 757737.0, 760281.0, 762610.0, 767240.0, 782039.0, 151728.0, 151847.24076379547, 156958.0, 158395.20802395913, 165704.5144322836, 1010.1968934696934, 1016.4765145949842, 1023.3552861697083, 1045.8222102242637, 1046.0324200114862, 18953.810461895206, 19205.32781352646, 19397.61204775925, 19438.708419374005, 19439.70840437423, 53751.92496150133, 56230.0, 57382.426175739376, 58332.12501812561, 59485.40514594799, 74197.0, 79208.60395698216, 83202.0, 85562.0, 87670.56164719391, 5984.0, 8141.267285944294, 8213.83572328562, 8295.751127465945, 8553.401261911606, 9148.405353651991, 11994.340311282964, 12553.372331383212, 12693.555725549932, 12741.98064154884, 9263.212626926786, 10839.319905414673, 11077.169212308949, 11267.746450710054, 11391.259568128045, 7854.293113619573, 11003.779924401628, 11041.447927603427, 11124.830717756815, 11578.768424631291, 9459.810803784023, 11389.202755807013, 11489.253198542068, 11596.188266821242, 11649.19437487157, 8144.185581441809, 8373.748787536384, 8465.66137354499, 8553.74338769838, 8609.526476043628, 8746.868796968178, 10951.959563841741, 11007.779844403227, 11092.33445993243, 11383.715407114889], "value": 11431.879717161044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.2493878244534, 1449.2391494465405, 1452.034397125911, 1472.3374481483331, 1473.4548217159645, 8086.51480911145, 8528.872066919, 8532.957335213316, 8550.657973681053, 8562.357823163256, 7438.070241219848, 7667.769966900988, 7678.0, 8029.5182289062695, 8332.791680207998, 2294.3346429535454, 2350.4006478347997, 2350.74141844397, 2354.3407845803117, 2354.6468029795583, 2352.0591763294733, 2376.287113865842, 2380.880955952204, 2386.642003699442, 2389.2712722619594, 2303.3320337102305, 2310.90756369745, 2332.801711854486, 2332.88335583221, 2333.393317737392, 1994.3518356534184, 2276.635738281875, 2300.769088537641, 2305.7809508096702, 2307.1002309099463, 2257.898394572248, 2337.590921588715, 2342.063174730122, 2342.636891281854, 2345.4957184205477, 8367.163283671645, 8398.0, 8426.915730842675, 8443.015891265548, 8459.703910363169, 5057.595392368602, 5090.694558326475, 5091.949080509185, 5161.974190129063, 5198.610104242159, 3264.4613638749815, 3358.0, 3481.0601137692934, 3526.400511912981, 3541.592716837571, 1201.9338936358497, 1210.4431961297814, 1227.4476485581524, 1240.9193402428814, 1259.6598918292102, 9738.123568878764, 10690.946545267301, 10772.353658780497, 10895.346279223271, 10913.83629245562, 4424.867253982386, 4624.95375046252, 4704.294355846582, 4707.7881495332795, 4708.529147085333, 9531.857022144673, 9537.189338906272, 9554.952225238969, 9561.091696288842, 9585.808283834283, 5226.738663066832, 5230.790768369223, 5233.110371236899, 5235.031519168966, 5242.13504771716, 4184.3932629768515, 4518.43519560055, 4642.257238841769, 4733.95266047342, 4742.620590352763, 3824.7513911595656, 3860.2279544091293, 3908.8241029153187, 3939.8227079781477, 3941.192055628589, 1267.4613289352174, 1272.6500212441467, 1278.7058976435471, 1286.633309506786, 1297.4874924404996, 905.6649039855164, 915.2129168914728, 933.7665583604099, 941.2940294778916, 976.72651657536, 5575.69333686643, 5606.990741666539, 5846.011620451593, 5867.325257595346, 5901.144334071536, 507.76388979124886, 570.4751628501788, 576.3199424678919, 585.493548080907, 588.9970550147222, 3840.0, 3852.075501879585, 3905.6875449963936, 3913.2369188008065, 3941.881743547698, 7847.882281765778, 9885.950570247103, 9888.555015024342, 10039.196864250842, 10041.849372259421, 9990.300678952404, 10003.849942250872, 10007.49962501872, 10024.54889529973, 10026.849597256047, 7752.418568607377, 7811.375089992787, 7926.207379262143, 7951.932497550679, 7960.761177164694, 5536.91694624589, 5779.450952159538, 5796.82609521715, 6006.81979540597, 6011.278646562266, 9274.6290148396, 9348.20540254086, 9355.719328420158, 9387.15515603599, 9421.62313507452, 9095.545222738969, 9578.521073946136, 9603.991580883907, 9607.90392096098, 9624.181944534794, 6605.966970165118, 6832.350926661959, 6848.383645471732, 7220.89168662481, 7373.188949215475, 7502.437317201123, 7691.5769632670745, 7981.161977992228, 8091.635876385694, 8107.594620268845, 7045.084139062094, 7158.606276654834, 7257.0, 7304.561726296439, 7394.149672787698, 6903.689333980084, 7036.753713619999, 7078.646067696697, 7174.354308112295, 7180.497365184387, 6434.549581529248, 6446.613203207822, 6510.544261901811, 6520.673966301761, 6635.767748128792, 5022.221555658879, 5053.797848086036, 5092.261622064706, 5104.489551045014, 5105.285260063668, 5016.673916195582, 5030.446650868328, 5158.845234642967, 5206.0, 5213.322268105122], "value": 4399.131790406261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.35675783589534, 366.790929170373, 367.3259568691451, 382.1306527649595, 382.9578746337904, 4485.102979404116, 5075.314832497612, 5102.591792656593, 5293.300416787437, 5327.094393953028, 4091.4067460218253, 4356.89107772305, 5025.698458092517, 5068.46781087986, 5322.9620224056325, 3563.8574457021687, 3819.1667999360325, 4116.382542618601, 4180.728252663567, 4236.512801027875, 4131.52487463941, 4149.605787450188, 4172.311568591179, 4229.957700423002, 4230.640395566381, 3177.8252196129206, 3416.7949923004576, 3778.622137786213, 4031.8912299117833, 4178.749275043507, 3373.797572145667, 3381.9323613527836, 3965.6430921217084, 3982.3429134192825, 4042.43405923171, 2835.7306055924655, 3458.187325978393, 3460.602030766444, 3466.324066806974, 3501.8949431517094, 4568.223402021665, 5114.130597798383, 5114.872128196787, 5134.229865520165, 5244.81643142492, 4128.855490057834, 4306.578828986427, 4530.660200484944, 4616.746078965655, 4661.417322834645, 4698.919248572847, 5025.969676216367, 5220.712860792655, 5320.707361095138, 5352.57179425645, 3744.7378683492166, 3817.8091095445116, 3865.9226815463535, 3878.1274213302063, 3913.4521167036637, 4692.507286734912, 5139.922901156486, 5274.602230408945, 5301.686445971268, 5744.310682718101, 3304.8512816923294, 3518.225990282185, 3771.151490914522, 3879.1078052048188, 3880.262750077476, 3935.2916475034194, 3968.3253846846105, 3974.8608798692485, 3977.7812220327583, 3997.32045552251, 4014.558398576154, 4429.335599660012, 4596.862094137115, 4618.237990731559, 4620.283856002325, 4751.907061375903, 4981.975090124599, 5576.6096373254295, 5624.803131890364, 5657.727011422479, 1095.2257343104063, 1137.7155711072232, 1219.7255617485994, 1268.5560053981033, 1282.6985658370274, 801.6753214947955, 830.6096134816627, 831.8086840026828, 852.4459101584021, 868.2533021601417, 4144.191882582867, 4216.662666986634, 4434.645228381722, 5001.424836143818, 5014.868680810641, 4916.6321070067115, 5109.310243117206, 5123.590112790967, 5166.715830629276, 5478.45215478449, 4217.36739489073, 4328.5022222444195, 4813.855584332476, 4940.728259945666, 4986.90026199474, 2590.2229331200565, 2786.9163925081875, 2841.346490307241, 2859.270885924076, 2878.3811480531785, 4726.243800991893, 4993.850184494471, 5238.869028274247, 5412.78348866041, 5560.582956278296, 4470.865874023784, 5090.93090451002, 5222.213894926148, 5515.7242137892945, 5694.743736531866, 4857.951420485821, 5080.034793389244, 5218.7475005998285, 5333.973330133324, 5447.782088716565, 4793.004372267333, 5343.759530821045, 5367.919481207863, 5369.54358879484, 5370.9731451342495, 5184.533391994739, 5622.465865742748, 5653.717314134359, 5677.687727175045, 5753.71231438418, 5025.346704928336, 5904.645721256738, 5924.6149000314845, 5958.914379966977, 5958.940410595838, 2934.662513810854, 3402.098443912316, 3764.284785890672, 3868.2843673920415, 3918.9804050979565, 5387.299651045339, 5728.625129968861, 5862.794802182074, 5863.384344643751, 5888.499477544457, 5182.989317083133, 5323.243329701267, 5358.062339090566, 5609.298837645294, 5675.829725108253, 4890.608751299958, 5063.518965698253, 5100.744962751922, 5544.0, 5624.74688639004, 4683.0, 5312.910853275147, 5486.753096110764, 5497.378273409274, 5526.651173251272, 4812.35033270504, 4874.074740477562, 5345.65253258537, 5369.919451208157, 5571.832845014656, 4346.521882592975, 5407.593216273723, 5497.285352904097, 5497.752601132878, 5499.285092937893], "value": 3964.0865571394015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.7363801755332, 721.0770214125918, 773.4817672159652, 831.6631764135525, 842.5660784695883, 14988.400463981428, 15357.462488812895, 15775.368985240577, 15807.0, 15851.890367674254, 12853.67865803353, 12884.16252943558, 12912.289824059673, 15694.37222511101, 16595.66808663826, 855.4439614250724, 883.0286684646869, 885.437747030637, 886.685226744506, 887.3256325192867, 874.1389731114847, 874.7550685807984, 875.374107513128, 876.1457578860624, 883.5405589093667, 883.6156272021659, 927.0636656976469, 927.3925578745932, 929.7675581104724, 933.2207606648457, 908.577511457169, 923.5520772425368, 925.6575067225136, 926.3098991251493, 928.9396189247711, 690.3338278561213, 691.1360799001249, 692.9792106236821, 693.1335830212234, 694.3403766421869, 15545.0, 16063.759043614238, 16276.430324938688, 16278.51164465068, 16289.266982985793, 12095.0, 12150.392480375946, 12152.21010634306, 12251.57119500822, 12416.787695235971, 11318.434078296135, 11711.590094346657, 11789.0, 11848.703782405422, 11866.466009029615, 3622.6920711739535, 3723.7765734056043, 3731.067233191702, 3739.476473293741, 3765.002274397287, 58283.41716582865, 77752.61123694346, 93870.06129938681, 99951.50024249905, 108230.0, 11078.0583650389, 11103.83344249837, 11137.109031277478, 11329.43352832355, 11347.489362978686, 22101.778982210293, 22316.44208894758, 22355.10579576831, 22496.21263255778, 22633.660495092587, 7628.80927976805, 7963.562004089831, 8055.718049868226, 8080.353571714249, 8255.711050113217, 4289.978550107229, 4373.890652733707, 4411.698548928074, 4424.756638384855, 4525.524819893863, 3587.587427445877, 3693.076730817296, 3702.204026134394, 3711.5917249102577, 3824.3116239077235, 713.1727196452194, 720.6288761287941, 721.5418209437046, 734.9118105827334, 746.6192241956642, 616.7286393986722, 617.9227596550431, 626.2891618013497, 637.3594537489793, 663.810813918031, 9541.284403669753, 9768.51157442125, 9967.55146018431, 10246.231532635082, 10432.68701938928, 581.2995340614549, 633.5238893378418, 653.7058323754329, 658.7101675262869, 673.6665350651459, 4184.644305234028, 4718.740469274223, 4885.682430641997, 4947.678400903929, 4958.157113290749, 74912.50174996578, 99846.50230246552, 100576.98846023185, 101942.49028754809, 106820.46589767002, 69855.65072174606, 71215.0, 72109.0, 72332.27667723256, 82206.17793822105, 68915.3108468919, 70875.2912470879, 71270.28729712637, 72817.0, 74684.87972680414, 10003.099721025143, 10277.0, 10445.477726113511, 10480.056794888496, 10496.580136794442, 36674.633253667125, 43087.56912430836, 44149.55850441455, 45013.32480012868, 49032.019359613325, 54751.72624136854, 59921.70039149776, 66261.01216963498, 67204.6639766798, 71488.0, 12057.81913271284, 12143.75712485763, 12221.511139554319, 12245.387730613256, 12777.87222127804, 13230.0, 13519.256440895451, 13962.650933726332, 14096.08375455592, 14388.0, 12837.550685725955, 12920.935395322964, 13062.216267024009, 13089.280089595164, 13342.266175360448, 13022.47910083586, 13036.217826930415, 13275.004374671746, 13333.066685331934, 13365.933170334087, 12501.0, 12811.103222774316, 12842.486300548248, 12975.221486710827, 13442.193468391928, 10650.8402373966, 10675.946620266848, 10943.179261555257, 11087.667369978913, 11301.378424186749, 10158.928633451946, 10365.222608304257, 10435.217358697977, 10440.425776582057, 10478.685639430829], "value": 7368.7771449745205, "unit": "score"}], "name": "dromaeo_css", "value": 7402.626439923292, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 116.0, 112.0, 114.0, 114.0, 110.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 107.0, 141.0, 111.0, 116.0, 139.0, 124.0, 128.0, 111.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 183.0, 186.0, 181.0, 183.0, 182.0, 182.0, 185.0, 185.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 89.0, 61.0, 58.0, 61.0, 60.0, 73.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 87.0, 69.0, 68.0, 69.0, 82.0, 67.0, 68.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 85.0, 87.0, 84.0, 88.0, 83.0, 88.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 94.0, 92.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 83.0, 86.0, 88.0, 85.0, 85.0, 87.0, 86.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 59.0, 58.0, 58.0, 56.0, 57.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 74.0, 74.0, 73.0, 70.0, 69.0, 70.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 101.0, 99.0, 84.0, 83.0, 87.0, 86.0, 83.0, 88.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 139.0, 135.0, 145.0, 146.0, 154.0, 141.0, 177.0, 141.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 173.0, 164.0, 160.0, 167.0, 171.0, 220.0, 152.0, 208.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 68.0, 66.0, 64.0, 66.0, 70.0, 77.0, 83.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1431.1, "alertThreshold": 2.0}]} 11:39:50 INFO - Return code: 0 11:39:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:39:50 ERROR - # TBPL SUCCESS # 11:39:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:39:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:39:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:39:50 INFO - 2017-01-25 11:39:50.746 screenresolution[1927:14013] starting screenresolution argv=screenresolution get 11:39:50 INFO - 2017-01-25 11:39:50.749 screenresolution[1927:14013] Display 0: 1600x1200x32@60 11:39:50 INFO - 2017-01-25 11:39:50.756 screenresolution[1928:14017] starting screenresolution argv=screenresolution list 11:39:50 INFO - Available Modes on Display 0 11:39:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:39:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:39:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:39:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:39:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:39:50 INFO - Intel Iris: 11:39:50 INFO - Chipset Model: Intel Iris 11:39:50 INFO - Type: GPU 11:39:50 INFO - Bus: Built-In 11:39:50 INFO - VRAM (Dynamic, Max): 1536 MB 11:39:50 INFO - Vendor: Intel (0x8086) 11:39:50 INFO - Device ID: 0x0a2e 11:39:50 INFO - Revision ID: 0x0009 11:39:50 INFO - Displays: 11:39:50 INFO - Display: 11:39:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:39:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:39:50 INFO - Display Serial Number: 1600x1200 60 11:39:50 INFO - Main Display: Yes 11:39:50 INFO - Mirror: Off 11:39:50 INFO - Online: Yes 11:39:50 INFO - Rotation: Supported 11:39:50 INFO - Return code: 0 11:39:50 INFO - Running post-action listener: _resource_record_post_action 11:39:50 INFO - [mozharness: 2017-01-25 19:39:50.995126Z] Finished run-tests step (success) 11:39:50 INFO - Running post-run listener: _resource_record_post_run 11:39:51 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 1581056; Write bytes: 505661440; Read time: 14; Write time: 1596 11:39:51 INFO - TinderboxPrint: CPU usage
53.4% 11:39:51 INFO - TinderboxPrint: I/O read bytes / time
1,581,056 / 14 11:39:51 INFO - TinderboxPrint: I/O write bytes / time
505,661,440 / 1,596 11:39:51 INFO - TinderboxPrint: CPU idle
2,231.4 (46.6%) 11:39:51 INFO - TinderboxPrint: CPU system
954.7 (19.9%) 11:39:51 INFO - TinderboxPrint: CPU user
1,607.5 (33.5%) 11:39:51 INFO - TinderboxPrint: Swap in / out
209,350,656 / 0 11:39:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205031936; Write bytes: 198639616; Read time: 15679; Write time: 427 11:39:51 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 577536; Write bytes: 294711808; Read time: 10; Write time: 1121 11:39:51 INFO - Running post-run listener: _upload_blobber_files 11:39:51 INFO - Blob upload gear active. 11:39:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:39:51 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 11:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:39:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:53 INFO - (blobuploader) - INFO - Done attempting. 11:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:53 INFO - (blobuploader) - INFO - Done attempting. 11:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:54 INFO - (blobuploader) - INFO - Done attempting. 11:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:57 INFO - (blobuploader) - INFO - Done attempting. 11:39:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:57 INFO - Return code: 0 11:39:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f10e44d061ff1cf66f98d15936782bd0bc914c1689f237942e2155a4d1adfb464ea9d35811b3c1860a55a5395798afbc6ff183cd4f904d42c84244ae963f9d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f8dc87317104d0335caebaff97c40d02e21c98cd8f97a58419f4f7bf2f6f189dc973a990db2dc294ef8fe61a99d2eea65019804d316c3544ba0d075b75de7a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea770f73af9d8a584aeaa8b49aeb437c5320f8c11fc6c919ea5fba1ae7bfb70ebd52c3f6479c914e9f7c91464ff1cbf3415338c8e2f8c96aff139b94c234ffe6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85458be2f52fe962087d6cc49fd1e31ae5315d9ae820e673434ed78ece0b6a2e52444e0e8079b18aabe2f0297da8005ad2694ef1ba3ff10bef1873d44f743101"} 11:39:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:57 INFO - Contents: 11:39:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f10e44d061ff1cf66f98d15936782bd0bc914c1689f237942e2155a4d1adfb464ea9d35811b3c1860a55a5395798afbc6ff183cd4f904d42c84244ae963f9d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f8dc87317104d0335caebaff97c40d02e21c98cd8f97a58419f4f7bf2f6f189dc973a990db2dc294ef8fe61a99d2eea65019804d316c3544ba0d075b75de7a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea770f73af9d8a584aeaa8b49aeb437c5320f8c11fc6c919ea5fba1ae7bfb70ebd52c3f6479c914e9f7c91464ff1cbf3415338c8e2f8c96aff139b94c234ffe6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85458be2f52fe962087d6cc49fd1e31ae5315d9ae820e673434ed78ece0b6a2e52444e0e8079b18aabe2f0297da8005ad2694ef1ba3ff10bef1873d44f743101"} 11:39:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:57 INFO - Copying logs to upload dir... 11:39:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.195030 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-25 11:39:57.380299) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 11:39:57.385250) ========= 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.oXyGM0zRvj/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.88iAMgWSVx/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f10e44d061ff1cf66f98d15936782bd0bc914c1689f237942e2155a4d1adfb464ea9d35811b3c1860a55a5395798afbc6ff183cd4f904d42c84244ae963f9d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f8dc87317104d0335caebaff97c40d02e21c98cd8f97a58419f4f7bf2f6f189dc973a990db2dc294ef8fe61a99d2eea65019804d316c3544ba0d075b75de7a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea770f73af9d8a584aeaa8b49aeb437c5320f8c11fc6c919ea5fba1ae7bfb70ebd52c3f6479c914e9f7c91464ff1cbf3415338c8e2f8c96aff139b94c234ffe6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85458be2f52fe962087d6cc49fd1e31ae5315d9ae820e673434ed78ece0b6a2e52444e0e8079b18aabe2f0297da8005ad2694ef1ba3ff10bef1873d44f743101"} build_url:https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f10e44d061ff1cf66f98d15936782bd0bc914c1689f237942e2155a4d1adfb464ea9d35811b3c1860a55a5395798afbc6ff183cd4f904d42c84244ae963f9d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f8dc87317104d0335caebaff97c40d02e21c98cd8f97a58419f4f7bf2f6f189dc973a990db2dc294ef8fe61a99d2eea65019804d316c3544ba0d075b75de7a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea770f73af9d8a584aeaa8b49aeb437c5320f8c11fc6c919ea5fba1ae7bfb70ebd52c3f6479c914e9f7c91464ff1cbf3415338c8e2f8c96aff139b94c234ffe6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85458be2f52fe962087d6cc49fd1e31ae5315d9ae820e673434ed78ece0b6a2e52444e0e8079b18aabe2f0297da8005ad2694ef1ba3ff10bef1873d44f743101"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 11:39:57.420078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:39:57.420414) ========= 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.oXyGM0zRvj/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.88iAMgWSVx/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:39:57.468417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 11:39:57.468730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 11:39:57.469088) ========= ========= Total master_lag: 0.18 =========