builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0227 starttime: 1493496283.61 results: success (0) buildid: 20170429122646 builduid: da8149bd852a47b8a01242dd8adbeabb revision: 52b69565a24db74c0184e3a5039e32cf6de3f39e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:43.613319) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:43.613827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:43.614167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:43.652806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:43.653080) ========= 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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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-29 13:04:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-04-29 13:04:44 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.628260 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:44.310468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:44.310934) ========= 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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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.027684 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:44.361842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:44.362152) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52b69565a24db74c0184e3a5039e32cf6de3f39e --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 52b69565a24db74c0184e3a5039e32cf6de3f39e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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-29 13:04:44,464 truncating revision to first 12 chars 2017-04-29 13:04:44,464 Setting DEBUG logging. 2017-04-29 13:04:44,464 attempt 1/10 2017-04-29 13:04:44,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52b69565a24d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-29 13:04:45,111 unpacking tar archive at: mozilla-central-52b69565a24d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942528 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:45.328606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:45.328876) ========= script_repo_revision: 52b69565a24db74c0184e3a5039e32cf6de3f39e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:45.329271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:45.329532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-29 13:04:45.349093) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-29 13:04:45.349391) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:04:45 INFO - MultiFileLogger online at 20170429 13:04:45 in /builds/slave/test 13:04:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:04:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:04:45 INFO - {'append_to_log': False, 13:04:45 INFO - 'base_work_dir': '/builds/slave/test', 13:04:45 INFO - 'blob_upload_branch': 'Firefox', 13:04:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:04:45 INFO - 'branch': 'Firefox', 13:04:45 INFO - 'buildbot_json_path': 'buildprops.json', 13:04:45 INFO - 'config_files': ('talos/mac_config.py',), 13:04:45 INFO - 'default_actions': ('clobber', 13:04:45 INFO - 'read-buildbot-config', 13:04:45 INFO - 'download-and-extract', 13:04:45 INFO - 'populate-webroot', 13:04:45 INFO - 'create-virtualenv', 13:04:45 INFO - 'install', 13:04:45 INFO - 'run-tests'), 13:04:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:04:45 INFO - 'download_minidump_stackwalk': True, 13:04:45 INFO - 'download_symbols': 'ondemand', 13:04:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:04:45 INFO - 'tooltool.py': '/tools/tooltool.py', 13:04:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:04:45 INFO - '/tools/misc-python/virtualenv.py')}, 13:04:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:04:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:04:45 INFO - 'gecko_profile': False, 13:04:45 INFO - 'gecko_profile_interval': 0, 13:04:45 INFO - 'installer_path': 'installer.exe', 13:04:45 INFO - 'log_level': 'info', 13:04:45 INFO - 'log_name': 'talos', 13:04:45 INFO - 'log_to_console': True, 13:04:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:04:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:04:45 INFO - 'opt_config_files': (), 13:04:45 INFO - 'pip_index': False, 13:04:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:04:45 INFO - 'cmd': ('bash', 13:04:45 INFO - '-c', 13:04:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:04:45 INFO - 'enabled': True, 13:04:45 INFO - 'halt_on_failure': False, 13:04:45 INFO - 'name': 'check_screen_resolution'},), 13:04:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:04:45 INFO - 'cmd': ('bash', 13:04:45 INFO - '-c', 13:04:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:04:45 INFO - 'enabled': True, 13:04:45 INFO - 'halt_on_failure': False, 13:04:45 INFO - 'name': 'check_screen_resolution'},), 13:04:45 INFO - 'run_cmd_checks_enabled': True, 13:04:45 INFO - 'suite': 'dromaeojs-e10s', 13:04:45 INFO - 'system_bits': '32', 13:04:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:04:45 INFO - 'title': 't-yosemite-r7-0227', 13:04:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:04:45 INFO - 'use_talos_json': True, 13:04:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:04:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:04:45 INFO - 'work_dir': 'build'} 13:04:45 INFO - [mozharness: 2017-04-29 20:04:45.560729Z] Running clobber step. 13:04:45 INFO - Running pre-action listener: _resource_record_pre_action 13:04:45 INFO - Running main action method: clobber 13:04:45 INFO - rmtree: /builds/slave/test/build 13:04:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:04:48 INFO - Running post-action listener: _resource_record_post_action 13:04:48 INFO - [mozharness: 2017-04-29 20:04:48.124818Z] Finished clobber step (success) 13:04:48 INFO - [mozharness: 2017-04-29 20:04:48.125099Z] Running read-buildbot-config step. 13:04:48 INFO - Running pre-action listener: _resource_record_pre_action 13:04:48 INFO - Running main action method: read_buildbot_config 13:04:48 INFO - Using buildbot properties: 13:04:48 INFO - { 13:04:48 INFO - "project": "", 13:04:48 INFO - "product": "firefox", 13:04:48 INFO - "script_repo_revision": "production", 13:04:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:04:48 INFO - "repository": "", 13:04:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:04:48 INFO - "buildid": "20170429122646", 13:04:48 INFO - "pgo_build": "False", 13:04:48 INFO - "basedir": "/builds/slave/test", 13:04:48 INFO - "buildnumber": 54, 13:04:48 INFO - "slavename": "t-yosemite-r7-0227", 13:04:48 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:04:48 INFO - "platform": "yosemite_r7", 13:04:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:04:48 INFO - "branch": "mozilla-central", 13:04:48 INFO - "repo_path": "mozilla-central", 13:04:48 INFO - "revision": "52b69565a24db74c0184e3a5039e32cf6de3f39e", 13:04:48 INFO - "stage_platform": "macosx64", 13:04:48 INFO - "builduid": "da8149bd852a47b8a01242dd8adbeabb", 13:04:48 INFO - "slavebuilddir": "test" 13:04:48 INFO - } 13:04:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 13:04:48 INFO - Running post-action listener: _resource_record_post_action 13:04:48 INFO - [mozharness: 2017-04-29 20:04:48.130894Z] Finished read-buildbot-config step (success) 13:04:48 INFO - [mozharness: 2017-04-29 20:04:48.131090Z] Running download-and-extract step. 13:04:48 INFO - Running pre-action listener: _resource_record_pre_action 13:04:48 INFO - Running main action method: download_and_extract 13:04:48 INFO - mkdir: /builds/slave/test/build/tests 13:04:48 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')]} 13:04:48 INFO - trying https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 13:04:48 INFO - Downloading https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/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 13:04:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/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 13:04:49 INFO - Downloaded 1325 bytes. 13:04:49 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:04:49 INFO - Using the following test package requirements: 13:04:49 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 13:04:49 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:04:49 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 13:04:49 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 13:04:49 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'jsshell-mac.zip'], 13:04:49 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 13:04:49 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:04:49 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 13:04:49 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 13:04:49 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 13:04:49 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:04:49 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 13:04:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:04:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:04:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:04:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:04:51 INFO - Content-Length response header: 52698544 13:04:51 INFO - Bytes received: 52698544 13:05:07 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 13:05:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:05:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:05:07 INFO - Fetch https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:05:08 INFO - Content-Length response header: 52698544 13:05:08 INFO - Bytes received: 52698544 13:05:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 13:05:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:05:23 INFO - Fetch https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 13:05:25 INFO - Content-Length response header: 14408811 13:05:25 INFO - Bytes received: 14408811 13:05:25 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')]} 13:05:25 INFO - trying https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:05:25 INFO - Downloading https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 13:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/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 13:05:27 INFO - Downloaded 71193181 bytes. 13:05:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:05:27 INFO - mkdir: /builds/slave/test/properties 13:05:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:05:27 INFO - Writing to file /builds/slave/test/properties/build_url 13:05:27 INFO - Contents: 13:05:27 INFO - build_url:https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:05:28 INFO - Running post-action listener: _resource_record_post_action 13:05:28 INFO - Running post-action listener: set_extra_try_arguments 13:05:28 INFO - [mozharness: 2017-04-29 20:05:28.340722Z] Finished download-and-extract step (success) 13:05:28 INFO - [mozharness: 2017-04-29 20:05:28.340845Z] Running populate-webroot step. 13:05:28 INFO - Running pre-action listener: _resource_record_pre_action 13:05:28 INFO - Running main action method: populate_webroot 13:05:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:05:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:05:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:05:28 INFO - '--tppagecycles', 13:05:28 INFO - '7'], 13:05:28 INFO - 'tests': ['tsvgm']}}, 13:05:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:05:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:05:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:05:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:05:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:05:28 INFO - 'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:05:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:05:28 INFO - 'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['damp', 'tps']}, 13:05:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:05:28 INFO - 'tests': ['damp', 'tps']}, 13:05:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['dromaeo_dom']}, 13:05:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:05:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:05:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:05:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['a11yr', 13:05:28 INFO - 'ts_paint', 13:05:28 INFO - 'tpaint', 13:05:28 INFO - 'sessionrestore', 13:05:28 INFO - 'sessionrestore_no_auto_restore', 13:05:28 INFO - 'tabpaint']}, 13:05:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:05:28 INFO - 'ts_paint', 13:05:28 INFO - 'tpaint', 13:05:28 INFO - 'sessionrestore', 13:05:28 INFO - 'sessionrestore_no_auto_restore', 13:05:28 INFO - 'tabpaint']}, 13:05:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:05:28 INFO - 'ts_paint', 13:05:28 INFO - 'tpaint', 13:05:28 INFO - 'sessionrestore', 13:05:28 INFO - 'sessionrestore_no_auto_restore', 13:05:28 INFO - 'tabpaint']}, 13:05:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:05:28 INFO - 'ts_paint', 13:05:28 INFO - 'tpaint', 13:05:28 INFO - 'sessionrestore', 13:05:28 INFO - 'sessionrestore_no_auto_restore', 13:05:28 INFO - 'tabpaint']}, 13:05:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['a11yr', 13:05:28 INFO - 'ts_paint', 13:05:28 INFO - 'tpaint', 13:05:28 INFO - 'sessionrestore', 13:05:28 INFO - 'sessionrestore_no_auto_restore', 13:05:28 INFO - 'tabpaint']}, 13:05:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['a11yr', 13:05:28 INFO - 'ts_paint', 13:05:28 INFO - 'tpaint', 13:05:28 INFO - 'sessionrestore', 13:05:28 INFO - 'sessionrestore_no_auto_restore', 13:05:28 INFO - 'tabpaint']}, 13:05:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:05:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:05:28 INFO - 'bloom_basic_ref']}, 13:05:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['tsvgx', 13:05:28 INFO - 'tsvgr_opacity', 13:05:28 INFO - 'tart', 13:05:28 INFO - 'tscrollx', 13:05:28 INFO - 'cart', 13:05:28 INFO - 'tsvg_static']}, 13:05:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:05:28 INFO - 'tsvgr_opacity', 13:05:28 INFO - 'tart', 13:05:28 INFO - 'tscrollx', 13:05:28 INFO - 'cart', 13:05:28 INFO - 'tsvg_static']}, 13:05:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:05:28 INFO - 'talos_options': ['--disable-e10s'], 13:05:28 INFO - 'tests': ['tp5o']}, 13:05:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:05:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:05:28 INFO - 'talos_options': ['--disable-e10s', 13:05:28 INFO - '--xperf_path', 13:05:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:28 INFO - 'tests': ['tp5n']}, 13:05:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:05:28 INFO - 'talos_options': ['--xperf_path', 13:05:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:28 INFO - 'tests': ['tp5n']}}, 13:05:28 INFO - 'talos.zip': {'path': '', 13:05:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:05:28 INFO - Running post-action listener: _resource_record_post_action 13:05:28 INFO - [mozharness: 2017-04-29 20:05:28.359848Z] Finished populate-webroot step (success) 13:05:28 INFO - [mozharness: 2017-04-29 20:05:28.359983Z] Running create-virtualenv step. 13:05:28 INFO - Running pre-action listener: _resource_record_pre_action 13:05:28 INFO - Running main action method: create_virtualenv 13:05:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:05:28 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 13:05:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:05:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:05:28 INFO - Using real prefix '/tools/python27' 13:05:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:05:29 INFO - Installing distribute.............................................................................................................................................................................................done. 13:05:32 INFO - Installing pip.................done. 13:05:32 INFO - Return code: 0 13:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:05:32 INFO - Reading from file tmpfile_stdout 13:05:32 INFO - Output received: 13:05:32 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) 13:05:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:32 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:32 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 13:05:32 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 13:05:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:32 INFO - 'HOME': '/Users/cltbld', 13:05:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:32 INFO - 'LOGNAME': 'cltbld', 13:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:32 INFO - 'MOZ_NO_REMOTE': '1', 13:05:32 INFO - 'NO_EM_RESTART': '1', 13:05:32 INFO - 'PAGER': '/bin/cat', 13:05:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:32 INFO - 'PWD': '/builds/slave/test', 13:05:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:32 INFO - 'SHELL': '/bin/bash', 13:05:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:32 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:32 INFO - 'USER': 'cltbld', 13:05:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:32 INFO - 'XPC_FLAGS': '0x0', 13:05:32 INFO - 'XPC_SERVICE_NAME': '0', 13:05:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:32 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 13:05:32 INFO - Cleaning up... 13:05:32 INFO - Return code: 0 13:05:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:32 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:32 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 13:05:32 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 13:05:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:32 INFO - 'HOME': '/Users/cltbld', 13:05:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:32 INFO - 'LOGNAME': 'cltbld', 13:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:32 INFO - 'MOZ_NO_REMOTE': '1', 13:05:32 INFO - 'NO_EM_RESTART': '1', 13:05:32 INFO - 'PAGER': '/bin/cat', 13:05:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:32 INFO - 'PWD': '/builds/slave/test', 13:05:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:32 INFO - 'SHELL': '/bin/bash', 13:05:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:32 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:32 INFO - 'USER': 'cltbld', 13:05:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:32 INFO - 'XPC_FLAGS': '0x0', 13:05:32 INFO - 'XPC_SERVICE_NAME': '0', 13:05:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:32 INFO - Downloading/unpacking psutil>=3.1.1 13:05:32 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 13:05:32 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 13:05:32 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 13:05:32 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 13:05:32 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 13:05:32 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 13:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:36 INFO - Installing collected packages: psutil 13:05:36 INFO - Running setup.py install for psutil 13:05:36 INFO - building 'psutil._psutil_osx' extension 13:05:36 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 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 INFO - building 'psutil._psutil_posix' extension 13:05:37 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 13:05:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:05:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:05:37 INFO - ^ 13:05:37 INFO - 1 warning generated. 13:05:37 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 13:05:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:38 INFO - Successfully installed psutil 13:05:38 INFO - Cleaning up... 13:05:38 INFO - Return code: 0 13:05:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:38 INFO - 'HOME': '/Users/cltbld', 13:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:38 INFO - 'LOGNAME': 'cltbld', 13:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:38 INFO - 'MOZ_NO_REMOTE': '1', 13:05:38 INFO - 'NO_EM_RESTART': '1', 13:05:38 INFO - 'PAGER': '/bin/cat', 13:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:38 INFO - 'PWD': '/builds/slave/test', 13:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:38 INFO - 'SHELL': '/bin/bash', 13:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:38 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:38 INFO - 'USER': 'cltbld', 13:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:38 INFO - 'XPC_FLAGS': '0x0', 13:05:38 INFO - 'XPC_SERVICE_NAME': '0', 13:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:05:41 INFO - Installing collected packages: mozsystemmonitor 13:05:41 INFO - Running setup.py install for mozsystemmonitor 13:05:41 INFO - Successfully installed mozsystemmonitor 13:05:41 INFO - Cleaning up... 13:05:41 INFO - Return code: 0 13:05:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:41 INFO - 'HOME': '/Users/cltbld', 13:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:41 INFO - 'LOGNAME': 'cltbld', 13:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:41 INFO - 'MOZ_NO_REMOTE': '1', 13:05:41 INFO - 'NO_EM_RESTART': '1', 13:05:41 INFO - 'PAGER': '/bin/cat', 13:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:41 INFO - 'PWD': '/builds/slave/test', 13:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:41 INFO - 'SHELL': '/bin/bash', 13:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:41 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:41 INFO - 'USER': 'cltbld', 13:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:41 INFO - 'XPC_FLAGS': '0x0', 13:05:41 INFO - 'XPC_SERVICE_NAME': '0', 13:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:41 INFO - Downloading/unpacking jsonschema==2.5.1 13:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:05:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:05:44 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 13:05:44 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 13:05:44 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 13:05:44 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 13:05:44 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 13:05:44 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 13:05:44 INFO - Downloading functools32-3.2.3-2.tar.gz 13:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:05:44 INFO - warning: no files found matching '*.txt' 13:05:44 INFO - no previously-included directories found matching 'build' 13:05:44 INFO - no previously-included directories found matching 'dist' 13:05:44 INFO - no previously-included directories found matching '.git*' 13:05:44 INFO - Installing collected packages: jsonschema, functools32 13:05:44 INFO - Running setup.py install for functools32 13:05:44 INFO - warning: no files found matching '*.txt' 13:05:44 INFO - no previously-included directories found matching 'build' 13:05:44 INFO - no previously-included directories found matching 'dist' 13:05:44 INFO - no previously-included directories found matching '.git*' 13:05:44 INFO - Successfully installed jsonschema functools32 13:05:44 INFO - Cleaning up... 13:05:45 INFO - Return code: 0 13:05:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:05:45 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')]} 13:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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')]} 13:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:45 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 13:05:45 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 13:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:45 INFO - 'HOME': '/Users/cltbld', 13:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:45 INFO - 'LOGNAME': 'cltbld', 13:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:45 INFO - 'MOZ_NO_REMOTE': '1', 13:05:45 INFO - 'NO_EM_RESTART': '1', 13:05:45 INFO - 'PAGER': '/bin/cat', 13:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:45 INFO - 'PWD': '/builds/slave/test', 13:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:45 INFO - 'SHELL': '/bin/bash', 13:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:45 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:45 INFO - 'USER': 'cltbld', 13:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:45 INFO - 'XPC_FLAGS': '0x0', 13:05:45 INFO - 'XPC_SERVICE_NAME': '0', 13:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:05:45 INFO - Cleaning up... 13:05:45 INFO - Return code: 0 13:05:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:05:45 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')]} 13:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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')]} 13:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:45 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 13:05:45 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 13:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:45 INFO - 'HOME': '/Users/cltbld', 13:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:45 INFO - 'LOGNAME': 'cltbld', 13:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:45 INFO - 'MOZ_NO_REMOTE': '1', 13:05:45 INFO - 'NO_EM_RESTART': '1', 13:05:45 INFO - 'PAGER': '/bin/cat', 13:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:45 INFO - 'PWD': '/builds/slave/test', 13:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:45 INFO - 'SHELL': '/bin/bash', 13:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:45 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:45 INFO - 'USER': 'cltbld', 13:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:45 INFO - 'XPC_FLAGS': '0x0', 13:05:45 INFO - 'XPC_SERVICE_NAME': '0', 13:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:05:45 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 13:05:45 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 13:05:45 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 13:05:45 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 13:05:45 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 13:05:45 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 13:05:48 INFO - Downloading blobuploader-1.2.4.tar.gz 13:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:05:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:05:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:49 INFO - Downloading docopt-0.6.1.tar.gz 13:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:05:49 INFO - Installing collected packages: blobuploader, requests, docopt 13:05:49 INFO - Running setup.py install for blobuploader 13:05:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:05:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:05:49 INFO - Running setup.py install for requests 13:05:50 INFO - Running setup.py install for docopt 13:05:50 INFO - Successfully installed blobuploader requests docopt 13:05:50 INFO - Cleaning up... 13:05:50 INFO - Return code: 0 13:05:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:50 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:50 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 13:05:50 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 13:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:50 INFO - 'HOME': '/Users/cltbld', 13:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:50 INFO - 'LOGNAME': 'cltbld', 13:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:50 INFO - 'MOZ_NO_REMOTE': '1', 13:05:50 INFO - 'NO_EM_RESTART': '1', 13:05:50 INFO - 'PAGER': '/bin/cat', 13:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:50 INFO - 'PWD': '/builds/slave/test', 13:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:50 INFO - 'SHELL': '/bin/bash', 13:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:50 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:50 INFO - 'USER': 'cltbld', 13:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:50 INFO - 'XPC_FLAGS': '0x0', 13:05:50 INFO - 'XPC_SERVICE_NAME': '0', 13:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:05:50 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-g9Zw3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:05:50 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-i0YhHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:05:50 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Vjgh2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-WQVYMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-H2bQNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-kIgPan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-2FnYUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-IFzBi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-05E_jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Mkz15h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-lblDdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:51 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-S1Gdw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:52 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-0sGgTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:52 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-uoCZjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:52 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-MSyUFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:52 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-wGTIrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:52 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-cJsJH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:05:52 INFO - Running setup.py install for manifestparser 13:05:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:05:52 INFO - Running setup.py install for mozcrash 13:05:52 INFO - Running setup.py install for mozdebug 13:05:52 INFO - Running setup.py install for mozdevice 13:05:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Running setup.py install for mozfile 13:05:53 INFO - Running setup.py install for mozhttpd 13:05:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Running setup.py install for mozinfo 13:05:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Running setup.py install for mozInstall 13:05:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Running setup.py install for mozleak 13:05:53 INFO - Running setup.py install for mozlog 13:05:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:05:53 INFO - Running setup.py install for moznetwork 13:05:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:05:54 INFO - Running setup.py install for mozprocess 13:05:54 INFO - Running setup.py install for mozprofile 13:05:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:05:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:05:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:05:54 INFO - Running setup.py install for mozrunner 13:05:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:05:54 INFO - Running setup.py install for mozscreenshot 13:05:54 INFO - Running setup.py install for moztest 13:05:54 INFO - Running setup.py install for mozversion 13:05:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:05:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:05:55 INFO - Cleaning up... 13:05:55 INFO - Return code: 0 13:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05: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')]} 13:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05: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')]} 13:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:55 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:05:55 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 13:05:55 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 13:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:55 INFO - 'HOME': '/Users/cltbld', 13:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:55 INFO - 'LOGNAME': 'cltbld', 13:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:55 INFO - 'MOZ_NO_REMOTE': '1', 13:05:55 INFO - 'NO_EM_RESTART': '1', 13:05:55 INFO - 'PAGER': '/bin/cat', 13:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:55 INFO - 'PWD': '/builds/slave/test', 13:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:55 INFO - 'SHELL': '/bin/bash', 13:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:05:55 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:55 INFO - 'USER': 'cltbld', 13:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:55 INFO - 'XPC_FLAGS': '0x0', 13:05:55 INFO - 'XPC_SERVICE_NAME': '0', 13:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:05:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-PQzDKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:05:55 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)) 13:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:05:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Yg9BG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:05:55 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)) 13:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:05:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-npX6wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:05:55 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)) 13:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:05:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-VOVtHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:05:55 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)) 13:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:05:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-dKrD2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:55 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)) 13:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-b3kvgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:55 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)) 13:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-ZU16ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-2sNlu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-7x4Lgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Lh9oUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-1KXicJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-mRp8qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-fAduoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-EOJmWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-XhvDoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:56 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)) 13:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-ATfWNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:57 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)) 13:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:57 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-YItQD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:57 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)) 13:05:57 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)) 13:05:57 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)) 13:05:57 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)) 13:05:57 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)) 13:05:57 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)) 13:05:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:05:57 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 13:05:57 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 13:05:57 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 13:05:57 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 13:05:57 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 13:05:57 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 13:05:59 INFO - Downloading blessings-1.6.tar.gz 13:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:05:59 INFO - Installing collected packages: blessings 13:05:59 INFO - Running setup.py install for blessings 13:06:00 INFO - Successfully installed blessings 13:06:00 INFO - Cleaning up... 13:06:00 INFO - Return code: 0 13:06:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:00 INFO - Reading from file tmpfile_stdout 13:06:00 INFO - Current package versions: 13:06:00 INFO - blessings == 1.6 13:06:00 INFO - blobuploader == 1.2.4 13:06:00 INFO - docopt == 0.6.1 13:06:00 INFO - functools32 == 3.2.3-2 13:06:00 INFO - jsonschema == 2.5.1 13:06:00 INFO - manifestparser == 1.1 13:06:00 INFO - mozInstall == 1.12 13:06:00 INFO - mozcrash == 1.0 13:06:00 INFO - mozdebug == 0.1 13:06:00 INFO - mozdevice == 0.50 13:06:00 INFO - mozfile == 1.2 13:06:00 INFO - mozhttpd == 0.7 13:06:00 INFO - mozinfo == 0.9 13:06:00 INFO - mozleak == 0.1 13:06:00 INFO - mozlog == 3.4 13:06:00 INFO - moznetwork == 0.27 13:06:00 INFO - mozprocess == 0.25 13:06:00 INFO - mozprofile == 0.28 13:06:00 INFO - mozrunner == 6.13 13:06:00 INFO - mozscreenshot == 0.1 13:06:00 INFO - mozsystemmonitor == 0.3 13:06:00 INFO - moztest == 0.8 13:06:00 INFO - mozversion == 1.4 13:06:00 INFO - psutil == 3.1.1 13:06:00 INFO - requests == 1.2.3 13:06:00 INFO - wsgiref == 0.1.2 13:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:00 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')]} 13:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:00 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')]} 13:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:00 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:06:00 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 13:06:00 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 13:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:00 INFO - 'HOME': '/Users/cltbld', 13:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:00 INFO - 'LOGNAME': 'cltbld', 13:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:00 INFO - 'MOZ_NO_REMOTE': '1', 13:06:00 INFO - 'NO_EM_RESTART': '1', 13:06:00 INFO - 'PAGER': '/bin/cat', 13:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:00 INFO - 'PWD': '/builds/slave/test', 13:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:00 INFO - 'SHELL': '/bin/bash', 13:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:06:00 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:00 INFO - 'USER': 'cltbld', 13:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:00 INFO - 'XPC_FLAGS': '0x0', 13:06:00 INFO - 'XPC_SERVICE_NAME': '0', 13:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 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)) 13:06:00 INFO - Cleaning up... 13:06:00 INFO - Return code: 0 13:06:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:06:00 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')]} 13:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:00 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')]} 13:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:00 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 0x101653b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101656768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed8d5f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, '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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 13:06:00 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 13:06:00 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 13:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:00 INFO - 'HOME': '/Users/cltbld', 13:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:00 INFO - 'LOGNAME': 'cltbld', 13:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:00 INFO - 'MOZ_NO_REMOTE': '1', 13:06:00 INFO - 'NO_EM_RESTART': '1', 13:06:00 INFO - 'PAGER': '/bin/cat', 13:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:00 INFO - 'PWD': '/builds/slave/test', 13:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:00 INFO - 'SHELL': '/bin/bash', 13:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:06:00 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:00 INFO - 'USER': 'cltbld', 13:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:00 INFO - 'XPC_FLAGS': '0x0', 13:06:00 INFO - 'XPC_SERVICE_NAME': '0', 13:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:06:00 INFO - Cleaning up... 13:06:00 INFO - Return code: 0 13:06:00 INFO - Running post-action listener: _resource_record_post_action 13:06:00 INFO - Running post-action listener: _start_resource_monitoring 13:06:01 INFO - Starting resource monitoring. 13:06:01 INFO - [mozharness: 2017-04-29 20:06:01.007330Z] Finished create-virtualenv step (success) 13:06:01 INFO - [mozharness: 2017-04-29 20:06:01.008306Z] Running install step. 13:06:01 INFO - Running pre-action listener: _resource_record_pre_action 13:06:01 INFO - Running main action method: install 13:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:01 INFO - Reading from file tmpfile_stdout 13:06:01 INFO - Detecting whether we're running mozinstall >=1.0... 13:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:06:01 INFO - Reading from file tmpfile_stdout 13:06:01 INFO - Output received: 13:06:01 INFO - Usage: mozinstall [options] installer 13:06:01 INFO - Options: 13:06:01 INFO - -h, --help show this help message and exit 13:06:01 INFO - -d DEST, --destination=DEST 13:06:01 INFO - Directory to install application into. [default: 13:06:01 INFO - "/builds/slave/test"] 13:06:01 INFO - --app=APP Application being installed. [default: firefox] 13:06:01 INFO - mkdir: /builds/slave/test/build/application 13:06:01 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'] 13:06:01 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 13:06:21 INFO - Reading from file tmpfile_stdout 13:06:21 INFO - Output received: 13:06:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:06:21 INFO - Running post-action listener: _resource_record_post_action 13:06:21 INFO - [mozharness: 2017-04-29 20:06:21.278143Z] Finished install step (success) 13:06:21 INFO - [mozharness: 2017-04-29 20:06:21.278279Z] Running run-tests step. 13:06:21 INFO - Running pre-action listener: _resource_record_pre_action 13:06:21 INFO - Running main action method: run_tests 13:06:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:06:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:06:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:06:21 INFO - 2017-04-29 13:06:21.292 screenresolution[1630:8820] starting screenresolution argv=screenresolution get 13:06:21 INFO - 2017-04-29 13:06:21.295 screenresolution[1630:8820] Display 0: 1600x1200x32@60 13:06:21 INFO - 2017-04-29 13:06:21.301 screenresolution[1631:8825] starting screenresolution argv=screenresolution list 13:06:21 INFO - Available Modes on Display 0 13:06:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:06:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:06:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:06:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:06:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:06:21 INFO - Intel Iris: 13:06:21 INFO - Chipset Model: Intel Iris 13:06:21 INFO - Type: GPU 13:06:21 INFO - Bus: Built-In 13:06:21 INFO - VRAM (Dynamic, Max): 1536 MB 13:06:21 INFO - Vendor: Intel (0x8086) 13:06:21 INFO - Device ID: 0x0a2e 13:06:21 INFO - Revision ID: 0x0009 13:06:21 INFO - Displays: 13:06:21 INFO - Display: 13:06:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:06:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:06:21 INFO - Display Serial Number: 1600x1200 60 13:06:21 INFO - Main Display: Yes 13:06:21 INFO - Mirror: Off 13:06:21 INFO - Online: Yes 13:06:21 INFO - Rotation: Supported 13:06:21 INFO - Return code: 0 13:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:06:21 INFO - Python 2.7.3 13:06:21 INFO - Return code: 0 13:06:21 INFO - grabbing minidump binary from tooltool 13:06: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')]} 13:06:21 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 0x101431d30>, '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 0x101357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101426be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:06:21 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 13:06:21 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 13:06:21 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 13:06:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:06:21 INFO - Return code: 0 13:06:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:06:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:06:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:06:21 INFO - ENV: RUST_BACKTRACE is now 1 13:06:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:06:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0227', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0227 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EPyc60UHgW/Render', 13:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:06:21 INFO - 'HOME': '/Users/cltbld', 13:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:06:21 INFO - 'LOGNAME': 'cltbld', 13:06:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:06:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:21 INFO - 'MOZ_NO_REMOTE': '1', 13:06:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:06:21 INFO - 'NO_EM_RESTART': '1', 13:06:21 INFO - 'PAGER': '/bin/cat', 13:06:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:21 INFO - 'PWD': '/builds/slave/test', 13:06:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:06:21 INFO - 'RUST_BACKTRACE': '1', 13:06:21 INFO - 'SHELL': '/bin/bash', 13:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wx7yZ7fp6O/Listeners', 13:06:21 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 13:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:06:21 INFO - 'USER': 'cltbld', 13:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:21 INFO - 'XPC_FLAGS': '0x0', 13:06:21 INFO - 'XPC_SERVICE_NAME': '0', 13:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:06:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0227', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:06:21 INFO - mozversion application_buildid: 20170429122646 13:06:21 INFO - mozversion application_changeset: 52b69565a24db74c0184e3a5039e32cf6de3f39e 13:06:21 INFO - mozversion application_display_name: Nightly 13:06:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:06:21 INFO - mozversion application_name: Firefox 13:06:21 INFO - mozversion application_remotingname: firefox 13:06:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:06:21 INFO - mozversion application_vendor: Mozilla 13:06:21 INFO - mozversion application_version: 55.0a1 13:06:21 INFO - mozversion platform_buildid: 20170429122646 13:06:21 INFO - mozversion platform_changeset: 52b69565a24db74c0184e3a5039e32cf6de3f39e 13:06:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:06:21 INFO - mozversion platform_version: 55.0a1 13:06:21 INFO - using testdate: 1493496381 13:06:21 INFO - actual date: 1493496381 13:06:21 INFO - starting webserver on 'localhost:49235' 13:06:21 INFO - SUITE-START | Running 2 tests 13:06:21 INFO - TEST-START | dromaeo_css 13:06:21 INFO - operating with platform_type : mac_ 13:06:21 INFO - Initialising browser for dromaeo_css test... 13:06:21 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpHWL_BB/profile http://localhost:49235/getInfo.html) 13:06:24 INFO - PID 1641 | 2017-04-29 13:06:24.692 plugin-container[1643:9005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983b, name = 'com.apple.tsm.portname' 13:06:24 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:06:24 INFO - PID 1641 | 2017-04-29 13:06:24.695 plugin-container[1643:9005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0f, name = 'com.apple.CFPasteboardClient' 13:06:24 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:06:24 INFO - PID 1641 | 2017-04-29 13:06:24.695 plugin-container[1643:9005] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:06:24 INFO - PID 1641 | __metrics Screen width/height:1600/1200 13:06:24 INFO - PID 1641 | colorDepth:24 13:06:24 INFO - PID 1641 | Browser inner width/height: 1024/689 13:06:24 INFO - PID 1641 | __metrics 13:06:25 INFO - TEST-INFO | 1641: exit 0 13:06:25 INFO - Browser initialized. 13:06:25 INFO - Running cycle 1/1 for dromaeo_css test... 13:06:25 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpHWL_BB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:06:28 INFO - PID 1645 | 2017-04-29 13:06:28.186 plugin-container[1646:9145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 13:06:28 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:06:28 INFO - PID 1645 | 2017-04-29 13:06:28.186 plugin-container[1646:9145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 13:06:28 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:06:28 INFO - PID 1645 | 2017-04-29 13:06:28.186 plugin-container[1646:9145] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:06:38 INFO - PID 1645 | RSS: Main: 234856448 13:06:38 INFO - PID 1645 | 13:09:42 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 13:09:43 INFO - PID 1645 | RSS: Main: 257064960 13:09:43 INFO - PID 1645 | 13:11:26 INFO - PID 1645 | ************************* 13:11:26 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 13:11:26 INFO - PID 1645 | 13:11:26 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:11:26 INFO - PID 1645 | Full stack: 13:11:26 INFO - PID 1645 | ************************* 13:11:26 INFO - PID 1645 | ************************* 13:11:26 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 13:11:26 INFO - PID 1645 | 13:11:26 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:11:26 INFO - PID 1645 | Full stack: 13:11:26 INFO - PID 1645 | ************************* 13:11:26 INFO - PID 1645 | ************************* 13:11:26 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 13:11:26 INFO - PID 1645 | 13:11:26 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:11:26 INFO - PID 1645 | Full stack: 13:11:26 INFO - PID 1645 | ************************* 13:11:26 INFO - PID 1645 | ************************* 13:11:26 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 13:11:26 INFO - PID 1645 | 13:11:26 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:11:26 INFO - PID 1645 | Full stack: 13:11:26 INFO - PID 1645 | ************************* 13:12:45 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 13:12:46 INFO - PID 1645 | RSS: Main: 259317760 13:12:46 INFO - PID 1645 | 13:15:47 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 13:15:48 INFO - PID 1645 | RSS: Main: 268189696 13:15:48 INFO - PID 1645 | 13:18:50 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 13:18:51 INFO - PID 1645 | RSS: Main: 261079040 13:18:51 INFO - PID 1645 | 13:21:53 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 13:21:54 INFO - PID 1645 | RSS: Main: 273358848 13:21:54 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 13:24:56 INFO - PID 1645 | RSS: Main: 267964416 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | __start_tp_report 13:24:56 INFO - PID 1645 | _x_x_mozilla_page_load 13:24:56 INFO - PID 1645 | _x_x_mozilla_page_load_details 13:24:56 INFO - PID 1645 | |i|pagename|runs| 13:24:56 INFO - PID 1645 | |0;dojo.html;2870.282429392652;3577.624349443307;3599.748017638763;3623.4745961835533;3645.5625324961;4462.9776851115785;5556.638818476797;6038.66787326698;6177.84555386115;6177.980633195523;5910.67491287979;6099.672983688887;6150.784722534701;6193.938060619393;6250.968745156268;5163.1480805667015;5286.603504737141;5359.38367087786;5363.919541206876;5441.646292990943;5394.757235924373;5444.700541470217;5474.534664553517;5494.752736126864;5494.917576236359;5393.703346315951;5397.298351214317;5424.783008679648;5444.5916556258435;5475.945240547623;5381.811636592701;5398.811041613525;5399.730013499309;5420.728963551846;5450.645708028966;5324.440933701983;5387.326584176978;5391.838244852661;5397.433269506724;5411.512963833235;5826.912596311059;6117.388261173847;6125.479643195305;6131.049687298476;6169.105479705418;6600.570962887397;6621.437177839889;6634.834129146761;6640.501962352843;6643.601383916932;6703.363180497845;6706.966465167643;6725.562838415487;6727;6735.494837887178;6104.3590423005835;6195.4424101831055;6273;6281.937180628227;6294.087357333161;5717;6759.966200169066;6802.183737951378;6859.039734437183;6866.759663411756;6281.654509001957;6341.143945567382;6411.070394792729;6483.740650374027;6508.707108180143;6611.272759996396;6710.0941372915;6710.396064354231;6712.2616512184595;6713.395794378529;6353.428191462791;6448.645324507197;6588.571742836701;6602.471802255808;6629.071929929813;6535.771248006297;6584.967075164594;6611.272759996396;6613.60318380889;6661.700223489955;5281.234221037928;5289.18017707256;5289.338832645919;5296;5328.200769884548;4622.029373831533;4717.150912835723;4727.2436410174205;4745.477997420281;4772.5943294819635;5054.69671819692;6087.147799308101;6198.938010619926;6324.209473815773;6352.968235158794;6667.199936007613;6699.129113215251;6713.731450741916;6718.7312507499155;6721.529492935545;6235.844103897439;6266.655333956676;6300.558960872695;6315.589486683442;6319.462845658079;5702.0591602385975;5771.451712087345;5775.27809023872;5777.248957635565;5781.913271300934;6716.261211266855;6750.5274630775375;6796.35434633709;6899.827504312432;6917.9308206917285;6689.933100668931;6728.529002969745;6740.12378390806;6751.898721519279;6789.932100679128;6901.689423976033;6903.299181040366;6934.549254298455;6970.268121847133;6975.232724400414;6355.046742988588;6428.164338635947;6518.902216466662;6555.311692272243;6593.538452308292;5173.430922598586;6466.935330646634;6704.497162712913;6711.765088221889;6725.697343619451;6252.718627661857;6417.26201486835;6505.837354066186;6508.60948343101;6516.087747715229;6426.614403135827;6460.935390646034;6479.352064793483;6487.578307410192;6509.804705858832;6187.783427580193;6241.344658810759;6264.968675156595;6301.590396624205;6322.178116844781;6462.3537646235;6518.771842985473;6536.248331441945;6553.770618028346;6567.211934567882;6340.49276057905;6348.5238607105575;6356.555041147075;6367.649779262185;6402.263739669811 13:24:56 INFO - PID 1645 | |1;ext.html;775.1086250811567;1209.3106929050434;1222.0345926717896;1242.9937850310748;1288.6842723532736;36576;37638;37690.62309376912;37797;37805;37510.8124459378;37860.43209351862;37882.863514094555;37905;37990;7783.766487005399;7952.045754509467;8340.83318333633;8489.957550212272;8491.575421228914;8446.57767111645;8519.829603407929;8540.871886921701;8545.700900468484;8554.18735220153;8521.488710677348;8537.57312134394;8574.485530868136;8586.184312490303;8591.742247732578;8510;8550.572471376407;8552.52961087143;8553.40126191167;8558.058613552505;8457.788555286166;8507.02169250538;8517.53153576553;8525.658973641046;8548;28110.718892811015;37277.627223727686;37327.4400883987;37565;37684.81157594222;3543.7519373643854;3581.8925432237074;3585.1216451969435;3595.6404359564094;3597.94603080954;30792.538111928337;30829.691703082906;30875;30879.228019299473;31014.069577912698;3136.52952057191;3144.591203143577;3164.8892288769784;3167.4773662345683;3185.9203519911957;240286;248086;285241.1475885235;292097.99999999785;292698;39222.80388598096;39775.60224397719;48424.273635895486;48937;49250.75374623104;50462.98148074036;51099.74450127726;51134.48865511372;51321.486785132416;51409;11869.347185904859;14189.645258868612;14288.142711437347;14313.212773297568;14319.35562899672;11400.201985861077;11427.542898284142;11443.885561144281;11453.713657158638;11573.421328933688;13583.981201409933;13616.65958351049;13683.931580342234;13713.725725485634;13782.93108534471;5337.546308563816;5768.1636162757;6008.3144557019095;6027.78902738402;6032.095185722089;908.0420156734708;946.2619157057507;1001.7796084861319;1060.7825395793843;1090.7654854206385;22069;24474.877625611756;24506.142285019938;24513.754862451147;24529.87735061349;1133.6032388663903;1136.170595465315;1166.5742004168587;1176.517627772609;1181;12046.932738373825;12468.753124687459;12488.375581220902;12503.249805011728;12590.874091259153;319208;321431;321674.0911840723;321748;322219;42525.57474425216;55246;55693.443065569634;55876.44123558794;56113.87772244532;1509.2830905319886;1559.22818204987;1567.2477210938584;1574.6063484128968;1581.5571639940836;24189.395265118514;24208.75791242065;24229.909654065257;24255.393615159763;24334.63498047566;39070.4139437903;39105.41341879817;39364;39378.40932385959;39389.212215756095;285089;285382;285554;285826;286102;34713.65286347104;35026.64973350234;35415.64584354227;35418.46872296866;35556.28887422186;35335.82332088323;44345.55654443414;44475;46088.46938367417;46128.76935615435;30364.392712145192;30889.69110308958;31323.843380783863;31407.37185256328;31603.525947111273;30809.537856932613;30871.84564077165;31399;31490.842545787124;31782;36166.914992550264;37681.43477847889;37793.433098504094;37831.62168378281;37876.81061594674;30050.34723090251;31071.75712971456;31164.220894477818;31498.527522087647;32203.677963220067;19545.902270488557;19824.207031719146;21413;24333;24537.631935520625 13:24:56 INFO - PID 1645 | |2;jquery.html;442.6768459024914;445.9732416055037;450.3290097754346;464.67008424018945;469.34057649003165;16658.667786509883;19227.519312017208;21716.457088572795;21859.781402185974;21864.672029919526;21763.6735448968;22407.99164037618;23077.192298269565;23105.30684079476;23559.646605300935;5960.165576819249;6082.330943596201;6155.692215389235;6174.629522228658;6183.350748171422;5755.136729490568;5999.070144127645;6059;6066.150738896536;6083.665398403108;5934.287885453751;5947.791827286046;5993.490553302974;5995.310539287994;6024.246969128859;5840.883182336351;5989.221401217814;6018.097285407181;6052.273727152726;6068.575199736042;5271.28837606922;5360.59795515334;5362.034833729927;5417.945820541783;5487.75305111271;27292.181234562995;27435.31411714723;27469;27631;27933.441331173464;2066.380085974202;2274.8521346112448;2336.0538981712434;2339.251439539348;2342.1334106380577;17733.556661083447;17940.820591794178;18024.90987545067;18315.816841831544;18443.907780461013;2180.6401943679275;2182.886727768833;2222.4554984028855;2226.877521736304;2230.620794464945;126080;164774.1761291186;165586;166823;168764.15617922076;10896.455177241107;11776.52893884252;12747.745045099045;12752.872471275168;12882.80675789864;16379.262933168036;16555.420560280334;16584.336626535045;16596.751048734277;16620.418285359956;8904.465732056098;9070.909290907006;9132.086791320948;9163.175314221751;9219.723408297761;8670.176333248332;8689.478631282016;8733.170348816979;8817.162369575008;8876.979147398131;7927.167647397056;8045.637946292431;8092;8102.513849169069;8125.9187408126345;2202.8678279303294;2203.0062793172206;2203.0967303405528;2209.414505156135;2389.4504264019374;996.6710985374809;1009.1472705563787;1012.281280290987;1035.440861934562;1042.5777560088177;15539.223038848239;17366.739498907526;18716.625667486573;19582.020898954994;20951.638143520624;805.8549461097059;967.7822489939707;1003.799240151958;1035.4512108582464;1069.4973362519604;9627.422354658604;10612.097971672494;10978.341299522055;11039.779204415867;11102.722431939266;551039;558328;558848.4115158878;571629;572103;122571;126057.36971315085;128516.35741821417;132534;137439;1193.1528614683498;1240.8076748104058;1281.416955285343;1282.26269894809;1283.146707439561;18392.724109138107;19808.504787380432;21890.905454726882;22203.555928881655;22311.665325019814;57547.424525754206;57869;58606.4139358618;58888;58985;78940;79181.8122728171;80777.98055048671;81281.18718812973;81500;8730.083341249077;8854.506106813315;8942;8994.280457563511;9159;11979.460924258256;13886.444542218198;14137.293135342987;14334.211618360672;14483.565493035227;12008.459619316976;12020.939895300467;12100;12191.75616487683;12235.265884046985;11135.276207046516;11411.315321080761;11516.94241528787;11658.300501969909;11740.295582265091;11727.472263748323;11965.641030769091;12293.44679489443;12341;12376.81434778461;8749;8803.64785408602;8930;9087.2730181584;9092.136247056518;11419.60031398897;11975.101867360157;12123.908848203704;12126.27242365461;12167.33079680626 13:24:56 INFO - PID 1645 | |3;mootools.html;1374.257900733604;1462.583163798317;1480.4818313590251;1485.465232516294;1501.519513755598;11058.723531911695;11141.498632561534;11750.647480575586;11770.7645847083;11980.34108124053;10716.517756700947;11644.650660480178;11831.40842957853;11832.940835295833;11874.05007599392;2526.8989240430406;2537.1120107962156;2554.846709197445;2557.4629327841176;2558.219742978391;2485.689288838895;2524.116559204282;2524.9621255681086;2526.5704830178915;2527.8736063196857;2031.959360812783;2497.126005897939;2519.962200566993;2548.2610043087484;2607;2457.1400009996537;2485.403503159247;2506.097804790274;2509.3852006258585;2510.6485092087123;2439.7438268981855;2475.443025319307;2498.475320182764;2502.5370306493173;2529.1148098165677;11706.063514918786;11744.530218791238;11765.294082355085;11798.764024719458;11827.586034488837;6578.473722102221;6830.248672646005;6836.658167091675;6837.726490940357;6842.110525631636;4057.3913912913004;4373.868783936487;4425.225585522553;4440.200763862504;4453.487848897385;1239.8884100430914;1259.502496513881;1308.4439113376777;1312.1339915655717;1316.0590178022665;15904.443344482888;16201;16441.58896027597;16504.33982640693;16761.413350532795;5536.695481748542;5625.156226565966;5661.2923384576925;5764.048931926269;5801.158831969426;11774.88225117755;11828.408579570987;11850.940745296391;11856.22934509254;11863.644090677293;6562.67186640666;6587.143671322698;6597.538172327891;6599.769008084694;6604.867902642017;6056.424639659225;6172.166757487682;6201.96899015502;6260.968695156586;6273.8745225095245;4309.159713855831;4437.467503899553;4440.800163992628;4482.932756008662;4488.304312831517;1063.8138325792954;1098.8626421697288;1310.8754668306497;1314.2574445438297;1315.339515197765;793.7460012795965;818.8321394114192;824.6165533027051;831.9625616847256;852.4203541591653;5127.64106512548;5914.610066634337;6120.540959428061;6361.522885783585;6385.680715964276;551.6842331040498;555.4612026334449;567.4410705455124;612.2622240200548;614.0328981853598;3874.946278472414;3891.124496988155;3944.8422063117728;3955.624215699504;3967.682585393162;14489.855101448851;14916.477923272634;14979.026363286352;14998.02512836684;15004.849951500346;14661.48684796027;14802.703945921021;14868.405263789544;14869;14875.330610122353;8156.877646835303;8301.958490207631;8461.534615596202;8560.357973152039;8567.186117318844;6708.966455167888;6913.2049814272;6971.6165610891885;7041.859162816818;7110.217876033736;13067.869321306665;13155.53955611549;13221.537246196336;13229.933850330686;13353.198808071547;10454.843177352497;13781.242031688353;13913.234772087633;14110.294485275901;14231.146131232159;9172.816543668956;9465.242780577399;9601.37591056579;9636.855447168438;9644.75888102803;10861.40262285582;10873.45632718345;10969.616063438061;10975.560977560808;10980.835287470534;9120.270378369847;9282.582283797381;9287.303452241244;9354.859677104985;9415.105564971316;9039.728808135504;9062.50156241413;9083.318751093562;9113.954430227806;9231.446113233227;8197.877031844408;8309.169083091643;8357.791055223668;8378.874316885129;8380.455270407405;6044.093385992136;6069.9089513656445;6171.352008039271;6196.907046394217;6245.656488893154;6111.327753947151;6233.470155036873;6324.177856878577;6355.586886852339;6383.1382763326355 13:24:56 INFO - PID 1645 | |4;prototype.html;404.6418919256458;408.92248924085027;410.96712263018964;410.98767036988903;420.99579004209966;5024.844285814261;6086.30007549132;6302.716377763;6323.20959880015;6367.777127800522;5520.806771762989;5646.802361917334;6070.119832624267;6152.5693201475915;6168.105624684429;3636.563612366513;3847.942280865789;4698;4713.175194340994;4714.387129673155;4309.870703878889;4464.6874718769695;4744.928826067612;4748.050389922012;4756.550376556076;3917.514445959375;4148.771817550049;4432.512423633398;4435.800388982488;4457.968581364671;3701.6298370163036;4339.958409981613;4431.180231657154;4443.644508439317;4448.310511870665;3535.8861958482994;3835.9616403835885;3837.328467518173;3841.138351927804;3876.476675648808;4241;6017.398260173992;6025.638461692312;6028.668423236721;6039.335673075958;4210.789460526961;4603.447586289633;5260.500252476008;5288.444713305086;5336.839894803162;5371.623986320959;6442.323556026643;6534.379233972765;6589.86820263592;6606;3599.532060832075;4299.462567179103;4303.462067241595;4306.547812479707;4309.719868208556;6075.696215189267;6772.69522871472;6901.930980690229;7006.9649651751415;7034.6482675866;4308.095299987038;4387.868363949086;4389.736615803062;4391.802368893407;4406.383106365111;4083.979005248688;4453.910921781546;4458.242098843204;4478.955210447919;4485.708428952108;4800.783964721526;4899.387576552931;5187.870303242374;5257.710825904612;5354.625176237626;6650.401463868178;6652.237157153359;6679.332066793282;6681.599104053676;6707.1616047994;1342.4227582139774;1437.6046587188607;1439.136318467587;1440.8991370604167;1517.833038365779;955.8518429643416;982.29274922056;990.8067926754358;997.9401235925868;1007.5768177365524;6213.875722485525;6224.595401298901;6273.780417685359;6298.244210694746;6301.464375528131;5714.685482420186;6655.733770649216;6776.983452482167;6813.693383797741;6832.872576025;6279.026750853625;6286.811395658137;6297.716602752887;6310.6213627182515;6326.9683651581445;3427.7429192810637;3530.770499917497;3550.378683730337;3570.9285814283567;3577.83899724513;7052.717891284394;7055.2239253682055;7061.258567850302;7097.25478824716;7120.572765634079;5643.492085712305;5905.173275741399;6612.603243805387;7106.477200593818;7115.5730656160795;6353.745850165941;6844.760433384908;7014.579125252501;7039.894401583981;7200.9639951802;5266.31238262683;6205.6586887721605;6606.636634985122;6811.863762724817;6988.4059854910865;5639.548836093185;5949.851253718692;6648.135742353463;6751.729930802713;6897.448204143757;7149.892751608834;7151.892721609284;7163.713451461883;7168.354848063699;7199.82000449972;4377.102693947797;4391;4413.12442212065;4414.492333381702;4431.7340959542535;6262;6277;6564.737410503526;6941.757038503628;6959.972412000796;5568.610197286151;6486.551296910618;6683.198016238082;6700.564463309869;6703.865922681616;6241.625502469867;6472.902906456501;6627.602343859191;6672.866542669217;6674.733010679518;5621.943780562142;5981.820545383472;6461.967690161707;6499.5775274607;6551.705173267119;5247.370315562157;6106.542009349406;6403.7118329676205;6636.966815165893;6661.533692641468;5586.944130558805;6216.564840461305;6390.5526613136635;6497.967510162608;6526.184226971629 13:24:56 INFO - PID 1645 | |5;yui.html;842.4860834890719;854.5086575219249;859.0722020218165;875.6366108065151;877.8288233794409;16277.674446511062;16710.498685039453;16753.413630522933;17977.64044719105;19110.52223694405;17609.64780704385;18098.185581648824;18211.72682409765;18476.445706628823;18477.445676629723;935.4106912645024;974.9519266788195;978.3249557805127;979.4172467381896;980.7401038724744;911.3119594705988;970.8009857979133;976.9413835169877;989.3470309595668;991.990080099197;980.5391466010999;1048.6329784575414;1049.459528342904;1052.3475445223933;1053.4679986606752;865.7402779166256;891.589868660417;1040.885502594714;1046.6546039806844;1049.7008352619505;765.3876898481193;775.2673723331454;777.4946284914794;779.3842864137325;780.5628847845225;16444;16729.16354182298;16900.408485703065;16987.66024679512;17261.827381726147;17297;17368.218430170546;17494.999999999873;17534.29862805486;17740.822591774046;14112.929435352757;14241.430342786276;14269;14650.413983440756;14797;3547.5210846535647;3564.625714299987;3573.4639804029343;3583.4624806279007;3586.067622418164;115723;118022;120570;121844.78155218512;123149.38425307906;13351;13541;13628;13745.450181992608;13861.584152475441;24786.884590193484;25319.367015824384;25437.982480700564;25765.09822156253;26287.73712262891;7830.256125668053;8026.678932842738;8034.397420193509;8039.155888631726;8055.677772889136;3795.6204379561823;3906.2187562487616;3941.684665226775;3992.980035099864;4020.115574573589;4324.589164029412;4403.779811009436;4413.801378937956;4414.757188354672;4417.889552761142;846.2975730144088;877.2105105405186;972.1250874213265;978.9951050244703;980.8479685648736;569.9829005129852;576.314186118526;656.474820143883;677.6103740349319;695.422799076765;11206.271592346471;11233.494492747846;11717;11952.22310549829;12137.434639790012;667.1460530520941;667.5227212543055;673.0375562945036;678.060885673346;688.2326206279962;5468.562514998791;5550.306211723535;5679.687617181012;5700.543956483471;5740.6268592541355;95177;95961.52019239859;96810;98443;99284;89271.55364223137;89415;90468.5476572613;90607.64088538545;90903;78892;79917.20082799214;80674;81609.9999999988;81617.6764647073;9319.347645664739;9805.313628045968;10088.798224035625;11211.47741758098;11352.318860868045;27608;33957.49063764095;35557.64442355543;39347.213055739296;39903.40869321775;47916.76041619769;52358;53002.67493312544;53245.201321980974;53769.462305376444;14328.785068224193;14413.351399187271;14538.41846326135;14734.410623574937;14835.703285934436;15491.225438727794;15688.843111568738;15898.297289460588;16053.919730401274;16063.598410039842;14638.487652932095;14692.559223223321;14748.705025899637;15046.172460514777;15078.773818392952;12827.807582886451;12864.356782161041;14635.195064271567;14716;14787.038842475635;11226.236687568624;14309.284535772962;14316.57050288493;14712.632184195481;14759;10593.682189534326;10784.514696838503;10911.454427278763;10956.56173753041;10976.396298203676;11017.906597746403;11628.767424651629;11713.824292635447;11874.940625296818;11911.463984120908 13:24:56 INFO - PID 1645 | __end_tp_report 13:24:56 INFO - PID 1645 | __start_cc_report 13:24:56 INFO - PID 1645 | _x_x_mozilla_cycle_collect,419 13:24:56 INFO - PID 1645 | __end_cc_report 13:24:56 INFO - PID 1645 | __startTimestamp1493497496402__endTimestamp 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | ------- Summary: start ------- 13:24:56 INFO - PID 1645 | Number of tests: 6 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:6088.61 Median:6324.21 stddev:745.89 (11.8%) stddev-sans-first:704.16 13:24:56 INFO - PID 1645 | Values: 2870.3 3577.6 3599.7 3623.5 3645.6 4463.0 5556.6 6038.7 6177.8 6178.0 5910.7 6099.7 6150.8 6193.9 6251.0 5163.1 5286.6 5359.4 5363.9 5441.6 5394.8 5444.7 5474.5 5494.8 5494.9 5393.7 5397.3 5424.8 5444.6 5475.9 5381.8 5398.8 5399.7 5420.7 5450.6 5324.4 5387.3 5391.8 5397.4 5411.5 5826.9 6117.4 6125.5 6131.0 6169.1 6600.6 6621.4 6634.8 6640.5 6643.6 6703.4 6707.0 6725.6 6727.0 6735.5 6104.4 6195.4 6273.0 6281.9 6294.1 5717.0 6760.0 6802.2 6859.0 6866.8 6281.7 6341.1 6411.1 6483.7 6508.7 6611.3 6710.1 6710.4 6712.3 6713.4 6353.4 6448.6 6588.6 6602.5 6629.1 6535.8 6585.0 6611.3 6613.6 6661.7 5281.2 5289.2 5289.3 5296.0 5328.2 4622.0 4717.2 4727.2 4745.5 4772.6 5054.7 6087.1 6198.9 6324.2 6353.0 6667.2 6699.1 6713.7 6718.7 6721.5 6235.8 6266.7 6300.6 6315.6 6319.5 5702.1 5771.5 5775.3 5777.2 5781.9 6716.3 6750.5 6796.4 6899.8 6917.9 6689.9 6728.5 6740.1 6751.9 6789.9 6901.7 6903.3 6934.5 6970.3 6975.2 6355.0 6428.2 6518.9 6555.3 6593.5 5173.4 6466.9 6704.5 6711.8 6725.7 6252.7 6417.3 6505.8 6508.6 6516.1 6426.6 6460.9 6479.4 6487.6 6509.8 6187.8 6241.3 6265.0 6301.6 6322.2 6462.4 6518.8 6536.2 6553.8 6567.2 6340.5 6348.5 6356.6 6367.6 6402.3 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:44438.50 Median:176975.84 stddev:77011.85 (43.5%) stddev-sans-first:77158.10 13:24:56 INFO - PID 1645 | Values: 775.1 1209.3 1222.0 1243.0 1288.7 36576.0 37638.0 37690.6 37797.0 37805.0 37510.8 37860.4 37882.9 37905.0 37990.0 7783.8 7952.0 8340.8 8490.0 8491.6 8446.6 8519.8 8540.9 8545.7 8554.2 8521.5 8537.6 8574.5 8586.2 8591.7 8510.0 8550.6 8552.5 8553.4 8558.1 8457.8 8507.0 8517.5 8525.7 8548.0 28110.7 37277.6 37327.4 37565.0 37684.8 3543.8 3581.9 3585.1 3595.6 3597.9 30792.5 30829.7 30875.0 30879.2 31014.1 3136.5 3144.6 3164.9 3167.5 3185.9 240286.0 248086.0 285241.1 292098.0 292698.0 39222.8 39775.6 48424.3 48937.0 49250.8 50463.0 51099.7 51134.5 51321.5 51409.0 11869.3 14189.6 14288.1 14313.2 14319.4 11400.2 11427.5 11443.9 11453.7 11573.4 13584.0 13616.7 13683.9 13713.7 13782.9 5337.5 5768.2 6008.3 6027.8 6032.1 908.0 946.3 1001.8 1060.8 1090.8 22069.0 24474.9 24506.1 24513.8 24529.9 1133.6 1136.2 1166.6 1176.5 1181.0 12046.9 12468.8 12488.4 12503.2 12590.9 319208.0 321431.0 321674.1 321748.0 322219.0 42525.6 55246.0 55693.4 55876.4 56113.9 1509.3 1559.2 1567.2 1574.6 1581.6 24189.4 24208.8 24229.9 24255.4 24334.6 39070.4 39105.4 39364.0 39378.4 39389.2 285089.0 285382.0 285554.0 285826.0 286102.0 34713.7 35026.6 35415.6 35418.5 35556.3 35335.8 44345.6 44475.0 46088.5 46128.8 30364.4 30889.7 31323.8 31407.4 31603.5 30809.5 30871.8 31399.0 31490.8 31782.0 36166.9 37681.4 37793.4 37831.6 37876.8 30050.3 31071.8 31164.2 31498.5 32203.7 19545.9 19824.2 21413.0 24333.0 24537.6 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:36154.11 Median:12271.14 stddev:95421.39 (777.6%) stddev-sans-first:95651.39 13:24:56 INFO - PID 1645 | Values: 442.7 446.0 450.3 464.7 469.3 16658.7 19227.5 21716.5 21859.8 21864.7 21763.7 22408.0 23077.2 23105.3 23559.6 5960.2 6082.3 6155.7 6174.6 6183.4 5755.1 5999.1 6059.0 6066.2 6083.7 5934.3 5947.8 5993.5 5995.3 6024.2 5840.9 5989.2 6018.1 6052.3 6068.6 5271.3 5360.6 5362.0 5417.9 5487.8 27292.2 27435.3 27469.0 27631.0 27933.4 2066.4 2274.9 2336.1 2339.3 2342.1 17733.6 17940.8 18024.9 18315.8 18443.9 2180.6 2182.9 2222.5 2226.9 2230.6 126080.0 164774.2 165586.0 166823.0 168764.2 10896.5 11776.5 12747.7 12752.9 12882.8 16379.3 16555.4 16584.3 16596.8 16620.4 8904.5 9070.9 9132.1 9163.2 9219.7 8670.2 8689.5 8733.2 8817.2 8877.0 7927.2 8045.6 8092.0 8102.5 8125.9 2202.9 2203.0 2203.1 2209.4 2389.5 996.7 1009.1 1012.3 1035.4 1042.6 15539.2 17366.7 18716.6 19582.0 20951.6 805.9 967.8 1003.8 1035.5 1069.5 9627.4 10612.1 10978.3 11039.8 11102.7 551039.0 558328.0 558848.4 571629.0 572103.0 122571.0 126057.4 128516.4 132534.0 137439.0 1193.2 1240.8 1281.4 1282.3 1283.1 18392.7 19808.5 21890.9 22203.6 22311.7 57547.4 57869.0 58606.4 58888.0 58985.0 78940.0 79181.8 80778.0 81281.2 81500.0 8730.1 8854.5 8942.0 8994.3 9159.0 11979.5 13886.4 14137.3 14334.2 14483.6 12008.5 12020.9 12100.0 12191.8 12235.3 11135.3 11411.3 11516.9 11658.3 11740.3 11727.5 11965.6 12293.4 12341.0 12376.8 8749.0 8803.6 8930.0 9087.3 9092.1 11419.6 11975.1 12123.9 12126.3 12167.3 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:7111.85 Median:3883.04 stddev:4483.80 (115.5%) stddev-sans-first:4475.65 13:24:56 INFO - PID 1645 | Values: 1374.3 1462.6 1480.5 1485.5 1501.5 11058.7 11141.5 11750.6 11770.8 11980.3 10716.5 11644.7 11831.4 11832.9 11874.1 2526.9 2537.1 2554.8 2557.5 2558.2 2485.7 2524.1 2525.0 2526.6 2527.9 2032.0 2497.1 2520.0 2548.3 2607.0 2457.1 2485.4 2506.1 2509.4 2510.6 2439.7 2475.4 2498.5 2502.5 2529.1 11706.1 11744.5 11765.3 11798.8 11827.6 6578.5 6830.2 6836.7 6837.7 6842.1 4057.4 4373.9 4425.2 4440.2 4453.5 1239.9 1259.5 1308.4 1312.1 1316.1 15904.4 16201.0 16441.6 16504.3 16761.4 5536.7 5625.2 5661.3 5764.0 5801.2 11774.9 11828.4 11850.9 11856.2 11863.6 6562.7 6587.1 6597.5 6599.8 6604.9 6056.4 6172.2 6202.0 6261.0 6273.9 4309.2 4437.5 4440.8 4482.9 4488.3 1063.8 1098.9 1310.9 1314.3 1315.3 793.7 818.8 824.6 832.0 852.4 5127.6 5914.6 6120.5 6361.5 6385.7 551.7 555.5 567.4 612.3 614.0 3874.9 3891.1 3944.8 3955.6 3967.7 14489.9 14916.5 14979.0 14998.0 15004.8 14661.5 14802.7 14868.4 14869.0 14875.3 8156.9 8302.0 8461.5 8560.4 8567.2 6709.0 6913.2 6971.6 7041.9 7110.2 13067.9 13155.5 13221.5 13229.9 13353.2 10454.8 13781.2 13913.2 14110.3 14231.1 9172.8 9465.2 9601.4 9636.9 9644.8 10861.4 10873.5 10969.6 10975.6 10980.8 9120.3 9282.6 9287.3 9354.9 9415.1 9039.7 9062.5 9083.3 9114.0 9231.4 8197.9 8309.2 8357.8 8378.9 8380.5 6044.1 6069.9 6171.4 6196.9 6245.7 6111.3 6233.5 6324.2 6355.6 6383.1 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:5280.10 Median:6054.73 stddev:1703.56 (28.1%) stddev-sans-first:1668.58 13:24:56 INFO - PID 1645 | Values: 404.6 408.9 411.0 411.0 421.0 5024.8 6086.3 6302.7 6323.2 6367.8 5520.8 5646.8 6070.1 6152.6 6168.1 3636.6 3847.9 4698.0 4713.2 4714.4 4309.9 4464.7 4744.9 4748.1 4756.6 3917.5 4148.8 4432.5 4435.8 4458.0 3701.6 4340.0 4431.2 4443.6 4448.3 3535.9 3836.0 3837.3 3841.1 3876.5 4241.0 6017.4 6025.6 6028.7 6039.3 4210.8 4603.4 5260.5 5288.4 5336.8 5371.6 6442.3 6534.4 6589.9 6606.0 3599.5 4299.5 4303.5 4306.5 4309.7 6075.7 6772.7 6901.9 7007.0 7034.6 4308.1 4387.9 4389.7 4391.8 4406.4 4084.0 4453.9 4458.2 4479.0 4485.7 4800.8 4899.4 5187.9 5257.7 5354.6 6650.4 6652.2 6679.3 6681.6 6707.2 1342.4 1437.6 1439.1 1440.9 1517.8 955.9 982.3 990.8 997.9 1007.6 6213.9 6224.6 6273.8 6298.2 6301.5 5714.7 6655.7 6777.0 6813.7 6832.9 6279.0 6286.8 6297.7 6310.6 6327.0 3427.7 3530.8 3550.4 3570.9 3577.8 7052.7 7055.2 7061.3 7097.3 7120.6 5643.5 5905.2 6612.6 7106.5 7115.6 6353.7 6844.8 7014.6 7039.9 7201.0 5266.3 6205.7 6606.6 6811.9 6988.4 5639.5 5949.9 6648.1 6751.7 6897.4 7149.9 7151.9 7163.7 7168.4 7199.8 4377.1 4391.0 4413.1 4414.5 4431.7 6262.0 6277.0 6564.7 6941.8 6960.0 5568.6 6486.6 6683.2 6700.6 6703.9 6241.6 6472.9 6627.6 6672.9 6674.7 5621.9 5981.8 6462.0 6499.6 6551.7 5247.4 6106.5 6403.7 6637.0 6661.5 5586.9 6216.6 6390.6 6498.0 6526.2 13:24:56 INFO - PID 1645 | 13:24:56 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:20815.87 Median:30782.75 stddev:29327.95 (95.3%) stddev-sans-first:29371.88 13:24:56 INFO - PID 1645 | Values: 842.5 854.5 859.1 875.6 877.8 16277.7 16710.5 16753.4 17977.6 19110.5 17609.6 18098.2 18211.7 18476.4 18477.4 935.4 975.0 978.3 979.4 980.7 911.3 970.8 976.9 989.3 992.0 980.5 1048.6 1049.5 1052.3 1053.5 865.7 891.6 1040.9 1046.7 1049.7 765.4 775.3 777.5 779.4 780.6 16444.0 16729.2 16900.4 16987.7 17261.8 17297.0 17368.2 17495.0 17534.3 17740.8 14112.9 14241.4 14269.0 14650.4 14797.0 3547.5 3564.6 3573.5 3583.5 3586.1 115723.0 118022.0 120570.0 121844.8 123149.4 13351.0 13541.0 13628.0 13745.5 13861.6 24786.9 25319.4 25438.0 25765.1 26287.7 7830.3 8026.7 8034.4 8039.2 8055.7 3795.6 3906.2 3941.7 3993.0 4020.1 4324.6 4403.8 4413.8 4414.8 4417.9 846.3 877.2 972.1 979.0 980.8 570.0 576.3 656.5 677.6 695.4 11206.3 11233.5 11717.0 11952.2 12137.4 667.1 667.5 673.0 678.1 688.2 5468.6 5550.3 5679.7 5700.5 5740.6 95177.0 95961.5 96810.0 98443.0 99284.0 89271.6 89415.0 90468.5 90607.6 90903.0 78892.0 79917.2 80674.0 81610.0 81617.7 9319.3 9805.3 10088.8 11211.5 11352.3 27608.0 33957.5 35557.6 39347.2 39903.4 47916.8 52358.0 53002.7 53245.2 53769.5 14328.8 14413.4 14538.4 14734.4 14835.7 15491.2 15688.8 15898.3 16053.9 16063.6 14638.5 14692.6 14748.7 15046.2 15078.8 12827.8 12864.4 14635.2 14716.0 14787.0 11226.2 14309.3 14316.6 14712.6 14759.0 10593.7 10784.5 10911.5 10956.6 10976.4 11017.9 11628.8 11713.8 11874.9 11911.5 13:24:56 INFO - PID 1645 | -------- Summary: end -------- 13:24:56 INFO - PID 1645 | 13:24:57 INFO - TEST-INFO | 1645: exit 0 13:24:57 INFO - TEST-OK | dromaeo_css | took 1115141ms 13:24:57 INFO - TEST-START | kraken 13:24:57 INFO - operating with platform_type : mac_ 13:24:57 INFO - Initialising browser for kraken test... 13:24:57 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmp8OfJau/profile http://localhost:49235/getInfo.html) 13:24:59 INFO - PID 1654 | 2017-04-29 13:24:59.907 plugin-container[1655:11259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x963f, name = 'com.apple.tsm.portname' 13:24:59 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:24:59 INFO - PID 1654 | 2017-04-29 13:24:59.910 plugin-container[1655:11259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 13:24:59 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:24:59 INFO - PID 1654 | 2017-04-29 13:24:59.911 plugin-container[1655:11259] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:25:00 INFO - PID 1654 | __metrics Screen width/height:1600/1200 13:25:00 INFO - PID 1654 | colorDepth:24 13:25:00 INFO - PID 1654 | Browser inner width/height: 1024/689 13:25:00 INFO - PID 1654 | __metrics 13:25:00 INFO - TEST-INFO | 1654: exit 0 13:25:00 INFO - Browser initialized. 13:25:00 INFO - Running cycle 1/1 for kraken test... 13:25:00 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmp8OfJau/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:25:03 INFO - PID 1656 | 2017-04-29 13:25:03.250 plugin-container[1657:11386] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 13:25:03 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:25:03 INFO - PID 1656 | 2017-04-29 13:25:03.250 plugin-container[1657:11386] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.CFPasteboardClient' 13:25:03 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:25:03 INFO - PID 1656 | 2017-04-29 13:25:03.250 plugin-container[1657:11386] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:25:13 INFO - PID 1656 | RSS: Main: 235806720 13:25:13 INFO - PID 1656 | 13:25:15 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 13:25:16 INFO - PID 1656 | RSS: Main: 248676352 13:25:16 INFO - PID 1656 | 13:25:19 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 13:25:19 INFO - PID 1656 | RSS: Main: 256696320 13:25:19 INFO - PID 1656 | 13:25:23 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 13:25:23 INFO - PID 1656 | RSS: Main: 258744320 13:25:23 INFO - PID 1656 | 13:25:25 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 13:25:26 INFO - PID 1656 | RSS: Main: 261160960 13:25:26 INFO - PID 1656 | 13:25:28 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:25:29 INFO - PID 1656 | RSS: Main: 261640192 13:25:29 INFO - PID 1656 | 13:25:31 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 13:25:32 INFO - PID 1656 | RSS: Main: 267378688 13:25:32 INFO - PID 1656 | 13:25:35 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 13:25:36 INFO - PID 1656 | RSS: Main: 268959744 13:25:36 INFO - PID 1656 | 13:25:39 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 13:25:39 INFO - PID 1656 | RSS: Main: 268533760 13:25:39 INFO - PID 1656 | 13:25:41 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:25:41 INFO - PID 1656 | RSS: Main: 268005376 13:25:41 INFO - PID 1656 | 13:25:43 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:25:44 INFO - PID 1656 | RSS: Main: 267776000 13:25:44 INFO - PID 1656 | 13:25:46 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:25:47 INFO - PID 1656 | RSS: Main: 267313152 13:25:47 INFO - PID 1656 | 13:25:50 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:25:51 INFO - PID 1656 | RSS: Main: 267460608 13:25:51 INFO - PID 1656 | 13:25:54 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:25:54 INFO - PID 1656 | RSS: Main: 267759616 13:25:54 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 13:25:56 INFO - PID 1656 | RSS: Main: 269271040 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | __start_tp_report 13:25:56 INFO - PID 1656 | _x_x_mozilla_page_load 13:25:56 INFO - PID 1656 | _x_x_mozilla_page_load_details 13:25:56 INFO - PID 1656 | |i|pagename|runs| 13:25:56 INFO - PID 1656 | |0;ai-astar;104;113;114;113;113;128;113;114;114;111 13:25:56 INFO - PID 1656 | |1;audio-beat-detection;143;107;110;148;132;146;110;111;135;108 13:25:56 INFO - PID 1656 | |2;audio-dft;195;197;202;210;217;232;194;239;254;201 13:25:56 INFO - PID 1656 | |3;audio-fft;79;60;63;106;88;85;48;75;92;81 13:25:56 INFO - PID 1656 | |4;audio-oscillator;81;70;85;70;71;69;86;68;70;90 13:25:56 INFO - PID 1656 | |5;imaging-gaussian-blur;89;89;89;89;90;88;90;88;88;93 13:25:56 INFO - PID 1656 | |6;imaging-darkroom;95;95;109;154;96;95;95;96;106;100 13:25:56 INFO - PID 1656 | |7;imaging-desaturate;92;97;119;91;91;91;89;91;90;94 13:25:56 INFO - PID 1656 | |8;json-parse-financial;51;50;49;50;50;52;50;50;51;48 13:25:56 INFO - PID 1656 | |9;json-stringify-tinderbox;56;63;58;62;79;88;59;56;54;61 13:25:56 INFO - PID 1656 | |10;stanford-crypto-aes;100;98;112;82;85;83;84;87;77;93 13:25:56 INFO - PID 1656 | |11;stanford-crypto-ccm;139;138;160;153;141;142;158;156;280;157 13:25:56 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;202;190;189;181;182;183;184;183;184;186 13:25:56 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;70;69;66;68;70;67;66;69;67;78 13:25:56 INFO - PID 1656 | __end_tp_report 13:25:56 INFO - PID 1656 | __start_cc_report 13:25:56 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1026 13:25:56 INFO - PID 1656 | __end_cc_report 13:25:56 INFO - PID 1656 | __startTimestamp1493497556671__endTimestamp 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | ------- Summary: start ------- 13:25:56 INFO - PID 1656 | Number of tests: 14 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:113.70 Median:113.50 stddev:5.85 (5.2%) stddev-sans-first:5.04 13:25:56 INFO - PID 1656 | Values: 104.0 113.0 114.0 113.0 113.0 128.0 113.0 114.0 114.0 111.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:133.50 stddev:17.33 (13.0%) stddev-sans-first:17.11 13:25:56 INFO - PID 1656 | Values: 143.0 107.0 110.0 148.0 132.0 146.0 110.0 111.0 135.0 108.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:214.10 Median:213.50 stddev:20.91 (9.8%) stddev-sans-first:21.01 13:25:56 INFO - PID 1656 | Values: 195.0 197.0 202.0 210.0 217.0 232.0 194.0 239.0 254.0 201.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:77.70 Median:80.00 stddev:16.98 (21.2%) stddev-sans-first:18.01 13:25:56 INFO - PID 1656 | Values: 79.0 60.0 63.0 106.0 88.0 85.0 48.0 75.0 92.0 81.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:76.00 stddev:8.49 (11.2%) stddev-sans-first:8.80 13:25:56 INFO - PID 1656 | Values: 81.0 70.0 85.0 70.0 71.0 69.0 86.0 68.0 70.0 90.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:89.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 13:25:56 INFO - PID 1656 | Values: 89.0 89.0 89.0 89.0 90.0 88.0 90.0 88.0 88.0 93.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:95.00 stddev:18.25 (19.2%) stddev-sans-first:19.06 13:25:56 INFO - PID 1656 | Values: 95.0 95.0 109.0 154.0 96.0 95.0 95.0 96.0 106.0 100.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:91.00 stddev:8.90 (9.8%) stddev-sans-first:9.39 13:25:56 INFO - PID 1656 | Values: 92.0 97.0 119.0 91.0 91.0 91.0 89.0 91.0 90.0 94.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:1.10 (2.2%) stddev-sans-first:1.12 13:25:56 INFO - PID 1656 | Values: 51.0 50.0 49.0 50.0 50.0 52.0 50.0 50.0 51.0 48.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:61.50 stddev:11.07 (18.0%) stddev-sans-first:11.39 13:25:56 INFO - PID 1656 | Values: 56.0 63.0 58.0 62.0 79.0 88.0 59.0 56.0 54.0 61.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:84.50 stddev:10.59 (12.5%) stddev-sans-first:10.61 13:25:56 INFO - PID 1656 | Values: 100.0 98.0 112.0 82.0 85.0 83.0 84.0 87.0 77.0 93.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:156.50 stddev:42.20 (27.0%) stddev-sans-first:43.91 13:25:56 INFO - PID 1656 | Values: 139.0 138.0 160.0 153.0 141.0 142.0 158.0 156.0 280.0 157.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:185.00 stddev:6.20 (3.4%) stddev-sans-first:3.08 13:25:56 INFO - PID 1656 | Values: 202.0 190.0 189.0 181.0 182.0 183.0 184.0 183.0 184.0 186.0 13:25:56 INFO - PID 1656 | 13:25:56 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:3.50 (5.1%) stddev-sans-first:3.69 13:25:56 INFO - PID 1656 | Values: 70.0 69.0 66.0 68.0 70.0 67.0 66.0 69.0 67.0 78.0 13:25:56 INFO - PID 1656 | -------- Summary: end -------- 13:25:56 INFO - PID 1656 | 13:25:57 INFO - TEST-INFO | 1656: exit 0 13:25:57 INFO - TEST-OK | kraken | took 60815ms 13:25:57 INFO - SUITE-END | took 1175s 13:25:58 INFO - Completed test suite (00:19:36) 13:25:58 INFO - javascript benchmark 13:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7826.917155723193, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2870.282429392652, 3577.624349443307, 3599.748017638763, 3623.4745961835533, 3645.5625324961, 4462.9776851115785, 5556.638818476797, 6038.66787326698, 6177.84555386115, 6177.980633195523, 5910.67491287979, 6099.672983688887, 6150.784722534701, 6193.938060619393, 6250.968745156268, 5163.1480805667015, 5286.603504737141, 5359.38367087786, 5363.919541206876, 5441.646292990943, 5394.757235924373, 5444.700541470217, 5474.534664553517, 5494.752736126864, 5494.917576236359, 5393.703346315951, 5397.298351214317, 5424.783008679648, 5444.5916556258435, 5475.945240547623, 5381.811636592701, 5398.811041613525, 5399.730013499309, 5420.728963551846, 5450.645708028966, 5324.440933701983, 5387.326584176978, 5391.838244852661, 5397.433269506724, 5411.512963833235, 5826.912596311059, 6117.388261173847, 6125.479643195305, 6131.049687298476, 6169.105479705418, 6600.570962887397, 6621.437177839889, 6634.834129146761, 6640.501962352843, 6643.601383916932, 6703.363180497845, 6706.966465167643, 6725.562838415487, 6727.0, 6735.494837887178, 6104.3590423005835, 6195.4424101831055, 6273.0, 6281.937180628227, 6294.087357333161, 5717.0, 6759.966200169066, 6802.183737951378, 6859.039734437183, 6866.759663411756, 6281.654509001957, 6341.143945567382, 6411.070394792729, 6483.740650374027, 6508.707108180143, 6611.272759996396, 6710.0941372915, 6710.396064354231, 6712.2616512184595, 6713.395794378529, 6353.428191462791, 6448.645324507197, 6588.571742836701, 6602.471802255808, 6629.071929929813, 6535.771248006297, 6584.967075164594, 6611.272759996396, 6613.60318380889, 6661.700223489955, 5281.234221037928, 5289.18017707256, 5289.338832645919, 5296.0, 5328.200769884548, 4622.029373831533, 4717.150912835723, 4727.2436410174205, 4745.477997420281, 4772.5943294819635, 5054.69671819692, 6087.147799308101, 6198.938010619926, 6324.209473815773, 6352.968235158794, 6667.199936007613, 6699.129113215251, 6713.731450741916, 6718.7312507499155, 6721.529492935545, 6235.844103897439, 6266.655333956676, 6300.558960872695, 6315.589486683442, 6319.462845658079, 5702.0591602385975, 5771.451712087345, 5775.27809023872, 5777.248957635565, 5781.913271300934, 6716.261211266855, 6750.5274630775375, 6796.35434633709, 6899.827504312432, 6917.9308206917285, 6689.933100668931, 6728.529002969745, 6740.12378390806, 6751.898721519279, 6789.932100679128, 6901.689423976033, 6903.299181040366, 6934.549254298455, 6970.268121847133, 6975.232724400414, 6355.046742988588, 6428.164338635947, 6518.902216466662, 6555.311692272243, 6593.538452308292, 5173.430922598586, 6466.935330646634, 6704.497162712913, 6711.765088221889, 6725.697343619451, 6252.718627661857, 6417.26201486835, 6505.837354066186, 6508.60948343101, 6516.087747715229, 6426.614403135827, 6460.935390646034, 6479.352064793483, 6487.578307410192, 6509.804705858832, 6187.783427580193, 6241.344658810759, 6264.968675156595, 6301.590396624205, 6322.178116844781, 6462.3537646235, 6518.771842985473, 6536.248331441945, 6553.770618028346, 6567.211934567882, 6340.49276057905, 6348.5238607105575, 6356.555041147075, 6367.649779262185, 6402.263739669811], "value": 6038.724142885315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.1086250811567, 1209.3106929050434, 1222.0345926717896, 1242.9937850310748, 1288.6842723532736, 36576.0, 37638.0, 37690.62309376912, 37797.0, 37805.0, 37510.8124459378, 37860.43209351862, 37882.863514094555, 37905.0, 37990.0, 7783.766487005399, 7952.045754509467, 8340.83318333633, 8489.957550212272, 8491.575421228914, 8446.57767111645, 8519.829603407929, 8540.871886921701, 8545.700900468484, 8554.18735220153, 8521.488710677348, 8537.57312134394, 8574.485530868136, 8586.184312490303, 8591.742247732578, 8510.0, 8550.572471376407, 8552.52961087143, 8553.40126191167, 8558.058613552505, 8457.788555286166, 8507.02169250538, 8517.53153576553, 8525.658973641046, 8548.0, 28110.718892811015, 37277.627223727686, 37327.4400883987, 37565.0, 37684.81157594222, 3543.7519373643854, 3581.8925432237074, 3585.1216451969435, 3595.6404359564094, 3597.94603080954, 30792.538111928337, 30829.691703082906, 30875.0, 30879.228019299473, 31014.069577912698, 3136.52952057191, 3144.591203143577, 3164.8892288769784, 3167.4773662345683, 3185.9203519911957, 240286.0, 248086.0, 285241.1475885235, 292097.99999999785, 292698.0, 39222.80388598096, 39775.60224397719, 48424.273635895486, 48937.0, 49250.75374623104, 50462.98148074036, 51099.74450127726, 51134.48865511372, 51321.486785132416, 51409.0, 11869.347185904859, 14189.645258868612, 14288.142711437347, 14313.212773297568, 14319.35562899672, 11400.201985861077, 11427.542898284142, 11443.885561144281, 11453.713657158638, 11573.421328933688, 13583.981201409933, 13616.65958351049, 13683.931580342234, 13713.725725485634, 13782.93108534471, 5337.546308563816, 5768.1636162757, 6008.3144557019095, 6027.78902738402, 6032.095185722089, 908.0420156734708, 946.2619157057507, 1001.7796084861319, 1060.7825395793843, 1090.7654854206385, 22069.0, 24474.877625611756, 24506.142285019938, 24513.754862451147, 24529.87735061349, 1133.6032388663903, 1136.170595465315, 1166.5742004168587, 1176.517627772609, 1181.0, 12046.932738373825, 12468.753124687459, 12488.375581220902, 12503.249805011728, 12590.874091259153, 319208.0, 321431.0, 321674.0911840723, 321748.0, 322219.0, 42525.57474425216, 55246.0, 55693.443065569634, 55876.44123558794, 56113.87772244532, 1509.2830905319886, 1559.22818204987, 1567.2477210938584, 1574.6063484128968, 1581.5571639940836, 24189.395265118514, 24208.75791242065, 24229.909654065257, 24255.393615159763, 24334.63498047566, 39070.4139437903, 39105.41341879817, 39364.0, 39378.40932385959, 39389.212215756095, 285089.0, 285382.0, 285554.0, 285826.0, 286102.0, 34713.65286347104, 35026.64973350234, 35415.64584354227, 35418.46872296866, 35556.28887422186, 35335.82332088323, 44345.55654443414, 44475.0, 46088.46938367417, 46128.76935615435, 30364.392712145192, 30889.69110308958, 31323.843380783863, 31407.37185256328, 31603.525947111273, 30809.537856932613, 30871.84564077165, 31399.0, 31490.842545787124, 31782.0, 36166.914992550264, 37681.43477847889, 37793.433098504094, 37831.62168378281, 37876.81061594674, 30050.34723090251, 31071.75712971456, 31164.220894477818, 31498.527522087647, 32203.677963220067, 19545.902270488557, 19824.207031719146, 21413.0, 24333.0, 24537.631935520625], "value": 17582.675352341666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.6768459024914, 445.9732416055037, 450.3290097754346, 464.67008424018945, 469.34057649003165, 16658.667786509883, 19227.519312017208, 21716.457088572795, 21859.781402185974, 21864.672029919526, 21763.6735448968, 22407.99164037618, 23077.192298269565, 23105.30684079476, 23559.646605300935, 5960.165576819249, 6082.330943596201, 6155.692215389235, 6174.629522228658, 6183.350748171422, 5755.136729490568, 5999.070144127645, 6059.0, 6066.150738896536, 6083.665398403108, 5934.287885453751, 5947.791827286046, 5993.490553302974, 5995.310539287994, 6024.246969128859, 5840.883182336351, 5989.221401217814, 6018.097285407181, 6052.273727152726, 6068.575199736042, 5271.28837606922, 5360.59795515334, 5362.034833729927, 5417.945820541783, 5487.75305111271, 27292.181234562995, 27435.31411714723, 27469.0, 27631.0, 27933.441331173464, 2066.380085974202, 2274.8521346112448, 2336.0538981712434, 2339.251439539348, 2342.1334106380577, 17733.556661083447, 17940.820591794178, 18024.90987545067, 18315.816841831544, 18443.907780461013, 2180.6401943679275, 2182.886727768833, 2222.4554984028855, 2226.877521736304, 2230.620794464945, 126080.0, 164774.1761291186, 165586.0, 166823.0, 168764.15617922076, 10896.455177241107, 11776.52893884252, 12747.745045099045, 12752.872471275168, 12882.80675789864, 16379.262933168036, 16555.420560280334, 16584.336626535045, 16596.751048734277, 16620.418285359956, 8904.465732056098, 9070.909290907006, 9132.086791320948, 9163.175314221751, 9219.723408297761, 8670.176333248332, 8689.478631282016, 8733.170348816979, 8817.162369575008, 8876.979147398131, 7927.167647397056, 8045.637946292431, 8092.0, 8102.513849169069, 8125.9187408126345, 2202.8678279303294, 2203.0062793172206, 2203.0967303405528, 2209.414505156135, 2389.4504264019374, 996.6710985374809, 1009.1472705563787, 1012.281280290987, 1035.440861934562, 1042.5777560088177, 15539.223038848239, 17366.739498907526, 18716.625667486573, 19582.020898954994, 20951.638143520624, 805.8549461097059, 967.7822489939707, 1003.799240151958, 1035.4512108582464, 1069.4973362519604, 9627.422354658604, 10612.097971672494, 10978.341299522055, 11039.779204415867, 11102.722431939266, 551039.0, 558328.0, 558848.4115158878, 571629.0, 572103.0, 122571.0, 126057.36971315085, 128516.35741821417, 132534.0, 137439.0, 1193.1528614683498, 1240.8076748104058, 1281.416955285343, 1282.26269894809, 1283.146707439561, 18392.724109138107, 19808.504787380432, 21890.905454726882, 22203.555928881655, 22311.665325019814, 57547.424525754206, 57869.0, 58606.4139358618, 58888.0, 58985.0, 78940.0, 79181.8122728171, 80777.98055048671, 81281.18718812973, 81500.0, 8730.083341249077, 8854.506106813315, 8942.0, 8994.280457563511, 9159.0, 11979.460924258256, 13886.444542218198, 14137.293135342987, 14334.211618360672, 14483.565493035227, 12008.459619316976, 12020.939895300467, 12100.0, 12191.75616487683, 12235.265884046985, 11135.276207046516, 11411.315321080761, 11516.94241528787, 11658.300501969909, 11740.295582265091, 11727.472263748323, 11965.641030769091, 12293.44679489443, 12341.0, 12376.81434778461, 8749.0, 8803.64785408602, 8930.0, 9087.2730181584, 9092.136247056518, 11419.60031398897, 11975.101867360157, 12123.908848203704, 12126.27242365461, 12167.33079680626], "value": 10542.388616618136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.257900733604, 1462.583163798317, 1480.4818313590251, 1485.465232516294, 1501.519513755598, 11058.723531911695, 11141.498632561534, 11750.647480575586, 11770.7645847083, 11980.34108124053, 10716.517756700947, 11644.650660480178, 11831.40842957853, 11832.940835295833, 11874.05007599392, 2526.8989240430406, 2537.1120107962156, 2554.846709197445, 2557.4629327841176, 2558.219742978391, 2485.689288838895, 2524.116559204282, 2524.9621255681086, 2526.5704830178915, 2527.8736063196857, 2031.959360812783, 2497.126005897939, 2519.962200566993, 2548.2610043087484, 2607.0, 2457.1400009996537, 2485.403503159247, 2506.097804790274, 2509.3852006258585, 2510.6485092087123, 2439.7438268981855, 2475.443025319307, 2498.475320182764, 2502.5370306493173, 2529.1148098165677, 11706.063514918786, 11744.530218791238, 11765.294082355085, 11798.764024719458, 11827.586034488837, 6578.473722102221, 6830.248672646005, 6836.658167091675, 6837.726490940357, 6842.110525631636, 4057.3913912913004, 4373.868783936487, 4425.225585522553, 4440.200763862504, 4453.487848897385, 1239.8884100430914, 1259.502496513881, 1308.4439113376777, 1312.1339915655717, 1316.0590178022665, 15904.443344482888, 16201.0, 16441.58896027597, 16504.33982640693, 16761.413350532795, 5536.695481748542, 5625.156226565966, 5661.2923384576925, 5764.048931926269, 5801.158831969426, 11774.88225117755, 11828.408579570987, 11850.940745296391, 11856.22934509254, 11863.644090677293, 6562.67186640666, 6587.143671322698, 6597.538172327891, 6599.769008084694, 6604.867902642017, 6056.424639659225, 6172.166757487682, 6201.96899015502, 6260.968695156586, 6273.8745225095245, 4309.159713855831, 4437.467503899553, 4440.800163992628, 4482.932756008662, 4488.304312831517, 1063.8138325792954, 1098.8626421697288, 1310.8754668306497, 1314.2574445438297, 1315.339515197765, 793.7460012795965, 818.8321394114192, 824.6165533027051, 831.9625616847256, 852.4203541591653, 5127.64106512548, 5914.610066634337, 6120.540959428061, 6361.522885783585, 6385.680715964276, 551.6842331040498, 555.4612026334449, 567.4410705455124, 612.2622240200548, 614.0328981853598, 3874.946278472414, 3891.124496988155, 3944.8422063117728, 3955.624215699504, 3967.682585393162, 14489.855101448851, 14916.477923272634, 14979.026363286352, 14998.02512836684, 15004.849951500346, 14661.48684796027, 14802.703945921021, 14868.405263789544, 14869.0, 14875.330610122353, 8156.877646835303, 8301.958490207631, 8461.534615596202, 8560.357973152039, 8567.186117318844, 6708.966455167888, 6913.2049814272, 6971.6165610891885, 7041.859162816818, 7110.217876033736, 13067.869321306665, 13155.53955611549, 13221.537246196336, 13229.933850330686, 13353.198808071547, 10454.843177352497, 13781.242031688353, 13913.234772087633, 14110.294485275901, 14231.146131232159, 9172.816543668956, 9465.242780577399, 9601.37591056579, 9636.855447168438, 9644.75888102803, 10861.40262285582, 10873.45632718345, 10969.616063438061, 10975.560977560808, 10980.835287470534, 9120.270378369847, 9282.582283797381, 9287.303452241244, 9354.859677104985, 9415.105564971316, 9039.728808135504, 9062.50156241413, 9083.318751093562, 9113.954430227806, 9231.446113233227, 8197.877031844408, 8309.169083091643, 8357.791055223668, 8378.874316885129, 8380.455270407405, 6044.093385992136, 6069.9089513656445, 6171.352008039271, 6196.907046394217, 6245.656488893154, 6111.327753947151, 6233.470155036873, 6324.177856878577, 6355.586886852339, 6383.1382763326355], "value": 5333.125729464369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.6418919256458, 408.92248924085027, 410.96712263018964, 410.98767036988903, 420.99579004209966, 5024.844285814261, 6086.30007549132, 6302.716377763, 6323.20959880015, 6367.777127800522, 5520.806771762989, 5646.802361917334, 6070.119832624267, 6152.5693201475915, 6168.105624684429, 3636.563612366513, 3847.942280865789, 4698.0, 4713.175194340994, 4714.387129673155, 4309.870703878889, 4464.6874718769695, 4744.928826067612, 4748.050389922012, 4756.550376556076, 3917.514445959375, 4148.771817550049, 4432.512423633398, 4435.800388982488, 4457.968581364671, 3701.6298370163036, 4339.958409981613, 4431.180231657154, 4443.644508439317, 4448.310511870665, 3535.8861958482994, 3835.9616403835885, 3837.328467518173, 3841.138351927804, 3876.476675648808, 4241.0, 6017.398260173992, 6025.638461692312, 6028.668423236721, 6039.335673075958, 4210.789460526961, 4603.447586289633, 5260.500252476008, 5288.444713305086, 5336.839894803162, 5371.623986320959, 6442.323556026643, 6534.379233972765, 6589.86820263592, 6606.0, 3599.532060832075, 4299.462567179103, 4303.462067241595, 4306.547812479707, 4309.719868208556, 6075.696215189267, 6772.69522871472, 6901.930980690229, 7006.9649651751415, 7034.6482675866, 4308.095299987038, 4387.868363949086, 4389.736615803062, 4391.802368893407, 4406.383106365111, 4083.979005248688, 4453.910921781546, 4458.242098843204, 4478.955210447919, 4485.708428952108, 4800.783964721526, 4899.387576552931, 5187.870303242374, 5257.710825904612, 5354.625176237626, 6650.401463868178, 6652.237157153359, 6679.332066793282, 6681.599104053676, 6707.1616047994, 1342.4227582139774, 1437.6046587188607, 1439.136318467587, 1440.8991370604167, 1517.833038365779, 955.8518429643416, 982.29274922056, 990.8067926754358, 997.9401235925868, 1007.5768177365524, 6213.875722485525, 6224.595401298901, 6273.780417685359, 6298.244210694746, 6301.464375528131, 5714.685482420186, 6655.733770649216, 6776.983452482167, 6813.693383797741, 6832.872576025, 6279.026750853625, 6286.811395658137, 6297.716602752887, 6310.6213627182515, 6326.9683651581445, 3427.7429192810637, 3530.770499917497, 3550.378683730337, 3570.9285814283567, 3577.83899724513, 7052.717891284394, 7055.2239253682055, 7061.258567850302, 7097.25478824716, 7120.572765634079, 5643.492085712305, 5905.173275741399, 6612.603243805387, 7106.477200593818, 7115.5730656160795, 6353.745850165941, 6844.760433384908, 7014.579125252501, 7039.894401583981, 7200.9639951802, 5266.31238262683, 6205.6586887721605, 6606.636634985122, 6811.863762724817, 6988.4059854910865, 5639.548836093185, 5949.851253718692, 6648.135742353463, 6751.729930802713, 6897.448204143757, 7149.892751608834, 7151.892721609284, 7163.713451461883, 7168.354848063699, 7199.82000449972, 4377.102693947797, 4391.0, 4413.12442212065, 4414.492333381702, 4431.7340959542535, 6262.0, 6277.0, 6564.737410503526, 6941.757038503628, 6959.972412000796, 5568.610197286151, 6486.551296910618, 6683.198016238082, 6700.564463309869, 6703.865922681616, 6241.625502469867, 6472.902906456501, 6627.602343859191, 6672.866542669217, 6674.733010679518, 5621.943780562142, 5981.820545383472, 6461.967690161707, 6499.5775274607, 6551.705173267119, 5247.370315562157, 6106.542009349406, 6403.7118329676205, 6636.966815165893, 6661.533692641468, 5586.944130558805, 6216.564840461305, 6390.5526613136635, 6497.967510162608, 6526.184226971629], "value": 4750.952283665056, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.4860834890719, 854.5086575219249, 859.0722020218165, 875.6366108065151, 877.8288233794409, 16277.674446511062, 16710.498685039453, 16753.413630522933, 17977.64044719105, 19110.52223694405, 17609.64780704385, 18098.185581648824, 18211.72682409765, 18476.445706628823, 18477.445676629723, 935.4106912645024, 974.9519266788195, 978.3249557805127, 979.4172467381896, 980.7401038724744, 911.3119594705988, 970.8009857979133, 976.9413835169877, 989.3470309595668, 991.990080099197, 980.5391466010999, 1048.6329784575414, 1049.459528342904, 1052.3475445223933, 1053.4679986606752, 865.7402779166256, 891.589868660417, 1040.885502594714, 1046.6546039806844, 1049.7008352619505, 765.3876898481193, 775.2673723331454, 777.4946284914794, 779.3842864137325, 780.5628847845225, 16444.0, 16729.16354182298, 16900.408485703065, 16987.66024679512, 17261.827381726147, 17297.0, 17368.218430170546, 17494.999999999873, 17534.29862805486, 17740.822591774046, 14112.929435352757, 14241.430342786276, 14269.0, 14650.413983440756, 14797.0, 3547.5210846535647, 3564.625714299987, 3573.4639804029343, 3583.4624806279007, 3586.067622418164, 115723.0, 118022.0, 120570.0, 121844.78155218512, 123149.38425307906, 13351.0, 13541.0, 13628.0, 13745.450181992608, 13861.584152475441, 24786.884590193484, 25319.367015824384, 25437.982480700564, 25765.09822156253, 26287.73712262891, 7830.256125668053, 8026.678932842738, 8034.397420193509, 8039.155888631726, 8055.677772889136, 3795.6204379561823, 3906.2187562487616, 3941.684665226775, 3992.980035099864, 4020.115574573589, 4324.589164029412, 4403.779811009436, 4413.801378937956, 4414.757188354672, 4417.889552761142, 846.2975730144088, 877.2105105405186, 972.1250874213265, 978.9951050244703, 980.8479685648736, 569.9829005129852, 576.314186118526, 656.474820143883, 677.6103740349319, 695.422799076765, 11206.271592346471, 11233.494492747846, 11717.0, 11952.22310549829, 12137.434639790012, 667.1460530520941, 667.5227212543055, 673.0375562945036, 678.060885673346, 688.2326206279962, 5468.562514998791, 5550.306211723535, 5679.687617181012, 5700.543956483471, 5740.6268592541355, 95177.0, 95961.52019239859, 96810.0, 98443.0, 99284.0, 89271.55364223137, 89415.0, 90468.5476572613, 90607.64088538545, 90903.0, 78892.0, 79917.20082799214, 80674.0, 81609.9999999988, 81617.6764647073, 9319.347645664739, 9805.313628045968, 10088.798224035625, 11211.47741758098, 11352.318860868045, 27608.0, 33957.49063764095, 35557.64442355543, 39347.213055739296, 39903.40869321775, 47916.76041619769, 52358.0, 53002.67493312544, 53245.201321980974, 53769.462305376444, 14328.785068224193, 14413.351399187271, 14538.41846326135, 14734.410623574937, 14835.703285934436, 15491.225438727794, 15688.843111568738, 15898.297289460588, 16053.919730401274, 16063.598410039842, 14638.487652932095, 14692.559223223321, 14748.705025899637, 15046.172460514777, 15078.773818392952, 12827.807582886451, 12864.356782161041, 14635.195064271567, 14716.0, 14787.038842475635, 11226.236687568624, 14309.284535772962, 14316.57050288493, 14712.632184195481, 14759.0, 10593.682189534326, 10784.514696838503, 10911.454427278763, 10956.56173753041, 10976.396298203676, 11017.906597746403, 11628.767424651629, 11713.824292635447, 11874.940625296818, 11911.463984120908], "value": 8105.530690032183, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 113.0, 113.0, 128.0, 113.0, 114.0, 114.0, 111.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 110.0, 148.0, 132.0, 146.0, 110.0, 111.0, 135.0, 108.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 197.0, 202.0, 210.0, 217.0, 232.0, 194.0, 239.0, 254.0, 201.0], "value": 214.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 63.0, 106.0, 88.0, 85.0, 48.0, 75.0, 92.0, 81.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 85.0, 70.0, 71.0, 69.0, 86.0, 68.0, 70.0, 90.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 90.0, 88.0, 90.0, 88.0, 88.0, 93.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 109.0, 154.0, 96.0, 95.0, 95.0, 96.0, 106.0, 100.0], "value": 104.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 97.0, 119.0, 91.0, 91.0, 91.0, 89.0, 91.0, 90.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 50.0, 52.0, 50.0, 50.0, 51.0, 48.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 58.0, 62.0, 79.0, 88.0, 59.0, 56.0, 54.0, 61.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 98.0, 112.0, 82.0, 85.0, 83.0, 84.0, 87.0, 77.0, 93.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 160.0, 153.0, 141.0, 142.0, 158.0, 156.0, 280.0, 157.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 190.0, 189.0, 181.0, 182.0, 183.0, 184.0, 183.0, 184.0, 186.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 66.0, 68.0, 70.0, 67.0, 66.0, 69.0, 67.0, 78.0], "value": 69.0, "unit": "score"}]}]} 13:25:58 INFO - Return code: 0 13:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:25:58 ERROR - # TBPL SUCCESS # 13:25:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:25:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:25:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:25:58 INFO - 2017-04-29 13:25:58.477 screenresolution[1662:11775] starting screenresolution argv=screenresolution get 13:25:58 INFO - 2017-04-29 13:25:58.480 screenresolution[1662:11775] Display 0: 1600x1200x32@60 13:25:58 INFO - 2017-04-29 13:25:58.486 screenresolution[1663:11778] starting screenresolution argv=screenresolution list 13:25:58 INFO - Available Modes on Display 0 13:25:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:25:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:25:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:25:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:25:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:25:58 INFO - Intel Iris: 13:25:58 INFO - Chipset Model: Intel Iris 13:25:58 INFO - Type: GPU 13:25:58 INFO - Bus: Built-In 13:25:58 INFO - VRAM (Dynamic, Max): 1536 MB 13:25:58 INFO - Vendor: Intel (0x8086) 13:25:58 INFO - Device ID: 0x0a2e 13:25:58 INFO - Revision ID: 0x0009 13:25:58 INFO - Displays: 13:25:58 INFO - Display: 13:25:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:25:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:25:58 INFO - Display Serial Number: 1600x1200 60 13:25:58 INFO - Main Display: Yes 13:25:58 INFO - Mirror: Off 13:25:58 INFO - Online: Yes 13:25:58 INFO - Rotation: Supported 13:25:58 INFO - Return code: 0 13:25:58 INFO - Running post-action listener: _resource_record_post_action 13:25:58 INFO - [mozharness: 2017-04-29 20:25:58.721895Z] Finished run-tests step (success) 13:25:58 INFO - Running post-run listener: _resource_record_post_run 13:25:58 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 32064512; Write bytes: 513318912; Read time: 198; Write time: 1582 13:25:58 INFO - TinderboxPrint: CPU usage
54.0% 13:25:58 INFO - TinderboxPrint: I/O read bytes / time
32,064,512 / 198 13:25:58 INFO - TinderboxPrint: I/O write bytes / time
513,318,912 / 1,582 13:25:58 INFO - TinderboxPrint: CPU idle
2,202.4 (46.0%) 13:25:58 INFO - TinderboxPrint: CPU system
958.3 (20.0%) 13:25:58 INFO - TinderboxPrint: CPU user
1,628.9 (34.0%) 13:25:58 INFO - TinderboxPrint: Swap in / out
236,654,592 / 0 13:25:58 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206027264; Write bytes: 204699136; Read time: 16282; Write time: 417 13:25:58 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29844480; Write bytes: 301419008; Read time: 178; Write time: 1136 13:25:59 INFO - Running post-run listener: _upload_blobber_files 13:25:59 INFO - Blob upload gear active. 13:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:25:59 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 13:25:59 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'] 13:25:59 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 13:25:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:01 INFO - (blobuploader) - INFO - Done attempting. 13:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:02 INFO - (blobuploader) - INFO - Done attempting. 13:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:03 INFO - (blobuploader) - INFO - Done attempting. 13:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:06 INFO - (blobuploader) - INFO - Done attempting. 13:26:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:26:06 INFO - Return code: 0 13:26:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:26:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:26:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6a6e44e20f62677c15b3aa79f787cee585ad014b8d16b1074eab1475b36834a75b5b26f67f3bf022049a7f202c4548cc822521ae7c81bf7f30341a6776e0b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6928711d2ab8ff0c5c86d129e76dcb33eac590d8f52536cb6bce49265ca7088e202a88a3cfe0a19034575a5632be0421feb5bf2a2956e03ff48f17923ea98b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd16b5dd52a989c26e034fd1492e1d7583b90a78f4c983d0fd9efa676eaba028fac7f0339e1e478b409c039c540f7a63a3c8c8a5ed2946985e80e616cdf6aaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dde6a9d001b8806245c4f23e3a457f6812809ecbfac8ea516eb55f4a8f3d3005de079fdbab892cba5eb1bbf7bd620e0250d1c2476c07c2453fda350fc7ebe321"} 13:26:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:26:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:26:06 INFO - Contents: 13:26:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6a6e44e20f62677c15b3aa79f787cee585ad014b8d16b1074eab1475b36834a75b5b26f67f3bf022049a7f202c4548cc822521ae7c81bf7f30341a6776e0b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6928711d2ab8ff0c5c86d129e76dcb33eac590d8f52536cb6bce49265ca7088e202a88a3cfe0a19034575a5632be0421feb5bf2a2956e03ff48f17923ea98b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd16b5dd52a989c26e034fd1492e1d7583b90a78f4c983d0fd9efa676eaba028fac7f0339e1e478b409c039c540f7a63a3c8c8a5ed2946985e80e616cdf6aaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dde6a9d001b8806245c4f23e3a457f6812809ecbfac8ea516eb55f4a8f3d3005de079fdbab892cba5eb1bbf7bd620e0250d1c2476c07c2453fda350fc7ebe321"} 13:26:06 INFO - Running post-run listener: copy_logs_to_upload_dir 13:26:06 INFO - Copying logs to upload dir... 13:26:06 INFO - mkdir: /builds/slave/test/build/upload/logs 13:26:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.574121 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-29 13:26:06.967359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 13:26:06.970634) ========= 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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6a6e44e20f62677c15b3aa79f787cee585ad014b8d16b1074eab1475b36834a75b5b26f67f3bf022049a7f202c4548cc822521ae7c81bf7f30341a6776e0b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6928711d2ab8ff0c5c86d129e76dcb33eac590d8f52536cb6bce49265ca7088e202a88a3cfe0a19034575a5632be0421feb5bf2a2956e03ff48f17923ea98b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd16b5dd52a989c26e034fd1492e1d7583b90a78f4c983d0fd9efa676eaba028fac7f0339e1e478b409c039c540f7a63a3c8c8a5ed2946985e80e616cdf6aaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dde6a9d001b8806245c4f23e3a457f6812809ecbfac8ea516eb55f4a8f3d3005de079fdbab892cba5eb1bbf7bd620e0250d1c2476c07c2453fda350fc7ebe321"} build_url:https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/MmJS4aPWT-u5hrNt0dIsqg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa6a6e44e20f62677c15b3aa79f787cee585ad014b8d16b1074eab1475b36834a75b5b26f67f3bf022049a7f202c4548cc822521ae7c81bf7f30341a6776e0b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6928711d2ab8ff0c5c86d129e76dcb33eac590d8f52536cb6bce49265ca7088e202a88a3cfe0a19034575a5632be0421feb5bf2a2956e03ff48f17923ea98b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cd16b5dd52a989c26e034fd1492e1d7583b90a78f4c983d0fd9efa676eaba028fac7f0339e1e478b409c039c540f7a63a3c8c8a5ed2946985e80e616cdf6aaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dde6a9d001b8806245c4f23e3a457f6812809ecbfac8ea516eb55f4a8f3d3005de079fdbab892cba5eb1bbf7bd620e0250d1c2476c07c2453fda350fc7ebe321"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 13:26:07.006112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:26:07.006444) ========= 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.EPyc60UHgW/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.Wx7yZ7fp6O/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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.005124 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 13:26:07.055008) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 13:26:07.055329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 13:26:07.055660) ========= ========= Total master_lag: 0.19 =========