builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0250 starttime: 1492508287.26 results: success (0) buildid: 20170418012246 builduid: 98394671db5541e0afabefcf63977ff6 revision: bb38d935d699e0529f9e0bb35578d381026415c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.257900) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.258344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.258626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.286049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.286808) ========= 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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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-18 02:38:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-04-18 02:38:07 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.459926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.460259) ========= 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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.025952 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:07.508635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 02:38:07.508970) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb38d935d699e0529f9e0bb35578d381026415c4 --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 bb38d935d699e0529f9e0bb35578d381026415c4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.APh6gB2Q0J/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.UTLWZf1JAV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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-18 02:38:07,614 truncating revision to first 12 chars 2017-04-18 02:38:07,614 Setting DEBUG logging. 2017-04-18 02:38:07,614 attempt 1/10 2017-04-18 02:38:07,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb38d935d699?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 02:38:09,347 unpacking tar archive at: mozilla-central-bb38d935d699/testing/mozharness/ program finished with exit code 0 elapsedTime=2.022883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 02:38:09.555593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:09.555952) ========= script_repo_revision: bb38d935d699e0529f9e0bb35578d381026415c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:09.556433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:09.556750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:38:09.576724) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-18 02:38:09.577080) ========= /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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:38:09 INFO - MultiFileLogger online at 20170418 02:38:09 in /builds/slave/test 02:38:09 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 02:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:09 INFO - {'append_to_log': False, 02:38:09 INFO - 'base_work_dir': '/builds/slave/test', 02:38:09 INFO - 'blob_upload_branch': 'Firefox', 02:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:09 INFO - 'branch': 'Firefox', 02:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:09 INFO - 'config_files': ('talos/mac_config.py',), 02:38:09 INFO - 'default_actions': ('clobber', 02:38:09 INFO - 'read-buildbot-config', 02:38:09 INFO - 'download-and-extract', 02:38:09 INFO - 'populate-webroot', 02:38:09 INFO - 'create-virtualenv', 02:38:09 INFO - 'install', 02:38:09 INFO - 'run-tests'), 02:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:09 INFO - 'download_minidump_stackwalk': True, 02:38:09 INFO - 'download_symbols': 'ondemand', 02:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:09 INFO - 'gecko_profile': False, 02:38:09 INFO - 'gecko_profile_interval': 0, 02:38:09 INFO - 'installer_path': 'installer.exe', 02:38:09 INFO - 'log_level': 'info', 02:38:09 INFO - 'log_name': 'talos', 02:38:09 INFO - 'log_to_console': True, 02:38:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:38:09 INFO - 'opt_config_files': (), 02:38:09 INFO - 'pip_index': False, 02:38:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:09 INFO - 'cmd': ('bash', 02:38:09 INFO - '-c', 02:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:09 INFO - 'enabled': True, 02:38:09 INFO - 'halt_on_failure': False, 02:38:09 INFO - 'name': 'check_screen_resolution'},), 02:38:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:38:09 INFO - 'cmd': ('bash', 02:38:09 INFO - '-c', 02:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:38:09 INFO - 'enabled': True, 02:38:09 INFO - 'halt_on_failure': False, 02:38:09 INFO - 'name': 'check_screen_resolution'},), 02:38:09 INFO - 'run_cmd_checks_enabled': True, 02:38:09 INFO - 'suite': 'dromaeojs-e10s', 02:38:09 INFO - 'system_bits': '32', 02:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:09 INFO - 'title': 't-yosemite-r7-0250', 02:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:09 INFO - 'use_talos_json': True, 02:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:09 INFO - 'work_dir': 'build'} 02:38:09 INFO - [mozharness: 2017-04-18 09:38:09.789326Z] Running clobber step. 02:38:09 INFO - Running pre-action listener: _resource_record_pre_action 02:38:09 INFO - Running main action method: clobber 02:38:09 INFO - rmtree: /builds/slave/test/build 02:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:12 INFO - Running post-action listener: _resource_record_post_action 02:38:12 INFO - [mozharness: 2017-04-18 09:38:12.273779Z] Finished clobber step (success) 02:38:12 INFO - [mozharness: 2017-04-18 09:38:12.273944Z] Running read-buildbot-config step. 02:38:12 INFO - Running pre-action listener: _resource_record_pre_action 02:38:12 INFO - Running main action method: read_buildbot_config 02:38:12 INFO - Using buildbot properties: 02:38:12 INFO - { 02:38:12 INFO - "project": "", 02:38:12 INFO - "product": "firefox", 02:38:12 INFO - "script_repo_revision": "production", 02:38:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:38:12 INFO - "repository": "", 02:38:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:38:12 INFO - "buildid": "20170418012246", 02:38:12 INFO - "pgo_build": "False", 02:38:12 INFO - "basedir": "/builds/slave/test", 02:38:12 INFO - "buildnumber": 14, 02:38:12 INFO - "slavename": "t-yosemite-r7-0250", 02:38:12 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:38:12 INFO - "platform": "yosemite_r7", 02:38:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:38:12 INFO - "branch": "mozilla-central", 02:38:12 INFO - "repo_path": "mozilla-central", 02:38:12 INFO - "revision": "bb38d935d699e0529f9e0bb35578d381026415c4", 02:38:12 INFO - "stage_platform": "macosx64", 02:38:12 INFO - "builduid": "98394671db5541e0afabefcf63977ff6", 02:38:12 INFO - "slavebuilddir": "test" 02:38:12 INFO - } 02:38:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:38:12 INFO - Running post-action listener: _resource_record_post_action 02:38:12 INFO - [mozharness: 2017-04-18 09:38:12.277278Z] Finished read-buildbot-config step (success) 02:38:12 INFO - [mozharness: 2017-04-18 09:38:12.277379Z] Running download-and-extract step. 02:38:12 INFO - Running pre-action listener: _resource_record_pre_action 02:38:12 INFO - Running main action method: download_and_extract 02:38:12 INFO - mkdir: /builds/slave/test/build/tests 02:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:12 INFO - trying https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:38:12 INFO - Downloading https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/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 02:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/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 02:38:13 INFO - Downloaded 1325 bytes. 02:38:13 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:38:13 INFO - Using the following test package requirements: 02:38:13 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:38:13 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:38:13 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:38:13 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:38:13 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'jsshell-mac.zip'], 02:38:13 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:38:13 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:38:13 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:38:13 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:38:13 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:38:13 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:38:13 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:38:13 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:38:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:38:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:38:13 INFO - Fetch https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:38:15 INFO - Expected file size: 52635597 02:38:15 INFO - Obtained file size: 52635597 02:38:31 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 02:38:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:38:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:38:31 INFO - Fetch https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:38:33 INFO - Expected file size: 52635597 02:38:33 INFO - Obtained file size: 52635597 02:38:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:38:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:38:48 INFO - Fetch https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:38:49 INFO - Expected file size: 14408802 02:38:49 INFO - Obtained file size: 14408802 02:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:49 INFO - trying https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:38:49 INFO - Downloading https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/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 02:38:51 INFO - Downloaded 71364059 bytes. 02:38:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:38:51 INFO - mkdir: /builds/slave/test/properties 02:38:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:51 INFO - Contents: 02:38:51 INFO - build_url:https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:38:52 INFO - Running post-action listener: _resource_record_post_action 02:38:52 INFO - Running post-action listener: set_extra_try_arguments 02:38:52 INFO - [mozharness: 2017-04-18 09:38:52.517743Z] Finished download-and-extract step (success) 02:38:52 INFO - [mozharness: 2017-04-18 09:38:52.517875Z] Running populate-webroot step. 02:38:52 INFO - Running pre-action listener: _resource_record_pre_action 02:38:52 INFO - Running main action method: populate_webroot 02:38:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:52 INFO - '--tppagecycles', 02:38:52 INFO - '7'], 02:38:52 INFO - 'tests': ['tsvgm']}}, 02:38:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:38:52 INFO - 'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:38:52 INFO - 'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['damp', 'tps']}, 02:38:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:38:52 INFO - 'tests': ['damp', 'tps']}, 02:38:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['dromaeo_dom']}, 02:38:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:38:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:38:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['a11yr', 02:38:52 INFO - 'ts_paint', 02:38:52 INFO - 'tpaint', 02:38:52 INFO - 'sessionrestore', 02:38:52 INFO - 'sessionrestore_no_auto_restore', 02:38:52 INFO - 'tabpaint']}, 02:38:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:52 INFO - 'ts_paint', 02:38:52 INFO - 'tpaint', 02:38:52 INFO - 'sessionrestore', 02:38:52 INFO - 'sessionrestore_no_auto_restore', 02:38:52 INFO - 'tabpaint']}, 02:38:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:38:52 INFO - 'ts_paint', 02:38:52 INFO - 'tpaint', 02:38:52 INFO - 'sessionrestore', 02:38:52 INFO - 'sessionrestore_no_auto_restore', 02:38:52 INFO - 'tabpaint']}, 02:38:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:38:52 INFO - 'ts_paint', 02:38:52 INFO - 'tpaint', 02:38:52 INFO - 'sessionrestore', 02:38:52 INFO - 'sessionrestore_no_auto_restore', 02:38:52 INFO - 'tabpaint']}, 02:38:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['a11yr', 02:38:52 INFO - 'ts_paint', 02:38:52 INFO - 'tpaint', 02:38:52 INFO - 'sessionrestore', 02:38:52 INFO - 'sessionrestore_no_auto_restore', 02:38:52 INFO - 'tabpaint']}, 02:38:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['a11yr', 02:38:52 INFO - 'ts_paint', 02:38:52 INFO - 'tpaint', 02:38:52 INFO - 'sessionrestore', 02:38:52 INFO - 'sessionrestore_no_auto_restore', 02:38:52 INFO - 'tabpaint']}, 02:38:52 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:38:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:38:52 INFO - 'bloom_basic_ref']}, 02:38:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['tsvgx', 02:38:52 INFO - 'tsvgr_opacity', 02:38:52 INFO - 'tart', 02:38:52 INFO - 'tscrollx', 02:38:52 INFO - 'cart', 02:38:52 INFO - 'tsvg_static']}, 02:38:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:52 INFO - 'tsvgr_opacity', 02:38:52 INFO - 'tart', 02:38:52 INFO - 'tscrollx', 02:38:52 INFO - 'cart', 02:38:52 INFO - 'tsvg_static']}, 02:38:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:38:52 INFO - 'talos_options': ['--disable-e10s'], 02:38:52 INFO - 'tests': ['tp5o']}, 02:38:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:38:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:38:52 INFO - 'talos_options': ['--disable-e10s', 02:38:52 INFO - '--xperf_path', 02:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:52 INFO - 'tests': ['tp5n']}, 02:38:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:38:52 INFO - 'talos_options': ['--xperf_path', 02:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:52 INFO - 'tests': ['tp5n']}}, 02:38:52 INFO - 'talos.zip': {'path': '', 02:38:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:52 INFO - Running post-action listener: _resource_record_post_action 02:38:52 INFO - [mozharness: 2017-04-18 09:38:52.537097Z] Finished populate-webroot step (success) 02:38:52 INFO - [mozharness: 2017-04-18 09:38:52.537234Z] Running create-virtualenv step. 02:38:52 INFO - Running pre-action listener: _resource_record_pre_action 02:38:52 INFO - Running main action method: create_virtualenv 02:38:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:38:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:52 INFO - Using real prefix '/tools/python27' 02:38:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:56 INFO - Installing pip.................done. 02:38:56 INFO - Return code: 0 02:38:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:38:56 INFO - Reading from file tmpfile_stdout 02:38:56 INFO - Output received: 02:38:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:38:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:57 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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:38:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:38:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:38:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:57 INFO - 'HOME': '/Users/cltbld', 02:38:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:57 INFO - 'LOGNAME': 'cltbld', 02:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:57 INFO - 'MOZ_NO_REMOTE': '1', 02:38:57 INFO - 'NO_EM_RESTART': '1', 02:38:57 INFO - 'PAGER': '/bin/cat', 02:38:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:57 INFO - 'PWD': '/builds/slave/test', 02:38:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:57 INFO - 'SHELL': '/bin/bash', 02:38:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:38:57 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:38:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:57 INFO - 'USER': 'cltbld', 02:38:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:57 INFO - 'XPC_FLAGS': '0x0', 02:38:57 INFO - 'XPC_SERVICE_NAME': '0', 02:38:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:38:57 INFO - Cleaning up... 02:38:57 INFO - Return code: 0 02:38:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:58 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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:58 INFO - 'HOME': '/Users/cltbld', 02:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:58 INFO - 'LOGNAME': 'cltbld', 02:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:58 INFO - 'MOZ_NO_REMOTE': '1', 02:38:58 INFO - 'NO_EM_RESTART': '1', 02:38:58 INFO - 'PAGER': '/bin/cat', 02:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:58 INFO - 'PWD': '/builds/slave/test', 02:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:58 INFO - 'SHELL': '/bin/bash', 02:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:38:58 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:58 INFO - 'USER': 'cltbld', 02:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:58 INFO - 'XPC_FLAGS': '0x0', 02:38:58 INFO - 'XPC_SERVICE_NAME': '0', 02:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:58 INFO - Downloading/unpacking psutil>=3.1.1 02:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:02 INFO - Installing collected packages: psutil 02:39:02 INFO - Running setup.py install for psutil 02:39:02 INFO - building 'psutil._psutil_osx' extension 02:39:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:39:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:39:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:39:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:39:03 INFO - building 'psutil._psutil_posix' extension 02:39:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:39:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:39:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:39:03 INFO - ^ 02:39:03 INFO - 1 warning generated. 02:39:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:39:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:03 INFO - Successfully installed psutil 02:39:03 INFO - Cleaning up... 02:39:03 INFO - Return code: 0 02:39:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:03 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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:03 INFO - 'HOME': '/Users/cltbld', 02:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:03 INFO - 'LOGNAME': 'cltbld', 02:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:03 INFO - 'MOZ_NO_REMOTE': '1', 02:39:03 INFO - 'NO_EM_RESTART': '1', 02:39:03 INFO - 'PAGER': '/bin/cat', 02:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:03 INFO - 'PWD': '/builds/slave/test', 02:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:03 INFO - 'SHELL': '/bin/bash', 02:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:03 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:03 INFO - 'USER': 'cltbld', 02:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:03 INFO - 'XPC_FLAGS': '0x0', 02:39:03 INFO - 'XPC_SERVICE_NAME': '0', 02:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:06 INFO - Installing collected packages: mozsystemmonitor 02:39:06 INFO - Running setup.py install for mozsystemmonitor 02:39:06 INFO - Successfully installed mozsystemmonitor 02:39:06 INFO - Cleaning up... 02:39:06 INFO - Return code: 0 02:39:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:06 INFO - 'HOME': '/Users/cltbld', 02:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:06 INFO - 'LOGNAME': 'cltbld', 02:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:06 INFO - 'MOZ_NO_REMOTE': '1', 02:39:06 INFO - 'NO_EM_RESTART': '1', 02:39:06 INFO - 'PAGER': '/bin/cat', 02:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:06 INFO - 'PWD': '/builds/slave/test', 02:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:06 INFO - 'SHELL': '/bin/bash', 02:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:06 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:06 INFO - 'USER': 'cltbld', 02:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:06 INFO - 'XPC_FLAGS': '0x0', 02:39:06 INFO - 'XPC_SERVICE_NAME': '0', 02:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:09 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:09 INFO - warning: no files found matching '*.txt' 02:39:09 INFO - no previously-included directories found matching 'build' 02:39:09 INFO - no previously-included directories found matching 'dist' 02:39:09 INFO - no previously-included directories found matching '.git*' 02:39:09 INFO - Installing collected packages: jsonschema, functools32 02:39:10 INFO - Running setup.py install for functools32 02:39:10 INFO - warning: no files found matching '*.txt' 02:39:10 INFO - no previously-included directories found matching 'build' 02:39:10 INFO - no previously-included directories found matching 'dist' 02:39:10 INFO - no previously-included directories found matching '.git*' 02:39:10 INFO - Successfully installed jsonschema functools32 02:39:10 INFO - Cleaning up... 02:39:10 INFO - Return code: 0 02:39:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:10 INFO - 'HOME': '/Users/cltbld', 02:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:10 INFO - 'LOGNAME': 'cltbld', 02:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:10 INFO - 'MOZ_NO_REMOTE': '1', 02:39:10 INFO - 'NO_EM_RESTART': '1', 02:39:10 INFO - 'PAGER': '/bin/cat', 02:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:10 INFO - 'PWD': '/builds/slave/test', 02:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:10 INFO - 'SHELL': '/bin/bash', 02:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:10 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:10 INFO - 'USER': 'cltbld', 02:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:10 INFO - 'XPC_FLAGS': '0x0', 02:39:10 INFO - 'XPC_SERVICE_NAME': '0', 02:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:39:10 INFO - Cleaning up... 02:39:10 INFO - Return code: 0 02:39:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:10 INFO - 'HOME': '/Users/cltbld', 02:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:10 INFO - 'LOGNAME': 'cltbld', 02:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:10 INFO - 'MOZ_NO_REMOTE': '1', 02:39:10 INFO - 'NO_EM_RESTART': '1', 02:39:10 INFO - 'PAGER': '/bin/cat', 02:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:10 INFO - 'PWD': '/builds/slave/test', 02:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:10 INFO - 'SHELL': '/bin/bash', 02:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:10 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:10 INFO - 'USER': 'cltbld', 02:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:10 INFO - 'XPC_FLAGS': '0x0', 02:39:10 INFO - 'XPC_SERVICE_NAME': '0', 02:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:14 INFO - Downloading docopt-0.6.1.tar.gz 02:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:14 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:14 INFO - Running setup.py install for blobuploader 02:39:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:14 INFO - Running setup.py install for requests 02:39:15 INFO - Running setup.py install for docopt 02:39:15 INFO - Successfully installed blobuploader requests docopt 02:39:15 INFO - Cleaning up... 02:39:15 INFO - Return code: 0 02:39:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:15 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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:15 INFO - 'HOME': '/Users/cltbld', 02:39:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:15 INFO - 'LOGNAME': 'cltbld', 02:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:15 INFO - 'MOZ_NO_REMOTE': '1', 02:39:15 INFO - 'NO_EM_RESTART': '1', 02:39:15 INFO - 'PAGER': '/bin/cat', 02:39:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:15 INFO - 'PWD': '/builds/slave/test', 02:39:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:15 INFO - 'SHELL': '/bin/bash', 02:39:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:15 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:15 INFO - 'USER': 'cltbld', 02:39:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:15 INFO - 'XPC_FLAGS': '0x0', 02:39:15 INFO - 'XPC_SERVICE_NAME': '0', 02:39:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:15 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-i0IeD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:15 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-hTitZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-GBFBAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-W1Wrf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-txBupH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-hR9qHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-SQVf1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ei3BqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-9lWsmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Rslj1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-DHazgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:16 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-lh3vc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:17 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-oCwMk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:17 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-EVquIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:17 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-H8j5FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:17 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-LSVzbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:17 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ZXTz1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:17 INFO - Running setup.py install for manifestparser 02:39:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:17 INFO - Running setup.py install for mozcrash 02:39:17 INFO - Running setup.py install for mozdebug 02:39:18 INFO - Running setup.py install for mozdevice 02:39:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:18 INFO - Running setup.py install for mozfile 02:39:18 INFO - Running setup.py install for mozhttpd 02:39:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:18 INFO - Running setup.py install for mozinfo 02:39:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:18 INFO - Running setup.py install for mozInstall 02:39:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:18 INFO - Running setup.py install for mozleak 02:39:18 INFO - Running setup.py install for mozlog 02:39:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for moznetwork 02:39:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for mozprocess 02:39:19 INFO - Running setup.py install for mozprofile 02:39:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for mozrunner 02:39:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for mozscreenshot 02:39:19 INFO - Running setup.py install for moztest 02:39:19 INFO - Running setup.py install for mozversion 02:39:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:20 INFO - Cleaning up... 02:39:20 INFO - Return code: 0 02:39:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:20 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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:20 INFO - 'HOME': '/Users/cltbld', 02:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:20 INFO - 'LOGNAME': 'cltbld', 02:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:20 INFO - 'MOZ_NO_REMOTE': '1', 02:39:20 INFO - 'NO_EM_RESTART': '1', 02:39:20 INFO - 'PAGER': '/bin/cat', 02:39:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:20 INFO - 'PWD': '/builds/slave/test', 02:39:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:20 INFO - 'SHELL': '/bin/bash', 02:39:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:20 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:20 INFO - 'USER': 'cltbld', 02:39:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:20 INFO - 'XPC_FLAGS': '0x0', 02:39:20 INFO - 'XPC_SERVICE_NAME': '0', 02:39:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:20 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-swRDTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:20 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-M5i_AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:20 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-p5kFYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:20 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-m3ttI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:20 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)) 02:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:20 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-duI2EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:20 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-a8YKER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Cs5sZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-NbZ4KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-evQUf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-DgiCeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-EAFC1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-V58hsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-2OiM15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-p5BgTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Dh4tlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:21 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-uLzmy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:22 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-PNDkB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:39:22 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)) 02:39:22 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)) 02:39:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:24 INFO - Downloading blessings-1.6.tar.gz 02:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:24 INFO - Installing collected packages: blessings 02:39:24 INFO - Running setup.py install for blessings 02:39:25 INFO - Successfully installed blessings 02:39:25 INFO - Cleaning up... 02:39:25 INFO - Return code: 0 02:39:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:25 INFO - Reading from file tmpfile_stdout 02:39:25 INFO - Current package versions: 02:39:25 INFO - blessings == 1.6 02:39:25 INFO - blobuploader == 1.2.4 02:39:25 INFO - docopt == 0.6.1 02:39:25 INFO - functools32 == 3.2.3-2 02:39:25 INFO - jsonschema == 2.5.1 02:39:25 INFO - manifestparser == 1.1 02:39:25 INFO - mozInstall == 1.12 02:39:25 INFO - mozcrash == 1.0 02:39:25 INFO - mozdebug == 0.1 02:39:25 INFO - mozdevice == 0.50 02:39:25 INFO - mozfile == 1.2 02:39:25 INFO - mozhttpd == 0.7 02:39:25 INFO - mozinfo == 0.9 02:39:25 INFO - mozleak == 0.1 02:39:25 INFO - mozlog == 3.4 02:39:25 INFO - moznetwork == 0.27 02:39:25 INFO - mozprocess == 0.25 02:39:25 INFO - mozprofile == 0.28 02:39:25 INFO - mozrunner == 6.13 02:39:25 INFO - mozscreenshot == 0.1 02:39:25 INFO - mozsystemmonitor == 0.3 02:39:25 INFO - moztest == 0.8 02:39:25 INFO - mozversion == 1.4 02:39:25 INFO - psutil == 3.1.1 02:39:25 INFO - requests == 1.2.3 02:39:25 INFO - wsgiref == 0.1.2 02:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:25 INFO - 'HOME': '/Users/cltbld', 02:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:25 INFO - 'LOGNAME': 'cltbld', 02:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:25 INFO - 'MOZ_NO_REMOTE': '1', 02:39:25 INFO - 'NO_EM_RESTART': '1', 02:39:25 INFO - 'PAGER': '/bin/cat', 02:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:25 INFO - 'PWD': '/builds/slave/test', 02:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:25 INFO - 'SHELL': '/bin/bash', 02:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:25 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:25 INFO - 'USER': 'cltbld', 02:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:25 INFO - 'XPC_FLAGS': '0x0', 02:39:25 INFO - 'XPC_SERVICE_NAME': '0', 02:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:39:25 INFO - Cleaning up... 02:39:25 INFO - Return code: 0 02:39:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 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 0x103cbeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a048b4c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, '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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:25 INFO - 'HOME': '/Users/cltbld', 02:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:25 INFO - 'LOGNAME': 'cltbld', 02:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:25 INFO - 'MOZ_NO_REMOTE': '1', 02:39:25 INFO - 'NO_EM_RESTART': '1', 02:39:25 INFO - 'PAGER': '/bin/cat', 02:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:25 INFO - 'PWD': '/builds/slave/test', 02:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:25 INFO - 'SHELL': '/bin/bash', 02:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:25 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:25 INFO - 'USER': 'cltbld', 02:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:25 INFO - 'XPC_FLAGS': '0x0', 02:39:25 INFO - 'XPC_SERVICE_NAME': '0', 02:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:39:26 INFO - Cleaning up... 02:39:26 INFO - Return code: 0 02:39:26 INFO - Running post-action listener: _resource_record_post_action 02:39:26 INFO - Running post-action listener: _start_resource_monitoring 02:39:26 INFO - Starting resource monitoring. 02:39:26 INFO - [mozharness: 2017-04-18 09:39:26.085852Z] Finished create-virtualenv step (success) 02:39:26 INFO - [mozharness: 2017-04-18 09:39:26.086845Z] Running install step. 02:39:26 INFO - Running pre-action listener: _resource_record_pre_action 02:39:26 INFO - Running main action method: install 02:39:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:26 INFO - Reading from file tmpfile_stdout 02:39:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:26 INFO - Reading from file tmpfile_stdout 02:39:26 INFO - Output received: 02:39:26 INFO - Usage: mozinstall [options] installer 02:39:26 INFO - Options: 02:39:26 INFO - -h, --help show this help message and exit 02:39:26 INFO - -d DEST, --destination=DEST 02:39:26 INFO - Directory to install application into. [default: 02:39:26 INFO - "/builds/slave/test"] 02:39:26 INFO - --app=APP Application being installed. [default: firefox] 02:39:26 INFO - mkdir: /builds/slave/test/build/application 02:39:26 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'] 02:39:26 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 02:39:45 INFO - Reading from file tmpfile_stdout 02:39:45 INFO - Output received: 02:39:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:39:45 INFO - Running post-action listener: _resource_record_post_action 02:39:45 INFO - [mozharness: 2017-04-18 09:39:45.985130Z] Finished install step (success) 02:39:45 INFO - [mozharness: 2017-04-18 09:39:45.985282Z] Running run-tests step. 02:39:45 INFO - Running pre-action listener: _resource_record_pre_action 02:39:45 INFO - Running main action method: run_tests 02:39:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:39:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:39:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:39:46 INFO - 2017-04-18 02:39:45.999 screenresolution[1617:7352] starting screenresolution argv=screenresolution get 02:39:46 INFO - 2017-04-18 02:39:46.002 screenresolution[1617:7352] Display 0: 1600x1200x32@60 02:39:46 INFO - 2017-04-18 02:39:46.008 screenresolution[1618:7355] starting screenresolution argv=screenresolution list 02:39:46 INFO - Available Modes on Display 0 02:39:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:39:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:39:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:39:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:39:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:39:46 INFO - Intel Iris: 02:39:46 INFO - Chipset Model: Intel Iris 02:39:46 INFO - Type: GPU 02:39:46 INFO - Bus: Built-In 02:39:46 INFO - VRAM (Dynamic, Max): 1536 MB 02:39:46 INFO - Vendor: Intel (0x8086) 02:39:46 INFO - Device ID: 0x0a2e 02:39:46 INFO - Revision ID: 0x0009 02:39:46 INFO - Displays: 02:39:46 INFO - Display: 02:39:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:39:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:39:46 INFO - Display Serial Number: 1600x1200 60 02:39:46 INFO - Main Display: Yes 02:39:46 INFO - Mirror: Off 02:39:46 INFO - Online: Yes 02:39:46 INFO - Rotation: Supported 02:39:46 INFO - Return code: 0 02:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:46 INFO - Python 2.7.3 02:39:46 INFO - Return code: 0 02:39:46 INFO - grabbing minidump binary from tooltool 02:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:46 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 0x103a9cd30>, '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 0x1039c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a91be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:39:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:39:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:39:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:46 INFO - Return code: 0 02:39:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:39:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:46 INFO - ENV: RUST_BACKTRACE is now 1 02:39:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:39:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:46 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/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 02:39:46 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/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0250 --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 02:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.APh6gB2Q0J/Render', 02:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:46 INFO - 'HOME': '/Users/cltbld', 02:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:46 INFO - 'LOGNAME': 'cltbld', 02:39:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:46 INFO - 'MOZ_NO_REMOTE': '1', 02:39:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:46 INFO - 'NO_EM_RESTART': '1', 02:39:46 INFO - 'PAGER': '/bin/cat', 02:39:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:46 INFO - 'PWD': '/builds/slave/test', 02:39:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:46 INFO - 'RUST_BACKTRACE': '1', 02:39:46 INFO - 'SHELL': '/bin/bash', 02:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UTLWZf1JAV/Listeners', 02:39:46 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 02:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:46 INFO - 'USER': 'cltbld', 02:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:46 INFO - 'XPC_FLAGS': '0x0', 02:39:46 INFO - 'XPC_SERVICE_NAME': '0', 02:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:46 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/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 02:39:46 INFO - mozversion application_buildid: 20170418012246 02:39:46 INFO - mozversion application_changeset: bb38d935d699e0529f9e0bb35578d381026415c4 02:39:46 INFO - mozversion application_display_name: Nightly 02:39:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:46 INFO - mozversion application_name: Firefox 02:39:46 INFO - mozversion application_remotingname: firefox 02:39:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:39:46 INFO - mozversion application_vendor: Mozilla 02:39:46 INFO - mozversion application_version: 55.0a1 02:39:46 INFO - mozversion platform_buildid: 20170418012246 02:39:46 INFO - mozversion platform_changeset: bb38d935d699e0529f9e0bb35578d381026415c4 02:39:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:39:46 INFO - mozversion platform_version: 55.0a1 02:39:46 INFO - using testdate: 1492508386 02:39:46 INFO - actual date: 1492508386 02:39:46 INFO - starting webserver on 'localhost:49238' 02:39:46 INFO - SUITE-START | Running 2 tests 02:39:46 INFO - TEST-START | dromaeo_css 02:39:46 INFO - operating with platform_type : mac_ 02:39:46 INFO - Initialising browser for dromaeo_css test... 02:39:46 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpox_Gnt/profile http://localhost:49238/getInfo.html) 02:39:49 INFO - PID 1628 | 2017-04-18 02:39:49.375 plugin-container[1630:7546] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 02:39:49 INFO - PID 1628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:39:49 INFO - PID 1628 | 2017-04-18 02:39:49.379 plugin-container[1630:7546] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 02:39:49 INFO - PID 1628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:39:49 INFO - PID 1628 | 2017-04-18 02:39:49.379 plugin-container[1630:7546] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:39:49 INFO - PID 1628 | __metrics Screen width/height:1600/1200 02:39:49 INFO - PID 1628 | colorDepth:24 02:39:49 INFO - PID 1628 | Browser inner width/height: 1024/689 02:39:49 INFO - PID 1628 | __metrics 02:39:49 ERROR - PID 1628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 02:39:50 INFO - TEST-INFO | 1628: exit 0 02:39:50 INFO - Browser initialized. 02:39:50 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:50 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpox_Gnt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:52 INFO - PID 1631 | 2017-04-18 02:39:52.884 plugin-container[1632:7678] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882b, name = 'com.apple.tsm.portname' 02:39:52 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:39:52 INFO - PID 1631 | 2017-04-18 02:39:52.885 plugin-container[1632:7678] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 02:39:52 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:39:52 INFO - PID 1631 | 2017-04-18 02:39:52.885 plugin-container[1632:7678] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:40:02 INFO - PID 1631 | RSS: Main: 236036096 02:40:02 INFO - PID 1631 | 02:43:06 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 02:43:08 INFO - PID 1631 | RSS: Main: 254296064 02:43:08 INFO - PID 1631 | 02:44:50 INFO - PID 1631 | ************************* 02:44:50 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 02:44:50 INFO - PID 1631 | 02:44:50 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:44:50 INFO - PID 1631 | Full stack: 02:44:50 INFO - PID 1631 | ************************* 02:44:50 INFO - PID 1631 | ************************* 02:44:50 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 02:44:50 INFO - PID 1631 | 02:44:50 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:44:50 INFO - PID 1631 | Full stack: 02:44:50 INFO - PID 1631 | ************************* 02:44:50 INFO - PID 1631 | ************************* 02:44:50 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 02:44:50 INFO - PID 1631 | 02:44:50 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:44:50 INFO - PID 1631 | Full stack: 02:44:50 INFO - PID 1631 | ************************* 02:44:50 INFO - PID 1631 | ************************* 02:44:50 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 02:44:50 INFO - PID 1631 | 02:44:50 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:44:50 INFO - PID 1631 | Full stack: 02:44:50 INFO - PID 1631 | ************************* 02:46:10 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 02:46:10 INFO - PID 1631 | RSS: Main: 258863104 02:46:10 INFO - PID 1631 | 02:49:12 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 02:49:13 INFO - PID 1631 | RSS: Main: 267784192 02:49:13 INFO - PID 1631 | 02:52:14 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 02:52:15 INFO - PID 1631 | RSS: Main: 260722688 02:52:15 INFO - PID 1631 | 02:55:18 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 02:55:19 INFO - PID 1631 | RSS: Main: 268505088 02:55:19 INFO - PID 1631 | 02:58:20 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 02:58:21 INFO - PID 1631 | RSS: Main: 264323072 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | __start_tp_report 02:58:21 INFO - PID 1631 | _x_x_mozilla_page_load 02:58:21 INFO - PID 1631 | _x_x_mozilla_page_load_details 02:58:21 INFO - PID 1631 | |i|pagename|runs| 02:58:21 INFO - PID 1631 | |0;dojo.html;3570.0896271450774;3587.7847329160245;3598.7300952428573;3621.9456708149373;3643.325984692832;6141.332587233701;6264.5928014679075;6270.717817698203;6273.874522509547;6309.11672365868;4972.980538989507;6207.255129384469;6219.875602487948;6247.406496382836;6309.62142271464;5484.61607687462;5512.173174023908;5532.585056120807;5562;5650.49145576898;4565.703229290086;5462.6995515246645;5528.474794894499;5562.582806289524;5598.356189038252;4809.663323567352;5089.6691715038405;5400.486953739389;5525.944740552583;5616.859578510529;5417.566594672417;5426.9185962210595;5442.183672449125;5454.209139674725;5459.153831156177;5431.158170483582;5445.891082178334;5446.455354464521;5455.454454554552;5478.45215478453;5543.861403464905;5701.916635839178;6272.372762723691;6291.402316779899;6292.930201865694;6392.55252132351;6535.281119076898;6681.298463661343;6687.665616719145;6722.462203023795;6717.462602991749;6763.661816909184;6803.659817009179;6823.1812182538415;6845.5550389224545;5194.428612852583;5286.81496147633;6309.4636955858805;6347.238331400262;6353.3329000455215;5791.305043394819;6600;6953.756618518328;6964.582125072512;6969.0940177776565;5468.28912241406;6378.266499352541;6511.186101737283;6585;6614.272430032693;6719.328067193242;6756.966215168893;6758.222804377461;6789.558678685869;6825.1809782825385;6586.670666466657;6640.136782218281;6662.900056499157;6684.86630267392;6704.564203326768;6466.353364663496;6559.245686746085;6670.199576050905;6722.226943901416;6750.797476075725;5375.489328513785;5376.193570964387;5386.218998245233;5390.838274851761;5397.298351214396;4767.356406885096;4779.474257831635;4785.856424307276;4789.233722604366;4794.304825800309;5830.38780928005;6078.179445774764;6304.085907543381;6304.464120549713;6335.461485773761;6747.831304217336;6771.356721111487;6855.828604284933;6858.794236172923;6871.5189936703955;6295.370462953668;6296.5592408531875;6314.210723659543;6314.431701146918;6317.894368485497;5782.277215348082;5914.290285165807;5970.641761494324;5983.581149319593;5999.580029397987;6798.04827324175;6818.829529261609;6846.349596788297;6880.105586273752;6898.448124150156;6551.4103730664465;6838.316168383122;6859.451243900576;6866.382025617719;6889.586624802528;5847.473727364558;6767.424768894502;6873.656317184221;6954.374106330454;6967.825804354931;6678.265390806911;6710.228323742832;6742.494312926452;6748;6753.358430949052;5305.018571564273;6434.260060092962;6517.543771936109;6573.474122070318;6740.494462915399;6496.545241833026;6589.736410543716;6597;6608.107905432705;6611.206655201407;6535.477161827138;6560.3111673273615;6579.309172536815;6581.80254592363;6601.075849381186;6184.6724646933035;6318.399752023734;6396.968015159894;6403.103565500741;6492.285848556749;6458.22501299847;6508.804735857742;6534.934650653623;6545.574537655038;6559.409653131241;6366.427021567896;6394.296627371078;6409.551331406757;6410.358964103552;6414.679266036586 02:58:21 INFO - PID 1631 | |1;ext.html;812.1431889356728;836.5106412748544;1076.8815430302661;1122.927009744367;1157.7337212441143;37348.62651373485;37916.67291644793;37962.430563541566;37966.4305035424;38020;37669.623303767024;37943.62056379436;38042.23915521688;38093.61906380942;38179.663711770096;7910.169432209607;8071.354291656653;8089.2315230053055;8243.299319557846;8478.78803029923;8546.871796923051;8623.95688021559;8639.265662418671;8650.134986501362;8688.131186881294;8644.351673624504;8693.7826554336;8698.695545655903;8701.434406763572;8707.172818582256;8641.222289993899;8647.697330593463;8673.869891951626;8676.826463470758;8685.348598855111;8508.574571271412;8513.702020429317;8554.05905350411;8564.143585641386;8592.613332400057;38278.42582361267;38292.80853595742;38463.423048654295;38565.843024709306;38620.5241528261;3561.3589553880292;3561.4835848801777;3595.227026189382;3602.7117830573493;3607.6572725591027;31012.689873101204;31151.37697246065;31170.688293117233;31208.751649933976;31361.215969600944;3116.174213833336;3138.0899539133625;3144.402563512925;3157.147570156068;3172.0642410488963;298051.0194898045;298116;299207;300398.4980075086;300797;40311.99220019523;40909.79545102255;48382.758086209345;50048.49951500438;50125;51411;51423.48576514262;51567.968640626976;51587.48412515902;51654;14504.637384065272;14652;14653.853461465462;14661;14687.706245875237;11685.006774424099;11728.354940478184;11733.296002239893;11736.413179340998;11771.587994420153;10195.133413659774;12291.815622765665;13858.307084645727;13865.237411942238;13993.860061399255;5943.970280148572;5982.192404025401;5999.700014999233;6002.09968504719;6008.369121242294;1020.3928662445833;1046.4140081554353;1049.4333060147435;1078.320657985464;1082.1451053667672;23126.074957001867;23177.3046808596;24362.634560481605;24421.877890610434;24493.775311234367;1141.2809929744208;1147.7417581044365;1176.917615766888;1186.4898093819568;1186.7745128425572;10933.234673572773;12441.502339906303;12472.189307694971;12504;12530.436130374155;304406;306617;306867;307728;309079;54200.72899635555;54578.90842183214;54749.178762318596;54772;54789;1523.405871710034;1530.556138719781;1563.9218039098;1572.1353255709314;1574.5827355750735;19682.80317196867;24032.51934961326;24189;24205.878970605034;24240;36247.45628815517;36677.899663010154;36701.63298367089;36741.26517469689;36941.07647308839;292109;294562;295549;295872;296812;34481;35074;35248.471272930416;35363.46954795629;35494.112647184025;44100.89747756332;45307.773461132485;45419.31871022003;45508.77245613751;45639.54360456486;28213.858930706036;29824.956126535468;29904.551431728978;30637.846810765805;31277.06168814939;29234;29937.80248790111;30560.235994100327;31310;31861.840690797326;36366.818165909004;36402.635973639924;36895.44656830096;36907.815460922524;37141.88574342774;26880.32799180036;29892.55161172541;30586.388272234875;31602.52596211013;31645.20886977844;20699.172033118506;24192.51614967726;24288.392790180387;24429;24645.01419943254 02:58:21 INFO - PID 1631 | |2;jquery.html;390.38514339914633;427.7369417808045;434.96302814260804;437.590852552863;459.42571785268416;19539.023048847554;21093;21745.23891663792;21991.890040549795;21998.560028799413;21864.23475178369;22699;23366.299011029652;23386.88306558469;23657.17199898004;6117.541184411176;6343.175387199681;6352.428281454668;6360.109584658151;6366.076918846765;6105.664188469633;6629.535932484728;6986.895196572055;7074.469414793885;7078.85842283154;6836.65816709165;7046.647667616624;7050.964745176293;7094.326039026284;7176.964115179417;6912.758053468155;7246.96376518114;7259.201487836333;7290.234525374813;7292.781216563485;6951.0616066830835;6998.720051197946;7009.929900700979;7020.227774944752;7023.297670232987;28226;29479.70520294791;29710.257243568867;29802.701972980427;30054.54918176229;2311.6185829338137;2364.9763502364926;2365.7042869641296;2368.1593034472858;2377.8335516513853;14921.403143874231;19004;19322.71015934762;19504.70742938857;19597.706034409497;2007.4178488238392;2117.6188286108495;2152.86974338472;2355.693759811231;2400.9399765006015;148748;150403;150690.24654876764;151665;155396;23731.288061358187;24620.876895615766;25992.610110848353;26073.217803465926;26349.604755928678;41134.794326028175;41172.58827411747;41184.588154118675;41288.96777580524;41297.587024129374;11320.150988675883;11453.713657158638;11551.364674942959;11656.242344247597;11875.990540803956;7371.631418429057;9028.548572571477;9077.636894524278;9200.079992000747;9284.25725941923;9573.32986690925;10427.270091093702;10795.56817727282;11561.768764624829;11875.881241187477;4419.248727716296;4573.715357823623;4618.745968971739;4707.340972263886;4732.810687572527;854.7563944275852;974.1184228273424;980.0346658541331;989.5942663507927;1008.193445243802;21174.258900938392;21438.356849294545;21621.459463513223;21634.459138521663;21797;1008.4907121903392;1021.9897801021895;1028.4343611013912;1034.3225187502198;1037.9117774989058;10251.58993640261;10732.624358147583;10957.890421095846;10977.890221097687;10994.725131871768;563574;579146;583284;622214;637269;133647;137876.31061844627;141297;141850;144815;1185.1170877696172;1185.7272827249608;1259.6661884600587;1269.3082270162968;1274.5602767045355;18144.18351174174;20339;20384;22611.773882260968;22868.542629146992;57800.71099644475;58050;58061.4193858056;59472;59807.70096149491;81905;83220.01359836859;84403;84615.15384846073;86802.56598716966;12545.686357841127;12649.873501265238;13231.933840331121;13479.98900082478;13549;11692.181547291608;14261.073030253001;14328.570142895729;14413.567592972227;14546.781798272823;11801.613981186954;12052;12164.148509604243;12288.078394120656;12309;10383.740406489898;11453.255538389978;11690.615399861195;11755.529778809094;11778.528858845893;11988.880111199125;12172.208806427554;12372.257664540157;12479.625611231677;12492.562760303346;13090.869091308965;13107.14803537767;13160.40778165004;13422.731545369234;13465.528706495617;11379.374134422686;11536.846315368395;12101.576444824388;12225;12307.138500304893 02:58:21 INFO - PID 1631 | |3;mootools.html;1289.8903593194577;1298.6428732098673;1403.1160368967548;1459.9926051024793;1486.3980088064332;11505.137114716399;11842.467088980995;12047.337396443192;12047.397630118481;12273.956713679325;10544.156467482602;11934.283942963428;12097.032237421006;12111.576094836682;12119.636410907664;2479.6404521344393;2480.7271200167966;2515.4717509323063;2521.1932181701864;2522.2937577478338;2434.379233295507;2486.8880900359527;2547.121243171103;2551.4641925195733;2558.2708927955537;2030.1371916935318;2215.4572129828134;2476.578981573137;2531.632913227581;2536.378587246127;2371.6679664846934;2376.6435034744754;2391.473875747333;2410.288964755401;2533.6832895888015;2410;2507.924762257135;2514.622806579028;2521.5587272227285;2530.5065512225124;11968.581099661556;12046.879531204751;12138.028957683453;12142.696432589168;12191.634250972396;6603.174603174603;6843.07618471505;6853.314668533107;6858.211305699859;6858.279880612564;4074.9185016299507;4319.43847299849;4373.934390984138;4398;4409.074094440171;1111.7331840358336;1259.7921342978398;1269.866664000276;1309.9672508187277;1311.9672008199775;16452.424165154163;16869.493915182564;17005.23476443563;17012.82987170137;17029.574260643458;4849.2968519565175;5675.971620141873;5759.308882934075;5922.703864806743;5927.673977931255;12395.442205100791;12455.314957677414;12487.31319777421;12492.437840297209;12523.436445359981;6617.9669101655145;6638.871391863395;6639.236487803868;6644.269130395653;6646.169228846395;6008.158857759917;6164.4143806338325;6186.907196392058;6223.719932603044;6274.090256912813;4377.409049778303;4488.640908727294;4494.07871386365;4512.503624601291;4524.841630542981;1302.3878776974807;1321.6101250131235;1325.0790700463278;1337.4516448256168;1340.2360654427077;762.8245503534218;769.4652216709334;785.9017622797151;792.9255858312019;798.8601994651029;6545.541812073109;6646.102776125162;6863.759768408082;6901.62041087745;6931.2375638679705;911.5897845969208;931.4550987672152;936.7283487788465;942.8585712143233;948.2129832239225;3591.5331006968927;3870.438786376016;3985.664802291207;4235.322348424237;4245.5542168072525;13511.864881351257;14069.226192559507;14796;15418.997765145454;15435;14832.777508337384;15042.774358384633;15126.39494420211;15289.541313760605;15323.387064517518;8626.00800907891;8641.654333826576;8780.78048048791;8805.911940880509;8881.73354799357;6831.6242606657115;6860.725570977304;6993.440524757905;7029.578225306498;7067.858642827217;13815.930920345334;13886.652833679238;14014.929925350309;14122.929385353007;14134.717305653623;13991.58025259244;14148.504802331869;14209.360578774187;14227.288635568388;14386.712265754835;8217.383696222687;9396.483193424427;9580;9813.067758562926;9830.852537211804;10871.239013268996;10885.945570272099;10888.183386245904;11031.724206894893;11039.012977663777;9218.124278193562;9290.860637090314;9368.812623747623;9378.67174648884;9401.952990235006;7549.471536992358;8903.955480222558;9108.772280693036;9150.816983660156;9286.767830804283;7967.163447837894;8119.3098586618435;8123.390745694215;8131.512109273463;8145.348372130097;5347.572194224531;5779.913301300399;5880.441358071148;5895.233619629592;6153.784617538365;5896.528277737856;5985.25184351956;6176;6184.319724830175;6330.208723909512 02:58:21 INFO - PID 1631 | |4;prototype.html;369.6303696303696;391.94316824060513;413.0726518964924;416.76452804165643;417.7013435393693;5924.407559244079;6176.536759743026;6345.143405640237;6369.840753981152;6380.9999999999945;6055.666938318402;6128.9387106128925;6181.567290289681;6196.628202307854;6196.690165491718;3801.638844309793;3956.327424337855;4560.726356418625;4580.595187526542;4598.333241679954;3849.7690138591774;3995.540512841017;4374.95001199713;4492.618127459154;4599.862004139881;3790.8248442982763;4444.355568442574;4487.977560112211;4504.7747612619405;4521.276595744682;4495.415595972519;4509.075639493896;4514.5936865681915;4533.705309154894;4547.567981041796;3747.1381582235967;3821.522309711286;3890.5720370759195;3897.649211570944;3912.667423268997;4480.820767169309;5090.414602320707;5411.512963833235;5463.863403414946;6032.909506357408;5384.838454846361;5400.405955344909;5420.728963551846;5438.428964958662;5444.767645265461;5105.595961110687;6540.215174179129;6601.458438501164;6642.4353929916015;6648.800535983928;4286.42133312002;4401.603855652975;4402.669799764998;4419.602235798793;4431.446069241345;6072.908906366408;6655.633940133291;6856.520043597;6896.827579310508;7015.263397343308;4138.944569134851;4239.448871646666;4481.977590112028;4499.730016199039;4512.488316414038;4028.879133625996;4423.871912662251;4583.954160458419;4588.885277868013;4622.2835460503675;5275.736213189325;5360.088784906575;5387.919181212285;5397.271368365299;5459.972700136474;6645.501587380966;6672.466202703772;6700.195976482756;6710.597364158166;6722.596644201363;1284.4091717809913;1535.786728484507;1553.4174684493314;1562.4843801545462;1566.4987204094807;1017.2624846985876;1025.0927928782933;1028.3315844701003;1029.6705054382526;1038.4703801061362;5083.61872859537;5764;6177.590739611555;6240.812775616739;6316.494680425555;6195.2255968004;6604.919450373117;6900.896486552706;6931.826704332432;6946.583205007716;6295.401936815995;6324.608586111048;6334;6379.840503987438;6394.552381333262;3089;3314.8839790607212;3496.4755286707195;3633.5458067741533;3643.0892276930767;6655.567388119756;7005.439564834801;7081.433485321162;7120.572765634079;7122.5726456412785;6295.842603934938;6833.180018397824;7097.989635855725;7132.393746531603;7175.677094530759;5895.7052147393315;5922.407759224129;7045.436365090678;7058.400035996998;7132.393746531499;5584.687598414288;6356.77751278703;6963.876017814413;6974.721011159497;6993.755218567326;6538.313477085027;6628.90056649141;6677.732890684319;6832.795016149524;6879.8968015480805;6400.743970241138;6834.179898412023;6854.828629284308;7050.15398152225;7083.610401427971;4613.746243956614;4931.186354251508;4990.301357809982;4997.375328083989;5003;6625.569337993015;6766.289539598271;6930.965345173242;6944.722211111499;6973.546719463218;5354.54486368663;6696.330366963265;6710.194776626836;6730.528862979544;6737.69680364375;5829.446202610745;6297.622142671455;6542.509311801538;6644.435223006099;6732.562383445061;6435.841548521311;6469.644169570719;6497.350264973465;6529.159815480281;6529.412352888263;6101.359357267601;6402.653784090337;6579.374959378852;6644.136262286065;6666.83332916681;5054.9494505055945;5601.579881508985;6486.237981970351;6513.4463570595135;6523.097221736281 02:58:21 INFO - PID 1631 | |5;yui.html;697.3026973026972;828.4242451496212;840.3571267979996;866.88605142392;869.6999535160371;16443.753343699853;17024;17068.231929563168;18214.72677909829;18829;17766.555836104104;18236.908815455936;18449.125683606424;18496.44510664682;18797.812021879778;971.8833739951216;978.7993461340426;999.9400035997827;1005.1707341443339;1008.5814387029374;856.5545916123643;1012.9797404051915;1021.1728499915092;1025.5282570017764;1025.9281850270484;1068.3269540189708;1071.1109778883508;1071.3304184884448;1072.2226385870222;1075.4568942683973;889.9599518021672;1059.0680201422776;1061.368485750977;1070.7323169207698;1073.4793625091825;759.7758661194961;776.1966364812392;780.239266714954;780.6838230516593;783.060327606874;16561.585960350967;16632.33470661172;16715.832841671672;16887.91556042212;16907.746383804253;16893.662126757517;16973.236204370834;17196.828031719648;17313.65372692539;17320.9607423555;13939.721205575934;14015.719685606231;14269.78595321071;14271.429142834275;14334.784978225334;3438.9828050859837;3506.912327191815;3507.9123021924656;3509.087637214317;3519.208178159919;126960.36519817435;127462;127995.24021418966;129004.35497822544;130862.691373086;13294.800577991338;13360.131591446525;13517.391717372742;13598.524051658342;13606.86393136056;25479.23562293134;25538.616920746204;25695.87152064228;25717.614235786477;26092.60861087085;7616.961915190389;7629.427792915553;7654.464187506933;7691.269329413697;7704.30661240491;3634.5638523377365;3750.5124333836425;3757.267332870119;3757.981210093932;3758.0604848787802;4292.699511034198;4379.934300985487;4386.890327741832;4391.560843915583;4405.933910991338;877.5129802959419;900.2887718702283;900.6667533012696;900.7162743735702;905.542700936023;540.7296351824087;576.5790972589949;627.4008322052429;644.2655372874926;658.7582407162438;10548;11581.363025033535;11582.131340149523;11647.359395233343;11746.412679365998;623.9095331177044;632.5951391109694;639.3223183425583;655.2824657000576;662.7978466567744;5223.373195216598;5267.367915850123;5326.46735326472;5363.463653634605;5411.242426060355;78495.60752196203;103979;104143;104635.4768226154;105620;75638.8654170188;85807.57096214479;87215.56392217998;87222;91041.08958910326;63187.42031449159;77454.612726936;78219;78518;79291.60354198192;9015.864762028443;11803.645890623295;11913.689494155462;12094.818577721517;12171.939140304241;39721.80139099286;40223.597764021986;40391.59608403996;40400.19199615932;40513.392299114945;35968.8201559001;37141.0714732123;42401.78799105985;51462;52019;14254.216018119103;14759.188244646648;15043.774343385077;15537.22313884324;15669.608259793597;17815.910920445316;17854.464366069038;17861.28554857791;18106.45680629583;18164.818351816313;12632.747345052863;15105.093694378373;15288.617784555476;15385.846141538888;15567.766483502983;14118.152910825384;15647.139407332706;15716.60708482297;16018;16057.759133612772;15004.6999060016;15357.69284614279;15506.379744810532;15521.922390387976;15538.766918496458;11553.960143587117;11652.825207622061;11810.87796659316;11914.702132446759;11919;12160.148789584999;12747.678402939788;12756.362181890683;12759.87240127624;13356.866431335951 02:58:21 INFO - PID 1631 | __end_tp_report 02:58:21 INFO - PID 1631 | __start_cc_report 02:58:21 INFO - PID 1631 | _x_x_mozilla_cycle_collect,412 02:58:21 INFO - PID 1631 | __end_cc_report 02:58:21 INFO - PID 1631 | __startTimestamp1492509501029__endTimestamp 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | ------- Summary: start ------- 02:58:21 INFO - PID 1631 | Number of tests: 6 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | [#0] dojo.html Cycles:165 Average:6135.19 Median:6378.27 stddev:742.83 (11.6%) stddev-sans-first:717.33 02:58:21 INFO - PID 1631 | Values: 3570.1 3587.8 3598.7 3621.9 3643.3 6141.3 6264.6 6270.7 6273.9 6309.1 4973.0 6207.3 6219.9 6247.4 6309.6 5484.6 5512.2 5532.6 5562.0 5650.5 4565.7 5462.7 5528.5 5562.6 5598.4 4809.7 5089.7 5400.5 5525.9 5616.9 5417.6 5426.9 5442.2 5454.2 5459.2 5431.2 5445.9 5446.5 5455.5 5478.5 5543.9 5701.9 6272.4 6291.4 6292.9 6392.6 6535.3 6681.3 6687.7 6722.5 6717.5 6763.7 6803.7 6823.2 6845.6 5194.4 5286.8 6309.5 6347.2 6353.3 5791.3 6600.0 6953.8 6964.6 6969.1 5468.3 6378.3 6511.2 6585.0 6614.3 6719.3 6757.0 6758.2 6789.6 6825.2 6586.7 6640.1 6662.9 6684.9 6704.6 6466.4 6559.2 6670.2 6722.2 6750.8 5375.5 5376.2 5386.2 5390.8 5397.3 4767.4 4779.5 4785.9 4789.2 4794.3 5830.4 6078.2 6304.1 6304.5 6335.5 6747.8 6771.4 6855.8 6858.8 6871.5 6295.4 6296.6 6314.2 6314.4 6317.9 5782.3 5914.3 5970.6 5983.6 5999.6 6798.0 6818.8 6846.3 6880.1 6898.4 6551.4 6838.3 6859.5 6866.4 6889.6 5847.5 6767.4 6873.7 6954.4 6967.8 6678.3 6710.2 6742.5 6748.0 6753.4 5305.0 6434.3 6517.5 6573.5 6740.5 6496.5 6589.7 6597.0 6608.1 6611.2 6535.5 6560.3 6579.3 6581.8 6601.1 6184.7 6318.4 6397.0 6403.1 6492.3 6458.2 6508.8 6534.9 6545.6 6559.4 6366.4 6394.3 6409.6 6410.4 6414.7 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | [#1] ext.html Cycles:180 Average:45155.51 Median:17408.64 stddev:78747.80 (452.3%) stddev-sans-first:78898.33 02:58:21 INFO - PID 1631 | Values: 812.1 836.5 1076.9 1122.9 1157.7 37348.6 37916.7 37962.4 37966.4 38020.0 37669.6 37943.6 38042.2 38093.6 38179.7 7910.2 8071.4 8089.2 8243.3 8478.8 8546.9 8624.0 8639.3 8650.1 8688.1 8644.4 8693.8 8698.7 8701.4 8707.2 8641.2 8647.7 8673.9 8676.8 8685.3 8508.6 8513.7 8554.1 8564.1 8592.6 38278.4 38292.8 38463.4 38565.8 38620.5 3561.4 3561.5 3595.2 3602.7 3607.7 31012.7 31151.4 31170.7 31208.8 31361.2 3116.2 3138.1 3144.4 3157.1 3172.1 298051.0 298116.0 299207.0 300398.5 300797.0 40312.0 40909.8 48382.8 50048.5 50125.0 51411.0 51423.5 51568.0 51587.5 51654.0 14504.6 14652.0 14653.9 14661.0 14687.7 11685.0 11728.4 11733.3 11736.4 11771.6 10195.1 12291.8 13858.3 13865.2 13993.9 5944.0 5982.2 5999.7 6002.1 6008.4 1020.4 1046.4 1049.4 1078.3 1082.1 23126.1 23177.3 24362.6 24421.9 24493.8 1141.3 1147.7 1176.9 1186.5 1186.8 10933.2 12441.5 12472.2 12504.0 12530.4 304406.0 306617.0 306867.0 307728.0 309079.0 54200.7 54578.9 54749.2 54772.0 54789.0 1523.4 1530.6 1563.9 1572.1 1574.6 19682.8 24032.5 24189.0 24205.9 24240.0 36247.5 36677.9 36701.6 36741.3 36941.1 292109.0 294562.0 295549.0 295872.0 296812.0 34481.0 35074.0 35248.5 35363.5 35494.1 44100.9 45307.8 45419.3 45508.8 45639.5 28213.9 29825.0 29904.6 30637.8 31277.1 29234.0 29937.8 30560.2 31310.0 31861.8 36366.8 36402.6 36895.4 36907.8 37141.9 26880.3 29892.6 30586.4 31602.5 31645.2 20699.2 24192.5 24288.4 24429.0 24645.0 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | [#2] jquery.html Cycles:180 Average:39151.36 Median:21995.23 stddev:100616.11 (457.4%) stddev-sans-first:100856.28 02:58:21 INFO - PID 1631 | Values: 390.4 427.7 435.0 437.6 459.4 19539.0 21093.0 21745.2 21991.9 21998.6 21864.2 22699.0 23366.3 23386.9 23657.2 6117.5 6343.2 6352.4 6360.1 6366.1 6105.7 6629.5 6986.9 7074.5 7078.9 6836.7 7046.6 7051.0 7094.3 7177.0 6912.8 7247.0 7259.2 7290.2 7292.8 6951.1 6998.7 7009.9 7020.2 7023.3 28226.0 29479.7 29710.3 29802.7 30054.5 2311.6 2365.0 2365.7 2368.2 2377.8 14921.4 19004.0 19322.7 19504.7 19597.7 2007.4 2117.6 2152.9 2355.7 2400.9 148748.0 150403.0 150690.2 151665.0 155396.0 23731.3 24620.9 25992.6 26073.2 26349.6 41134.8 41172.6 41184.6 41289.0 41297.6 11320.2 11453.7 11551.4 11656.2 11876.0 7371.6 9028.5 9077.6 9200.1 9284.3 9573.3 10427.3 10795.6 11561.8 11875.9 4419.2 4573.7 4618.7 4707.3 4732.8 854.8 974.1 980.0 989.6 1008.2 21174.3 21438.4 21621.5 21634.5 21797.0 1008.5 1022.0 1028.4 1034.3 1037.9 10251.6 10732.6 10957.9 10977.9 10994.7 563574.0 579146.0 583284.0 622214.0 637269.0 133647.0 137876.3 141297.0 141850.0 144815.0 1185.1 1185.7 1259.7 1269.3 1274.6 18144.2 20339.0 20384.0 22611.8 22868.5 57800.7 58050.0 58061.4 59472.0 59807.7 81905.0 83220.0 84403.0 84615.2 86802.6 12545.7 12649.9 13231.9 13480.0 13549.0 11692.2 14261.1 14328.6 14413.6 14546.8 11801.6 12052.0 12164.1 12288.1 12309.0 10383.7 11453.3 11690.6 11755.5 11778.5 11988.9 12172.2 12372.3 12479.6 12492.6 13090.9 13107.1 13160.4 13422.7 13465.5 11379.4 11536.8 12101.6 12225.0 12307.1 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | [#3] mootools.html Cycles:180 Average:7223.42 Median:3730.99 stddev:4617.39 (123.8%) stddev-sans-first:4608.82 02:58:21 INFO - PID 1631 | Values: 1289.9 1298.6 1403.1 1460.0 1486.4 11505.1 11842.5 12047.3 12047.4 12274.0 10544.2 11934.3 12097.0 12111.6 12119.6 2479.6 2480.7 2515.5 2521.2 2522.3 2434.4 2486.9 2547.1 2551.5 2558.3 2030.1 2215.5 2476.6 2531.6 2536.4 2371.7 2376.6 2391.5 2410.3 2533.7 2410.0 2507.9 2514.6 2521.6 2530.5 11968.6 12046.9 12138.0 12142.7 12191.6 6603.2 6843.1 6853.3 6858.2 6858.3 4074.9 4319.4 4373.9 4398.0 4409.1 1111.7 1259.8 1269.9 1310.0 1312.0 16452.4 16869.5 17005.2 17012.8 17029.6 4849.3 5676.0 5759.3 5922.7 5927.7 12395.4 12455.3 12487.3 12492.4 12523.4 6618.0 6638.9 6639.2 6644.3 6646.2 6008.2 6164.4 6186.9 6223.7 6274.1 4377.4 4488.6 4494.1 4512.5 4524.8 1302.4 1321.6 1325.1 1337.5 1340.2 762.8 769.5 785.9 792.9 798.9 6545.5 6646.1 6863.8 6901.6 6931.2 911.6 931.5 936.7 942.9 948.2 3591.5 3870.4 3985.7 4235.3 4245.6 13511.9 14069.2 14796.0 15419.0 15435.0 14832.8 15042.8 15126.4 15289.5 15323.4 8626.0 8641.7 8780.8 8805.9 8881.7 6831.6 6860.7 6993.4 7029.6 7067.9 13815.9 13886.7 14014.9 14122.9 14134.7 13991.6 14148.5 14209.4 14227.3 14386.7 8217.4 9396.5 9580.0 9813.1 9830.9 10871.2 10885.9 10888.2 11031.7 11039.0 9218.1 9290.9 9368.8 9378.7 9402.0 7549.5 8904.0 9108.8 9150.8 9286.8 7967.2 8119.3 8123.4 8131.5 8145.3 5347.6 5779.9 5880.4 5895.2 6153.8 5896.5 5985.3 6176.0 6184.3 6330.2 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | [#4] prototype.html Cycles:180 Average:5341.22 Median:6044.29 stddev:1696.33 (28.1%) stddev-sans-first:1659.53 02:58:21 INFO - PID 1631 | Values: 369.6 391.9 413.1 416.8 417.7 5924.4 6176.5 6345.1 6369.8 6381.0 6055.7 6128.9 6181.6 6196.6 6196.7 3801.6 3956.3 4560.7 4580.6 4598.3 3849.8 3995.5 4375.0 4492.6 4599.9 3790.8 4444.4 4488.0 4504.8 4521.3 4495.4 4509.1 4514.6 4533.7 4547.6 3747.1 3821.5 3890.6 3897.6 3912.7 4480.8 5090.4 5411.5 5463.9 6032.9 5384.8 5400.4 5420.7 5438.4 5444.8 5105.6 6540.2 6601.5 6642.4 6648.8 4286.4 4401.6 4402.7 4419.6 4431.4 6072.9 6655.6 6856.5 6896.8 7015.3 4138.9 4239.4 4482.0 4499.7 4512.5 4028.9 4423.9 4584.0 4588.9 4622.3 5275.7 5360.1 5387.9 5397.3 5460.0 6645.5 6672.5 6700.2 6710.6 6722.6 1284.4 1535.8 1553.4 1562.5 1566.5 1017.3 1025.1 1028.3 1029.7 1038.5 5083.6 5764.0 6177.6 6240.8 6316.5 6195.2 6604.9 6900.9 6931.8 6946.6 6295.4 6324.6 6334.0 6379.8 6394.6 3089.0 3314.9 3496.5 3633.5 3643.1 6655.6 7005.4 7081.4 7120.6 7122.6 6295.8 6833.2 7098.0 7132.4 7175.7 5895.7 5922.4 7045.4 7058.4 7132.4 5584.7 6356.8 6963.9 6974.7 6993.8 6538.3 6628.9 6677.7 6832.8 6879.9 6400.7 6834.2 6854.8 7050.2 7083.6 4613.7 4931.2 4990.3 4997.4 5003.0 6625.6 6766.3 6931.0 6944.7 6973.5 5354.5 6696.3 6710.2 6730.5 6737.7 5829.4 6297.6 6542.5 6644.4 6732.6 6435.8 6469.6 6497.4 6529.2 6529.4 6101.4 6402.7 6579.4 6644.1 6666.8 5054.9 5601.6 6486.2 6513.4 6523.1 02:58:21 INFO - PID 1631 | 02:58:21 INFO - PID 1631 | [#5] yui.html Cycles:180 Average:20948.70 Median:18135.64 stddev:29670.45 (163.6%) stddev-sans-first:29714.72 02:58:21 INFO - PID 1631 | Values: 697.3 828.4 840.4 866.9 869.7 16443.8 17024.0 17068.2 18214.7 18829.0 17766.6 18236.9 18449.1 18496.4 18797.8 971.9 978.8 999.9 1005.2 1008.6 856.6 1013.0 1021.2 1025.5 1025.9 1068.3 1071.1 1071.3 1072.2 1075.5 890.0 1059.1 1061.4 1070.7 1073.5 759.8 776.2 780.2 780.7 783.1 16561.6 16632.3 16715.8 16887.9 16907.7 16893.7 16973.2 17196.8 17313.7 17321.0 13939.7 14015.7 14269.8 14271.4 14334.8 3439.0 3506.9 3507.9 3509.1 3519.2 126960.4 127462.0 127995.2 129004.4 130862.7 13294.8 13360.1 13517.4 13598.5 13606.9 25479.2 25538.6 25695.9 25717.6 26092.6 7617.0 7629.4 7654.5 7691.3 7704.3 3634.6 3750.5 3757.3 3758.0 3758.1 4292.7 4379.9 4386.9 4391.6 4405.9 877.5 900.3 900.7 900.7 905.5 540.7 576.6 627.4 644.3 658.8 10548.0 11581.4 11582.1 11647.4 11746.4 623.9 632.6 639.3 655.3 662.8 5223.4 5267.4 5326.5 5363.5 5411.2 78495.6 103979.0 104143.0 104635.5 105620.0 75638.9 85807.6 87215.6 87222.0 91041.1 63187.4 77454.6 78219.0 78518.0 79291.6 9015.9 11803.6 11913.7 12094.8 12171.9 39721.8 40223.6 40391.6 40400.2 40513.4 35968.8 37141.1 42401.8 51462.0 52019.0 14254.2 14759.2 15043.8 15537.2 15669.6 17815.9 17854.5 17861.3 18106.5 18164.8 12632.7 15105.1 15288.6 15385.8 15567.8 14118.2 15647.1 15716.6 16018.0 16057.8 15004.7 15357.7 15506.4 15521.9 15538.8 11554.0 11652.8 11810.9 11914.7 11919.0 12160.1 12747.7 12756.4 12759.9 13356.9 02:58:21 INFO - PID 1631 | -------- Summary: end -------- 02:58:21 INFO - PID 1631 | 02:58:21 INFO - TEST-INFO | 1631: exit 0 02:58:21 INFO - TEST-OK | dromaeo_css | took 1115107ms 02:58:21 INFO - TEST-START | kraken 02:58:21 INFO - operating with platform_type : mac_ 02:58:21 INFO - Initialising browser for kraken test... 02:58:21 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpY0gd80/profile http://localhost:49238/getInfo.html) 02:58:24 INFO - PID 1643 | 2017-04-18 02:58:24.655 plugin-container[1644:10055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 02:58:24 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:24 INFO - PID 1643 | 2017-04-18 02:58:24.658 plugin-container[1644:10055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 02:58:24 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:24 INFO - PID 1643 | 2017-04-18 02:58:24.658 plugin-container[1644:10055] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:24 INFO - PID 1643 | __metrics Screen width/height:1600/1200 02:58:24 INFO - PID 1643 | colorDepth:24 02:58:24 INFO - PID 1643 | Browser inner width/height: 1024/689 02:58:24 INFO - PID 1643 | __metrics 02:58:24 ERROR - PID 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 02:58:25 INFO - TEST-INFO | 1643: exit 0 02:58:25 INFO - Browser initialized. 02:58:25 INFO - Running cycle 1/1 for kraken test... 02:58:25 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpY0gd80/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:28 INFO - PID 1645 | 2017-04-18 02:58:28.052 plugin-container[1646:10186] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 02:58:28 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:28 INFO - PID 1645 | 2017-04-18 02:58:28.053 plugin-container[1646:10186] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 02:58:28 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:28 INFO - PID 1645 | 2017-04-18 02:58:28.053 plugin-container[1646:10186] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:37 INFO - PID 1645 | RSS: Main: 236490752 02:58:37 INFO - PID 1645 | 02:58:40 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:41 INFO - PID 1645 | RSS: Main: 248586240 02:58:41 INFO - PID 1645 | 02:58:44 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 02:58:44 INFO - PID 1645 | RSS: Main: 256753664 02:58:44 INFO - PID 1645 | 02:58:48 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 02:58:48 INFO - PID 1645 | RSS: Main: 259080192 02:58:48 INFO - PID 1645 | 02:58:50 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 02:58:51 INFO - PID 1645 | RSS: Main: 261443584 02:58:51 INFO - PID 1645 | 02:58:53 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:53 INFO - PID 1645 | RSS: Main: 261697536 02:58:53 INFO - PID 1645 | 02:58:56 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:57 INFO - PID 1645 | RSS: Main: 268050432 02:58:57 INFO - PID 1645 | 02:59:00 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:00 INFO - PID 1645 | RSS: Main: 269287424 02:59:00 INFO - PID 1645 | 02:59:03 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 02:59:04 INFO - PID 1645 | RSS: Main: 268640256 02:59:04 INFO - PID 1645 | 02:59:05 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:06 INFO - PID 1645 | RSS: Main: 268705792 02:59:06 INFO - PID 1645 | 02:59:08 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:08 INFO - PID 1645 | RSS: Main: 268468224 02:59:08 INFO - PID 1645 | 02:59:10 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:11 INFO - PID 1645 | RSS: Main: 267984896 02:59:11 INFO - PID 1645 | 02:59:14 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:15 INFO - PID 1645 | RSS: Main: 268120064 02:59:15 INFO - PID 1645 | 02:59:18 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:19 INFO - PID 1645 | RSS: Main: 268701696 02:59:19 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 02:59:21 INFO - PID 1645 | RSS: Main: 270471168 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | __start_tp_report 02:59:21 INFO - PID 1645 | _x_x_mozilla_page_load 02:59:21 INFO - PID 1645 | _x_x_mozilla_page_load_details 02:59:21 INFO - PID 1645 | |i|pagename|runs| 02:59:21 INFO - PID 1645 | |0;ai-astar;104;117;112;119;115;112;115;116;115;115 02:59:21 INFO - PID 1645 | |1;audio-beat-detection;141;112;114;147;112;112;110;109;150;144 02:59:21 INFO - PID 1645 | |2;audio-dft;194;197;197;207;211;208;214;198;202;247 02:59:21 INFO - PID 1645 | |3;audio-fft;79;57;58;80;56;58;58;56;88;86 02:59:21 INFO - PID 1645 | |4;audio-oscillator;86;69;85;71;70;71;90;69;72;89 02:59:21 INFO - PID 1645 | |5;imaging-gaussian-blur;89;89;89;91;89;87;88;84;135;137 02:59:21 INFO - PID 1645 | |6;imaging-darkroom;96;96;97;96;95;95;95;96;105;97 02:59:21 INFO - PID 1645 | |7;imaging-desaturate;89;92;130;96;86;75;122;83;129;94 02:59:21 INFO - PID 1645 | |8;json-parse-financial;51;51;52;52;50;51;50;52;52;52 02:59:21 INFO - PID 1645 | |9;json-stringify-tinderbox;58;55;63;61;70;62;56;58;57;58 02:59:21 INFO - PID 1645 | |10;stanford-crypto-aes;82;83;82;84;82;84;81;87;82;83 02:59:21 INFO - PID 1645 | |11;stanford-crypto-ccm;155;152;137;166;151;157;141;140;215;146 02:59:21 INFO - PID 1645 | |12;stanford-crypto-pbkdf2;214;235;184;214;232;190;188;181;188;187 02:59:21 INFO - PID 1645 | |13;stanford-crypto-sha256-iterative;68;69;72;69;94;98;96;93;73;70 02:59:21 INFO - PID 1645 | __end_tp_report 02:59:21 INFO - PID 1645 | __start_cc_report 02:59:21 INFO - PID 1645 | _x_x_mozilla_cycle_collect,977 02:59:21 INFO - PID 1645 | __end_cc_report 02:59:21 INFO - PID 1645 | __startTimestamp1492509561295__endTimestamp 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | ------- Summary: start ------- 02:59:21 INFO - PID 1645 | Number of tests: 14 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:4.08 (3.5%) stddev-sans-first:2.20 02:59:21 INFO - PID 1645 | Values: 104.0 117.0 112.0 119.0 115.0 112.0 115.0 116.0 115.0 115.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:127.50 stddev:17.75 (13.9%) stddev-sans-first:17.87 02:59:21 INFO - PID 1645 | Values: 141.0 112.0 114.0 147.0 112.0 112.0 110.0 109.0 150.0 144.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#2] audio-dft Cycles:10 Average:207.50 Median:207.50 stddev:15.41 (7.4%) stddev-sans-first:15.56 02:59:21 INFO - PID 1645 | Values: 194.0 197.0 197.0 207.0 211.0 208.0 214.0 198.0 202.0 247.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#3] audio-fft Cycles:10 Average:67.60 Median:68.50 stddev:13.73 (20.0%) stddev-sans-first:13.93 02:59:21 INFO - PID 1645 | Values: 79.0 57.0 58.0 80.0 56.0 58.0 58.0 56.0 88.0 86.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.50 stddev:9.02 (11.5%) stddev-sans-first:8.98 02:59:21 INFO - PID 1645 | Values: 86.0 69.0 85.0 71.0 70.0 71.0 90.0 69.0 72.0 89.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:89.00 stddev:20.22 (22.7%) stddev-sans-first:21.19 02:59:21 INFO - PID 1645 | Values: 89.0 89.0 89.0 91.0 89.0 87.0 88.0 84.0 135.0 137.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.00 stddev:2.97 (3.1%) stddev-sans-first:3.14 02:59:21 INFO - PID 1645 | Values: 96.0 96.0 97.0 96.0 95.0 95.0 95.0 96.0 105.0 97.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:87.50 stddev:19.92 (22.8%) stddev-sans-first:20.75 02:59:21 INFO - PID 1645 | Values: 89.0 92.0 130.0 96.0 86.0 75.0 122.0 83.0 129.0 94.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 02:59:21 INFO - PID 1645 | Values: 51.0 51.0 52.0 52.0 50.0 51.0 50.0 52.0 52.0 52.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.50 stddev:4.42 (7.4%) stddev-sans-first:4.64 02:59:21 INFO - PID 1645 | Values: 58.0 55.0 63.0 61.0 70.0 62.0 56.0 58.0 57.0 58.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:1.70 (2.0%) stddev-sans-first:1.76 02:59:21 INFO - PID 1645 | Values: 82.0 83.0 82.0 84.0 82.0 84.0 81.0 87.0 82.0 83.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:156.00 Median:153.50 stddev:22.52 (14.7%) stddev-sans-first:23.89 02:59:21 INFO - PID 1645 | Values: 155.0 152.0 137.0 166.0 151.0 157.0 141.0 140.0 215.0 146.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.30 Median:202.00 stddev:20.54 (10.2%) stddev-sans-first:21.27 02:59:21 INFO - PID 1645 | Values: 214.0 235.0 184.0 214.0 232.0 190.0 188.0 181.0 188.0 187.0 02:59:21 INFO - PID 1645 | 02:59:21 INFO - PID 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.20 Median:83.00 stddev:13.10 (15.8%) stddev-sans-first:13.13 02:59:21 INFO - PID 1645 | Values: 68.0 69.0 72.0 69.0 94.0 98.0 96.0 93.0 73.0 70.0 02:59:21 INFO - PID 1645 | -------- Summary: end -------- 02:59:21 INFO - PID 1645 | 02:59:22 INFO - TEST-INFO | 1645: exit 0 02:59:22 INFO - TEST-OK | kraken | took 60732ms 02:59:22 INFO - SUITE-END | took 1175s 02:59:22 INFO - Completed test suite (00:19:35) 02:59:22 INFO - javascript benchmark 02:59:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8072.2525497117085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3570.0896271450774, 3587.7847329160245, 3598.7300952428573, 3621.9456708149373, 3643.325984692832, 6141.332587233701, 6264.5928014679075, 6270.717817698203, 6273.874522509547, 6309.11672365868, 4972.980538989507, 6207.255129384469, 6219.875602487948, 6247.406496382836, 6309.62142271464, 5484.61607687462, 5512.173174023908, 5532.585056120807, 5562.0, 5650.49145576898, 4565.703229290086, 5462.6995515246645, 5528.474794894499, 5562.582806289524, 5598.356189038252, 4809.663323567352, 5089.6691715038405, 5400.486953739389, 5525.944740552583, 5616.859578510529, 5417.566594672417, 5426.9185962210595, 5442.183672449125, 5454.209139674725, 5459.153831156177, 5431.158170483582, 5445.891082178334, 5446.455354464521, 5455.454454554552, 5478.45215478453, 5543.861403464905, 5701.916635839178, 6272.372762723691, 6291.402316779899, 6292.930201865694, 6392.55252132351, 6535.281119076898, 6681.298463661343, 6687.665616719145, 6722.462203023795, 6717.462602991749, 6763.661816909184, 6803.659817009179, 6823.1812182538415, 6845.5550389224545, 5194.428612852583, 5286.81496147633, 6309.4636955858805, 6347.238331400262, 6353.3329000455215, 5791.305043394819, 6600.0, 6953.756618518328, 6964.582125072512, 6969.0940177776565, 5468.28912241406, 6378.266499352541, 6511.186101737283, 6585.0, 6614.272430032693, 6719.328067193242, 6756.966215168893, 6758.222804377461, 6789.558678685869, 6825.1809782825385, 6586.670666466657, 6640.136782218281, 6662.900056499157, 6684.86630267392, 6704.564203326768, 6466.353364663496, 6559.245686746085, 6670.199576050905, 6722.226943901416, 6750.797476075725, 5375.489328513785, 5376.193570964387, 5386.218998245233, 5390.838274851761, 5397.298351214396, 4767.356406885096, 4779.474257831635, 4785.856424307276, 4789.233722604366, 4794.304825800309, 5830.38780928005, 6078.179445774764, 6304.085907543381, 6304.464120549713, 6335.461485773761, 6747.831304217336, 6771.356721111487, 6855.828604284933, 6858.794236172923, 6871.5189936703955, 6295.370462953668, 6296.5592408531875, 6314.210723659543, 6314.431701146918, 6317.894368485497, 5782.277215348082, 5914.290285165807, 5970.641761494324, 5983.581149319593, 5999.580029397987, 6798.04827324175, 6818.829529261609, 6846.349596788297, 6880.105586273752, 6898.448124150156, 6551.4103730664465, 6838.316168383122, 6859.451243900576, 6866.382025617719, 6889.586624802528, 5847.473727364558, 6767.424768894502, 6873.656317184221, 6954.374106330454, 6967.825804354931, 6678.265390806911, 6710.228323742832, 6742.494312926452, 6748.0, 6753.358430949052, 5305.018571564273, 6434.260060092962, 6517.543771936109, 6573.474122070318, 6740.494462915399, 6496.545241833026, 6589.736410543716, 6597.0, 6608.107905432705, 6611.206655201407, 6535.477161827138, 6560.3111673273615, 6579.309172536815, 6581.80254592363, 6601.075849381186, 6184.6724646933035, 6318.399752023734, 6396.968015159894, 6403.103565500741, 6492.285848556749, 6458.22501299847, 6508.804735857742, 6534.934650653623, 6545.574537655038, 6559.409653131241, 6366.427021567896, 6394.296627371078, 6409.551331406757, 6410.358964103552, 6414.679266036586], "value": 6088.043218637807, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.1431889356728, 836.5106412748544, 1076.8815430302661, 1122.927009744367, 1157.7337212441143, 37348.62651373485, 37916.67291644793, 37962.430563541566, 37966.4305035424, 38020.0, 37669.623303767024, 37943.62056379436, 38042.23915521688, 38093.61906380942, 38179.663711770096, 7910.169432209607, 8071.354291656653, 8089.2315230053055, 8243.299319557846, 8478.78803029923, 8546.871796923051, 8623.95688021559, 8639.265662418671, 8650.134986501362, 8688.131186881294, 8644.351673624504, 8693.7826554336, 8698.695545655903, 8701.434406763572, 8707.172818582256, 8641.222289993899, 8647.697330593463, 8673.869891951626, 8676.826463470758, 8685.348598855111, 8508.574571271412, 8513.702020429317, 8554.05905350411, 8564.143585641386, 8592.613332400057, 38278.42582361267, 38292.80853595742, 38463.423048654295, 38565.843024709306, 38620.5241528261, 3561.3589553880292, 3561.4835848801777, 3595.227026189382, 3602.7117830573493, 3607.6572725591027, 31012.689873101204, 31151.37697246065, 31170.688293117233, 31208.751649933976, 31361.215969600944, 3116.174213833336, 3138.0899539133625, 3144.402563512925, 3157.147570156068, 3172.0642410488963, 298051.0194898045, 298116.0, 299207.0, 300398.4980075086, 300797.0, 40311.99220019523, 40909.79545102255, 48382.758086209345, 50048.49951500438, 50125.0, 51411.0, 51423.48576514262, 51567.968640626976, 51587.48412515902, 51654.0, 14504.637384065272, 14652.0, 14653.853461465462, 14661.0, 14687.706245875237, 11685.006774424099, 11728.354940478184, 11733.296002239893, 11736.413179340998, 11771.587994420153, 10195.133413659774, 12291.815622765665, 13858.307084645727, 13865.237411942238, 13993.860061399255, 5943.970280148572, 5982.192404025401, 5999.700014999233, 6002.09968504719, 6008.369121242294, 1020.3928662445833, 1046.4140081554353, 1049.4333060147435, 1078.320657985464, 1082.1451053667672, 23126.074957001867, 23177.3046808596, 24362.634560481605, 24421.877890610434, 24493.775311234367, 1141.2809929744208, 1147.7417581044365, 1176.917615766888, 1186.4898093819568, 1186.7745128425572, 10933.234673572773, 12441.502339906303, 12472.189307694971, 12504.0, 12530.436130374155, 304406.0, 306617.0, 306867.0, 307728.0, 309079.0, 54200.72899635555, 54578.90842183214, 54749.178762318596, 54772.0, 54789.0, 1523.405871710034, 1530.556138719781, 1563.9218039098, 1572.1353255709314, 1574.5827355750735, 19682.80317196867, 24032.51934961326, 24189.0, 24205.878970605034, 24240.0, 36247.45628815517, 36677.899663010154, 36701.63298367089, 36741.26517469689, 36941.07647308839, 292109.0, 294562.0, 295549.0, 295872.0, 296812.0, 34481.0, 35074.0, 35248.471272930416, 35363.46954795629, 35494.112647184025, 44100.89747756332, 45307.773461132485, 45419.31871022003, 45508.77245613751, 45639.54360456486, 28213.858930706036, 29824.956126535468, 29904.551431728978, 30637.846810765805, 31277.06168814939, 29234.0, 29937.80248790111, 30560.235994100327, 31310.0, 31861.840690797326, 36366.818165909004, 36402.635973639924, 36895.44656830096, 36907.815460922524, 37141.88574342774, 26880.32799180036, 29892.55161172541, 30586.388272234875, 31602.52596211013, 31645.20886977844, 20699.172033118506, 24192.51614967726, 24288.392790180387, 24429.0, 24645.01419943254], "value": 17635.528114133034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.38514339914633, 427.7369417808045, 434.96302814260804, 437.590852552863, 459.42571785268416, 19539.023048847554, 21093.0, 21745.23891663792, 21991.890040549795, 21998.560028799413, 21864.23475178369, 22699.0, 23366.299011029652, 23386.88306558469, 23657.17199898004, 6117.541184411176, 6343.175387199681, 6352.428281454668, 6360.109584658151, 6366.076918846765, 6105.664188469633, 6629.535932484728, 6986.895196572055, 7074.469414793885, 7078.85842283154, 6836.65816709165, 7046.647667616624, 7050.964745176293, 7094.326039026284, 7176.964115179417, 6912.758053468155, 7246.96376518114, 7259.201487836333, 7290.234525374813, 7292.781216563485, 6951.0616066830835, 6998.720051197946, 7009.929900700979, 7020.227774944752, 7023.297670232987, 28226.0, 29479.70520294791, 29710.257243568867, 29802.701972980427, 30054.54918176229, 2311.6185829338137, 2364.9763502364926, 2365.7042869641296, 2368.1593034472858, 2377.8335516513853, 14921.403143874231, 19004.0, 19322.71015934762, 19504.70742938857, 19597.706034409497, 2007.4178488238392, 2117.6188286108495, 2152.86974338472, 2355.693759811231, 2400.9399765006015, 148748.0, 150403.0, 150690.24654876764, 151665.0, 155396.0, 23731.288061358187, 24620.876895615766, 25992.610110848353, 26073.217803465926, 26349.604755928678, 41134.794326028175, 41172.58827411747, 41184.588154118675, 41288.96777580524, 41297.587024129374, 11320.150988675883, 11453.713657158638, 11551.364674942959, 11656.242344247597, 11875.990540803956, 7371.631418429057, 9028.548572571477, 9077.636894524278, 9200.079992000747, 9284.25725941923, 9573.32986690925, 10427.270091093702, 10795.56817727282, 11561.768764624829, 11875.881241187477, 4419.248727716296, 4573.715357823623, 4618.745968971739, 4707.340972263886, 4732.810687572527, 854.7563944275852, 974.1184228273424, 980.0346658541331, 989.5942663507927, 1008.193445243802, 21174.258900938392, 21438.356849294545, 21621.459463513223, 21634.459138521663, 21797.0, 1008.4907121903392, 1021.9897801021895, 1028.4343611013912, 1034.3225187502198, 1037.9117774989058, 10251.58993640261, 10732.624358147583, 10957.890421095846, 10977.890221097687, 10994.725131871768, 563574.0, 579146.0, 583284.0, 622214.0, 637269.0, 133647.0, 137876.31061844627, 141297.0, 141850.0, 144815.0, 1185.1170877696172, 1185.7272827249608, 1259.6661884600587, 1269.3082270162968, 1274.5602767045355, 18144.18351174174, 20339.0, 20384.0, 22611.773882260968, 22868.542629146992, 57800.71099644475, 58050.0, 58061.4193858056, 59472.0, 59807.70096149491, 81905.0, 83220.01359836859, 84403.0, 84615.15384846073, 86802.56598716966, 12545.686357841127, 12649.873501265238, 13231.933840331121, 13479.98900082478, 13549.0, 11692.181547291608, 14261.073030253001, 14328.570142895729, 14413.567592972227, 14546.781798272823, 11801.613981186954, 12052.0, 12164.148509604243, 12288.078394120656, 12309.0, 10383.740406489898, 11453.255538389978, 11690.615399861195, 11755.529778809094, 11778.528858845893, 11988.880111199125, 12172.208806427554, 12372.257664540157, 12479.625611231677, 12492.562760303346, 13090.869091308965, 13107.14803537767, 13160.40778165004, 13422.731545369234, 13465.528706495617, 11379.374134422686, 11536.846315368395, 12101.576444824388, 12225.0, 12307.138500304893], "value": 12067.018227592025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.8903593194577, 1298.6428732098673, 1403.1160368967548, 1459.9926051024793, 1486.3980088064332, 11505.137114716399, 11842.467088980995, 12047.337396443192, 12047.397630118481, 12273.956713679325, 10544.156467482602, 11934.283942963428, 12097.032237421006, 12111.576094836682, 12119.636410907664, 2479.6404521344393, 2480.7271200167966, 2515.4717509323063, 2521.1932181701864, 2522.2937577478338, 2434.379233295507, 2486.8880900359527, 2547.121243171103, 2551.4641925195733, 2558.2708927955537, 2030.1371916935318, 2215.4572129828134, 2476.578981573137, 2531.632913227581, 2536.378587246127, 2371.6679664846934, 2376.6435034744754, 2391.473875747333, 2410.288964755401, 2533.6832895888015, 2410.0, 2507.924762257135, 2514.622806579028, 2521.5587272227285, 2530.5065512225124, 11968.581099661556, 12046.879531204751, 12138.028957683453, 12142.696432589168, 12191.634250972396, 6603.174603174603, 6843.07618471505, 6853.314668533107, 6858.211305699859, 6858.279880612564, 4074.9185016299507, 4319.43847299849, 4373.934390984138, 4398.0, 4409.074094440171, 1111.7331840358336, 1259.7921342978398, 1269.866664000276, 1309.9672508187277, 1311.9672008199775, 16452.424165154163, 16869.493915182564, 17005.23476443563, 17012.82987170137, 17029.574260643458, 4849.2968519565175, 5675.971620141873, 5759.308882934075, 5922.703864806743, 5927.673977931255, 12395.442205100791, 12455.314957677414, 12487.31319777421, 12492.437840297209, 12523.436445359981, 6617.9669101655145, 6638.871391863395, 6639.236487803868, 6644.269130395653, 6646.169228846395, 6008.158857759917, 6164.4143806338325, 6186.907196392058, 6223.719932603044, 6274.090256912813, 4377.409049778303, 4488.640908727294, 4494.07871386365, 4512.503624601291, 4524.841630542981, 1302.3878776974807, 1321.6101250131235, 1325.0790700463278, 1337.4516448256168, 1340.2360654427077, 762.8245503534218, 769.4652216709334, 785.9017622797151, 792.9255858312019, 798.8601994651029, 6545.541812073109, 6646.102776125162, 6863.759768408082, 6901.62041087745, 6931.2375638679705, 911.5897845969208, 931.4550987672152, 936.7283487788465, 942.8585712143233, 948.2129832239225, 3591.5331006968927, 3870.438786376016, 3985.664802291207, 4235.322348424237, 4245.5542168072525, 13511.864881351257, 14069.226192559507, 14796.0, 15418.997765145454, 15435.0, 14832.777508337384, 15042.774358384633, 15126.39494420211, 15289.541313760605, 15323.387064517518, 8626.00800907891, 8641.654333826576, 8780.78048048791, 8805.911940880509, 8881.73354799357, 6831.6242606657115, 6860.725570977304, 6993.440524757905, 7029.578225306498, 7067.858642827217, 13815.930920345334, 13886.652833679238, 14014.929925350309, 14122.929385353007, 14134.717305653623, 13991.58025259244, 14148.504802331869, 14209.360578774187, 14227.288635568388, 14386.712265754835, 8217.383696222687, 9396.483193424427, 9580.0, 9813.067758562926, 9830.852537211804, 10871.239013268996, 10885.945570272099, 10888.183386245904, 11031.724206894893, 11039.012977663777, 9218.124278193562, 9290.860637090314, 9368.812623747623, 9378.67174648884, 9401.952990235006, 7549.471536992358, 8903.955480222558, 9108.772280693036, 9150.816983660156, 9286.767830804283, 7967.163447837894, 8119.3098586618435, 8123.390745694215, 8131.512109273463, 8145.348372130097, 5347.572194224531, 5779.913301300399, 5880.441358071148, 5895.233619629592, 6153.784617538365, 5896.528277737856, 5985.25184351956, 6176.0, 6184.319724830175, 6330.208723909512], "value": 5431.937886137884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.6303696303696, 391.94316824060513, 413.0726518964924, 416.76452804165643, 417.7013435393693, 5924.407559244079, 6176.536759743026, 6345.143405640237, 6369.840753981152, 6380.9999999999945, 6055.666938318402, 6128.9387106128925, 6181.567290289681, 6196.628202307854, 6196.690165491718, 3801.638844309793, 3956.327424337855, 4560.726356418625, 4580.595187526542, 4598.333241679954, 3849.7690138591774, 3995.540512841017, 4374.95001199713, 4492.618127459154, 4599.862004139881, 3790.8248442982763, 4444.355568442574, 4487.977560112211, 4504.7747612619405, 4521.276595744682, 4495.415595972519, 4509.075639493896, 4514.5936865681915, 4533.705309154894, 4547.567981041796, 3747.1381582235967, 3821.522309711286, 3890.5720370759195, 3897.649211570944, 3912.667423268997, 4480.820767169309, 5090.414602320707, 5411.512963833235, 5463.863403414946, 6032.909506357408, 5384.838454846361, 5400.405955344909, 5420.728963551846, 5438.428964958662, 5444.767645265461, 5105.595961110687, 6540.215174179129, 6601.458438501164, 6642.4353929916015, 6648.800535983928, 4286.42133312002, 4401.603855652975, 4402.669799764998, 4419.602235798793, 4431.446069241345, 6072.908906366408, 6655.633940133291, 6856.520043597, 6896.827579310508, 7015.263397343308, 4138.944569134851, 4239.448871646666, 4481.977590112028, 4499.730016199039, 4512.488316414038, 4028.879133625996, 4423.871912662251, 4583.954160458419, 4588.885277868013, 4622.2835460503675, 5275.736213189325, 5360.088784906575, 5387.919181212285, 5397.271368365299, 5459.972700136474, 6645.501587380966, 6672.466202703772, 6700.195976482756, 6710.597364158166, 6722.596644201363, 1284.4091717809913, 1535.786728484507, 1553.4174684493314, 1562.4843801545462, 1566.4987204094807, 1017.2624846985876, 1025.0927928782933, 1028.3315844701003, 1029.6705054382526, 1038.4703801061362, 5083.61872859537, 5764.0, 6177.590739611555, 6240.812775616739, 6316.494680425555, 6195.2255968004, 6604.919450373117, 6900.896486552706, 6931.826704332432, 6946.583205007716, 6295.401936815995, 6324.608586111048, 6334.0, 6379.840503987438, 6394.552381333262, 3089.0, 3314.8839790607212, 3496.4755286707195, 3633.5458067741533, 3643.0892276930767, 6655.567388119756, 7005.439564834801, 7081.433485321162, 7120.572765634079, 7122.5726456412785, 6295.842603934938, 6833.180018397824, 7097.989635855725, 7132.393746531603, 7175.677094530759, 5895.7052147393315, 5922.407759224129, 7045.436365090678, 7058.400035996998, 7132.393746531499, 5584.687598414288, 6356.77751278703, 6963.876017814413, 6974.721011159497, 6993.755218567326, 6538.313477085027, 6628.90056649141, 6677.732890684319, 6832.795016149524, 6879.8968015480805, 6400.743970241138, 6834.179898412023, 6854.828629284308, 7050.15398152225, 7083.610401427971, 4613.746243956614, 4931.186354251508, 4990.301357809982, 4997.375328083989, 5003.0, 6625.569337993015, 6766.289539598271, 6930.965345173242, 6944.722211111499, 6973.546719463218, 5354.54486368663, 6696.330366963265, 6710.194776626836, 6730.528862979544, 6737.69680364375, 5829.446202610745, 6297.622142671455, 6542.509311801538, 6644.435223006099, 6732.562383445061, 6435.841548521311, 6469.644169570719, 6497.350264973465, 6529.159815480281, 6529.412352888263, 6101.359357267601, 6402.653784090337, 6579.374959378852, 6644.136262286065, 6666.83332916681, 5054.9494505055945, 5601.579881508985, 6486.237981970351, 6513.4463570595135, 6523.097221736281], "value": 4811.007454171656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3026973026972, 828.4242451496212, 840.3571267979996, 866.88605142392, 869.6999535160371, 16443.753343699853, 17024.0, 17068.231929563168, 18214.72677909829, 18829.0, 17766.555836104104, 18236.908815455936, 18449.125683606424, 18496.44510664682, 18797.812021879778, 971.8833739951216, 978.7993461340426, 999.9400035997827, 1005.1707341443339, 1008.5814387029374, 856.5545916123643, 1012.9797404051915, 1021.1728499915092, 1025.5282570017764, 1025.9281850270484, 1068.3269540189708, 1071.1109778883508, 1071.3304184884448, 1072.2226385870222, 1075.4568942683973, 889.9599518021672, 1059.0680201422776, 1061.368485750977, 1070.7323169207698, 1073.4793625091825, 759.7758661194961, 776.1966364812392, 780.239266714954, 780.6838230516593, 783.060327606874, 16561.585960350967, 16632.33470661172, 16715.832841671672, 16887.91556042212, 16907.746383804253, 16893.662126757517, 16973.236204370834, 17196.828031719648, 17313.65372692539, 17320.9607423555, 13939.721205575934, 14015.719685606231, 14269.78595321071, 14271.429142834275, 14334.784978225334, 3438.9828050859837, 3506.912327191815, 3507.9123021924656, 3509.087637214317, 3519.208178159919, 126960.36519817435, 127462.0, 127995.24021418966, 129004.35497822544, 130862.691373086, 13294.800577991338, 13360.131591446525, 13517.391717372742, 13598.524051658342, 13606.86393136056, 25479.23562293134, 25538.616920746204, 25695.87152064228, 25717.614235786477, 26092.60861087085, 7616.961915190389, 7629.427792915553, 7654.464187506933, 7691.269329413697, 7704.30661240491, 3634.5638523377365, 3750.5124333836425, 3757.267332870119, 3757.981210093932, 3758.0604848787802, 4292.699511034198, 4379.934300985487, 4386.890327741832, 4391.560843915583, 4405.933910991338, 877.5129802959419, 900.2887718702283, 900.6667533012696, 900.7162743735702, 905.542700936023, 540.7296351824087, 576.5790972589949, 627.4008322052429, 644.2655372874926, 658.7582407162438, 10548.0, 11581.363025033535, 11582.131340149523, 11647.359395233343, 11746.412679365998, 623.9095331177044, 632.5951391109694, 639.3223183425583, 655.2824657000576, 662.7978466567744, 5223.373195216598, 5267.367915850123, 5326.46735326472, 5363.463653634605, 5411.242426060355, 78495.60752196203, 103979.0, 104143.0, 104635.4768226154, 105620.0, 75638.8654170188, 85807.57096214479, 87215.56392217998, 87222.0, 91041.08958910326, 63187.42031449159, 77454.612726936, 78219.0, 78518.0, 79291.60354198192, 9015.864762028443, 11803.645890623295, 11913.689494155462, 12094.818577721517, 12171.939140304241, 39721.80139099286, 40223.597764021986, 40391.59608403996, 40400.19199615932, 40513.392299114945, 35968.8201559001, 37141.0714732123, 42401.78799105985, 51462.0, 52019.0, 14254.216018119103, 14759.188244646648, 15043.774343385077, 15537.22313884324, 15669.608259793597, 17815.910920445316, 17854.464366069038, 17861.28554857791, 18106.45680629583, 18164.818351816313, 12632.747345052863, 15105.093694378373, 15288.617784555476, 15385.846141538888, 15567.766483502983, 14118.152910825384, 15647.139407332706, 15716.60708482297, 16018.0, 16057.759133612772, 15004.6999060016, 15357.69284614279, 15506.379744810532, 15521.922390387976, 15538.766918496458, 11553.960143587117, 11652.825207622061, 11810.87796659316, 11914.702132446759, 11919.0, 12160.148789584999, 12747.678402939788, 12756.362181890683, 12759.87240127624, 13356.866431335951], "value": 8171.070228106004, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 112.0, 119.0, 115.0, 112.0, 115.0, 116.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 114.0, 147.0, 112.0, 112.0, 110.0, 109.0, 150.0, 144.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 197.0, 197.0, 207.0, 211.0, 208.0, 214.0, 198.0, 202.0, 247.0], "value": 207.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 80.0, 56.0, 58.0, 58.0, 56.0, 88.0, 86.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 85.0, 71.0, 70.0, 71.0, 90.0, 69.0, 72.0, 89.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 91.0, 89.0, 87.0, 88.0, 84.0, 135.0, 137.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 105.0, 97.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 130.0, 96.0, 86.0, 75.0, 122.0, 83.0, 129.0, 94.0], "value": 99.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 50.0, 51.0, 50.0, 52.0, 52.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 63.0, 61.0, 70.0, 62.0, 56.0, 58.0, 57.0, 58.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 84.0, 82.0, 84.0, 81.0, 87.0, 82.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 152.0, 137.0, 166.0, 151.0, 157.0, 141.0, 140.0, 215.0, 146.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 235.0, 184.0, 214.0, 232.0, 190.0, 188.0, 181.0, 188.0, 187.0], "value": 201.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 72.0, 69.0, 94.0, 98.0, 96.0, 93.0, 73.0, 70.0], "value": 80.2, "unit": "score"}]}]} 02:59:22 INFO - Return code: 0 02:59:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:22 ERROR - # TBPL SUCCESS # 02:59:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:59:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:59:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:59:22 INFO - 2017-04-18 02:59:22.640 screenresolution[1651:10579] starting screenresolution argv=screenresolution get 02:59:22 INFO - 2017-04-18 02:59:22.643 screenresolution[1651:10579] Display 0: 1600x1200x32@60 02:59:22 INFO - 2017-04-18 02:59:22.650 screenresolution[1652:10582] starting screenresolution argv=screenresolution list 02:59:22 INFO - Available Modes on Display 0 02:59:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:59:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:59:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:59:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:59:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:59:22 INFO - Intel Iris: 02:59:22 INFO - Chipset Model: Intel Iris 02:59:22 INFO - Type: GPU 02:59:22 INFO - Bus: Built-In 02:59:22 INFO - VRAM (Dynamic, Max): 1536 MB 02:59:22 INFO - Vendor: Intel (0x8086) 02:59:22 INFO - Device ID: 0x0a2e 02:59:22 INFO - Revision ID: 0x0009 02:59:22 INFO - Displays: 02:59:22 INFO - Display: 02:59:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:59:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:59:22 INFO - Display Serial Number: 1600x1200 60 02:59:22 INFO - Main Display: Yes 02:59:22 INFO - Mirror: Off 02:59:22 INFO - Online: Yes 02:59:22 INFO - Rotation: Supported 02:59:22 INFO - Return code: 0 02:59:22 INFO - Running post-action listener: _resource_record_post_action 02:59:22 INFO - [mozharness: 2017-04-18 09:59:22.897138Z] Finished run-tests step (success) 02:59:22 INFO - Running post-run listener: _resource_record_post_run 02:59:22 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39156736; Write bytes: 519990272; Read time: 252; Write time: 1628 02:59:22 INFO - TinderboxPrint: CPU usage
54.2% 02:59:22 INFO - TinderboxPrint: I/O read bytes / time
39,156,736 / 252 02:59:22 INFO - TinderboxPrint: I/O write bytes / time
519,990,272 / 1,628 02:59:22 INFO - TinderboxPrint: CPU idle
2,191.5 (45.8%) 02:59:22 INFO - TinderboxPrint: CPU system
964.6 (20.2%) 02:59:22 INFO - TinderboxPrint: CPU user
1,629.6 (34.1%) 02:59:22 INFO - TinderboxPrint: Swap in / out
248,012,800 / 0 02:59:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195037696; Write bytes: 196089856; Read time: 15072; Write time: 417 02:59:22 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 38194176; Write bytes: 307078144; Read time: 238; Write time: 1160 02:59:23 INFO - Running post-run listener: _upload_blobber_files 02:59:23 INFO - Blob upload gear active. 02:59:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:59:23 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'] 02:59:23 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 02:59:23 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:59:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:59:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:24 INFO - (blobuploader) - INFO - Done attempting. 02:59:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:59:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:59:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:26 INFO - (blobuploader) - INFO - Done attempting. 02:59:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:59:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:59:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:27 INFO - (blobuploader) - INFO - Done attempting. 02:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:29 INFO - (blobuploader) - INFO - Done attempting. 02:59:29 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:29 INFO - Return code: 0 02:59:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7dddae05cd2b84a50868ee08a11cd3c610c4b4274882a941b73d02fbf7ad3a75b47c2adec270d9fc3b5efebdcde2ac8ab091060144f60b913670e6647cb9463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0dcdb09e752630325b32121f6c73a655528026ec655d3b8e88598aaa4132fe38692ebaa101c6a2bd49c9256d0543b2d4fc5345bd71347d198bb794ee06cbde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa8b13eec262d21be4ad1a93b1a3c340f104638893f0b527d74929b7c18ead92eff53e75c586b0ff81ec755073f020a6eff0dd514ef0bdec7bc22051b2e0132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9f899ea15e030aca76ea4c578703d20b0a0ee25299328b7b78c1830b33d6181085ab28ca45e31a0ccf40b7532b6aaffd4466314244989d82b433f49a8f148b"} 02:59:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:29 INFO - Contents: 02:59:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7dddae05cd2b84a50868ee08a11cd3c610c4b4274882a941b73d02fbf7ad3a75b47c2adec270d9fc3b5efebdcde2ac8ab091060144f60b913670e6647cb9463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0dcdb09e752630325b32121f6c73a655528026ec655d3b8e88598aaa4132fe38692ebaa101c6a2bd49c9256d0543b2d4fc5345bd71347d198bb794ee06cbde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa8b13eec262d21be4ad1a93b1a3c340f104638893f0b527d74929b7c18ead92eff53e75c586b0ff81ec755073f020a6eff0dd514ef0bdec7bc22051b2e0132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9f899ea15e030aca76ea4c578703d20b0a0ee25299328b7b78c1830b33d6181085ab28ca45e31a0ccf40b7532b6aaffd4466314244989d82b433f49a8f148b"} 02:59:29 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:29 INFO - Copying logs to upload dir... 02:59:29 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.596853 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-18 02:59:29.212476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 02:59:29.215547) ========= 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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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/c7dddae05cd2b84a50868ee08a11cd3c610c4b4274882a941b73d02fbf7ad3a75b47c2adec270d9fc3b5efebdcde2ac8ab091060144f60b913670e6647cb9463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0dcdb09e752630325b32121f6c73a655528026ec655d3b8e88598aaa4132fe38692ebaa101c6a2bd49c9256d0543b2d4fc5345bd71347d198bb794ee06cbde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa8b13eec262d21be4ad1a93b1a3c340f104638893f0b527d74929b7c18ead92eff53e75c586b0ff81ec755073f020a6eff0dd514ef0bdec7bc22051b2e0132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9f899ea15e030aca76ea4c578703d20b0a0ee25299328b7b78c1830b33d6181085ab28ca45e31a0ccf40b7532b6aaffd4466314244989d82b433f49a8f148b"} build_url:https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/XUFxttiHS5moUhmks78ndA/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/c7dddae05cd2b84a50868ee08a11cd3c610c4b4274882a941b73d02fbf7ad3a75b47c2adec270d9fc3b5efebdcde2ac8ab091060144f60b913670e6647cb9463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0dcdb09e752630325b32121f6c73a655528026ec655d3b8e88598aaa4132fe38692ebaa101c6a2bd49c9256d0543b2d4fc5345bd71347d198bb794ee06cbde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa8b13eec262d21be4ad1a93b1a3c340f104638893f0b527d74929b7c18ead92eff53e75c586b0ff81ec755073f020a6eff0dd514ef0bdec7bc22051b2e0132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9f899ea15e030aca76ea4c578703d20b0a0ee25299328b7b78c1830b33d6181085ab28ca45e31a0ccf40b7532b6aaffd4466314244989d82b433f49a8f148b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 02:59:29.249004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:59:29.249325) ========= 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.APh6gB2Q0J/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.UTLWZf1JAV/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.005267 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:59:29.299725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 02:59:29.300203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 02:59:29.300502) ========= ========= Total master_lag: 0.18 =========