builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0203 starttime: 1487261295.58 results: success (0) buildid: 20170216065318 builduid: f64370de4c934e598315b00e0881f425 revision: 8103314b2cd43d908f44d600315fc0127b7c1e79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.579832) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.580316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.580603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.605685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.606070) ========= 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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-02-16 08:08:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.41M=0.002s 2017-02-16 08:08:15 (7.41 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.749035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.749403) ========= 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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.019900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.798037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:15.798506) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8103314b2cd43d908f44d600315fc0127b7c1e79 --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 8103314b2cd43d908f44d600315fc0127b7c1e79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.K2qZcLQwwu/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.0R7yTQWzkB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-02-16 08:08:15,888 truncating revision to first 12 chars 2017-02-16 08:08:15,888 Setting DEBUG logging. 2017-02-16 08:08:15,888 attempt 1/10 2017-02-16 08:08:15,888 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8103314b2cd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 08:08:16,530 unpacking tar archive at: mozilla-aurora-8103314b2cd4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.896297 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:16.719905) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:16.720468) ========= script_repo_revision: 8103314b2cd43d908f44d600315fc0127b7c1e79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:16.721121) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:16.721550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 08:08:16.742686) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-16 08:08:16.743085) ========= /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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:16 INFO - MultiFileLogger online at 20170216 08:08:16 in /builds/slave/test 08:08:16 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 08:08:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:16 INFO - {'append_to_log': False, 08:08:16 INFO - 'base_work_dir': '/builds/slave/test', 08:08:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:08:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:16 INFO - 'branch': 'Mozilla-Aurora', 08:08:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:16 INFO - 'config_files': ('talos/mac_config.py',), 08:08:16 INFO - 'default_actions': ('clobber', 08:08:16 INFO - 'read-buildbot-config', 08:08:16 INFO - 'download-and-extract', 08:08:16 INFO - 'populate-webroot', 08:08:16 INFO - 'create-virtualenv', 08:08:16 INFO - 'install', 08:08:16 INFO - 'run-tests'), 08:08:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:16 INFO - 'download_minidump_stackwalk': True, 08:08:16 INFO - 'download_symbols': 'ondemand', 08:08:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:16 INFO - 'installer_path': 'installer.exe', 08:08:16 INFO - 'log_level': 'info', 08:08:16 INFO - 'log_name': 'talos', 08:08:16 INFO - 'log_to_console': True, 08:08:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:08:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:08:16 INFO - 'opt_config_files': (), 08:08:16 INFO - 'pip_index': False, 08:08:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:16 INFO - 'cmd': ('bash', 08:08:16 INFO - '-c', 08:08:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:16 INFO - 'enabled': True, 08:08:16 INFO - 'halt_on_failure': False, 08:08:16 INFO - 'name': 'check_screen_resolution'},), 08:08:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:16 INFO - 'cmd': ('bash', 08:08:16 INFO - '-c', 08:08:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:16 INFO - 'enabled': True, 08:08:16 INFO - 'halt_on_failure': False, 08:08:16 INFO - 'name': 'check_screen_resolution'},), 08:08:16 INFO - 'run_cmd_checks_enabled': True, 08:08:16 INFO - 'sps_profile': False, 08:08:16 INFO - 'sps_profile_interval': 0, 08:08:16 INFO - 'suite': 'dromaeojs', 08:08:16 INFO - 'system_bits': '32', 08:08:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:16 INFO - 'title': 't-yosemite-r7-0203', 08:08:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:16 INFO - 'use_talos_json': True, 08:08:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:16 INFO - 'work_dir': 'build'} 08:08:16 INFO - [mozharness: 2017-02-16 16:08:16.953685Z] Running clobber step. 08:08:16 INFO - Running pre-action listener: _resource_record_pre_action 08:08:16 INFO - Running main action method: clobber 08:08:16 INFO - rmtree: /builds/slave/test/build 08:08:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:17 INFO - Running post-action listener: _resource_record_post_action 08:08:17 INFO - [mozharness: 2017-02-16 16:08:17.283741Z] Finished clobber step (success) 08:08:17 INFO - [mozharness: 2017-02-16 16:08:17.283869Z] Running read-buildbot-config step. 08:08:17 INFO - Running pre-action listener: _resource_record_pre_action 08:08:17 INFO - Running main action method: read_buildbot_config 08:08:17 INFO - Using buildbot properties: 08:08:17 INFO - { 08:08:17 INFO - "project": "", 08:08:17 INFO - "product": "firefox", 08:08:17 INFO - "script_repo_revision": "production", 08:08:17 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:08:17 INFO - "repository": "", 08:08:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:08:17 INFO - "buildid": "20170216065318", 08:08:17 INFO - "pgo_build": "False", 08:08:17 INFO - "basedir": "/builds/slave/test", 08:08:17 INFO - "buildnumber": 3, 08:08:17 INFO - "slavename": "t-yosemite-r7-0203", 08:08:17 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:08:17 INFO - "platform": "yosemite_r7", 08:08:17 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:08:17 INFO - "branch": "mozilla-aurora", 08:08:17 INFO - "repo_path": "releases/mozilla-aurora", 08:08:17 INFO - "revision": "8103314b2cd43d908f44d600315fc0127b7c1e79", 08:08:17 INFO - "stage_platform": "macosx64", 08:08:17 INFO - "builduid": "f64370de4c934e598315b00e0881f425", 08:08:17 INFO - "slavebuilddir": "test" 08:08:17 INFO - } 08:08:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:08:17 INFO - Running post-action listener: _resource_record_post_action 08:08:17 INFO - [mozharness: 2017-02-16 16:08:17.287070Z] Finished read-buildbot-config step (success) 08:08:17 INFO - [mozharness: 2017-02-16 16:08:17.287203Z] Running download-and-extract step. 08:08:17 INFO - Running pre-action listener: _resource_record_pre_action 08:08:17 INFO - Running main action method: download_and_extract 08:08:17 INFO - mkdir: /builds/slave/test/build/tests 08:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:17 INFO - trying https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:08:17 INFO - Downloading https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/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 08:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/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 08:08:17 INFO - Downloaded 1199 bytes. 08:08:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:08:17 INFO - Using the following test package requirements: 08:08:17 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:08:17 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:08:17 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:08:17 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'jsshell-mac.zip'], 08:08:17 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:08:17 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:08:17 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:08:17 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:08:17 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:08:17 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:08:17 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:08:17 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:08:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:08:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:08:17 INFO - Fetch https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:08:18 INFO - Expected file size: 16358150 08:08:18 INFO - Obtained file size: 16358150 08:08:25 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 08:08:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:08:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:08:25 INFO - Fetch https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:08:26 INFO - Expected file size: 16358150 08:08:26 INFO - Obtained file size: 16358150 08:08:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:08:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:08:32 INFO - Fetch https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:08:33 INFO - Expected file size: 14403485 08:08:33 INFO - Obtained file size: 14403485 08:08: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')]} 08:08:34 INFO - trying https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:08:34 INFO - Downloading https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/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 08:08:36 INFO - Downloaded 73943098 bytes. 08:08:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:08:36 INFO - mkdir: /builds/slave/test/properties 08:08:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:08:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:08:36 INFO - Contents: 08:08:36 INFO - build_url:https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:08:36 INFO - Running post-action listener: _resource_record_post_action 08:08:36 INFO - Running post-action listener: set_extra_try_arguments 08:08:36 INFO - [mozharness: 2017-02-16 16:08:36.826532Z] Finished download-and-extract step (success) 08:08:36 INFO - [mozharness: 2017-02-16 16:08:36.826673Z] Running populate-webroot step. 08:08:36 INFO - Running pre-action listener: _resource_record_pre_action 08:08:36 INFO - Running main action method: populate_webroot 08:08:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:36 INFO - '--tppagecycles', 08:08:36 INFO - '7'], 08:08:36 INFO - 'tests': ['tsvgm']}}, 08:08:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:08:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:08:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:08:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:08:36 INFO - 'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:08:36 INFO - 'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['damp', 'tps']}, 08:08:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:08:36 INFO - 'tests': ['damp', 'tps']}, 08:08:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['dromaeo_dom']}, 08:08:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['basic_compositor_video']}, 08:08:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:08:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['a11yr', 08:08:36 INFO - 'ts_paint', 08:08:36 INFO - 'tpaint', 08:08:36 INFO - 'sessionrestore', 08:08:36 INFO - 'sessionrestore_no_auto_restore', 08:08:36 INFO - 'tabpaint']}, 08:08:36 INFO - 'other-e10s': {'tests': ['a11yr', 08:08:36 INFO - 'ts_paint', 08:08:36 INFO - 'tpaint', 08:08:36 INFO - 'sessionrestore', 08:08:36 INFO - 'sessionrestore_no_auto_restore', 08:08:36 INFO - 'tabpaint']}, 08:08:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:08:36 INFO - 'ts_paint', 08:08:36 INFO - 'tpaint', 08:08:36 INFO - 'sessionrestore', 08:08:36 INFO - 'sessionrestore_no_auto_restore', 08:08:36 INFO - 'tabpaint']}, 08:08:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:08:36 INFO - 'ts_paint', 08:08:36 INFO - 'tpaint', 08:08:36 INFO - 'sessionrestore', 08:08:36 INFO - 'sessionrestore_no_auto_restore', 08:08:36 INFO - 'tabpaint']}, 08:08:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['a11yr', 08:08:36 INFO - 'ts_paint', 08:08:36 INFO - 'tpaint', 08:08:36 INFO - 'sessionrestore', 08:08:36 INFO - 'sessionrestore_no_auto_restore', 08:08:36 INFO - 'tabpaint']}, 08:08:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['a11yr', 08:08:36 INFO - 'ts_paint', 08:08:36 INFO - 'tpaint', 08:08:36 INFO - 'sessionrestore', 08:08:36 INFO - 'sessionrestore_no_auto_restore', 08:08:36 INFO - 'tabpaint']}, 08:08:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['tsvgx', 08:08:36 INFO - 'tsvgr_opacity', 08:08:36 INFO - 'tart', 08:08:36 INFO - 'tscrollx', 08:08:36 INFO - 'cart', 08:08:36 INFO - 'tsvg_static']}, 08:08:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:08:36 INFO - 'tsvgr_opacity', 08:08:36 INFO - 'tart', 08:08:36 INFO - 'tscrollx', 08:08:36 INFO - 'cart', 08:08:36 INFO - 'tsvg_static']}, 08:08:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:08:36 INFO - 'talos_options': ['--disable-e10s'], 08:08:36 INFO - 'tests': ['tp5o']}, 08:08:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:08:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:08:36 INFO - 'talos_options': ['--disable-e10s', 08:08:36 INFO - '--xperf_path', 08:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:36 INFO - 'tests': ['tp5n']}, 08:08:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:08:36 INFO - 'talos_options': ['--xperf_path', 08:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:36 INFO - 'tests': ['tp5n']}}, 08:08:36 INFO - 'talos.zip': {'path': '', 08:08:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:36 INFO - Running post-action listener: _resource_record_post_action 08:08:36 INFO - [mozharness: 2017-02-16 16:08:36.844813Z] Finished populate-webroot step (success) 08:08:36 INFO - [mozharness: 2017-02-16 16:08:36.844942Z] Running create-virtualenv step. 08:08:36 INFO - Running pre-action listener: _resource_record_pre_action 08:08:36 INFO - Running main action method: create_virtualenv 08:08:36 INFO - Creating virtualenv /builds/slave/test/build/venv 08:08:36 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 08:08:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:08:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:36 INFO - Using real prefix '/tools/python27' 08:08:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:08:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:40 INFO - Installing pip.................done. 08:08:40 INFO - Return code: 0 08:08:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:08:40 INFO - Reading from file tmpfile_stdout 08:08:40 INFO - Output received: 08:08:40 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) 08:08:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:40 INFO - 'HOME': '/Users/cltbld', 08:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:40 INFO - 'LOGNAME': 'cltbld', 08:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:40 INFO - 'MOZ_NO_REMOTE': '1', 08:08:40 INFO - 'NO_EM_RESTART': '1', 08:08:40 INFO - 'PAGER': '/bin/cat', 08:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:40 INFO - 'PWD': '/builds/slave/test', 08:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:40 INFO - 'SHELL': '/bin/bash', 08:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:08:40 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:40 INFO - 'USER': 'cltbld', 08:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:40 INFO - 'XPC_FLAGS': '0x0', 08:08:40 INFO - 'XPC_SERVICE_NAME': '0', 08:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:41 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 08:08:41 INFO - Cleaning up... 08:08:41 INFO - Return code: 0 08:08:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:41 INFO - 'HOME': '/Users/cltbld', 08:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:41 INFO - 'LOGNAME': 'cltbld', 08:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:41 INFO - 'MOZ_NO_REMOTE': '1', 08:08:41 INFO - 'NO_EM_RESTART': '1', 08:08:41 INFO - 'PAGER': '/bin/cat', 08:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:41 INFO - 'PWD': '/builds/slave/test', 08:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:41 INFO - 'SHELL': '/bin/bash', 08:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:08:41 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:41 INFO - 'USER': 'cltbld', 08:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:41 INFO - 'XPC_FLAGS': '0x0', 08:08:41 INFO - 'XPC_SERVICE_NAME': '0', 08:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:41 INFO - Downloading/unpacking psutil>=3.1.1 08:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:45 INFO - Installing collected packages: psutil 08:08:45 INFO - Running setup.py install for psutil 08:08:45 INFO - building 'psutil._psutil_osx' extension 08:08:45 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 08:08:45 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 08:08:45 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 08:08:45 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 08:08:45 INFO - building 'psutil._psutil_posix' extension 08:08:45 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 08:08:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:08:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:08:45 INFO - ^ 08:08:45 INFO - 1 warning generated. 08:08:45 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 08:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:45 INFO - Successfully installed psutil 08:08:45 INFO - Cleaning up... 08:08:46 INFO - Return code: 0 08:08:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:08:46 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')]} 08:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:46 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')]} 08:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:46 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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:46 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 08:08:46 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 08:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:46 INFO - 'HOME': '/Users/cltbld', 08:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:46 INFO - 'LOGNAME': 'cltbld', 08:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:46 INFO - 'MOZ_NO_REMOTE': '1', 08:08:46 INFO - 'NO_EM_RESTART': '1', 08:08:46 INFO - 'PAGER': '/bin/cat', 08:08:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:46 INFO - 'PWD': '/builds/slave/test', 08:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:46 INFO - 'SHELL': '/bin/bash', 08:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:08:46 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:46 INFO - 'USER': 'cltbld', 08:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:46 INFO - 'XPC_FLAGS': '0x0', 08:08:46 INFO - 'XPC_SERVICE_NAME': '0', 08:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:08:48 INFO - Installing collected packages: mozsystemmonitor 08:08:48 INFO - Running setup.py install for mozsystemmonitor 08:08:49 INFO - Successfully installed mozsystemmonitor 08:08:49 INFO - Cleaning up... 08:08:49 INFO - Return code: 0 08:08:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:49 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 08:08:49 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 08:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:49 INFO - 'HOME': '/Users/cltbld', 08:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:49 INFO - 'LOGNAME': 'cltbld', 08:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:49 INFO - 'MOZ_NO_REMOTE': '1', 08:08:49 INFO - 'NO_EM_RESTART': '1', 08:08:49 INFO - 'PAGER': '/bin/cat', 08:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:49 INFO - 'PWD': '/builds/slave/test', 08:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:49 INFO - 'SHELL': '/bin/bash', 08:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:08:49 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:49 INFO - 'USER': 'cltbld', 08:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:49 INFO - 'XPC_FLAGS': '0x0', 08:08:49 INFO - 'XPC_SERVICE_NAME': '0', 08:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:08:49 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 08:08:49 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 08:08:49 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 08:08:49 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 08:08:49 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 08:08:49 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 08:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:52 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:52 INFO - warning: no files found matching '*.txt' 08:08:52 INFO - no previously-included directories found matching 'build' 08:08:52 INFO - no previously-included directories found matching 'dist' 08:08:52 INFO - no previously-included directories found matching '.git*' 08:08:52 INFO - Installing collected packages: jsonschema, functools32 08:08:52 INFO - Running setup.py install for functools32 08:08:52 INFO - warning: no files found matching '*.txt' 08:08:52 INFO - no previously-included directories found matching 'build' 08:08:52 INFO - no previously-included directories found matching 'dist' 08:08:52 INFO - no previously-included directories found matching '.git*' 08:08:52 INFO - Successfully installed jsonschema functools32 08:08:52 INFO - Cleaning up... 08:08:52 INFO - Return code: 0 08:08:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:08:52 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')]} 08:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:52 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')]} 08:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:52 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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:52 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 08:08:52 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 08:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:52 INFO - 'HOME': '/Users/cltbld', 08:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:52 INFO - 'LOGNAME': 'cltbld', 08:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:52 INFO - 'MOZ_NO_REMOTE': '1', 08:08:52 INFO - 'NO_EM_RESTART': '1', 08:08:52 INFO - 'PAGER': '/bin/cat', 08:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:52 INFO - 'PWD': '/builds/slave/test', 08:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:52 INFO - 'SHELL': '/bin/bash', 08:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:08:52 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:52 INFO - 'USER': 'cltbld', 08:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:52 INFO - 'XPC_FLAGS': '0x0', 08:08:52 INFO - 'XPC_SERVICE_NAME': '0', 08:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:08:52 INFO - Cleaning up... 08:08:52 INFO - Return code: 0 08:08:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:52 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')]} 08:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:52 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')]} 08:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:52 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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:52 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 08:08:52 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 08:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:52 INFO - 'HOME': '/Users/cltbld', 08:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:52 INFO - 'LOGNAME': 'cltbld', 08:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:52 INFO - 'MOZ_NO_REMOTE': '1', 08:08:52 INFO - 'NO_EM_RESTART': '1', 08:08:52 INFO - 'PAGER': '/bin/cat', 08:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:52 INFO - 'PWD': '/builds/slave/test', 08:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:52 INFO - 'SHELL': '/bin/bash', 08:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:08:52 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:52 INFO - 'USER': 'cltbld', 08:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:52 INFO - 'XPC_FLAGS': '0x0', 08:08:52 INFO - 'XPC_SERVICE_NAME': '0', 08:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:53 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 08:08:53 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 08:08:53 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 08:08:53 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 08:08:53 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 08:08:53 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 08:08:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:55 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 08:08:55 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 08:08:55 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 08:08:55 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 08:08:56 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 08:08:56 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 08:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:56 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 08:08:56 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 08:08:56 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 08:08:56 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 08:08:56 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 08:08:56 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 08:08:57 INFO - Downloading docopt-0.6.1.tar.gz 08:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:57 INFO - Running setup.py install for blobuploader 08:08:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:57 INFO - Running setup.py install for requests 08:08:57 INFO - Running setup.py install for docopt 08:08:57 INFO - Successfully installed blobuploader requests docopt 08:08:57 INFO - Cleaning up... 08:08:58 INFO - Return code: 0 08:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:58 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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:08:58 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 08:08:58 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 08:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:58 INFO - 'HOME': '/Users/cltbld', 08:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:58 INFO - 'LOGNAME': 'cltbld', 08:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:58 INFO - 'MOZ_NO_REMOTE': '1', 08:08:58 INFO - 'NO_EM_RESTART': '1', 08:08:58 INFO - 'PAGER': '/bin/cat', 08:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:58 INFO - 'PWD': '/builds/slave/test', 08:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:58 INFO - 'SHELL': '/bin/bash', 08:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:08:58 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:58 INFO - 'USER': 'cltbld', 08:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:58 INFO - 'XPC_FLAGS': '0x0', 08:08:58 INFO - 'XPC_SERVICE_NAME': '0', 08:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:58 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-YEGZOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:58 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-R_2TXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:58 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-MSdlNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:58 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-xrS0lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:58 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-qfwmh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:58 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-C6X4wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:58 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-wxgJVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-4nvMtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-NPFHVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-p7PfGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-6L6Kfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HNRym_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HEXvM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-_kLnuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-tCG_PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-OZwdvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HlbWWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:00 INFO - Running setup.py install for manifestparser 08:09:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:00 INFO - Running setup.py install for mozcrash 08:09:00 INFO - Running setup.py install for mozdebug 08:09:00 INFO - Running setup.py install for mozdevice 08:09:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:00 INFO - Running setup.py install for mozfile 08:09:00 INFO - Running setup.py install for mozhttpd 08:09:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Running setup.py install for mozinfo 08:09:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Running setup.py install for mozInstall 08:09:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Running setup.py install for mozleak 08:09:01 INFO - Running setup.py install for mozlog 08:09:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Running setup.py install for moznetwork 08:09:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:01 INFO - Running setup.py install for mozprocess 08:09:01 INFO - Running setup.py install for mozprofile 08:09:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:02 INFO - Running setup.py install for mozrunner 08:09:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:02 INFO - Running setup.py install for mozscreenshot 08:09:02 INFO - Running setup.py install for moztest 08:09:02 INFO - Running setup.py install for mozversion 08:09:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:02 INFO - Cleaning up... 08:09:02 INFO - Return code: 0 08:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:02 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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:09:02 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 08:09:02 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 08:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:02 INFO - 'HOME': '/Users/cltbld', 08:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:02 INFO - 'LOGNAME': 'cltbld', 08:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:02 INFO - 'MOZ_NO_REMOTE': '1', 08:09:02 INFO - 'NO_EM_RESTART': '1', 08:09:02 INFO - 'PAGER': '/bin/cat', 08:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:02 INFO - 'PWD': '/builds/slave/test', 08:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:02 INFO - 'SHELL': '/bin/bash', 08:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:09:02 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:02 INFO - 'USER': 'cltbld', 08:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:02 INFO - 'XPC_FLAGS': '0x0', 08:09:02 INFO - 'XPC_SERVICE_NAME': '0', 08:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:02 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-a23lGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-0VoSV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-_3gY_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-tkZStB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-y4s6st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-_kwi3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-IqRr_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-KuxVIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-k7hyaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:03 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)) 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:03 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-jBdTCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-tOTkn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-mV2o4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Cmo0ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-TOeaWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-hp79Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-0OC953-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:04 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)) 08:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Shscww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:04 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)) 08:09:04 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)) 08:09:04 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)) 08:09:04 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)) 08:09:04 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)) 08:09:04 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)) 08:09:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:04 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 08:09:04 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 08:09:04 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 08:09:04 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 08:09:04 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 08:09:04 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 08:09:07 INFO - Downloading blessings-1.6.tar.gz 08:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:07 INFO - Installing collected packages: blessings 08:09:07 INFO - Running setup.py install for blessings 08:09:07 INFO - Successfully installed blessings 08:09:07 INFO - Cleaning up... 08:09:07 INFO - Return code: 0 08:09:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:07 INFO - Reading from file tmpfile_stdout 08:09:07 INFO - Current package versions: 08:09:07 INFO - blessings == 1.6 08:09:07 INFO - blobuploader == 1.2.4 08:09:07 INFO - docopt == 0.6.1 08:09:07 INFO - functools32 == 3.2.3-2 08:09:07 INFO - jsonschema == 2.5.1 08:09:07 INFO - manifestparser == 1.1 08:09:07 INFO - mozInstall == 1.12 08:09:07 INFO - mozcrash == 1.0 08:09:07 INFO - mozdebug == 0.1 08:09:07 INFO - mozdevice == 0.49 08:09:07 INFO - mozfile == 1.2 08:09:07 INFO - mozhttpd == 0.7 08:09:07 INFO - mozinfo == 0.9 08:09:07 INFO - mozleak == 0.1 08:09:07 INFO - mozlog == 3.4 08:09:07 INFO - moznetwork == 0.27 08:09:07 INFO - mozprocess == 0.24 08:09:07 INFO - mozprofile == 0.28 08:09:07 INFO - mozrunner == 6.13 08:09:07 INFO - mozscreenshot == 0.1 08:09:07 INFO - mozsystemmonitor == 0.3 08:09:07 INFO - moztest == 0.8 08:09:07 INFO - mozversion == 1.4 08:09:07 INFO - psutil == 3.1.1 08:09:07 INFO - requests == 1.2.3 08:09:07 INFO - wsgiref == 0.1.2 08:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:07 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')]} 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:08 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')]} 08:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 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 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:09:09 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 08:09:09 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 08:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:09 INFO - 'HOME': '/Users/cltbld', 08:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PAGER': '/bin/cat', 08:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test', 08:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:09:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - 'XPC_FLAGS': '0x0', 08:09:09 INFO - 'XPC_SERVICE_NAME': '0', 08:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 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)) 08:09:09 INFO - Cleaning up... 08:09:09 INFO - Return code: 0 08:09:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101106b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101109768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4a480aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, '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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 08:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:09 INFO - 'HOME': '/Users/cltbld', 08:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PAGER': '/bin/cat', 08:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test', 08:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:09:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - 'XPC_FLAGS': '0x0', 08:09:09 INFO - 'XPC_SERVICE_NAME': '0', 08:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:10 INFO - Cleaning up... 08:09:10 INFO - Return code: 0 08:09:10 INFO - Running post-action listener: _resource_record_post_action 08:09:10 INFO - Running post-action listener: _start_resource_monitoring 08:09:10 INFO - Starting resource monitoring. 08:09:10 INFO - [mozharness: 2017-02-16 16:09:10.100120Z] Finished create-virtualenv step (success) 08:09:10 INFO - [mozharness: 2017-02-16 16:09:10.101098Z] Running install step. 08:09:10 INFO - Running pre-action listener: _resource_record_pre_action 08:09:10 INFO - Running main action method: install 08:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:10 INFO - Reading from file tmpfile_stdout 08:09:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:10 INFO - Reading from file tmpfile_stdout 08:09:10 INFO - Output received: 08:09:10 INFO - Usage: mozinstall [options] installer 08:09:10 INFO - Options: 08:09:10 INFO - -h, --help show this help message and exit 08:09:10 INFO - -d DEST, --destination=DEST 08:09:10 INFO - Directory to install application into. [default: 08:09:10 INFO - "/builds/slave/test"] 08:09:10 INFO - --app=APP Application being installed. [default: firefox] 08:09:10 INFO - mkdir: /builds/slave/test/build/application 08:09:10 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'] 08:09:10 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 08:09:30 INFO - Reading from file tmpfile_stdout 08:09:30 INFO - Output received: 08:09:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:09:30 INFO - Running post-action listener: _resource_record_post_action 08:09:30 INFO - [mozharness: 2017-02-16 16:09:30.386630Z] Finished install step (success) 08:09:30 INFO - [mozharness: 2017-02-16 16:09:30.386805Z] Running run-tests step. 08:09:30 INFO - Running pre-action listener: _resource_record_pre_action 08:09:30 INFO - Running main action method: run_tests 08:09:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:09:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:09:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:09:30 INFO - 2017-02-16 08:09:30.401 screenresolution[2525:33211] starting screenresolution argv=screenresolution get 08:09:30 INFO - 2017-02-16 08:09:30.404 screenresolution[2525:33211] Display 0: 1600x1200x32@60 08:09:30 INFO - 2017-02-16 08:09:30.410 screenresolution[2526:33213] starting screenresolution argv=screenresolution list 08:09:30 INFO - Available Modes on Display 0 08:09:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:09:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:09:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:09:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:09:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:09:30 INFO - Intel Iris: 08:09:30 INFO - Chipset Model: Intel Iris 08:09:30 INFO - Type: GPU 08:09:30 INFO - Bus: Built-In 08:09:30 INFO - VRAM (Dynamic, Max): 1536 MB 08:09:30 INFO - Vendor: Intel (0x8086) 08:09:30 INFO - Device ID: 0x0a2e 08:09:30 INFO - Revision ID: 0x0009 08:09:30 INFO - Displays: 08:09:30 INFO - Display: 08:09:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:09:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:09:30 INFO - Display Serial Number: 1600x1200 60 08:09:30 INFO - Main Display: Yes 08:09:30 INFO - Mirror: Off 08:09:30 INFO - Online: Yes 08:09:30 INFO - Rotation: Supported 08:09:30 INFO - Return code: 0 08:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:09:30 INFO - Python 2.7.3 08:09:30 INFO - Return code: 0 08:09:30 INFO - grabbing minidump binary from tooltool 08:09:30 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')]} 08:09:30 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 0x100ee4d30>, '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 0x100e0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ed9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:09:30 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 08:09:30 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 08:09:30 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 08:09:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:30 INFO - Return code: 0 08:09:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:09:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:09:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:09:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:09:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:09:30 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/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 08:09:30 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/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --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 08:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K2qZcLQwwu/Render', 08:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:30 INFO - 'HOME': '/Users/cltbld', 08:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:30 INFO - 'LOGNAME': 'cltbld', 08:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:30 INFO - 'MOZ_NO_REMOTE': '1', 08:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:09:30 INFO - 'NO_EM_RESTART': '1', 08:09:30 INFO - 'PAGER': '/bin/cat', 08:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:30 INFO - 'PWD': '/builds/slave/test', 08:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:30 INFO - 'SHELL': '/bin/bash', 08:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0R7yTQWzkB/Listeners', 08:09:30 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:30 INFO - 'USER': 'cltbld', 08:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:30 INFO - 'XPC_FLAGS': '0x0', 08:09:30 INFO - 'XPC_SERVICE_NAME': '0', 08:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:30 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/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 08:09:30 INFO - mozversion application_buildid: 20170216065318 08:09:30 INFO - mozversion application_changeset: 8103314b2cd43d908f44d600315fc0127b7c1e79 08:09:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:09:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:30 INFO - mozversion application_name: Firefox 08:09:30 INFO - mozversion application_remotingname: firefox-dev 08:09:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:09:30 INFO - mozversion application_vendor: Mozilla 08:09:30 INFO - mozversion application_version: 53.0a2 08:09:30 INFO - mozversion platform_buildid: 20170216065318 08:09:30 INFO - mozversion platform_changeset: 8103314b2cd43d908f44d600315fc0127b7c1e79 08:09:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:09:30 INFO - mozversion platform_version: 53.0a2 08:09:30 INFO - using testdate: 1487261370 08:09:30 INFO - actual date: 1487261370 08:09:30 INFO - starting webserver on 'localhost:52011' 08:09:30 INFO - SUITE-START | Running 2 tests 08:09:30 INFO - TEST-START | dromaeo_css 08:09:30 INFO - operating with platform_type : mac_ 08:09:30 INFO - Initialising browser for dromaeo_css test... 08:09:31 INFO - TEST-INFO | started process 2536 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmp6u23LV/profile http://localhost:52011/getInfo.html) 08:09:33 INFO - PROCESS | 2536 | __metrics Screen width/height:1600/1200 08:09:33 INFO - PROCESS | 2536 | colorDepth:24 08:09:33 INFO - PROCESS | 2536 | Browser inner width/height: 1024/689 08:09:33 INFO - PROCESS | 2536 | __metrics 08:09:33 INFO - PROCESS | 2536 | 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" 08:09:33 INFO - PROCESS | 2536 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:34 INFO - TEST-INFO | 2536: exit 0 08:09:34 INFO - Browser initialized. 08:09:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:34 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmp6u23LV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:46 INFO - PROCESS | 2538 | RSS: Main: 213655552 08:09:46 INFO - PROCESS | 2538 | 08:12:50 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52011/tests/dromaeo/cssquery-ext.html) 08:12:52 INFO - PROCESS | 2538 | RSS: Main: 344788992 08:12:52 INFO - PROCESS | 2538 | 08:14:36 INFO - PROCESS | 2538 | ************************* 08:14:36 INFO - PROCESS | 2538 | A coding exception was thrown and uncaught in a Task. 08:14:36 INFO - PROCESS | 2538 | 08:14:36 ERROR - PROCESS | 2538 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:14:36 INFO - PROCESS | 2538 | Full stack: 08:14:36 INFO - PROCESS | 2538 | ************************* 08:15:55 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-ext.html (next: http://localhost:52011/tests/dromaeo/cssquery-jquery.html) 08:15:55 INFO - PROCESS | 2538 | RSS: Main: 360054784 08:15:55 INFO - PROCESS | 2538 | 08:18:58 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52011/tests/dromaeo/cssquery-mootools.html) 08:18:58 INFO - PROCESS | 2538 | RSS: Main: 351813632 08:18:58 INFO - PROCESS | 2538 | 08:22:01 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52011/tests/dromaeo/cssquery-prototype.html) 08:22:01 INFO - PROCESS | 2538 | RSS: Main: 332562432 08:22:01 INFO - PROCESS | 2538 | 08:25:05 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52011/tests/dromaeo/cssquery-yui.html) 08:25:05 INFO - PROCESS | 2538 | RSS: Main: 312909824 08:25:05 INFO - PROCESS | 2538 | 08:28:08 INFO - PROCESS | 2538 | Cycle 1(1): loaded http://localhost:52011/tests/dromaeo/cssquery-yui.html (next: http://localhost:52011/tests/dromaeo/cssquery-dojo.html) 08:28:09 INFO - PROCESS | 2538 | RSS: Main: 420220928 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | __start_tp_report 08:28:09 INFO - PROCESS | 2538 | _x_x_mozilla_page_load 08:28:09 INFO - PROCESS | 2538 | _x_x_mozilla_page_load_details 08:28:09 INFO - PROCESS | 2538 | |i|pagename|runs| 08:28:09 INFO - PROCESS | 2538 | |0;dojo.html;3310.106271306747;3325.318309746502;3332.466805311151;3361.5629968104145;3383.0696558446425;5760.510356619687;5821.970890145543;5831.387704291052;5848.561357898158;5853.326867410249;5617.606767526275;5648.858778530539;5693.402192769761;5698.914516282259;5715.342735585409;5136.614753893455;5191.351081114861;5202.453742357055;5206.921896171561;5260.289860868791;5229.50319719626;5230.137027390495;5241.68549887008;5280.023195708806;5307.177387504924;5297.761600727958;5331.546818520431;5385.569154467633;5389.622726409153;5399.055165346049;5372.677639341613;5385.434529374418;5387.164989426645;5388.91916621251;5392.325959255093;5109.284700141983;5189.195674670432;5325.680459172462;5331.360236771612;5371.75827087782;5782.190493330937;5798.420157984167;5803.158542011427;5804.2744656917885;5827.708614569297;6218.5025197984505;6240.563160578761;6257.530685198628;6281.560290779647;6287.402696743802;5271.947280527184;5563.777448902039;6266.937330626681;6280.1835761351185;6304.243490781089;6036.8188954331445;6052.878942421171;6056.545759068087;6068.423499767515;6074.058520929263;6176.7838125666285;6237.719302631393;6241.375862413723;6381.1704478417505;6386.552941294065;5618.213450116987;6026.6986650667295;6221;6234.594751341148;6252.3122456529745;6234.438900498886;6298.653574053471;6299.716512756937;6306.1171435998995;6313.179286692701;6147;6191.690415479208;6282.654454005074;6292.46514046302;6297.149884765589;5255.63210575256;6216.098665693449;6259.843503912439;6295.811125666238;6297.244330680348;5095.923561146586;5098.1842905135;5101.642884998015;5110.080185566634;5113.974430127825;4504.031633198878;4517.954820451753;4519.932201016987;4523.705959112647;4548.7725613719185;5637.3235211774845;5659;5702.315722113373;5743.85640358986;5777.364489906107;5102.897942041212;6220.409061139185;6221.595596286227;6268.435840774352;6278.340774218641;5662.8301150965535;5701.629394089371;5756.33802112754;5797.681127537941;5838.4453476919625;5498.945010549844;5561;5561.443855614487;5570.3315602128005;5605.831825045255;6234.781782637586;6314.210723659543;6328.019157030668;6478.093066970722;6486.967565162144;6179.752809887555;6231.345708700521;6268.216472940882;6275.937240627535;6278.434940855345;6423.9036414452885;6431.099646049463;6448.355164483702;6450.516211284079;6451.258105317761;6134.7427470591965;6178.443940045418;6273.592216505913;6280.842978925563;6285.622862628257;5206.635535512478;6180.103884936749;6272.655003974825;6275.090111933653;6298.590591611531;6114.969425152845;6216.627002379872;6219.595726277777;6231.003039513656;6238.812835614939;5006.974965125151;6074.969625151846;6241.625502469867;6261.060840873905;6328.367163283635;6008.309044459943;6054.455099041107;6067.484263837623;6125.387461253839;6130.489860652556;6142.416470435302;6143.017117261216;6145.692715364304;6149.692515374303;6149.938500615115;4893.584045356185;6093.36019717941;6108.297545782292;6129.172561704113;6129.172561704291 08:28:09 INFO - PROCESS | 2538 | |1;ext.html;468.9976550117249;495.9925601115984;501.27315392680623;504.44007152061226;520.5653279511607;31165.532517012234;40944;43191.568084319144;43258.78370608146;44273;44294.33558496617;44696.553034469645;44726.77636611812;44813.55186448134;44835.551644483545;8515.574221288942;9318.953405232982;9516.000819913914;9526.476043817587;9547.427154370725;8518.87221691675;10494.422806745626;11028.172887033465;11309.208355415125;11518.654440366803;11403.48684309204;11470.426478676074;11477.311361318347;11536.307821530734;11539.365334906577;8561.785955351104;11237.775244495146;11400.486978085964;11497.827532587018;11510.712232194179;8560.700375486891;11125.666230013112;11414.71463213418;11421.657350279505;11656.533738650443;41856.58143418588;42350.15299693989;42385.78807105975;42402.15195696069;42493.362599561035;3940.5862384449506;3941.1920556286177;3970.305196590585;3987.48162738845;3988.441618173458;26189.73810261911;27760.917931155043;29885.103446896628;30614.928477503403;31559.211019724462;3059.174023013796;3230.2893363460003;3274.6070471543567;3375.4093033719246;3379.763416560817;443523;445502;446772;447019;448902;65325.693486130964;66109;66208;66243.00635490472;66409;67965;68019.65990170017;68024.6598767003;68085.65957170182;68224;16718.331266749195;16986.405475808286;16998.81008329405;17015.489535313962;17022.57443563921;11707.414629268673;12025.098117641212;12854.971602271797;12988.285644289655;13030.739385212242;16560.50318490447;18437.63124737498;19011.954342511017;19013.33453329127;19057.714134287995;5660.603757737002;6187.535934804908;6582.539222254396;6672.7330906764155;6710.765123220664;879.2526352600239;883.394874510962;893.9821203575892;909.554318383987;914.1909410171912;30353.392932141232;30372;30461.365210501997;30925.381492370027;31161;1047.9056884880397;1048.4128887822844;1087.8477013218155;1089.934603923767;1206.2099324942176;15431.922840385727;15767;15922.76115858263;16023.839761602469;16048.197590120448;611822.8817711854;616023;619673;620383;621690;51775.48224517782;62731.05903411452;62941.68529157325;63094.684526577075;63139;1402.9298535073206;1423.8789702875165;1466.3548038862866;1466.9046511976687;1470.8823294136444;29389.853050734608;29977.65100570436;30420.224674578734;30542.930997414984;30765.23086922845;54401;54839;54846.177307339625;54980.900381992935;55003;523166;525855;526365;527895;529015.3549232383;41939;42513;42605.5739442614;42617;42653.36019959765;47569.286460702424;47719.80700482377;47794.76102619465;48529.75735121302;48794.75602621964;37808.810955945046;39154.21691566096;39428.2114357717;39699;40785;39305.82082537528;39697;40050.39157627388;40703.389449157694;40962.566310179;37304.44043339298;38693.41959870548;38953.805230974795;38983.41524877186;39053.80473097616;24611.630825537988;27948.72051279461;34111.48832767461;34750.82624586861;34967.65032349746;24110.51778964446;24968.126115585867;25184.866680999767;25204.73976301214;25230 08:28:09 INFO - PROCESS | 2538 | |2;jquery.html;348.1730889138295;374.02752842609203;392.1588193325317;405.0946135387409;414.6413352450132;14989;15368.308426120824;16125.758113628275;17109;21478.78521214791;17051.914740426313;21388.786112138874;21581.46046348842;22325.330240092782;22465.87670616467;4659.8835029124375;5577.888442231163;5830.154627578999;5831.533477321826;5833.416658334175;5744.138379243105;5770.33641131269;5831.30024397073;5836.474717275444;5878.764849406019;5521.917171242435;5678.772849086032;5697.430256974311;5795.942040579604;5797.623154494944;5731.168980497825;5732.5987180897355;5742.3396309424115;5765.106408506688;5767.307923049261;4881.829135980259;5041.621878359101;5118.667286626357;5119.56483698886;5128.615353848476;23027.388082834208;23838.761612383827;24905.750942490526;26924.46151076987;27399.315017124532;2604.1536500637367;2605.3095929578676;2607.361196506868;2626.763591276794;2668.946621067568;9930.9503452483;10151.390916544957;10489.160867130611;13517;14376.424943002268;1795.1473050301133;1797.694391953371;1798.3256278895415;1809.4933418642802;1832.5601855554705;134188;136786;140524.16330856844;140586.44208173512;141491;9655.468949207721;11491.827622585668;11708.70728231784;11969.760604787856;12209.267443953391;16094;16103.516894493185;16116.435924742578;16126.677466450605;16126.838731612768;8331.083580806106;8676.34927380449;8789.824203515895;8884.777880552909;8886.822263554694;8581.227689507974;8592;8635.740927772176;8735.039145693969;8809.251213646912;4632.2125238709505;4754.9286760698615;4796.016816552598;4809.326694262806;4844.95155048452;1741.4427383237241;1786.1337251433044;1985.3547597031022;2024.170090262985;2030.6852437872153;883.1521739130507;902.3863772634671;954.6754103604669;988.5106872098214;1006.2855372685475;18938.62122757537;19009.14458849355;21689.701404014024;21820.42468949116;21952.45118872041;947.3226642950324;969.8566168767104;972.5672075926145;999.0976214097911;1010.9848352274722;9165.862512062191;9189.95405022984;10270.794584108276;10422.635207767691;11366;361572;362329;423012;605031;710468;153550;153804;153874.23062884613;159917.20041399953;161353;887.9067697891628;912.5665308978182;962.3263715399108;980.4803454169444;986.1765425869336;17750.46748597544;18768.62462750765;18866;18884.150213240162;18890;54513;55153.449887622126;58583.53384245173;58951;59157.70421147867;82893;84325;84465;87587.56206218927;89416.2937779656;6623.3376662333385;8340.916590834015;8499.83000340002;8661.350398720248;8844.95577522134;9205;13202;13257.403416846073;13459.865401345862;13607.115537490032;10791;11051.171162163031;11075.390853503135;11271.436428178395;11682.123840712151;9682;11403.486843091914;11530.365829879102;11703.531858725555;11916.16586838913;11656.53373865036;11781.939625433752;11877.990370818578;11927.284362938251;12008.699782505508;6750.5274630775375;8290.46112002718;8336.416450848383;8520.616572254388;8576.44253123545;9333.206677432494;11371.090312775124;11452.312861228353;11571.19001669875;11598.304101753922 08:28:09 INFO - PROCESS | 2538 | |3;mootools.html;1426.9357878895448;1428.7571112910805;1446.5804916574193;1456.9271536423175;1458.8322342930562;7937.3253273471755;8309.584520773968;8311.875321870177;8318.500889946607;8327.916720832805;7232.421406287497;7515.210902855203;7549.433792465559;7949.483283586577;7956.403269754763;2228.2869481765883;2273.7385200701965;2278.498730279336;2278.5215104828007;2283.817294616427;2250.549890021994;2291.232437133562;2300.942476438094;2303.527776805751;2304.2511183865226;1945.5038965063889;2018.7577490701062;2190.496185877249;2240.1711366794307;2274.7725227477204;2258.627326491127;2265.9433514162115;2266.648669456245;2273.6703178039093;2274.8748818814956;2183.563287342522;2199.912003519857;2212.712347394828;2260.8982595783227;2277.8633282003134;8174.713885013996;8243.752687419386;8246;8264.21489958453;8264.504129752235;4931.901361972777;5097.8215762448135;5100.1074811907765;5107.284980102789;5118.436971933084;3200.5519227308196;3447.3277710846396;3453.2920751245933;3522.964770352289;3530.488079228523;1145.7364806094645;1187.091874715843;1202.4649031181127;1222.822690709851;1254.3728135932033;10697.572097116106;10705.143588512978;10714.357138571788;10730.517126729315;10731.302465339728;4384.693071484965;4560.840370587013;4604.88487787808;4613.5386461354265;4618.584327410549;9377.718668439958;9439.716808495756;9440.433573985583;9464.290178236659;9465.952670236742;5155.7679904404395;5162.148245539519;5164.302819119371;5179.896402072013;5187.714675692873;4040.4141399496907;4409.4488188976375;4635.907281854344;4717.858464246078;4754.953910139764;3743.981280093582;3798.772073675588;3850.0374906273432;3892.260470510594;3900.044489100132;1221.828943947848;1223.2232532342027;1226.3255209634665;1234.969125771863;1236.6166488388628;863.6329559937002;868.8479516084786;877.9517126558101;880.3837313880309;890.398980688033;5084.8220312288895;5280.841574752763;5347.652402593819;5417.322834645669;5668.914966275509;843.5697794125041;866.644675682967;941.9623215071457;983.6262220356361;1041.9218558608134;3483.268513612119;3498.510208570802;3567.733454623623;3592.6407359263862;3595.184431861893;9711.5144242789;9888.307818452638;9961.203103751683;9963.053509916546;10035.448050357301;9301.953490232505;9701.369410988264;9858.901410985798;9885.159761420216;9968.700938971842;7466;7668.233176682399;7780.961095194488;7802.336801371834;7870.173631768696;4382.978085109554;4916.672498425477;5119.283300337881;5312.7343632818975;5382.542483888913;8678.869816952625;8771.38600297973;9118.589663465293;9227.492487913229;9268.72193834186;8959.507227102571;9201.677941272023;9279.860802087838;9302.255819534286;9306;7439.776806695808;7693.230676932262;7753.302202801775;7822.5697586631;7883.211678832071;7676.078870535572;7686.192949740197;7688.730894418669;7740.993670822757;7827.021622297213;7039;7044.260352663102;7090.858182836418;7133.964330178316;7208.747693830691;6862.348076932683;6903.309669033057;6956.79129626112;6993.230744618189;7015.649217539205;6094.573379863367;6170.969145154246;6207.410296022052;6226.346233645583;6246.9062964054665;3894.337962546317;4642.210824159968;4674.392328997209;4686.531346865286;4833.371661683958;4719.5988340990025;4762.404699412574;4793.281007848851;4912.336834527293;4982.501749824988 08:28:09 INFO - PROCESS | 2538 | |4;prototype.html;337.5797132569951;350.182324272823;356.65939028228047;359.496704613541;371.87542173371935;4231.724937879036;4999.850004499871;5148.382194136704;5246;5314.202869569562;4343.023924114528;5050.727172772249;5092.363454568179;5163.767630456629;5168.793248270064;3575.1419659281714;4060.167665628554;4077.8368865245357;4104.240715467633;4124.6700263978955;3594.7663401878926;3687.3178461984485;3689.35436298648;4094.61101195386;4138.627523522882;3525.806080665562;3686.0279750333575;3931.862384816532;3939.8227079781477;3942.290387730222;3904.414337849317;3940.940885886714;3955.5846636103083;3957.3272543667645;3961.643452089326;2848.2309776360476;3376.6830935935004;3459.0739510655585;3463.8960831175104;3467.9133021674406;4777.593904518086;4786.569208771228;4979.900401991976;5054.519820617035;5130.384353877521;3759;3777.7166712496396;4314.245007123741;4471.955280447187;4493.393391892118;4625.606823420013;5420.945790542083;5438.428964958662;5446.645968012067;5488.679348993841;3113.9532907006414;3349.882754103595;3673.2557269985186;3780.621937806225;3829;4732.479427262998;5643.1535269709875;5669.914951275734;5675.744591493392;5716.79991200306;3505.8772942946875;3798.2593394287846;3805.486259355007;3808.5048943637703;3810.161764411825;3115.2367669920563;3857.4599556062176;3865.9226815463535;3868.574456809749;3877.3020856245585;4110.835566577363;4181.247375472444;4398.912021759611;4420.31485119807;4458.286674132188;5446.972765136228;5465.262189604432;5472.5621950243885;5473.397926228112;5549;1054.6572363981736;1100.79462988028;1166.8448236246056;1204.4880925606583;1226.877312268766;696.4880812602732;723.8950352198901;774.9499428274719;814.1492140712969;815.229608020415;4685.929711054337;4847.158079929604;5074.5686616637995;5084.3644544431945;5102.260172275;4924.630652701062;5042.924356134661;5227.242049902743;5602.663840169603;5653.462921022497;4480.619147372445;4918.262260660929;5091.66904151229;5108.930882992394;5163.561097306771;2196.615592271346;2579.2778022153825;2785.818921770119;2787.456445993012;2808.3571110899943;4559.993602814817;4769.59458446029;5023.422306434733;5418.669971912115;5480.561555075585;4490.2142125127975;4834.927476087862;5113.335266415416;5353.598480114007;5460;4610.654200934943;5077.5684066853255;5370.401830773391;5500.779968801203;5509.713468910438;3984.960150398575;4327.221100201994;4418.067919551538;5059.443461219336;5260.68576796631;4542.545745425431;4687.554647334138;4710.905781884275;4735.455422626442;5204;4682.484926658133;4894.902101958012;5094.439611642642;5144.97427512875;5232.607554433356;3117.6258848938273;3539.2303848075962;3567.375709250819;3568.1971556399603;3585.7848529088337;4410.669199810091;5262.526372626482;5541.030319694118;5569.053260945568;5633.056595474554;4780.95219047805;5474.507294343528;5506.5870059744875;5513;5516.972415138059;4252.808623612007;4453.768919526398;5262.394824595221;5435.374931882884;5464.606525336173;5094.974525127351;5207.895842083061;5219.347581552306;5253.842384728464;5384.219288203267;5411.485908838654;5417.21013677964;5444.782208711607;5454.218528359951;5462.890742185214;5050.661574682638;5334.026410228241;5368.8389348319615;5393.460653934732;5401.137397179501 08:28:09 INFO - PROCESS | 2538 | |5;yui.html;714.5498336048289;718.9604571748552;731.9926800731992;733.8055415314942;793.2543409195358;13973.02188846781;14854.77717834232;15313.310901009454;15537.456189033386;15758.921205393957;11832.881671183286;13594.320283985811;14148.434062637481;14175.574732758008;14618;726.8800647893091;874.204473928725;876.6668665906979;885.9468431894074;893.2139717048988;684.982800541196;704.4998051383499;848.3891598049426;868.3704314372093;878.8418084744743;927.2674587076202;933.2347475070445;933.3280038372361;939.1922946266205;939.3424602778049;724.9565026098451;930.060638754859;930.4649826349809;934.5280633280184;935.1209862729013;557.7964043124271;558.625720767087;563.0484481226714;563.3943510725986;678.5419841606896;15013.774793378108;15052.172130532816;15445.30496127677;15497.690046199126;15517.689646207013;14002.229877356742;14016.509422170175;14175.29123543829;14211.928940355336;14213.360398781977;12142.939285303517;12380.257184568954;12429.192102513398;12649.241045537205;12725.363731813464;4297.613214810682;4419.889502762425;4477.552244775497;4482.686211965164;4631.16639004979;108985.82028359389;112317;115627;117901.56787456982;121714;9080.591373388213;10877.401742904058;11272;11335.376554289593;11430.428478576037;22475;22783.860806959587;22799.31602051941;23225;23372.532549349256;7635.541867487968;7704.961475192588;7715.537067775951;7923.603819808986;7930.44486885924;4194.6853985951175;4196.748195108304;4210.7473551587;4263.744175349489;4283.528811830696;3342.665733426638;3443.483477478348;3463.757536972438;3467.2718729066673;3477.0264325988765;633.5438484291395;639.5139693832721;640.9839754006094;660.593734853062;663.1346093348227;570.8886767080379;580.3355158343758;601.6674500878291;614.0617146951814;619.9783007594713;8914.420562663407;9382.671606493877;9430.90569094314;9619.855702164474;9703.884053333957;613.2150846915955;629.8110566830024;630.6878095342835;645.7868903261913;661.5699795133106;3921.005599314787;4184.979075104666;4319.287317592625;4556.7721613919175;4622.90265522101;76933;98962;100934.49532752289;104262;107448.46275768572;91774.54112729394;94198.5290073559;94925.05074949162;95048;95117;49634.766435510486;68084.63830723357;82508;82692;85257;8864.113588641085;8892.510911899908;8895.2883769297;8899.599518021576;9079.273658107204;49364.506354937424;50362.992740145724;52778;53915;54530.182047270115;65298;69860.30139698538;70320;70523.64738176276;72972.63513682397;10758.515866785858;10772.730681732706;11102.167337449562;11700.531978721096;11970.58102966392;11744.58893938708;11928.701782455508;11977.820332695192;12000.519979200733;12104.697382565506;11374.829377559508;11603.187776855539;11689.532418703157;11725.824112638147;11880.702982425162;10669.35983840972;11011.559537618405;11023.503942322775;11089;11373.91947764961;10772.784544309226;11111;11192.384418856715;11226.326420414802;11952.701182470508;8809.339299552432;9311.953440233026;9569.808603827745;9750.463724495221;9953.900460995297;8818.86771698438;8898.555072246232;8966.10917895023;9108.590113445043;9225.538723063686 08:28:09 INFO - PROCESS | 2538 | __end_tp_report 08:28:09 INFO - PROCESS | 2538 | __start_cc_report 08:28:09 INFO - PROCESS | 2538 | _x_x_mozilla_cycle_collect,1308 08:28:09 INFO - PROCESS | 2538 | __end_cc_report 08:28:09 INFO - PROCESS | 2538 | __startTimestamp1487262489253__endTimestamp 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | ------- Summary: start ------- 08:28:09 INFO - PROCESS | 2538 | Number of tests: 6 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | [#0] dojo.html Cycles:165 Average:5775.51 Median:6054.46 stddev:643.94 (10.6%) stddev-sans-first:616.18 08:28:09 INFO - PROCESS | 2538 | Values: 3310.1 3325.3 3332.5 3361.6 3383.1 5760.5 5822.0 5831.4 5848.6 5853.3 5617.6 5648.9 5693.4 5698.9 5715.3 5136.6 5191.4 5202.5 5206.9 5260.3 5229.5 5230.1 5241.7 5280.0 5307.2 5297.8 5331.5 5385.6 5389.6 5399.1 5372.7 5385.4 5387.2 5388.9 5392.3 5109.3 5189.2 5325.7 5331.4 5371.8 5782.2 5798.4 5803.2 5804.3 5827.7 6218.5 6240.6 6257.5 6281.6 6287.4 5271.9 5563.8 6266.9 6280.2 6304.2 6036.8 6052.9 6056.5 6068.4 6074.1 6176.8 6237.7 6241.4 6381.2 6386.6 5618.2 6026.7 6221.0 6234.6 6252.3 6234.4 6298.7 6299.7 6306.1 6313.2 6147.0 6191.7 6282.7 6292.5 6297.1 5255.6 6216.1 6259.8 6295.8 6297.2 5095.9 5098.2 5101.6 5110.1 5114.0 4504.0 4518.0 4519.9 4523.7 4548.8 5637.3 5659.0 5702.3 5743.9 5777.4 5102.9 6220.4 6221.6 6268.4 6278.3 5662.8 5701.6 5756.3 5797.7 5838.4 5498.9 5561.0 5561.4 5570.3 5605.8 6234.8 6314.2 6328.0 6478.1 6487.0 6179.8 6231.3 6268.2 6275.9 6278.4 6423.9 6431.1 6448.4 6450.5 6451.3 6134.7 6178.4 6273.6 6280.8 6285.6 5206.6 6180.1 6272.7 6275.1 6298.6 6115.0 6216.6 6219.6 6231.0 6238.8 5007.0 6075.0 6241.6 6261.1 6328.4 6008.3 6054.5 6067.5 6125.4 6130.5 6142.4 6143.0 6145.7 6149.7 6149.9 4893.6 6093.4 6108.3 6129.2 6129.2 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | [#1] ext.html Cycles:180 Average:68254.57 Median:21834.65 stddev:142449.55 (652.4%) stddev-sans-first:142758.24 08:28:09 INFO - PROCESS | 2538 | Values: 469.0 496.0 501.3 504.4 520.6 31165.5 40944.0 43191.6 43258.8 44273.0 44294.3 44696.6 44726.8 44813.6 44835.6 8515.6 9319.0 9516.0 9526.5 9547.4 8518.9 10494.4 11028.2 11309.2 11518.7 11403.5 11470.4 11477.3 11536.3 11539.4 8561.8 11237.8 11400.5 11497.8 11510.7 8560.7 11125.7 11414.7 11421.7 11656.5 41856.6 42350.2 42385.8 42402.2 42493.4 3940.6 3941.2 3970.3 3987.5 3988.4 26189.7 27760.9 29885.1 30614.9 31559.2 3059.2 3230.3 3274.6 3375.4 3379.8 443523.0 445502.0 446772.0 447019.0 448902.0 65325.7 66109.0 66208.0 66243.0 66409.0 67965.0 68019.7 68024.7 68085.7 68224.0 16718.3 16986.4 16998.8 17015.5 17022.6 11707.4 12025.1 12855.0 12988.3 13030.7 16560.5 18437.6 19012.0 19013.3 19057.7 5660.6 6187.5 6582.5 6672.7 6710.8 879.3 883.4 894.0 909.6 914.2 30353.4 30372.0 30461.4 30925.4 31161.0 1047.9 1048.4 1087.8 1089.9 1206.2 15431.9 15767.0 15922.8 16023.8 16048.2 611822.9 616023.0 619673.0 620383.0 621690.0 51775.5 62731.1 62941.7 63094.7 63139.0 1402.9 1423.9 1466.4 1466.9 1470.9 29389.9 29977.7 30420.2 30542.9 30765.2 54401.0 54839.0 54846.2 54980.9 55003.0 523166.0 525855.0 526365.0 527895.0 529015.4 41939.0 42513.0 42605.6 42617.0 42653.4 47569.3 47719.8 47794.8 48529.8 48794.8 37808.8 39154.2 39428.2 39699.0 40785.0 39305.8 39697.0 40050.4 40703.4 40962.6 37304.4 38693.4 38953.8 38983.4 39053.8 24611.6 27948.7 34111.5 34750.8 34967.7 24110.5 24968.1 25184.9 25204.7 25230.0 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | [#2] jquery.html Cycles:180 Average:33786.17 Median:180960.09 stddev:88374.56 (48.8%) stddev-sans-first:88586.81 08:28:09 INFO - PROCESS | 2538 | Values: 348.2 374.0 392.2 405.1 414.6 14989.0 15368.3 16125.8 17109.0 21478.8 17051.9 21388.8 21581.5 22325.3 22465.9 4659.9 5577.9 5830.2 5831.5 5833.4 5744.1 5770.3 5831.3 5836.5 5878.8 5521.9 5678.8 5697.4 5795.9 5797.6 5731.2 5732.6 5742.3 5765.1 5767.3 4881.8 5041.6 5118.7 5119.6 5128.6 23027.4 23838.8 24905.8 26924.5 27399.3 2604.2 2605.3 2607.4 2626.8 2668.9 9931.0 10151.4 10489.2 13517.0 14376.4 1795.1 1797.7 1798.3 1809.5 1832.6 134188.0 136786.0 140524.2 140586.4 141491.0 9655.5 11491.8 11708.7 11969.8 12209.3 16094.0 16103.5 16116.4 16126.7 16126.8 8331.1 8676.3 8789.8 8884.8 8886.8 8581.2 8592.0 8635.7 8735.0 8809.3 4632.2 4754.9 4796.0 4809.3 4845.0 1741.4 1786.1 1985.4 2024.2 2030.7 883.2 902.4 954.7 988.5 1006.3 18938.6 19009.1 21689.7 21820.4 21952.5 947.3 969.9 972.6 999.1 1011.0 9165.9 9190.0 10270.8 10422.6 11366.0 361572.0 362329.0 423012.0 605031.0 710468.0 153550.0 153804.0 153874.2 159917.2 161353.0 887.9 912.6 962.3 980.5 986.2 17750.5 18768.6 18866.0 18884.2 18890.0 54513.0 55153.4 58583.5 58951.0 59157.7 82893.0 84325.0 84465.0 87587.6 89416.3 6623.3 8340.9 8499.8 8661.4 8845.0 9205.0 13202.0 13257.4 13459.9 13607.1 10791.0 11051.2 11075.4 11271.4 11682.1 9682.0 11403.5 11530.4 11703.5 11916.2 11656.5 11781.9 11878.0 11927.3 12008.7 6750.5 8290.5 8336.4 8520.6 8576.4 9333.2 11371.1 11452.3 11571.2 11598.3 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | [#3] mootools.html Cycles:180 Average:5342.00 Median:5137.53 stddev:2937.21 (57.2%) stddev-sans-first:2930.71 08:28:09 INFO - PROCESS | 2538 | Values: 1426.9 1428.8 1446.6 1456.9 1458.8 7937.3 8309.6 8311.9 8318.5 8327.9 7232.4 7515.2 7549.4 7949.5 7956.4 2228.3 2273.7 2278.5 2278.5 2283.8 2250.5 2291.2 2300.9 2303.5 2304.3 1945.5 2018.8 2190.5 2240.2 2274.8 2258.6 2265.9 2266.6 2273.7 2274.9 2183.6 2199.9 2212.7 2260.9 2277.9 8174.7 8243.8 8246.0 8264.2 8264.5 4931.9 5097.8 5100.1 5107.3 5118.4 3200.6 3447.3 3453.3 3523.0 3530.5 1145.7 1187.1 1202.5 1222.8 1254.4 10697.6 10705.1 10714.4 10730.5 10731.3 4384.7 4560.8 4604.9 4613.5 4618.6 9377.7 9439.7 9440.4 9464.3 9466.0 5155.8 5162.1 5164.3 5179.9 5187.7 4040.4 4409.4 4635.9 4717.9 4755.0 3744.0 3798.8 3850.0 3892.3 3900.0 1221.8 1223.2 1226.3 1235.0 1236.6 863.6 868.8 878.0 880.4 890.4 5084.8 5280.8 5347.7 5417.3 5668.9 843.6 866.6 942.0 983.6 1041.9 3483.3 3498.5 3567.7 3592.6 3595.2 9711.5 9888.3 9961.2 9963.1 10035.4 9302.0 9701.4 9858.9 9885.2 9968.7 7466.0 7668.2 7781.0 7802.3 7870.2 4383.0 4916.7 5119.3 5312.7 5382.5 8678.9 8771.4 9118.6 9227.5 9268.7 8959.5 9201.7 9279.9 9302.3 9306.0 7439.8 7693.2 7753.3 7822.6 7883.2 7676.1 7686.2 7688.7 7741.0 7827.0 7039.0 7044.3 7090.9 7134.0 7208.7 6862.3 6903.3 6956.8 6993.2 7015.6 6094.6 6171.0 6207.4 6226.3 6246.9 3894.3 4642.2 4674.4 4686.5 4833.4 4719.6 4762.4 4793.3 4912.3 4982.5 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | [#4] prototype.html Cycles:180 Average:4289.64 Median:4773.59 stddev:1319.26 (27.6%) stddev-sans-first:1289.18 08:28:09 INFO - PROCESS | 2538 | Values: 337.6 350.2 356.7 359.5 371.9 4231.7 4999.9 5148.4 5246.0 5314.2 4343.0 5050.7 5092.4 5163.8 5168.8 3575.1 4060.2 4077.8 4104.2 4124.7 3594.8 3687.3 3689.4 4094.6 4138.6 3525.8 3686.0 3931.9 3939.8 3942.3 3904.4 3940.9 3955.6 3957.3 3961.6 2848.2 3376.7 3459.1 3463.9 3467.9 4777.6 4786.6 4979.9 5054.5 5130.4 3759.0 3777.7 4314.2 4472.0 4493.4 4625.6 5420.9 5438.4 5446.6 5488.7 3114.0 3349.9 3673.3 3780.6 3829.0 4732.5 5643.2 5669.9 5675.7 5716.8 3505.9 3798.3 3805.5 3808.5 3810.2 3115.2 3857.5 3865.9 3868.6 3877.3 4110.8 4181.2 4398.9 4420.3 4458.3 5447.0 5465.3 5472.6 5473.4 5549.0 1054.7 1100.8 1166.8 1204.5 1226.9 696.5 723.9 774.9 814.1 815.2 4685.9 4847.2 5074.6 5084.4 5102.3 4924.6 5042.9 5227.2 5602.7 5653.5 4480.6 4918.3 5091.7 5108.9 5163.6 2196.6 2579.3 2785.8 2787.5 2808.4 4560.0 4769.6 5023.4 5418.7 5480.6 4490.2 4834.9 5113.3 5353.6 5460.0 4610.7 5077.6 5370.4 5500.8 5509.7 3985.0 4327.2 4418.1 5059.4 5260.7 4542.5 4687.6 4710.9 4735.5 5204.0 4682.5 4894.9 5094.4 5145.0 5232.6 3117.6 3539.2 3567.4 3568.2 3585.8 4410.7 5262.5 5541.0 5569.1 5633.1 4781.0 5474.5 5506.6 5513.0 5517.0 4252.8 4453.8 5262.4 5435.4 5464.6 5095.0 5207.9 5219.3 5253.8 5384.2 5411.5 5417.2 5444.8 5454.2 5462.9 5050.7 5334.0 5368.8 5393.5 5401.1 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - PROCESS | 2538 | [#5] yui.html Cycles:180 Average:20336.62 Median:53346.50 stddev:30338.79 (56.9%) stddev-sans-first:30388.12 08:28:09 INFO - PROCESS | 2538 | Values: 714.5 719.0 732.0 733.8 793.3 13973.0 14854.8 15313.3 15537.5 15758.9 11832.9 13594.3 14148.4 14175.6 14618.0 726.9 874.2 876.7 885.9 893.2 685.0 704.5 848.4 868.4 878.8 927.3 933.2 933.3 939.2 939.3 725.0 930.1 930.5 934.5 935.1 557.8 558.6 563.0 563.4 678.5 15013.8 15052.2 15445.3 15497.7 15517.7 14002.2 14016.5 14175.3 14211.9 14213.4 12142.9 12380.3 12429.2 12649.2 12725.4 4297.6 4419.9 4477.6 4482.7 4631.2 108985.8 112317.0 115627.0 117901.6 121714.0 9080.6 10877.4 11272.0 11335.4 11430.4 22475.0 22783.9 22799.3 23225.0 23372.5 7635.5 7705.0 7715.5 7923.6 7930.4 4194.7 4196.7 4210.7 4263.7 4283.5 3342.7 3443.5 3463.8 3467.3 3477.0 633.5 639.5 641.0 660.6 663.1 570.9 580.3 601.7 614.1 620.0 8914.4 9382.7 9430.9 9619.9 9703.9 613.2 629.8 630.7 645.8 661.6 3921.0 4185.0 4319.3 4556.8 4622.9 76933.0 98962.0 100934.5 104262.0 107448.5 91774.5 94198.5 94925.1 95048.0 95117.0 49634.8 68084.6 82508.0 82692.0 85257.0 8864.1 8892.5 8895.3 8899.6 9079.3 49364.5 50363.0 52778.0 53915.0 54530.2 65298.0 69860.3 70320.0 70523.6 72972.6 10758.5 10772.7 11102.2 11700.5 11970.6 11744.6 11928.7 11977.8 12000.5 12104.7 11374.8 11603.2 11689.5 11725.8 11880.7 10669.4 11011.6 11023.5 11089.0 11373.9 10772.8 11111.0 11192.4 11226.3 11952.7 8809.3 9312.0 9569.8 9750.5 9953.9 8818.9 8898.6 8966.1 9108.6 9225.5 08:28:09 INFO - PROCESS | 2538 | -------- Summary: end -------- 08:28:09 INFO - PROCESS | 2538 | 08:28:09 INFO - TEST-INFO | 2538: exit 0 08:28:09 INFO - TEST-OK | dromaeo_css | took 1118867ms 08:28:09 INFO - TEST-START | kraken 08:28:09 INFO - operating with platform_type : mac_ 08:28:09 INFO - Initialising browser for kraken test... 08:28:09 INFO - TEST-INFO | started process 2540 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmp8O4nYY/profile http://localhost:52011/getInfo.html) 08:28:12 INFO - PROCESS | 2540 | __metrics Screen width/height:1600/1200 08:28:12 INFO - PROCESS | 2540 | colorDepth:24 08:28:12 INFO - PROCESS | 2540 | Browser inner width/height: 1024/689 08:28:12 INFO - PROCESS | 2540 | __metrics 08:28:12 INFO - PROCESS | 2540 | 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" 08:28:12 INFO - PROCESS | 2540 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:13 INFO - TEST-INFO | 2540: exit 0 08:28:13 INFO - Browser initialized. 08:28:13 INFO - Running cycle 1/1 for kraken test... 08:28:13 INFO - TEST-INFO | started process 2541 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmp8O4nYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:25 INFO - PROCESS | 2541 | RSS: Main: 213970944 08:28:25 INFO - PROCESS | 2541 | 08:28:28 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:29 INFO - PROCESS | 2541 | RSS: Main: 266362880 08:28:29 INFO - PROCESS | 2541 | 08:28:31 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-dft) 08:28:32 INFO - PROCESS | 2541 | RSS: Main: 275152896 08:28:32 INFO - PROCESS | 2541 | 08:28:35 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-fft) 08:28:35 INFO - PROCESS | 2541 | RSS: Main: 373157888 08:28:35 INFO - PROCESS | 2541 | 08:28:37 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52011/tests/kraken/driver.html?testName=audio-oscillator) 08:28:38 INFO - PROCESS | 2541 | RSS: Main: 276418560 08:28:38 INFO - PROCESS | 2541 | 08:28:40 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52011/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:41 INFO - PROCESS | 2541 | RSS: Main: 277516288 08:28:41 INFO - PROCESS | 2541 | 08:28:44 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52011/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:44 INFO - PROCESS | 2541 | RSS: Main: 317722624 08:28:44 INFO - PROCESS | 2541 | 08:28:47 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52011/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:48 INFO - PROCESS | 2541 | RSS: Main: 319557632 08:28:48 INFO - PROCESS | 2541 | 08:28:51 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52011/tests/kraken/driver.html?testName=json-parse-financial) 08:28:51 INFO - PROCESS | 2541 | RSS: Main: 315650048 08:28:51 INFO - PROCESS | 2541 | 08:28:53 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52011/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:53 INFO - PROCESS | 2541 | RSS: Main: 295436288 08:28:53 INFO - PROCESS | 2541 | 08:28:55 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:56 INFO - PROCESS | 2541 | RSS: Main: 297242624 08:28:56 INFO - PROCESS | 2541 | 08:28:58 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:59 INFO - PROCESS | 2541 | RSS: Main: 299696128 08:28:59 INFO - PROCESS | 2541 | 08:29:02 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:02 INFO - PROCESS | 2541 | RSS: Main: 315584512 08:29:02 INFO - PROCESS | 2541 | 08:29:05 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:06 INFO - PROCESS | 2541 | RSS: Main: 309207040 08:29:06 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | Cycle 1(1): loaded http://localhost:52011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52011/tests/kraken/driver.html?testName=ai-astar) 08:29:08 INFO - PROCESS | 2541 | RSS: Main: 353693696 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | __start_tp_report 08:29:08 INFO - PROCESS | 2541 | _x_x_mozilla_page_load 08:29:08 INFO - PROCESS | 2541 | _x_x_mozilla_page_load_details 08:29:08 INFO - PROCESS | 2541 | |i|pagename|runs| 08:29:08 INFO - PROCESS | 2541 | |0;ai-astar;114;112;111;113;111;112;113;112;112;114 08:29:08 INFO - PROCESS | 2541 | |1;audio-beat-detection;142;109;110;138;109;107;108;106;127;107 08:29:08 INFO - PROCESS | 2541 | |2;audio-dft;186;181;182;184;185;182;185;180;184;182 08:29:08 INFO - PROCESS | 2541 | |3;audio-fft;82;58;58;87;51;51;60;74;98;82 08:29:08 INFO - PROCESS | 2541 | |4;audio-oscillator;90;69;85;71;68;70;81;67;68;82 08:29:08 INFO - PROCESS | 2541 | |5;imaging-gaussian-blur;118;85;105;131;86;83;87;84;87;90 08:29:08 INFO - PROCESS | 2541 | |6;imaging-darkroom;94;94;94;95;94;93;94;93;102;94 08:29:08 INFO - PROCESS | 2541 | |7;imaging-desaturate;87;85;88;85;87;87;84;87;86;87 08:29:08 INFO - PROCESS | 2541 | |8;json-parse-financial;55;54;55;54;56;57;58;56;57;57 08:29:08 INFO - PROCESS | 2541 | |9;json-stringify-tinderbox;65;69;82;76;73;68;68;66;69;69 08:29:08 INFO - PROCESS | 2541 | |10;stanford-crypto-aes;83;85;81;84;84;83;82;85;85;99 08:29:08 INFO - PROCESS | 2541 | |11;stanford-crypto-ccm;138;140;125;146;147;153;126;139;177;139 08:29:08 INFO - PROCESS | 2541 | |12;stanford-crypto-pbkdf2;168;167;166;172;168;167;166;167;167;168 08:29:08 INFO - PROCESS | 2541 | |13;stanford-crypto-sha256-iterative;65;65;67;66;67;65;64;65;64;64 08:29:08 INFO - PROCESS | 2541 | __end_tp_report 08:29:08 INFO - PROCESS | 2541 | __start_cc_report 08:29:08 INFO - PROCESS | 2541 | _x_x_mozilla_cycle_collect,2096 08:29:08 INFO - PROCESS | 2541 | __end_cc_report 08:29:08 INFO - PROCESS | 2541 | __startTimestamp1487262548330__endTimestamp 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | ------- Summary: start ------- 08:29:08 INFO - PROCESS | 2541 | Number of tests: 14 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:1.07 (1.0%) stddev-sans-first:0.97 08:29:08 INFO - PROCESS | 2541 | Values: 114.0 112.0 111.0 113.0 111.0 112.0 113.0 112.0 112.0 114.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:109.50 stddev:13.90 (12.7%) stddev-sans-first:11.22 08:29:08 INFO - PROCESS | 2541 | Values: 142.0 109.0 110.0 138.0 109.0 107.0 108.0 106.0 127.0 107.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:1.97 (1.1%) stddev-sans-first:1.79 08:29:08 INFO - PROCESS | 2541 | Values: 186.0 181.0 182.0 184.0 185.0 182.0 185.0 180.0 184.0 182.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#3] audio-fft Cycles:10 Average:70.10 Median:78.00 stddev:16.62 (21.3%) stddev-sans-first:17.06 08:29:08 INFO - PROCESS | 2541 | Values: 82.0 58.0 58.0 87.0 51.0 51.0 60.0 74.0 98.0 82.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:8.49 (11.2%) stddev-sans-first:7.09 08:29:08 INFO - PROCESS | 2541 | Values: 90.0 69.0 85.0 71.0 68.0 70.0 81.0 67.0 68.0 82.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:85.50 stddev:16.73 (19.6%) stddev-sans-first:15.66 08:29:08 INFO - PROCESS | 2541 | Values: 118.0 85.0 105.0 131.0 86.0 83.0 87.0 84.0 87.0 90.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:94.00 stddev:2.63 (2.8%) stddev-sans-first:2.77 08:29:08 INFO - PROCESS | 2541 | Values: 94.0 94.0 94.0 95.0 94.0 93.0 94.0 93.0 102.0 94.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:87.00 stddev:1.25 (1.4%) stddev-sans-first:1.30 08:29:08 INFO - PROCESS | 2541 | Values: 87.0 85.0 88.0 85.0 87.0 87.0 84.0 87.0 86.0 87.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.50 stddev:1.37 (2.4%) stddev-sans-first:1.41 08:29:08 INFO - PROCESS | 2541 | Values: 55.0 54.0 55.0 54.0 56.0 57.0 58.0 56.0 57.0 57.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:69.00 stddev:5.15 (7.5%) stddev-sans-first:5.06 08:29:08 INFO - PROCESS | 2541 | Values: 65.0 69.0 82.0 76.0 73.0 68.0 68.0 66.0 69.0 69.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:5.07 (6.0%) stddev-sans-first:5.32 08:29:08 INFO - PROCESS | 2541 | Values: 83.0 85.0 81.0 84.0 84.0 83.0 82.0 85.0 85.0 99.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:143.00 stddev:14.76 (10.3%) stddev-sans-first:15.54 08:29:08 INFO - PROCESS | 2541 | Values: 138.0 140.0 125.0 146.0 147.0 153.0 126.0 139.0 177.0 139.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:167.50 stddev:1.71 (1.0%) stddev-sans-first:1.81 08:29:08 INFO - PROCESS | 2541 | Values: 168.0 167.0 166.0 172.0 168.0 167.0 166.0 167.0 167.0 168.0 08:29:08 INFO - PROCESS | 2541 | 08:29:08 INFO - PROCESS | 2541 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 08:29:08 INFO - PROCESS | 2541 | Values: 65.0 65.0 67.0 66.0 67.0 65.0 64.0 65.0 64.0 64.0 08:29:08 INFO - PROCESS | 2541 | -------- Summary: end -------- 08:29:08 INFO - PROCESS | 2541 | 08:29:09 INFO - TEST-INFO | 2541: exit 0 08:29:09 INFO - TEST-OK | kraken | took 59511ms 08:29:09 INFO - SUITE-END | took 1178s 08:29:09 INFO - Completed test suite (00:19:38) 08:29:09 INFO - javascript benchmark 08:29:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.106271306747, 3325.318309746502, 3332.466805311151, 3361.5629968104145, 3383.0696558446425, 5760.510356619687, 5821.970890145543, 5831.387704291052, 5848.561357898158, 5853.326867410249, 5617.606767526275, 5648.858778530539, 5693.402192769761, 5698.914516282259, 5715.342735585409, 5136.614753893455, 5191.351081114861, 5202.453742357055, 5206.921896171561, 5260.289860868791, 5229.50319719626, 5230.137027390495, 5241.68549887008, 5280.023195708806, 5307.177387504924, 5297.761600727958, 5331.546818520431, 5385.569154467633, 5389.622726409153, 5399.055165346049, 5372.677639341613, 5385.434529374418, 5387.164989426645, 5388.91916621251, 5392.325959255093, 5109.284700141983, 5189.195674670432, 5325.680459172462, 5331.360236771612, 5371.75827087782, 5782.190493330937, 5798.420157984167, 5803.158542011427, 5804.2744656917885, 5827.708614569297, 6218.5025197984505, 6240.563160578761, 6257.530685198628, 6281.560290779647, 6287.402696743802, 5271.947280527184, 5563.777448902039, 6266.937330626681, 6280.1835761351185, 6304.243490781089, 6036.8188954331445, 6052.878942421171, 6056.545759068087, 6068.423499767515, 6074.058520929263, 6176.7838125666285, 6237.719302631393, 6241.375862413723, 6381.1704478417505, 6386.552941294065, 5618.213450116987, 6026.6986650667295, 6221.0, 6234.594751341148, 6252.3122456529745, 6234.438900498886, 6298.653574053471, 6299.716512756937, 6306.1171435998995, 6313.179286692701, 6147.0, 6191.690415479208, 6282.654454005074, 6292.46514046302, 6297.149884765589, 5255.63210575256, 6216.098665693449, 6259.843503912439, 6295.811125666238, 6297.244330680348, 5095.923561146586, 5098.1842905135, 5101.642884998015, 5110.080185566634, 5113.974430127825, 4504.031633198878, 4517.954820451753, 4519.932201016987, 4523.705959112647, 4548.7725613719185, 5637.3235211774845, 5659.0, 5702.315722113373, 5743.85640358986, 5777.364489906107, 5102.897942041212, 6220.409061139185, 6221.595596286227, 6268.435840774352, 6278.340774218641, 5662.8301150965535, 5701.629394089371, 5756.33802112754, 5797.681127537941, 5838.4453476919625, 5498.945010549844, 5561.0, 5561.443855614487, 5570.3315602128005, 5605.831825045255, 6234.781782637586, 6314.210723659543, 6328.019157030668, 6478.093066970722, 6486.967565162144, 6179.752809887555, 6231.345708700521, 6268.216472940882, 6275.937240627535, 6278.434940855345, 6423.9036414452885, 6431.099646049463, 6448.355164483702, 6450.516211284079, 6451.258105317761, 6134.7427470591965, 6178.443940045418, 6273.592216505913, 6280.842978925563, 6285.622862628257, 5206.635535512478, 6180.103884936749, 6272.655003974825, 6275.090111933653, 6298.590591611531, 6114.969425152845, 6216.627002379872, 6219.595726277777, 6231.003039513656, 6238.812835614939, 5006.974965125151, 6074.969625151846, 6241.625502469867, 6261.060840873905, 6328.367163283635, 6008.309044459943, 6054.455099041107, 6067.484263837623, 6125.387461253839, 6130.489860652556, 6142.416470435302, 6143.017117261216, 6145.692715364304, 6149.692515374303, 6149.938500615115, 4893.584045356185, 6093.36019717941, 6108.297545782292, 6129.172561704113, 6129.172561704291], "value": 5736.432480857642, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.9976550117249, 495.9925601115984, 501.27315392680623, 504.44007152061226, 520.5653279511607, 31165.532517012234, 40944.0, 43191.568084319144, 43258.78370608146, 44273.0, 44294.33558496617, 44696.553034469645, 44726.77636611812, 44813.55186448134, 44835.551644483545, 8515.574221288942, 9318.953405232982, 9516.000819913914, 9526.476043817587, 9547.427154370725, 8518.87221691675, 10494.422806745626, 11028.172887033465, 11309.208355415125, 11518.654440366803, 11403.48684309204, 11470.426478676074, 11477.311361318347, 11536.307821530734, 11539.365334906577, 8561.785955351104, 11237.775244495146, 11400.486978085964, 11497.827532587018, 11510.712232194179, 8560.700375486891, 11125.666230013112, 11414.71463213418, 11421.657350279505, 11656.533738650443, 41856.58143418588, 42350.15299693989, 42385.78807105975, 42402.15195696069, 42493.362599561035, 3940.5862384449506, 3941.1920556286177, 3970.305196590585, 3987.48162738845, 3988.441618173458, 26189.73810261911, 27760.917931155043, 29885.103446896628, 30614.928477503403, 31559.211019724462, 3059.174023013796, 3230.2893363460003, 3274.6070471543567, 3375.4093033719246, 3379.763416560817, 443523.0, 445502.0, 446772.0, 447019.0, 448902.0, 65325.693486130964, 66109.0, 66208.0, 66243.00635490472, 66409.0, 67965.0, 68019.65990170017, 68024.6598767003, 68085.65957170182, 68224.0, 16718.331266749195, 16986.405475808286, 16998.81008329405, 17015.489535313962, 17022.57443563921, 11707.414629268673, 12025.098117641212, 12854.971602271797, 12988.285644289655, 13030.739385212242, 16560.50318490447, 18437.63124737498, 19011.954342511017, 19013.33453329127, 19057.714134287995, 5660.603757737002, 6187.535934804908, 6582.539222254396, 6672.7330906764155, 6710.765123220664, 879.2526352600239, 883.394874510962, 893.9821203575892, 909.554318383987, 914.1909410171912, 30353.392932141232, 30372.0, 30461.365210501997, 30925.381492370027, 31161.0, 1047.9056884880397, 1048.4128887822844, 1087.8477013218155, 1089.934603923767, 1206.2099324942176, 15431.922840385727, 15767.0, 15922.76115858263, 16023.839761602469, 16048.197590120448, 611822.8817711854, 616023.0, 619673.0, 620383.0, 621690.0, 51775.48224517782, 62731.05903411452, 62941.68529157325, 63094.684526577075, 63139.0, 1402.9298535073206, 1423.8789702875165, 1466.3548038862866, 1466.9046511976687, 1470.8823294136444, 29389.853050734608, 29977.65100570436, 30420.224674578734, 30542.930997414984, 30765.23086922845, 54401.0, 54839.0, 54846.177307339625, 54980.900381992935, 55003.0, 523166.0, 525855.0, 526365.0, 527895.0, 529015.3549232383, 41939.0, 42513.0, 42605.5739442614, 42617.0, 42653.36019959765, 47569.286460702424, 47719.80700482377, 47794.76102619465, 48529.75735121302, 48794.75602621964, 37808.810955945046, 39154.21691566096, 39428.2114357717, 39699.0, 40785.0, 39305.82082537528, 39697.0, 40050.39157627388, 40703.389449157694, 40962.566310179, 37304.44043339298, 38693.41959870548, 38953.805230974795, 38983.41524877186, 39053.80473097616, 24611.630825537988, 27948.72051279461, 34111.48832767461, 34750.82624586861, 34967.65032349746, 24110.51778964446, 24968.126115585867, 25184.866680999767, 25204.73976301214, 25230.0], "value": 20631.219029226817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1730889138295, 374.02752842609203, 392.1588193325317, 405.0946135387409, 414.6413352450132, 14989.0, 15368.308426120824, 16125.758113628275, 17109.0, 21478.78521214791, 17051.914740426313, 21388.786112138874, 21581.46046348842, 22325.330240092782, 22465.87670616467, 4659.8835029124375, 5577.888442231163, 5830.154627578999, 5831.533477321826, 5833.416658334175, 5744.138379243105, 5770.33641131269, 5831.30024397073, 5836.474717275444, 5878.764849406019, 5521.917171242435, 5678.772849086032, 5697.430256974311, 5795.942040579604, 5797.623154494944, 5731.168980497825, 5732.5987180897355, 5742.3396309424115, 5765.106408506688, 5767.307923049261, 4881.829135980259, 5041.621878359101, 5118.667286626357, 5119.56483698886, 5128.615353848476, 23027.388082834208, 23838.761612383827, 24905.750942490526, 26924.46151076987, 27399.315017124532, 2604.1536500637367, 2605.3095929578676, 2607.361196506868, 2626.763591276794, 2668.946621067568, 9930.9503452483, 10151.390916544957, 10489.160867130611, 13517.0, 14376.424943002268, 1795.1473050301133, 1797.694391953371, 1798.3256278895415, 1809.4933418642802, 1832.5601855554705, 134188.0, 136786.0, 140524.16330856844, 140586.44208173512, 141491.0, 9655.468949207721, 11491.827622585668, 11708.70728231784, 11969.760604787856, 12209.267443953391, 16094.0, 16103.516894493185, 16116.435924742578, 16126.677466450605, 16126.838731612768, 8331.083580806106, 8676.34927380449, 8789.824203515895, 8884.777880552909, 8886.822263554694, 8581.227689507974, 8592.0, 8635.740927772176, 8735.039145693969, 8809.251213646912, 4632.2125238709505, 4754.9286760698615, 4796.016816552598, 4809.326694262806, 4844.95155048452, 1741.4427383237241, 1786.1337251433044, 1985.3547597031022, 2024.170090262985, 2030.6852437872153, 883.1521739130507, 902.3863772634671, 954.6754103604669, 988.5106872098214, 1006.2855372685475, 18938.62122757537, 19009.14458849355, 21689.701404014024, 21820.42468949116, 21952.45118872041, 947.3226642950324, 969.8566168767104, 972.5672075926145, 999.0976214097911, 1010.9848352274722, 9165.862512062191, 9189.95405022984, 10270.794584108276, 10422.635207767691, 11366.0, 361572.0, 362329.0, 423012.0, 605031.0, 710468.0, 153550.0, 153804.0, 153874.23062884613, 159917.20041399953, 161353.0, 887.9067697891628, 912.5665308978182, 962.3263715399108, 980.4803454169444, 986.1765425869336, 17750.46748597544, 18768.62462750765, 18866.0, 18884.150213240162, 18890.0, 54513.0, 55153.449887622126, 58583.53384245173, 58951.0, 59157.70421147867, 82893.0, 84325.0, 84465.0, 87587.56206218927, 89416.2937779656, 6623.3376662333385, 8340.916590834015, 8499.83000340002, 8661.350398720248, 8844.95577522134, 9205.0, 13202.0, 13257.403416846073, 13459.865401345862, 13607.115537490032, 10791.0, 11051.171162163031, 11075.390853503135, 11271.436428178395, 11682.123840712151, 9682.0, 11403.486843091914, 11530.365829879102, 11703.531858725555, 11916.16586838913, 11656.53373865036, 11781.939625433752, 11877.990370818578, 11927.284362938251, 12008.699782505508, 6750.5274630775375, 8290.46112002718, 8336.416450848383, 8520.616572254388, 8576.44253123545, 9333.206677432494, 11371.090312775124, 11452.312861228353, 11571.19001669875, 11598.304101753922], "value": 9690.316428416334, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.9357878895448, 1428.7571112910805, 1446.5804916574193, 1456.9271536423175, 1458.8322342930562, 7937.3253273471755, 8309.584520773968, 8311.875321870177, 8318.500889946607, 8327.916720832805, 7232.421406287497, 7515.210902855203, 7549.433792465559, 7949.483283586577, 7956.403269754763, 2228.2869481765883, 2273.7385200701965, 2278.498730279336, 2278.5215104828007, 2283.817294616427, 2250.549890021994, 2291.232437133562, 2300.942476438094, 2303.527776805751, 2304.2511183865226, 1945.5038965063889, 2018.7577490701062, 2190.496185877249, 2240.1711366794307, 2274.7725227477204, 2258.627326491127, 2265.9433514162115, 2266.648669456245, 2273.6703178039093, 2274.8748818814956, 2183.563287342522, 2199.912003519857, 2212.712347394828, 2260.8982595783227, 2277.8633282003134, 8174.713885013996, 8243.752687419386, 8246.0, 8264.21489958453, 8264.504129752235, 4931.901361972777, 5097.8215762448135, 5100.1074811907765, 5107.284980102789, 5118.436971933084, 3200.5519227308196, 3447.3277710846396, 3453.2920751245933, 3522.964770352289, 3530.488079228523, 1145.7364806094645, 1187.091874715843, 1202.4649031181127, 1222.822690709851, 1254.3728135932033, 10697.572097116106, 10705.143588512978, 10714.357138571788, 10730.517126729315, 10731.302465339728, 4384.693071484965, 4560.840370587013, 4604.88487787808, 4613.5386461354265, 4618.584327410549, 9377.718668439958, 9439.716808495756, 9440.433573985583, 9464.290178236659, 9465.952670236742, 5155.7679904404395, 5162.148245539519, 5164.302819119371, 5179.896402072013, 5187.714675692873, 4040.4141399496907, 4409.4488188976375, 4635.907281854344, 4717.858464246078, 4754.953910139764, 3743.981280093582, 3798.772073675588, 3850.0374906273432, 3892.260470510594, 3900.044489100132, 1221.828943947848, 1223.2232532342027, 1226.3255209634665, 1234.969125771863, 1236.6166488388628, 863.6329559937002, 868.8479516084786, 877.9517126558101, 880.3837313880309, 890.398980688033, 5084.8220312288895, 5280.841574752763, 5347.652402593819, 5417.322834645669, 5668.914966275509, 843.5697794125041, 866.644675682967, 941.9623215071457, 983.6262220356361, 1041.9218558608134, 3483.268513612119, 3498.510208570802, 3567.733454623623, 3592.6407359263862, 3595.184431861893, 9711.5144242789, 9888.307818452638, 9961.203103751683, 9963.053509916546, 10035.448050357301, 9301.953490232505, 9701.369410988264, 9858.901410985798, 9885.159761420216, 9968.700938971842, 7466.0, 7668.233176682399, 7780.961095194488, 7802.336801371834, 7870.173631768696, 4382.978085109554, 4916.672498425477, 5119.283300337881, 5312.7343632818975, 5382.542483888913, 8678.869816952625, 8771.38600297973, 9118.589663465293, 9227.492487913229, 9268.72193834186, 8959.507227102571, 9201.677941272023, 9279.860802087838, 9302.255819534286, 9306.0, 7439.776806695808, 7693.230676932262, 7753.302202801775, 7822.5697586631, 7883.211678832071, 7676.078870535572, 7686.192949740197, 7688.730894418669, 7740.993670822757, 7827.021622297213, 7039.0, 7044.260352663102, 7090.858182836418, 7133.964330178316, 7208.747693830691, 6862.348076932683, 6903.309669033057, 6956.79129626112, 6993.230744618189, 7015.649217539205, 6094.573379863367, 6170.969145154246, 6207.410296022052, 6226.346233645583, 6246.9062964054665, 3894.337962546317, 4642.210824159968, 4674.392328997209, 4686.531346865286, 4833.371661683958, 4719.5988340990025, 4762.404699412574, 4793.281007848851, 4912.336834527293, 4982.501749824988], "value": 4336.345078449237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.5797132569951, 350.182324272823, 356.65939028228047, 359.496704613541, 371.87542173371935, 4231.724937879036, 4999.850004499871, 5148.382194136704, 5246.0, 5314.202869569562, 4343.023924114528, 5050.727172772249, 5092.363454568179, 5163.767630456629, 5168.793248270064, 3575.1419659281714, 4060.167665628554, 4077.8368865245357, 4104.240715467633, 4124.6700263978955, 3594.7663401878926, 3687.3178461984485, 3689.35436298648, 4094.61101195386, 4138.627523522882, 3525.806080665562, 3686.0279750333575, 3931.862384816532, 3939.8227079781477, 3942.290387730222, 3904.414337849317, 3940.940885886714, 3955.5846636103083, 3957.3272543667645, 3961.643452089326, 2848.2309776360476, 3376.6830935935004, 3459.0739510655585, 3463.8960831175104, 3467.9133021674406, 4777.593904518086, 4786.569208771228, 4979.900401991976, 5054.519820617035, 5130.384353877521, 3759.0, 3777.7166712496396, 4314.245007123741, 4471.955280447187, 4493.393391892118, 4625.606823420013, 5420.945790542083, 5438.428964958662, 5446.645968012067, 5488.679348993841, 3113.9532907006414, 3349.882754103595, 3673.2557269985186, 3780.621937806225, 3829.0, 4732.479427262998, 5643.1535269709875, 5669.914951275734, 5675.744591493392, 5716.79991200306, 3505.8772942946875, 3798.2593394287846, 3805.486259355007, 3808.5048943637703, 3810.161764411825, 3115.2367669920563, 3857.4599556062176, 3865.9226815463535, 3868.574456809749, 3877.3020856245585, 4110.835566577363, 4181.247375472444, 4398.912021759611, 4420.31485119807, 4458.286674132188, 5446.972765136228, 5465.262189604432, 5472.5621950243885, 5473.397926228112, 5549.0, 1054.6572363981736, 1100.79462988028, 1166.8448236246056, 1204.4880925606583, 1226.877312268766, 696.4880812602732, 723.8950352198901, 774.9499428274719, 814.1492140712969, 815.229608020415, 4685.929711054337, 4847.158079929604, 5074.5686616637995, 5084.3644544431945, 5102.260172275, 4924.630652701062, 5042.924356134661, 5227.242049902743, 5602.663840169603, 5653.462921022497, 4480.619147372445, 4918.262260660929, 5091.66904151229, 5108.930882992394, 5163.561097306771, 2196.615592271346, 2579.2778022153825, 2785.818921770119, 2787.456445993012, 2808.3571110899943, 4559.993602814817, 4769.59458446029, 5023.422306434733, 5418.669971912115, 5480.561555075585, 4490.2142125127975, 4834.927476087862, 5113.335266415416, 5353.598480114007, 5460.0, 4610.654200934943, 5077.5684066853255, 5370.401830773391, 5500.779968801203, 5509.713468910438, 3984.960150398575, 4327.221100201994, 4418.067919551538, 5059.443461219336, 5260.68576796631, 4542.545745425431, 4687.554647334138, 4710.905781884275, 4735.455422626442, 5204.0, 4682.484926658133, 4894.902101958012, 5094.439611642642, 5144.97427512875, 5232.607554433356, 3117.6258848938273, 3539.2303848075962, 3567.375709250819, 3568.1971556399603, 3585.7848529088337, 4410.669199810091, 5262.526372626482, 5541.030319694118, 5569.053260945568, 5633.056595474554, 4780.95219047805, 5474.507294343528, 5506.5870059744875, 5513.0, 5516.972415138059, 4252.808623612007, 4453.768919526398, 5262.394824595221, 5435.374931882884, 5464.606525336173, 5094.974525127351, 5207.895842083061, 5219.347581552306, 5253.842384728464, 5384.219288203267, 5411.485908838654, 5417.21013677964, 5444.782208711607, 5454.218528359951, 5462.890742185214, 5050.661574682638, 5334.026410228241, 5368.8389348319615, 5393.460653934732, 5401.137397179501], "value": 3877.038739039157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.5498336048289, 718.9604571748552, 731.9926800731992, 733.8055415314942, 793.2543409195358, 13973.02188846781, 14854.77717834232, 15313.310901009454, 15537.456189033386, 15758.921205393957, 11832.881671183286, 13594.320283985811, 14148.434062637481, 14175.574732758008, 14618.0, 726.8800647893091, 874.204473928725, 876.6668665906979, 885.9468431894074, 893.2139717048988, 684.982800541196, 704.4998051383499, 848.3891598049426, 868.3704314372093, 878.8418084744743, 927.2674587076202, 933.2347475070445, 933.3280038372361, 939.1922946266205, 939.3424602778049, 724.9565026098451, 930.060638754859, 930.4649826349809, 934.5280633280184, 935.1209862729013, 557.7964043124271, 558.625720767087, 563.0484481226714, 563.3943510725986, 678.5419841606896, 15013.774793378108, 15052.172130532816, 15445.30496127677, 15497.690046199126, 15517.689646207013, 14002.229877356742, 14016.509422170175, 14175.29123543829, 14211.928940355336, 14213.360398781977, 12142.939285303517, 12380.257184568954, 12429.192102513398, 12649.241045537205, 12725.363731813464, 4297.613214810682, 4419.889502762425, 4477.552244775497, 4482.686211965164, 4631.16639004979, 108985.82028359389, 112317.0, 115627.0, 117901.56787456982, 121714.0, 9080.591373388213, 10877.401742904058, 11272.0, 11335.376554289593, 11430.428478576037, 22475.0, 22783.860806959587, 22799.31602051941, 23225.0, 23372.532549349256, 7635.541867487968, 7704.961475192588, 7715.537067775951, 7923.603819808986, 7930.44486885924, 4194.6853985951175, 4196.748195108304, 4210.7473551587, 4263.744175349489, 4283.528811830696, 3342.665733426638, 3443.483477478348, 3463.757536972438, 3467.2718729066673, 3477.0264325988765, 633.5438484291395, 639.5139693832721, 640.9839754006094, 660.593734853062, 663.1346093348227, 570.8886767080379, 580.3355158343758, 601.6674500878291, 614.0617146951814, 619.9783007594713, 8914.420562663407, 9382.671606493877, 9430.90569094314, 9619.855702164474, 9703.884053333957, 613.2150846915955, 629.8110566830024, 630.6878095342835, 645.7868903261913, 661.5699795133106, 3921.005599314787, 4184.979075104666, 4319.287317592625, 4556.7721613919175, 4622.90265522101, 76933.0, 98962.0, 100934.49532752289, 104262.0, 107448.46275768572, 91774.54112729394, 94198.5290073559, 94925.05074949162, 95048.0, 95117.0, 49634.766435510486, 68084.63830723357, 82508.0, 82692.0, 85257.0, 8864.113588641085, 8892.510911899908, 8895.2883769297, 8899.599518021576, 9079.273658107204, 49364.506354937424, 50362.992740145724, 52778.0, 53915.0, 54530.182047270115, 65298.0, 69860.30139698538, 70320.0, 70523.64738176276, 72972.63513682397, 10758.515866785858, 10772.730681732706, 11102.167337449562, 11700.531978721096, 11970.58102966392, 11744.58893938708, 11928.701782455508, 11977.820332695192, 12000.519979200733, 12104.697382565506, 11374.829377559508, 11603.187776855539, 11689.532418703157, 11725.824112638147, 11880.702982425162, 10669.35983840972, 11011.559537618405, 11023.503942322775, 11089.0, 11373.91947764961, 10772.784544309226, 11111.0, 11192.384418856715, 11226.326420414802, 11952.701182470508, 8809.339299552432, 9311.953440233026, 9569.808603827745, 9750.463724495221, 9953.900460995297, 8818.86771698438, 8898.555072246232, 8966.10917895023, 9108.590113445043, 9225.538723063686], "value": 7197.948372299769, "unit": "score"}], "name": "dromaeo_css", "value": 7195.56490370549, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 111.0, 113.0, 111.0, 112.0, 113.0, 112.0, 112.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 110.0, 138.0, 109.0, 107.0, 108.0, 106.0, 127.0, 107.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 182.0, 184.0, 185.0, 182.0, 185.0, 180.0, 184.0, 182.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 87.0, 51.0, 51.0, 60.0, 74.0, 98.0, 82.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 71.0, 68.0, 70.0, 81.0, 67.0, 68.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 85.0, 105.0, 131.0, 86.0, 83.0, 87.0, 84.0, 87.0, 90.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 93.0, 102.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 87.0, 84.0, 87.0, 86.0, 87.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 56.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 82.0, 76.0, 73.0, 68.0, 68.0, 66.0, 69.0, 69.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 81.0, 84.0, 84.0, 83.0, 82.0, 85.0, 85.0, 99.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 125.0, 146.0, 147.0, 153.0, 126.0, 139.0, 177.0, 139.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 166.0, 172.0, 168.0, 167.0, 166.0, 167.0, 167.0, 168.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 66.0, 67.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1420.8999999999999, "alertThreshold": 2.0}]} 08:29:09 INFO - Return code: 0 08:29:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:09 ERROR - # TBPL SUCCESS # 08:29:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:29:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:29:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:29:09 INFO - 2017-02-16 08:29:09.639 screenresolution[2545:35265] starting screenresolution argv=screenresolution get 08:29:09 INFO - 2017-02-16 08:29:09.641 screenresolution[2545:35265] Display 0: 1600x1200x32@60 08:29:09 INFO - 2017-02-16 08:29:09.648 screenresolution[2546:35268] starting screenresolution argv=screenresolution list 08:29:09 INFO - Available Modes on Display 0 08:29:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:29:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:29:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:29:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:29:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:29:09 INFO - Intel Iris: 08:29:09 INFO - Chipset Model: Intel Iris 08:29:09 INFO - Type: GPU 08:29:09 INFO - Bus: Built-In 08:29:09 INFO - VRAM (Dynamic, Max): 1536 MB 08:29:09 INFO - Vendor: Intel (0x8086) 08:29:09 INFO - Device ID: 0x0a2e 08:29:09 INFO - Revision ID: 0x0009 08:29:09 INFO - Displays: 08:29:09 INFO - Display: 08:29:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:29:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:29:09 INFO - Display Serial Number: 1600x1200 60 08:29:09 INFO - Main Display: Yes 08:29:09 INFO - Mirror: Off 08:29:09 INFO - Online: Yes 08:29:09 INFO - Rotation: Supported 08:29:09 INFO - Return code: 0 08:29:09 INFO - Running post-action listener: _resource_record_post_action 08:29:09 INFO - [mozharness: 2017-02-16 16:29:09.895212Z] Finished run-tests step (success) 08:29:09 INFO - Running post-run listener: _resource_record_post_run 08:29:09 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 647168; Write bytes: 507808768; Read time: 5; Write time: 1590 08:29:09 INFO - TinderboxPrint: CPU usage
53.6% 08:29:09 INFO - TinderboxPrint: I/O read bytes / time
647,168 / 5 08:29:09 INFO - TinderboxPrint: I/O write bytes / time
507,808,768 / 1,590 08:29:09 INFO - TinderboxPrint: CPU idle
2,227.2 (46.4%) 08:29:09 INFO - TinderboxPrint: CPU system
960.7 (20.0%) 08:29:09 INFO - TinderboxPrint: CPU user
1,609.8 (33.6%) 08:29:09 INFO - TinderboxPrint: Swap in / out
207,802,368 / 0 08:29:09 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205285888; Write bytes: 203003392; Read time: 15466; Write time: 445 08:29:09 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 569344; Write bytes: 295888384; Read time: 3; Write time: 1109 08:29:10 INFO - Running post-run listener: _upload_blobber_files 08:29:10 INFO - Blob upload gear active. 08:29:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:10 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 08:29:10 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'] 08:29:10 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 08:29:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:11 INFO - (blobuploader) - INFO - Done attempting. 08:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:12 INFO - (blobuploader) - INFO - Done attempting. 08:29:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:29:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:29:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:13 INFO - (blobuploader) - INFO - Done attempting. 08:29:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:16 INFO - (blobuploader) - INFO - Done attempting. 08:29:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:16 INFO - Return code: 0 08:29:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e8f2c0a493d6bb4e929f1bb200b0e3b9610567538e8905adca90c058e15cd7b5a6a9a2cc8d90b3362ad6a2669af0be8804c7fbd258c7d5f3bc3ed2ac363f420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d149f3dec9d9d16c9f6c23d9e2285c7696aad900383e20b00a2572b5653a3998ffc519be30af7c65965175cf125f5174ea542c89184f52ea7082b059c607e17e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95ee7d7efa15b366b93c3f9d436e2ae90f6b97870feb5373094221aa720dcb325ce45f4d59efeeedfecb9d378d51067d26a723952d42c5b56dd103791f00b67e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7ad2efc7b5b9954dc09368037937993ba11202afd535efd0585865152479fa7774a11e2059d2385cff35446b12607d5b5844c591de289387dc989200144c6fc"} 08:29:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:16 INFO - Contents: 08:29:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e8f2c0a493d6bb4e929f1bb200b0e3b9610567538e8905adca90c058e15cd7b5a6a9a2cc8d90b3362ad6a2669af0be8804c7fbd258c7d5f3bc3ed2ac363f420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d149f3dec9d9d16c9f6c23d9e2285c7696aad900383e20b00a2572b5653a3998ffc519be30af7c65965175cf125f5174ea542c89184f52ea7082b059c607e17e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95ee7d7efa15b366b93c3f9d436e2ae90f6b97870feb5373094221aa720dcb325ce45f4d59efeeedfecb9d378d51067d26a723952d42c5b56dd103791f00b67e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7ad2efc7b5b9954dc09368037937993ba11202afd535efd0585865152479fa7774a11e2059d2385cff35446b12607d5b5844c591de289387dc989200144c6fc"} 08:29:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:16 INFO - Copying logs to upload dir... 08:29:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.312128 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-16 08:29:16.094789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 08:29:16.100669) ========= 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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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/7e8f2c0a493d6bb4e929f1bb200b0e3b9610567538e8905adca90c058e15cd7b5a6a9a2cc8d90b3362ad6a2669af0be8804c7fbd258c7d5f3bc3ed2ac363f420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d149f3dec9d9d16c9f6c23d9e2285c7696aad900383e20b00a2572b5653a3998ffc519be30af7c65965175cf125f5174ea542c89184f52ea7082b059c607e17e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95ee7d7efa15b366b93c3f9d436e2ae90f6b97870feb5373094221aa720dcb325ce45f4d59efeeedfecb9d378d51067d26a723952d42c5b56dd103791f00b67e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7ad2efc7b5b9954dc09368037937993ba11202afd535efd0585865152479fa7774a11e2059d2385cff35446b12607d5b5844c591de289387dc989200144c6fc"} build_url:https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/f9b13jUpStugIsCUU9wBvQ/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/7e8f2c0a493d6bb4e929f1bb200b0e3b9610567538e8905adca90c058e15cd7b5a6a9a2cc8d90b3362ad6a2669af0be8804c7fbd258c7d5f3bc3ed2ac363f420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d149f3dec9d9d16c9f6c23d9e2285c7696aad900383e20b00a2572b5653a3998ffc519be30af7c65965175cf125f5174ea542c89184f52ea7082b059c607e17e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95ee7d7efa15b366b93c3f9d436e2ae90f6b97870feb5373094221aa720dcb325ce45f4d59efeeedfecb9d378d51067d26a723952d42c5b56dd103791f00b67e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7ad2efc7b5b9954dc09368037937993ba11202afd535efd0585865152479fa7774a11e2059d2385cff35446b12607d5b5844c591de289387dc989200144c6fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 08:29:16.135699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:29:16.136015) ========= 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.K2qZcLQwwu/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.0R7yTQWzkB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.005393 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 08:29:16.184665) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 08:29:16.184969) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 08:29:16.185294) ========= ========= Total master_lag: 0.18 =========