builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0259 starttime: 1493425813.79 results: success (0) buildid: 20170428154347 builduid: 28ef61acb52c41fe9eb5b21a1265788e revision: 1c994cd72265c48bbdc9f6404df87c4eae488b34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:13.793561) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:13.794028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:13.794321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:13.828615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-28 17:30:13.829033) ========= 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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-28 17:30:13-- 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% 6.06M=0.002s 2017-04-28 17:30:13 (6.06 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091018 ========= master_lag: 3.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-28 17:30:17.072184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:17.072526) ========= 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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.020927 ========= master_lag: 0.66 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:17.749447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:30:17.749814) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c994cd72265c48bbdc9f6404df87c4eae488b34 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1c994cd72265c48bbdc9f6404df87c4eae488b34 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NZwEa1pQuK/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.KDbmRx0W9P/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-28 17:30:17,770 truncating revision to first 12 chars 2017-04-28 17:30:17,770 Setting DEBUG logging. 2017-04-28 17:30:17,770 attempt 1/10 2017-04-28 17:30:17,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c994cd72265?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 17:30:19,102 unpacking tar archive at: mozilla-central-1c994cd72265/testing/mozharness/ program finished with exit code 0 elapsedTime=1.616623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:30:19.391024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:19.391347) ========= script_repo_revision: 1c994cd72265c48bbdc9f6404df87c4eae488b34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:19.391741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:19.392060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:30:19.412692) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-28 17:30:19.413153) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NZwEa1pQuK/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.KDbmRx0W9P/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:30:19 INFO - MultiFileLogger online at 20170428 17:30:19 in /builds/slave/test 17:30:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:30:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:30:19 INFO - {'append_to_log': False, 17:30:19 INFO - 'base_work_dir': '/builds/slave/test', 17:30:19 INFO - 'blob_upload_branch': 'Firefox', 17:30:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:30:19 INFO - 'branch': 'Firefox', 17:30:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:30:19 INFO - 'config_files': ('talos/mac_config.py',), 17:30:19 INFO - 'default_actions': ('clobber', 17:30:19 INFO - 'read-buildbot-config', 17:30:19 INFO - 'download-and-extract', 17:30:19 INFO - 'populate-webroot', 17:30:19 INFO - 'create-virtualenv', 17:30:19 INFO - 'install', 17:30:19 INFO - 'run-tests'), 17:30:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:30:19 INFO - 'download_minidump_stackwalk': True, 17:30:19 INFO - 'download_symbols': 'ondemand', 17:30:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:30:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:30:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:30:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:30:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:30:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:30:19 INFO - 'gecko_profile': False, 17:30:19 INFO - 'gecko_profile_interval': 0, 17:30:19 INFO - 'installer_path': 'installer.exe', 17:30:19 INFO - 'log_level': 'info', 17:30:19 INFO - 'log_name': 'talos', 17:30:19 INFO - 'log_to_console': True, 17:30:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:30:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:30:19 INFO - 'opt_config_files': (), 17:30:19 INFO - 'pip_index': False, 17:30:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:30:19 INFO - 'cmd': ('bash', 17:30:19 INFO - '-c', 17:30:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:30:19 INFO - 'enabled': True, 17:30:19 INFO - 'halt_on_failure': False, 17:30:19 INFO - 'name': 'check_screen_resolution'},), 17:30:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:30:19 INFO - 'cmd': ('bash', 17:30:19 INFO - '-c', 17:30:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:30:19 INFO - 'enabled': True, 17:30:19 INFO - 'halt_on_failure': False, 17:30:19 INFO - 'name': 'check_screen_resolution'},), 17:30:19 INFO - 'run_cmd_checks_enabled': True, 17:30:19 INFO - 'suite': 'dromaeojs', 17:30:19 INFO - 'system_bits': '32', 17:30:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:30:19 INFO - 'title': 't-yosemite-r7-0259', 17:30:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:30:19 INFO - 'use_talos_json': True, 17:30:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:30:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:30:19 INFO - 'work_dir': 'build'} 17:30:19 INFO - [mozharness: 2017-04-29 00:30:19.547916Z] Running clobber step. 17:30:19 INFO - Running pre-action listener: _resource_record_pre_action 17:30:19 INFO - Running main action method: clobber 17:30:19 INFO - rmtree: /builds/slave/test/build 17:30:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:30:21 INFO - Running post-action listener: _resource_record_post_action 17:30:21 INFO - [mozharness: 2017-04-29 00:30:21.774356Z] Finished clobber step (success) 17:30:21 INFO - [mozharness: 2017-04-29 00:30:21.774487Z] Running read-buildbot-config step. 17:30:21 INFO - Running pre-action listener: _resource_record_pre_action 17:30:21 INFO - Running main action method: read_buildbot_config 17:30:21 INFO - Using buildbot properties: 17:30:21 INFO - { 17:30:21 INFO - "project": "", 17:30:21 INFO - "product": "firefox", 17:30:21 INFO - "script_repo_revision": "production", 17:30:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:30:21 INFO - "repository": "", 17:30:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:30:21 INFO - "buildid": "20170428154347", 17:30:21 INFO - "pgo_build": "False", 17:30:21 INFO - "basedir": "/builds/slave/test", 17:30:21 INFO - "buildnumber": 15, 17:30:21 INFO - "slavename": "t-yosemite-r7-0259", 17:30:21 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:30:21 INFO - "platform": "yosemite_r7", 17:30:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:30:21 INFO - "branch": "mozilla-central", 17:30:21 INFO - "repo_path": "mozilla-central", 17:30:21 INFO - "revision": "1c994cd72265c48bbdc9f6404df87c4eae488b34", 17:30:21 INFO - "stage_platform": "macosx64", 17:30:21 INFO - "builduid": "28ef61acb52c41fe9eb5b21a1265788e", 17:30:21 INFO - "slavebuilddir": "test" 17:30:21 INFO - } 17:30:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:30:21 INFO - Running post-action listener: _resource_record_post_action 17:30:21 INFO - [mozharness: 2017-04-29 00:30:21.777727Z] Finished read-buildbot-config step (success) 17:30:21 INFO - [mozharness: 2017-04-29 00:30:21.777873Z] Running download-and-extract step. 17:30:21 INFO - Running pre-action listener: _resource_record_pre_action 17:30:21 INFO - Running main action method: download_and_extract 17:30:21 INFO - mkdir: /builds/slave/test/build/tests 17:30:21 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')]} 17:30:21 INFO - trying https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:30:21 INFO - Downloading https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 17:30:22 INFO - Downloaded 1325 bytes. 17:30:22 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:30:22 INFO - Using the following test package requirements: 17:30:22 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:30:22 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:30:22 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:30:22 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:30:22 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'jsshell-mac.zip'], 17:30:22 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:30:22 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:30:22 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:30:22 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:30:22 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:30:22 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:30:22 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:30:22 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:30:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:30:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:30:22 INFO - Fetch https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:30:23 INFO - Content-Length response header: 52698548 17:30:23 INFO - Bytes received: 52698548 17:30:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:30:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:30:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:30:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:30:41 INFO - Content-Length response header: 52698548 17:30:41 INFO - Bytes received: 52698548 17:30:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:30:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:30:56 INFO - Fetch https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:30:58 INFO - Content-Length response header: 14408809 17:30:58 INFO - Bytes received: 14408809 17:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:58 INFO - trying https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:30:58 INFO - Downloading https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:30:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:31:00 INFO - Downloaded 71215545 bytes. 17:31:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:31:00 INFO - mkdir: /builds/slave/test/properties 17:31:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:31:00 INFO - Writing to file /builds/slave/test/properties/build_url 17:31:00 INFO - Contents: 17:31:00 INFO - build_url:https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:31:02 INFO - Running post-action listener: _resource_record_post_action 17:31:02 INFO - Running post-action listener: set_extra_try_arguments 17:31:02 INFO - [mozharness: 2017-04-29 00:31:02.052584Z] Finished download-and-extract step (success) 17:31:02 INFO - [mozharness: 2017-04-29 00:31:02.052680Z] Running populate-webroot step. 17:31:02 INFO - Running pre-action listener: _resource_record_pre_action 17:31:02 INFO - Running main action method: populate_webroot 17:31:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:31:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:31:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:31:02 INFO - '--tppagecycles', 17:31:02 INFO - '7'], 17:31:02 INFO - 'tests': ['tsvgm']}}, 17:31:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:31:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:31:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:31:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:31:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:31:02 INFO - 'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:31:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:31:02 INFO - 'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['damp', 'tps']}, 17:31:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:31:02 INFO - 'tests': ['damp', 'tps']}, 17:31:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['dromaeo_dom']}, 17:31:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:31:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:31:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:31:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['a11yr', 17:31:02 INFO - 'ts_paint', 17:31:02 INFO - 'tpaint', 17:31:02 INFO - 'sessionrestore', 17:31:02 INFO - 'sessionrestore_no_auto_restore', 17:31:02 INFO - 'tabpaint']}, 17:31:02 INFO - 'other-e10s': {'tests': ['a11yr', 17:31:02 INFO - 'ts_paint', 17:31:02 INFO - 'tpaint', 17:31:02 INFO - 'sessionrestore', 17:31:02 INFO - 'sessionrestore_no_auto_restore', 17:31:02 INFO - 'tabpaint']}, 17:31:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:31:02 INFO - 'ts_paint', 17:31:02 INFO - 'tpaint', 17:31:02 INFO - 'sessionrestore', 17:31:02 INFO - 'sessionrestore_no_auto_restore', 17:31:02 INFO - 'tabpaint']}, 17:31:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:31:02 INFO - 'ts_paint', 17:31:02 INFO - 'tpaint', 17:31:02 INFO - 'sessionrestore', 17:31:02 INFO - 'sessionrestore_no_auto_restore', 17:31:02 INFO - 'tabpaint']}, 17:31:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['a11yr', 17:31:02 INFO - 'ts_paint', 17:31:02 INFO - 'tpaint', 17:31:02 INFO - 'sessionrestore', 17:31:02 INFO - 'sessionrestore_no_auto_restore', 17:31:02 INFO - 'tabpaint']}, 17:31:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['a11yr', 17:31:02 INFO - 'ts_paint', 17:31:02 INFO - 'tpaint', 17:31:02 INFO - 'sessionrestore', 17:31:02 INFO - 'sessionrestore_no_auto_restore', 17:31:02 INFO - 'tabpaint']}, 17:31:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:31:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:31:02 INFO - 'bloom_basic_ref']}, 17:31:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['tsvgx', 17:31:02 INFO - 'tsvgr_opacity', 17:31:02 INFO - 'tart', 17:31:02 INFO - 'tscrollx', 17:31:02 INFO - 'cart', 17:31:02 INFO - 'tsvg_static']}, 17:31:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:31:02 INFO - 'tsvgr_opacity', 17:31:02 INFO - 'tart', 17:31:02 INFO - 'tscrollx', 17:31:02 INFO - 'cart', 17:31:02 INFO - 'tsvg_static']}, 17:31:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:31:02 INFO - 'talos_options': ['--disable-e10s'], 17:31:02 INFO - 'tests': ['tp5o']}, 17:31:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:31:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:31:02 INFO - 'talos_options': ['--disable-e10s', 17:31:02 INFO - '--xperf_path', 17:31:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:02 INFO - 'tests': ['tp5n']}, 17:31:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:31:02 INFO - 'talos_options': ['--xperf_path', 17:31:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:02 INFO - 'tests': ['tp5n']}}, 17:31:02 INFO - 'talos.zip': {'path': '', 17:31:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:31:02 INFO - Running post-action listener: _resource_record_post_action 17:31:02 INFO - [mozharness: 2017-04-29 00:31:02.071776Z] Finished populate-webroot step (success) 17:31:02 INFO - [mozharness: 2017-04-29 00:31:02.071889Z] Running create-virtualenv step. 17:31:02 INFO - Running pre-action listener: _resource_record_pre_action 17:31:02 INFO - Running main action method: create_virtualenv 17:31:02 INFO - Creating virtualenv /builds/slave/test/build/venv 17:31:02 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 17:31:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:31:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:31:02 INFO - Using real prefix '/tools/python27' 17:31:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:31:02 INFO - Installing distribute.............................................................................................................................................................................................done. 17:31:05 INFO - Installing pip.................done. 17:31:05 INFO - Return code: 0 17:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:31:06 INFO - Reading from file tmpfile_stdout 17:31:06 INFO - Output received: 17:31:06 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) 17:31:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:31:06 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')]} 17:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:06 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')]} 17:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:06 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:06 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 17:31:06 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 17:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:06 INFO - 'HOME': '/Users/cltbld', 17:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:06 INFO - 'LOGNAME': 'cltbld', 17:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:06 INFO - 'MOZ_NO_REMOTE': '1', 17:31:06 INFO - 'NO_EM_RESTART': '1', 17:31:06 INFO - 'PAGER': '/bin/cat', 17:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:06 INFO - 'PWD': '/builds/slave/test', 17:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:06 INFO - 'SHELL': '/bin/bash', 17:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:06 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:06 INFO - 'USER': 'cltbld', 17:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:06 INFO - 'XPC_FLAGS': '0x0', 17:31:06 INFO - 'XPC_SERVICE_NAME': '0', 17:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:06 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 17:31:06 INFO - Cleaning up... 17:31:06 INFO - Return code: 0 17:31:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:31:06 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')]} 17:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:06 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')]} 17:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:06 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:06 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 17:31:06 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 17:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:06 INFO - 'HOME': '/Users/cltbld', 17:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:06 INFO - 'LOGNAME': 'cltbld', 17:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:06 INFO - 'MOZ_NO_REMOTE': '1', 17:31:06 INFO - 'NO_EM_RESTART': '1', 17:31:06 INFO - 'PAGER': '/bin/cat', 17:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:06 INFO - 'PWD': '/builds/slave/test', 17:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:06 INFO - 'SHELL': '/bin/bash', 17:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:06 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:06 INFO - 'USER': 'cltbld', 17:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:06 INFO - 'XPC_FLAGS': '0x0', 17:31:06 INFO - 'XPC_SERVICE_NAME': '0', 17:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:06 INFO - Downloading/unpacking psutil>=3.1.1 17:31:06 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 17:31:06 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 17:31:06 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 17:31:06 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 17:31:06 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 17:31:06 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 17:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:10 INFO - Installing collected packages: psutil 17:31:10 INFO - Running setup.py install for psutil 17:31:10 INFO - building 'psutil._psutil_osx' extension 17:31:10 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 17:31:10 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 17:31:10 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 17:31:10 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 17:31:10 INFO - building 'psutil._psutil_posix' extension 17:31:10 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 17:31:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:31:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:31:10 INFO - ^ 17:31:10 INFO - 1 warning generated. 17:31:10 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 17:31:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:10 INFO - Successfully installed psutil 17:31:10 INFO - Cleaning up... 17:31:10 INFO - Return code: 0 17:31:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:11 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')]} 17:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:11 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:11 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 17:31:11 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 17:31:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:11 INFO - 'HOME': '/Users/cltbld', 17:31:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:11 INFO - 'LOGNAME': 'cltbld', 17:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:11 INFO - 'MOZ_NO_REMOTE': '1', 17:31:11 INFO - 'NO_EM_RESTART': '1', 17:31:11 INFO - 'PAGER': '/bin/cat', 17:31:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:11 INFO - 'PWD': '/builds/slave/test', 17:31:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:11 INFO - 'SHELL': '/bin/bash', 17:31:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:11 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:11 INFO - 'USER': 'cltbld', 17:31:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:11 INFO - 'XPC_FLAGS': '0x0', 17:31:11 INFO - 'XPC_SERVICE_NAME': '0', 17:31:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:31:11 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 17:31:11 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 17:31:11 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 17:31:11 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 17:31:11 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 17:31:11 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 17:31:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:31:14 INFO - Installing collected packages: mozsystemmonitor 17:31:14 INFO - Running setup.py install for mozsystemmonitor 17:31:15 INFO - Successfully installed mozsystemmonitor 17:31:15 INFO - Cleaning up... 17:31:15 INFO - Return code: 0 17:31:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:31:15 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')]} 17:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:15 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')]} 17:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:15 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:15 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 17:31:15 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 17:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:15 INFO - 'HOME': '/Users/cltbld', 17:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:15 INFO - 'LOGNAME': 'cltbld', 17:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:15 INFO - 'MOZ_NO_REMOTE': '1', 17:31:15 INFO - 'NO_EM_RESTART': '1', 17:31:15 INFO - 'PAGER': '/bin/cat', 17:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:15 INFO - 'PWD': '/builds/slave/test', 17:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:15 INFO - 'SHELL': '/bin/bash', 17:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:15 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:15 INFO - 'USER': 'cltbld', 17:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:15 INFO - 'XPC_FLAGS': '0x0', 17:31:15 INFO - 'XPC_SERVICE_NAME': '0', 17:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:15 INFO - Downloading/unpacking jsonschema==2.5.1 17:31:15 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 17:31:15 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 17:31:15 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 17:31:15 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 17:31:15 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 17:31:15 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 17:31:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:31:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:31:18 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 17:31:18 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 17:31:18 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 17:31:18 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 17:31:18 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 17:31:18 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 17:31:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:31:18 INFO - warning: no files found matching '*.txt' 17:31:18 INFO - no previously-included directories found matching 'build' 17:31:18 INFO - no previously-included directories found matching 'dist' 17:31:18 INFO - no previously-included directories found matching '.git*' 17:31:18 INFO - Installing collected packages: jsonschema, functools32 17:31:18 INFO - Running setup.py install for functools32 17:31:18 INFO - warning: no files found matching '*.txt' 17:31:18 INFO - no previously-included directories found matching 'build' 17:31:18 INFO - no previously-included directories found matching 'dist' 17:31:18 INFO - no previously-included directories found matching '.git*' 17:31:18 INFO - Successfully installed jsonschema functools32 17:31:18 INFO - Cleaning up... 17:31:18 INFO - Return code: 0 17:31:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:18 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:18 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 17:31:18 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 17:31:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:18 INFO - 'HOME': '/Users/cltbld', 17:31:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:18 INFO - 'LOGNAME': 'cltbld', 17:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:18 INFO - 'MOZ_NO_REMOTE': '1', 17:31:18 INFO - 'NO_EM_RESTART': '1', 17:31:18 INFO - 'PAGER': '/bin/cat', 17:31:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:18 INFO - 'PWD': '/builds/slave/test', 17:31:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:18 INFO - 'SHELL': '/bin/bash', 17:31:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:18 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:18 INFO - 'USER': 'cltbld', 17:31:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:18 INFO - 'XPC_FLAGS': '0x0', 17:31:18 INFO - 'XPC_SERVICE_NAME': '0', 17:31:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:31:19 INFO - Cleaning up... 17:31:19 INFO - Return code: 0 17:31:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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', '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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:31: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 blobuploader==1.2.4 17:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:19 INFO - 'HOME': '/Users/cltbld', 17:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:19 INFO - 'LOGNAME': 'cltbld', 17:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:19 INFO - 'MOZ_NO_REMOTE': '1', 17:31:19 INFO - 'NO_EM_RESTART': '1', 17:31:19 INFO - 'PAGER': '/bin/cat', 17:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:19 INFO - 'PWD': '/builds/slave/test', 17:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:19 INFO - 'SHELL': '/bin/bash', 17:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:19 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:19 INFO - 'USER': 'cltbld', 17:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:19 INFO - 'XPC_FLAGS': '0x0', 17:31:19 INFO - 'XPC_SERVICE_NAME': '0', 17:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:31:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:31:22 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 17:31:22 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 17:31:22 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 17:31:22 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 17:31:22 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 17:31:22 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 17:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:31:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:31:22 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 17:31:22 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 17:31:22 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 17:31:22 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 17:31:22 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 17:31:22 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 17:31:23 INFO - Downloading docopt-0.6.1.tar.gz 17:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:31:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:31:23 INFO - Running setup.py install for blobuploader 17:31:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:31:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:31:23 INFO - Running setup.py install for requests 17:31:24 INFO - Running setup.py install for docopt 17:31:24 INFO - Successfully installed blobuploader requests docopt 17:31:24 INFO - Cleaning up... 17:31:24 INFO - Return code: 0 17:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:24 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:24 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 17:31:24 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 17:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:24 INFO - 'HOME': '/Users/cltbld', 17:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:24 INFO - 'LOGNAME': 'cltbld', 17:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:24 INFO - 'MOZ_NO_REMOTE': '1', 17:31:24 INFO - 'NO_EM_RESTART': '1', 17:31:24 INFO - 'PAGER': '/bin/cat', 17:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:24 INFO - 'PWD': '/builds/slave/test', 17:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:24 INFO - 'SHELL': '/bin/bash', 17:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:24 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:24 INFO - 'USER': 'cltbld', 17:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:24 INFO - 'XPC_FLAGS': '0x0', 17:31:24 INFO - 'XPC_SERVICE_NAME': '0', 17:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-XH3ESz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Ov9_vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-2gedmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-DVregA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-5UMsGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-3Z8JG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-IvIY81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-mGYXbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-33iPyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-CPtObQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-vuU8Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-neEKqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-W2mewC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-fpgGhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-3z6xos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-_oej06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-9tlaDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:31:26 INFO - Running setup.py install for manifestparser 17:31:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:31:26 INFO - Running setup.py install for mozcrash 17:31:26 INFO - Running setup.py install for mozdebug 17:31:26 INFO - Running setup.py install for mozdevice 17:31:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:31:26 INFO - Running setup.py install for mozfile 17:31:26 INFO - Running setup.py install for mozhttpd 17:31:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Running setup.py install for mozinfo 17:31:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Running setup.py install for mozInstall 17:31:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Running setup.py install for mozleak 17:31:27 INFO - Running setup.py install for mozlog 17:31:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Running setup.py install for moznetwork 17:31:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:31:27 INFO - Running setup.py install for mozprocess 17:31:28 INFO - Running setup.py install for mozprofile 17:31:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:31:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:31:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:31:28 INFO - Running setup.py install for mozrunner 17:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:31:28 INFO - Running setup.py install for mozscreenshot 17:31:28 INFO - Running setup.py install for moztest 17:31:28 INFO - Running setup.py install for mozversion 17:31:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:31:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:31:28 INFO - Cleaning up... 17:31:28 INFO - Return code: 0 17:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:28 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:28 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 17:31:28 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 17:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:28 INFO - 'HOME': '/Users/cltbld', 17:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:28 INFO - 'LOGNAME': 'cltbld', 17:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:28 INFO - 'MOZ_NO_REMOTE': '1', 17:31:28 INFO - 'NO_EM_RESTART': '1', 17:31:28 INFO - 'PAGER': '/bin/cat', 17:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:28 INFO - 'PWD': '/builds/slave/test', 17:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:28 INFO - 'SHELL': '/bin/bash', 17:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:28 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:28 INFO - 'USER': 'cltbld', 17:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:28 INFO - 'XPC_FLAGS': '0x0', 17:31:28 INFO - 'XPC_SERVICE_NAME': '0', 17:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-BTOZMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:29 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)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-_aCGU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:29 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)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PxZwVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:29 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)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-cI1bZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-kkrvQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:29 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)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-AcOxrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:29 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)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-O4Dv1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:29 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)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-XaigLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:29 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)) 17:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-qKJ_Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-hmJ794-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-qr9VJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-tSZeOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-4xvgBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-bGLi8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-LlvU8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-36poGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:30 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)) 17:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-RuTQiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:30 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)) 17:31:30 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)) 17:31:30 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)) 17:31:30 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)) 17:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:33 INFO - Downloading blessings-1.6.tar.gz 17:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:31:33 INFO - Installing collected packages: blessings 17:31:33 INFO - Running setup.py install for blessings 17:31:33 INFO - Successfully installed blessings 17:31:33 INFO - Cleaning up... 17:31:33 INFO - Return code: 0 17:31:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:34 INFO - Reading from file tmpfile_stdout 17:31:34 INFO - Current package versions: 17:31:34 INFO - blessings == 1.6 17:31:34 INFO - blobuploader == 1.2.4 17:31:34 INFO - docopt == 0.6.1 17:31:34 INFO - functools32 == 3.2.3-2 17:31:34 INFO - jsonschema == 2.5.1 17:31:34 INFO - manifestparser == 1.1 17:31:34 INFO - mozInstall == 1.12 17:31:34 INFO - mozcrash == 1.0 17:31:34 INFO - mozdebug == 0.1 17:31:34 INFO - mozdevice == 0.50 17:31:34 INFO - mozfile == 1.2 17:31:34 INFO - mozhttpd == 0.7 17:31:34 INFO - mozinfo == 0.9 17:31:34 INFO - mozleak == 0.1 17:31:34 INFO - mozlog == 3.4 17:31:34 INFO - moznetwork == 0.27 17:31:34 INFO - mozprocess == 0.25 17:31:34 INFO - mozprofile == 0.28 17:31:34 INFO - mozrunner == 6.13 17:31:34 INFO - mozscreenshot == 0.1 17:31:34 INFO - mozsystemmonitor == 0.3 17:31:34 INFO - moztest == 0.8 17:31:34 INFO - mozversion == 1.4 17:31:34 INFO - psutil == 3.1.1 17:31:34 INFO - requests == 1.2.3 17:31:34 INFO - wsgiref == 0.1.2 17:31:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:34 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 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:34 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 17:31:34 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 17:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:34 INFO - 'HOME': '/Users/cltbld', 17:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:34 INFO - 'LOGNAME': 'cltbld', 17:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:34 INFO - 'MOZ_NO_REMOTE': '1', 17:31:34 INFO - 'NO_EM_RESTART': '1', 17:31:34 INFO - 'PAGER': '/bin/cat', 17:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:34 INFO - 'PWD': '/builds/slave/test', 17:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:34 INFO - 'SHELL': '/bin/bash', 17:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:34 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:34 INFO - 'USER': 'cltbld', 17:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:34 INFO - 'XPC_FLAGS': '0x0', 17:31:34 INFO - 'XPC_SERVICE_NAME': '0', 17:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 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)) 17:31:34 INFO - Cleaning up... 17:31:34 INFO - Return code: 0 17:31:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb6db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb70768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcbc9d520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, '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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 17:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:34 INFO - 'HOME': '/Users/cltbld', 17:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:34 INFO - 'LOGNAME': 'cltbld', 17:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:34 INFO - 'MOZ_NO_REMOTE': '1', 17:31:34 INFO - 'NO_EM_RESTART': '1', 17:31:34 INFO - 'PAGER': '/bin/cat', 17:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:34 INFO - 'PWD': '/builds/slave/test', 17:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:34 INFO - 'SHELL': '/bin/bash', 17:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:34 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:34 INFO - 'USER': 'cltbld', 17:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:34 INFO - 'XPC_FLAGS': '0x0', 17:31:34 INFO - 'XPC_SERVICE_NAME': '0', 17:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:31:34 INFO - Cleaning up... 17:31:34 INFO - Return code: 0 17:31:34 INFO - Running post-action listener: _resource_record_post_action 17:31:34 INFO - Running post-action listener: _start_resource_monitoring 17:31:34 INFO - Starting resource monitoring. 17:31:34 INFO - [mozharness: 2017-04-29 00:31:34.789371Z] Finished create-virtualenv step (success) 17:31:34 INFO - [mozharness: 2017-04-29 00:31:34.790332Z] Running install step. 17:31:34 INFO - Running pre-action listener: _resource_record_pre_action 17:31:34 INFO - Running main action method: install 17:31:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:35 INFO - Reading from file tmpfile_stdout 17:31:35 INFO - Detecting whether we're running mozinstall >=1.0... 17:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:31:35 INFO - Reading from file tmpfile_stdout 17:31:35 INFO - Output received: 17:31:35 INFO - Usage: mozinstall [options] installer 17:31:35 INFO - Options: 17:31:35 INFO - -h, --help show this help message and exit 17:31:35 INFO - -d DEST, --destination=DEST 17:31:35 INFO - Directory to install application into. [default: 17:31:35 INFO - "/builds/slave/test"] 17:31:35 INFO - --app=APP Application being installed. [default: firefox] 17:31:35 INFO - mkdir: /builds/slave/test/build/application 17:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:31:54 INFO - Reading from file tmpfile_stdout 17:31:54 INFO - Output received: 17:31:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:31:54 INFO - Running post-action listener: _resource_record_post_action 17:31:54 INFO - [mozharness: 2017-04-29 00:31:54.875372Z] Finished install step (success) 17:31:54 INFO - [mozharness: 2017-04-29 00:31:54.875584Z] Running run-tests step. 17:31:54 INFO - Running pre-action listener: _resource_record_pre_action 17:31:54 INFO - Running main action method: run_tests 17:31:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:31:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:31:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:31:54 INFO - 2017-04-28 17:31:54.890 screenresolution[1939:13415] starting screenresolution argv=screenresolution get 17:31:54 INFO - 2017-04-28 17:31:54.892 screenresolution[1939:13415] Display 0: 1600x1200x32@60 17:31:54 INFO - 2017-04-28 17:31:54.898 screenresolution[1940:13417] starting screenresolution argv=screenresolution list 17:31:54 INFO - Available Modes on Display 0 17:31:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:31:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:31:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:31:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:31:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:31:55 INFO - Intel Iris: 17:31:55 INFO - Chipset Model: Intel Iris 17:31:55 INFO - Type: GPU 17:31:55 INFO - Bus: Built-In 17:31:55 INFO - VRAM (Dynamic, Max): 1536 MB 17:31:55 INFO - Vendor: Intel (0x8086) 17:31:55 INFO - Device ID: 0x0a2e 17:31:55 INFO - Revision ID: 0x0009 17:31:55 INFO - Displays: 17:31:55 INFO - Display: 17:31:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:31:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:31:55 INFO - Display Serial Number: 1600x1200 60 17:31:55 INFO - Main Display: Yes 17:31:55 INFO - Mirror: Off 17:31:55 INFO - Online: Yes 17:31:55 INFO - Rotation: Supported 17:31:55 INFO - Return code: 0 17:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:31:55 INFO - Python 2.7.3 17:31:55 INFO - Return code: 0 17:31:55 INFO - grabbing minidump binary from tooltool 17:31:55 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')]} 17:31:55 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 0x10c94bd30>, '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 0x10c871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c940be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:31:55 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 17:31:55 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 17:31:55 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 17:31:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:31:55 INFO - Return code: 0 17:31:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:31:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:31:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:31:55 INFO - ENV: RUST_BACKTRACE is now 1 17:31:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:31:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 17:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --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 17:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZwEa1pQuK/Render', 17:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:55 INFO - 'HOME': '/Users/cltbld', 17:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:55 INFO - 'LOGNAME': 'cltbld', 17:31:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:31:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:55 INFO - 'MOZ_NO_REMOTE': '1', 17:31:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:31:55 INFO - 'NO_EM_RESTART': '1', 17:31:55 INFO - 'PAGER': '/bin/cat', 17:31:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:55 INFO - 'PWD': '/builds/slave/test', 17:31:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:55 INFO - 'RUST_BACKTRACE': '1', 17:31:55 INFO - 'SHELL': '/bin/bash', 17:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KDbmRx0W9P/Listeners', 17:31:55 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 17:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:55 INFO - 'USER': 'cltbld', 17:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:55 INFO - 'XPC_FLAGS': '0x0', 17:31:55 INFO - 'XPC_SERVICE_NAME': '0', 17:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 17:31:55 INFO - mozversion application_buildid: 20170428154347 17:31:55 INFO - mozversion application_changeset: 1c994cd72265c48bbdc9f6404df87c4eae488b34 17:31:55 INFO - mozversion application_display_name: Nightly 17:31:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:31:55 INFO - mozversion application_name: Firefox 17:31:55 INFO - mozversion application_remotingname: firefox 17:31:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:31:55 INFO - mozversion application_vendor: Mozilla 17:31:55 INFO - mozversion application_version: 55.0a1 17:31:55 INFO - mozversion platform_buildid: 20170428154347 17:31:55 INFO - mozversion platform_changeset: 1c994cd72265c48bbdc9f6404df87c4eae488b34 17:31:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:31:55 INFO - mozversion platform_version: 55.0a1 17:31:55 INFO - using testdate: 1493425915 17:31:55 INFO - actual date: 1493425915 17:31:55 INFO - starting webserver on 'localhost:49475' 17:31:55 INFO - SUITE-START | Running 2 tests 17:31:55 INFO - TEST-START | dromaeo_css 17:31:55 INFO - operating with platform_type : mac_ 17:31:55 INFO - Initialising browser for dromaeo_css test... 17:31:55 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpVQ0QzR/profile http://localhost:49475/getInfo.html) 17:31:58 INFO - PID 1950 | __metrics Screen width/height:1600/1200 17:31:58 INFO - PID 1950 | colorDepth:24 17:31:58 INFO - PID 1950 | Browser inner width/height: 1024/689 17:31:58 INFO - PID 1950 | __metrics 17:31:58 INFO - PID 1950 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:31:58 INFO - PID 1950 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:31:59 INFO - TEST-INFO | 1950: exit 0 17:31:59 INFO - Browser initialized. 17:31:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:31:59 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpVQ0QzR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:11 INFO - PID 1951 | RSS: Main: 240742400 17:32:11 INFO - PID 1951 | 17:35:17 INFO - PID 1951 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49475/tests/dromaeo/cssquery-ext.html) 17:35:18 INFO - PID 1951 | RSS: Main: 387731456 17:35:18 INFO - PID 1951 | 17:37:01 INFO - PID 1951 | ************************* 17:37:01 INFO - PID 1951 | A coding exception was thrown and uncaught in a Task. 17:37:01 INFO - PID 1951 | 17:37:01 ERROR - PID 1951 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:37:01 INFO - PID 1951 | Full stack: 17:37:01 INFO - PID 1951 | ************************* 17:37:01 INFO - PID 1951 | ************************* 17:37:01 INFO - PID 1951 | A coding exception was thrown and uncaught in a Task. 17:37:01 INFO - PID 1951 | 17:37:01 ERROR - PID 1951 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:37:01 INFO - PID 1951 | Full stack: 17:37:01 INFO - PID 1951 | ************************* 17:37:01 INFO - PID 1951 | ************************* 17:37:01 INFO - PID 1951 | A coding exception was thrown and uncaught in a Task. 17:37:01 INFO - PID 1951 | 17:37:01 ERROR - PID 1951 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:37:01 INFO - PID 1951 | Full stack: 17:37:01 INFO - PID 1951 | ************************* 17:37:01 INFO - PID 1951 | ************************* 17:37:01 INFO - PID 1951 | A coding exception was thrown and uncaught in a Task. 17:37:01 INFO - PID 1951 | 17:37:01 ERROR - PID 1951 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:37:01 INFO - PID 1951 | Full stack: 17:37:01 INFO - PID 1951 | ************************* 17:38:21 INFO - PID 1951 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-ext.html (next: http://localhost:49475/tests/dromaeo/cssquery-jquery.html) 17:38:21 INFO - PID 1951 | RSS: Main: 365006848 17:38:21 INFO - PID 1951 | 17:41:23 INFO - PID 1951 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49475/tests/dromaeo/cssquery-mootools.html) 17:41:24 INFO - PID 1951 | RSS: Main: 324956160 17:41:24 INFO - PID 1951 | 17:44:26 INFO - PID 1951 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49475/tests/dromaeo/cssquery-prototype.html) 17:44:27 INFO - PID 1951 | RSS: Main: 326905856 17:44:27 INFO - PID 1951 | 17:47:30 INFO - PID 1951 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49475/tests/dromaeo/cssquery-yui.html) 17:47:31 INFO - PID 1951 | RSS: Main: 337276928 17:47:31 INFO - PID 1951 | 17:50:33 INFO - PID 1951 | Cycle 1(1): loaded http://localhost:49475/tests/dromaeo/cssquery-yui.html (next: http://localhost:49475/tests/dromaeo/cssquery-dojo.html) 17:50:34 INFO - PID 1951 | RSS: Main: 372375552 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | __start_tp_report 17:50:34 INFO - PID 1951 | _x_x_mozilla_page_load 17:50:34 INFO - PID 1951 | _x_x_mozilla_page_load_details 17:50:34 INFO - PID 1951 | |i|pagename|runs| 17:50:34 INFO - PID 1951 | |0;dojo.html;3456.7925924444526;3471.409860323746;3483.1640406302495;3501.3697534443804;3526.982365088176;5963.970180149104;6069.42340477655;6207.068939659053;6211.347808480113;6230.750769969201;6084.482818960382;6113.567524283673;6154.661493617849;6209.348018458065;6211.720472578733;5133.050385678662;5201.349831271091;5279.551238144743;5295.338082739658;5382.6232163748555;5325.094733895227;5346.732663366835;5369.62412631116;5374.838754837361;5376.892462150755;5218.425973142951;5279.392869819982;5294.020606187868;5333.35999680037;5339.492748188935;5325.467453254682;5340.973295133538;5354.116570765819;5356.11624082026;5395.514403703646;5277.419483856773;5325.893482130375;5336.839894803162;5338.786448542053;5388.78444862205;5956.910646340309;6045.395460453963;6128.7242074106325;6152.723127459275;6168.568200225986;6302.684865756693;6344.33384494626;6381.489480841522;6385.457236134934;6387.457066149383;6519.119918810948;6520.315366886456;6520.869582608369;6524.836879078013;6540.149780528501;6186.81439556814;6193.256809182837;6263.31103578606;6266.655333956631;6287.654179020106;6370.171877655967;6444.484441244689;6603.174603174603;6678.065070890079;6697.430718388894;6321.8735625288155;6327.177466929362;6331.113644089831;6339.207599050119;6346.777862774781;6357.841053973688;6482.416582507597;6484;6486.935130648728;6502.837429064311;6278.591891527128;6331.841703957438;6346.524010699216;6352.618842869442;6361.872762544724;6285.937140628626;6303.149074874925;6347.936520634827;6385.712642931079;6403.519736019817;5184.662996905189;5189.169732842727;5190.766415511311;5198.194279886624;5199.272101905736;3965.6516784292903;4570.9314360284625;4626.21354369758;4679.27471241958;4684.461286952044;4943.9258411123865;6067.7876274331065;6070.514358851281;6194.442500175006;6210.844728881814;6425.485961123099;6465.903011454832;6496.025596160519;6497.902531462032;6519.608823470607;6112.205413296332;6154.261488621304;6176.752929882754;6178.598391104564;6187.628742275388;5564.91652625219;5689.886202276014;5697.601167918288;5711.8000869969355;5732.7706891723865;6480.643564603992;6490.675466226576;6496.70764815575;6498.837529061811;6507.284198738041;6365.840853978688;6440.0983862260255;6502.219733631994;6520.869582608416;6523.24982627004;6641.369069938348;6667.066610674412;6687.76592819249;6691.1636045494315;6721.227058888095;6280.183576135073;6389.137466441971;6406.519511036598;6408.775692850728;6409.262934762375;6370.4903607712195;6419.518536109717;6423;6459.192600924885;6507.804765857032;6256.5620406572925;6285.057241413824;6312.873742525216;6316.6841657916;6324.114623952558;6173.043178307369;6297.937020629735;6311.179546658905;6315.400036996478;6317.336679648571;6137.438273608381;6230.470410015199;6243.594166379171;6262.718177681924;6317.336679648571;6289.654069026247;6310.84222894413;6314.179156709783;6318.968405157945;6325.493960483058;6292.2134733158355;6293.716782744879;6303.873922521432;6307.36926307384;6307.842303942438 17:50:34 INFO - PID 1951 | |1;ext.html;753.56669914799;785.1559573458532;794.0868001797934;1095.9726006849833;1114.0363585498542;25361.49277014461;35497.46753798695;35552;35634.75278365258;35636.10909727258;37572.81213593935;37898.24203515928;37905.810470947676;37921.62078379222;37940.86177414682;5844.561657875676;5872.7063646817705;8122.47203931744;8250.669973201066;8275.337972962148;8113.472624279432;8210.630521626512;8218.137095604965;8227.876581851277;8231.135730748276;8175.7138500152505;8255.009398872144;8271.131531189229;8273.172682731709;8363.581820908961;8156.714514991976;8205.302549283319;8214.46605970616;8226.05400378958;8228.341732661404;8152.8777068344025;8216.301614362786;8217.58912054401;8227.54748488833;8235.95882020592;35215.82392088049;35439;35445.46831797499;35515.467267991;35573;3553.9466907996402;3560.359135355635;3580.7672501287334;3586.5875424326277;3588.372034893883;29199.854000730073;29329.560056599166;29354.41291174186;29373.11880643584;29383;3035.8633861476287;3068.9693103068907;3086.42901063304;3105.177128061043;3116.5169398743005;281221;284337;285467;287154;289703;46331;46722.83192920204;46725;46764.83087922829;46905;48289.6197266188;48307.516924831005;48324;48363.758181209574;48438.27342589864;13637.045406821428;13698.246596437291;13705.040647154603;13709.588712338646;13720.794188087186;9539.189168920719;9553.331266811256;9673.274504412197;11152.163587730953;11166.609168679057;11689.298642081503;11723.4138293085;11793.705157371134;11799.233049851731;11980.52077916891;5303.655262408009;5310.389305229871;5324.414314425488;5332.760025798849;5343.866403339947;875.9781005474914;905.7726780212848;963.1668606655193;999.2755252441922;1004.8191325561323;20590.588188236452;22736.886315568318;23723.169689061146;23866.642000370008;23955;1067.5996501312009;1078.250615822012;1106.8727096383857;1108.3405373802575;1132.252713209278;12055.397230138458;12095.516179352904;12172.695682608006;12193.32936688473;12233.266004039786;288770;305888;306268;306376;306537;50034.9993000138;50130;50251.74874125606;50264.49735502598;50296.999999999265;1436.3392839293833;1452.2230606625405;1494.887883408727;1496.513633069257;1521;23284.53430931406;23361.299161025196;23462.530749384576;23475.64786528169;23488.53022939566;36557.634423656484;36742.26515469622;36744;36827.63172368242;36856.07859803527;268711;268852;269125;269263;269539;28715.856420717762;29295;32655.836720816245;32680.54895882866;32723;41712.79143604262;41800.79099604482;41820.58179418167;41882.37176442295;41886.16227675368;26245.606315904894;27501.249875013138;27824.582631260142;28832.711672883004;28908.132756017352;28616.85691571529;29469.557956631095;29472.852635736683;29774.702252977193;29808.254793630334;33334.66665333316;34157;34494;34997.300053999286;35055.47416788801;28710.856445717636;28728.712712872602;29614.259643509085;29653.851730741208;29947.70052299536;22206;22954;23394.76605233926;23405.648915265945;23498.942547585742 17:50:34 INFO - PID 1951 | |2;jquery.html;418.67679103270444;424.20461634435435;430.2878735692429;438.2834066301597;445.2808713927009;18483.907580462095;20253.39239822804;20809.895950520226;21017.054232559534;21064.157433702632;17471.91264043678;20747;21432.57134857302;21445.892770536164;21605.567888642217;5787.450192231731;6102.633841969474;6115.877682446348;6128.264608247016;6143.784967526138;5851.561132915027;6025.457708806207;6038.154658347813;6118.755249790003;6126.908096378535;6042.667653279068;6045.244344456943;6053.606515576474;6057.030875059992;6105.32841387447;5878.441548052928;5905.822825315247;6012.30858451275;6024.397560243984;6025.186599809035;5205.245239440298;5335.493128152819;5337.06601344767;5337.866553336159;5349.866253343658;21924.561508769893;25895.35261618456;25934.87032564844;26521.07176248822;27194.04820831281;2153.074178103415;2191.561687662474;2225.0765932138142;2229.264342766883;2231.5871563760757;17179.656406871793;17480.038597877112;17979.550511237194;18279.63440731178;18352.632947341113;1873.709575015861;2064.298138632872;2132.402927180392;2170.728658917635;2171.782821717831;151065;155707.22146389307;157740;159213.2039339796;160650;11223.214374993671;11801.704957376134;11803.40982950849;11834.112441566916;11905.702357441134;15014;15558;15605;15624.687506249811;15629.68740625181;7507.286807753364;8619.439736417113;8790.164934331227;8810.691625793066;8957.596908139149;8341.499510029418;8367;8397.916020839835;8541.273991710774;8581.35639827003;6272.278687950944;7389.630518474055;7498.512596681198;7541.811454713676;7569.735059272899;2054.815066644009;2070.554830711404;2074.854760166804;2076.3770868739316;2213.922512712047;887.8135591525722;929.990700093004;954.6944977607099;957.1098878043347;963.5663951221838;19959.700604490943;20584.073716682786;20727.792722072587;20781.272655456985;20967.790322096887;971.7182017214928;973.0998826085984;980.1717548671361;1011.4790882695418;1013.1034034879185;10336.483175841178;10640.255182137176;10730.624428144978;10734.355938643706;10738.463076846127;561341;564204;569396;579509;580679.0966045227;123835.14247286298;128534.35732821276;128832.35583822208;129385.70614293925;133219;1148.5635458525708;1156.7397335599592;1184.2065815903366;1184.9822252666218;1187.5368606243571;16880.831191687925;17489.82510174882;17561.94628322305;17594.648107038043;17883.195256213763;53484.73257633687;54456.727716361165;54831;55362.723186385425;55999.44000560105;63116.68441657762;71697.84906452814;78251;78556.60721696354;79082;7243.348098671145;8329.583520824055;8566.700165494178;8787.165219304155;8928.86606700887;13464.865351346753;14507.854921450651;14525.636859078608;14980.475683351031;15071.698566028399;11825.940870295593;11884.702882428008;11950.163488555718;12240.69398265015;12352;11620.767584648429;11634;11738.119641026786;11798.410079496163;12027.398630068286;12169.452374643339;12340.81488777651;12411.131220814455;12558.686032849251;12566;8720.302375810046;8725.650973961225;8993.220863952765;9174.770630734285;9201.677941272023;10397.956990859277;10726.463676815973;11557.711057223636;11926.284422934652;12152.75694486123 17:50:34 INFO - PID 1951 | |3;mootools.html;1198.646399312203;1404.7401230772307;1440.567829651105;1459.5183589415494;1466.6260103673562;9627.759306017344;10109.393436393811;11348.829767553472;11583.768324633502;11586.65240042798;11198;11283.37941413222;11286.604968826092;11309.886901131007;11323.943380283086;2254.9289087683383;2408.4460574067975;2467.69212317472;2502.924912252626;2506.636537702032;2106.4523223961805;2183.7816218378193;2467.346877592018;2528.595424732034;2540.212534114421;2476.2447453526665;2487.6641653376832;2507.3104896153523;2513.54756143894;2520.2565243253284;2492.9750702492925;2499.3501689560753;2499.500099979993;2499.5375855466614;2509.2095989763166;2436.4517983453757;2460.692413448319;2464.950700985988;2465.630155476675;2468.6790717206827;11300.547978080867;11344.716382090513;11430.485628146753;11477.426128693533;11488.02351800098;6401.039844023434;6651.0023496475915;6657.5006874484125;6662.933370666328;6663.800085997379;3917.745346552465;4108.4453598764385;4180.143070670536;4255.914881702349;4263.65890728744;1212.254463504947;1216.173002358396;1254.5483625894672;1255.1339575692743;1274.0635632809876;16568.585785355343;16638.916805416018;16641.91679041597;16673.91663041689;16676.499705008748;5683.943160568424;5811.3026436827;5854.560907931922;5916.26046744157;6003.459688628044;13738.725225495435;13769.31153442324;13777.517786877412;13782;13805.51680691171;6737.595744255263;6741.820181468223;6742.898856517156;6743.730250790011;6752.291009444036;5213.452587478336;6095.878082438327;6141.692915354214;6148.784792532329;6151.815445536641;3723.497327860758;4082.693797965105;4194.538600753915;4532.864014079517;4574.519675434098;1372.848986611472;1415.688548519324;1419.1485108934558;1438.7841823726524;1438.892083093772;780.7189411811743;783.8941742864754;793.7102957420616;799.6201804142986;803.7869964459423;5589.496945274864;6560.147180866552;6680.565763225375;6962.825929351807;7001.054857594261;903.3405613901889;922.1838672774509;923.4136323434667;923.6259314977444;941.18117238002;4276.230278549829;4305.246581848227;4365.869023929287;4432.822687092545;4470.821167153277;14352.49766258176;14775.335109920079;14957;15214.239288035555;15321.616959575877;14675.19286439256;14934.626634334229;14951.775723364159;14967.550973470814;14973.326200321011;8339.332853371716;8545.572721363907;8550.1449855014;8551.01663308715;8572.742817715478;5156.56169225605;6678.83302917431;7156.320149585781;7174.246704095995;7196.532225405332;11838.408079595814;12869.970402367975;13249.072564920363;13622.114562553403;13764.65588360299;13254.867451325363;13678.726425471634;13783.379747911167;13864.098833575785;14109.153450792985;9078.546072696206;9350.205232555038;9354.859677104712;9375.531223438664;9401.153896149379;8599.52702601363;9589.712308630753;10583.576656933636;10616.575336986434;10688.57245710194;9044.728658140266;9056.320775941698;9063.184313411824;9130.726078217664;9173.54132293396;8739.563021848755;8828.117188281121;8924.9736280326;8988.235999940078;8995.830542029495;8153.510789352657;8170.836583268182;8281.420300578902;8281.710140145065;8283.95858020706;6019.18740969981;6122.173506576733;6168.876622467616;6182.907256391068;6196.938030619816;6058.666773327509;6108.541859360477;6182.28903676083;6225.3774622539195;6247.5939063960695 17:50:34 INFO - PID 1951 | |4;prototype.html;388.6113886113886;395.12676983865657;398.8683734367659;399.16773527195807;405.3979839937694;5761.687029957775;5762.366139724632;5775.422457754233;5777.248957635512;5852.9707351463185;4232.730180945711;5087.85523257267;5634.19705694178;5728;5748.885022299552;4334.263175260197;4356.041670832427;4375.584319489643;4378.409704042686;4382.452193475816;3989.9202015959663;4396.582324679166;4398.582134697214;4438.467383913919;4438.800253988578;3569.3575156471825;4206.663466922639;4311.461067366579;4358.368036634686;4369.016971181491;3541.38025845476;4341.175176716414;4349.934750978738;4353.717008394444;4362.083962367875;3854.1520865409566;3862.517185351831;3867.7872717000555;3873.6513713765617;3877.786721730332;5432.837014889559;5585.692786896719;5601.60788744788;5605.458498912791;5659.830205093854;4892.363992680965;5213.348331458567;5246.842594722164;5248.716808188412;5271.47127333073;5026.497350264981;5097.464766199532;5287.524122828964;6067.089936509515;6098.9695051524905;3831.689349481833;4038.6268668652506;4096.242195193899;4099.929535584541;4108.671306295519;5425.647332923387;6323.20959880015;6335.714892829834;6444.806655800334;6456.386643268882;4018.749500279853;4137.855175068858;4146.362186936203;4153.314703073959;4154.231467178582;4227.936580951288;4230.963413963598;4232.111256636141;4237.555056719062;4239.258129827268;4025.6376926076796;4089.795510224477;4114.547399786021;4780.354652121989;4956.628252881048;6114.113453549299;6190.226221722285;6198.535109866778;6203.503719702413;6209.5032397408095;1173.3253379306761;1194.8028575285155;1427.1151885830852;1435.612384656137;1442.2500299844232;901.6573701993332;936.7260525685062;943.104051151409;950.1211379474097;959.1128206409044;5722.77108915647;5726.856828579319;5730.598858079978;5738.282714660668;5765.625234359753;6376.553641245161;6379.681015949184;6393.776217832354;6407.199100112486;6423.293437721847;5300.840974770763;5730.942690573041;5775.249217601769;5821.417858214145;5829.125631155361;2914.6502419709773;3052.8399208300702;3129.718325350729;3293.4565796643287;3307.2724000719804;5811.941880581225;6052.848678782978;6479.935200648028;6512.120863683437;6558.344165583499;6494.675266236669;6505.577137486048;6506.544541882117;6531.3142120077655;6533.386645341806;5718.027935251017;5964.777220669752;6290.528210384239;6421.5825971311715;6563.50773691975;6327.873442531216;6373.171487706569;6375.872482550416;6393.904091438539;6408.711607977559;5364.873376590959;6030.427109424598;6238.908191066636;6291.150694656346;6312.558120931674;5605.635633683797;6137.815865524041;6310.7475700971445;6458.903116453351;6473.158489396348;4040.8887555921183;4083.0809519525774;4084.897877553085;4109.383592461155;4132.421460995403;6045.4281886708895;6273.341299163704;6319.46284565817;6330.847511845995;6354;5173.456787037307;6046.1257010326935;6065.575409721454;6134.171886795226;6153.72308246139;5235.691077230692;5696.8006119785605;6043.788467403796;6108.541859360655;6140.508759299335;4558.8632341029825;4994.450610432777;5738.9139162913425;5861.84506268425;6007.609505382136;5240.34495688039;6092.969535152473;6106.480949119375;6118.663473509;6125.9693701531205;4713;5702.857428564153;5899.262592175978;6012.909806352821;6020.488258498077 17:50:34 INFO - PID 1951 | |5;yui.html;692.0760784352889;834.5618550261108;838.6687258532879;840.1052878684201;852.3820230333007;13032.413541390637;16838.83161168388;18254.361097361594;18618.51051915847;18838.717419238706;16887.746683799753;16972;17429.30282788687;17530.211140498675;17561.736573951403;961.5769061612885;969.5055521683921;972.1687956796943;974.1038244814752;974.2060220919927;657.1424291299852;668.4218151299116;953.2183609440261;959.7936443664611;977.6920270114927;1005.8088963097025;1006.2453160129902;1006.582268358634;1006.6778630838135;1018.0074427433267;1004.3321191407705;1006.9093781559621;1007.2898606482412;1007.536533194735;1023.2223510132278;498.9945260300497;501.1955810923452;509.57195955397646;513.36342934761;754.8452567223706;12453;16226.756598651029;16699.08155051472;16704.164791760362;16958.915205423895;16265.430709925215;16770.664586708197;17080;17288.913555432267;17292.913535432242;13945.233012184326;14150;14268.857311426857;14271.78592321116;14272.571822845332;3369.2924485858;3425.5889293284963;3447.637998010223;3450.8274586270586;3455.378031954247;99513.01460956183;120271;121392;121922;128261.71738282591;11014.669559913054;11359.488823002985;13224.735505290033;13404.664883377993;13412.262325571992;17407.390741324245;19394;19397.709034364496;20064.69902951457;25397.238082857544;7658.540487570764;7779.338756205672;7856.450048496665;7869.213078692085;7891.171427000198;3802.5817160112365;3929.8821035368983;3932.6657234134846;3933.350997085506;3933.940990885139;4247.129338485603;4332.176886391576;4337;4337.284348082531;4339;906.9229115525122;912.2565109435789;925.0240995749549;927.6011315134422;927.7402327348353;621.8880601491775;657.2343220148473;661.3122352753082;668.9799306020827;689.3864460630043;11155.27490713101;11877.524899004116;11982.940085299691;12041.578544751066;12103.818442723366;630.6216270237912;631.9557630965788;635.7552342348137;644.9161608990895;670.8591195848829;4503.482099558592;5434.755436005389;5509.146082357241;5598.58010649203;5635.690037048002;89179;107715.46142269239;107946.46026769816;109561.45219274012;111013;94620.52689736507;95135;97035;97317.5134124339;99782;73256;74487.62756186293;74916;74980.50038999299;75235.24764752392;8465.238128568459;10546.103581195684;10752.247342685936;11122.277051991594;11148.275362101438;41790.79104604458;41991;42379;42407.78796106;42606;52412.21381679201;52745.47254527559;52901;53073.20390194073;53758.19362709484;13898.861011389758;14313;16012.839871601134;16545.338186472887;16708.16459177012;17710.64578708393;17978.64042719112;18456.077196140406;18573.071346432895;18896.05519724036;16273.186340682681;16356.509304720877;17203;17532.474025779247;17643.647127057644;16631.085290308663;16884.66230675355;17048.403305884236;17086.48740537786;17256.568585785455;15958.361665533714;16401.42595009169;16671.583210419838;16796.66406671884;16917.830821691627;11140.16448766362;11880.940595296968;11967.581134660246;12004.099692522921;12110.576129835414;11681.240719353214;12203.75592488163;12652.114351995271;13324.333783310602;13363.799543007057 17:50:34 INFO - PID 1951 | __end_tp_report 17:50:34 INFO - PID 1951 | __start_cc_report 17:50:34 INFO - PID 1951 | _x_x_mozilla_cycle_collect,1537 17:50:34 INFO - PID 1951 | __end_cc_report 17:50:34 INFO - PID 1951 | __startTimestamp1493427034145__endTimestamp 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | ------- Summary: start ------- 17:50:34 INFO - PID 1951 | Number of tests: 6 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | [#0] dojo.html Cycles:165 Average:5983.01 Median:6285.06 stddev:683.54 (10.9%) stddev-sans-first:656.28 17:50:34 INFO - PID 1951 | Values: 3456.8 3471.4 3483.2 3501.4 3527.0 5964.0 6069.4 6207.1 6211.3 6230.8 6084.5 6113.6 6154.7 6209.3 6211.7 5133.1 5201.3 5279.6 5295.3 5382.6 5325.1 5346.7 5369.6 5374.8 5376.9 5218.4 5279.4 5294.0 5333.4 5339.5 5325.5 5341.0 5354.1 5356.1 5395.5 5277.4 5325.9 5336.8 5338.8 5388.8 5956.9 6045.4 6128.7 6152.7 6168.6 6302.7 6344.3 6381.5 6385.5 6387.5 6519.1 6520.3 6520.9 6524.8 6540.1 6186.8 6193.3 6263.3 6266.7 6287.7 6370.2 6444.5 6603.2 6678.1 6697.4 6321.9 6327.2 6331.1 6339.2 6346.8 6357.8 6482.4 6484.0 6486.9 6502.8 6278.6 6331.8 6346.5 6352.6 6361.9 6285.9 6303.1 6347.9 6385.7 6403.5 5184.7 5189.2 5190.8 5198.2 5199.3 3965.7 4570.9 4626.2 4679.3 4684.5 4943.9 6067.8 6070.5 6194.4 6210.8 6425.5 6465.9 6496.0 6497.9 6519.6 6112.2 6154.3 6176.8 6178.6 6187.6 5564.9 5689.9 5697.6 5711.8 5732.8 6480.6 6490.7 6496.7 6498.8 6507.3 6365.8 6440.1 6502.2 6520.9 6523.2 6641.4 6667.1 6687.8 6691.2 6721.2 6280.2 6389.1 6406.5 6408.8 6409.3 6370.5 6419.5 6423.0 6459.2 6507.8 6256.6 6285.1 6312.9 6316.7 6324.1 6173.0 6297.9 6311.2 6315.4 6317.3 6137.4 6230.5 6243.6 6262.7 6317.3 6289.7 6310.8 6314.2 6319.0 6325.5 6292.2 6293.7 6303.9 6307.4 6307.8 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | [#1] ext.html Cycles:180 Average:42876.26 Median:33028.83 stddev:75037.10 (227.2%) stddev-sans-first:75180.95 17:50:34 INFO - PID 1951 | Values: 753.6 785.2 794.1 1096.0 1114.0 25361.5 35497.5 35552.0 35634.8 35636.1 37572.8 37898.2 37905.8 37921.6 37940.9 5844.6 5872.7 8122.5 8250.7 8275.3 8113.5 8210.6 8218.1 8227.9 8231.1 8175.7 8255.0 8271.1 8273.2 8363.6 8156.7 8205.3 8214.5 8226.1 8228.3 8152.9 8216.3 8217.6 8227.5 8236.0 35215.8 35439.0 35445.5 35515.5 35573.0 3553.9 3560.4 3580.8 3586.6 3588.4 29199.9 29329.6 29354.4 29373.1 29383.0 3035.9 3069.0 3086.4 3105.2 3116.5 281221.0 284337.0 285467.0 287154.0 289703.0 46331.0 46722.8 46725.0 46764.8 46905.0 48289.6 48307.5 48324.0 48363.8 48438.3 13637.0 13698.2 13705.0 13709.6 13720.8 9539.2 9553.3 9673.3 11152.2 11166.6 11689.3 11723.4 11793.7 11799.2 11980.5 5303.7 5310.4 5324.4 5332.8 5343.9 876.0 905.8 963.2 999.3 1004.8 20590.6 22736.9 23723.2 23866.6 23955.0 1067.6 1078.3 1106.9 1108.3 1132.3 12055.4 12095.5 12172.7 12193.3 12233.3 288770.0 305888.0 306268.0 306376.0 306537.0 50035.0 50130.0 50251.7 50264.5 50297.0 1436.3 1452.2 1494.9 1496.5 1521.0 23284.5 23361.3 23462.5 23475.6 23488.5 36557.6 36742.3 36744.0 36827.6 36856.1 268711.0 268852.0 269125.0 269263.0 269539.0 28715.9 29295.0 32655.8 32680.5 32723.0 41712.8 41800.8 41820.6 41882.4 41886.2 26245.6 27501.2 27824.6 28832.7 28908.1 28616.9 29469.6 29472.9 29774.7 29808.3 33334.7 34157.0 34494.0 34997.3 35055.5 28710.9 28728.7 29614.3 29653.9 29947.7 22206.0 22954.0 23394.8 23405.6 23498.9 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | [#2] jquery.html Cycles:180 Average:35799.28 Median:2171.26 stddev:96603.45 (4449.2%) stddev-sans-first:96837.92 17:50:34 INFO - PID 1951 | Values: 418.7 424.2 430.3 438.3 445.3 18483.9 20253.4 20809.9 21017.1 21064.2 17471.9 20747.0 21432.6 21445.9 21605.6 5787.5 6102.6 6115.9 6128.3 6143.8 5851.6 6025.5 6038.2 6118.8 6126.9 6042.7 6045.2 6053.6 6057.0 6105.3 5878.4 5905.8 6012.3 6024.4 6025.2 5205.2 5335.5 5337.1 5337.9 5349.9 21924.6 25895.4 25934.9 26521.1 27194.0 2153.1 2191.6 2225.1 2229.3 2231.6 17179.7 17480.0 17979.6 18279.6 18352.6 1873.7 2064.3 2132.4 2170.7 2171.8 151065.0 155707.2 157740.0 159213.2 160650.0 11223.2 11801.7 11803.4 11834.1 11905.7 15014.0 15558.0 15605.0 15624.7 15629.7 7507.3 8619.4 8790.2 8810.7 8957.6 8341.5 8367.0 8397.9 8541.3 8581.4 6272.3 7389.6 7498.5 7541.8 7569.7 2054.8 2070.6 2074.9 2076.4 2213.9 887.8 930.0 954.7 957.1 963.6 19959.7 20584.1 20727.8 20781.3 20967.8 971.7 973.1 980.2 1011.5 1013.1 10336.5 10640.3 10730.6 10734.4 10738.5 561341.0 564204.0 569396.0 579509.0 580679.1 123835.1 128534.4 128832.4 129385.7 133219.0 1148.6 1156.7 1184.2 1185.0 1187.5 16880.8 17489.8 17561.9 17594.6 17883.2 53484.7 54456.7 54831.0 55362.7 55999.4 63116.7 71697.8 78251.0 78556.6 79082.0 7243.3 8329.6 8566.7 8787.2 8928.9 13464.9 14507.9 14525.6 14980.5 15071.7 11825.9 11884.7 11950.2 12240.7 12352.0 11620.8 11634.0 11738.1 11798.4 12027.4 12169.5 12340.8 12411.1 12558.7 12566.0 8720.3 8725.7 8993.2 9174.8 9201.7 10398.0 10726.5 11557.7 11926.3 12152.8 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | [#3] mootools.html Cycles:180 Average:7113.81 Median:4144.29 stddev:4514.92 (108.9%) stddev-sans-first:4505.70 17:50:34 INFO - PID 1951 | Values: 1198.6 1404.7 1440.6 1459.5 1466.6 9627.8 10109.4 11348.8 11583.8 11586.7 11198.0 11283.4 11286.6 11309.9 11323.9 2254.9 2408.4 2467.7 2502.9 2506.6 2106.5 2183.8 2467.3 2528.6 2540.2 2476.2 2487.7 2507.3 2513.5 2520.3 2493.0 2499.4 2499.5 2499.5 2509.2 2436.5 2460.7 2465.0 2465.6 2468.7 11300.5 11344.7 11430.5 11477.4 11488.0 6401.0 6651.0 6657.5 6662.9 6663.8 3917.7 4108.4 4180.1 4255.9 4263.7 1212.3 1216.2 1254.5 1255.1 1274.1 16568.6 16638.9 16641.9 16673.9 16676.5 5683.9 5811.3 5854.6 5916.3 6003.5 13738.7 13769.3 13777.5 13782.0 13805.5 6737.6 6741.8 6742.9 6743.7 6752.3 5213.5 6095.9 6141.7 6148.8 6151.8 3723.5 4082.7 4194.5 4532.9 4574.5 1372.8 1415.7 1419.1 1438.8 1438.9 780.7 783.9 793.7 799.6 803.8 5589.5 6560.1 6680.6 6962.8 7001.1 903.3 922.2 923.4 923.6 941.2 4276.2 4305.2 4365.9 4432.8 4470.8 14352.5 14775.3 14957.0 15214.2 15321.6 14675.2 14934.6 14951.8 14967.6 14973.3 8339.3 8545.6 8550.1 8551.0 8572.7 5156.6 6678.8 7156.3 7174.2 7196.5 11838.4 12870.0 13249.1 13622.1 13764.7 13254.9 13678.7 13783.4 13864.1 14109.2 9078.5 9350.2 9354.9 9375.5 9401.2 8599.5 9589.7 10583.6 10616.6 10688.6 9044.7 9056.3 9063.2 9130.7 9173.5 8739.6 8828.1 8925.0 8988.2 8995.8 8153.5 8170.8 8281.4 8281.7 8284.0 6019.2 6122.2 6168.9 6182.9 6196.9 6058.7 6108.5 6182.3 6225.4 6247.6 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | [#4] prototype.html Cycles:180 Average:4939.41 Median:5678.32 stddev:1546.03 (27.2%) stddev-sans-first:1512.16 17:50:34 INFO - PID 1951 | Values: 388.6 395.1 398.9 399.2 405.4 5761.7 5762.4 5775.4 5777.2 5853.0 4232.7 5087.9 5634.2 5728.0 5748.9 4334.3 4356.0 4375.6 4378.4 4382.5 3989.9 4396.6 4398.6 4438.5 4438.8 3569.4 4206.7 4311.5 4358.4 4369.0 3541.4 4341.2 4349.9 4353.7 4362.1 3854.2 3862.5 3867.8 3873.7 3877.8 5432.8 5585.7 5601.6 5605.5 5659.8 4892.4 5213.3 5246.8 5248.7 5271.5 5026.5 5097.5 5287.5 6067.1 6099.0 3831.7 4038.6 4096.2 4099.9 4108.7 5425.6 6323.2 6335.7 6444.8 6456.4 4018.7 4137.9 4146.4 4153.3 4154.2 4227.9 4231.0 4232.1 4237.6 4239.3 4025.6 4089.8 4114.5 4780.4 4956.6 6114.1 6190.2 6198.5 6203.5 6209.5 1173.3 1194.8 1427.1 1435.6 1442.3 901.7 936.7 943.1 950.1 959.1 5722.8 5726.9 5730.6 5738.3 5765.6 6376.6 6379.7 6393.8 6407.2 6423.3 5300.8 5730.9 5775.2 5821.4 5829.1 2914.7 3052.8 3129.7 3293.5 3307.3 5811.9 6052.8 6479.9 6512.1 6558.3 6494.7 6505.6 6506.5 6531.3 6533.4 5718.0 5964.8 6290.5 6421.6 6563.5 6327.9 6373.2 6375.9 6393.9 6408.7 5364.9 6030.4 6238.9 6291.2 6312.6 5605.6 6137.8 6310.7 6458.9 6473.2 4040.9 4083.1 4084.9 4109.4 4132.4 6045.4 6273.3 6319.5 6330.8 6354.0 5173.5 6046.1 6065.6 6134.2 6153.7 5235.7 5696.8 6043.8 6108.5 6140.5 4558.9 4994.5 5738.9 5861.8 6007.6 5240.3 6093.0 6106.5 6118.7 6126.0 4713.0 5702.9 5899.3 6012.9 6020.5 17:50:34 INFO - PID 1951 | 17:50:34 INFO - PID 1951 | [#5] yui.html Cycles:180 Average:21314.95 Median:18728.61 stddev:30080.25 (160.6%) stddev-sans-first:30124.78 17:50:34 INFO - PID 1951 | Values: 692.1 834.6 838.7 840.1 852.4 13032.4 16838.8 18254.4 18618.5 18838.7 16887.7 16972.0 17429.3 17530.2 17561.7 961.6 969.5 972.2 974.1 974.2 657.1 668.4 953.2 959.8 977.7 1005.8 1006.2 1006.6 1006.7 1018.0 1004.3 1006.9 1007.3 1007.5 1023.2 499.0 501.2 509.6 513.4 754.8 12453.0 16226.8 16699.1 16704.2 16958.9 16265.4 16770.7 17080.0 17288.9 17292.9 13945.2 14150.0 14268.9 14271.8 14272.6 3369.3 3425.6 3447.6 3450.8 3455.4 99513.0 120271.0 121392.0 121922.0 128261.7 11014.7 11359.5 13224.7 13404.7 13412.3 17407.4 19394.0 19397.7 20064.7 25397.2 7658.5 7779.3 7856.5 7869.2 7891.2 3802.6 3929.9 3932.7 3933.4 3933.9 4247.1 4332.2 4337.0 4337.3 4339.0 906.9 912.3 925.0 927.6 927.7 621.9 657.2 661.3 669.0 689.4 11155.3 11877.5 11982.9 12041.6 12103.8 630.6 632.0 635.8 644.9 670.9 4503.5 5434.8 5509.1 5598.6 5635.7 89179.0 107715.5 107946.5 109561.5 111013.0 94620.5 95135.0 97035.0 97317.5 99782.0 73256.0 74487.6 74916.0 74980.5 75235.2 8465.2 10546.1 10752.2 11122.3 11148.3 41790.8 41991.0 42379.0 42407.8 42606.0 52412.2 52745.5 52901.0 53073.2 53758.2 13898.9 14313.0 16012.8 16545.3 16708.2 17710.6 17978.6 18456.1 18573.1 18896.1 16273.2 16356.5 17203.0 17532.5 17643.6 16631.1 16884.7 17048.4 17086.5 17256.6 15958.4 16401.4 16671.6 16796.7 16917.8 11140.2 11880.9 11967.6 12004.1 12110.6 11681.2 12203.8 12652.1 13324.3 13363.8 17:50:34 INFO - PID 1951 | -------- Summary: end -------- 17:50:34 INFO - PID 1951 | 17:50:34 INFO - TEST-INFO | 1951: exit 0 17:50:34 INFO - TEST-OK | dromaeo_css | took 1119370ms 17:50:34 INFO - TEST-START | kraken 17:50:34 INFO - operating with platform_type : mac_ 17:50:34 INFO - Initialising browser for kraken test... 17:50:34 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpFjL0bY/profile http://localhost:49475/getInfo.html) 17:50:37 INFO - PID 1957 | __metrics Screen width/height:1600/1200 17:50:37 INFO - PID 1957 | colorDepth:24 17:50:37 INFO - PID 1957 | Browser inner width/height: 1024/689 17:50:37 INFO - PID 1957 | __metrics 17:50:37 INFO - PID 1957 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:50:37 INFO - PID 1957 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:50:38 INFO - TEST-INFO | 1957: exit 0 17:50:38 INFO - Browser initialized. 17:50:38 INFO - Running cycle 1/1 for kraken test... 17:50:38 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpFjL0bY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:50 INFO - PID 1958 | RSS: Main: 241983488 17:50:50 INFO - PID 1958 | 17:50:53 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-beat-detection) 17:50:54 INFO - PID 1958 | RSS: Main: 310652928 17:50:54 INFO - PID 1958 | 17:50:57 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-dft) 17:50:57 INFO - PID 1958 | RSS: Main: 292306944 17:50:57 INFO - PID 1958 | 17:51:01 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-fft) 17:51:01 INFO - PID 1958 | RSS: Main: 384921600 17:51:01 INFO - PID 1958 | 17:51:03 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49475/tests/kraken/driver.html?testName=audio-oscillator) 17:51:04 INFO - PID 1958 | RSS: Main: 287678464 17:51:04 INFO - PID 1958 | 17:51:06 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:51:06 INFO - PID 1958 | RSS: Main: 291008512 17:51:06 INFO - PID 1958 | 17:51:09 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49475/tests/kraken/driver.html?testName=imaging-darkroom) 17:51:10 INFO - PID 1958 | RSS: Main: 356855808 17:51:10 INFO - PID 1958 | 17:51:13 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49475/tests/kraken/driver.html?testName=imaging-desaturate) 17:51:13 INFO - PID 1958 | RSS: Main: 364187648 17:51:13 INFO - PID 1958 | 17:51:16 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49475/tests/kraken/driver.html?testName=json-parse-financial) 17:51:17 INFO - PID 1958 | RSS: Main: 363364352 17:51:17 INFO - PID 1958 | 17:51:18 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:51:19 INFO - PID 1958 | RSS: Main: 330592256 17:51:19 INFO - PID 1958 | 17:51:21 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:51:21 INFO - PID 1958 | RSS: Main: 330219520 17:51:21 INFO - PID 1958 | 17:51:23 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:51:24 INFO - PID 1958 | RSS: Main: 332369920 17:51:24 INFO - PID 1958 | 17:51:27 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:51:28 INFO - PID 1958 | RSS: Main: 351260672 17:51:28 INFO - PID 1958 | 17:51:31 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:51:32 INFO - PID 1958 | RSS: Main: 343420928 17:51:32 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | Cycle 1(1): loaded http://localhost:49475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49475/tests/kraken/driver.html?testName=ai-astar) 17:51:33 INFO - PID 1958 | RSS: Main: 387043328 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | __start_tp_report 17:51:33 INFO - PID 1958 | _x_x_mozilla_page_load 17:51:33 INFO - PID 1958 | _x_x_mozilla_page_load_details 17:51:33 INFO - PID 1958 | |i|pagename|runs| 17:51:33 INFO - PID 1958 | |0;ai-astar;108;109;109;109;110;110;109;108;108;110 17:51:33 INFO - PID 1958 | |1;audio-beat-detection;142;109;108;148;110;108;107;105;137;112 17:51:33 INFO - PID 1958 | |2;audio-dft;190;186;184;185;183;183;186;267;209;181 17:51:33 INFO - PID 1958 | |3;audio-fft;83;59;58;88;61;56;60;58;81;56 17:51:33 INFO - PID 1958 | |4;audio-oscillator;94;70;85;71;68;69;89;68;69;90 17:51:33 INFO - PID 1958 | |5;imaging-gaussian-blur;89;89;90;90;90;90;93;89;90;94 17:51:33 INFO - PID 1958 | |6;imaging-darkroom;95;95;96;95;95;94;94;105;148;94 17:51:33 INFO - PID 1958 | |7;imaging-desaturate;84;85;84;85;84;85;83;83;86;83 17:51:33 INFO - PID 1958 | |8;json-parse-financial;47;47;49;47;48;49;50;50;49;49 17:51:33 INFO - PID 1958 | |9;json-stringify-tinderbox;63;59;62;53;59;60;57;57;57;57 17:51:33 INFO - PID 1958 | |10;stanford-crypto-aes;83;82;83;82;83;82;82;81;83;82 17:51:33 INFO - PID 1958 | |11;stanford-crypto-ccm;137;137;136;137;147;141;147;156;179;141 17:51:33 INFO - PID 1958 | |12;stanford-crypto-pbkdf2;184;188;187;186;188;192;241;187;185;183 17:51:33 INFO - PID 1958 | |13;stanford-crypto-sha256-iterative;69;69;69;67;68;69;69;67;68;69 17:51:33 INFO - PID 1958 | __end_tp_report 17:51:33 INFO - PID 1958 | __start_cc_report 17:51:33 INFO - PID 1958 | _x_x_mozilla_cycle_collect,2185 17:51:33 INFO - PID 1958 | __end_cc_report 17:51:33 INFO - PID 1958 | __startTimestamp1493427093979__endTimestamp 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | ------- Summary: start ------- 17:51:33 INFO - PID 1958 | Number of tests: 14 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 17:51:33 INFO - PID 1958 | Values: 108.0 109.0 109.0 109.0 110.0 110.0 109.0 108.0 108.0 110.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:111.00 stddev:16.68 (15.0%) stddev-sans-first:15.39 17:51:33 INFO - PID 1958 | Values: 142.0 109.0 108.0 148.0 110.0 108.0 107.0 105.0 137.0 112.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#2] audio-dft Cycles:10 Average:195.40 Median:186.00 stddev:26.40 (14.2%) stddev-sans-first:27.92 17:51:33 INFO - PID 1958 | Values: 190.0 186.0 184.0 185.0 183.0 183.0 186.0 267.0 209.0 181.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:12.63 (20.9%) stddev-sans-first:11.81 17:51:33 INFO - PID 1958 | Values: 83.0 59.0 58.0 88.0 61.0 56.0 60.0 58.0 81.0 56.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:10.75 (13.8%) stddev-sans-first:9.55 17:51:33 INFO - PID 1958 | Values: 94.0 70.0 85.0 71.0 68.0 69.0 89.0 68.0 69.0 90.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:90.00 stddev:1.71 (1.9%) stddev-sans-first:1.74 17:51:33 INFO - PID 1958 | Values: 89.0 89.0 90.0 90.0 90.0 90.0 93.0 89.0 90.0 94.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:95.00 stddev:16.80 (17.7%) stddev-sans-first:17.68 17:51:33 INFO - PID 1958 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 94.0 105.0 148.0 94.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.50 stddev:1.03 (1.2%) stddev-sans-first:1.09 17:51:33 INFO - PID 1958 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 83.0 83.0 86.0 83.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:49.00 stddev:1.18 (2.4%) stddev-sans-first:1.12 17:51:33 INFO - PID 1958 | Values: 47.0 47.0 49.0 47.0 48.0 49.0 50.0 50.0 49.0 49.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:59.00 stddev:2.88 (4.9%) stddev-sans-first:2.52 17:51:33 INFO - PID 1958 | Values: 63.0 59.0 62.0 53.0 59.0 60.0 57.0 57.0 57.0 57.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 17:51:33 INFO - PID 1958 | Values: 83.0 82.0 83.0 82.0 83.0 82.0 82.0 81.0 83.0 82.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:144.00 stddev:13.26 (9.2%) stddev-sans-first:13.68 17:51:33 INFO - PID 1958 | Values: 137.0 137.0 136.0 137.0 147.0 141.0 147.0 156.0 179.0 141.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.10 Median:187.50 stddev:17.36 (9.3%) stddev-sans-first:18.17 17:51:33 INFO - PID 1958 | Values: 184.0 188.0 187.0 186.0 188.0 192.0 241.0 187.0 185.0 183.0 17:51:33 INFO - PID 1958 | 17:51:33 INFO - PID 1958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 17:51:33 INFO - PID 1958 | Values: 69.0 69.0 69.0 67.0 68.0 69.0 69.0 67.0 68.0 69.0 17:51:33 INFO - PID 1958 | -------- Summary: end -------- 17:51:33 INFO - PID 1958 | 17:51:34 INFO - TEST-INFO | 1958: exit 0 17:51:35 INFO - TEST-OK | kraken | took 60188ms 17:51:35 INFO - SUITE-END | took 1179s 17:51:35 INFO - Completed test suite (00:19:39) 17:51:35 INFO - javascript benchmark 17:51:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7626.640767966675, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3456.7925924444526, 3471.409860323746, 3483.1640406302495, 3501.3697534443804, 3526.982365088176, 5963.970180149104, 6069.42340477655, 6207.068939659053, 6211.347808480113, 6230.750769969201, 6084.482818960382, 6113.567524283673, 6154.661493617849, 6209.348018458065, 6211.720472578733, 5133.050385678662, 5201.349831271091, 5279.551238144743, 5295.338082739658, 5382.6232163748555, 5325.094733895227, 5346.732663366835, 5369.62412631116, 5374.838754837361, 5376.892462150755, 5218.425973142951, 5279.392869819982, 5294.020606187868, 5333.35999680037, 5339.492748188935, 5325.467453254682, 5340.973295133538, 5354.116570765819, 5356.11624082026, 5395.514403703646, 5277.419483856773, 5325.893482130375, 5336.839894803162, 5338.786448542053, 5388.78444862205, 5956.910646340309, 6045.395460453963, 6128.7242074106325, 6152.723127459275, 6168.568200225986, 6302.684865756693, 6344.33384494626, 6381.489480841522, 6385.457236134934, 6387.457066149383, 6519.119918810948, 6520.315366886456, 6520.869582608369, 6524.836879078013, 6540.149780528501, 6186.81439556814, 6193.256809182837, 6263.31103578606, 6266.655333956631, 6287.654179020106, 6370.171877655967, 6444.484441244689, 6603.174603174603, 6678.065070890079, 6697.430718388894, 6321.8735625288155, 6327.177466929362, 6331.113644089831, 6339.207599050119, 6346.777862774781, 6357.841053973688, 6482.416582507597, 6484.0, 6486.935130648728, 6502.837429064311, 6278.591891527128, 6331.841703957438, 6346.524010699216, 6352.618842869442, 6361.872762544724, 6285.937140628626, 6303.149074874925, 6347.936520634827, 6385.712642931079, 6403.519736019817, 5184.662996905189, 5189.169732842727, 5190.766415511311, 5198.194279886624, 5199.272101905736, 3965.6516784292903, 4570.9314360284625, 4626.21354369758, 4679.27471241958, 4684.461286952044, 4943.9258411123865, 6067.7876274331065, 6070.514358851281, 6194.442500175006, 6210.844728881814, 6425.485961123099, 6465.903011454832, 6496.025596160519, 6497.902531462032, 6519.608823470607, 6112.205413296332, 6154.261488621304, 6176.752929882754, 6178.598391104564, 6187.628742275388, 5564.91652625219, 5689.886202276014, 5697.601167918288, 5711.8000869969355, 5732.7706891723865, 6480.643564603992, 6490.675466226576, 6496.70764815575, 6498.837529061811, 6507.284198738041, 6365.840853978688, 6440.0983862260255, 6502.219733631994, 6520.869582608416, 6523.24982627004, 6641.369069938348, 6667.066610674412, 6687.76592819249, 6691.1636045494315, 6721.227058888095, 6280.183576135073, 6389.137466441971, 6406.519511036598, 6408.775692850728, 6409.262934762375, 6370.4903607712195, 6419.518536109717, 6423.0, 6459.192600924885, 6507.804765857032, 6256.5620406572925, 6285.057241413824, 6312.873742525216, 6316.6841657916, 6324.114623952558, 6173.043178307369, 6297.937020629735, 6311.179546658905, 6315.400036996478, 6317.336679648571, 6137.438273608381, 6230.470410015199, 6243.594166379171, 6262.718177681924, 6317.336679648571, 6289.654069026247, 6310.84222894413, 6314.179156709783, 6318.968405157945, 6325.493960483058, 6292.2134733158355, 6293.716782744879, 6303.873922521432, 6307.36926307384, 6307.842303942438], "value": 5937.602224629117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.56669914799, 785.1559573458532, 794.0868001797934, 1095.9726006849833, 1114.0363585498542, 25361.49277014461, 35497.46753798695, 35552.0, 35634.75278365258, 35636.10909727258, 37572.81213593935, 37898.24203515928, 37905.810470947676, 37921.62078379222, 37940.86177414682, 5844.561657875676, 5872.7063646817705, 8122.47203931744, 8250.669973201066, 8275.337972962148, 8113.472624279432, 8210.630521626512, 8218.137095604965, 8227.876581851277, 8231.135730748276, 8175.7138500152505, 8255.009398872144, 8271.131531189229, 8273.172682731709, 8363.581820908961, 8156.714514991976, 8205.302549283319, 8214.46605970616, 8226.05400378958, 8228.341732661404, 8152.8777068344025, 8216.301614362786, 8217.58912054401, 8227.54748488833, 8235.95882020592, 35215.82392088049, 35439.0, 35445.46831797499, 35515.467267991, 35573.0, 3553.9466907996402, 3560.359135355635, 3580.7672501287334, 3586.5875424326277, 3588.372034893883, 29199.854000730073, 29329.560056599166, 29354.41291174186, 29373.11880643584, 29383.0, 3035.8633861476287, 3068.9693103068907, 3086.42901063304, 3105.177128061043, 3116.5169398743005, 281221.0, 284337.0, 285467.0, 287154.0, 289703.0, 46331.0, 46722.83192920204, 46725.0, 46764.83087922829, 46905.0, 48289.6197266188, 48307.516924831005, 48324.0, 48363.758181209574, 48438.27342589864, 13637.045406821428, 13698.246596437291, 13705.040647154603, 13709.588712338646, 13720.794188087186, 9539.189168920719, 9553.331266811256, 9673.274504412197, 11152.163587730953, 11166.609168679057, 11689.298642081503, 11723.4138293085, 11793.705157371134, 11799.233049851731, 11980.52077916891, 5303.655262408009, 5310.389305229871, 5324.414314425488, 5332.760025798849, 5343.866403339947, 875.9781005474914, 905.7726780212848, 963.1668606655193, 999.2755252441922, 1004.8191325561323, 20590.588188236452, 22736.886315568318, 23723.169689061146, 23866.642000370008, 23955.0, 1067.5996501312009, 1078.250615822012, 1106.8727096383857, 1108.3405373802575, 1132.252713209278, 12055.397230138458, 12095.516179352904, 12172.695682608006, 12193.32936688473, 12233.266004039786, 288770.0, 305888.0, 306268.0, 306376.0, 306537.0, 50034.9993000138, 50130.0, 50251.74874125606, 50264.49735502598, 50296.999999999265, 1436.3392839293833, 1452.2230606625405, 1494.887883408727, 1496.513633069257, 1521.0, 23284.53430931406, 23361.299161025196, 23462.530749384576, 23475.64786528169, 23488.53022939566, 36557.634423656484, 36742.26515469622, 36744.0, 36827.63172368242, 36856.07859803527, 268711.0, 268852.0, 269125.0, 269263.0, 269539.0, 28715.856420717762, 29295.0, 32655.836720816245, 32680.54895882866, 32723.0, 41712.79143604262, 41800.79099604482, 41820.58179418167, 41882.37176442295, 41886.16227675368, 26245.606315904894, 27501.249875013138, 27824.582631260142, 28832.711672883004, 28908.132756017352, 28616.85691571529, 29469.557956631095, 29472.852635736683, 29774.702252977193, 29808.254793630334, 33334.66665333316, 34157.0, 34494.0, 34997.300053999286, 35055.47416788801, 28710.856445717636, 28728.712712872602, 29614.259643509085, 29653.851730741208, 29947.70052299536, 22206.0, 22954.0, 23394.76605233926, 23405.648915265945, 23498.942547585742], "value": 16654.249840212316, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.67679103270444, 424.20461634435435, 430.2878735692429, 438.2834066301597, 445.2808713927009, 18483.907580462095, 20253.39239822804, 20809.895950520226, 21017.054232559534, 21064.157433702632, 17471.91264043678, 20747.0, 21432.57134857302, 21445.892770536164, 21605.567888642217, 5787.450192231731, 6102.633841969474, 6115.877682446348, 6128.264608247016, 6143.784967526138, 5851.561132915027, 6025.457708806207, 6038.154658347813, 6118.755249790003, 6126.908096378535, 6042.667653279068, 6045.244344456943, 6053.606515576474, 6057.030875059992, 6105.32841387447, 5878.441548052928, 5905.822825315247, 6012.30858451275, 6024.397560243984, 6025.186599809035, 5205.245239440298, 5335.493128152819, 5337.06601344767, 5337.866553336159, 5349.866253343658, 21924.561508769893, 25895.35261618456, 25934.87032564844, 26521.07176248822, 27194.04820831281, 2153.074178103415, 2191.561687662474, 2225.0765932138142, 2229.264342766883, 2231.5871563760757, 17179.656406871793, 17480.038597877112, 17979.550511237194, 18279.63440731178, 18352.632947341113, 1873.709575015861, 2064.298138632872, 2132.402927180392, 2170.728658917635, 2171.782821717831, 151065.0, 155707.22146389307, 157740.0, 159213.2039339796, 160650.0, 11223.214374993671, 11801.704957376134, 11803.40982950849, 11834.112441566916, 11905.702357441134, 15014.0, 15558.0, 15605.0, 15624.687506249811, 15629.68740625181, 7507.286807753364, 8619.439736417113, 8790.164934331227, 8810.691625793066, 8957.596908139149, 8341.499510029418, 8367.0, 8397.916020839835, 8541.273991710774, 8581.35639827003, 6272.278687950944, 7389.630518474055, 7498.512596681198, 7541.811454713676, 7569.735059272899, 2054.815066644009, 2070.554830711404, 2074.854760166804, 2076.3770868739316, 2213.922512712047, 887.8135591525722, 929.990700093004, 954.6944977607099, 957.1098878043347, 963.5663951221838, 19959.700604490943, 20584.073716682786, 20727.792722072587, 20781.272655456985, 20967.790322096887, 971.7182017214928, 973.0998826085984, 980.1717548671361, 1011.4790882695418, 1013.1034034879185, 10336.483175841178, 10640.255182137176, 10730.624428144978, 10734.355938643706, 10738.463076846127, 561341.0, 564204.0, 569396.0, 579509.0, 580679.0966045227, 123835.14247286298, 128534.35732821276, 128832.35583822208, 129385.70614293925, 133219.0, 1148.5635458525708, 1156.7397335599592, 1184.2065815903366, 1184.9822252666218, 1187.5368606243571, 16880.831191687925, 17489.82510174882, 17561.94628322305, 17594.648107038043, 17883.195256213763, 53484.73257633687, 54456.727716361165, 54831.0, 55362.723186385425, 55999.44000560105, 63116.68441657762, 71697.84906452814, 78251.0, 78556.60721696354, 79082.0, 7243.348098671145, 8329.583520824055, 8566.700165494178, 8787.165219304155, 8928.86606700887, 13464.865351346753, 14507.854921450651, 14525.636859078608, 14980.475683351031, 15071.698566028399, 11825.940870295593, 11884.702882428008, 11950.163488555718, 12240.69398265015, 12352.0, 11620.767584648429, 11634.0, 11738.119641026786, 11798.410079496163, 12027.398630068286, 12169.452374643339, 12340.81488777651, 12411.131220814455, 12558.686032849251, 12566.0, 8720.302375810046, 8725.650973961225, 8993.220863952765, 9174.770630734285, 9201.677941272023, 10397.956990859277, 10726.463676815973, 11557.711057223636, 11926.284422934652, 12152.75694486123], "value": 10228.091453412013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.646399312203, 1404.7401230772307, 1440.567829651105, 1459.5183589415494, 1466.6260103673562, 9627.759306017344, 10109.393436393811, 11348.829767553472, 11583.768324633502, 11586.65240042798, 11198.0, 11283.37941413222, 11286.604968826092, 11309.886901131007, 11323.943380283086, 2254.9289087683383, 2408.4460574067975, 2467.69212317472, 2502.924912252626, 2506.636537702032, 2106.4523223961805, 2183.7816218378193, 2467.346877592018, 2528.595424732034, 2540.212534114421, 2476.2447453526665, 2487.6641653376832, 2507.3104896153523, 2513.54756143894, 2520.2565243253284, 2492.9750702492925, 2499.3501689560753, 2499.500099979993, 2499.5375855466614, 2509.2095989763166, 2436.4517983453757, 2460.692413448319, 2464.950700985988, 2465.630155476675, 2468.6790717206827, 11300.547978080867, 11344.716382090513, 11430.485628146753, 11477.426128693533, 11488.02351800098, 6401.039844023434, 6651.0023496475915, 6657.5006874484125, 6662.933370666328, 6663.800085997379, 3917.745346552465, 4108.4453598764385, 4180.143070670536, 4255.914881702349, 4263.65890728744, 1212.254463504947, 1216.173002358396, 1254.5483625894672, 1255.1339575692743, 1274.0635632809876, 16568.585785355343, 16638.916805416018, 16641.91679041597, 16673.91663041689, 16676.499705008748, 5683.943160568424, 5811.3026436827, 5854.560907931922, 5916.26046744157, 6003.459688628044, 13738.725225495435, 13769.31153442324, 13777.517786877412, 13782.0, 13805.51680691171, 6737.595744255263, 6741.820181468223, 6742.898856517156, 6743.730250790011, 6752.291009444036, 5213.452587478336, 6095.878082438327, 6141.692915354214, 6148.784792532329, 6151.815445536641, 3723.497327860758, 4082.693797965105, 4194.538600753915, 4532.864014079517, 4574.519675434098, 1372.848986611472, 1415.688548519324, 1419.1485108934558, 1438.7841823726524, 1438.892083093772, 780.7189411811743, 783.8941742864754, 793.7102957420616, 799.6201804142986, 803.7869964459423, 5589.496945274864, 6560.147180866552, 6680.565763225375, 6962.825929351807, 7001.054857594261, 903.3405613901889, 922.1838672774509, 923.4136323434667, 923.6259314977444, 941.18117238002, 4276.230278549829, 4305.246581848227, 4365.869023929287, 4432.822687092545, 4470.821167153277, 14352.49766258176, 14775.335109920079, 14957.0, 15214.239288035555, 15321.616959575877, 14675.19286439256, 14934.626634334229, 14951.775723364159, 14967.550973470814, 14973.326200321011, 8339.332853371716, 8545.572721363907, 8550.1449855014, 8551.01663308715, 8572.742817715478, 5156.56169225605, 6678.83302917431, 7156.320149585781, 7174.246704095995, 7196.532225405332, 11838.408079595814, 12869.970402367975, 13249.072564920363, 13622.114562553403, 13764.65588360299, 13254.867451325363, 13678.726425471634, 13783.379747911167, 13864.098833575785, 14109.153450792985, 9078.546072696206, 9350.205232555038, 9354.859677104712, 9375.531223438664, 9401.153896149379, 8599.52702601363, 9589.712308630753, 10583.576656933636, 10616.575336986434, 10688.57245710194, 9044.728658140266, 9056.320775941698, 9063.184313411824, 9130.726078217664, 9173.54132293396, 8739.563021848755, 8828.117188281121, 8924.9736280326, 8988.235999940078, 8995.830542029495, 8153.510789352657, 8170.836583268182, 8281.420300578902, 8281.710140145065, 8283.95858020706, 6019.18740969981, 6122.173506576733, 6168.876622467616, 6182.907256391068, 6196.938030619816, 6058.666773327509, 6108.541859360477, 6182.28903676083, 6225.3774622539195, 6247.5939063960695], "value": 5385.668880034196, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.6113886113886, 395.12676983865657, 398.8683734367659, 399.16773527195807, 405.3979839937694, 5761.687029957775, 5762.366139724632, 5775.422457754233, 5777.248957635512, 5852.9707351463185, 4232.730180945711, 5087.85523257267, 5634.19705694178, 5728.0, 5748.885022299552, 4334.263175260197, 4356.041670832427, 4375.584319489643, 4378.409704042686, 4382.452193475816, 3989.9202015959663, 4396.582324679166, 4398.582134697214, 4438.467383913919, 4438.800253988578, 3569.3575156471825, 4206.663466922639, 4311.461067366579, 4358.368036634686, 4369.016971181491, 3541.38025845476, 4341.175176716414, 4349.934750978738, 4353.717008394444, 4362.083962367875, 3854.1520865409566, 3862.517185351831, 3867.7872717000555, 3873.6513713765617, 3877.786721730332, 5432.837014889559, 5585.692786896719, 5601.60788744788, 5605.458498912791, 5659.830205093854, 4892.363992680965, 5213.348331458567, 5246.842594722164, 5248.716808188412, 5271.47127333073, 5026.497350264981, 5097.464766199532, 5287.524122828964, 6067.089936509515, 6098.9695051524905, 3831.689349481833, 4038.6268668652506, 4096.242195193899, 4099.929535584541, 4108.671306295519, 5425.647332923387, 6323.20959880015, 6335.714892829834, 6444.806655800334, 6456.386643268882, 4018.749500279853, 4137.855175068858, 4146.362186936203, 4153.314703073959, 4154.231467178582, 4227.936580951288, 4230.963413963598, 4232.111256636141, 4237.555056719062, 4239.258129827268, 4025.6376926076796, 4089.795510224477, 4114.547399786021, 4780.354652121989, 4956.628252881048, 6114.113453549299, 6190.226221722285, 6198.535109866778, 6203.503719702413, 6209.5032397408095, 1173.3253379306761, 1194.8028575285155, 1427.1151885830852, 1435.612384656137, 1442.2500299844232, 901.6573701993332, 936.7260525685062, 943.104051151409, 950.1211379474097, 959.1128206409044, 5722.77108915647, 5726.856828579319, 5730.598858079978, 5738.282714660668, 5765.625234359753, 6376.553641245161, 6379.681015949184, 6393.776217832354, 6407.199100112486, 6423.293437721847, 5300.840974770763, 5730.942690573041, 5775.249217601769, 5821.417858214145, 5829.125631155361, 2914.6502419709773, 3052.8399208300702, 3129.718325350729, 3293.4565796643287, 3307.2724000719804, 5811.941880581225, 6052.848678782978, 6479.935200648028, 6512.120863683437, 6558.344165583499, 6494.675266236669, 6505.577137486048, 6506.544541882117, 6531.3142120077655, 6533.386645341806, 5718.027935251017, 5964.777220669752, 6290.528210384239, 6421.5825971311715, 6563.50773691975, 6327.873442531216, 6373.171487706569, 6375.872482550416, 6393.904091438539, 6408.711607977559, 5364.873376590959, 6030.427109424598, 6238.908191066636, 6291.150694656346, 6312.558120931674, 5605.635633683797, 6137.815865524041, 6310.7475700971445, 6458.903116453351, 6473.158489396348, 4040.8887555921183, 4083.0809519525774, 4084.897877553085, 4109.383592461155, 4132.421460995403, 6045.4281886708895, 6273.341299163704, 6319.46284565817, 6330.847511845995, 6354.0, 5173.456787037307, 6046.1257010326935, 6065.575409721454, 6134.171886795226, 6153.72308246139, 5235.691077230692, 5696.8006119785605, 6043.788467403796, 6108.541859360655, 6140.508759299335, 4558.8632341029825, 4994.450610432777, 5738.9139162913425, 5861.84506268425, 6007.609505382136, 5240.34495688039, 6092.969535152473, 6106.480949119375, 6118.663473509, 6125.9693701531205, 4713.0, 5702.857428564153, 5899.262592175978, 6012.909806352821, 6020.488258498077], "value": 4459.23616859848, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.0760784352889, 834.5618550261108, 838.6687258532879, 840.1052878684201, 852.3820230333007, 13032.413541390637, 16838.83161168388, 18254.361097361594, 18618.51051915847, 18838.717419238706, 16887.746683799753, 16972.0, 17429.30282788687, 17530.211140498675, 17561.736573951403, 961.5769061612885, 969.5055521683921, 972.1687956796943, 974.1038244814752, 974.2060220919927, 657.1424291299852, 668.4218151299116, 953.2183609440261, 959.7936443664611, 977.6920270114927, 1005.8088963097025, 1006.2453160129902, 1006.582268358634, 1006.6778630838135, 1018.0074427433267, 1004.3321191407705, 1006.9093781559621, 1007.2898606482412, 1007.536533194735, 1023.2223510132278, 498.9945260300497, 501.1955810923452, 509.57195955397646, 513.36342934761, 754.8452567223706, 12453.0, 16226.756598651029, 16699.08155051472, 16704.164791760362, 16958.915205423895, 16265.430709925215, 16770.664586708197, 17080.0, 17288.913555432267, 17292.913535432242, 13945.233012184326, 14150.0, 14268.857311426857, 14271.78592321116, 14272.571822845332, 3369.2924485858, 3425.5889293284963, 3447.637998010223, 3450.8274586270586, 3455.378031954247, 99513.01460956183, 120271.0, 121392.0, 121922.0, 128261.71738282591, 11014.669559913054, 11359.488823002985, 13224.735505290033, 13404.664883377993, 13412.262325571992, 17407.390741324245, 19394.0, 19397.709034364496, 20064.69902951457, 25397.238082857544, 7658.540487570764, 7779.338756205672, 7856.450048496665, 7869.213078692085, 7891.171427000198, 3802.5817160112365, 3929.8821035368983, 3932.6657234134846, 3933.350997085506, 3933.940990885139, 4247.129338485603, 4332.176886391576, 4337.0, 4337.284348082531, 4339.0, 906.9229115525122, 912.2565109435789, 925.0240995749549, 927.6011315134422, 927.7402327348353, 621.8880601491775, 657.2343220148473, 661.3122352753082, 668.9799306020827, 689.3864460630043, 11155.27490713101, 11877.524899004116, 11982.940085299691, 12041.578544751066, 12103.818442723366, 630.6216270237912, 631.9557630965788, 635.7552342348137, 644.9161608990895, 670.8591195848829, 4503.482099558592, 5434.755436005389, 5509.146082357241, 5598.58010649203, 5635.690037048002, 89179.0, 107715.46142269239, 107946.46026769816, 109561.45219274012, 111013.0, 94620.52689736507, 95135.0, 97035.0, 97317.5134124339, 99782.0, 73256.0, 74487.62756186293, 74916.0, 74980.50038999299, 75235.24764752392, 8465.238128568459, 10546.103581195684, 10752.247342685936, 11122.277051991594, 11148.275362101438, 41790.79104604458, 41991.0, 42379.0, 42407.78796106, 42606.0, 52412.21381679201, 52745.47254527559, 52901.0, 53073.20390194073, 53758.19362709484, 13898.861011389758, 14313.0, 16012.839871601134, 16545.338186472887, 16708.16459177012, 17710.64578708393, 17978.64042719112, 18456.077196140406, 18573.071346432895, 18896.05519724036, 16273.186340682681, 16356.509304720877, 17203.0, 17532.474025779247, 17643.647127057644, 16631.085290308663, 16884.66230675355, 17048.403305884236, 17086.48740537786, 17256.568585785455, 15958.361665533714, 16401.42595009169, 16671.583210419838, 16796.66406671884, 16917.830821691627, 11140.16448766362, 11880.940595296968, 11967.581134660246, 12004.099692522921, 12110.576129835414, 11681.240719353214, 12203.75592488163, 12652.114351995271, 13324.333783310602, 13363.799543007057], "value": 8100.973204950156, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1437.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 108.0, 108.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 148.0, 110.0, 108.0, 107.0, 105.0, 137.0, 112.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 186.0, 184.0, 185.0, 183.0, 183.0, 186.0, 267.0, 209.0, 181.0], "value": 195.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 88.0, 61.0, 56.0, 60.0, 58.0, 81.0, 56.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 70.0, 85.0, 71.0, 68.0, 69.0, 89.0, 68.0, 69.0, 90.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 90.0, 90.0, 90.0, 93.0, 89.0, 90.0, 94.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 105.0, 148.0, 94.0], "value": 101.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 83.0, 83.0, 86.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 49.0, 47.0, 48.0, 49.0, 50.0, 50.0, 49.0, 49.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 62.0, 53.0, 59.0, 60.0, 57.0, 57.0, 57.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 82.0, 83.0, 82.0, 82.0, 81.0, 83.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 136.0, 137.0, 147.0, 141.0, 147.0, 156.0, 179.0, 141.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 187.0, 186.0, 188.0, 192.0, 241.0, 187.0, 185.0, 183.0], "value": 192.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 67.0, 68.0, 69.0, 69.0, 67.0, 68.0, 69.0], "value": 68.4, "unit": "score"}]}]} 17:51:35 INFO - Return code: 0 17:51:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:51:35 ERROR - # TBPL SUCCESS # 17:51:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:51:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:51:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:51:35 INFO - 2017-04-28 17:51:35.339 screenresolution[1963:15536] starting screenresolution argv=screenresolution get 17:51:35 INFO - 2017-04-28 17:51:35.343 screenresolution[1963:15536] Display 0: 1600x1200x32@60 17:51:35 INFO - 2017-04-28 17:51:35.350 screenresolution[1964:15539] starting screenresolution argv=screenresolution list 17:51:35 INFO - Available Modes on Display 0 17:51:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:51:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:51:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:51:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:51:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:51:35 INFO - Intel Iris: 17:51:35 INFO - Chipset Model: Intel Iris 17:51:35 INFO - Type: GPU 17:51:35 INFO - Bus: Built-In 17:51:35 INFO - VRAM (Dynamic, Max): 1536 MB 17:51:35 INFO - Vendor: Intel (0x8086) 17:51:35 INFO - Device ID: 0x0a2e 17:51:35 INFO - Revision ID: 0x0009 17:51:35 INFO - Displays: 17:51:35 INFO - Display: 17:51:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:51:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:51:35 INFO - Display Serial Number: 1600x1200 60 17:51:35 INFO - Main Display: Yes 17:51:35 INFO - Mirror: Off 17:51:35 INFO - Online: Yes 17:51:35 INFO - Rotation: Supported 17:51:35 INFO - Return code: 0 17:51:35 INFO - Running post-action listener: _resource_record_post_action 17:51:35 INFO - [mozharness: 2017-04-29 00:51:35.601050Z] Finished run-tests step (success) 17:51:35 INFO - Running post-run listener: _resource_record_post_run 17:51:35 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 1090048; Write bytes: 509357056; Read time: 13; Write time: 1565 17:51:35 INFO - TinderboxPrint: CPU usage
53.4% 17:51:35 INFO - TinderboxPrint: I/O read bytes / time
1,090,048 / 13 17:51:35 INFO - TinderboxPrint: I/O write bytes / time
509,357,056 / 1,565 17:51:35 INFO - TinderboxPrint: CPU idle
2,238.8 (46.6%) 17:51:35 INFO - TinderboxPrint: CPU system
959.9 (20.0%) 17:51:35 INFO - TinderboxPrint: CPU user
1,602.9 (33.4%) 17:51:35 INFO - TinderboxPrint: Swap in / out
210,915,328 / 0 17:51:35 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209826304; Write bytes: 211617280; Read time: 16034; Write time: 454 17:51:35 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 1090048; Write bytes: 296293888; Read time: 13; Write time: 1101 17:51:36 INFO - Running post-run listener: _upload_blobber_files 17:51:36 INFO - Blob upload gear active. 17:51:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:51:36 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 17:51:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:51:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:37 INFO - (blobuploader) - INFO - Done attempting. 17:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:51:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:38 INFO - (blobuploader) - INFO - Done attempting. 17:51:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:51:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:51:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:39 INFO - (blobuploader) - INFO - Done attempting. 17:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:41 INFO - (blobuploader) - INFO - Done attempting. 17:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:51:41 INFO - Return code: 0 17:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e9c8724625d086020db7f95f6161c1a96c72fc43af24c06ba1ebea8fc612d8036a736d8791f71bf8ff0b7848acf25944d994c18221e033b68a0c02d21397a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3947a5fa02f87ea2925bc20fa036e98791a8f2977597be49a169b622cc565c5aa8aea2dfb9cf4497c0352e446be85bdcca2426a51a860646f93c2ddf3414c509", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737bc6a557879af0227327bd5172151df93b423a0fbc49499638a96a602e93ac1eb73f77f097707790142319e4ce268361082e17b06a4bb62267d6938dbe138d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331eea61cbdf21388a1934445e1a946a98ddc2df54757f222847e34288fafc6c0d5e1aeedf14af747e0bf704e5c0b9aa9882a8747bbbd26c73ae22ef839badbe"} 17:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:51:41 INFO - Contents: 17:51:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e9c8724625d086020db7f95f6161c1a96c72fc43af24c06ba1ebea8fc612d8036a736d8791f71bf8ff0b7848acf25944d994c18221e033b68a0c02d21397a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3947a5fa02f87ea2925bc20fa036e98791a8f2977597be49a169b622cc565c5aa8aea2dfb9cf4497c0352e446be85bdcca2426a51a860646f93c2ddf3414c509", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737bc6a557879af0227327bd5172151df93b423a0fbc49499638a96a602e93ac1eb73f77f097707790142319e4ce268361082e17b06a4bb62267d6938dbe138d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331eea61cbdf21388a1934445e1a946a98ddc2df54757f222847e34288fafc6c0d5e1aeedf14af747e0bf704e5c0b9aa9882a8747bbbd26c73ae22ef839badbe"} 17:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:51:41 INFO - Copying logs to upload dir... 17:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.471658 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-28 17:51:41.810064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:51:41.813149) ========= 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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e9c8724625d086020db7f95f6161c1a96c72fc43af24c06ba1ebea8fc612d8036a736d8791f71bf8ff0b7848acf25944d994c18221e033b68a0c02d21397a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3947a5fa02f87ea2925bc20fa036e98791a8f2977597be49a169b622cc565c5aa8aea2dfb9cf4497c0352e446be85bdcca2426a51a860646f93c2ddf3414c509", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737bc6a557879af0227327bd5172151df93b423a0fbc49499638a96a602e93ac1eb73f77f097707790142319e4ce268361082e17b06a4bb62267d6938dbe138d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331eea61cbdf21388a1934445e1a946a98ddc2df54757f222847e34288fafc6c0d5e1aeedf14af747e0bf704e5c0b9aa9882a8747bbbd26c73ae22ef839badbe"} build_url:https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/UewMW9DnT9a5s9xVhGxJ5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e9c8724625d086020db7f95f6161c1a96c72fc43af24c06ba1ebea8fc612d8036a736d8791f71bf8ff0b7848acf25944d994c18221e033b68a0c02d21397a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3947a5fa02f87ea2925bc20fa036e98791a8f2977597be49a169b622cc565c5aa8aea2dfb9cf4497c0352e446be85bdcca2426a51a860646f93c2ddf3414c509", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737bc6a557879af0227327bd5172151df93b423a0fbc49499638a96a602e93ac1eb73f77f097707790142319e4ce268361082e17b06a4bb62267d6938dbe138d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331eea61cbdf21388a1934445e1a946a98ddc2df54757f222847e34288fafc6c0d5e1aeedf14af747e0bf704e5c0b9aa9882a8747bbbd26c73ae22ef839badbe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:51:41.847951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:51:41.848238) ========= 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.NZwEa1pQuK/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.KDbmRx0W9P/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:51:41.896225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:51:41.896502) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:51:41.896794) ========= ========= Total master_lag: 3.82 =========