builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0305 starttime: 1491348864.83 results: success (0) buildid: 20170404152627 builduid: 75b81a29690541b0bd1366d28b4b3254 revision: 29eab893bad014e0e9e6af3df255230e2abebad5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:24.834535) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:24.835088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:24.835438) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:24.862713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:24.863125) ========= 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.YyERXokh9f/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.VcaV2L90tv/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-04 16:34:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 197M=0s 2017-04-04 16:34:25 (197 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147499 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:25.036139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:25.036645) ========= 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.YyERXokh9f/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.VcaV2L90tv/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.026685 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:25.086963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 16:34:25.087349) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29eab893bad014e0e9e6af3df255230e2abebad5 --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 29eab893bad014e0e9e6af3df255230e2abebad5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YyERXokh9f/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.VcaV2L90tv/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-04 16:34:25,192 truncating revision to first 12 chars 2017-04-04 16:34:25,192 Setting DEBUG logging. 2017-04-04 16:34:25,192 attempt 1/10 2017-04-04 16:34:25,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/29eab893bad0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 16:34:26,806 unpacking tar archive at: mozilla-aurora-29eab893bad0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.883692 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 16:34:26.995908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:26.996700) ========= script_repo_revision: 29eab893bad014e0e9e6af3df255230e2abebad5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:26.997692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:26.998510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 16:34:27.020853) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-04 16:34:27.021549) ========= /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.YyERXokh9f/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.VcaV2L90tv/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:34:27 INFO - MultiFileLogger online at 20170404 16:34:27 in /builds/slave/test 16:34:27 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 16:34:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:34:27 INFO - {'append_to_log': False, 16:34:27 INFO - 'base_work_dir': '/builds/slave/test', 16:34:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:34:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:34:27 INFO - 'branch': 'Mozilla-Aurora', 16:34:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:27 INFO - 'config_files': ('talos/mac_config.py',), 16:34:27 INFO - 'default_actions': ('clobber', 16:34:27 INFO - 'read-buildbot-config', 16:34:27 INFO - 'download-and-extract', 16:34:27 INFO - 'populate-webroot', 16:34:27 INFO - 'create-virtualenv', 16:34:27 INFO - 'install', 16:34:27 INFO - 'run-tests'), 16:34:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:27 INFO - 'download_minidump_stackwalk': True, 16:34:27 INFO - 'download_symbols': 'ondemand', 16:34:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:27 INFO - 'gecko_profile': False, 16:34:27 INFO - 'gecko_profile_interval': 0, 16:34:27 INFO - 'installer_path': 'installer.exe', 16:34:27 INFO - 'log_level': 'info', 16:34:27 INFO - 'log_name': 'talos', 16:34:27 INFO - 'log_to_console': True, 16:34:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:34:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:34:27 INFO - 'opt_config_files': (), 16:34:27 INFO - 'pip_index': False, 16:34:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:27 INFO - 'cmd': ('bash', 16:34:27 INFO - '-c', 16:34:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:27 INFO - 'enabled': True, 16:34:27 INFO - 'halt_on_failure': False, 16:34:27 INFO - 'name': 'check_screen_resolution'},), 16:34:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:27 INFO - 'cmd': ('bash', 16:34:27 INFO - '-c', 16:34:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:27 INFO - 'enabled': True, 16:34:27 INFO - 'halt_on_failure': False, 16:34:27 INFO - 'name': 'check_screen_resolution'},), 16:34:27 INFO - 'run_cmd_checks_enabled': True, 16:34:27 INFO - 'suite': 'dromaeojs', 16:34:27 INFO - 'system_bits': '32', 16:34:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:27 INFO - 'title': 't-yosemite-r7-0305', 16:34:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:27 INFO - 'use_talos_json': True, 16:34:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:34:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:27 INFO - 'work_dir': 'build'} 16:34:27 INFO - [mozharness: 2017-04-04 23:34:27.231721Z] Running clobber step. 16:34:27 INFO - Running pre-action listener: _resource_record_pre_action 16:34:27 INFO - Running main action method: clobber 16:34:27 INFO - rmtree: /builds/slave/test/build 16:34:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:34:29 INFO - Running post-action listener: _resource_record_post_action 16:34:29 INFO - [mozharness: 2017-04-04 23:34:29.710702Z] Finished clobber step (success) 16:34:29 INFO - [mozharness: 2017-04-04 23:34:29.710825Z] Running read-buildbot-config step. 16:34:29 INFO - Running pre-action listener: _resource_record_pre_action 16:34:29 INFO - Running main action method: read_buildbot_config 16:34:29 INFO - Using buildbot properties: 16:34:29 INFO - { 16:34:29 INFO - "project": "", 16:34:29 INFO - "product": "firefox", 16:34:29 INFO - "script_repo_revision": "production", 16:34:29 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:34:29 INFO - "repository": "", 16:34:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:34:29 INFO - "buildid": "20170404152627", 16:34:29 INFO - "pgo_build": "False", 16:34:29 INFO - "basedir": "/builds/slave/test", 16:34:29 INFO - "buildnumber": 7, 16:34:29 INFO - "slavename": "t-yosemite-r7-0305", 16:34:29 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:34:29 INFO - "platform": "yosemite_r7", 16:34:29 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:34:29 INFO - "branch": "mozilla-aurora", 16:34:29 INFO - "repo_path": "releases/mozilla-aurora", 16:34:29 INFO - "revision": "29eab893bad014e0e9e6af3df255230e2abebad5", 16:34:29 INFO - "stage_platform": "macosx64", 16:34:29 INFO - "builduid": "75b81a29690541b0bd1366d28b4b3254", 16:34:29 INFO - "slavebuilddir": "test" 16:34:29 INFO - } 16:34:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 16:34:29 INFO - Running post-action listener: _resource_record_post_action 16:34:29 INFO - [mozharness: 2017-04-04 23:34:29.714233Z] Finished read-buildbot-config step (success) 16:34:29 INFO - [mozharness: 2017-04-04 23:34:29.714364Z] Running download-and-extract step. 16:34:29 INFO - Running pre-action listener: _resource_record_pre_action 16:34:29 INFO - Running main action method: download_and_extract 16:34:29 INFO - mkdir: /builds/slave/test/build/tests 16:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:29 INFO - trying https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 16:34:29 INFO - Downloading https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 16:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 16:34:30 INFO - Downloaded 1199 bytes. 16:34:30 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 16:34:30 INFO - Using the following test package requirements: 16:34:30 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 16:34:30 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 16:34:30 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 16:34:30 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'jsshell-mac.zip'], 16:34:30 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 16:34:30 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 16:34:30 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 16:34:30 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 16:34:30 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 16:34:30 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 16:34:30 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 16:34:30 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:34:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 16:34:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:34:30 INFO - Fetch https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 16:34:32 INFO - Expected file size: 51790807 16:34:32 INFO - Obtained file size: 51790807 16:34:47 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:34:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 16:34:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:34:47 INFO - Fetch https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 16:34:50 INFO - Expected file size: 51790807 16:34:50 INFO - Obtained file size: 51790807 16:35:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 16:35:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:35:05 INFO - Fetch https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 16:35:06 INFO - Expected file size: 14404438 16:35:06 INFO - Obtained file size: 14404438 16:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:07 INFO - trying https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 16:35:07 INFO - Downloading https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 16:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 16:35:09 INFO - Downloaded 74681179 bytes. 16:35:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 16:35:09 INFO - mkdir: /builds/slave/test/properties 16:35:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:09 INFO - Contents: 16:35:09 INFO - build_url:https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 16:35:09 INFO - Running post-action listener: _resource_record_post_action 16:35:09 INFO - Running post-action listener: set_extra_try_arguments 16:35:09 INFO - [mozharness: 2017-04-04 23:35:09.832325Z] Finished download-and-extract step (success) 16:35:09 INFO - [mozharness: 2017-04-04 23:35:09.832448Z] Running populate-webroot step. 16:35:09 INFO - Running pre-action listener: _resource_record_pre_action 16:35:09 INFO - Running main action method: populate_webroot 16:35:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:09 INFO - '--tppagecycles', 16:35:09 INFO - '7'], 16:35:09 INFO - 'tests': ['tsvgm']}}, 16:35:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:35:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:35:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:35:09 INFO - 'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:35:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:35:09 INFO - 'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['damp', 'tps']}, 16:35:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:35:09 INFO - 'tests': ['damp', 'tps']}, 16:35:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['dromaeo_dom']}, 16:35:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['basic_compositor_video']}, 16:35:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:35:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['a11yr', 16:35:09 INFO - 'ts_paint', 16:35:09 INFO - 'tpaint', 16:35:09 INFO - 'sessionrestore', 16:35:09 INFO - 'sessionrestore_no_auto_restore', 16:35:09 INFO - 'tabpaint']}, 16:35:09 INFO - 'other-e10s': {'tests': ['a11yr', 16:35:09 INFO - 'ts_paint', 16:35:09 INFO - 'tpaint', 16:35:09 INFO - 'sessionrestore', 16:35:09 INFO - 'sessionrestore_no_auto_restore', 16:35:09 INFO - 'tabpaint']}, 16:35:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:35:09 INFO - 'ts_paint', 16:35:09 INFO - 'tpaint', 16:35:09 INFO - 'sessionrestore', 16:35:09 INFO - 'sessionrestore_no_auto_restore', 16:35:09 INFO - 'tabpaint']}, 16:35:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:35:09 INFO - 'ts_paint', 16:35:09 INFO - 'tpaint', 16:35:09 INFO - 'sessionrestore', 16:35:09 INFO - 'sessionrestore_no_auto_restore', 16:35:09 INFO - 'tabpaint']}, 16:35:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['a11yr', 16:35:09 INFO - 'ts_paint', 16:35:09 INFO - 'tpaint', 16:35:09 INFO - 'sessionrestore', 16:35:09 INFO - 'sessionrestore_no_auto_restore', 16:35:09 INFO - 'tabpaint']}, 16:35:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['a11yr', 16:35:09 INFO - 'ts_paint', 16:35:09 INFO - 'tpaint', 16:35:09 INFO - 'sessionrestore', 16:35:09 INFO - 'sessionrestore_no_auto_restore', 16:35:09 INFO - 'tabpaint']}, 16:35:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['tsvgx', 16:35:09 INFO - 'tsvgr_opacity', 16:35:09 INFO - 'tart', 16:35:09 INFO - 'tscrollx', 16:35:09 INFO - 'cart', 16:35:09 INFO - 'tsvg_static']}, 16:35:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:35:09 INFO - 'tsvgr_opacity', 16:35:09 INFO - 'tart', 16:35:09 INFO - 'tscrollx', 16:35:09 INFO - 'cart', 16:35:09 INFO - 'tsvg_static']}, 16:35:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:35:09 INFO - 'talos_options': ['--disable-e10s'], 16:35:09 INFO - 'tests': ['tp5o']}, 16:35:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:35:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:35:09 INFO - 'talos_options': ['--disable-e10s', 16:35:09 INFO - '--xperf_path', 16:35:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:09 INFO - 'tests': ['tp5n']}, 16:35:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:35:09 INFO - 'talos_options': ['--xperf_path', 16:35:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:09 INFO - 'tests': ['tp5n']}}, 16:35:09 INFO - 'talos.zip': {'path': '', 16:35:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:09 INFO - Running post-action listener: _resource_record_post_action 16:35:09 INFO - [mozharness: 2017-04-04 23:35:09.851010Z] Finished populate-webroot step (success) 16:35:09 INFO - [mozharness: 2017-04-04 23:35:09.851151Z] Running create-virtualenv step. 16:35:09 INFO - Running pre-action listener: _resource_record_pre_action 16:35:09 INFO - Running main action method: create_virtualenv 16:35:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:09 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 16:35:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:09 INFO - Using real prefix '/tools/python27' 16:35:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:13 INFO - Installing pip.................done. 16:35:13 INFO - Return code: 0 16:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:35:13 INFO - Reading from file tmpfile_stdout 16:35:13 INFO - Output received: 16:35:13 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) 16:35:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35:13 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')]} 16:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:13 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')]} 16:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:13 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:13 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 16:35:13 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 16:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:13 INFO - 'HOME': '/Users/cltbld', 16:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:13 INFO - 'LOGNAME': 'cltbld', 16:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:13 INFO - 'MOZ_NO_REMOTE': '1', 16:35:13 INFO - 'NO_EM_RESTART': '1', 16:35:13 INFO - 'PAGER': '/bin/cat', 16:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:13 INFO - 'PWD': '/builds/slave/test', 16:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:13 INFO - 'SHELL': '/bin/bash', 16:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:13 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:13 INFO - 'USER': 'cltbld', 16:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:13 INFO - 'XPC_FLAGS': '0x0', 16:35:13 INFO - 'XPC_SERVICE_NAME': '0', 16:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:14 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 16:35:14 INFO - Cleaning up... 16:35:14 INFO - Return code: 0 16:35:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:14 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:14 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 16:35:14 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 16:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:14 INFO - 'HOME': '/Users/cltbld', 16:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:14 INFO - 'LOGNAME': 'cltbld', 16:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:14 INFO - 'MOZ_NO_REMOTE': '1', 16:35:14 INFO - 'NO_EM_RESTART': '1', 16:35:14 INFO - 'PAGER': '/bin/cat', 16:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:14 INFO - 'PWD': '/builds/slave/test', 16:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:14 INFO - 'SHELL': '/bin/bash', 16:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:14 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:14 INFO - 'USER': 'cltbld', 16:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:14 INFO - 'XPC_FLAGS': '0x0', 16:35:14 INFO - 'XPC_SERVICE_NAME': '0', 16:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:14 INFO - Downloading/unpacking psutil>=3.1.1 16:35:14 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 16:35:14 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 16:35:14 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 16:35:14 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 16:35:14 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 16:35:14 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 16:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:35:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:17 INFO - Installing collected packages: psutil 16:35:17 INFO - Running setup.py install for psutil 16:35:17 INFO - building 'psutil._psutil_osx' extension 16:35:17 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 16:35:18 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 16:35:18 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 16:35:18 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 16:35:18 INFO - building 'psutil._psutil_posix' extension 16:35:18 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 16:35:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:35:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:35:18 INFO - ^ 16:35:18 INFO - 1 warning generated. 16:35:18 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 16:35:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:18 INFO - Successfully installed psutil 16:35:18 INFO - Cleaning up... 16:35:19 INFO - Return code: 0 16:35:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:35: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 mozsystemmonitor==0.3 16:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:19 INFO - 'HOME': '/Users/cltbld', 16:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:19 INFO - 'LOGNAME': 'cltbld', 16:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:19 INFO - 'MOZ_NO_REMOTE': '1', 16:35:19 INFO - 'NO_EM_RESTART': '1', 16:35:19 INFO - 'PAGER': '/bin/cat', 16:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:19 INFO - 'PWD': '/builds/slave/test', 16:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:19 INFO - 'SHELL': '/bin/bash', 16:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:19 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:19 INFO - 'USER': 'cltbld', 16:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:19 INFO - 'XPC_FLAGS': '0x0', 16:35:19 INFO - 'XPC_SERVICE_NAME': '0', 16:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:35:19 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 16:35:19 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 16:35:19 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 16:35:19 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 16:35:19 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 16:35:19 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 16:35:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:35:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:35:22 INFO - Installing collected packages: mozsystemmonitor 16:35:22 INFO - Running setup.py install for mozsystemmonitor 16:35:22 INFO - Successfully installed mozsystemmonitor 16:35:22 INFO - Cleaning up... 16:35:22 INFO - Return code: 0 16:35:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:35:22 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')]} 16:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:22 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')]} 16:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:35:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:23 INFO - 'HOME': '/Users/cltbld', 16:35:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:23 INFO - 'LOGNAME': 'cltbld', 16:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:23 INFO - 'MOZ_NO_REMOTE': '1', 16:35:23 INFO - 'NO_EM_RESTART': '1', 16:35:23 INFO - 'PAGER': '/bin/cat', 16:35:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:23 INFO - 'PWD': '/builds/slave/test', 16:35:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:23 INFO - 'SHELL': '/bin/bash', 16:35:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:23 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:23 INFO - 'USER': 'cltbld', 16:35:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:23 INFO - 'XPC_FLAGS': '0x0', 16:35:23 INFO - 'XPC_SERVICE_NAME': '0', 16:35:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:23 INFO - Downloading/unpacking jsonschema==2.5.1 16:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:35:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:35:26 INFO - warning: no files found matching '*.txt' 16:35:26 INFO - no previously-included directories found matching 'build' 16:35:26 INFO - no previously-included directories found matching 'dist' 16:35:26 INFO - no previously-included directories found matching '.git*' 16:35:26 INFO - Installing collected packages: jsonschema, functools32 16:35:26 INFO - Running setup.py install for functools32 16:35:27 INFO - warning: no files found matching '*.txt' 16:35:27 INFO - no previously-included directories found matching 'build' 16:35:27 INFO - no previously-included directories found matching 'dist' 16:35:27 INFO - no previously-included directories found matching '.git*' 16:35:27 INFO - Successfully installed jsonschema functools32 16:35:27 INFO - Cleaning up... 16:35:27 INFO - Return code: 0 16:35:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:35:27 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')]} 16:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:27 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')]} 16:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:27 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:27 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 16:35:27 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 16:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:27 INFO - 'HOME': '/Users/cltbld', 16:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:27 INFO - 'LOGNAME': 'cltbld', 16:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:27 INFO - 'MOZ_NO_REMOTE': '1', 16:35:27 INFO - 'NO_EM_RESTART': '1', 16:35:27 INFO - 'PAGER': '/bin/cat', 16:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:27 INFO - 'PWD': '/builds/slave/test', 16:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:27 INFO - 'SHELL': '/bin/bash', 16:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:27 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:27 INFO - 'USER': 'cltbld', 16:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:27 INFO - 'XPC_FLAGS': '0x0', 16:35:27 INFO - 'XPC_SERVICE_NAME': '0', 16:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:35:27 INFO - Cleaning up... 16:35:27 INFO - Return code: 0 16:35:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:35:27 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')]} 16:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:27 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')]} 16:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:27 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:27 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 16:35:27 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 16:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:27 INFO - 'HOME': '/Users/cltbld', 16:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:27 INFO - 'LOGNAME': 'cltbld', 16:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:27 INFO - 'MOZ_NO_REMOTE': '1', 16:35:27 INFO - 'NO_EM_RESTART': '1', 16:35:27 INFO - 'PAGER': '/bin/cat', 16:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:27 INFO - 'PWD': '/builds/slave/test', 16:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:27 INFO - 'SHELL': '/bin/bash', 16:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:27 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:27 INFO - 'USER': 'cltbld', 16:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:27 INFO - 'XPC_FLAGS': '0x0', 16:35:27 INFO - 'XPC_SERVICE_NAME': '0', 16:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:27 INFO - Downloading/unpacking blobuploader==1.2.4 16:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:35:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:35:30 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 16:35:30 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 16:35:30 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 16:35:30 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 16:35:30 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 16:35:30 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 16:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:35:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:31 INFO - Downloading docopt-0.6.1.tar.gz 16:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:35:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:35:31 INFO - Running setup.py install for blobuploader 16:35:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:35:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:35:31 INFO - Running setup.py install for requests 16:35:32 INFO - Running setup.py install for docopt 16:35:32 INFO - Successfully installed blobuploader requests docopt 16:35:32 INFO - Cleaning up... 16:35:32 INFO - Return code: 0 16:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:32 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')]} 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:32 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')]} 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:32 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:32 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 16:35:32 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 16:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:32 INFO - 'HOME': '/Users/cltbld', 16:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:32 INFO - 'LOGNAME': 'cltbld', 16:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:32 INFO - 'MOZ_NO_REMOTE': '1', 16:35:32 INFO - 'NO_EM_RESTART': '1', 16:35:32 INFO - 'PAGER': '/bin/cat', 16:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:32 INFO - 'PWD': '/builds/slave/test', 16:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:32 INFO - 'SHELL': '/bin/bash', 16:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:32 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:32 INFO - 'USER': 'cltbld', 16:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:32 INFO - 'XPC_FLAGS': '0x0', 16:35:32 INFO - 'XPC_SERVICE_NAME': '0', 16:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:32 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-oRicRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-jou_J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XnBU9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-pk1cdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-MOvo2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-b_0RJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-NE6XxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Mgxh85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XGn_PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-6ckjq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:33 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-iwmQwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:34 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-mR0jmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:34 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-vYAycM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:34 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-PtU0g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:34 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-WhH8Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:34 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-hrHAXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:34 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-tRJrCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:35:34 INFO - Running setup.py install for manifestparser 16:35:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:35:34 INFO - Running setup.py install for mozcrash 16:35:34 INFO - Running setup.py install for mozdebug 16:35:35 INFO - Running setup.py install for mozdevice 16:35:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Running setup.py install for mozfile 16:35:35 INFO - Running setup.py install for mozhttpd 16:35:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Running setup.py install for mozinfo 16:35:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Running setup.py install for mozInstall 16:35:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:35:35 INFO - Running setup.py install for mozleak 16:35:36 INFO - Running setup.py install for mozlog 16:35:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Running setup.py install for moznetwork 16:35:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Running setup.py install for mozprocess 16:35:36 INFO - Running setup.py install for mozprofile 16:35:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Running setup.py install for mozrunner 16:35:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Running setup.py install for mozscreenshot 16:35:36 INFO - Running setup.py install for moztest 16:35:37 INFO - Running setup.py install for mozversion 16:35:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:35:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:35:37 INFO - Cleaning up... 16:35:37 INFO - Return code: 0 16:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:37 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')]} 16:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:37 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')]} 16:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:37 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:37 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 16:35:37 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 16:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:37 INFO - 'HOME': '/Users/cltbld', 16:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:37 INFO - 'LOGNAME': 'cltbld', 16:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:37 INFO - 'MOZ_NO_REMOTE': '1', 16:35:37 INFO - 'NO_EM_RESTART': '1', 16:35:37 INFO - 'PAGER': '/bin/cat', 16:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:37 INFO - 'PWD': '/builds/slave/test', 16:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:37 INFO - 'SHELL': '/bin/bash', 16:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:37 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:37 INFO - 'USER': 'cltbld', 16:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:37 INFO - 'XPC_FLAGS': '0x0', 16:35:37 INFO - 'XPC_SERVICE_NAME': '0', 16:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:37 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-77JsBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:37 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)) 16:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:37 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-YgLBZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:37 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)) 16:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:37 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-JgARqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:37 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)) 16:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:37 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-e8iQUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:37 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)) 16:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ggU3Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-x00bb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-PdaWGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-088KjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-7MZ6FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-98nDDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-YM5I8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-INBfdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-bGAcQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:38 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)) 16:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:38 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-5Fy7A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:39 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)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:39 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-AOZNLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:39 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)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:39 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-HJ9xyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:39 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)) 16:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:39 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-TjnM98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:39 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)) 16:35:39 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)) 16:35:39 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)) 16:35:39 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)) 16:35:39 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)) 16:35:39 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)) 16:35:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:41 INFO - Downloading blessings-1.6.tar.gz 16:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:42 INFO - Installing collected packages: blessings 16:35:42 INFO - Running setup.py install for blessings 16:35:42 INFO - Successfully installed blessings 16:35:42 INFO - Cleaning up... 16:35:42 INFO - Return code: 0 16:35:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:42 INFO - Reading from file tmpfile_stdout 16:35:42 INFO - Current package versions: 16:35:42 INFO - blessings == 1.6 16:35:42 INFO - blobuploader == 1.2.4 16:35:42 INFO - docopt == 0.6.1 16:35:42 INFO - functools32 == 3.2.3-2 16:35:42 INFO - jsonschema == 2.5.1 16:35:42 INFO - manifestparser == 1.1 16:35:42 INFO - mozInstall == 1.12 16:35:42 INFO - mozcrash == 1.0 16:35:42 INFO - mozdebug == 0.1 16:35:42 INFO - mozdevice == 0.49 16:35:42 INFO - mozfile == 1.2 16:35:42 INFO - mozhttpd == 0.7 16:35:42 INFO - mozinfo == 0.9 16:35:42 INFO - mozleak == 0.1 16:35:42 INFO - mozlog == 3.4 16:35:42 INFO - moznetwork == 0.27 16:35:42 INFO - mozprocess == 0.25 16:35:42 INFO - mozprofile == 0.28 16:35:42 INFO - mozrunner == 6.13 16:35:42 INFO - mozscreenshot == 0.1 16:35:42 INFO - mozsystemmonitor == 0.3 16:35:42 INFO - moztest == 0.8 16:35:42 INFO - mozversion == 1.4 16:35:42 INFO - psutil == 3.1.1 16:35:42 INFO - requests == 1.2.3 16:35:42 INFO - wsgiref == 0.1.2 16:35:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:42 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')]} 16:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:42 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')]} 16:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:42 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:42 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 16:35:42 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 16:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:42 INFO - 'HOME': '/Users/cltbld', 16:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:42 INFO - 'LOGNAME': 'cltbld', 16:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:42 INFO - 'MOZ_NO_REMOTE': '1', 16:35:42 INFO - 'NO_EM_RESTART': '1', 16:35:42 INFO - 'PAGER': '/bin/cat', 16:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:42 INFO - 'PWD': '/builds/slave/test', 16:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:42 INFO - 'SHELL': '/bin/bash', 16:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:42 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:42 INFO - 'USER': 'cltbld', 16:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:42 INFO - 'XPC_FLAGS': '0x0', 16:35:42 INFO - 'XPC_SERVICE_NAME': '0', 16:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 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)) 16:35:42 INFO - Cleaning up... 16:35:42 INFO - Return code: 0 16:35:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:35:42 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')]} 16:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:42 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')]} 16:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:42 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 0x10a924b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a927768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc408c9f500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, '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.YyERXokh9f/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.VcaV2L90tv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 16:35:42 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 16:35:42 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 16:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:42 INFO - 'HOME': '/Users/cltbld', 16:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:42 INFO - 'LOGNAME': 'cltbld', 16:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:42 INFO - 'MOZ_NO_REMOTE': '1', 16:35:42 INFO - 'NO_EM_RESTART': '1', 16:35:42 INFO - 'PAGER': '/bin/cat', 16:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:42 INFO - 'PWD': '/builds/slave/test', 16:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:42 INFO - 'SHELL': '/bin/bash', 16:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:35:42 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:42 INFO - 'USER': 'cltbld', 16:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:42 INFO - 'XPC_FLAGS': '0x0', 16:35:42 INFO - 'XPC_SERVICE_NAME': '0', 16:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:35:43 INFO - Cleaning up... 16:35:43 INFO - Return code: 0 16:35:43 INFO - Running post-action listener: _resource_record_post_action 16:35:43 INFO - Running post-action listener: _start_resource_monitoring 16:35:43 INFO - Starting resource monitoring. 16:35:43 INFO - [mozharness: 2017-04-04 23:35:43.168270Z] Finished create-virtualenv step (success) 16:35:43 INFO - [mozharness: 2017-04-04 23:35:43.169225Z] Running install step. 16:35:43 INFO - Running pre-action listener: _resource_record_pre_action 16:35:43 INFO - Running main action method: install 16:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:43 INFO - Reading from file tmpfile_stdout 16:35:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:43 INFO - Reading from file tmpfile_stdout 16:35:43 INFO - Output received: 16:35:43 INFO - Usage: mozinstall [options] installer 16:35:43 INFO - Options: 16:35:43 INFO - -h, --help show this help message and exit 16:35:43 INFO - -d DEST, --destination=DEST 16:35:43 INFO - Directory to install application into. [default: 16:35:43 INFO - "/builds/slave/test"] 16:35:43 INFO - --app=APP Application being installed. [default: firefox] 16:35:43 INFO - mkdir: /builds/slave/test/build/application 16:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:36:03 INFO - Reading from file tmpfile_stdout 16:36:03 INFO - Output received: 16:36:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:36:03 INFO - Running post-action listener: _resource_record_post_action 16:36:03 INFO - [mozharness: 2017-04-04 23:36:03.920057Z] Finished install step (success) 16:36:03 INFO - [mozharness: 2017-04-04 23:36:03.920224Z] Running run-tests step. 16:36:03 INFO - Running pre-action listener: _resource_record_pre_action 16:36:03 INFO - Running main action method: run_tests 16:36:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:03 INFO - 2017-04-04 16:36:03.934 screenresolution[1624:7426] starting screenresolution argv=screenresolution get 16:36:03 INFO - 2017-04-04 16:36:03.937 screenresolution[1624:7426] Display 0: 1600x1200x32@60 16:36:03 INFO - 2017-04-04 16:36:03.942 screenresolution[1625:7429] starting screenresolution argv=screenresolution list 16:36:03 INFO - Available Modes on Display 0 16:36:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:04 INFO - Intel Iris: 16:36:04 INFO - Chipset Model: Intel Iris 16:36:04 INFO - Type: GPU 16:36:04 INFO - Bus: Built-In 16:36:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:04 INFO - Vendor: Intel (0x8086) 16:36:04 INFO - Device ID: 0x0a2e 16:36:04 INFO - Revision ID: 0x0009 16:36:04 INFO - Displays: 16:36:04 INFO - Display: 16:36:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:04 INFO - Display Serial Number: 1600x1200 60 16:36:04 INFO - Main Display: Yes 16:36:04 INFO - Mirror: Off 16:36:04 INFO - Online: Yes 16:36:04 INFO - Rotation: Supported 16:36:04 INFO - Return code: 0 16:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:04 INFO - Python 2.7.3 16:36:04 INFO - Return code: 0 16:36:04 INFO - grabbing minidump binary from tooltool 16:36:04 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')]} 16:36:04 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 0x10a702d30>, '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 0x10a629db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:04 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 16:36:04 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 16:36:04 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 16:36:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:04 INFO - Return code: 0 16:36:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:36:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:04 INFO - ENV: RUST_BACKTRACE is now 1 16:36:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:36:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:04 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/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 16:36:04 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/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0305 --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 16:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YyERXokh9f/Render', 16:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:04 INFO - 'HOME': '/Users/cltbld', 16:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:04 INFO - 'LOGNAME': 'cltbld', 16:36:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:04 INFO - 'MOZ_NO_REMOTE': '1', 16:36:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:04 INFO - 'NO_EM_RESTART': '1', 16:36:04 INFO - 'PAGER': '/bin/cat', 16:36:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:04 INFO - 'PWD': '/builds/slave/test', 16:36:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:04 INFO - 'RUST_BACKTRACE': '1', 16:36:04 INFO - 'SHELL': '/bin/bash', 16:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcaV2L90tv/Listeners', 16:36:04 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 16:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:04 INFO - 'USER': 'cltbld', 16:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:04 INFO - 'XPC_FLAGS': '0x0', 16:36:04 INFO - 'XPC_SERVICE_NAME': '0', 16:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:04 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/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 16:36:04 INFO - mozversion application_buildid: 20170404152627 16:36:04 INFO - mozversion application_changeset: 29eab893bad014e0e9e6af3df255230e2abebad5 16:36:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:36:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:04 INFO - mozversion application_name: Firefox 16:36:04 INFO - mozversion application_remotingname: firefox-dev 16:36:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:36:04 INFO - mozversion application_vendor: Mozilla 16:36:04 INFO - mozversion application_version: 54.0a2 16:36:04 INFO - mozversion platform_buildid: 20170404152627 16:36:04 INFO - mozversion platform_changeset: 29eab893bad014e0e9e6af3df255230e2abebad5 16:36:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:36:04 INFO - mozversion platform_version: 54.0a2 16:36:04 INFO - using testdate: 1491348964 16:36:04 INFO - actual date: 1491348964 16:36:04 INFO - starting webserver on 'localhost:49243' 16:36:04 INFO - SUITE-START | Running 2 tests 16:36:04 INFO - TEST-START | dromaeo_css 16:36:04 INFO - operating with platform_type : mac_ 16:36:04 INFO - Initialising browser for dromaeo_css test... 16:36:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpfY4wBB/profile http://localhost:49243/getInfo.html) 16:36:07 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 16:36:07 INFO - PROCESS | 1635 | colorDepth:24 16:36:07 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 16:36:07 INFO - PROCESS | 1635 | __metrics 16:36:07 INFO - PROCESS | 1635 | 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" 16:36:07 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:08 INFO - TEST-INFO | 1635: exit 0 16:36:08 INFO - Browser initialized. 16:36:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:08 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpfY4wBB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:20 INFO - PROCESS | 1637 | RSS: Main: 214810624 16:36:20 INFO - PROCESS | 1637 | 16:39:24 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 16:39:26 INFO - PROCESS | 1637 | RSS: Main: 347779072 16:39:26 INFO - PROCESS | 1637 | 16:41:10 INFO - PROCESS | 1637 | ************************* 16:41:10 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 16:41:10 INFO - PROCESS | 1637 | 16:41:10 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:41:10 INFO - PROCESS | 1637 | Full stack: 16:41:10 INFO - PROCESS | 1637 | ************************* 16:42:29 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 16:42:30 INFO - PROCESS | 1637 | RSS: Main: 348643328 16:42:30 INFO - PROCESS | 1637 | 16:45:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 16:45:33 INFO - PROCESS | 1637 | RSS: Main: 326270976 16:45:33 INFO - PROCESS | 1637 | 16:48:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 16:48:36 INFO - PROCESS | 1637 | RSS: Main: 319545344 16:48:36 INFO - PROCESS | 1637 | 16:51:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 16:51:40 INFO - PROCESS | 1637 | RSS: Main: 318636032 16:51:40 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 16:54:44 INFO - PROCESS | 1637 | RSS: Main: 481841152 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | __start_tp_report 16:54:44 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 16:54:44 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 16:54:44 INFO - PROCESS | 1637 | |i|pagename|runs| 16:54:44 INFO - PROCESS | 1637 | |0;dojo.html;3077.3845230953807;3263.2820779428516;3369.736348869174;3378.459446488562;3427.9657203427973;5881.911771323428;5911.85220369491;5918.644881307114;5968.313643930944;5974.551908606855;5917.970410147954;5934.703264836762;5943.643381397108;5960.850978725534;5999.460048595625;5337.70642614656;5385.649932754359;5388.084025715638;5469.835904922858;5476.26070480486;5262.631615786897;5271.499207575293;5314.415414304423;5370.91943620846;5492.286002819648;5394.541463975567;5436.592255580827;5443.673379597217;5446.2647542581835;5495.313085864267;5444.646098003617;5451.454854514556;5452.100403433429;5455.208994695787;5460.126379779256;5251;5251.343582052244;5292.814751483718;5388.1648344506275;5451.863703407407;5808.535317174616;5813.186153938452;5821.563382746311;5823.82528524145;5843.948089343917;6256.405641464054;6349.238091429058;6394.296627370985;6402.391772781578;6407.903881441782;6354.2692590352235;6383.808485745389;6396.968015159894;6397.040443933401;6440.710168042449;5606.467385598362;6110.663913484756;6126.571140020245;6126.663033533154;6127.5404344674325;6002.849928751816;6327.715252813635;6374.139491168633;6385.457236134887;6461.547691661539;6367.968160159262;6384.872302553923;6392.20097487814;6410.326915673787;6426.807195784134;6427.614343139427;6430.485561155097;6450.129232553639;6453.9354606453335;6464.062710906892;6250.812475625738;6269.62382257066;6353.777617783356;6393.424591786668;6403.58376705522;5020.272060551272;6331.271903731038;6379.106925030499;6393.4885209184085;6400.359964003563;5137.691738495702;5138.743062846917;5143.12566863634;5160.200168973815;5164.948350516522;4475.26158183896;4496.123255965055;4591.265397536378;4613.838515651936;4636.79134438951;5863.882722345529;5978.611390259619;6024.819255422344;6074.544409169242;6107.48086412651;6318.462930650854;6425.261094974045;6425.518086143465;6427.839304017437;6434.549581529342;6034.336223015464;6041.124037014608;6051.727672254671;6067.089936509471;6067.362926892701;5475.780968761284;5510.724463776795;5596.244506991504;5598.776048957996;5601.103823388238;6402.6158430494315;6409.230892293048;6418.422341989243;6421.357864213542;6491.993740970157;5687.374388817144;6151.661658608819;6375.521835862236;6408.487321014401;6428.357164283534;6619.404253617197;6627.867442651216;6630.535862489773;6657.866842663023;6678.465722742266;6225.972714502056;6283.8114856554375;6422.582532135396;6439.7424103035355;6453.257875344396;5295.655782374133;6183.103449999815;6344.682765861596;6417.133686952202;6436.098946147449;6311.116443697794;6349.9682501587195;6358.395952384516;6380.234371875219;6381.904271435839;6131.957816599936;6330.556861019684;6361.840953976188;6364;6373.904391434039;6097.329293777592;6147.954847675816;6177;6266.624002559861;6270.404311590391;6344.71448784815;6361.713722882574;6367.363263673596;6368.9044664330995;6388.840278993062;6193.783217587543;6239.594426362272;6245.656488893154;6245.781397651061;6263.718132684131 16:54:44 INFO - PROCESS | 1637 | |1;ext.html;609.6128958111599;750.8160500677335;803.4616806739485;872.5288344294078;882.488156869016;27439.314017149558;27706;28610.570841437395;38953.805230973805;39684.809455716306;40512.79743601285;40650;40673.796631016805;40698.389524157086;40739.59260407402;9140;9293.58178881952;9305;9305;9310.53447327631;7258.600776957265;7412.444066694992;9207.631694732203;10874.510647020863;11149.554017839277;10091.344062635942;10580.259381843274;11105.167112466557;11106.333619982826;11183.776324473505;10979.341239525615;10997.34015959037;11012.834807477895;11021.228514004022;11039.061679757231;7232.457565682595;7398.149212840484;10645.787084258349;10790.543276657629;10884.891151088466;38326;38528.22943541114;38549.614503854886;38564.421533677014;38663.8066809667;3720.9302325581502;3823.483829683013;3853.075261937143;3887.630675085862;3928.5874983126646;27275.727242727517;28124.437511249864;28717.856410717814;28738.568921466194;28832.567511487345;3010.6387233531896;3052.8931487397836;3071.3703690743346;3176.126565194567;3284.310294838087;295561.52219238767;295603;297498;298234;299992;50846.745766270935;50887.491125089015;50978.490215098114;51063.74468127636;51064.74467627638;44238;51603.96792064138;53177.7341113292;53308.73345633247;53417;14791;14926.776098358534;14936.70126597462;14943.178125203001;14957.775633365509;12891.806622900664;12900;12960.870391295966;12963.416646250942;12967;8596.742097737078;8759.036505984337;10250.026247506476;11488.885111148782;11511.942440287912;4794.154250613539;5013.248012798036;5561.58288128392;5629.521490673339;5643.887122257614;1103.194667892443;1127.6278827986744;1134.8581427321585;1135.625243669587;1147.846414353586;25806.612900806504;25872.094476693226;26399;26474.867625662133;26484.33789155248;1052.8368102944055;1232.6548566401423;1234.1361047266769;1247.8910641016653;1297.2994582925303;11796.29222246668;13534.187948723109;13726.039177257695;13930.930345348208;14511.419543218153;478263;482520;483328;483483;483985;48909.266361004615;49108.75445622749;49116.263256051185;49221.50778492169;49230.01539969252;1349.2376807103956;1383.0387880423411;1384.5431007767613;1385.2173521960262;1390.367382840805;24370;25488.617670734584;26434.206973790817;26627.60058599161;26638.733612663626;39494.01264968284;39575.2084958305;39588.2082358357;39622.60377396189;39632.00919977023;430198;430486;430659;431166;431760;28108;29021.12936611905;29562.704372955995;30359.544606830474;30395;38713.4192987111;39041.80479097586;39072.2185556293;39389;39481.01297467586;27109.1867243983;27776.583351250152;28524.57213141763;28854.711452885203;29291.53542322918;20002.69995950091;28193.01324453634;28474;28836.855815720788;29002.099790020828;31509.527357089202;32321.35357292794;32668.183295417806;32709.69161233524;33114.33771324608;27776.722232777414;27829.02598409046;28462.85768571144;28601.42797144087;28625.71374286314;22596.322110336718;22770.544589107794;22960.4259893504;23075.961581728527;23109.88445057764 16:54:44 INFO - PROCESS | 1637 | |2;jquery.html;384.84606157537;405.8599783074838;423.19381578093726;429.8581468115522;446.3795324498945;12713.936430317846;14636.634084147901;20481.897590512028;20961.895190524046;21411.892940535276;21555.892220538877;21685.3494395168;22093.005814738335;22387.664185037236;22641.886790566066;6414.454771344442;6481.611103333803;6593.703283352261;6648.734050637969;6666.23338316095;6348.301686814447;6530.249021362557;6546.214454265471;6596.901046484307;6684.732610695566;6733.764318248862;6748.595084294958;6750.189977202718;6752.898706519406;6767.796966091;6350.206224221973;6432.774852880174;6679.332066793282;6694.397504224643;6740.393364597186;6433.8391540211405;6498.740050397979;6509.6419696916655;6516.501204722893;6521.445677117451;26681.866590666923;26945.461090778073;27108.59337109945;27260.59109113365;27426.588601171;2585.2244326702103;2599.820770686061;2602.6616539849697;2608.1132414978997;2633.6350832839826;16288.918555407266;16357.91821040899;16567.585810354718;16596.50210493687;17189.1405429728;1958.9020548972494;1992.481954691776;2009.3670493794407;2011.1754180785808;2029.411470673503;132400.33799831037;132592;140247.89628155585;141264;141338;20229.696554551694;21361.67957480639;21447;21558.245461408776;21750;35278.47082293768;35866.82066589651;35968.10079748027;35971.82014089913;35995.64004359975;9086.681966131153;10435.676648245739;10790.24468287228;10962.671119866416;11175.050120739828;7478.2521747824785;9000.099990000948;9022.917249929918;9091.454512729257;9216.032316606794;9880;10208.897911020944;10349.068583827491;10387;10387.779788265661;3326.467765157563;3408.8468166945477;3961.187956468917;4139.855105071308;4146.896327591834;877.7279043496536;879.3009557401881;887.9556022198864;904.615538396179;922.6401703335705;21638.891805541185;22303;22417.215397461012;22506.66240006401;22645.773542264695;730.2770257445092;907.2968449451728;919.1268295119663;920.3787443475761;926.36081104038;11227.38249396291;11259.887401126047;11349.865013498584;11900.940495297467;11958.880411195776;719887.201691975;737334.3133284299;737593;759632;765309;127575;157585.2120739389;158657.2067139657;160087;164280;1226.0743138930052;1247.9376031198403;1273.7325161715958;1287.1247551664958;1288.6585054960442;19153.083448529098;19920.81229342077;20075.820009889707;20170;20195.192192312144;55564.72217638886;56296;62375.6881215591;64472;65700.67149664412;56901.430985691266;80856.59571702103;81070.59464702639;81595;82452.58773706094;11397.632284125957;11444.94277528607;11621.954024137869;11626.418679066182;11865.940670296593;10744.51649675782;11325.32048077118;12227;12959.416826242654;13139.474421023053;10611.09805666527;10818.945905270422;10845.186611004048;10960;10961.561537538728;8448.450850694686;9389.765255868659;10164.491775411052;10208.897911021091;10513.894861051598;11258.493367798632;11332.716682083013;11351.772964540829;11479.827802583135;11641.825372619249;11136.33182009082;11287.717807054889;11428.599998999995;11434.199606027498;11480.196386252883;8586.441881277697;10718.35689858611;10754.300970436896;10964.945175274073;11201.327920324806 16:54:44 INFO - PROCESS | 1637 | |3;mootools.html;1365.6517588015054;1415.3630866110248;1562.3672412672865;1607.606136496558;1610.8228094909562;9164.450132992026;9581.041895810415;10768.73078173045;11087.168462365335;11285.097192224623;10907.83638245427;11040.33757974522;11057.778844423106;11085.113190944725;11096.778064438706;2046.4474591860226;2432.1487479382254;2442.096424323003;2443.7556244375596;2445.596476581362;1984.335247692025;2062.288510463895;2362.0669835415;2443.9389015274583;2461.483088551406;2145.7639659637507;2420;2426.6238732996326;2426.8543887366814;2427.053449154831;2360.5160942006846;2396.412878844694;2402.5915594349003;2403.7836594706387;2413.4569721812713;2346.190564255346;2368.857868527894;2376.429656882353;2380.5000949800565;2392.294273189396;10787.5684972601;11024.50389732464;11042.668719938414;11042.779144417147;11052.502637381338;5570.275864137677;5735.913961290584;5741.540676745851;5752.424757524214;5756.683382413966;3427.1946092668204;3539.7876127432437;3679.2089700714473;3684.4841722158917;3686.3733165361955;1070.1599244592958;1151.8157094864864;1153.123626044204;1190.8749581293926;1238.5479300055506;15231.162286074261;15363;15429.691406171925;15440.768388474069;15447.459338923196;4785.617150627942;4939.456659767423;5025.6482046256415;5043.067032598908;5065.594752419871;12911;12911.35443227835;12913.612591622266;12916.095873288967;12933.417996190194;6032.517398608101;6044.637321760709;6059.303180134253;6060.42425969541;6064.545159113084;4493.7977790999485;5023.799048038038;5235.554977826851;5303.681779093266;5313.415524292402;3638;4086.0602061526015;4210.578942105765;4231.61915427613;4233.343831706091;1139.151332257457;1155.5608868630036;1157.4039369724599;1167.3462860797981;1170.3563040327786;914.410205417502;922;933.2487347685178;934.9621919669162;982.8673129127619;6149.41580549847;6475.32009139043;6652.334766523309;6777.220619628707;6818.318168183142;856.5075081827974;987.3976874106789;992.1764935103846;1007.1367969256962;1040.287403128859;4001.679865610744;4164.271252530795;4186.958130418718;4222.303319952173;4296.505901821268;13234.205947643171;13939.930300348433;13954.372053257628;13955.023148379516;13965.930170349286;13759.38082786277;13909.165450073027;13921.095128816594;13938.790918136236;13940.024198306224;9731.978142295098;10123.544440500194;10233.9488302558;10234.385936843813;10251.641192558225;5733.455321744427;5852.239208902815;6630.370114839083;6723.428508576826;6975.79072627822;11862.881371186179;12044.75910481768;12257.938710306391;12317.876821231674;12414.751704965669;12137.817932731192;12372.13395062337;12375.195612285173;12377.133600647869;12568.30874301922;8772.078931712078;8820.162084601952;8848.690295839615;8936.41913275635;8960.596773145095;8188.959055204686;8705.998810136914;8971.50656713887;8986.236169925369;9885.950570247103;8643.17889800468;8800.779980500538;8853.69012084574;8874.112588741333;9072.364934454788;8574.056853746208;8629.482231066157;8659.653613855375;8715.91284087151;8762.780930476789;7769;7911.12977572455;7993.440459167802;8005.07941586725;8008.1191068983535;4945.530174633404;5520.951019306319;5683.829485115453;5740.425957404226;5828.475437210672;4979.477154898684;5043.5460808527405;5080.263361812443;5709.628874123168;5945.583809133319 16:54:44 INFO - PROCESS | 1637 | |4;prototype.html;345.6923338228975;353.5509902423921;381.3383779143186;381.7804762261697;387.1559999201741;4410.338449232617;5023.497650234975;5080.745962701869;5083.085044691954;5149.253358263049;4780.8565743027675;4869.172240719077;4961.652684312091;4974.850754477362;5003.14883493108;3357.446021406477;3536.398812201932;3754.6808521275725;4148.730332528384;4202.579742025789;3617.981910090446;3898.9805050974705;3901.5708272090046;3995.7602543847315;4106.67359438854;3846.2114816905328;4098.897527561805;4180.2025129194435;4186.518550366701;4286.614204721574;4085.285075111873;4099.467069280974;4136.503619565641;4155.376693495985;4184.14225083857;3545.503629491873;3691.9847042063648;3818.56803698613;3850.6534411903062;3869.400242962345;4250.447441832542;4661.336476181422;4695.272232803921;4781.235002399634;4905.2151655734915;3559.839807208682;3950.9924969132976;4266.914661706748;4720.858374248778;4775.474697783241;4819.975900120477;4870.878228044292;4960.70235785854;5254.605904557174;5298;3792.260509200707;4235.162441164427;4243.384709217146;4325.783710814479;4398.318260669601;5237.816676416345;5480.945190548084;5531.585131115183;5561.804212094419;5643.476261409396;4724.763761811896;4760.928791022062;4798.185442573163;4840.685355451885;4863.537963893425;4140.660526802347;4245.660347172219;4717;4928.876778080505;4929.433115191727;4484.730916145042;4537.185125949646;4616.330632058332;5000.849974500771;5033.7734801934;5051.722155281494;5140.997505486394;5311.442298558673;5313.388960269541;5341.893162136736;1573.7796708460824;1592.4983630156696;1635.386729976259;1676.3964972609851;1692.2892385198247;1253.846461255647;1261.7287283234148;1351.2838195756265;1363.936129818743;1365.7132002279632;4388.451443569554;4877.074155103372;4945.10711233925;4992.15133427311;4998.275250088716;4668.299755036704;5125.718085505333;5416.322959630046;5439.972800135974;5445.821671331499;4111.938320925188;4679.298105284234;4682.601978831837;4802.7341407842305;4908.141075311806;2475.4553998120386;2515.823892327556;2841.928951776181;2848.7293707097792;2863.9952033576164;4830.7101573905675;5638.43615638441;5647.37878833328;5656.632318899258;5683.829485115453;4678.789454474557;5014.389639459583;5247.921281180786;5376.247325374451;5554.805716770914;4639.559241872017;5396.163594642837;5627.803026894039;5632.3804381518;5702.543796496353;4924.704517728805;5048.62714524173;5446.429463046448;5487.862803429786;5507.697076660662;4491.96684762513;4518.412606361152;5109.821156259513;5360.571154307568;5438.537724293479;4935.8025678972435;5587.804426845041;5645;5673.461021203144;5677.063284558001;4555.612772914207;4747.501512341292;4779.733370656709;4820.132376172322;4826.758662066813;4810.7113573185725;4896.36347274852;5281.260623512634;5413.458654134555;5444.918326225189;4591.714319990408;4769.594584460221;4827.59999600112;5293.894122117613;5318.175682769177;4658.767061646837;4836.564709176191;5161.432242453402;5254.710990895537;5274.97362513185;4555.863324100283;4707.882302942454;5089.567386772018;5098.005888851639;5141.408737995179;4733.479317275028;4918.458969513422;5210.723372773543;5350.732463376893;5371.194320851903;4536.818527259004;4844.588210002048;4847.757612119451;5151.8196863109615;5209 16:54:44 INFO - PROCESS | 1637 | |5;yui.html;709.2800807180715;735.7204262380299;744.9515781474204;818.8239528501372;824.2252282854118;13377.26425046622;15241.771373429394;15427.228638568069;16221.513354599381;16275;14272.215028173447;14613.123212607252;14666.560003199895;14739.852601473982;15360.692786144298;915.7939463620698;946.820104180207;952.8380175370169;956.206348730552;957.6791774755466;920.2959735802117;939.2673714502665;941.8493041113423;956.6603855631255;958.966436174734;1006.5571148694551;1010.6816352848866;1011.0597144655468;1011.3426272922586;1012.1346248957146;1005.3415013166315;1006.8892421833592;1008.0222184481041;1009.6920439266021;1010.0757806606946;744.9962750186269;745.329203716654;745.3478206569251;746.6901235987059;751.3801114080851;15383;15764.684706305925;15831.762523562156;15965.201739912958;16269.430569929995;14049.578512644637;14155.363008664635;14315.57053288403;14357.066790658573;14404.783928241084;11479.25384849982;11770.470328835223;11908.821367679491;11958.40207989597;12339.568115116017;3350.3299340131825;3581.1584277694983;3653.2328211075705;3675.4303083022173;3691.169486865461;105365.41951870728;108049.45975270151;108515.99999999921;109074;109622.45188774086;9845.950770246103;9856.162226210852;10290.794184116276;10581.259311848096;10942.069924056545;21056.684149737765;21308.57382852365;21356;21504;21640.134394624038;7467.551946883204;7474.85050298991;7496.362809161283;7572.4699271050495;7680.155182929873;4210.347396153601;4281.100968796588;4315.892102697458;4320.308750599952;4430.82276708928;3250.609926808751;3341.18141055443;3343.297907439465;3346.6151392589677;3351.0784534253276;602.8553147244629;611.8133969139456;631.3970158498623;636.7071147272306;639.398964972924;542.7503348459753;620.7796232337546;646.812424396929;647.4852492268564;655.9376859198369;8785.542576435422;9591.136797688241;9676.919771990466;9760.609575617038;9761.804763904682;627.1157667688537;637.8501052252717;664.707528687376;672.2269390201308;684.7534887440518;4321.222180007629;4617.561331673485;4622.46841613212;4624.5144259852905;4627.375304333939;83669.58165209135;95696.52151739197;97758.5112074435;98628.52057219147;100613.49693251487;52450;59966;60362;74937;81934.59032704799;62271.68864155741;67045.65908681897;67959;69085.96371054438;69242.30757692359;10043.69868903934;10679.199060070681;11160.162987775788;11312.886871131182;11480.82778758336;41275.555355563614;42002.78998604987;42404;43818.780906095264;44842.87892802706;50255.49744502654;61942.69028654828;63755;63864.68067659632;65121;12704.618861434172;13022.804657930328;13117.34413279313;13228.735425291248;13658.385372658055;14978;15068.472603458826;15081.662342336955;15239.149071913977;15246.3901443941;13503.613306523923;13582.524611638546;13880.097793643381;13958.930205348908;14643.56069317922;13247.735045299232;13324.333783310989;13827.654308641962;13846.684564966312;13920.651983700489;12913.289769062792;13331.200127992352;13474.124181928144;13486.325683715579;13547.458101675822;9652.517374131125;9937.254705896941;10171.796564068825;10196.898031019891;10225.233107517115;9292.495253322837;11150.498227579941;11371.48828302745;11385.316880987168;11402.372869491926 16:54:44 INFO - PROCESS | 1637 | __end_tp_report 16:54:44 INFO - PROCESS | 1637 | __start_cc_report 16:54:44 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1464 16:54:44 INFO - PROCESS | 1637 | __end_cc_report 16:54:44 INFO - PROCESS | 1637 | __startTimestamp1491350084401__endTimestamp 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | ------- Summary: start ------- 16:54:44 INFO - PROCESS | 1637 | Number of tests: 6 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5919.26 Median:6151.66 stddev:674.17 (11.0%) stddev-sans-first:638.32 16:54:44 INFO - PROCESS | 1637 | Values: 3077.4 3263.3 3369.7 3378.5 3428.0 5881.9 5911.9 5918.6 5968.3 5974.6 5918.0 5934.7 5943.6 5960.9 5999.5 5337.7 5385.6 5388.1 5469.8 5476.3 5262.6 5271.5 5314.4 5370.9 5492.3 5394.5 5436.6 5443.7 5446.3 5495.3 5444.6 5451.5 5452.1 5455.2 5460.1 5251.0 5251.3 5292.8 5388.2 5451.9 5808.5 5813.2 5821.6 5823.8 5843.9 6256.4 6349.2 6394.3 6402.4 6407.9 6354.3 6383.8 6397.0 6397.0 6440.7 5606.5 6110.7 6126.6 6126.7 6127.5 6002.8 6327.7 6374.1 6385.5 6461.5 6368.0 6384.9 6392.2 6410.3 6426.8 6427.6 6430.5 6450.1 6453.9 6464.1 6250.8 6269.6 6353.8 6393.4 6403.6 5020.3 6331.3 6379.1 6393.5 6400.4 5137.7 5138.7 5143.1 5160.2 5164.9 4475.3 4496.1 4591.3 4613.8 4636.8 5863.9 5978.6 6024.8 6074.5 6107.5 6318.5 6425.3 6425.5 6427.8 6434.5 6034.3 6041.1 6051.7 6067.1 6067.4 5475.8 5510.7 5596.2 5598.8 5601.1 6402.6 6409.2 6418.4 6421.4 6492.0 5687.4 6151.7 6375.5 6408.5 6428.4 6619.4 6627.9 6630.5 6657.9 6678.5 6226.0 6283.8 6422.6 6439.7 6453.3 5295.7 6183.1 6344.7 6417.1 6436.1 6311.1 6350.0 6358.4 6380.2 6381.9 6132.0 6330.6 6361.8 6364.0 6373.9 6097.3 6148.0 6177.0 6266.6 6270.4 6344.7 6361.7 6367.4 6368.9 6388.8 6193.8 6239.6 6245.7 6245.8 6263.7 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:53302.19 Median:163530.35 stddev:109285.48 (66.8%) stddev-sans-first:109520.44 16:54:44 INFO - PROCESS | 1637 | Values: 609.6 750.8 803.5 872.5 882.5 27439.3 27706.0 28610.6 38953.8 39684.8 40512.8 40650.0 40673.8 40698.4 40739.6 9140.0 9293.6 9305.0 9305.0 9310.5 7258.6 7412.4 9207.6 10874.5 11149.6 10091.3 10580.3 11105.2 11106.3 11183.8 10979.3 10997.3 11012.8 11021.2 11039.1 7232.5 7398.1 10645.8 10790.5 10884.9 38326.0 38528.2 38549.6 38564.4 38663.8 3720.9 3823.5 3853.1 3887.6 3928.6 27275.7 28124.4 28717.9 28738.6 28832.6 3010.6 3052.9 3071.4 3176.1 3284.3 295561.5 295603.0 297498.0 298234.0 299992.0 50846.7 50887.5 50978.5 51063.7 51064.7 44238.0 51604.0 53177.7 53308.7 53417.0 14791.0 14926.8 14936.7 14943.2 14957.8 12891.8 12900.0 12960.9 12963.4 12967.0 8596.7 8759.0 10250.0 11488.9 11511.9 4794.2 5013.2 5561.6 5629.5 5643.9 1103.2 1127.6 1134.9 1135.6 1147.8 25806.6 25872.1 26399.0 26474.9 26484.3 1052.8 1232.7 1234.1 1247.9 1297.3 11796.3 13534.2 13726.0 13930.9 14511.4 478263.0 482520.0 483328.0 483483.0 483985.0 48909.3 49108.8 49116.3 49221.5 49230.0 1349.2 1383.0 1384.5 1385.2 1390.4 24370.0 25488.6 26434.2 26627.6 26638.7 39494.0 39575.2 39588.2 39622.6 39632.0 430198.0 430486.0 430659.0 431166.0 431760.0 28108.0 29021.1 29562.7 30359.5 30395.0 38713.4 39041.8 39072.2 39389.0 39481.0 27109.2 27776.6 28524.6 28854.7 29291.5 20002.7 28193.0 28474.0 28836.9 29002.1 31509.5 32321.4 32668.2 32709.7 33114.3 27776.7 27829.0 28462.9 28601.4 28625.7 22596.3 22770.5 22960.4 23076.0 23109.9 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:42194.22 Median:22402.44 stddev:123728.15 (552.3%) stddev-sans-first:124035.42 16:54:44 INFO - PROCESS | 1637 | Values: 384.8 405.9 423.2 429.9 446.4 12713.9 14636.6 20481.9 20961.9 21411.9 21555.9 21685.3 22093.0 22387.7 22641.9 6414.5 6481.6 6593.7 6648.7 6666.2 6348.3 6530.2 6546.2 6596.9 6684.7 6733.8 6748.6 6750.2 6752.9 6767.8 6350.2 6432.8 6679.3 6694.4 6740.4 6433.8 6498.7 6509.6 6516.5 6521.4 26681.9 26945.5 27108.6 27260.6 27426.6 2585.2 2599.8 2602.7 2608.1 2633.6 16288.9 16357.9 16567.6 16596.5 17189.1 1958.9 1992.5 2009.4 2011.2 2029.4 132400.3 132592.0 140247.9 141264.0 141338.0 20229.7 21361.7 21447.0 21558.2 21750.0 35278.5 35866.8 35968.1 35971.8 35995.6 9086.7 10435.7 10790.2 10962.7 11175.1 7478.3 9000.1 9022.9 9091.5 9216.0 9880.0 10208.9 10349.1 10387.0 10387.8 3326.5 3408.8 3961.2 4139.9 4146.9 877.7 879.3 888.0 904.6 922.6 21638.9 22303.0 22417.2 22506.7 22645.8 730.3 907.3 919.1 920.4 926.4 11227.4 11259.9 11349.9 11900.9 11958.9 719887.2 737334.3 737593.0 759632.0 765309.0 127575.0 157585.2 158657.2 160087.0 164280.0 1226.1 1247.9 1273.7 1287.1 1288.7 19153.1 19920.8 20075.8 20170.0 20195.2 55564.7 56296.0 62375.7 64472.0 65700.7 56901.4 80856.6 81070.6 81595.0 82452.6 11397.6 11444.9 11622.0 11626.4 11865.9 10744.5 11325.3 12227.0 12959.4 13139.5 10611.1 10818.9 10845.2 10960.0 10961.6 8448.5 9389.8 10164.5 10208.9 10513.9 11258.5 11332.7 11351.8 11479.8 11641.8 11136.3 11287.7 11428.6 11434.2 11480.2 8586.4 10718.4 10754.3 10964.9 11201.3 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6704.63 Median:3588.89 stddev:4243.52 (118.2%) stddev-sans-first:4236.46 16:54:44 INFO - PROCESS | 1637 | Values: 1365.7 1415.4 1562.4 1607.6 1610.8 9164.5 9581.0 10768.7 11087.2 11285.1 10907.8 11040.3 11057.8 11085.1 11096.8 2046.4 2432.1 2442.1 2443.8 2445.6 1984.3 2062.3 2362.1 2443.9 2461.5 2145.8 2420.0 2426.6 2426.9 2427.1 2360.5 2396.4 2402.6 2403.8 2413.5 2346.2 2368.9 2376.4 2380.5 2392.3 10787.6 11024.5 11042.7 11042.8 11052.5 5570.3 5735.9 5741.5 5752.4 5756.7 3427.2 3539.8 3679.2 3684.5 3686.4 1070.2 1151.8 1153.1 1190.9 1238.5 15231.2 15363.0 15429.7 15440.8 15447.5 4785.6 4939.5 5025.6 5043.1 5065.6 12911.0 12911.4 12913.6 12916.1 12933.4 6032.5 6044.6 6059.3 6060.4 6064.5 4493.8 5023.8 5235.6 5303.7 5313.4 3638.0 4086.1 4210.6 4231.6 4233.3 1139.2 1155.6 1157.4 1167.3 1170.4 914.4 922.0 933.2 935.0 982.9 6149.4 6475.3 6652.3 6777.2 6818.3 856.5 987.4 992.2 1007.1 1040.3 4001.7 4164.3 4187.0 4222.3 4296.5 13234.2 13939.9 13954.4 13955.0 13965.9 13759.4 13909.2 13921.1 13938.8 13940.0 9732.0 10123.5 10233.9 10234.4 10251.6 5733.5 5852.2 6630.4 6723.4 6975.8 11862.9 12044.8 12257.9 12317.9 12414.8 12137.8 12372.1 12375.2 12377.1 12568.3 8772.1 8820.2 8848.7 8936.4 8960.6 8189.0 8706.0 8971.5 8986.2 9886.0 8643.2 8800.8 8853.7 8874.1 9072.4 8574.1 8629.5 8659.7 8715.9 8762.8 7769.0 7911.1 7993.4 8005.1 8008.1 4945.5 5521.0 5683.8 5740.4 5828.5 4979.5 5043.5 5080.3 5709.6 5945.6 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4444.74 Median:4815.34 stddev:1197.09 (24.9%) stddev-sans-first:1160.24 16:54:44 INFO - PROCESS | 1637 | Values: 345.7 353.6 381.3 381.8 387.2 4410.3 5023.5 5080.7 5083.1 5149.3 4780.9 4869.2 4961.7 4974.9 5003.1 3357.4 3536.4 3754.7 4148.7 4202.6 3618.0 3899.0 3901.6 3995.8 4106.7 3846.2 4098.9 4180.2 4186.5 4286.6 4085.3 4099.5 4136.5 4155.4 4184.1 3545.5 3692.0 3818.6 3850.7 3869.4 4250.4 4661.3 4695.3 4781.2 4905.2 3559.8 3951.0 4266.9 4720.9 4775.5 4820.0 4870.9 4960.7 5254.6 5298.0 3792.3 4235.2 4243.4 4325.8 4398.3 5237.8 5480.9 5531.6 5561.8 5643.5 4724.8 4760.9 4798.2 4840.7 4863.5 4140.7 4245.7 4717.0 4928.9 4929.4 4484.7 4537.2 4616.3 5000.8 5033.8 5051.7 5141.0 5311.4 5313.4 5341.9 1573.8 1592.5 1635.4 1676.4 1692.3 1253.8 1261.7 1351.3 1363.9 1365.7 4388.5 4877.1 4945.1 4992.2 4998.3 4668.3 5125.7 5416.3 5440.0 5445.8 4111.9 4679.3 4682.6 4802.7 4908.1 2475.5 2515.8 2841.9 2848.7 2864.0 4830.7 5638.4 5647.4 5656.6 5683.8 4678.8 5014.4 5247.9 5376.2 5554.8 4639.6 5396.2 5627.8 5632.4 5702.5 4924.7 5048.6 5446.4 5487.9 5507.7 4492.0 4518.4 5109.8 5360.6 5438.5 4935.8 5587.8 5645.0 5673.5 5677.1 4555.6 4747.5 4779.7 4820.1 4826.8 4810.7 4896.4 5281.3 5413.5 5444.9 4591.7 4769.6 4827.6 5293.9 5318.2 4658.8 4836.6 5161.4 5254.7 5275.0 4555.9 4707.9 5089.6 5098.0 5141.4 4733.5 4918.5 5210.7 5350.7 5371.2 4536.8 4844.6 4847.8 5151.8 5209.0 16:54:44 INFO - PROCESS | 1637 | 16:54:44 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19034.49 Median:3350.70 stddev:26665.96 (795.8%) stddev-sans-first:26705.26 16:54:44 INFO - PROCESS | 1637 | Values: 709.3 735.7 745.0 818.8 824.2 13377.3 15241.8 15427.2 16221.5 16275.0 14272.2 14613.1 14666.6 14739.9 15360.7 915.8 946.8 952.8 956.2 957.7 920.3 939.3 941.8 956.7 959.0 1006.6 1010.7 1011.1 1011.3 1012.1 1005.3 1006.9 1008.0 1009.7 1010.1 745.0 745.3 745.3 746.7 751.4 15383.0 15764.7 15831.8 15965.2 16269.4 14049.6 14155.4 14315.6 14357.1 14404.8 11479.3 11770.5 11908.8 11958.4 12339.6 3350.3 3581.2 3653.2 3675.4 3691.2 105365.4 108049.5 108516.0 109074.0 109622.5 9846.0 9856.2 10290.8 10581.3 10942.1 21056.7 21308.6 21356.0 21504.0 21640.1 7467.6 7474.9 7496.4 7572.5 7680.2 4210.3 4281.1 4315.9 4320.3 4430.8 3250.6 3341.2 3343.3 3346.6 3351.1 602.9 611.8 631.4 636.7 639.4 542.8 620.8 646.8 647.5 655.9 8785.5 9591.1 9676.9 9760.6 9761.8 627.1 637.9 664.7 672.2 684.8 4321.2 4617.6 4622.5 4624.5 4627.4 83669.6 95696.5 97758.5 98628.5 100613.5 52450.0 59966.0 60362.0 74937.0 81934.6 62271.7 67045.7 67959.0 69086.0 69242.3 10043.7 10679.2 11160.2 11312.9 11480.8 41275.6 42002.8 42404.0 43818.8 44842.9 50255.5 61942.7 63755.0 63864.7 65121.0 12704.6 13022.8 13117.3 13228.7 13658.4 14978.0 15068.5 15081.7 15239.1 15246.4 13503.6 13582.5 13880.1 13958.9 14643.6 13247.7 13324.3 13827.7 13846.7 13920.7 12913.3 13331.2 13474.1 13486.3 13547.5 9652.5 9937.3 10171.8 10196.9 10225.2 9292.5 11150.5 11371.5 11385.3 11402.4 16:54:44 INFO - PROCESS | 1637 | -------- Summary: end -------- 16:54:44 INFO - PROCESS | 1637 | 16:54:45 INFO - TEST-INFO | 1637: exit 0 16:54:45 INFO - TEST-OK | dromaeo_css | took 1120601ms 16:54:45 INFO - TEST-START | kraken 16:54:45 INFO - operating with platform_type : mac_ 16:54:45 INFO - Initialising browser for kraken test... 16:54:45 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpTIf0gy/profile http://localhost:49243/getInfo.html) 16:54:47 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 16:54:47 INFO - PROCESS | 1647 | colorDepth:24 16:54:47 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 16:54:47 INFO - PROCESS | 1647 | __metrics 16:54:47 INFO - PROCESS | 1647 | 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" 16:54:47 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:54:48 INFO - TEST-INFO | 1647: exit 0 16:54:48 INFO - Browser initialized. 16:54:48 INFO - Running cycle 1/1 for kraken test... 16:54:48 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpTIf0gy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:00 INFO - PROCESS | 1648 | RSS: Main: 215044096 16:55:00 INFO - PROCESS | 1648 | 16:55:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:04 INFO - PROCESS | 1648 | RSS: Main: 268959744 16:55:04 INFO - PROCESS | 1648 | 16:55:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 16:55:07 INFO - PROCESS | 1648 | RSS: Main: 280903680 16:55:07 INFO - PROCESS | 1648 | 16:55:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 16:55:11 INFO - PROCESS | 1648 | RSS: Main: 377835520 16:55:11 INFO - PROCESS | 1648 | 16:55:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 16:55:13 INFO - PROCESS | 1648 | RSS: Main: 279642112 16:55:13 INFO - PROCESS | 1648 | 16:55:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:16 INFO - PROCESS | 1648 | RSS: Main: 280682496 16:55:16 INFO - PROCESS | 1648 | 16:55:19 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 16:55:20 INFO - PROCESS | 1648 | RSS: Main: 322715648 16:55:20 INFO - PROCESS | 1648 | 16:55:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 16:55:23 INFO - PROCESS | 1648 | RSS: Main: 321064960 16:55:23 INFO - PROCESS | 1648 | 16:55:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 16:55:27 INFO - PROCESS | 1648 | RSS: Main: 319668224 16:55:27 INFO - PROCESS | 1648 | 16:55:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:55:29 INFO - PROCESS | 1648 | RSS: Main: 296423424 16:55:29 INFO - PROCESS | 1648 | 16:55:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:55:32 INFO - PROCESS | 1648 | RSS: Main: 298307584 16:55:32 INFO - PROCESS | 1648 | 16:55:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:55:34 INFO - PROCESS | 1648 | RSS: Main: 303616000 16:55:34 INFO - PROCESS | 1648 | 16:55:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:55:38 INFO - PROCESS | 1648 | RSS: Main: 320106496 16:55:38 INFO - PROCESS | 1648 | 16:55:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:55:42 INFO - PROCESS | 1648 | RSS: Main: 313753600 16:55:42 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 16:55:44 INFO - PROCESS | 1648 | RSS: Main: 358531072 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | __start_tp_report 16:55:44 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 16:55:44 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 16:55:44 INFO - PROCESS | 1648 | |i|pagename|runs| 16:55:44 INFO - PROCESS | 1648 | |0;ai-astar;116;117;114;115;115;116;115;116;114;115 16:55:44 INFO - PROCESS | 1648 | |1;audio-beat-detection;143;110;109;144;108;110;108;112;154;135 16:55:44 INFO - PROCESS | 1648 | |2;audio-dft;186;184;184;184;182;183;183;184;186;184 16:55:44 INFO - PROCESS | 1648 | |3;audio-fft;81;64;81;117;86;62;59;59;78;59 16:55:44 INFO - PROCESS | 1648 | |4;audio-oscillator;89;70;87;70;69;68;82;69;70;83 16:55:44 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;91;89;90;89;89;90;90;90;89;90 16:55:44 INFO - PROCESS | 1648 | |6;imaging-darkroom;96;96;96;97;97;96;96;96;96;96 16:55:44 INFO - PROCESS | 1648 | |7;imaging-desaturate;83;86;83;85;84;85;85;82;83;81 16:55:44 INFO - PROCESS | 1648 | |8;json-parse-financial;64;63;64;63;63;66;65;63;63;64 16:55:44 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;53;68;90;88;87;57;60;58;58;58 16:55:44 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;84;85;86;82;86;82;101;83;84;76 16:55:44 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;138;151;141;131;137;138;140;143;215;169 16:55:44 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;165;165;164;164;163;207;214;218;162;164 16:55:44 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;65;65;64;65;65;65;65;65;63;64 16:55:44 INFO - PROCESS | 1648 | __end_tp_report 16:55:44 INFO - PROCESS | 1648 | __start_cc_report 16:55:44 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2213 16:55:44 INFO - PROCESS | 1648 | __end_cc_report 16:55:44 INFO - PROCESS | 1648 | __startTimestamp1491350144301__endTimestamp 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | ------- Summary: start ------- 16:55:44 INFO - PROCESS | 1648 | Number of tests: 14 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.50 stddev:0.95 (0.8%) stddev-sans-first:0.97 16:55:44 INFO - PROCESS | 1648 | Values: 116.0 117.0 114.0 115.0 115.0 116.0 115.0 116.0 114.0 115.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:123.50 stddev:18.41 (14.9%) stddev-sans-first:18.09 16:55:44 INFO - PROCESS | 1648 | Values: 143.0 110.0 109.0 144.0 108.0 110.0 108.0 112.0 154.0 135.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.25 (0.7%) stddev-sans-first:1.09 16:55:44 INFO - PROCESS | 1648 | Values: 186.0 184.0 184.0 184.0 182.0 183.0 183.0 184.0 186.0 184.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:74.60 Median:71.00 stddev:18.33 (25.8%) stddev-sans-first:19.29 16:55:44 INFO - PROCESS | 1648 | Values: 81.0 64.0 81.0 117.0 86.0 62.0 59.0 59.0 78.0 59.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:8.46 (11.1%) stddev-sans-first:7.48 16:55:44 INFO - PROCESS | 1648 | Values: 89.0 70.0 87.0 70.0 69.0 68.0 82.0 69.0 70.0 83.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:90.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 16:55:44 INFO - PROCESS | 1648 | Values: 91.0 89.0 90.0 89.0 89.0 90.0 90.0 90.0 89.0 90.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:55:44 INFO - PROCESS | 1648 | Values: 96.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:83.70 Median:84.50 stddev:1.57 (1.9%) stddev-sans-first:1.64 16:55:44 INFO - PROCESS | 1648 | Values: 83.0 86.0 83.0 85.0 84.0 85.0 85.0 82.0 83.0 81.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 16:55:44 INFO - PROCESS | 1648 | Values: 64.0 63.0 64.0 63.0 63.0 66.0 65.0 63.0 63.0 64.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:64.00 stddev:14.74 (23.0%) stddev-sans-first:14.64 16:55:44 INFO - PROCESS | 1648 | Values: 53.0 68.0 90.0 88.0 87.0 57.0 60.0 58.0 58.0 58.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:6.35 (7.6%) stddev-sans-first:6.73 16:55:44 INFO - PROCESS | 1648 | Values: 84.0 85.0 86.0 82.0 86.0 82.0 101.0 83.0 84.0 76.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:142.00 stddev:25.02 (17.6%) stddev-sans-first:26.14 16:55:44 INFO - PROCESS | 1648 | Values: 138.0 151.0 141.0 131.0 137.0 138.0 140.0 143.0 215.0 169.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:165.00 stddev:23.90 (14.5%) stddev-sans-first:24.84 16:55:44 INFO - PROCESS | 1648 | Values: 165.0 165.0 164.0 164.0 163.0 207.0 214.0 218.0 162.0 164.0 16:55:44 INFO - PROCESS | 1648 | 16:55:44 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 16:55:44 INFO - PROCESS | 1648 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 63.0 64.0 16:55:44 INFO - PROCESS | 1648 | -------- Summary: end -------- 16:55:44 INFO - PROCESS | 1648 | 16:55:45 INFO - TEST-INFO | 1648: exit 0 16:55:45 INFO - TEST-OK | kraken | took 60124ms 16:55:45 INFO - SUITE-END | took 1180s 16:55:45 INFO - Completed test suite (00:19:40) 16:55:45 INFO - javascript benchmark 16:55:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7558.373461465421, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.3845230953807, 3263.2820779428516, 3369.736348869174, 3378.459446488562, 3427.9657203427973, 5881.911771323428, 5911.85220369491, 5918.644881307114, 5968.313643930944, 5974.551908606855, 5917.970410147954, 5934.703264836762, 5943.643381397108, 5960.850978725534, 5999.460048595625, 5337.70642614656, 5385.649932754359, 5388.084025715638, 5469.835904922858, 5476.26070480486, 5262.631615786897, 5271.499207575293, 5314.415414304423, 5370.91943620846, 5492.286002819648, 5394.541463975567, 5436.592255580827, 5443.673379597217, 5446.2647542581835, 5495.313085864267, 5444.646098003617, 5451.454854514556, 5452.100403433429, 5455.208994695787, 5460.126379779256, 5251.0, 5251.343582052244, 5292.814751483718, 5388.1648344506275, 5451.863703407407, 5808.535317174616, 5813.186153938452, 5821.563382746311, 5823.82528524145, 5843.948089343917, 6256.405641464054, 6349.238091429058, 6394.296627370985, 6402.391772781578, 6407.903881441782, 6354.2692590352235, 6383.808485745389, 6396.968015159894, 6397.040443933401, 6440.710168042449, 5606.467385598362, 6110.663913484756, 6126.571140020245, 6126.663033533154, 6127.5404344674325, 6002.849928751816, 6327.715252813635, 6374.139491168633, 6385.457236134887, 6461.547691661539, 6367.968160159262, 6384.872302553923, 6392.20097487814, 6410.326915673787, 6426.807195784134, 6427.614343139427, 6430.485561155097, 6450.129232553639, 6453.9354606453335, 6464.062710906892, 6250.812475625738, 6269.62382257066, 6353.777617783356, 6393.424591786668, 6403.58376705522, 5020.272060551272, 6331.271903731038, 6379.106925030499, 6393.4885209184085, 6400.359964003563, 5137.691738495702, 5138.743062846917, 5143.12566863634, 5160.200168973815, 5164.948350516522, 4475.26158183896, 4496.123255965055, 4591.265397536378, 4613.838515651936, 4636.79134438951, 5863.882722345529, 5978.611390259619, 6024.819255422344, 6074.544409169242, 6107.48086412651, 6318.462930650854, 6425.261094974045, 6425.518086143465, 6427.839304017437, 6434.549581529342, 6034.336223015464, 6041.124037014608, 6051.727672254671, 6067.089936509471, 6067.362926892701, 5475.780968761284, 5510.724463776795, 5596.244506991504, 5598.776048957996, 5601.103823388238, 6402.6158430494315, 6409.230892293048, 6418.422341989243, 6421.357864213542, 6491.993740970157, 5687.374388817144, 6151.661658608819, 6375.521835862236, 6408.487321014401, 6428.357164283534, 6619.404253617197, 6627.867442651216, 6630.535862489773, 6657.866842663023, 6678.465722742266, 6225.972714502056, 6283.8114856554375, 6422.582532135396, 6439.7424103035355, 6453.257875344396, 5295.655782374133, 6183.103449999815, 6344.682765861596, 6417.133686952202, 6436.098946147449, 6311.116443697794, 6349.9682501587195, 6358.395952384516, 6380.234371875219, 6381.904271435839, 6131.957816599936, 6330.556861019684, 6361.840953976188, 6364.0, 6373.904391434039, 6097.329293777592, 6147.954847675816, 6177.0, 6266.624002559861, 6270.404311590391, 6344.71448784815, 6361.713722882574, 6367.363263673596, 6368.9044664330995, 6388.840278993062, 6193.783217587543, 6239.594426362272, 6245.656488893154, 6245.781397651061, 6263.718132684131], "value": 5874.4445253341155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.6128958111599, 750.8160500677335, 803.4616806739485, 872.5288344294078, 882.488156869016, 27439.314017149558, 27706.0, 28610.570841437395, 38953.805230973805, 39684.809455716306, 40512.79743601285, 40650.0, 40673.796631016805, 40698.389524157086, 40739.59260407402, 9140.0, 9293.58178881952, 9305.0, 9305.0, 9310.53447327631, 7258.600776957265, 7412.444066694992, 9207.631694732203, 10874.510647020863, 11149.554017839277, 10091.344062635942, 10580.259381843274, 11105.167112466557, 11106.333619982826, 11183.776324473505, 10979.341239525615, 10997.34015959037, 11012.834807477895, 11021.228514004022, 11039.061679757231, 7232.457565682595, 7398.149212840484, 10645.787084258349, 10790.543276657629, 10884.891151088466, 38326.0, 38528.22943541114, 38549.614503854886, 38564.421533677014, 38663.8066809667, 3720.9302325581502, 3823.483829683013, 3853.075261937143, 3887.630675085862, 3928.5874983126646, 27275.727242727517, 28124.437511249864, 28717.856410717814, 28738.568921466194, 28832.567511487345, 3010.6387233531896, 3052.8931487397836, 3071.3703690743346, 3176.126565194567, 3284.310294838087, 295561.52219238767, 295603.0, 297498.0, 298234.0, 299992.0, 50846.745766270935, 50887.491125089015, 50978.490215098114, 51063.74468127636, 51064.74467627638, 44238.0, 51603.96792064138, 53177.7341113292, 53308.73345633247, 53417.0, 14791.0, 14926.776098358534, 14936.70126597462, 14943.178125203001, 14957.775633365509, 12891.806622900664, 12900.0, 12960.870391295966, 12963.416646250942, 12967.0, 8596.742097737078, 8759.036505984337, 10250.026247506476, 11488.885111148782, 11511.942440287912, 4794.154250613539, 5013.248012798036, 5561.58288128392, 5629.521490673339, 5643.887122257614, 1103.194667892443, 1127.6278827986744, 1134.8581427321585, 1135.625243669587, 1147.846414353586, 25806.612900806504, 25872.094476693226, 26399.0, 26474.867625662133, 26484.33789155248, 1052.8368102944055, 1232.6548566401423, 1234.1361047266769, 1247.8910641016653, 1297.2994582925303, 11796.29222246668, 13534.187948723109, 13726.039177257695, 13930.930345348208, 14511.419543218153, 478263.0, 482520.0, 483328.0, 483483.0, 483985.0, 48909.266361004615, 49108.75445622749, 49116.263256051185, 49221.50778492169, 49230.01539969252, 1349.2376807103956, 1383.0387880423411, 1384.5431007767613, 1385.2173521960262, 1390.367382840805, 24370.0, 25488.617670734584, 26434.206973790817, 26627.60058599161, 26638.733612663626, 39494.01264968284, 39575.2084958305, 39588.2082358357, 39622.60377396189, 39632.00919977023, 430198.0, 430486.0, 430659.0, 431166.0, 431760.0, 28108.0, 29021.12936611905, 29562.704372955995, 30359.544606830474, 30395.0, 38713.4192987111, 39041.80479097586, 39072.2185556293, 39389.0, 39481.01297467586, 27109.1867243983, 27776.583351250152, 28524.57213141763, 28854.711452885203, 29291.53542322918, 20002.69995950091, 28193.01324453634, 28474.0, 28836.855815720788, 29002.099790020828, 31509.527357089202, 32321.35357292794, 32668.183295417806, 32709.69161233524, 33114.33771324608, 27776.722232777414, 27829.02598409046, 28462.85768571144, 28601.42797144087, 28625.71374286314, 22596.322110336718, 22770.544589107794, 22960.4259893504, 23075.961581728527, 23109.88445057764], "value": 17931.014100792912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.84606157537, 405.8599783074838, 423.19381578093726, 429.8581468115522, 446.3795324498945, 12713.936430317846, 14636.634084147901, 20481.897590512028, 20961.895190524046, 21411.892940535276, 21555.892220538877, 21685.3494395168, 22093.005814738335, 22387.664185037236, 22641.886790566066, 6414.454771344442, 6481.611103333803, 6593.703283352261, 6648.734050637969, 6666.23338316095, 6348.301686814447, 6530.249021362557, 6546.214454265471, 6596.901046484307, 6684.732610695566, 6733.764318248862, 6748.595084294958, 6750.189977202718, 6752.898706519406, 6767.796966091, 6350.206224221973, 6432.774852880174, 6679.332066793282, 6694.397504224643, 6740.393364597186, 6433.8391540211405, 6498.740050397979, 6509.6419696916655, 6516.501204722893, 6521.445677117451, 26681.866590666923, 26945.461090778073, 27108.59337109945, 27260.59109113365, 27426.588601171, 2585.2244326702103, 2599.820770686061, 2602.6616539849697, 2608.1132414978997, 2633.6350832839826, 16288.918555407266, 16357.91821040899, 16567.585810354718, 16596.50210493687, 17189.1405429728, 1958.9020548972494, 1992.481954691776, 2009.3670493794407, 2011.1754180785808, 2029.411470673503, 132400.33799831037, 132592.0, 140247.89628155585, 141264.0, 141338.0, 20229.696554551694, 21361.67957480639, 21447.0, 21558.245461408776, 21750.0, 35278.47082293768, 35866.82066589651, 35968.10079748027, 35971.82014089913, 35995.64004359975, 9086.681966131153, 10435.676648245739, 10790.24468287228, 10962.671119866416, 11175.050120739828, 7478.2521747824785, 9000.099990000948, 9022.917249929918, 9091.454512729257, 9216.032316606794, 9880.0, 10208.897911020944, 10349.068583827491, 10387.0, 10387.779788265661, 3326.467765157563, 3408.8468166945477, 3961.187956468917, 4139.855105071308, 4146.896327591834, 877.7279043496536, 879.3009557401881, 887.9556022198864, 904.615538396179, 922.6401703335705, 21638.891805541185, 22303.0, 22417.215397461012, 22506.66240006401, 22645.773542264695, 730.2770257445092, 907.2968449451728, 919.1268295119663, 920.3787443475761, 926.36081104038, 11227.38249396291, 11259.887401126047, 11349.865013498584, 11900.940495297467, 11958.880411195776, 719887.201691975, 737334.3133284299, 737593.0, 759632.0, 765309.0, 127575.0, 157585.2120739389, 158657.2067139657, 160087.0, 164280.0, 1226.0743138930052, 1247.9376031198403, 1273.7325161715958, 1287.1247551664958, 1288.6585054960442, 19153.083448529098, 19920.81229342077, 20075.820009889707, 20170.0, 20195.192192312144, 55564.72217638886, 56296.0, 62375.6881215591, 64472.0, 65700.67149664412, 56901.430985691266, 80856.59571702103, 81070.59464702639, 81595.0, 82452.58773706094, 11397.632284125957, 11444.94277528607, 11621.954024137869, 11626.418679066182, 11865.940670296593, 10744.51649675782, 11325.32048077118, 12227.0, 12959.416826242654, 13139.474421023053, 10611.09805666527, 10818.945905270422, 10845.186611004048, 10960.0, 10961.561537538728, 8448.450850694686, 9389.765255868659, 10164.491775411052, 10208.897911021091, 10513.894861051598, 11258.493367798632, 11332.716682083013, 11351.772964540829, 11479.827802583135, 11641.825372619249, 11136.33182009082, 11287.717807054889, 11428.599998999995, 11434.199606027498, 11480.196386252883, 8586.441881277697, 10718.35689858611, 10754.300970436896, 10964.945175274073, 11201.327920324806], "value": 11361.591554839519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.6517588015054, 1415.3630866110248, 1562.3672412672865, 1607.606136496558, 1610.8228094909562, 9164.450132992026, 9581.041895810415, 10768.73078173045, 11087.168462365335, 11285.097192224623, 10907.83638245427, 11040.33757974522, 11057.778844423106, 11085.113190944725, 11096.778064438706, 2046.4474591860226, 2432.1487479382254, 2442.096424323003, 2443.7556244375596, 2445.596476581362, 1984.335247692025, 2062.288510463895, 2362.0669835415, 2443.9389015274583, 2461.483088551406, 2145.7639659637507, 2420.0, 2426.6238732996326, 2426.8543887366814, 2427.053449154831, 2360.5160942006846, 2396.412878844694, 2402.5915594349003, 2403.7836594706387, 2413.4569721812713, 2346.190564255346, 2368.857868527894, 2376.429656882353, 2380.5000949800565, 2392.294273189396, 10787.5684972601, 11024.50389732464, 11042.668719938414, 11042.779144417147, 11052.502637381338, 5570.275864137677, 5735.913961290584, 5741.540676745851, 5752.424757524214, 5756.683382413966, 3427.1946092668204, 3539.7876127432437, 3679.2089700714473, 3684.4841722158917, 3686.3733165361955, 1070.1599244592958, 1151.8157094864864, 1153.123626044204, 1190.8749581293926, 1238.5479300055506, 15231.162286074261, 15363.0, 15429.691406171925, 15440.768388474069, 15447.459338923196, 4785.617150627942, 4939.456659767423, 5025.6482046256415, 5043.067032598908, 5065.594752419871, 12911.0, 12911.35443227835, 12913.612591622266, 12916.095873288967, 12933.417996190194, 6032.517398608101, 6044.637321760709, 6059.303180134253, 6060.42425969541, 6064.545159113084, 4493.7977790999485, 5023.799048038038, 5235.554977826851, 5303.681779093266, 5313.415524292402, 3638.0, 4086.0602061526015, 4210.578942105765, 4231.61915427613, 4233.343831706091, 1139.151332257457, 1155.5608868630036, 1157.4039369724599, 1167.3462860797981, 1170.3563040327786, 914.410205417502, 922.0, 933.2487347685178, 934.9621919669162, 982.8673129127619, 6149.41580549847, 6475.32009139043, 6652.334766523309, 6777.220619628707, 6818.318168183142, 856.5075081827974, 987.3976874106789, 992.1764935103846, 1007.1367969256962, 1040.287403128859, 4001.679865610744, 4164.271252530795, 4186.958130418718, 4222.303319952173, 4296.505901821268, 13234.205947643171, 13939.930300348433, 13954.372053257628, 13955.023148379516, 13965.930170349286, 13759.38082786277, 13909.165450073027, 13921.095128816594, 13938.790918136236, 13940.024198306224, 9731.978142295098, 10123.544440500194, 10233.9488302558, 10234.385936843813, 10251.641192558225, 5733.455321744427, 5852.239208902815, 6630.370114839083, 6723.428508576826, 6975.79072627822, 11862.881371186179, 12044.75910481768, 12257.938710306391, 12317.876821231674, 12414.751704965669, 12137.817932731192, 12372.13395062337, 12375.195612285173, 12377.133600647869, 12568.30874301922, 8772.078931712078, 8820.162084601952, 8848.690295839615, 8936.41913275635, 8960.596773145095, 8188.959055204686, 8705.998810136914, 8971.50656713887, 8986.236169925369, 9885.950570247103, 8643.17889800468, 8800.779980500538, 8853.69012084574, 8874.112588741333, 9072.364934454788, 8574.056853746208, 8629.482231066157, 8659.653613855375, 8715.91284087151, 8762.780930476789, 7769.0, 7911.12977572455, 7993.440459167802, 8005.07941586725, 8008.1191068983535, 4945.530174633404, 5520.951019306319, 5683.829485115453, 5740.425957404226, 5828.475437210672, 4979.477154898684, 5043.5460808527405, 5080.263361812443, 5709.628874123168, 5945.583809133319], "value": 5109.00860291063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6923338228975, 353.5509902423921, 381.3383779143186, 381.7804762261697, 387.1559999201741, 4410.338449232617, 5023.497650234975, 5080.745962701869, 5083.085044691954, 5149.253358263049, 4780.8565743027675, 4869.172240719077, 4961.652684312091, 4974.850754477362, 5003.14883493108, 3357.446021406477, 3536.398812201932, 3754.6808521275725, 4148.730332528384, 4202.579742025789, 3617.981910090446, 3898.9805050974705, 3901.5708272090046, 3995.7602543847315, 4106.67359438854, 3846.2114816905328, 4098.897527561805, 4180.2025129194435, 4186.518550366701, 4286.614204721574, 4085.285075111873, 4099.467069280974, 4136.503619565641, 4155.376693495985, 4184.14225083857, 3545.503629491873, 3691.9847042063648, 3818.56803698613, 3850.6534411903062, 3869.400242962345, 4250.447441832542, 4661.336476181422, 4695.272232803921, 4781.235002399634, 4905.2151655734915, 3559.839807208682, 3950.9924969132976, 4266.914661706748, 4720.858374248778, 4775.474697783241, 4819.975900120477, 4870.878228044292, 4960.70235785854, 5254.605904557174, 5298.0, 3792.260509200707, 4235.162441164427, 4243.384709217146, 4325.783710814479, 4398.318260669601, 5237.816676416345, 5480.945190548084, 5531.585131115183, 5561.804212094419, 5643.476261409396, 4724.763761811896, 4760.928791022062, 4798.185442573163, 4840.685355451885, 4863.537963893425, 4140.660526802347, 4245.660347172219, 4717.0, 4928.876778080505, 4929.433115191727, 4484.730916145042, 4537.185125949646, 4616.330632058332, 5000.849974500771, 5033.7734801934, 5051.722155281494, 5140.997505486394, 5311.442298558673, 5313.388960269541, 5341.893162136736, 1573.7796708460824, 1592.4983630156696, 1635.386729976259, 1676.3964972609851, 1692.2892385198247, 1253.846461255647, 1261.7287283234148, 1351.2838195756265, 1363.936129818743, 1365.7132002279632, 4388.451443569554, 4877.074155103372, 4945.10711233925, 4992.15133427311, 4998.275250088716, 4668.299755036704, 5125.718085505333, 5416.322959630046, 5439.972800135974, 5445.821671331499, 4111.938320925188, 4679.298105284234, 4682.601978831837, 4802.7341407842305, 4908.141075311806, 2475.4553998120386, 2515.823892327556, 2841.928951776181, 2848.7293707097792, 2863.9952033576164, 4830.7101573905675, 5638.43615638441, 5647.37878833328, 5656.632318899258, 5683.829485115453, 4678.789454474557, 5014.389639459583, 5247.921281180786, 5376.247325374451, 5554.805716770914, 4639.559241872017, 5396.163594642837, 5627.803026894039, 5632.3804381518, 5702.543796496353, 4924.704517728805, 5048.62714524173, 5446.429463046448, 5487.862803429786, 5507.697076660662, 4491.96684762513, 4518.412606361152, 5109.821156259513, 5360.571154307568, 5438.537724293479, 4935.8025678972435, 5587.804426845041, 5645.0, 5673.461021203144, 5677.063284558001, 4555.612772914207, 4747.501512341292, 4779.733370656709, 4820.132376172322, 4826.758662066813, 4810.7113573185725, 4896.36347274852, 5281.260623512634, 5413.458654134555, 5444.918326225189, 4591.714319990408, 4769.594584460221, 4827.59999600112, 5293.894122117613, 5318.175682769177, 4658.767061646837, 4836.564709176191, 5161.432242453402, 5254.710990895537, 5274.97362513185, 4555.863324100283, 4707.882302942454, 5089.567386772018, 5098.005888851639, 5141.408737995179, 4733.479317275028, 4918.458969513422, 5210.723372773543, 5350.732463376893, 5371.194320851903, 4536.818527259004, 4844.588210002048, 4847.757612119451, 5151.8196863109615, 5209.0], "value": 4108.91541761725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2800807180715, 735.7204262380299, 744.9515781474204, 818.8239528501372, 824.2252282854118, 13377.26425046622, 15241.771373429394, 15427.228638568069, 16221.513354599381, 16275.0, 14272.215028173447, 14613.123212607252, 14666.560003199895, 14739.852601473982, 15360.692786144298, 915.7939463620698, 946.820104180207, 952.8380175370169, 956.206348730552, 957.6791774755466, 920.2959735802117, 939.2673714502665, 941.8493041113423, 956.6603855631255, 958.966436174734, 1006.5571148694551, 1010.6816352848866, 1011.0597144655468, 1011.3426272922586, 1012.1346248957146, 1005.3415013166315, 1006.8892421833592, 1008.0222184481041, 1009.6920439266021, 1010.0757806606946, 744.9962750186269, 745.329203716654, 745.3478206569251, 746.6901235987059, 751.3801114080851, 15383.0, 15764.684706305925, 15831.762523562156, 15965.201739912958, 16269.430569929995, 14049.578512644637, 14155.363008664635, 14315.57053288403, 14357.066790658573, 14404.783928241084, 11479.25384849982, 11770.470328835223, 11908.821367679491, 11958.40207989597, 12339.568115116017, 3350.3299340131825, 3581.1584277694983, 3653.2328211075705, 3675.4303083022173, 3691.169486865461, 105365.41951870728, 108049.45975270151, 108515.99999999921, 109074.0, 109622.45188774086, 9845.950770246103, 9856.162226210852, 10290.794184116276, 10581.259311848096, 10942.069924056545, 21056.684149737765, 21308.57382852365, 21356.0, 21504.0, 21640.134394624038, 7467.551946883204, 7474.85050298991, 7496.362809161283, 7572.4699271050495, 7680.155182929873, 4210.347396153601, 4281.100968796588, 4315.892102697458, 4320.308750599952, 4430.82276708928, 3250.609926808751, 3341.18141055443, 3343.297907439465, 3346.6151392589677, 3351.0784534253276, 602.8553147244629, 611.8133969139456, 631.3970158498623, 636.7071147272306, 639.398964972924, 542.7503348459753, 620.7796232337546, 646.812424396929, 647.4852492268564, 655.9376859198369, 8785.542576435422, 9591.136797688241, 9676.919771990466, 9760.609575617038, 9761.804763904682, 627.1157667688537, 637.8501052252717, 664.707528687376, 672.2269390201308, 684.7534887440518, 4321.222180007629, 4617.561331673485, 4622.46841613212, 4624.5144259852905, 4627.375304333939, 83669.58165209135, 95696.52151739197, 97758.5112074435, 98628.52057219147, 100613.49693251487, 52450.0, 59966.0, 60362.0, 74937.0, 81934.59032704799, 62271.68864155741, 67045.65908681897, 67959.0, 69085.96371054438, 69242.30757692359, 10043.69868903934, 10679.199060070681, 11160.162987775788, 11312.886871131182, 11480.82778758336, 41275.555355563614, 42002.78998604987, 42404.0, 43818.780906095264, 44842.87892802706, 50255.49744502654, 61942.69028654828, 63755.0, 63864.68067659632, 65121.0, 12704.618861434172, 13022.804657930328, 13117.34413279313, 13228.735425291248, 13658.385372658055, 14978.0, 15068.472603458826, 15081.662342336955, 15239.149071913977, 15246.3901443941, 13503.613306523923, 13582.524611638546, 13880.097793643381, 13958.930205348908, 14643.56069317922, 13247.735045299232, 13324.333783310989, 13827.654308641962, 13846.684564966312, 13920.651983700489, 12913.289769062792, 13331.200127992352, 13474.124181928144, 13486.325683715579, 13547.458101675822, 9652.517374131125, 9937.254705896941, 10171.796564068825, 10196.898031019891, 10225.233107517115, 9292.495253322837, 11150.498227579941, 11371.48828302745, 11385.316880987168, 11402.372869491926], "value": 7420.865795875262, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 114.0, 115.0, 115.0, 116.0, 115.0, 116.0, 114.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 109.0, 144.0, 108.0, 110.0, 108.0, 112.0, 154.0, 135.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 184.0, 184.0, 182.0, 183.0, 183.0, 184.0, 186.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 64.0, 81.0, 117.0, 86.0, 62.0, 59.0, 59.0, 78.0, 59.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 87.0, 70.0, 69.0, 68.0, 82.0, 69.0, 70.0, 83.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 90.0, 89.0, 89.0, 90.0, 90.0, 90.0, 89.0, 90.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 83.0, 85.0, 84.0, 85.0, 85.0, 82.0, 83.0, 81.0], "value": 83.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 66.0, 65.0, 63.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 68.0, 90.0, 88.0, 87.0, 57.0, 60.0, 58.0, 58.0, 58.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 82.0, 86.0, 82.0, 101.0, 83.0, 84.0, 76.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 151.0, 141.0, 131.0, 137.0, 138.0, 140.0, 143.0, 215.0, 169.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 164.0, 163.0, 207.0, 214.0, 218.0, 162.0, 164.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 63.0, 64.0], "value": 64.6, "unit": "score"}]}]} 16:55:45 INFO - Return code: 0 16:55:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:55:45 ERROR - # TBPL SUCCESS # 16:55:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:45 INFO - 2017-04-04 16:55:45.642 screenresolution[1652:10002] starting screenresolution argv=screenresolution get 16:55:45 INFO - 2017-04-04 16:55:45.645 screenresolution[1652:10002] Display 0: 1600x1200x32@60 16:55:45 INFO - 2017-04-04 16:55:45.651 screenresolution[1653:10006] starting screenresolution argv=screenresolution list 16:55:45 INFO - Available Modes on Display 0 16:55:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:45 INFO - Intel Iris: 16:55:45 INFO - Chipset Model: Intel Iris 16:55:45 INFO - Type: GPU 16:55:45 INFO - Bus: Built-In 16:55:45 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:45 INFO - Vendor: Intel (0x8086) 16:55:45 INFO - Device ID: 0x0a2e 16:55:45 INFO - Revision ID: 0x0009 16:55:45 INFO - Displays: 16:55:45 INFO - Display: 16:55:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:45 INFO - Display Serial Number: 1600x1200 60 16:55:45 INFO - Main Display: Yes 16:55:45 INFO - Mirror: Off 16:55:45 INFO - Online: Yes 16:55:45 INFO - Rotation: Supported 16:55:45 INFO - Return code: 0 16:55:45 INFO - Running post-action listener: _resource_record_post_action 16:55:45 INFO - [mozharness: 2017-04-04 23:55:45.888158Z] Finished run-tests step (success) 16:55:45 INFO - Running post-run listener: _resource_record_post_run 16:55:45 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38122496; Write bytes: 511064576; Read time: 240; Write time: 1566 16:55:45 INFO - TinderboxPrint: CPU usage
53.9% 16:55:45 INFO - TinderboxPrint: I/O read bytes / time
38,122,496 / 240 16:55:45 INFO - TinderboxPrint: I/O write bytes / time
511,064,576 / 1,566 16:55:45 INFO - TinderboxPrint: CPU idle
2,219.2 (46.1%) 16:55:45 INFO - TinderboxPrint: CPU system
957.9 (19.9%) 16:55:45 INFO - TinderboxPrint: CPU user
1,632.5 (33.9%) 16:55:45 INFO - TinderboxPrint: Swap in / out
246,345,728 / 0 16:55:45 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201738752; Write bytes: 201803776; Read time: 15671; Write time: 443 16:55:45 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 37159936; Write bytes: 299340288; Read time: 226; Write time: 1094 16:55:46 INFO - Running post-run listener: _upload_blobber_files 16:55:46 INFO - Blob upload gear active. 16:55:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:55:46 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 16:55:46 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'] 16:55:46 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 16:55:46 INFO - (blobuploader) - INFO - Open directory for files ... 16:55:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:55:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:55:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:47 INFO - (blobuploader) - INFO - Done attempting. 16:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:48 INFO - (blobuploader) - INFO - Done attempting. 16:55:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:55:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:55:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:49 INFO - (blobuploader) - INFO - Done attempting. 16:55:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:55:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:51 INFO - (blobuploader) - INFO - Done attempting. 16:55:51 INFO - (blobuploader) - INFO - Iteration through files over. 16:55:51 INFO - Return code: 0 16:55:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:55:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:55:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dc6b3439485f4f7a934d3e5fd5895a96fe2055a117067964c0f74287026e62b11bcce85f89a1a495e56565147829ad579292a171f7184817220c4c98c14918d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5d1aa71d11152afa1c4977f84b0745d59bba057a11d9dc152f2f0e4632f03fcdfcb3a7cb8bfbc2e7f5ba70546955f15a6a022f419f0e211ebed9ba12c1cedb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f6fcafbb1c29f56bc8147cc7fcb8253bdd55236dd75557bc4a3a9fa2c11ff3d060b4f4f4f0216aecc1ef39661b967ec1fd7be1d477899cf9dbaeeaf73d2f733", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f0af02a9cd847d8c04631e668a2663802781acb0876774893ab631d53621c828ad94c7a3c94c3b51957a28f5cc673f31768a0073ef1d98bb4ea629f4ef1412"} 16:55:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:55:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:55:51 INFO - Contents: 16:55:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dc6b3439485f4f7a934d3e5fd5895a96fe2055a117067964c0f74287026e62b11bcce85f89a1a495e56565147829ad579292a171f7184817220c4c98c14918d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5d1aa71d11152afa1c4977f84b0745d59bba057a11d9dc152f2f0e4632f03fcdfcb3a7cb8bfbc2e7f5ba70546955f15a6a022f419f0e211ebed9ba12c1cedb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f6fcafbb1c29f56bc8147cc7fcb8253bdd55236dd75557bc4a3a9fa2c11ff3d060b4f4f4f0216aecc1ef39661b967ec1fd7be1d477899cf9dbaeeaf73d2f733", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f0af02a9cd847d8c04631e668a2663802781acb0876774893ab631d53621c828ad94c7a3c94c3b51957a28f5cc673f31768a0073ef1d98bb4ea629f4ef1412"} 16:55:51 INFO - Running post-run listener: copy_logs_to_upload_dir 16:55:51 INFO - Copying logs to upload dir... 16:55:51 INFO - mkdir: /builds/slave/test/build/upload/logs 16:55:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.998760 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-04 16:55:52.068293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 16:55:52.073627) ========= 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.YyERXokh9f/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.VcaV2L90tv/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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/2dc6b3439485f4f7a934d3e5fd5895a96fe2055a117067964c0f74287026e62b11bcce85f89a1a495e56565147829ad579292a171f7184817220c4c98c14918d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5d1aa71d11152afa1c4977f84b0745d59bba057a11d9dc152f2f0e4632f03fcdfcb3a7cb8bfbc2e7f5ba70546955f15a6a022f419f0e211ebed9ba12c1cedb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f6fcafbb1c29f56bc8147cc7fcb8253bdd55236dd75557bc4a3a9fa2c11ff3d060b4f4f4f0216aecc1ef39661b967ec1fd7be1d477899cf9dbaeeaf73d2f733", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f0af02a9cd847d8c04631e668a2663802781acb0876774893ab631d53621c828ad94c7a3c94c3b51957a28f5cc673f31768a0073ef1d98bb4ea629f4ef1412"} build_url:https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011111 build_url: 'https://queue.taskcluster.net/v1/task/XA4BEYgWRlytPS-mNyRWww/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dc6b3439485f4f7a934d3e5fd5895a96fe2055a117067964c0f74287026e62b11bcce85f89a1a495e56565147829ad579292a171f7184817220c4c98c14918d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a5d1aa71d11152afa1c4977f84b0745d59bba057a11d9dc152f2f0e4632f03fcdfcb3a7cb8bfbc2e7f5ba70546955f15a6a022f419f0e211ebed9ba12c1cedb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f6fcafbb1c29f56bc8147cc7fcb8253bdd55236dd75557bc4a3a9fa2c11ff3d060b4f4f4f0216aecc1ef39661b967ec1fd7be1d477899cf9dbaeeaf73d2f733", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0f0af02a9cd847d8c04631e668a2663802781acb0876774893ab631d53621c828ad94c7a3c94c3b51957a28f5cc673f31768a0073ef1d98bb4ea629f4ef1412"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 16:55:52.114904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:55:52.115530) ========= 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.YyERXokh9f/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.VcaV2L90tv/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.005251 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 16:55:52.167065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 16:55:52.167891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 16:55:52.168923) ========= ========= Total master_lag: 0.20 =========