builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0277 starttime: 1487239686.78 results: success (0) buildid: 20170216004023 builduid: 3c2e588caa5640d9b17ee9dfa6deac31 revision: d956e48d28dfd1b6cc180b92b1bf170f0438569e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:06.777646) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:06.778150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:06.778508) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:06.806177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:06.806591) ========= 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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:08:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 88.0M=0s 2017-02-16 02:08:07 (88.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.421210 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:07.253299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:07.253627) ========= 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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.025492 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:07.302552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-02-16 02:08:07.303243) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d956e48d28dfd1b6cc180b92b1bf170f0438569e --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 d956e48d28dfd1b6cc180b92b1bf170f0438569e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kw6ey6X3IO/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.DMz9lQgaIf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:08:07,646 truncating revision to first 12 chars 2017-02-16 02:08:07,647 Setting DEBUG logging. 2017-02-16 02:08:07,647 attempt 1/10 2017-02-16 02:08:07,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d956e48d28df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 02:08:11,723 unpacking tar archive at: mozilla-aurora-d956e48d28df/testing/mozharness/ program finished with exit code 0 elapsedTime=4.357930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-02-16 02:08:11.685945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:11.686269) ========= script_repo_revision: d956e48d28dfd1b6cc180b92b1bf170f0438569e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:11.686674) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:11.686941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 02:08:11.711825) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2017-02-16 02:08:11.712239) ========= /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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:08:12 INFO - MultiFileLogger online at 20170216 02:08:12 in /builds/slave/test 02:08:12 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 02:08:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:12 INFO - {'append_to_log': False, 02:08:12 INFO - 'base_work_dir': '/builds/slave/test', 02:08:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:08:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:12 INFO - 'branch': 'Mozilla-Aurora', 02:08:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:12 INFO - 'config_files': ('talos/mac_config.py',), 02:08:12 INFO - 'default_actions': ('clobber', 02:08:12 INFO - 'read-buildbot-config', 02:08:12 INFO - 'download-and-extract', 02:08:12 INFO - 'populate-webroot', 02:08:12 INFO - 'create-virtualenv', 02:08:12 INFO - 'install', 02:08:12 INFO - 'run-tests'), 02:08:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:12 INFO - 'download_minidump_stackwalk': True, 02:08:12 INFO - 'download_symbols': 'ondemand', 02:08:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:12 INFO - 'installer_path': 'installer.exe', 02:08:12 INFO - 'log_level': 'info', 02:08:12 INFO - 'log_name': 'talos', 02:08:12 INFO - 'log_to_console': True, 02:08:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:08:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:08:12 INFO - 'opt_config_files': (), 02:08:12 INFO - 'pip_index': False, 02:08:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:12 INFO - 'cmd': ('bash', 02:08:12 INFO - '-c', 02:08:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:12 INFO - 'enabled': True, 02:08:12 INFO - 'halt_on_failure': False, 02:08:12 INFO - 'name': 'check_screen_resolution'},), 02:08:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:12 INFO - 'cmd': ('bash', 02:08:12 INFO - '-c', 02:08:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:12 INFO - 'enabled': True, 02:08:12 INFO - 'halt_on_failure': False, 02:08:12 INFO - 'name': 'check_screen_resolution'},), 02:08:12 INFO - 'run_cmd_checks_enabled': True, 02:08:12 INFO - 'sps_profile': False, 02:08:12 INFO - 'sps_profile_interval': 0, 02:08:12 INFO - 'suite': 'dromaeojs', 02:08:12 INFO - 'system_bits': '32', 02:08:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:12 INFO - 'title': 't-yosemite-r7-0277', 02:08:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:12 INFO - 'use_talos_json': True, 02:08:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:12 INFO - 'work_dir': 'build'} 02:08:12 INFO - [mozharness: 2017-02-16 10:08:12.165003Z] Running clobber step. 02:08:12 INFO - Running pre-action listener: _resource_record_pre_action 02:08:12 INFO - Running main action method: clobber 02:08:12 INFO - rmtree: /builds/slave/test/build 02:08:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:14 INFO - Running post-action listener: _resource_record_post_action 02:08:14 INFO - [mozharness: 2017-02-16 10:08:14.684883Z] Finished clobber step (success) 02:08:14 INFO - [mozharness: 2017-02-16 10:08:14.685024Z] Running read-buildbot-config step. 02:08:14 INFO - Running pre-action listener: _resource_record_pre_action 02:08:14 INFO - Running main action method: read_buildbot_config 02:08:14 INFO - Using buildbot properties: 02:08:14 INFO - { 02:08:14 INFO - "project": "", 02:08:14 INFO - "product": "firefox", 02:08:14 INFO - "script_repo_revision": "production", 02:08:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:08:14 INFO - "repository": "", 02:08:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:08:14 INFO - "buildid": "20170216004023", 02:08:14 INFO - "stage_platform": "macosx64", 02:08:14 INFO - "basedir": "/builds/slave/test", 02:08:14 INFO - "nightly_build": "True", 02:08:14 INFO - "buildnumber": 60, 02:08:14 INFO - "slavename": "t-yosemite-r7-0277", 02:08:14 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:08:14 INFO - "platform": "yosemite_r7", 02:08:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:08:14 INFO - "branch": "mozilla-aurora", 02:08:14 INFO - "repo_path": "releases/mozilla-aurora", 02:08:14 INFO - "revision": "d956e48d28dfd1b6cc180b92b1bf170f0438569e", 02:08:14 INFO - "pgo_build": "False", 02:08:14 INFO - "builduid": "3c2e588caa5640d9b17ee9dfa6deac31", 02:08:14 INFO - "slavebuilddir": "test" 02:08:14 INFO - } 02:08:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:08:14 INFO - Running post-action listener: _resource_record_post_action 02:08:14 INFO - [mozharness: 2017-02-16 10:08:14.688417Z] Finished read-buildbot-config step (success) 02:08:14 INFO - [mozharness: 2017-02-16 10:08:14.688549Z] Running download-and-extract step. 02:08:14 INFO - Running pre-action listener: _resource_record_pre_action 02:08:14 INFO - Running main action method: download_and_extract 02:08:14 INFO - mkdir: /builds/slave/test/build/tests 02:08:14 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')]} 02:08:14 INFO - trying https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:08:14 INFO - Downloading https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/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 02:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/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 02:08:17 INFO - Downloaded 1199 bytes. 02:08:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:08:17 INFO - Using the following test package requirements: 02:08:17 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:08:17 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:08:17 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:08:17 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'jsshell-mac.zip'], 02:08:17 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:08:17 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:08:17 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:08:17 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:08:17 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:08:17 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:17 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:08:17 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:08:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:08:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:08:17 INFO - Fetch https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:08:18 INFO - Expected file size: 16358443 02:08:18 INFO - Obtained file size: 16358443 02: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 02:08:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:08:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:08:25 INFO - Fetch https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:08:57 INFO - retry: attempt #1 caught exception: '' 02:08:57 INFO - retry: Failed, sleeping 60 seconds before retrying 02:09:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #2 02:09:57 INFO - Fetch https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:09:59 INFO - Expected file size: 16358443 02:09:59 INFO - Obtained file size: 16358443 02:10:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:10:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:10:05 INFO - Fetch https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:10:09 INFO - Expected file size: 14403485 02:10:09 INFO - Obtained file size: 14403485 02:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:09 INFO - trying https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:10:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/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 02:10:12 INFO - Downloaded 73975037 bytes. 02:10:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:10:12 INFO - mkdir: /builds/slave/test/properties 02:10:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:12 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:12 INFO - Contents: 02:10:12 INFO - build_url:https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:10:14 INFO - Running post-action listener: _resource_record_post_action 02:10:14 INFO - Running post-action listener: set_extra_try_arguments 02:10:14 INFO - [mozharness: 2017-02-16 10:10:14.400690Z] Finished download-and-extract step (success) 02:10:14 INFO - [mozharness: 2017-02-16 10:10:14.400844Z] Running populate-webroot step. 02:10:14 INFO - Running pre-action listener: _resource_record_pre_action 02:10:14 INFO - Running main action method: populate_webroot 02:10:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:14 INFO - '--tppagecycles', 02:10:14 INFO - '7'], 02:10:14 INFO - 'tests': ['tsvgm']}}, 02:10:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:10:14 INFO - 'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:10:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:10:14 INFO - 'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['damp', 'tps']}, 02:10:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:10:14 INFO - 'tests': ['damp', 'tps']}, 02:10:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['dromaeo_dom']}, 02:10:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['basic_compositor_video']}, 02:10:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:10:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['a11yr', 02:10:14 INFO - 'ts_paint', 02:10:14 INFO - 'tpaint', 02:10:14 INFO - 'sessionrestore', 02:10:14 INFO - 'sessionrestore_no_auto_restore', 02:10:14 INFO - 'tabpaint']}, 02:10:14 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:14 INFO - 'ts_paint', 02:10:14 INFO - 'tpaint', 02:10:14 INFO - 'sessionrestore', 02:10:14 INFO - 'sessionrestore_no_auto_restore', 02:10:14 INFO - 'tabpaint']}, 02:10:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:14 INFO - 'ts_paint', 02:10:14 INFO - 'tpaint', 02:10:14 INFO - 'sessionrestore', 02:10:14 INFO - 'sessionrestore_no_auto_restore', 02:10:14 INFO - 'tabpaint']}, 02:10:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:14 INFO - 'ts_paint', 02:10:14 INFO - 'tpaint', 02:10:14 INFO - 'sessionrestore', 02:10:14 INFO - 'sessionrestore_no_auto_restore', 02:10:14 INFO - 'tabpaint']}, 02:10:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['a11yr', 02:10:14 INFO - 'ts_paint', 02:10:14 INFO - 'tpaint', 02:10:14 INFO - 'sessionrestore', 02:10:14 INFO - 'sessionrestore_no_auto_restore', 02:10:14 INFO - 'tabpaint']}, 02:10:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['a11yr', 02:10:14 INFO - 'ts_paint', 02:10:14 INFO - 'tpaint', 02:10:14 INFO - 'sessionrestore', 02:10:14 INFO - 'sessionrestore_no_auto_restore', 02:10:14 INFO - 'tabpaint']}, 02:10:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['tsvgx', 02:10:14 INFO - 'tsvgr_opacity', 02:10:14 INFO - 'tart', 02:10:14 INFO - 'tscrollx', 02:10:14 INFO - 'cart', 02:10:14 INFO - 'tsvg_static']}, 02:10:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:14 INFO - 'tsvgr_opacity', 02:10:14 INFO - 'tart', 02:10:14 INFO - 'tscrollx', 02:10:14 INFO - 'cart', 02:10:14 INFO - 'tsvg_static']}, 02:10:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:10:14 INFO - 'talos_options': ['--disable-e10s'], 02:10:14 INFO - 'tests': ['tp5o']}, 02:10:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:10:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:10:14 INFO - 'talos_options': ['--disable-e10s', 02:10:14 INFO - '--xperf_path', 02:10:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:14 INFO - 'tests': ['tp5n']}, 02:10:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:10:14 INFO - 'talos_options': ['--xperf_path', 02:10:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:14 INFO - 'tests': ['tp5n']}}, 02:10:14 INFO - 'talos.zip': {'path': '', 02:10:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:14 INFO - Running post-action listener: _resource_record_post_action 02:10:14 INFO - [mozharness: 2017-02-16 10:10:14.419444Z] Finished populate-webroot step (success) 02:10:14 INFO - [mozharness: 2017-02-16 10:10:14.419583Z] Running create-virtualenv step. 02:10:14 INFO - Running pre-action listener: _resource_record_pre_action 02:10:14 INFO - Running main action method: create_virtualenv 02:10:14 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:14 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 02:10:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:14 INFO - Using real prefix '/tools/python27' 02:10:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:18 INFO - Installing pip.................done. 02:10:18 INFO - Return code: 0 02:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:10:18 INFO - Reading from file tmpfile_stdout 02:10:18 INFO - Output received: 02:10:18 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) 02:10:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10:18 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')]} 02:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:18 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')]} 02:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:19 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:10:19 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 02:10:19 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 02:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:19 INFO - 'HOME': '/Users/cltbld', 02:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:19 INFO - 'LOGNAME': 'cltbld', 02:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:19 INFO - 'MOZ_NO_REMOTE': '1', 02:10:19 INFO - 'NO_EM_RESTART': '1', 02:10:19 INFO - 'PAGER': '/bin/cat', 02:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:19 INFO - 'PWD': '/builds/slave/test', 02:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:19 INFO - 'SHELL': '/bin/bash', 02:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:10:19 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:19 INFO - 'USER': 'cltbld', 02:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:19 INFO - 'XPC_FLAGS': '0x0', 02:10:19 INFO - 'XPC_SERVICE_NAME': '0', 02:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:19 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 02:10:19 INFO - Cleaning up... 02:10:19 INFO - Return code: 0 02:10:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:19 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:10:19 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 02:10:19 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 02:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:19 INFO - 'HOME': '/Users/cltbld', 02:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:19 INFO - 'LOGNAME': 'cltbld', 02:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:19 INFO - 'MOZ_NO_REMOTE': '1', 02:10:19 INFO - 'NO_EM_RESTART': '1', 02:10:19 INFO - 'PAGER': '/bin/cat', 02:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:19 INFO - 'PWD': '/builds/slave/test', 02:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:19 INFO - 'SHELL': '/bin/bash', 02:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:10:19 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:19 INFO - 'USER': 'cltbld', 02:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:19 INFO - 'XPC_FLAGS': '0x0', 02:10:19 INFO - 'XPC_SERVICE_NAME': '0', 02:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:20 INFO - Downloading/unpacking psutil>=3.1.1 02:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:25 INFO - Installing collected packages: psutil 02:10:25 INFO - Running setup.py install for psutil 02:10:25 INFO - building 'psutil._psutil_osx' extension 02:10:25 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 02:10:26 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 02:10:26 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 02:10:26 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 02:10:26 INFO - building 'psutil._psutil_posix' extension 02:10:26 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 02:10:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:10:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:10:26 INFO - ^ 02:10:26 INFO - 1 warning generated. 02:10:26 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 02:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:26 INFO - Successfully installed psutil 02:10:26 INFO - Cleaning up... 02:10:26 INFO - Return code: 0 02:10:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10:26 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')]} 02:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:26 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')]} 02:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:26 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:10:26 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 02:10:26 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 02:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:26 INFO - 'HOME': '/Users/cltbld', 02:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:26 INFO - 'LOGNAME': 'cltbld', 02:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:26 INFO - 'MOZ_NO_REMOTE': '1', 02:10:26 INFO - 'NO_EM_RESTART': '1', 02:10:26 INFO - 'PAGER': '/bin/cat', 02:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:26 INFO - 'PWD': '/builds/slave/test', 02:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:26 INFO - 'SHELL': '/bin/bash', 02:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:10:26 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:26 INFO - 'USER': 'cltbld', 02:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:26 INFO - 'XPC_FLAGS': '0x0', 02:10:26 INFO - 'XPC_SERVICE_NAME': '0', 02:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10:26 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 02:10:26 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 02:10:26 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 02:10:26 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 02:10:26 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 02:10:26 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 02:10:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:38 INFO - Installing collected packages: mozsystemmonitor 02:10:38 INFO - Running setup.py install for mozsystemmonitor 02:10:38 INFO - Successfully installed mozsystemmonitor 02:10:38 INFO - Cleaning up... 02:10:38 INFO - Return code: 0 02:10:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:38 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')]} 02:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:38 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')]} 02:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:38 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:10:38 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 02:10:38 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 02:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:38 INFO - 'HOME': '/Users/cltbld', 02:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:38 INFO - 'LOGNAME': 'cltbld', 02:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:38 INFO - 'MOZ_NO_REMOTE': '1', 02:10:38 INFO - 'NO_EM_RESTART': '1', 02:10:38 INFO - 'PAGER': '/bin/cat', 02:10:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:38 INFO - 'PWD': '/builds/slave/test', 02:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:38 INFO - 'SHELL': '/bin/bash', 02:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:10:38 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:38 INFO - 'USER': 'cltbld', 02:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:38 INFO - 'XPC_FLAGS': '0x0', 02:10:38 INFO - 'XPC_SERVICE_NAME': '0', 02:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:38 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10:42 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 02:10:42 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 02:10:42 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 02:10:42 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 02:10:42 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 02:10:42 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 02:10:42 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:42 INFO - warning: no files found matching '*.txt' 02:10:42 INFO - no previously-included directories found matching 'build' 02:10:42 INFO - no previously-included directories found matching 'dist' 02:10:42 INFO - no previously-included directories found matching '.git*' 02:10:42 INFO - Installing collected packages: jsonschema, functools32 02:10:42 INFO - Running setup.py install for functools32 02:10:42 INFO - warning: no files found matching '*.txt' 02:10:42 INFO - no previously-included directories found matching 'build' 02:10:42 INFO - no previously-included directories found matching 'dist' 02:10:42 INFO - no previously-included directories found matching '.git*' 02:10:42 INFO - Successfully installed jsonschema functools32 02:10:42 INFO - Cleaning up... 02:10:43 INFO - Return code: 0 02:10:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:10:43 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')]} 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 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')]} 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:10:43 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 02:10:43 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 02:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:43 INFO - 'HOME': '/Users/cltbld', 02:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:43 INFO - 'LOGNAME': 'cltbld', 02:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:43 INFO - 'MOZ_NO_REMOTE': '1', 02:10:43 INFO - 'NO_EM_RESTART': '1', 02:10:43 INFO - 'PAGER': '/bin/cat', 02:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:43 INFO - 'PWD': '/builds/slave/test', 02:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:43 INFO - 'SHELL': '/bin/bash', 02:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:10:43 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:43 INFO - 'USER': 'cltbld', 02:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:43 INFO - 'XPC_FLAGS': '0x0', 02:10:43 INFO - 'XPC_SERVICE_NAME': '0', 02:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:10:43 INFO - Cleaning up... 02:10:43 INFO - Return code: 0 02:10:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:43 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')]} 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 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')]} 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:10:43 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 02:10:43 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 02:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:43 INFO - 'HOME': '/Users/cltbld', 02:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:43 INFO - 'LOGNAME': 'cltbld', 02:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:43 INFO - 'MOZ_NO_REMOTE': '1', 02:10:43 INFO - 'NO_EM_RESTART': '1', 02:10:43 INFO - 'PAGER': '/bin/cat', 02:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:43 INFO - 'PWD': '/builds/slave/test', 02:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:43 INFO - 'SHELL': '/bin/bash', 02:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:10:43 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:43 INFO - 'USER': 'cltbld', 02:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:43 INFO - 'XPC_FLAGS': '0x0', 02:10:43 INFO - 'XPC_SERVICE_NAME': '0', 02:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:43 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:43 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 02:10:43 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 02:10:43 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 02:10:43 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 02:10:43 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 02:10:43 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 02:10:54 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:54 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 02:10:54 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 02:10:54 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 02:10:54 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 02:10:54 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 02:10:54 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 02:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:56 INFO - Downloading docopt-0.6.1.tar.gz 02:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:56 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:56 INFO - Running setup.py install for blobuploader 02:10:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:56 INFO - Running setup.py install for requests 02:10:56 INFO - Running setup.py install for docopt 02:10:56 INFO - Successfully installed blobuploader requests docopt 02:10:56 INFO - Cleaning up... 02:10:57 INFO - Return code: 0 02:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:57 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')]} 02:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:57 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')]} 02:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:57 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:10:57 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 02:10:57 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 02:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:57 INFO - 'HOME': '/Users/cltbld', 02:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:57 INFO - 'LOGNAME': 'cltbld', 02:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:57 INFO - 'MOZ_NO_REMOTE': '1', 02:10:57 INFO - 'NO_EM_RESTART': '1', 02:10:57 INFO - 'PAGER': '/bin/cat', 02:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:57 INFO - 'PWD': '/builds/slave/test', 02:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:57 INFO - 'SHELL': '/bin/bash', 02:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:10:57 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:57 INFO - 'USER': 'cltbld', 02:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:57 INFO - 'XPC_FLAGS': '0x0', 02:10:57 INFO - 'XPC_SERVICE_NAME': '0', 02:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-tdNTMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-PPnI6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-svHVGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ecqwbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-OnkhvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-PHxnJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Ip9ErW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-_cIhF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-4ydntP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-eEyaBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-mHIZpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-DYL67c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-0nVsdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-KIqStd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-awJWQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NTHA6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ow75VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:59 INFO - Running setup.py install for manifestparser 02:10:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:59 INFO - Running setup.py install for mozcrash 02:10:59 INFO - Running setup.py install for mozdebug 02:10:59 INFO - Running setup.py install for mozdevice 02:10:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:59 INFO - Running setup.py install for mozfile 02:10:59 INFO - Running setup.py install for mozhttpd 02:10:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:59 INFO - Running setup.py install for mozinfo 02:11:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:11:00 INFO - Running setup.py install for mozInstall 02:11:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:11:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:11:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:11:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:11:00 INFO - Running setup.py install for mozleak 02:11:00 INFO - Running setup.py install for mozlog 02:11:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:11:00 INFO - Running setup.py install for moznetwork 02:11:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:11:00 INFO - Running setup.py install for mozprocess 02:11:00 INFO - Running setup.py install for mozprofile 02:11:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:11:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:11:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:11:01 INFO - Running setup.py install for mozrunner 02:11:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:11:01 INFO - Running setup.py install for mozscreenshot 02:11:01 INFO - Running setup.py install for moztest 02:11:01 INFO - Running setup.py install for mozversion 02:11:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:11:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:11:01 INFO - Cleaning up... 02:11:01 INFO - Return code: 0 02:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:01 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')]} 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 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')]} 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:11:01 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 02:11:01 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 02:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:01 INFO - 'HOME': '/Users/cltbld', 02:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:01 INFO - 'LOGNAME': 'cltbld', 02:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:01 INFO - 'MOZ_NO_REMOTE': '1', 02:11:01 INFO - 'NO_EM_RESTART': '1', 02:11:01 INFO - 'PAGER': '/bin/cat', 02:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:01 INFO - 'PWD': '/builds/slave/test', 02:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:01 INFO - 'SHELL': '/bin/bash', 02:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:11:01 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:01 INFO - 'USER': 'cltbld', 02:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:01 INFO - 'XPC_FLAGS': '0x0', 02:11:01 INFO - 'XPC_SERVICE_NAME': '0', 02:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:01 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-LFbvak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-KD39MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-GLdmTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NOq_H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qe3dRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-MerNN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-93fegn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ZDkuG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-QyJ34e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:02 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)) 02:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:02 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-P1hsC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:03 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)) 02:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:03 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-vizuE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:03 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)) 02:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:03 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-H_3cwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:03 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)) 02:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:03 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ez9Nnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:03 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)) 02:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:03 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NzSob_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:03 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)) 02:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:03 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-9f14s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:03 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)) 02:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:03 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-q0zpK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:03 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)) 02:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:03 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Y7fLsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:03 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)) 02:11:03 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)) 02:11:03 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)) 02:11:03 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)) 02:11:03 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)) 02:11:03 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)) 02:11:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:09 INFO - Downloading blessings-1.6.tar.gz 02:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:11:09 INFO - Installing collected packages: blessings 02:11:09 INFO - Running setup.py install for blessings 02:11:09 INFO - Successfully installed blessings 02:11:09 INFO - Cleaning up... 02:11:09 INFO - Return code: 0 02:11:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:10 INFO - Reading from file tmpfile_stdout 02:11:10 INFO - Current package versions: 02:11:10 INFO - blessings == 1.6 02:11:10 INFO - blobuploader == 1.2.4 02:11:10 INFO - docopt == 0.6.1 02:11:10 INFO - functools32 == 3.2.3-2 02:11:10 INFO - jsonschema == 2.5.1 02:11:10 INFO - manifestparser == 1.1 02:11:10 INFO - mozInstall == 1.12 02:11:10 INFO - mozcrash == 1.0 02:11:10 INFO - mozdebug == 0.1 02:11:10 INFO - mozdevice == 0.49 02:11:10 INFO - mozfile == 1.2 02:11:10 INFO - mozhttpd == 0.7 02:11:10 INFO - mozinfo == 0.9 02:11:10 INFO - mozleak == 0.1 02:11:10 INFO - mozlog == 3.4 02:11:10 INFO - moznetwork == 0.27 02:11:10 INFO - mozprocess == 0.24 02:11:10 INFO - mozprofile == 0.28 02:11:10 INFO - mozrunner == 6.13 02:11:10 INFO - mozscreenshot == 0.1 02:11:10 INFO - mozsystemmonitor == 0.3 02:11:10 INFO - moztest == 0.8 02:11:10 INFO - mozversion == 1.4 02:11:10 INFO - psutil == 3.1.1 02:11:10 INFO - requests == 1.2.3 02:11:10 INFO - wsgiref == 0.1.2 02:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:10 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 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:11:10 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 02:11:10 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 02:11:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:11:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:10 INFO - 'HOME': '/Users/cltbld', 02:11:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:10 INFO - 'LOGNAME': 'cltbld', 02:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:10 INFO - 'MOZ_NO_REMOTE': '1', 02:11:10 INFO - 'NO_EM_RESTART': '1', 02:11:10 INFO - 'PAGER': '/bin/cat', 02:11:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:10 INFO - 'PWD': '/builds/slave/test', 02:11:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:10 INFO - 'SHELL': '/bin/bash', 02:11:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:11:10 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:11:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:10 INFO - 'USER': 'cltbld', 02:11:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:10 INFO - 'XPC_FLAGS': '0x0', 02:11:10 INFO - 'XPC_SERVICE_NAME': '0', 02:11:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 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)) 02:11:10 INFO - Cleaning up... 02:11:10 INFO - Return code: 0 02:11:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106fecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43a5dbf20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, '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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 02:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:11:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:11:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:10 INFO - 'HOME': '/Users/cltbld', 02:11:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:10 INFO - 'LOGNAME': 'cltbld', 02:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:10 INFO - 'MOZ_NO_REMOTE': '1', 02:11:10 INFO - 'NO_EM_RESTART': '1', 02:11:10 INFO - 'PAGER': '/bin/cat', 02:11:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:10 INFO - 'PWD': '/builds/slave/test', 02:11:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:10 INFO - 'SHELL': '/bin/bash', 02:11:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:11:10 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:11:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:10 INFO - 'USER': 'cltbld', 02:11:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:10 INFO - 'XPC_FLAGS': '0x0', 02:11:10 INFO - 'XPC_SERVICE_NAME': '0', 02:11:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:11:10 INFO - Cleaning up... 02:11:10 INFO - Return code: 0 02:11:10 INFO - Running post-action listener: _resource_record_post_action 02:11:10 INFO - Running post-action listener: _start_resource_monitoring 02:11:10 INFO - Starting resource monitoring. 02:11:10 INFO - [mozharness: 2017-02-16 10:11:10.672181Z] Finished create-virtualenv step (success) 02:11:10 INFO - [mozharness: 2017-02-16 10:11:10.673239Z] Running install step. 02:11:10 INFO - Running pre-action listener: _resource_record_pre_action 02:11:10 INFO - Running main action method: install 02:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:10 INFO - Reading from file tmpfile_stdout 02:11:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:11:11 INFO - Reading from file tmpfile_stdout 02:11:11 INFO - Output received: 02:11:11 INFO - Usage: mozinstall [options] installer 02:11:11 INFO - Options: 02:11:11 INFO - -h, --help show this help message and exit 02:11:11 INFO - -d DEST, --destination=DEST 02:11:11 INFO - Directory to install application into. [default: 02:11:11 INFO - "/builds/slave/test"] 02:11:11 INFO - --app=APP Application being installed. [default: firefox] 02:11:11 INFO - mkdir: /builds/slave/test/build/application 02:11:11 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'] 02:11:11 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 02:11:31 INFO - Reading from file tmpfile_stdout 02:11:31 INFO - Output received: 02:11:31 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:11:31 INFO - Running post-action listener: _resource_record_post_action 02:11:31 INFO - [mozharness: 2017-02-16 10:11:31.366432Z] Finished install step (success) 02:11:31 INFO - [mozharness: 2017-02-16 10:11:31.366609Z] Running run-tests step. 02:11:31 INFO - Running pre-action listener: _resource_record_pre_action 02:11:31 INFO - Running main action method: run_tests 02:11:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:11:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:11:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:11:31 INFO - 2017-02-16 02:11:31.381 screenresolution[1630:7919] starting screenresolution argv=screenresolution get 02:11:31 INFO - 2017-02-16 02:11:31.384 screenresolution[1630:7919] Display 0: 1600x1200x32@60 02:11:31 INFO - 2017-02-16 02:11:31.389 screenresolution[1631:7922] starting screenresolution argv=screenresolution list 02:11:31 INFO - Available Modes on Display 0 02:11:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:11:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:11:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:11:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:11:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:11:31 INFO - Intel Iris: 02:11:31 INFO - Chipset Model: Intel Iris 02:11:31 INFO - Type: GPU 02:11:31 INFO - Bus: Built-In 02:11:31 INFO - VRAM (Dynamic, Max): 1536 MB 02:11:31 INFO - Vendor: Intel (0x8086) 02:11:31 INFO - Device ID: 0x0a2e 02:11:31 INFO - Revision ID: 0x0009 02:11:31 INFO - Displays: 02:11:31 INFO - Display: 02:11:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:11:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:11:31 INFO - Display Serial Number: 1600x1200 60 02:11:31 INFO - Main Display: Yes 02:11:31 INFO - Mirror: Off 02:11:31 INFO - Online: Yes 02:11:31 INFO - Rotation: Supported 02:11:31 INFO - Return code: 0 02:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:11:31 INFO - Python 2.7.3 02:11:31 INFO - Return code: 0 02:11:31 INFO - grabbing minidump binary from tooltool 02:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:31 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 0x106dcad30>, '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 0x106cf1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbfbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:11:31 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 02:11:31 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 02:11:31 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 02:11:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:11:31 INFO - Return code: 0 02:11:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:11:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:11:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:11:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:11:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:11:31 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/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 02:11:31 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/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 02:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kw6ey6X3IO/Render', 02:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:31 INFO - 'HOME': '/Users/cltbld', 02:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:31 INFO - 'LOGNAME': 'cltbld', 02:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:31 INFO - 'MOZ_NO_REMOTE': '1', 02:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:31 INFO - 'NO_EM_RESTART': '1', 02:11:31 INFO - 'PAGER': '/bin/cat', 02:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:31 INFO - 'PWD': '/builds/slave/test', 02:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:31 INFO - 'SHELL': '/bin/bash', 02:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DMz9lQgaIf/Listeners', 02:11:31 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 02:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:31 INFO - 'USER': 'cltbld', 02:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:31 INFO - 'XPC_FLAGS': '0x0', 02:11:31 INFO - 'XPC_SERVICE_NAME': '0', 02:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:31 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/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 02:11:31 INFO - mozversion application_buildid: 20170216004023 02:11:31 INFO - mozversion application_changeset: d956e48d28dfd1b6cc180b92b1bf170f0438569e 02:11:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:11:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:11:31 INFO - mozversion application_name: Firefox 02:11:31 INFO - mozversion application_remotingname: firefox-dev 02:11:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:11:31 INFO - mozversion application_vendor: Mozilla 02:11:31 INFO - mozversion application_version: 53.0a2 02:11:31 INFO - mozversion platform_buildid: 20170216004023 02:11:31 INFO - mozversion platform_changeset: d956e48d28dfd1b6cc180b92b1bf170f0438569e 02:11:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:11:31 INFO - mozversion platform_version: 53.0a2 02:11:31 INFO - using testdate: 1487239891 02:11:31 INFO - actual date: 1487239891 02:11:31 INFO - starting webserver on 'localhost:49244' 02:11:31 INFO - SUITE-START | Running 2 tests 02:11:31 INFO - TEST-START | dromaeo_css 02:11:31 INFO - operating with platform_type : mac_ 02:11:31 INFO - Initialising browser for dromaeo_css test... 02:11:32 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpe2EyL3/profile http://localhost:49244/getInfo.html) 02:11:34 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 02:11:34 INFO - PROCESS | 1641 | colorDepth:24 02:11:34 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 02:11:34 INFO - PROCESS | 1641 | __metrics 02:11:34 INFO - PROCESS | 1641 | 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" 02:11:34 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:11:35 INFO - TEST-INFO | 1641: exit 0 02:11:35 INFO - Browser initialized. 02:11:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:35 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpe2EyL3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:47 INFO - PROCESS | 1645 | RSS: Main: 213233664 02:11:47 INFO - PROCESS | 1645 | 02:14:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 02:14:53 INFO - PROCESS | 1645 | RSS: Main: 345243648 02:14:53 INFO - PROCESS | 1645 | 02:16:37 INFO - PROCESS | 1645 | ************************* 02:16:37 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 02:16:37 INFO - PROCESS | 1645 | 02:16:37 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:16:37 INFO - PROCESS | 1645 | Full stack: 02:16:37 INFO - PROCESS | 1645 | ************************* 02:17:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 02:17:57 INFO - PROCESS | 1645 | RSS: Main: 353775616 02:17:57 INFO - PROCESS | 1645 | 02:21:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 02:21:00 INFO - PROCESS | 1645 | RSS: Main: 330964992 02:21:00 INFO - PROCESS | 1645 | 02:24:02 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 02:24:03 INFO - PROCESS | 1645 | RSS: Main: 334741504 02:24:03 INFO - PROCESS | 1645 | 02:27:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 02:27:07 INFO - PROCESS | 1645 | RSS: Main: 324435968 02:27:07 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 02:30:10 INFO - PROCESS | 1645 | RSS: Main: 400556032 02:30:10 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | __start_tp_report 02:30:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 02:30:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 02:30:10 INFO - PROCESS | 1645 | |i|pagename|runs| 02:30:10 INFO - PROCESS | 1645 | |0;dojo.html;3345.5316255724197;3379.138319728469;3385.6952874241297;3387.1193489692682;3421.81180035098;5820.708964551766;5874.618149820264;5889.2932848058235;5915;5921.20063791388;5792.131180322954;5870.823875283749;5871.442212989759;5940.940590594104;5941.108833674951;5285.99566082445;5301.284326615915;5357.705326207057;5377.704226267554;5408.296921400212;5221.869453263661;5230.2416149658275;5244.265802787613;5284.709340986245;5406.324209473816;5300.522952934235;5333.653312534692;5354.544863686572;5378.704171270579;5382.9730851345685;5357.946420535784;5380.892382152355;5380.946190538084;5383.950129724705;5390.677439403356;5164.354455693038;5191;5265.6840589564745;5328.387235467932;5396.19057141428;5762.971185144047;5771.451712087345;5779.653220806765;5805.767769289266;5813.88372232553;6168.0439531872635;6214.875702485971;6230.127782110508;6244.781432649836;6249.625022498664;6245.687715614246;6279.560430769848;6294.181756371689;6302.275238347557;6303.779367722108;5783.3638299787835;5835.854103647443;5957.285125784933;6033.3664965178905;6040.275166979946;6251.562390632703;6273.341299163613;6300.842478938063;6306.527010474141;6412.775552855627;6253.218347706536;6270.122182894398;6275.560710750295;6282.685865706696;6283.622982621057;6188.659623720739;6248.156498872685;6267.122602835607;6268.811935641938;6276.968615156895;6139.566483661902;6196.938030619726;6219.222597175353;6284.591501552384;6286.308506064329;6188.628682279078;6221.564490485713;6232.3144454110015;6234.875302493925;6267.934451143316;5011.84964451067;5074.644774865724;5081.161608334657;5091.872703182376;5099.515546023122;4545.409096817459;4548.681592288508;4551.089782043605;4566.908661826811;4584;5011.473795251446;5723.856903577361;5767.04843700793;5774.826755197267;5884.264466941632;6201.56589038772;6225.501959843202;6229.906551401733;6250.531210159256;6267.185265915493;4465.24090904547;5741.8277451675685;5782.7686892523825;5795.681237531976;5879.147523609138;5557.722113894289;5558.555315574744;5565.387807341189;5566.304211973504;5580.86047848807;6215.81352559424;6240.063990401476;6338.271098823694;6470.22357317125;6491.967540162269;5424;6137.683438940172;6172.969135154295;6253.5935164216;6256.124142619946;6438.356164383712;6443.742250309935;6463.935360646334;6467.7736279231885;6479.4816414685765;6119.258838874149;6139.4001448444;6251.9687401562705;6261.092141639528;6272.749090036347;5083.517065878736;6035.275766907824;6156.107364432221;6166.938330616636;6241.937580624136;6070.605410648293;6077.4226448487325;6084.756609735561;6090.482309003607;6258.624482531062;6075.513958883367;6082.452579267887;6158.784442544489;6192.349803270592;6206.658633775186;5989.940100599112;6008.279006519246;6015.699215039143;6050.42520960508;6131.96934015327;6141.680461099834;6146.661933593696;6161.661108639068;6165.784197553064;6175.752969881154;6084.056971169476;6092.238470191226;6094.886873317944;6110.572259941761;6132.8773424532155 02:30:10 INFO - PROCESS | 1645 | |1;ext.html;457.91299653065914;506.7694199139392;509.964302498825;510.5991796439795;519.0760446405397;25387.492250154985;40698;43179.35230971534;43222.56777432225;45406.318905216365;44613.55386446135;44778.776106119425;44838.55161448393;44904;45049;8489.066202717697;8782.473051616891;9245.07549245077;9398.906010939889;9576.281778866578;8587.52768597727;11463.828042579325;11719.765604687902;11741.119416043832;11974.281543107398;11621.302721836717;11728.944395004448;11739.11956603254;11752.118591105658;11758.17692761507;8621.267192288664;11594.188406811527;11665.183437159401;11673.241239319417;11686.357250351228;8667.869981950276;11399.316041037564;11506.654800356002;11626.709332266677;11681.299122052704;41666.37500437496;41899.58100418987;42230.155396892194;42232;42262;4000.439279581489;4048.9595104048876;4057.7159598828093;4072.572379900127;4088.100617864065;29943.40113197724;29982.550261745873;29985.40029199404;30614.693853061628;30898.53652195219;3013;3060.3114299282706;3163.4780261256865;3257.332246889382;3261.9184520386943;365932;367683.1615841904;367770;368029.9999999973;368268;67249.65500689959;67366.32633673698;67686;67858.66070669713;68052;60207.397926021054;70046.64976675084;72906.0837566502;73017;73153;17105.23026463812;17350.39273625417;17384.5653858652;17396.565085872953;17400.39098631567;10446.68659940203;11926;13056.934715326552;13153.67115822093;13167.60497185086;17076.12532136481;17400.825991740174;19180.040997950327;19247.326343577908;19255.56800534689;7126.786196414116;7146.213916469184;7153.35619794221;7236.674349654173;7270.818229544304;869.9913000870037;872.6081899370494;880.5113162194915;881.2113158722907;921.2721949659827;30634.54048189279;30687.8465607675;30743;31073.68926310753;31080.844595776878;997.7455748784014;1048.5858086056119;1053.3627155570769;1093.1582681335328;1103.624767579027;15205.847941520444;15885.126318052618;15995.840041599435;16305.429309974332;16423.91788041052;583734;587696;587772;588375;590799;62167;62356.376436235965;62483.12550623489;62514.374856251765;62957;1421.6943357178257;1456.8324642666016;1472.0505274098361;1475.4983305676337;1485.0569888120906;27917.58123628188;29813.850930745208;29834.55248171236;30398;30635.693643063285;46508;54792.63018424571;55467.44532554623;55477.61305967383;55600.72199638976;501778;502940;504248;504792;505339;41843.163136737705;42577;43008.56991430045;43103.7844810774;43391.78304108459;46845.765771170925;47709;49204.507954919995;49547.76130596764;49647;36178;36189.819050904574;37803.810980944916;39277.2144557113;39306.01734956649;30909.690903090683;35656.286874262885;35837;36960.815195923846;37239.441408378356;33924.3215135691;36620;37315.6939507116;37527.81236093802;37606.2478750418;31024;33298.834540791926;33380.833095834365;33410.832945835115;33522;23937.760622393555;24428.75571244265;24448;24806.875965620777;24999.50001000006 02:30:10 INFO - PROCESS | 1645 | |2;jquery.html;372.6552938531858;374.78449891312505;391.823679344295;398.3228511530397;426.53720713026365;15016.57285190343;15032.398704051839;18078.367257146;20157.395278141677;20492.180312787506;20054.89972550139;20468.976551172418;20494.077766500504;20806.375808725723;21868.343949681494;5244.265802787594;5655;5677.063284558053;5822.010258256086;5976.312724036748;4122.525909520398;5746.597738158331;5850.444207800252;5854.034084376073;5861.736221870026;4309.987153019038;5839.766409343642;6369.426751592356;6377;6435.806925792233;5444.915570923887;6348.238211414614;6417.807465776011;6440;6473.611583305017;5621.971890140523;5687.7156142192725;5696.231008813798;5707.315122185323;5710.8001219957105;25620.23139305824;26488.60267095995;26584.867075664497;26607.866960665266;26796.330091747863;3079.8306093164865;3101.720845123927;3102.751779857606;3109.8600562974493;3164.256399746058;14906.627334316621;15196.544103676908;15826.604334891605;16514.58713532159;16556.50330490087;1754.8596112310984;1812.8005919348861;1816.6548355812354;1825.1330617956496;1861.9348322808771;124814;128908;133301;134197;135330.32334838362;11639.59261425846;11868.940655296668;11964;12043.819342709867;12197;15469.690606187813;16182.595435114215;16187.676246475005;16210.67578648444;16234.918825405797;8427.578621068922;8909.955450222837;8973.237274831581;9008.369414141078;9134.132257435533;8685.174908383693;8693.304535637133;8695.913040869636;8853.911460885438;8892.199702026848;4064.349704047338;4851.054044461367;4873.658843880894;4876.414830220397;4934.235193545006;2017.5057111007898;2020.5554777948828;2042.1423002339054;2054.856160068781;2056.5578400643935;863.5250612163285;915.4141349536302;1005.3666190300211;1040.9011143941314;1042.6246551241547;21000.159993600086;23233.7676623235;23274.767252327598;24125.39686507816;24471.87764061168;960.6109525642127;968.4286271100085;993.2252842782641;1004.1665417703289;1004.9196064314983;6784.287649796799;6930.514863959575;6938.618375989268;7153;7170.103737032871;412649.9367503143;626582;729415;740942;749520;165057;167313.3268667322;168474;169997;170060.19759209492;965.1458459263603;1046.1160319529986;1078.1698092468755;1083.1713738989679;1097.6432659385732;19375.20721683649;20249.39251822448;20253.088611012834;20325.288614898407;20434.79565204329;61124;61904.07143892935;61968.69015654893;61989.690051549456;63749;80138.5993070031;89764.30707078798;90326.64510032223;92286.07713922775;93173.53413233161;7938.483998540077;8314.625841837253;8677.305815534615;8828.514431706319;8912.55437228123;11574.479148438171;13069.607911762663;13120;13507.594772156852;13509.324533773075;11278.266912650652;11542.307461552333;11557.239015176216;11689.824652630048;11868.58459953932;9355.06449355059;11236.325820450798;11390.37352945596;11727;11746.29522228669;11375.26060806045;11476.311421314747;11645;11899.405029748652;12025.819612705642;8353.33173346143;8485.151484851465;8501.322083543912;8547.914520854712;8626.309895208242;11429.485673144562;11433.542658293907;11494.425278735862;11686.24039437434;11813.704657383634 02:30:10 INFO - PROCESS | 1645 | |3;mootools.html;1438.8561044044377;1438.8776953958914;1449.572376149036;1454.6726986428052;1457.4461704552268;8196.836063278732;8569.100244474334;8574.18545238203;8577.39958202926;8601.784955376119;7429.962850185741;7694.88457673134;8185.9181408185905;8388.580570971442;8489.957550212255;2337.100216416679;2375.7861792438675;2379.8453100548495;2383.6305372667266;2384.332386931653;2363.8463499872455;2396.7243766966762;2397.137030668958;2399.4121440247163;2400.519896020794;2329.1615018593293;2337.4039619896903;2337.544178885118;2370.478494731165;2375.904963801446;2312.7802858728396;2316.1661801751357;2340.8595484271;2349.8472599281163;2354.9646755298686;2316.2703748319227;2381.392744850052;2381.4879800842727;2392.557376885282;2392.964105538418;8442.366822488339;8510.574471276412;8517.488950662919;8518.829623407559;8522.318214542822;5091.363579552556;5258.211268309746;5262.2632831403635;5264;5300.416954135042;3090.459169645303;3152.5271209318557;3348.614909285439;3362.260302733395;3369.4945758136478;1143.8398624192619;1149.8620165580185;1204.753025629744;1205.843240378754;1219.62191720566;10927.180461465421;11037.503312350884;11040.944795276053;11045.668629941034;11056.668299950934;4512.368268442421;4715.363425937455;4732.124556956974;4789.760511974388;4800.35195248637;9656.22750179984;9658.034196580425;9659.951700241454;9670.854937175947;9678.56446459911;5314.946850531523;5331.680099193984;5336.252924590561;5339;5346.492083252085;4068.4507591475362;4199.748015119103;4753.405824271966;4864.586510146677;4864.610831133572;3885.55316138642;3901.1027463683513;4004.5795191505053;4007.338789099824;4047.9392809107885;1293.4179619171412;1313.494304692681;1316.795896636023;1323.9602811915659;1328.7807511760645;877.8902637170354;911.2118017914456;922.3589605224439;930.945731340018;940.8118376324762;5447.319085114361;5583.911137328182;5607.299087614048;5632;5896.498797602166;548.700957977903;569.6781318555003;577.4687287695331;588.552699948034;590.4567797626195;3417.299453612053;3484.7212223022098;3559.199180184438;3571.6964058055355;3581.7850928944345;9802.95098524517;10220.284580079471;10255.641052563275;10298.536565854554;10308.32995855282;10115.443650599287;10236.744081397876;10245;10249.077583017564;10274.537645805956;7539.32146106853;7616.428767842323;7714.845703086019;7760.961195193875;7824.295813376823;5589;5607;5612.663240205437;5617.775288988395;5773.711314434346;9199.218066464426;9246.815063698554;9325.393849399767;9418.717438476582;9550.092741189575;9298.302627302844;9471.66849160276;9504.762380940532;9576.994415586263;9577.23382129414;6247;6570.638614876228;6827.180738311435;7325.377342925911;7331.083614548182;7270.091238595176;7739.729109481141;7924.683012679428;7971.963644726148;8110.5944702763445;7136.286371362822;7236.34872861445;7257.927420725725;7321.487495875238;7383.003294555167;7147.213806481387;7148.535345202546;7160.785176444715;7179.784606461814;7250.637468126467;6376.649284289409;6389.041643753474;6420.518461115342;6453.612783233021;6458.321876203119;4945.950540494549;5023.57299629521;5046.444891061907;5081.18701007837;5097.28637990689;4943.65394422387;4983.07813054586;5047.949520504748;5158.742062896765;5239.9782042502875 02:30:10 INFO - PROCESS | 1645 | |4;prototype.html;336.69865470404005;353.6746193501978;359.8290811864365;364.42420974859726;373.24604299315365;4804.471508134111;4916.337328690122;4959.504049595048;5424.403315635277;5574.916376254354;4766.665333706559;5232.555232805206;5278.173324339852;5416.702081385522;5474.671519708821;4232.619064284214;4247.171801498709;4266.146770645868;4307.461567304087;4316.330968699856;4224.838169503396;4260.254455470295;4269.380939763732;4274.145170965804;4328.783560821962;3646.4348026055873;4143.1713657268665;4223.366495025755;4253.80857861397;4273.465816772903;3699.6300369963055;4174.728642638249;4186.28833098374;4205.222033923734;4238.194742998836;3639.7452178347526;3736.215394767102;3745.232227393405;3746.587875333711;3768.491253680773;4579.305973696743;4871.658983871131;5314.893702125974;5339.46605339463;5343.625946183769;4893.804247830082;4909.901801963976;4922.26166075088;4929.556339929423;4945.604351651895;5090.770915308783;5245.396779370345;5321.973390133063;5729.627574207705;5787.247657804459;3927.5876033016407;4037.1128285617647;4059;4095.488063992001;4176.081262122329;5240.842774716726;5758.971205143989;5953.713326404982;6059.424354686298;6137.693115344215;4267.231898258281;4273.658107351404;4283.764392958417;4305.772854736448;4310.353446982977;3557.6086630470627;4084.1831633673382;4274.3374776909;4311.547287534764;4387.232234358974;4790.113828941588;4835.347228124158;4859.2954021666665;4871.8294859679745;4888.291197776373;5406.783728650888;5802.854928626818;5835.315754752861;5854.619449735838;5892.882142357129;1275.7129645829614;1312.9409176586885;1319.3535167767725;1331.9733605328033;1408.8802451791507;983.9852402213972;985.3388713210796;1003.7390278527636;1013.4881884648353;1019.2864994503877;4985.401751789808;5061.45625584193;5068.695878247317;5076.898462030738;5111.498623442953;5574.637648552913;5600.551955843523;5676.517496012802;5694.572907031989;5728.79949201776;4260.211860805699;4842.903141937141;5050.318207042076;5148.382194136728;5182.507661772125;2882.394697113588;2957.896473623413;2982.806117602349;3004.3991201759736;3045.74111200546;5273.841784746463;5584.162375643686;5702.486776190163;5759.280089988752;5997.290772129922;4780.569748722632;5034.546890779774;5463.934532766072;5523.917141242885;5859.648421094663;5142.6400151989;5583.804566840141;5924.682177980345;5928.881422371528;5938.317093534299;5093.770780314969;5170.948290517047;5209.817656382009;5287.308061420463;5734.19372897536;5492.642978206404;5911.704414779329;5947.702614869153;5964.83863552318;5967.433093856077;5572.665640061609;5805.883882322414;5939.3466718661775;6252.999520076766;6266;3584.283143371284;3853.2871418787613;3954.4859168309085;3959.3071212538266;4014.6386825185873;5879.823605291848;5883.146943693226;5908.763649453974;5944.494717949023;5967.671778052249;4924.552813030821;5180.7409629519125;5599.356074051536;5658.632188907708;5808.5353171747;5827.504662103769;5833.300003999547;5837.124431335334;5840.094785308284;5857.502112320501;5079.476157152765;5268.762905669178;5291.656042357235;5668;5680.4319568042865;4823.734694591831;5695.971520142372;5700.287464066992;5733.39799321082;5771.509421699203;4740.810367585396;5082.593392528663;5592.412796656293;5594.985390704927;5634.718264086861 02:30:10 INFO - PROCESS | 1645 | |5;yui.html;700.5761514283861;721.9566825990441;757.5568292548859;804.6017221475371;823.4482896459372;14734.926325368371;15699.97950133242;15727.292271847766;15749.448769293078;15787.605309867258;13511.527096551623;13856.792148117785;14317;14406.855931440683;14417.567472975801;849.464837152593;852.6887685994614;855.3883972959333;864.4726716702806;865.1651156633847;813.8331642013403;855.4653341661461;856.2935578148022;857.6655104509247;858.3991206155684;902.3142411767071;902.7111324376169;902.9097090290984;905.6875377994581;907.0249481807051;847.161310302802;898.2409863665192;899.0739538275586;900.7207765592622;901.3915606965305;667.7295695243434;668.8729141463107;670.9832254193635;671.2012704881175;671.6910221298209;11355.545778168864;13282.933585332012;13458.596242112751;13479.528216512474;13777.517786877512;11731.237469564536;11783.469743861548;11958.521659133625;12046.819297710541;12158.51365945361;10410.167186625127;10416.843747343795;10554.419506927115;10653.414062226575;10667.253292269545;3415.9829200853837;3459.41189997701;3612.4581312803025;3681.4845921571;3725.1618385863235;51565.742171288905;88416.55791721065;98242;99071.51392729115;111124.99999999919;11301.434928253555;11423.314601123793;11487.540498380138;11608.941955290169;11688.18182727218;23448.413789655053;23603;23894.402639934142;24123.75876241215;24133.51732965331;8021.679132834738;8022.2779949803635;8140.633671484798;8160.67357305713;8231.300339471212;4250.149970006011;4269.252880745919;4326.134773045404;4347.891302717458;4454.710443821141;3545.7517973742106;3644.872429464956;3649.3431182386894;3653.9634603654154;3655.83013435698;648.9902651460231;659.8449364399362;661.2957200581366;678.3013496099026;678.915135608049;674.4974993629679;694.9652517374111;706.7420391557148;711.4699548836047;740.8333125046821;9959.352642078387;10292.176625869912;10399.584016639401;10583.364998100138;10668.386245369778;644.7324360390479;651.1469974333638;660.6498555765452;670.2794495916909;696.9721211151497;4944.208926571731;4948.80461624494;5000.799968001312;5005.599552035828;5049.84850454487;89077.55461222652;91199.54400228089;95362.52318738501;96477.5176124115;97826.5108674452;56308.15537766937;57484;75030.8745368809;77069.2293077062;99069.51395729069;58695;62222;62810.371896281365;66557.66721166363;69793.65103174452;10562.630307939186;10703.785924281627;10817.18871084656;10837.45812709377;11294.322340659586;48167;48242;49501.75249123731;51110.744446279015;51531.104545068156;64044;64165;64596.385090373115;65936;66745.66508669897;12839.935800321313;12846.614601561969;12849.935750321189;12874.462026421412;13607.931960340135;14025.859741402455;14028.789568156282;14038.719225615634;14126.576202713935;15351.23243837826;12572.811407828707;13300.667483312607;13378.331083445983;13400.105324867553;13509.59471215865;13646.113002654796;13694.726105477635;13820.516281930084;14079.929600351932;14103;12139.75720485603;13262.734745304846;13369.53206637763;13489.527866524624;13686.589402317946;10941.890581094087;11110.283196478904;11199.21605487608;11275.267107637977;11594.01450876685;10077.798444031225;10716.73208169802;10860.891391085988;10868.891311087104;10899.182561308093 02:30:10 INFO - PROCESS | 1645 | __end_tp_report 02:30:10 INFO - PROCESS | 1645 | __start_cc_report 02:30:10 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1419 02:30:10 INFO - PROCESS | 1645 | __end_cc_report 02:30:10 INFO - PROCESS | 1645 | __startTimestamp1487241010978__endTimestamp 02:30:10 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | ------- Summary: start ------- 02:30:10 INFO - PROCESS | 1645 | Number of tests: 6 02:30:10 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5801.34 Median:6070.61 stddev:632.21 (10.4%) stddev-sans-first:604.08 02:30:10 INFO - PROCESS | 1645 | Values: 3345.5 3379.1 3385.7 3387.1 3421.8 5820.7 5874.6 5889.3 5915.0 5921.2 5792.1 5870.8 5871.4 5940.9 5941.1 5286.0 5301.3 5357.7 5377.7 5408.3 5221.9 5230.2 5244.3 5284.7 5406.3 5300.5 5333.7 5354.5 5378.7 5383.0 5357.9 5380.9 5380.9 5384.0 5390.7 5164.4 5191.0 5265.7 5328.4 5396.2 5763.0 5771.5 5779.7 5805.8 5813.9 6168.0 6214.9 6230.1 6244.8 6249.6 6245.7 6279.6 6294.2 6302.3 6303.8 5783.4 5835.9 5957.3 6033.4 6040.3 6251.6 6273.3 6300.8 6306.5 6412.8 6253.2 6270.1 6275.6 6282.7 6283.6 6188.7 6248.2 6267.1 6268.8 6277.0 6139.6 6196.9 6219.2 6284.6 6286.3 6188.6 6221.6 6232.3 6234.9 6267.9 5011.8 5074.6 5081.2 5091.9 5099.5 4545.4 4548.7 4551.1 4566.9 4584.0 5011.5 5723.9 5767.0 5774.8 5884.3 6201.6 6225.5 6229.9 6250.5 6267.2 4465.2 5741.8 5782.8 5795.7 5879.1 5557.7 5558.6 5565.4 5566.3 5580.9 6215.8 6240.1 6338.3 6470.2 6492.0 5424.0 6137.7 6173.0 6253.6 6256.1 6438.4 6443.7 6463.9 6467.8 6479.5 6119.3 6139.4 6252.0 6261.1 6272.7 5083.5 6035.3 6156.1 6166.9 6241.9 6070.6 6077.4 6084.8 6090.5 6258.6 6075.5 6082.5 6158.8 6192.3 6206.7 5989.9 6008.3 6015.7 6050.4 6132.0 6141.7 6146.7 6161.7 6165.8 6175.8 6084.1 6092.2 6094.9 6110.6 6132.9 02:30:10 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:64576.01 Median:37277.57 stddev:131621.68 (353.1%) stddev-sans-first:131902.88 02:30:10 INFO - PROCESS | 1645 | Values: 457.9 506.8 510.0 510.6 519.1 25387.5 40698.0 43179.4 43222.6 45406.3 44613.6 44778.8 44838.6 44904.0 45049.0 8489.1 8782.5 9245.1 9398.9 9576.3 8587.5 11463.8 11719.8 11741.1 11974.3 11621.3 11728.9 11739.1 11752.1 11758.2 8621.3 11594.2 11665.2 11673.2 11686.4 8667.9 11399.3 11506.7 11626.7 11681.3 41666.4 41899.6 42230.2 42232.0 42262.0 4000.4 4049.0 4057.7 4072.6 4088.1 29943.4 29982.6 29985.4 30614.7 30898.5 3013.0 3060.3 3163.5 3257.3 3261.9 365932.0 367683.2 367770.0 368030.0 368268.0 67249.7 67366.3 67686.0 67858.7 68052.0 60207.4 70046.6 72906.1 73017.0 73153.0 17105.2 17350.4 17384.6 17396.6 17400.4 10446.7 11926.0 13056.9 13153.7 13167.6 17076.1 17400.8 19180.0 19247.3 19255.6 7126.8 7146.2 7153.4 7236.7 7270.8 870.0 872.6 880.5 881.2 921.3 30634.5 30687.8 30743.0 31073.7 31080.8 997.7 1048.6 1053.4 1093.2 1103.6 15205.8 15885.1 15995.8 16305.4 16423.9 583734.0 587696.0 587772.0 588375.0 590799.0 62167.0 62356.4 62483.1 62514.4 62957.0 1421.7 1456.8 1472.1 1475.5 1485.1 27917.6 29813.9 29834.6 30398.0 30635.7 46508.0 54792.6 55467.4 55477.6 55600.7 501778.0 502940.0 504248.0 504792.0 505339.0 41843.2 42577.0 43008.6 43103.8 43391.8 46845.8 47709.0 49204.5 49547.8 49647.0 36178.0 36189.8 37803.8 39277.2 39306.0 30909.7 35656.3 35837.0 36960.8 37239.4 33924.3 36620.0 37315.7 37527.8 37606.2 31024.0 33298.8 33380.8 33410.8 33522.0 23937.8 24428.8 24448.0 24806.9 24999.5 02:30:10 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:38868.49 Median:26596.37 stddev:111920.16 (420.8%) stddev-sans-first:112196.80 02:30:10 INFO - PROCESS | 1645 | Values: 372.7 374.8 391.8 398.3 426.5 15016.6 15032.4 18078.4 20157.4 20492.2 20054.9 20469.0 20494.1 20806.4 21868.3 5244.3 5655.0 5677.1 5822.0 5976.3 4122.5 5746.6 5850.4 5854.0 5861.7 4310.0 5839.8 6369.4 6377.0 6435.8 5444.9 6348.2 6417.8 6440.0 6473.6 5622.0 5687.7 5696.2 5707.3 5710.8 25620.2 26488.6 26584.9 26607.9 26796.3 3079.8 3101.7 3102.8 3109.9 3164.3 14906.6 15196.5 15826.6 16514.6 16556.5 1754.9 1812.8 1816.7 1825.1 1861.9 124814.0 128908.0 133301.0 134197.0 135330.3 11639.6 11868.9 11964.0 12043.8 12197.0 15469.7 16182.6 16187.7 16210.7 16234.9 8427.6 8910.0 8973.2 9008.4 9134.1 8685.2 8693.3 8695.9 8853.9 8892.2 4064.3 4851.1 4873.7 4876.4 4934.2 2017.5 2020.6 2042.1 2054.9 2056.6 863.5 915.4 1005.4 1040.9 1042.6 21000.2 23233.8 23274.8 24125.4 24471.9 960.6 968.4 993.2 1004.2 1004.9 6784.3 6930.5 6938.6 7153.0 7170.1 412649.9 626582.0 729415.0 740942.0 749520.0 165057.0 167313.3 168474.0 169997.0 170060.2 965.1 1046.1 1078.2 1083.2 1097.6 19375.2 20249.4 20253.1 20325.3 20434.8 61124.0 61904.1 61968.7 61989.7 63749.0 80138.6 89764.3 90326.6 92286.1 93173.5 7938.5 8314.6 8677.3 8828.5 8912.6 11574.5 13069.6 13120.0 13507.6 13509.3 11278.3 11542.3 11557.2 11689.8 11868.6 9355.1 11236.3 11390.4 11727.0 11746.3 11375.3 11476.3 11645.0 11899.4 12025.8 8353.3 8485.2 8501.3 8547.9 8626.3 11429.5 11433.5 11494.4 11686.2 11813.7 02:30:10 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5483.85 Median:5260.24 stddev:3022.07 (57.5%) stddev-sans-first:3015.26 02:30:10 INFO - PROCESS | 1645 | Values: 1438.9 1438.9 1449.6 1454.7 1457.4 8196.8 8569.1 8574.2 8577.4 8601.8 7430.0 7694.9 8185.9 8388.6 8490.0 2337.1 2375.8 2379.8 2383.6 2384.3 2363.8 2396.7 2397.1 2399.4 2400.5 2329.2 2337.4 2337.5 2370.5 2375.9 2312.8 2316.2 2340.9 2349.8 2355.0 2316.3 2381.4 2381.5 2392.6 2393.0 8442.4 8510.6 8517.5 8518.8 8522.3 5091.4 5258.2 5262.3 5264.0 5300.4 3090.5 3152.5 3348.6 3362.3 3369.5 1143.8 1149.9 1204.8 1205.8 1219.6 10927.2 11037.5 11040.9 11045.7 11056.7 4512.4 4715.4 4732.1 4789.8 4800.4 9656.2 9658.0 9660.0 9670.9 9678.6 5314.9 5331.7 5336.3 5339.0 5346.5 4068.5 4199.7 4753.4 4864.6 4864.6 3885.6 3901.1 4004.6 4007.3 4047.9 1293.4 1313.5 1316.8 1324.0 1328.8 877.9 911.2 922.4 930.9 940.8 5447.3 5583.9 5607.3 5632.0 5896.5 548.7 569.7 577.5 588.6 590.5 3417.3 3484.7 3559.2 3571.7 3581.8 9803.0 10220.3 10255.6 10298.5 10308.3 10115.4 10236.7 10245.0 10249.1 10274.5 7539.3 7616.4 7714.8 7761.0 7824.3 5589.0 5607.0 5612.7 5617.8 5773.7 9199.2 9246.8 9325.4 9418.7 9550.1 9298.3 9471.7 9504.8 9577.0 9577.2 6247.0 6570.6 6827.2 7325.4 7331.1 7270.1 7739.7 7924.7 7972.0 8110.6 7136.3 7236.3 7257.9 7321.5 7383.0 7147.2 7148.5 7160.8 7179.8 7250.6 6376.6 6389.0 6420.5 6453.6 6458.3 4946.0 5023.6 5046.4 5081.2 5097.3 4943.7 4983.1 5047.9 5158.7 5240.0 02:30:10 INFO - PROCESS | 1645 | 02:30:10 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4656.61 Median:5078.19 stddev:1371.92 (27.0%) stddev-sans-first:1336.90 02:30:11 INFO - PROCESS | 1645 | Values: 336.7 353.7 359.8 364.4 373.2 4804.5 4916.3 4959.5 5424.4 5574.9 4766.7 5232.6 5278.2 5416.7 5474.7 4232.6 4247.2 4266.1 4307.5 4316.3 4224.8 4260.3 4269.4 4274.1 4328.8 3646.4 4143.2 4223.4 4253.8 4273.5 3699.6 4174.7 4186.3 4205.2 4238.2 3639.7 3736.2 3745.2 3746.6 3768.5 4579.3 4871.7 5314.9 5339.5 5343.6 4893.8 4909.9 4922.3 4929.6 4945.6 5090.8 5245.4 5322.0 5729.6 5787.2 3927.6 4037.1 4059.0 4095.5 4176.1 5240.8 5759.0 5953.7 6059.4 6137.7 4267.2 4273.7 4283.8 4305.8 4310.4 3557.6 4084.2 4274.3 4311.5 4387.2 4790.1 4835.3 4859.3 4871.8 4888.3 5406.8 5802.9 5835.3 5854.6 5892.9 1275.7 1312.9 1319.4 1332.0 1408.9 984.0 985.3 1003.7 1013.5 1019.3 4985.4 5061.5 5068.7 5076.9 5111.5 5574.6 5600.6 5676.5 5694.6 5728.8 4260.2 4842.9 5050.3 5148.4 5182.5 2882.4 2957.9 2982.8 3004.4 3045.7 5273.8 5584.2 5702.5 5759.3 5997.3 4780.6 5034.5 5463.9 5523.9 5859.6 5142.6 5583.8 5924.7 5928.9 5938.3 5093.8 5170.9 5209.8 5287.3 5734.2 5492.6 5911.7 5947.7 5964.8 5967.4 5572.7 5805.9 5939.3 6253.0 6266.0 3584.3 3853.3 3954.5 3959.3 4014.6 5879.8 5883.1 5908.8 5944.5 5967.7 4924.6 5180.7 5599.4 5658.6 5808.5 5827.5 5833.3 5837.1 5840.1 5857.5 5079.5 5268.8 5291.7 5668.0 5680.4 4823.7 5696.0 5700.3 5733.4 5771.5 4740.8 5082.6 5592.4 5595.0 5634.7 02:30:11 INFO - PROCESS | 1645 | 02:30:11 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:18843.67 Median:4259.70 stddev:25895.18 (607.9%) stddev-sans-first:25931.99 02:30:11 INFO - PROCESS | 1645 | Values: 700.6 722.0 757.6 804.6 823.4 14734.9 15700.0 15727.3 15749.4 15787.6 13511.5 13856.8 14317.0 14406.9 14417.6 849.5 852.7 855.4 864.5 865.2 813.8 855.5 856.3 857.7 858.4 902.3 902.7 902.9 905.7 907.0 847.2 898.2 899.1 900.7 901.4 667.7 668.9 671.0 671.2 671.7 11355.5 13282.9 13458.6 13479.5 13777.5 11731.2 11783.5 11958.5 12046.8 12158.5 10410.2 10416.8 10554.4 10653.4 10667.3 3416.0 3459.4 3612.5 3681.5 3725.2 51565.7 88416.6 98242.0 99071.5 111125.0 11301.4 11423.3 11487.5 11608.9 11688.2 23448.4 23603.0 23894.4 24123.8 24133.5 8021.7 8022.3 8140.6 8160.7 8231.3 4250.1 4269.3 4326.1 4347.9 4454.7 3545.8 3644.9 3649.3 3654.0 3655.8 649.0 659.8 661.3 678.3 678.9 674.5 695.0 706.7 711.5 740.8 9959.4 10292.2 10399.6 10583.4 10668.4 644.7 651.1 660.6 670.3 697.0 4944.2 4948.8 5000.8 5005.6 5049.8 89077.6 91199.5 95362.5 96477.5 97826.5 56308.2 57484.0 75030.9 77069.2 99069.5 58695.0 62222.0 62810.4 66557.7 69793.7 10562.6 10703.8 10817.2 10837.5 11294.3 48167.0 48242.0 49501.8 51110.7 51531.1 64044.0 64165.0 64596.4 65936.0 66745.7 12839.9 12846.6 12849.9 12874.5 13607.9 14025.9 14028.8 14038.7 14126.6 15351.2 12572.8 13300.7 13378.3 13400.1 13509.6 13646.1 13694.7 13820.5 14079.9 14103.0 12139.8 13262.7 13369.5 13489.5 13686.6 10941.9 11110.3 11199.2 11275.3 11594.0 10077.8 10716.7 10860.9 10868.9 10899.2 02:30:11 INFO - PROCESS | 1645 | -------- Summary: end -------- 02:30:11 INFO - PROCESS | 1645 | 02:30:11 INFO - TEST-INFO | 1645: exit 0 02:30:11 INFO - TEST-OK | dromaeo_css | took 1119675ms 02:30:11 INFO - TEST-START | kraken 02:30:11 INFO - operating with platform_type : mac_ 02:30:11 INFO - Initialising browser for kraken test... 02:30:11 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpItBlBB/profile http://localhost:49244/getInfo.html) 02:30:14 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 02:30:14 INFO - PROCESS | 1651 | colorDepth:24 02:30:14 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 02:30:14 INFO - PROCESS | 1651 | __metrics 02:30:14 INFO - PROCESS | 1651 | 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" 02:30:14 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:30:14 INFO - TEST-INFO | 1651: exit 0 02:30:14 INFO - Browser initialized. 02:30:14 INFO - Running cycle 1/1 for kraken test... 02:30:14 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpItBlBB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:27 INFO - PROCESS | 1653 | RSS: Main: 213495808 02:30:27 INFO - PROCESS | 1653 | 02:30:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 02:30:30 INFO - PROCESS | 1653 | RSS: Main: 265768960 02:30:30 INFO - PROCESS | 1653 | 02:30:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 02:30:33 INFO - PROCESS | 1653 | RSS: Main: 275677184 02:30:33 INFO - PROCESS | 1653 | 02:30:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 02:30:37 INFO - PROCESS | 1653 | RSS: Main: 372973568 02:30:37 INFO - PROCESS | 1653 | 02:30:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 02:30:40 INFO - PROCESS | 1653 | RSS: Main: 276873216 02:30:40 INFO - PROCESS | 1653 | 02:30:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:43 INFO - PROCESS | 1653 | RSS: Main: 278601728 02:30:43 INFO - PROCESS | 1653 | 02:30:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:46 INFO - PROCESS | 1653 | RSS: Main: 320053248 02:30:46 INFO - PROCESS | 1653 | 02:30:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:49 INFO - PROCESS | 1653 | RSS: Main: 318365696 02:30:49 INFO - PROCESS | 1653 | 02:30:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 02:30:53 INFO - PROCESS | 1653 | RSS: Main: 317751296 02:30:53 INFO - PROCESS | 1653 | 02:30:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:55 INFO - PROCESS | 1653 | RSS: Main: 294846464 02:30:55 INFO - PROCESS | 1653 | 02:30:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:58 INFO - PROCESS | 1653 | RSS: Main: 296476672 02:30:58 INFO - PROCESS | 1653 | 02:31:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:31:00 INFO - PROCESS | 1653 | RSS: Main: 299577344 02:31:00 INFO - PROCESS | 1653 | 02:31:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:31:04 INFO - PROCESS | 1653 | RSS: Main: 318119936 02:31:04 INFO - PROCESS | 1653 | 02:31:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:31:08 INFO - PROCESS | 1653 | RSS: Main: 311885824 02:31:08 INFO - PROCESS | 1653 | 02:31:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 02:31:10 INFO - PROCESS | 1653 | RSS: Main: 356741120 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | __start_tp_report 02:31:10 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 02:31:10 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 02:31:10 INFO - PROCESS | 1653 | |i|pagename|runs| 02:31:10 INFO - PROCESS | 1653 | |0;ai-astar;115;112;115;115;115;114;113;115;114;114 02:31:10 INFO - PROCESS | 1653 | |1;audio-beat-detection;137;109;110;143;111;107;108;107;128;107 02:31:10 INFO - PROCESS | 1653 | |2;audio-dft;184;185;184;184;185;182;187;182;183;183 02:31:10 INFO - PROCESS | 1653 | |3;audio-fft;81;57;71;112;85;75;58;58;77;49 02:31:10 INFO - PROCESS | 1653 | |4;audio-oscillator;83;72;87;69;68;70;106;94;78;81 02:31:10 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;91;88;91;89;91;88;91;89;91;87 02:31:10 INFO - PROCESS | 1653 | |6;imaging-darkroom;97;97;97;97;97;96;97;97;97;96 02:31:10 INFO - PROCESS | 1653 | |7;imaging-desaturate;84;85;87;85;88;85;85;87;88;84 02:31:10 INFO - PROCESS | 1653 | |8;json-parse-financial;56;54;53;53;55;58;57;56;56;57 02:31:10 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;64;71;73;73;71;69;68;68;70;70 02:31:10 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;84;84;84;82;82;81;83;86;84;88 02:31:10 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;137;137;137;136;136;141;140;142;191;163 02:31:10 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;237;166;165;168;168;168;166;167;170;165 02:31:10 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;64;66;64;64;65;67;75;80;81 02:31:10 INFO - PROCESS | 1653 | __end_tp_report 02:31:10 INFO - PROCESS | 1653 | __start_cc_report 02:31:10 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2169 02:31:10 INFO - PROCESS | 1653 | __end_cc_report 02:31:10 INFO - PROCESS | 1653 | __startTimestamp1487241070190__endTimestamp 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | ------- Summary: start ------- 02:31:10 INFO - PROCESS | 1653 | Number of tests: 14 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 02:31:10 INFO - PROCESS | 1653 | Values: 115.0 112.0 115.0 115.0 115.0 114.0 113.0 115.0 114.0 114.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:116.70 Median:110.50 stddev:13.85 (12.5%) stddev-sans-first:12.59 02:31:10 INFO - PROCESS | 1653 | Values: 137.0 109.0 110.0 143.0 111.0 107.0 108.0 107.0 128.0 107.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.52 (0.8%) stddev-sans-first:1.62 02:31:10 INFO - PROCESS | 1653 | Values: 184.0 185.0 184.0 184.0 185.0 182.0 187.0 182.0 183.0 183.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:72.30 Median:73.00 stddev:18.35 (25.1%) stddev-sans-first:19.19 02:31:10 INFO - PROCESS | 1653 | Values: 81.0 57.0 71.0 112.0 85.0 75.0 58.0 58.0 77.0 49.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:79.50 stddev:12.28 (15.4%) stddev-sans-first:13.00 02:31:10 INFO - PROCESS | 1653 | Values: 83.0 72.0 87.0 69.0 68.0 70.0 106.0 94.0 78.0 81.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:91.00 stddev:1.58 (1.7%) stddev-sans-first:1.59 02:31:10 INFO - PROCESS | 1653 | Values: 91.0 88.0 91.0 89.0 91.0 88.0 91.0 89.0 91.0 87.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:97.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:31:10 INFO - PROCESS | 1653 | Values: 97.0 97.0 97.0 97.0 97.0 96.0 97.0 97.0 97.0 96.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.50 02:31:10 INFO - PROCESS | 1653 | Values: 84.0 85.0 87.0 85.0 88.0 85.0 85.0 87.0 88.0 84.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.72 (3.1%) stddev-sans-first:1.81 02:31:10 INFO - PROCESS | 1653 | Values: 56.0 54.0 53.0 53.0 55.0 58.0 57.0 56.0 56.0 57.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.50 stddev:2.67 (3.8%) stddev-sans-first:1.87 02:31:10 INFO - PROCESS | 1653 | Values: 64.0 71.0 73.0 73.0 71.0 69.0 68.0 68.0 70.0 70.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:2.04 (2.4%) stddev-sans-first:2.17 02:31:10 INFO - PROCESS | 1653 | Values: 84.0 84.0 84.0 82.0 82.0 81.0 83.0 86.0 84.0 88.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:140.50 stddev:17.75 (12.6%) stddev-sans-first:18.52 02:31:10 INFO - PROCESS | 1653 | Values: 137.0 137.0 137.0 136.0 136.0 141.0 140.0 142.0 191.0 163.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:168.00 stddev:22.19 (13.2%) stddev-sans-first:1.66 02:31:10 INFO - PROCESS | 1653 | Values: 237.0 166.0 165.0 168.0 168.0 168.0 166.0 167.0 170.0 165.0 02:31:10 INFO - PROCESS | 1653 | 02:31:10 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:67.00 stddev:6.73 (10.1%) stddev-sans-first:7.09 02:31:10 INFO - PROCESS | 1653 | Values: 67.0 64.0 66.0 64.0 64.0 65.0 67.0 75.0 80.0 81.0 02:31:10 INFO - PROCESS | 1653 | -------- Summary: end -------- 02:31:10 INFO - PROCESS | 1653 | 02:31:11 INFO - TEST-INFO | 1653: exit 0 02:31:11 INFO - TEST-OK | kraken | took 59599ms 02:31:11 INFO - SUITE-END | took 1179s 02:31:11 INFO - Completed test suite (00:19:39) 02:31:11 INFO - javascript benchmark 02:31:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.5316255724197, 3379.138319728469, 3385.6952874241297, 3387.1193489692682, 3421.81180035098, 5820.708964551766, 5874.618149820264, 5889.2932848058235, 5915.0, 5921.20063791388, 5792.131180322954, 5870.823875283749, 5871.442212989759, 5940.940590594104, 5941.108833674951, 5285.99566082445, 5301.284326615915, 5357.705326207057, 5377.704226267554, 5408.296921400212, 5221.869453263661, 5230.2416149658275, 5244.265802787613, 5284.709340986245, 5406.324209473816, 5300.522952934235, 5333.653312534692, 5354.544863686572, 5378.704171270579, 5382.9730851345685, 5357.946420535784, 5380.892382152355, 5380.946190538084, 5383.950129724705, 5390.677439403356, 5164.354455693038, 5191.0, 5265.6840589564745, 5328.387235467932, 5396.19057141428, 5762.971185144047, 5771.451712087345, 5779.653220806765, 5805.767769289266, 5813.88372232553, 6168.0439531872635, 6214.875702485971, 6230.127782110508, 6244.781432649836, 6249.625022498664, 6245.687715614246, 6279.560430769848, 6294.181756371689, 6302.275238347557, 6303.779367722108, 5783.3638299787835, 5835.854103647443, 5957.285125784933, 6033.3664965178905, 6040.275166979946, 6251.562390632703, 6273.341299163613, 6300.842478938063, 6306.527010474141, 6412.775552855627, 6253.218347706536, 6270.122182894398, 6275.560710750295, 6282.685865706696, 6283.622982621057, 6188.659623720739, 6248.156498872685, 6267.122602835607, 6268.811935641938, 6276.968615156895, 6139.566483661902, 6196.938030619726, 6219.222597175353, 6284.591501552384, 6286.308506064329, 6188.628682279078, 6221.564490485713, 6232.3144454110015, 6234.875302493925, 6267.934451143316, 5011.84964451067, 5074.644774865724, 5081.161608334657, 5091.872703182376, 5099.515546023122, 4545.409096817459, 4548.681592288508, 4551.089782043605, 4566.908661826811, 4584.0, 5011.473795251446, 5723.856903577361, 5767.04843700793, 5774.826755197267, 5884.264466941632, 6201.56589038772, 6225.501959843202, 6229.906551401733, 6250.531210159256, 6267.185265915493, 4465.24090904547, 5741.8277451675685, 5782.7686892523825, 5795.681237531976, 5879.147523609138, 5557.722113894289, 5558.555315574744, 5565.387807341189, 5566.304211973504, 5580.86047848807, 6215.81352559424, 6240.063990401476, 6338.271098823694, 6470.22357317125, 6491.967540162269, 5424.0, 6137.683438940172, 6172.969135154295, 6253.5935164216, 6256.124142619946, 6438.356164383712, 6443.742250309935, 6463.935360646334, 6467.7736279231885, 6479.4816414685765, 6119.258838874149, 6139.4001448444, 6251.9687401562705, 6261.092141639528, 6272.749090036347, 5083.517065878736, 6035.275766907824, 6156.107364432221, 6166.938330616636, 6241.937580624136, 6070.605410648293, 6077.4226448487325, 6084.756609735561, 6090.482309003607, 6258.624482531062, 6075.513958883367, 6082.452579267887, 6158.784442544489, 6192.349803270592, 6206.658633775186, 5989.940100599112, 6008.279006519246, 6015.699215039143, 6050.42520960508, 6131.96934015327, 6141.680461099834, 6146.661933593696, 6161.661108639068, 6165.784197553064, 6175.752969881154, 6084.056971169476, 6092.238470191226, 6094.886873317944, 6110.572259941761, 6132.8773424532155], "value": 5762.338504144719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.91299653065914, 506.7694199139392, 509.964302498825, 510.5991796439795, 519.0760446405397, 25387.492250154985, 40698.0, 43179.35230971534, 43222.56777432225, 45406.318905216365, 44613.55386446135, 44778.776106119425, 44838.55161448393, 44904.0, 45049.0, 8489.066202717697, 8782.473051616891, 9245.07549245077, 9398.906010939889, 9576.281778866578, 8587.52768597727, 11463.828042579325, 11719.765604687902, 11741.119416043832, 11974.281543107398, 11621.302721836717, 11728.944395004448, 11739.11956603254, 11752.118591105658, 11758.17692761507, 8621.267192288664, 11594.188406811527, 11665.183437159401, 11673.241239319417, 11686.357250351228, 8667.869981950276, 11399.316041037564, 11506.654800356002, 11626.709332266677, 11681.299122052704, 41666.37500437496, 41899.58100418987, 42230.155396892194, 42232.0, 42262.0, 4000.439279581489, 4048.9595104048876, 4057.7159598828093, 4072.572379900127, 4088.100617864065, 29943.40113197724, 29982.550261745873, 29985.40029199404, 30614.693853061628, 30898.53652195219, 3013.0, 3060.3114299282706, 3163.4780261256865, 3257.332246889382, 3261.9184520386943, 365932.0, 367683.1615841904, 367770.0, 368029.9999999973, 368268.0, 67249.65500689959, 67366.32633673698, 67686.0, 67858.66070669713, 68052.0, 60207.397926021054, 70046.64976675084, 72906.0837566502, 73017.0, 73153.0, 17105.23026463812, 17350.39273625417, 17384.5653858652, 17396.565085872953, 17400.39098631567, 10446.68659940203, 11926.0, 13056.934715326552, 13153.67115822093, 13167.60497185086, 17076.12532136481, 17400.825991740174, 19180.040997950327, 19247.326343577908, 19255.56800534689, 7126.786196414116, 7146.213916469184, 7153.35619794221, 7236.674349654173, 7270.818229544304, 869.9913000870037, 872.6081899370494, 880.5113162194915, 881.2113158722907, 921.2721949659827, 30634.54048189279, 30687.8465607675, 30743.0, 31073.68926310753, 31080.844595776878, 997.7455748784014, 1048.5858086056119, 1053.3627155570769, 1093.1582681335328, 1103.624767579027, 15205.847941520444, 15885.126318052618, 15995.840041599435, 16305.429309974332, 16423.91788041052, 583734.0, 587696.0, 587772.0, 588375.0, 590799.0, 62167.0, 62356.376436235965, 62483.12550623489, 62514.374856251765, 62957.0, 1421.6943357178257, 1456.8324642666016, 1472.0505274098361, 1475.4983305676337, 1485.0569888120906, 27917.58123628188, 29813.850930745208, 29834.55248171236, 30398.0, 30635.693643063285, 46508.0, 54792.63018424571, 55467.44532554623, 55477.61305967383, 55600.72199638976, 501778.0, 502940.0, 504248.0, 504792.0, 505339.0, 41843.163136737705, 42577.0, 43008.56991430045, 43103.7844810774, 43391.78304108459, 46845.765771170925, 47709.0, 49204.507954919995, 49547.76130596764, 49647.0, 36178.0, 36189.819050904574, 37803.810980944916, 39277.2144557113, 39306.01734956649, 30909.690903090683, 35656.286874262885, 35837.0, 36960.815195923846, 37239.441408378356, 33924.3215135691, 36620.0, 37315.6939507116, 37527.81236093802, 37606.2478750418, 31024.0, 33298.834540791926, 33380.833095834365, 33410.832945835115, 33522.0, 23937.760622393555, 24428.75571244265, 24448.0, 24806.875965620777, 24999.50001000006], "value": 20500.38582601337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.6552938531858, 374.78449891312505, 391.823679344295, 398.3228511530397, 426.53720713026365, 15016.57285190343, 15032.398704051839, 18078.367257146, 20157.395278141677, 20492.180312787506, 20054.89972550139, 20468.976551172418, 20494.077766500504, 20806.375808725723, 21868.343949681494, 5244.265802787594, 5655.0, 5677.063284558053, 5822.010258256086, 5976.312724036748, 4122.525909520398, 5746.597738158331, 5850.444207800252, 5854.034084376073, 5861.736221870026, 4309.987153019038, 5839.766409343642, 6369.426751592356, 6377.0, 6435.806925792233, 5444.915570923887, 6348.238211414614, 6417.807465776011, 6440.0, 6473.611583305017, 5621.971890140523, 5687.7156142192725, 5696.231008813798, 5707.315122185323, 5710.8001219957105, 25620.23139305824, 26488.60267095995, 26584.867075664497, 26607.866960665266, 26796.330091747863, 3079.8306093164865, 3101.720845123927, 3102.751779857606, 3109.8600562974493, 3164.256399746058, 14906.627334316621, 15196.544103676908, 15826.604334891605, 16514.58713532159, 16556.50330490087, 1754.8596112310984, 1812.8005919348861, 1816.6548355812354, 1825.1330617956496, 1861.9348322808771, 124814.0, 128908.0, 133301.0, 134197.0, 135330.32334838362, 11639.59261425846, 11868.940655296668, 11964.0, 12043.819342709867, 12197.0, 15469.690606187813, 16182.595435114215, 16187.676246475005, 16210.67578648444, 16234.918825405797, 8427.578621068922, 8909.955450222837, 8973.237274831581, 9008.369414141078, 9134.132257435533, 8685.174908383693, 8693.304535637133, 8695.913040869636, 8853.911460885438, 8892.199702026848, 4064.349704047338, 4851.054044461367, 4873.658843880894, 4876.414830220397, 4934.235193545006, 2017.5057111007898, 2020.5554777948828, 2042.1423002339054, 2054.856160068781, 2056.5578400643935, 863.5250612163285, 915.4141349536302, 1005.3666190300211, 1040.9011143941314, 1042.6246551241547, 21000.159993600086, 23233.7676623235, 23274.767252327598, 24125.39686507816, 24471.87764061168, 960.6109525642127, 968.4286271100085, 993.2252842782641, 1004.1665417703289, 1004.9196064314983, 6784.287649796799, 6930.514863959575, 6938.618375989268, 7153.0, 7170.103737032871, 412649.9367503143, 626582.0, 729415.0, 740942.0, 749520.0, 165057.0, 167313.3268667322, 168474.0, 169997.0, 170060.19759209492, 965.1458459263603, 1046.1160319529986, 1078.1698092468755, 1083.1713738989679, 1097.6432659385732, 19375.20721683649, 20249.39251822448, 20253.088611012834, 20325.288614898407, 20434.79565204329, 61124.0, 61904.07143892935, 61968.69015654893, 61989.690051549456, 63749.0, 80138.5993070031, 89764.30707078798, 90326.64510032223, 92286.07713922775, 93173.53413233161, 7938.483998540077, 8314.625841837253, 8677.305815534615, 8828.514431706319, 8912.55437228123, 11574.479148438171, 13069.607911762663, 13120.0, 13507.594772156852, 13509.324533773075, 11278.266912650652, 11542.307461552333, 11557.239015176216, 11689.824652630048, 11868.58459953932, 9355.06449355059, 11236.325820450798, 11390.37352945596, 11727.0, 11746.29522228669, 11375.26060806045, 11476.311421314747, 11645.0, 11899.405029748652, 12025.819612705642, 8353.33173346143, 8485.151484851465, 8501.322083543912, 8547.914520854712, 8626.309895208242, 11429.485673144562, 11433.542658293907, 11494.425278735862, 11686.24039437434, 11813.704657383634], "value": 10088.558305516228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.8561044044377, 1438.8776953958914, 1449.572376149036, 1454.6726986428052, 1457.4461704552268, 8196.836063278732, 8569.100244474334, 8574.18545238203, 8577.39958202926, 8601.784955376119, 7429.962850185741, 7694.88457673134, 8185.9181408185905, 8388.580570971442, 8489.957550212255, 2337.100216416679, 2375.7861792438675, 2379.8453100548495, 2383.6305372667266, 2384.332386931653, 2363.8463499872455, 2396.7243766966762, 2397.137030668958, 2399.4121440247163, 2400.519896020794, 2329.1615018593293, 2337.4039619896903, 2337.544178885118, 2370.478494731165, 2375.904963801446, 2312.7802858728396, 2316.1661801751357, 2340.8595484271, 2349.8472599281163, 2354.9646755298686, 2316.2703748319227, 2381.392744850052, 2381.4879800842727, 2392.557376885282, 2392.964105538418, 8442.366822488339, 8510.574471276412, 8517.488950662919, 8518.829623407559, 8522.318214542822, 5091.363579552556, 5258.211268309746, 5262.2632831403635, 5264.0, 5300.416954135042, 3090.459169645303, 3152.5271209318557, 3348.614909285439, 3362.260302733395, 3369.4945758136478, 1143.8398624192619, 1149.8620165580185, 1204.753025629744, 1205.843240378754, 1219.62191720566, 10927.180461465421, 11037.503312350884, 11040.944795276053, 11045.668629941034, 11056.668299950934, 4512.368268442421, 4715.363425937455, 4732.124556956974, 4789.760511974388, 4800.35195248637, 9656.22750179984, 9658.034196580425, 9659.951700241454, 9670.854937175947, 9678.56446459911, 5314.946850531523, 5331.680099193984, 5336.252924590561, 5339.0, 5346.492083252085, 4068.4507591475362, 4199.748015119103, 4753.405824271966, 4864.586510146677, 4864.610831133572, 3885.55316138642, 3901.1027463683513, 4004.5795191505053, 4007.338789099824, 4047.9392809107885, 1293.4179619171412, 1313.494304692681, 1316.795896636023, 1323.9602811915659, 1328.7807511760645, 877.8902637170354, 911.2118017914456, 922.3589605224439, 930.945731340018, 940.8118376324762, 5447.319085114361, 5583.911137328182, 5607.299087614048, 5632.0, 5896.498797602166, 548.700957977903, 569.6781318555003, 577.4687287695331, 588.552699948034, 590.4567797626195, 3417.299453612053, 3484.7212223022098, 3559.199180184438, 3571.6964058055355, 3581.7850928944345, 9802.95098524517, 10220.284580079471, 10255.641052563275, 10298.536565854554, 10308.32995855282, 10115.443650599287, 10236.744081397876, 10245.0, 10249.077583017564, 10274.537645805956, 7539.32146106853, 7616.428767842323, 7714.845703086019, 7760.961195193875, 7824.295813376823, 5589.0, 5607.0, 5612.663240205437, 5617.775288988395, 5773.711314434346, 9199.218066464426, 9246.815063698554, 9325.393849399767, 9418.717438476582, 9550.092741189575, 9298.302627302844, 9471.66849160276, 9504.762380940532, 9576.994415586263, 9577.23382129414, 6247.0, 6570.638614876228, 6827.180738311435, 7325.377342925911, 7331.083614548182, 7270.091238595176, 7739.729109481141, 7924.683012679428, 7971.963644726148, 8110.5944702763445, 7136.286371362822, 7236.34872861445, 7257.927420725725, 7321.487495875238, 7383.003294555167, 7147.213806481387, 7148.535345202546, 7160.785176444715, 7179.784606461814, 7250.637468126467, 6376.649284289409, 6389.041643753474, 6420.518461115342, 6453.612783233021, 6458.321876203119, 4945.950540494549, 5023.57299629521, 5046.444891061907, 5081.18701007837, 5097.28637990689, 4943.65394422387, 4983.07813054586, 5047.949520504748, 5158.742062896765, 5239.9782042502875], "value": 4406.566893188966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.69865470404005, 353.6746193501978, 359.8290811864365, 364.42420974859726, 373.24604299315365, 4804.471508134111, 4916.337328690122, 4959.504049595048, 5424.403315635277, 5574.916376254354, 4766.665333706559, 5232.555232805206, 5278.173324339852, 5416.702081385522, 5474.671519708821, 4232.619064284214, 4247.171801498709, 4266.146770645868, 4307.461567304087, 4316.330968699856, 4224.838169503396, 4260.254455470295, 4269.380939763732, 4274.145170965804, 4328.783560821962, 3646.4348026055873, 4143.1713657268665, 4223.366495025755, 4253.80857861397, 4273.465816772903, 3699.6300369963055, 4174.728642638249, 4186.28833098374, 4205.222033923734, 4238.194742998836, 3639.7452178347526, 3736.215394767102, 3745.232227393405, 3746.587875333711, 3768.491253680773, 4579.305973696743, 4871.658983871131, 5314.893702125974, 5339.46605339463, 5343.625946183769, 4893.804247830082, 4909.901801963976, 4922.26166075088, 4929.556339929423, 4945.604351651895, 5090.770915308783, 5245.396779370345, 5321.973390133063, 5729.627574207705, 5787.247657804459, 3927.5876033016407, 4037.1128285617647, 4059.0, 4095.488063992001, 4176.081262122329, 5240.842774716726, 5758.971205143989, 5953.713326404982, 6059.424354686298, 6137.693115344215, 4267.231898258281, 4273.658107351404, 4283.764392958417, 4305.772854736448, 4310.353446982977, 3557.6086630470627, 4084.1831633673382, 4274.3374776909, 4311.547287534764, 4387.232234358974, 4790.113828941588, 4835.347228124158, 4859.2954021666665, 4871.8294859679745, 4888.291197776373, 5406.783728650888, 5802.854928626818, 5835.315754752861, 5854.619449735838, 5892.882142357129, 1275.7129645829614, 1312.9409176586885, 1319.3535167767725, 1331.9733605328033, 1408.8802451791507, 983.9852402213972, 985.3388713210796, 1003.7390278527636, 1013.4881884648353, 1019.2864994503877, 4985.401751789808, 5061.45625584193, 5068.695878247317, 5076.898462030738, 5111.498623442953, 5574.637648552913, 5600.551955843523, 5676.517496012802, 5694.572907031989, 5728.79949201776, 4260.211860805699, 4842.903141937141, 5050.318207042076, 5148.382194136728, 5182.507661772125, 2882.394697113588, 2957.896473623413, 2982.806117602349, 3004.3991201759736, 3045.74111200546, 5273.841784746463, 5584.162375643686, 5702.486776190163, 5759.280089988752, 5997.290772129922, 4780.569748722632, 5034.546890779774, 5463.934532766072, 5523.917141242885, 5859.648421094663, 5142.6400151989, 5583.804566840141, 5924.682177980345, 5928.881422371528, 5938.317093534299, 5093.770780314969, 5170.948290517047, 5209.817656382009, 5287.308061420463, 5734.19372897536, 5492.642978206404, 5911.704414779329, 5947.702614869153, 5964.83863552318, 5967.433093856077, 5572.665640061609, 5805.883882322414, 5939.3466718661775, 6252.999520076766, 6266.0, 3584.283143371284, 3853.2871418787613, 3954.4859168309085, 3959.3071212538266, 4014.6386825185873, 5879.823605291848, 5883.146943693226, 5908.763649453974, 5944.494717949023, 5967.671778052249, 4924.552813030821, 5180.7409629519125, 5599.356074051536, 5658.632188907708, 5808.5353171747, 5827.504662103769, 5833.300003999547, 5837.124431335334, 5840.094785308284, 5857.502112320501, 5079.476157152765, 5268.762905669178, 5291.656042357235, 5668.0, 5680.4319568042865, 4823.734694591831, 5695.971520142372, 5700.287464066992, 5733.39799321082, 5771.509421699203, 4740.810367585396, 5082.593392528663, 5592.412796656293, 5594.985390704927, 5634.718264086861], "value": 4232.442739987072, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5761514283861, 721.9566825990441, 757.5568292548859, 804.6017221475371, 823.4482896459372, 14734.926325368371, 15699.97950133242, 15727.292271847766, 15749.448769293078, 15787.605309867258, 13511.527096551623, 13856.792148117785, 14317.0, 14406.855931440683, 14417.567472975801, 849.464837152593, 852.6887685994614, 855.3883972959333, 864.4726716702806, 865.1651156633847, 813.8331642013403, 855.4653341661461, 856.2935578148022, 857.6655104509247, 858.3991206155684, 902.3142411767071, 902.7111324376169, 902.9097090290984, 905.6875377994581, 907.0249481807051, 847.161310302802, 898.2409863665192, 899.0739538275586, 900.7207765592622, 901.3915606965305, 667.7295695243434, 668.8729141463107, 670.9832254193635, 671.2012704881175, 671.6910221298209, 11355.545778168864, 13282.933585332012, 13458.596242112751, 13479.528216512474, 13777.517786877512, 11731.237469564536, 11783.469743861548, 11958.521659133625, 12046.819297710541, 12158.51365945361, 10410.167186625127, 10416.843747343795, 10554.419506927115, 10653.414062226575, 10667.253292269545, 3415.9829200853837, 3459.41189997701, 3612.4581312803025, 3681.4845921571, 3725.1618385863235, 51565.742171288905, 88416.55791721065, 98242.0, 99071.51392729115, 111124.99999999919, 11301.434928253555, 11423.314601123793, 11487.540498380138, 11608.941955290169, 11688.18182727218, 23448.413789655053, 23603.0, 23894.402639934142, 24123.75876241215, 24133.51732965331, 8021.679132834738, 8022.2779949803635, 8140.633671484798, 8160.67357305713, 8231.300339471212, 4250.149970006011, 4269.252880745919, 4326.134773045404, 4347.891302717458, 4454.710443821141, 3545.7517973742106, 3644.872429464956, 3649.3431182386894, 3653.9634603654154, 3655.83013435698, 648.9902651460231, 659.8449364399362, 661.2957200581366, 678.3013496099026, 678.915135608049, 674.4974993629679, 694.9652517374111, 706.7420391557148, 711.4699548836047, 740.8333125046821, 9959.352642078387, 10292.176625869912, 10399.584016639401, 10583.364998100138, 10668.386245369778, 644.7324360390479, 651.1469974333638, 660.6498555765452, 670.2794495916909, 696.9721211151497, 4944.208926571731, 4948.80461624494, 5000.799968001312, 5005.599552035828, 5049.84850454487, 89077.55461222652, 91199.54400228089, 95362.52318738501, 96477.5176124115, 97826.5108674452, 56308.15537766937, 57484.0, 75030.8745368809, 77069.2293077062, 99069.51395729069, 58695.0, 62222.0, 62810.371896281365, 66557.66721166363, 69793.65103174452, 10562.630307939186, 10703.785924281627, 10817.18871084656, 10837.45812709377, 11294.322340659586, 48167.0, 48242.0, 49501.75249123731, 51110.744446279015, 51531.104545068156, 64044.0, 64165.0, 64596.385090373115, 65936.0, 66745.66508669897, 12839.935800321313, 12846.614601561969, 12849.935750321189, 12874.462026421412, 13607.931960340135, 14025.859741402455, 14028.789568156282, 14038.719225615634, 14126.576202713935, 15351.23243837826, 12572.811407828707, 13300.667483312607, 13378.331083445983, 13400.105324867553, 13509.59471215865, 13646.113002654796, 13694.726105477635, 13820.516281930084, 14079.929600351932, 14103.0, 12139.75720485603, 13262.734745304846, 13369.53206637763, 13489.527866524624, 13686.589402317946, 10941.890581094087, 11110.283196478904, 11199.21605487608, 11275.267107637977, 11594.01450876685, 10077.798444031225, 10716.73208169802, 10860.891391085988, 10868.891311087104, 10899.182561308093], "value": 7363.545872587517, "unit": "score"}], "name": "dromaeo_css", "value": 7396.097547735256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 115.0, 115.0, 115.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 109.0, 110.0, 143.0, 111.0, 107.0, 108.0, 107.0, 128.0, 107.0], "value": 116.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 184.0, 185.0, 182.0, 187.0, 182.0, 183.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 71.0, 112.0, 85.0, 75.0, 58.0, 58.0, 77.0, 49.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 72.0, 87.0, 69.0, 68.0, 70.0, 106.0, 94.0, 78.0, 81.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 91.0, 88.0, 91.0, 89.0, 91.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 87.0, 85.0, 88.0, 85.0, 85.0, 87.0, 88.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 53.0, 55.0, 58.0, 57.0, 56.0, 56.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 73.0, 73.0, 71.0, 69.0, 68.0, 68.0, 70.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 82.0, 82.0, 81.0, 83.0, 86.0, 84.0, 88.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 137.0, 136.0, 136.0, 141.0, 140.0, 142.0, 191.0, 163.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [237.0, 166.0, 165.0, 168.0, 168.0, 168.0, 166.0, 167.0, 170.0, 165.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 64.0, 64.0, 65.0, 67.0, 75.0, 80.0, 81.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1438.3999999999999, "alertThreshold": 2.0}]} 02:31:11 INFO - Return code: 0 02:31:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:31:11 ERROR - # TBPL SUCCESS # 02:31:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:31:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:31:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:31:11 INFO - 2017-02-16 02:31:11.483 screenresolution[1657:10564] starting screenresolution argv=screenresolution get 02:31:11 INFO - 2017-02-16 02:31:11.485 screenresolution[1657:10564] Display 0: 1600x1200x32@60 02:31:11 INFO - 2017-02-16 02:31:11.492 screenresolution[1658:10567] starting screenresolution argv=screenresolution list 02:31:11 INFO - Available Modes on Display 0 02:31:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:31:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:31:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:31:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:31:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:31:11 INFO - Intel Iris: 02:31:11 INFO - Chipset Model: Intel Iris 02:31:11 INFO - Type: GPU 02:31:11 INFO - Bus: Built-In 02:31:11 INFO - VRAM (Dynamic, Max): 1536 MB 02:31:11 INFO - Vendor: Intel (0x8086) 02:31:11 INFO - Device ID: 0x0a2e 02:31:11 INFO - Revision ID: 0x0009 02:31:11 INFO - Displays: 02:31:11 INFO - Display: 02:31:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:31:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:31:11 INFO - Display Serial Number: 1600x1200 60 02:31:11 INFO - Main Display: Yes 02:31:11 INFO - Mirror: Off 02:31:11 INFO - Online: Yes 02:31:11 INFO - Rotation: Supported 02:31:11 INFO - Return code: 0 02:31:11 INFO - Running post-action listener: _resource_record_post_action 02:31:11 INFO - [mozharness: 2017-02-16 10:31:11.737621Z] Finished run-tests step (success) 02:31:11 INFO - Running post-run listener: _resource_record_post_run 02:31:11 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 32603136; Write bytes: 510366720; Read time: 207; Write time: 1620 02:31:11 INFO - TinderboxPrint: CPU usage
53.8% 02:31:11 INFO - TinderboxPrint: I/O read bytes / time
32,603,136 / 207 02:31:11 INFO - TinderboxPrint: I/O write bytes / time
510,366,720 / 1,620 02:31:11 INFO - TinderboxPrint: CPU idle
2,218.1 (46.2%) 02:31:11 INFO - TinderboxPrint: CPU system
959.3 (20.0%) 02:31:11 INFO - TinderboxPrint: CPU user
1,625.2 (33.8%) 02:31:11 INFO - TinderboxPrint: Swap in / out
235,958,272 / 0 02:31:11 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 201261568; Write bytes: 200095744; Read time: 15662; Write time: 445 02:31:11 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31677440; Write bytes: 300448768; Read time: 197; Write time: 1140 02:31:12 INFO - Running post-run listener: _upload_blobber_files 02:31:12 INFO - Blob upload gear active. 02:31:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:31:12 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 02:31:12 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'] 02:31:12 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 02:31:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:13 INFO - (blobuploader) - INFO - Done attempting. 02:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:14 INFO - (blobuploader) - INFO - Done attempting. 02:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:15 INFO - (blobuploader) - INFO - Done attempting. 02:31:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:17 INFO - (blobuploader) - INFO - Done attempting. 02:31:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:31:17 INFO - Return code: 0 02:31:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:31:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:31:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4870ef75ed4e88a4c3d392a57afa2b247a25f8c45340d2a6e645e81a4c01f2efeb108b9d8aa62158405c26cd2da5de0de8f28b5e8d8419cc7d1cbb3292b9101c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83759874a906671ad5990243a832e1dfbec0ff197b8af4449955af33c8c5a0a5226c42de92a00bb2bb273eb88f55a625cb96b4bf28a650e826d68944fe13aef8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e63780f8570db80e73fd68eee7fbfab5e1fcb2013aff74398ca281b69d240a1d97faf725f23dd08c3387fa12bbbe51a5423a5773d583192743444a10ece43592", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6831553f547aff83ad3d6b74ff8b43f6e913a0289a140a639887b908d5e9ee40018e1511d769814b0840e3de514f2ae8e6222040d83c754f8c1dbb9546722971"} 02:31:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:31:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:31:17 INFO - Contents: 02:31:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4870ef75ed4e88a4c3d392a57afa2b247a25f8c45340d2a6e645e81a4c01f2efeb108b9d8aa62158405c26cd2da5de0de8f28b5e8d8419cc7d1cbb3292b9101c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83759874a906671ad5990243a832e1dfbec0ff197b8af4449955af33c8c5a0a5226c42de92a00bb2bb273eb88f55a625cb96b4bf28a650e826d68944fe13aef8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e63780f8570db80e73fd68eee7fbfab5e1fcb2013aff74398ca281b69d240a1d97faf725f23dd08c3387fa12bbbe51a5423a5773d583192743444a10ece43592", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6831553f547aff83ad3d6b74ff8b43f6e913a0289a140a639887b908d5e9ee40018e1511d769814b0840e3de514f2ae8e6222040d83c754f8c1dbb9546722971"} 02:31:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:31:17 INFO - Copying logs to upload dir... 02:31:17 INFO - mkdir: /builds/slave/test/build/upload/logs 02:31:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1385.791304 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2017-02-16 02:31:17.782892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 02:31:17.786860) ========= 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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/4870ef75ed4e88a4c3d392a57afa2b247a25f8c45340d2a6e645e81a4c01f2efeb108b9d8aa62158405c26cd2da5de0de8f28b5e8d8419cc7d1cbb3292b9101c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83759874a906671ad5990243a832e1dfbec0ff197b8af4449955af33c8c5a0a5226c42de92a00bb2bb273eb88f55a625cb96b4bf28a650e826d68944fe13aef8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e63780f8570db80e73fd68eee7fbfab5e1fcb2013aff74398ca281b69d240a1d97faf725f23dd08c3387fa12bbbe51a5423a5773d583192743444a10ece43592", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6831553f547aff83ad3d6b74ff8b43f6e913a0289a140a639887b908d5e9ee40018e1511d769814b0840e3de514f2ae8e6222040d83c754f8c1dbb9546722971"} build_url:https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/WxbVlR6BQKy-v8X7bLZBlg/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/4870ef75ed4e88a4c3d392a57afa2b247a25f8c45340d2a6e645e81a4c01f2efeb108b9d8aa62158405c26cd2da5de0de8f28b5e8d8419cc7d1cbb3292b9101c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83759874a906671ad5990243a832e1dfbec0ff197b8af4449955af33c8c5a0a5226c42de92a00bb2bb273eb88f55a625cb96b4bf28a650e826d68944fe13aef8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e63780f8570db80e73fd68eee7fbfab5e1fcb2013aff74398ca281b69d240a1d97faf725f23dd08c3387fa12bbbe51a5423a5773d583192743444a10ece43592", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6831553f547aff83ad3d6b74ff8b43f6e913a0289a140a639887b908d5e9ee40018e1511d769814b0840e3de514f2ae8e6222040d83c754f8c1dbb9546722971"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 02:31:17.821326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 02:31:17.821676) ========= 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.kw6ey6X3IO/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.DMz9lQgaIf/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005139 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 02:31:17.870255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 02:31:17.870593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 02:31:17.870915) ========= ========= Total master_lag: 0.42 =========