builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0094 starttime: 1489170881.96 results: success (0) buildid: 20170310090022 builduid: 5a44063323e149759519ae07b748a11c revision: a8d497b09753c91783b68c5805c64f34a2f39629 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:41.963945) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:41.964378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:41.964647) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:41.989181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:41.989448) ========= 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.HpPeaz5sOz/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.hODPzPOFKn/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-03-10 10:34:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.73M=0.002s 2017-03-10 10:34:42 (7.73 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.335774 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:42.348918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:42.349231) ========= 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.HpPeaz5sOz/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.hODPzPOFKn/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.021844 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:42.397552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 10:34:42.397909) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8d497b09753c91783b68c5805c64f34a2f39629 --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 a8d497b09753c91783b68c5805c64f34a2f39629 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HpPeaz5sOz/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.hODPzPOFKn/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-03-10 10:34:42,483 truncating revision to first 12 chars 2017-03-10 10:34:42,483 Setting DEBUG logging. 2017-03-10 10:34:42,483 attempt 1/10 2017-03-10 10:34:42,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8d497b09753?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 10:34:43,675 unpacking tar archive at: mozilla-central-a8d497b09753/testing/mozharness/ program finished with exit code 0 elapsedTime=1.450249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 10:34:43.870274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:43.870592) ========= script_repo_revision: a8d497b09753c91783b68c5805c64f34a2f39629 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:43.871001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:43.871264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 10:34:43.891227) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-10 10:34:43.891662) ========= /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.HpPeaz5sOz/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.hODPzPOFKn/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:34:44 INFO - MultiFileLogger online at 20170310 10:34:44 in /builds/slave/test 10:34:44 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 10:34:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:34:44 INFO - {'append_to_log': False, 10:34:44 INFO - 'base_work_dir': '/builds/slave/test', 10:34:44 INFO - 'blob_upload_branch': 'Firefox', 10:34:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:34:44 INFO - 'branch': 'Firefox', 10:34:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:34:44 INFO - 'config_files': ('talos/mac_config.py',), 10:34:44 INFO - 'default_actions': ('clobber', 10:34:44 INFO - 'read-buildbot-config', 10:34:44 INFO - 'download-and-extract', 10:34:44 INFO - 'populate-webroot', 10:34:44 INFO - 'create-virtualenv', 10:34:44 INFO - 'install', 10:34:44 INFO - 'run-tests'), 10:34:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:34:44 INFO - 'download_minidump_stackwalk': True, 10:34:44 INFO - 'download_symbols': 'ondemand', 10:34:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:34:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:34:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:34:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:34:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:34:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:34:44 INFO - 'gecko_profile': False, 10:34:44 INFO - 'gecko_profile_interval': 0, 10:34:44 INFO - 'installer_path': 'installer.exe', 10:34:44 INFO - 'log_level': 'info', 10:34:44 INFO - 'log_name': 'talos', 10:34:44 INFO - 'log_to_console': True, 10:34:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:34:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:34:44 INFO - 'opt_config_files': (), 10:34:44 INFO - 'pip_index': False, 10:34:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:34:44 INFO - 'cmd': ('bash', 10:34:44 INFO - '-c', 10:34:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:34:44 INFO - 'enabled': True, 10:34:44 INFO - 'halt_on_failure': False, 10:34:44 INFO - 'name': 'check_screen_resolution'},), 10:34:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:34:44 INFO - 'cmd': ('bash', 10:34:44 INFO - '-c', 10:34:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:34:44 INFO - 'enabled': True, 10:34:44 INFO - 'halt_on_failure': False, 10:34:44 INFO - 'name': 'check_screen_resolution'},), 10:34:44 INFO - 'run_cmd_checks_enabled': True, 10:34:44 INFO - 'suite': 'dromaeojs-e10s', 10:34:44 INFO - 'system_bits': '32', 10:34:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:34:44 INFO - 'title': 't-yosemite-r7-0094', 10:34:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:34:44 INFO - 'use_talos_json': True, 10:34:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:34:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:34:44 INFO - 'work_dir': 'build'} 10:34:44 INFO - [mozharness: 2017-03-10 18:34:44.089539Z] Running clobber step. 10:34:44 INFO - Running pre-action listener: _resource_record_pre_action 10:34:44 INFO - Running main action method: clobber 10:34:44 INFO - rmtree: /builds/slave/test/build 10:34:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:34:47 INFO - Running post-action listener: _resource_record_post_action 10:34:47 INFO - [mozharness: 2017-03-10 18:34:47.304105Z] Finished clobber step (success) 10:34:47 INFO - [mozharness: 2017-03-10 18:34:47.304229Z] Running read-buildbot-config step. 10:34:47 INFO - Running pre-action listener: _resource_record_pre_action 10:34:47 INFO - Running main action method: read_buildbot_config 10:34:47 INFO - Using buildbot properties: 10:34:47 INFO - { 10:34:47 INFO - "project": "", 10:34:47 INFO - "product": "firefox", 10:34:47 INFO - "script_repo_revision": "production", 10:34:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:34:47 INFO - "repository": "", 10:34:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:34:47 INFO - "buildid": "20170310090022", 10:34:47 INFO - "pgo_build": "False", 10:34:47 INFO - "basedir": "/builds/slave/test", 10:34:47 INFO - "buildnumber": 111, 10:34:47 INFO - "slavename": "t-yosemite-r7-0094", 10:34:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:34:47 INFO - "platform": "yosemite_r7", 10:34:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:34:47 INFO - "branch": "mozilla-central", 10:34:47 INFO - "repo_path": "mozilla-central", 10:34:47 INFO - "revision": "a8d497b09753c91783b68c5805c64f34a2f39629", 10:34:47 INFO - "stage_platform": "macosx64", 10:34:47 INFO - "builduid": "5a44063323e149759519ae07b748a11c", 10:34:47 INFO - "slavebuilddir": "test" 10:34:47 INFO - } 10:34:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:34:47 INFO - Running post-action listener: _resource_record_post_action 10:34:47 INFO - [mozharness: 2017-03-10 18:34:47.307713Z] Finished read-buildbot-config step (success) 10:34:47 INFO - [mozharness: 2017-03-10 18:34:47.307802Z] Running download-and-extract step. 10:34:47 INFO - Running pre-action listener: _resource_record_pre_action 10:34:47 INFO - Running main action method: download_and_extract 10:34:47 INFO - mkdir: /builds/slave/test/build/tests 10:34:47 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')]} 10:34:47 INFO - trying https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:34:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/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 10:34:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/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 10:34:47 INFO - Downloaded 1199 bytes. 10:34:47 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:34:47 INFO - Using the following test package requirements: 10:34:47 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:34:47 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:34:47 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:34:47 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'jsshell-mac.zip'], 10:34:47 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:34:47 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:34:47 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:34:47 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:34:47 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:34:47 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:34:47 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:34:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:34:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:34:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:34:47 INFO - Fetch https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:34:49 INFO - Expected file size: 51786198 10:34:49 INFO - Obtained file size: 51786198 10:35:05 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 10:35:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:35:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:35:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:35:07 INFO - Expected file size: 51786198 10:35:07 INFO - Obtained file size: 51786198 10:35:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:35:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:35:22 INFO - Fetch https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:35:23 INFO - Expected file size: 14404424 10:35:23 INFO - Obtained file size: 14404424 10:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:24 INFO - trying https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:35:24 INFO - Downloading https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/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 10:35:26 INFO - Downloaded 74955577 bytes. 10:35:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:35:26 INFO - mkdir: /builds/slave/test/properties 10:35:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:35:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:35:26 INFO - Contents: 10:35:26 INFO - build_url:https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:35:26 INFO - Running post-action listener: _resource_record_post_action 10:35:26 INFO - Running post-action listener: set_extra_try_arguments 10:35:26 INFO - [mozharness: 2017-03-10 18:35:26.933318Z] Finished download-and-extract step (success) 10:35:26 INFO - [mozharness: 2017-03-10 18:35:26.933456Z] Running populate-webroot step. 10:35:26 INFO - Running pre-action listener: _resource_record_pre_action 10:35:26 INFO - Running main action method: populate_webroot 10:35:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:35:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:35:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:35:26 INFO - '--tppagecycles', 10:35:26 INFO - '7'], 10:35:26 INFO - 'tests': ['tsvgm']}}, 10:35:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:35:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:35:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:35:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:35:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:35:26 INFO - 'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:35:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:35:26 INFO - 'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['damp', 'tps']}, 10:35:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:35:26 INFO - 'tests': ['damp', 'tps']}, 10:35:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['dromaeo_dom']}, 10:35:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:35:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['basic_compositor_video']}, 10:35:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:35:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['a11yr', 10:35:26 INFO - 'ts_paint', 10:35:26 INFO - 'tpaint', 10:35:26 INFO - 'sessionrestore', 10:35:26 INFO - 'sessionrestore_no_auto_restore', 10:35:26 INFO - 'tabpaint']}, 10:35:26 INFO - 'other-e10s': {'tests': ['a11yr', 10:35:26 INFO - 'ts_paint', 10:35:26 INFO - 'tpaint', 10:35:26 INFO - 'sessionrestore', 10:35:26 INFO - 'sessionrestore_no_auto_restore', 10:35:26 INFO - 'tabpaint']}, 10:35:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:35:26 INFO - 'ts_paint', 10:35:26 INFO - 'tpaint', 10:35:26 INFO - 'sessionrestore', 10:35:26 INFO - 'sessionrestore_no_auto_restore', 10:35:26 INFO - 'tabpaint']}, 10:35:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:35:26 INFO - 'ts_paint', 10:35:26 INFO - 'tpaint', 10:35:26 INFO - 'sessionrestore', 10:35:26 INFO - 'sessionrestore_no_auto_restore', 10:35:26 INFO - 'tabpaint']}, 10:35:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['a11yr', 10:35:26 INFO - 'ts_paint', 10:35:26 INFO - 'tpaint', 10:35:26 INFO - 'sessionrestore', 10:35:26 INFO - 'sessionrestore_no_auto_restore', 10:35:26 INFO - 'tabpaint']}, 10:35:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['a11yr', 10:35:26 INFO - 'ts_paint', 10:35:26 INFO - 'tpaint', 10:35:26 INFO - 'sessionrestore', 10:35:26 INFO - 'sessionrestore_no_auto_restore', 10:35:26 INFO - 'tabpaint']}, 10:35:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['tsvgx', 10:35:26 INFO - 'tsvgr_opacity', 10:35:26 INFO - 'tart', 10:35:26 INFO - 'tscrollx', 10:35:26 INFO - 'cart', 10:35:26 INFO - 'tsvg_static']}, 10:35:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:35:26 INFO - 'tsvgr_opacity', 10:35:26 INFO - 'tart', 10:35:26 INFO - 'tscrollx', 10:35:26 INFO - 'cart', 10:35:26 INFO - 'tsvg_static']}, 10:35:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:35:26 INFO - 'talos_options': ['--disable-e10s'], 10:35:26 INFO - 'tests': ['tp5o']}, 10:35:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:35:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:35:26 INFO - 'talos_options': ['--disable-e10s', 10:35:26 INFO - '--xperf_path', 10:35:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:26 INFO - 'tests': ['tp5n']}, 10:35:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:35:26 INFO - 'talos_options': ['--xperf_path', 10:35:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:26 INFO - 'tests': ['tp5n']}}, 10:35:26 INFO - 'talos.zip': {'path': '', 10:35:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:35:26 INFO - Running post-action listener: _resource_record_post_action 10:35:26 INFO - [mozharness: 2017-03-10 18:35:26.951325Z] Finished populate-webroot step (success) 10:35:26 INFO - [mozharness: 2017-03-10 18:35:26.951459Z] Running create-virtualenv step. 10:35:26 INFO - Running pre-action listener: _resource_record_pre_action 10:35:26 INFO - Running main action method: create_virtualenv 10:35:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:35:26 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 10:35:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:35:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:35:27 INFO - Using real prefix '/tools/python27' 10:35:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:35:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:35:30 INFO - Installing pip.................done. 10:35:30 INFO - Return code: 0 10:35:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:35:30 INFO - Reading from file tmpfile_stdout 10:35:30 INFO - Output received: 10:35:30 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) 10:35:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:35:30 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')]} 10:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:30 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')]} 10:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:30 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:30 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 10:35:30 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 10:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:30 INFO - 'HOME': '/Users/cltbld', 10:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:30 INFO - 'LOGNAME': 'cltbld', 10:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:30 INFO - 'MOZ_NO_REMOTE': '1', 10:35:30 INFO - 'NO_EM_RESTART': '1', 10:35:30 INFO - 'PAGER': '/bin/cat', 10:35:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:30 INFO - 'PWD': '/builds/slave/test', 10:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:30 INFO - 'SHELL': '/bin/bash', 10:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:30 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:30 INFO - 'USER': 'cltbld', 10:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:30 INFO - 'XPC_FLAGS': '0x0', 10:35:30 INFO - 'XPC_SERVICE_NAME': '0', 10:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:31 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 10:35:31 INFO - Cleaning up... 10:35:31 INFO - Return code: 0 10:35:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:31 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:31 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 10:35:31 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 10:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:31 INFO - 'HOME': '/Users/cltbld', 10:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:31 INFO - 'LOGNAME': 'cltbld', 10:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:31 INFO - 'MOZ_NO_REMOTE': '1', 10:35:31 INFO - 'NO_EM_RESTART': '1', 10:35:31 INFO - 'PAGER': '/bin/cat', 10:35:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:31 INFO - 'PWD': '/builds/slave/test', 10:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:31 INFO - 'SHELL': '/bin/bash', 10:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:31 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:31 INFO - 'USER': 'cltbld', 10:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:31 INFO - 'XPC_FLAGS': '0x0', 10:35:31 INFO - 'XPC_SERVICE_NAME': '0', 10:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:31 INFO - Downloading/unpacking psutil>=3.1.1 10:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:35:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:35 INFO - Installing collected packages: psutil 10:35:35 INFO - Running setup.py install for psutil 10:35:35 INFO - building 'psutil._psutil_osx' extension 10:35:35 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 10:35:35 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 10:35:35 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 10:35:35 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 10:35:35 INFO - building 'psutil._psutil_posix' extension 10:35:35 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 10:35:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:35:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:35:35 INFO - ^ 10:35:35 INFO - 1 warning generated. 10:35:35 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 10:35:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:35 INFO - Successfully installed psutil 10:35:35 INFO - Cleaning up... 10:35:35 INFO - Return code: 0 10:35:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:35:35 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')]} 10:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:35 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')]} 10:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:35 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:35 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 10:35:35 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 10:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:35 INFO - 'HOME': '/Users/cltbld', 10:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:35 INFO - 'LOGNAME': 'cltbld', 10:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:35 INFO - 'MOZ_NO_REMOTE': '1', 10:35:35 INFO - 'NO_EM_RESTART': '1', 10:35:35 INFO - 'PAGER': '/bin/cat', 10:35:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:35 INFO - 'PWD': '/builds/slave/test', 10:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:35 INFO - 'SHELL': '/bin/bash', 10:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:35 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:35 INFO - 'USER': 'cltbld', 10:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:35 INFO - 'XPC_FLAGS': '0x0', 10:35:35 INFO - 'XPC_SERVICE_NAME': '0', 10:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:35:36 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 10:35:36 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 10:35:36 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 10:35:36 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 10:35:36 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 10:35:36 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 10:35:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:35:38 INFO - Installing collected packages: mozsystemmonitor 10:35:38 INFO - Running setup.py install for mozsystemmonitor 10:35:38 INFO - Successfully installed mozsystemmonitor 10:35:38 INFO - Cleaning up... 10:35:39 INFO - Return code: 0 10:35:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:35:39 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')]} 10:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:39 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')]} 10:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:40 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:40 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 10:35:40 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 10:35:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:40 INFO - 'HOME': '/Users/cltbld', 10:35:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:40 INFO - 'LOGNAME': 'cltbld', 10:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:40 INFO - 'MOZ_NO_REMOTE': '1', 10:35:40 INFO - 'NO_EM_RESTART': '1', 10:35:40 INFO - 'PAGER': '/bin/cat', 10:35:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:40 INFO - 'PWD': '/builds/slave/test', 10:35:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:40 INFO - 'SHELL': '/bin/bash', 10:35:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:40 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:40 INFO - 'USER': 'cltbld', 10:35:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:40 INFO - 'XPC_FLAGS': '0x0', 10:35:40 INFO - 'XPC_SERVICE_NAME': '0', 10:35:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:40 INFO - Downloading/unpacking jsonschema==2.5.1 10:35:40 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 10:35:40 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 10:35:40 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 10:35:40 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 10:35:40 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 10:35:40 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 10:35:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:35:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:35:43 INFO - warning: no files found matching '*.txt' 10:35:43 INFO - no previously-included directories found matching 'build' 10:35:43 INFO - no previously-included directories found matching 'dist' 10:35:43 INFO - no previously-included directories found matching '.git*' 10:35:43 INFO - Installing collected packages: jsonschema, functools32 10:35:43 INFO - Running setup.py install for functools32 10:35:43 INFO - warning: no files found matching '*.txt' 10:35:43 INFO - no previously-included directories found matching 'build' 10:35:43 INFO - no previously-included directories found matching 'dist' 10:35:43 INFO - no previously-included directories found matching '.git*' 10:35:43 INFO - Successfully installed jsonschema functools32 10:35:43 INFO - Cleaning up... 10:35:44 INFO - Return code: 0 10:35:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:35:44 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')]} 10:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:44 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')]} 10:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:44 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:44 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 10:35:44 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 10:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:44 INFO - 'HOME': '/Users/cltbld', 10:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:44 INFO - 'LOGNAME': 'cltbld', 10:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:44 INFO - 'MOZ_NO_REMOTE': '1', 10:35:44 INFO - 'NO_EM_RESTART': '1', 10:35:44 INFO - 'PAGER': '/bin/cat', 10:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:44 INFO - 'PWD': '/builds/slave/test', 10:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:44 INFO - 'SHELL': '/bin/bash', 10:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:44 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:44 INFO - 'USER': 'cltbld', 10:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:44 INFO - 'XPC_FLAGS': '0x0', 10:35:44 INFO - 'XPC_SERVICE_NAME': '0', 10:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:35:44 INFO - Cleaning up... 10:35:44 INFO - Return code: 0 10:35:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:35:44 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')]} 10:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:44 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')]} 10:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:44 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:44 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 10:35:44 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 10:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:44 INFO - 'HOME': '/Users/cltbld', 10:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:44 INFO - 'LOGNAME': 'cltbld', 10:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:44 INFO - 'MOZ_NO_REMOTE': '1', 10:35:44 INFO - 'NO_EM_RESTART': '1', 10:35:44 INFO - 'PAGER': '/bin/cat', 10:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:44 INFO - 'PWD': '/builds/slave/test', 10:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:44 INFO - 'SHELL': '/bin/bash', 10:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:44 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:44 INFO - 'USER': 'cltbld', 10:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:44 INFO - 'XPC_FLAGS': '0x0', 10:35:44 INFO - 'XPC_SERVICE_NAME': '0', 10:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:47 INFO - Downloading blobuploader-1.2.4.tar.gz 10:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:35:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:35:47 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 10:35:47 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 10:35:47 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 10:35:47 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 10:35:47 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 10:35:47 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 10:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:35:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:35:47 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 10:35:47 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 10:35:47 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 10:35:47 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 10:35:47 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 10:35:47 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 10:35:48 INFO - Downloading docopt-0.6.1.tar.gz 10:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:35:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:35:48 INFO - Running setup.py install for blobuploader 10:35:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:35:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:35:48 INFO - Running setup.py install for requests 10:35:49 INFO - Running setup.py install for docopt 10:35:49 INFO - Successfully installed blobuploader requests docopt 10:35:49 INFO - Cleaning up... 10:35:49 INFO - Return code: 0 10:35:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:49 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:49 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 10:35:49 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 10:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:49 INFO - 'HOME': '/Users/cltbld', 10:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:49 INFO - 'LOGNAME': 'cltbld', 10:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:49 INFO - 'MOZ_NO_REMOTE': '1', 10:35:49 INFO - 'NO_EM_RESTART': '1', 10:35:49 INFO - 'PAGER': '/bin/cat', 10:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:49 INFO - 'PWD': '/builds/slave/test', 10:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:49 INFO - 'SHELL': '/bin/bash', 10:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:49 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:49 INFO - 'USER': 'cltbld', 10:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:49 INFO - 'XPC_FLAGS': '0x0', 10:35:49 INFO - 'XPC_SERVICE_NAME': '0', 10:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:49 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-8DQxZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:49 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-mfIyZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:49 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-O9wfLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-AsfhtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-9pyyRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BQvmF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-40z1Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-UhBHq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-qB7n9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BFYf48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ZpGbWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-UWUVzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:50 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Hbhzf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:51 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-XGS0yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:51 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-J3JADc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:51 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-w1NusV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:51 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-V6W1ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:35:51 INFO - Running setup.py install for manifestparser 10:35:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:35:51 INFO - Running setup.py install for mozcrash 10:35:51 INFO - Running setup.py install for mozdebug 10:35:51 INFO - Running setup.py install for mozdevice 10:35:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Running setup.py install for mozfile 10:35:52 INFO - Running setup.py install for mozhttpd 10:35:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Running setup.py install for mozinfo 10:35:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Running setup.py install for mozInstall 10:35:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:35:52 INFO - Running setup.py install for mozleak 10:35:52 INFO - Running setup.py install for mozlog 10:35:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for moznetwork 10:35:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozprocess 10:35:53 INFO - Running setup.py install for mozprofile 10:35:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozrunner 10:35:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:35:53 INFO - Running setup.py install for mozscreenshot 10:35:53 INFO - Running setup.py install for moztest 10:35:53 INFO - Running setup.py install for mozversion 10:35:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:35:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:35:54 INFO - Cleaning up... 10:35:54 INFO - Return code: 0 10:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:54 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')]} 10:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:54 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')]} 10:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:54 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:54 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 10:35:54 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 10:35:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:54 INFO - 'HOME': '/Users/cltbld', 10:35:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:54 INFO - 'LOGNAME': 'cltbld', 10:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:54 INFO - 'MOZ_NO_REMOTE': '1', 10:35:54 INFO - 'NO_EM_RESTART': '1', 10:35:54 INFO - 'PAGER': '/bin/cat', 10:35:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:54 INFO - 'PWD': '/builds/slave/test', 10:35:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:54 INFO - 'SHELL': '/bin/bash', 10:35:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:54 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:54 INFO - 'USER': 'cltbld', 10:35:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:54 INFO - 'XPC_FLAGS': '0x0', 10:35:54 INFO - 'XPC_SERVICE_NAME': '0', 10:35:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-vG04X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:54 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)) 10:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-jOU9Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:54 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)) 10:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-wY02Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:54 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)) 10:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-lOSegd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BNdUJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:54 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)) 10:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-pYrN7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-2Sz8md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-8V84Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-6mBAVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-1puJi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-RH9jM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-W7KihU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-REBwha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-XHaR88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:55 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)) 10:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-_uvM9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:56 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-LpY3ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:56 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)) 10:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:56 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Qp4VJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:56 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)) 10:35:56 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)) 10:35:56 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)) 10:35:56 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)) 10:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:56 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 10:35:56 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 10:35:56 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 10:35:56 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 10:35:56 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 10:35:56 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 10:35:58 INFO - Downloading blessings-1.6.tar.gz 10:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:58 INFO - Installing collected packages: blessings 10:35:58 INFO - Running setup.py install for blessings 10:35:59 INFO - Successfully installed blessings 10:35:59 INFO - Cleaning up... 10:35:59 INFO - Return code: 0 10:35:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:59 INFO - Reading from file tmpfile_stdout 10:35:59 INFO - Current package versions: 10:35:59 INFO - blessings == 1.6 10:35:59 INFO - blobuploader == 1.2.4 10:35:59 INFO - docopt == 0.6.1 10:35:59 INFO - functools32 == 3.2.3-2 10:35:59 INFO - jsonschema == 2.5.1 10:35:59 INFO - manifestparser == 1.1 10:35:59 INFO - mozInstall == 1.12 10:35:59 INFO - mozcrash == 1.0 10:35:59 INFO - mozdebug == 0.1 10:35:59 INFO - mozdevice == 0.49 10:35:59 INFO - mozfile == 1.2 10:35:59 INFO - mozhttpd == 0.7 10:35:59 INFO - mozinfo == 0.9 10:35:59 INFO - mozleak == 0.1 10:35:59 INFO - mozlog == 3.4 10:35:59 INFO - moznetwork == 0.27 10:35:59 INFO - mozprocess == 0.25 10:35:59 INFO - mozprofile == 0.28 10:35:59 INFO - mozrunner == 6.13 10:35:59 INFO - mozscreenshot == 0.1 10:35:59 INFO - mozsystemmonitor == 0.3 10:35:59 INFO - moztest == 0.8 10:35:59 INFO - mozversion == 1.4 10:35:59 INFO - psutil == 3.1.1 10:35:59 INFO - requests == 1.2.3 10:35:59 INFO - wsgiref == 0.1.2 10:35:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:59 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')]} 10:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:59 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')]} 10:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:59 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:59 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 10:35:59 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 10:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:59 INFO - 'HOME': '/Users/cltbld', 10:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:59 INFO - 'LOGNAME': 'cltbld', 10:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:59 INFO - 'MOZ_NO_REMOTE': '1', 10:35:59 INFO - 'NO_EM_RESTART': '1', 10:35:59 INFO - 'PAGER': '/bin/cat', 10:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:59 INFO - 'PWD': '/builds/slave/test', 10:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:59 INFO - 'SHELL': '/bin/bash', 10:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:59 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:59 INFO - 'USER': 'cltbld', 10:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:59 INFO - 'XPC_FLAGS': '0x0', 10:35:59 INFO - 'XPC_SERVICE_NAME': '0', 10:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 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)) 10:35:59 INFO - Cleaning up... 10:35:59 INFO - Return code: 0 10:35:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35:59 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')]} 10:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:59 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')]} 10:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:59 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 0x10bb5fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb62768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd112ca94d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, '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.HpPeaz5sOz/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.hODPzPOFKn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 10:35:59 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 10:35:59 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 10:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:59 INFO - 'HOME': '/Users/cltbld', 10:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:59 INFO - 'LOGNAME': 'cltbld', 10:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:59 INFO - 'MOZ_NO_REMOTE': '1', 10:35:59 INFO - 'NO_EM_RESTART': '1', 10:35:59 INFO - 'PAGER': '/bin/cat', 10:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:59 INFO - 'PWD': '/builds/slave/test', 10:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:59 INFO - 'SHELL': '/bin/bash', 10:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:35:59 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:59 INFO - 'USER': 'cltbld', 10:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:59 INFO - 'XPC_FLAGS': '0x0', 10:35:59 INFO - 'XPC_SERVICE_NAME': '0', 10:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:59 INFO - Cleaning up... 10:36:00 INFO - Return code: 0 10:36:00 INFO - Running post-action listener: _resource_record_post_action 10:36:00 INFO - Running post-action listener: _start_resource_monitoring 10:36:00 INFO - Starting resource monitoring. 10:36:00 INFO - [mozharness: 2017-03-10 18:36:00.040458Z] Finished create-virtualenv step (success) 10:36:00 INFO - [mozharness: 2017-03-10 18:36:00.041264Z] Running install step. 10:36:00 INFO - Running pre-action listener: _resource_record_pre_action 10:36:00 INFO - Running main action method: install 10:36:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:00 INFO - Reading from file tmpfile_stdout 10:36:00 INFO - Detecting whether we're running mozinstall >=1.0... 10:36:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:36:00 INFO - Reading from file tmpfile_stdout 10:36:00 INFO - Output received: 10:36:00 INFO - Usage: mozinstall [options] installer 10:36:00 INFO - Options: 10:36:00 INFO - -h, --help show this help message and exit 10:36:00 INFO - -d DEST, --destination=DEST 10:36:00 INFO - Directory to install application into. [default: 10:36:00 INFO - "/builds/slave/test"] 10:36:00 INFO - --app=APP Application being installed. [default: firefox] 10:36:00 INFO - mkdir: /builds/slave/test/build/application 10:36:00 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'] 10:36:00 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 10:36:20 INFO - Reading from file tmpfile_stdout 10:36:20 INFO - Output received: 10:36:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:36:20 INFO - Running post-action listener: _resource_record_post_action 10:36:20 INFO - [mozharness: 2017-03-10 18:36:20.504395Z] Finished install step (success) 10:36:20 INFO - [mozharness: 2017-03-10 18:36:20.504538Z] Running run-tests step. 10:36:20 INFO - Running pre-action listener: _resource_record_pre_action 10:36:20 INFO - Running main action method: run_tests 10:36:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:36:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:36:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:36:20 INFO - 2017-03-10 10:36:20.519 screenresolution[2214:17074] starting screenresolution argv=screenresolution get 10:36:20 INFO - 2017-03-10 10:36:20.522 screenresolution[2214:17074] Display 0: 1600x1200x32@60 10:36:20 INFO - 2017-03-10 10:36:20.527 screenresolution[2215:17077] starting screenresolution argv=screenresolution list 10:36:20 INFO - Available Modes on Display 0 10:36:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:36:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:36:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:36:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:36:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:36:20 INFO - Intel Iris: 10:36:20 INFO - Chipset Model: Intel Iris 10:36:20 INFO - Type: GPU 10:36:20 INFO - Bus: Built-In 10:36:20 INFO - VRAM (Dynamic, Max): 1536 MB 10:36:20 INFO - Vendor: Intel (0x8086) 10:36:20 INFO - Device ID: 0x0a2e 10:36:20 INFO - Revision ID: 0x0009 10:36:20 INFO - Displays: 10:36:20 INFO - Display: 10:36:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:36:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:36:20 INFO - Display Serial Number: 1600x1200 60 10:36:20 INFO - Main Display: Yes 10:36:20 INFO - Mirror: Off 10:36:20 INFO - Online: Yes 10:36:20 INFO - Rotation: Supported 10:36:20 INFO - Return code: 0 10:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:36:20 INFO - Python 2.7.3 10:36:20 INFO - Return code: 0 10:36:20 INFO - grabbing minidump binary from tooltool 10:36: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')]} 10:36:20 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 0x10b93dd30>, '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 0x10b864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b932be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:36:20 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 10:36:20 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 10:36:20 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 10:36:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:36:20 INFO - Return code: 0 10:36:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:36:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:36:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:36:20 INFO - ENV: RUST_BACKTRACE is now 1 10:36:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:36:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:36:20 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/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 10:36:20 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/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --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 10:36:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpPeaz5sOz/Render', 10:36:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:20 INFO - 'HOME': '/Users/cltbld', 10:36:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:20 INFO - 'LOGNAME': 'cltbld', 10:36:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:36:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:20 INFO - 'MOZ_NO_REMOTE': '1', 10:36:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:36:20 INFO - 'NO_EM_RESTART': '1', 10:36:20 INFO - 'PAGER': '/bin/cat', 10:36:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:20 INFO - 'PWD': '/builds/slave/test', 10:36:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:36:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:20 INFO - 'RUST_BACKTRACE': '1', 10:36:20 INFO - 'SHELL': '/bin/bash', 10:36:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hODPzPOFKn/Listeners', 10:36:20 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 10:36:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:20 INFO - 'USER': 'cltbld', 10:36:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:20 INFO - 'XPC_FLAGS': '0x0', 10:36:20 INFO - 'XPC_SERVICE_NAME': '0', 10:36:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:20 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/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 10:36:21 INFO - mozversion application_buildid: 20170310090022 10:36:21 INFO - mozversion application_changeset: a8d497b09753c91783b68c5805c64f34a2f39629 10:36:21 INFO - mozversion application_display_name: Nightly 10:36:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:36:21 INFO - mozversion application_name: Firefox 10:36:21 INFO - mozversion application_remotingname: firefox 10:36:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:36:21 INFO - mozversion application_vendor: Mozilla 10:36:21 INFO - mozversion application_version: 55.0a1 10:36:21 INFO - mozversion platform_buildid: 20170310090022 10:36:21 INFO - mozversion platform_changeset: a8d497b09753c91783b68c5805c64f34a2f39629 10:36:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:36:21 INFO - mozversion platform_version: 55.0a1 10:36:21 INFO - using testdate: 1489170981 10:36:21 INFO - actual date: 1489170981 10:36:21 INFO - starting webserver on 'localhost:53094' 10:36:21 INFO - SUITE-START | Running 2 tests 10:36:21 INFO - TEST-START | dromaeo_css 10:36:21 INFO - operating with platform_type : mac_ 10:36:21 INFO - Initialising browser for dromaeo_css test... 10:36:21 INFO - TEST-INFO | started process 2225 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmp5WNJ2Q/profile http://localhost:53094/getInfo.html) 10:36:23 INFO - PROCESS | 2225 | 2017-03-10 10:36:23.948 plugin-container[2227:17249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a53, name = 'com.apple.tsm.portname' 10:36:23 INFO - PROCESS | 2225 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:23 INFO - PROCESS | 2225 | 2017-03-10 10:36:23.951 plugin-container[2227:17249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a57, name = 'com.apple.CFPasteboardClient' 10:36:23 INFO - PROCESS | 2225 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:23 INFO - PROCESS | 2225 | 2017-03-10 10:36:23.951 plugin-container[2227:17249] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:36:24 INFO - PROCESS | 2225 | __metrics Screen width/height:1600/1200 10:36:24 INFO - PROCESS | 2225 | colorDepth:24 10:36:24 INFO - PROCESS | 2225 | Browser inner width/height: 1024/689 10:36:24 INFO - PROCESS | 2225 | __metrics 10:36:24 ERROR - PROCESS | 2225 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 10:36:24 INFO - TEST-INFO | 2225: exit 0 10:36:24 INFO - Browser initialized. 10:36:24 INFO - Running cycle 1/1 for dromaeo_css test... 10:36:24 INFO - TEST-INFO | started process 2228 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmp5WNJ2Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:27 INFO - PROCESS | 2228 | 2017-03-10 10:36:27.408 plugin-container[2229:17372] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:36:27 INFO - PROCESS | 2228 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:27 INFO - PROCESS | 2228 | 2017-03-10 10:36:27.409 plugin-container[2229:17372] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 10:36:27 INFO - PROCESS | 2228 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:27 INFO - PROCESS | 2228 | 2017-03-10 10:36:27.409 plugin-container[2229:17372] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:36:37 INFO - PROCESS | 2228 | RSS: Main: 227454976 10:36:37 INFO - PROCESS | 2228 | 10:39:40 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53094/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53094/tests/dromaeo/cssquery-ext.html) 10:39:42 INFO - PROCESS | 2228 | RSS: Main: 252186624 10:39:42 INFO - PROCESS | 2228 | 10:41:25 INFO - PROCESS | 2228 | ************************* 10:41:25 INFO - PROCESS | 2228 | A coding exception was thrown and uncaught in a Task. 10:41:25 INFO - PROCESS | 2228 | 10:41:25 ERROR - PROCESS | 2228 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:41:25 INFO - PROCESS | 2228 | Full stack: 10:41:25 INFO - PROCESS | 2228 | ************************* 10:42:44 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53094/tests/dromaeo/cssquery-ext.html (next: http://localhost:53094/tests/dromaeo/cssquery-jquery.html) 10:42:45 INFO - PROCESS | 2228 | RSS: Main: 260218880 10:42:45 INFO - PROCESS | 2228 | 10:45:47 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53094/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53094/tests/dromaeo/cssquery-mootools.html) 10:45:48 INFO - PROCESS | 2228 | RSS: Main: 271360000 10:45:48 INFO - PROCESS | 2228 | 10:48:50 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53094/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53094/tests/dromaeo/cssquery-prototype.html) 10:48:50 INFO - PROCESS | 2228 | RSS: Main: 263614464 10:48:50 INFO - PROCESS | 2228 | 10:51:53 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53094/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53094/tests/dromaeo/cssquery-yui.html) 10:51:54 INFO - PROCESS | 2228 | RSS: Main: 273928192 10:51:54 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53094/tests/dromaeo/cssquery-yui.html (next: http://localhost:53094/tests/dromaeo/cssquery-dojo.html) 10:54:57 INFO - PROCESS | 2228 | RSS: Main: 267857920 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | __start_tp_report 10:54:57 INFO - PROCESS | 2228 | _x_x_mozilla_page_load 10:54:57 INFO - PROCESS | 2228 | _x_x_mozilla_page_load_details 10:54:57 INFO - PROCESS | 2228 | |i|pagename|runs| 10:54:57 INFO - PROCESS | 2228 | |0;dojo.html;3187.4103290891185;3431;3452.413089774738;3467.497212904129;3488.7034602058825;5858.7949421770245;6033.939660603392;6077.574569780118;6104.267487901452;6107.633541987484;5946.167536544887;5972.223610930584;6063.939360606392;6064.9090263646085;6089;4819.2771084337455;5274.92087618686;5404.6486978346475;5408.4591540845995;5443.101888188464;5333.599980001496;5428;5480.808171713991;5500.5874559408;5513.972430137864;5419.783208671648;5434;5437.34751829779;5455.481729235717;5465.262189604412;5294.470552944713;5321.787128514855;5404.4595540446035;5405.27028851104;5464.863378415532;5289.761960711778;5336.919946200771;5348.973255133699;5354.946450535523;5360.624756267063;5557.41647127054;5772.365039845614;5959.791407300767;6100.389961003909;6115.235595550556;5452.372977107644;6301.306856245809;6313.116163737081;6399.968000160016;6405.359464053604;5424.674519528841;6456.999165129412;6460.773872914426;6490.578112422678;6494.441334079834;6131.9882219434185;6158.969205153946;6168.629882207082;6184.350643182401;6187.102870083812;6320.336364681734;6367.395097465734;6545.639989800607;6545.738170473128;6555.180602424697;6170.10533472644;6309.432151106423;6350.555461117678;6354.555181137276;6358.237011558643;6252.406021427957;6295.118683384329;6394.456471199907;6459.386358295955;6485.902711459332;6380.138681278061;6393.360663933569;6395.360463953567;6401.03984402334;6401.615903045832;6229.501639868799;6232.8130156095385;6278.4035516625845;6291.779787707408;6305.306416294204;5157.123289040872;5159.148740457783;5168.173092305288;5178.223266510054;5195.19474481456;4617.12274667812;4619.69971951822;4620.745858977722;4641.953580464152;4643.187442197602;5951.732172052268;6035.517158627299;6106.389361063858;6112.113743507167;6209.0996805462955;6313.368663133741;6353.96823015882;6375.330590288046;6383.2978372379;6417.486601071903;5140.383154021467;5579.637323574036;6125.693715314216;6221.626702397871;6235.688215589203;5210.76551555181;5718.313802343662;5725.6850873202375;5734.770609175586;5745.080787074048;5333.306670132858;6306.4639505642535;6356.078368636429;6364.427201551883;6377.489800816016;6339.841503962438;6344.873102538016;6349.587276826992;6361.332060133619;6376.39424254695;6406.615603063831;6428.4857211423905;6444.323346048597;6507.349265073455;6537.5096867734155;6227.314995350417;6260.937390626035;6262.248530176408;6286;6302.968485157545;6411.647359395091;6418.29398766126;6418.871622567616;6430.421262086435;6458.128152699325;6148.815535533941;6167.229096362955;6260.780872669617;6304.211973503312;6314.242290924934;6269.937300626935;6296.087067375113;6343.111964324906;6353.174087368612;6361.904571431525;6103.822585931194;6124.693765311806;6141.232345956755;6161.476274516537;6183.84540386494;5254.710990895537;6159.784407545714;6317.968410158103;6331.651759153291;6345.0482427636225;6253.468455181361;6290.622562646073;6294.590851594632;6298.433141017331;6310.5898116622275 10:54:57 INFO - PROCESS | 2228 | |1;ext.html;617.3456136495315;909;911.5123408976197;914.391929366971;936.5598168860637;36784.44823327649;37424.81287593562;37447.876563703096;39024;39076;37670;37904.62095379045;37914;37942.8102859486;38126.8093659532;9093.863592046124;9277.396969196981;9319.440833550008;9340.906590934072;9347.626094956193;9188.58651360687;9282.118198771106;9302.953485232565;9303.581338839735;9328.766780830465;9324.834395700538;9337.953310233439;9343.813123737522;9347.112024357675;9359.578818953129;9272.443653380818;9311.813763724755;9316.8602470963;9320.114589114057;9326.300527460467;9116.361854670176;9160.267178625694;9202.401843880127;9206.907930920672;9239.676611318639;37908.81045594755;38160;38242.426363604565;38269.425958610365;38341.616583834366;3804.7907365094907;3836.827342769554;3850.4801851750217;3850.6330252760426;3866.168773713637;27405;27489.587656185173;27820.860895695594;28020.439591208265;28213;3116.630143657159;3160.288934989632;3174.6984036516724;3197.7441804655573;3205.3268813549184;276999.99999999796;340449;343750.28124859463;348227;348640.77038844436;41470.79264603658;48241.75879120582;49061;49069.50930490721;49126.26310605272;53006.46993530093;53066.20400693993;53085;53144.734276328374;53334.199987000226;14288.714225715428;14349.354279057468;14397.42410303576;14408.20754858493;14408.927955360155;11489.195756297146;11700.590479333183;11704.590339338083;11728.179027467995;11731.824022639667;11071.944640276908;11103.944480277547;11696.47365868538;13740.793888091686;13914.791278130837;6046.425589568984;6056.576039677268;6060.696965151813;6070.180525629072;6072.483838873745;1119.1270808769173;1121.9046381057537;1124.7637996020765;1144.3477217985835;1164.1850704506878;25161.993520258984;26311.47377052448;26622.733772662414;26825.463490730075;26877.193684189504;1169.561414469574;1220.1519943639264;1223.1254652923203;1230.1020255213743;1249.2504497301547;13510.121842080232;13762.724745505035;13772.311384430739;13811.585652430444;13960.58118256454;428796;428949;434709;435407;436230;55288.17067743987;55485.44514554803;55506.444935550935;55881.7205913976;56363.71818140883;1377.5109836008273;1440.2438719672257;1440.8703216710546;1442.725882082401;1442.898997070216;24628.50742985166;25444;25676.614850777627;25850.612240816026;25917.092901748347;44852.77573612111;45180.548194517636;45210.32184517169;45222.54777452183;45279;400408;403965;405260;406991;407848;32801.50797737988;33269.667303326656;33830;35512.46731298981;35538.64461355354;43235.13529729451;43715;43740.12519749523;44900;44952.77523612361;35586.46620300749;36156.63843361638;36447.81776091103;36822.8158859204;37374.8131259342;35539.28921421505;35592;36176;36550.08624784402;36733.89798306055;34739.826300868335;35276.82361588176;35424;35904.10239744027;35908.4613730789;28275.43449131047;30307.696923030486;31638.683613163576;31658.525122123647;31874.362512750078;22197.445063873532;23859.045638174277;24398.02407903735;24941.750582494667;25123 10:54:57 INFO - PROCESS | 2228 | |2;jquery.html;374.6232595212593;379.5748761387247;401.3297792686214;420.02554074547055;428.3574638042935;11498.850114988498;14645.780313295283;18470.722939155905;19257.518562035937;22436.775632243694;20612;21229.15083396662;22331.883405829725;22379.216727414543;23067.769322306773;6346.587471814329;7209.963950180242;7495.175530691647;7690.884636730426;7711.383089352838;5784.710764461781;7607.65765540552;7628.466007379486;7685.654145563463;7690.692372305101;6600.2409722882;7434.739784107557;7676;7690.230976902321;7692.846143077163;7600.657970391318;7723.691052357899;7724.497907635986;7758.612069396508;7763.961180194119;7351.154617218981;7461.440391970624;7484.588347640877;7519.248075192437;7526.774196774106;25616.487670246675;25798.613020804703;26805.597916031275;26843.19470415891;27251.591226131426;3215.469447541153;3339.883104091345;3360.7647464677484;3398.6261511233743;3490.075130090528;15715.921420392939;16066.036037837766;16177.272022759003;16499.010059396354;17116.828831711773;1641.5813967438346;1898.4399602117408;1927.7397551330532;1933.3909818407158;1968.3406058970263;155159;161604.99999999884;164068;166398;168689.15655421643;23287.301380958597;23439.531209375717;23559;23574.410639734146;23742;36177;36191.91424257276;36280.45579316312;36320.27359452849;36380.27239455196;10369.792604147875;10434.21743369235;10663.306885052602;10684.893151068545;10779.461026948622;8456.746297611082;8527.786805329917;8529.061803201643;8551.401401901807;8687.39188256816;10674.466276686135;10735.248532602644;10817.242793004572;10869;10905.83641245366;3952.703547233969;4101.589841015874;4113.259613269581;4114.300568903233;4129.946863549776;876.3952872517942;879.4986857491297;918.9448633082036;928.0811996123789;931.5528546297815;20579;21730.239441619466;21879.890600546896;21998.34004979853;23100.306990790305;731.6524650790939;732.9083864516936;881.8853549038712;907.3648446087633;933.7432206143229;10136.493175341204;11781.764364712657;11886.821697674543;11891.643250702493;11941.343226122646;391534;394849;621592.911518782;622069;622282;97747;114215;128862;152065;154702;1274.4265080713717;1279.9552015679405;1344.253939063829;1344.7915573086384;1347.3398034962797;21079.683804743247;21136.894315528323;21192.682109768673;21339.67990480175;21432.357029289145;47572.52427475681;60809.391906080375;62501;62603;62782;88913.7749158855;88919;89665.10334896567;90202.54898725465;90857.54571227102;11999.580014699444;12028.819567706316;12154.088443366605;12289.262644241375;12453.377331133226;12467.625971220878;13088.345582721016;13605.727885442433;13728.588142355746;14078.366473508511;9972.9528399517;11744.471498782405;11765.352905590275;11867.406629668654;11893.82159267629;11670.70823229426;11925.986291165349;11940.880591193976;12007.099467540143;12028.27830330183;9804.988888611679;11748.060155187735;11820.881791181979;12039.63881083569;12175.939120304341;11822.763544729229;12158.209716368408;12271.631851044483;12309.907315756522;12315.568955086886;11171.218014739216;11709.180357374902;11849.407529623657;11913.285202887855;12082.214656047328 10:54:57 INFO - PROCESS | 2228 | |3;mootools.html;1345.8519562848087;1356.0981947005241;1509.1171664576223;1555.152441919154;1586.920653967302;10778.838317425245;11056.778864422708;11380.829287560693;11416.31502109874;11428.200025998183;8735.388522803407;9732.65935692251;9939.260629389864;10758.515866785994;10766.192535559825;2301.171578231835;2328.057136859566;2336.719593648756;2340.754220806816;2342.3792694935855;2273.6816845641624;2305.538892221554;2311.9884400578057;2313.3406979010983;2320.1995311617466;2270.035235025116;2283.360659015478;2286.748457669655;2288.0504590594883;2295.8392912496133;2223.5997520446313;2233.4528040630066;2235.698180745595;2245;2259.0963614554144;2282.2540756321428;2323.7211534615785;2332.685087513198;2350.4006478348083;2351.4356554426986;8964.417312874642;11244.325340479598;11296.491657875333;11304.830427543593;11356.772864542745;5747.166660834156;5837.007708689533;5949.1968584241;5963.28440587128;5963.52291816658;3360.6639336066196;3461.532693086426;3638.8908332749793;3660.835262413171;3666.926661466782;974.6446202053581;1155.9768804623861;1177.4995626858636;1215.866254711981;1216.0818581970555;15176.964607078518;15296.929214954958;15406.075635461908;15423.22883855814;15430.228488575527;4407.920059585358;4444.488883778342;4708.505606911293;4778.713277203379;4784.7607619619575;10673.733156671145;11510.654680359603;11727.648170554898;11787.292762434281;11824.408779560987;5667.801626943037;5719.7712091516705;5751.309842818889;5755.136729490526;5759.654420734685;5081.695098294114;5140.40885298188;5193.143131383355;5251.474852514718;5291.285676433632;3763.096856754359;3842.193139440693;3845.2693988142164;3909.6090390961244;3940.014996250937;1018.5314755212685;1021.5198856537415;1027.6300531808542;1028.187731691955;1044.7127040064042;888.8044630181349;900.6217388696763;921.3228277216241;945.4053300957341;954.5418199264392;6592.637404942774;6605.933940660628;6606.405423511907;6628.972509261072;6695.765648202289;951.9952400238093;959.9184069354183;986.7681094942683;997.2919227348664;1047.711879233217;4096.856610018635;4201.68487363449;4204.411382406465;4324.308110702273;4340.131973605292;13457.730845383037;13692.178469291874;13894.4442222312;13913.513027044004;13915.652108697364;12858.421371038326;13655.726885462234;13818.585442436743;13834.169949803045;13847.79228311556;9993.500324983866;10366.393209052609;10376.896231037594;10397.740056498647;10399.584016639401;5736.368999410145;6612.371824676648;6711.46308295345;6798.830029249309;6953.513254072166;12065;12400.875991240333;12413.379331033231;12421.627351179479;12434.564790232298;12339.69150771238;12805.679858003625;12807.679808004874;12832.935835320764;12869.9704023676;9112.589933453142;9442.15020648145;9454.05459454049;9461.574229159842;9465.911420186767;10160.390376577428;10336.966303369903;10406.531706073396;10417;10448.268621196443;8476.32189424857;8492.447990880573;9023.458592484209;9106.908930910606;9368.625254989724;9014.2788576915;9051.95474022652;9055.139761722627;9130.817383652156;9147;7721.884171737541;7848.450608457353;7851.882221766792;7889.4871833332945;7893;4676.92984605238;5831.212786273799;5833.4749872511675;5989.910151347821;6017.849553761191;5563.304586926634;5785.304453135831;5973.313068996948;6048.939510604838;6119.2350956130485 10:54:57 INFO - PROCESS | 2228 | |4;prototype.html;333.36161251203936;367.90548119344953;377.0893292698134;386.3875756925273;390.5801263641585;4432.34059564262;4688.6249100072;5041.563154500964;5311.131988726088;5329.946700532993;4473.552644735525;5182.922256166161;5197.428282888879;5266.736663166836;5344.866378340544;3523.9647603523895;3646.6171052039617;3880.7865567393783;3957.9604203958024;4326.329418940069;3549.94675079874;3591.8204089795404;3758.3422900992355;4268.954106243959;4316.719413238129;4236.19512292665;4248.086661367805;4281.571842815724;4291.721038132527;4303.419038429804;3709.332320182366;4077.2060293470927;4262.893427664302;4291.163223171498;4317.589828966243;3533.0637381093775;3587.3542762302777;3971;3974.920501589952;4008.8997775055564;4420.535843736426;4516.864494065183;4691.812327506896;4963.975180124076;5143.974280128613;4800.951990480085;4905.8773530661665;4931.482194369575;5022.497750224985;5105.770240339194;4668.486466488684;5267.604929630293;5489.368722596912;5632.35227948787;5691;4158.2307273154565;4193.643540299078;4339.284018137004;4356.886909848721;4423.451791872819;4802.7118372897385;5445.564354851642;5483.369412517532;5841;5866.120081987693;4411.382406463098;4426.778661066934;4432.1634154141375;4441.936192740279;4482.439695038121;4316.503602085801;4532.388127602731;4581.518940511265;4584.6561507887045;4659.088069956278;4236.978815105905;4299.634531064895;4352.585409741847;4919.2867034279825;4977.954629527767;4640.86077417678;5443.7881649826;5559.943610713952;5588.776448941997;5601.915971260434;1450.6590951126477;1477.7955965887982;1575.3855996161506;1576.5979675182755;1580.9841901581067;1054.8997845204694;1077.2136340471343;1167.4629670351565;1191.5948577483698;1200.4837919694442;4532.410786597721;4754.7147171169145;5214.32213812202;5222.503862133167;5374.758135883894;4772.95227047732;4877.951240483313;5325.3875804282225;5463.945360546344;5764.155470249564;4298.9570104298555;4591.357209990604;4601.608863246594;4757.714537127784;5189.273501709688;2640.379510814957;2708.268767432782;2795.720427957229;2842.616246806696;3020.758339332848;5573.832785016456;5901.436119428355;5918.7928422505;5968.910466343008;5985.46130848217;4904.485029071896;5069;5354.788445403314;5390.784368625289;5997.7001149942325;5195;5505.054286784056;5514.007478653881;5939.46544810969;5982.54300546096;5362.51737343641;5478.781093657075;5609.157726957047;5744.597878148489;5782.2194003808945;5320.153717760979;5350.92981403713;5390.595705322038;5577.295011919297;5742.966266072147;5201.777582268088;5884.762970661117;5892.292924849045;5961.254843144607;5969.4627483524955;3770.585235624134;4007.2786898358577;4447.508016902887;4520.864374068652;4562.520935301745;4739.739314337607;4935.333729946555;5129.563987061141;5598.916016259678;5806.854828629149;4692.038132182963;4727.3854398927915;5185.451566823614;5336.439673834191;5577.804776832953;4787.8563643090765;4820.758962051954;4909.729964851967;5240.842774716764;5600.131979543177;4974.482782751295;5367;5466.5900057495055;5521.475459831309;5561.777528898799;4921.188003979303;5203.843884683465;5220.295260139833;5562.527185189304;5646.2942132233475;4876.926846097383;5422.566194704493;5455.372632147354;5461.42655021233;5554.028045092174 10:54:57 INFO - PROCESS | 2228 | |5;yui.html;572.8367415286644;722.4798145335359;735.1435577552155;768.6387397922978;807.7617102954626;14944.327505262263;15630.29663665135;16168.191590420462;16300.673986520278;16366.672666546661;13288.667783305422;14496.985211035231;14960.625984350396;14973.77539336908;15170.013949093302;902.467544148952;915.945043297401;925.2875286029753;939.7556635274809;942.5004747483845;904.8914130304373;937.9812403751921;938.2681508423441;941.8728471656307;945.4988855906346;967.4292167621102;993.3344659078399;993.5429702336897;996.0587245053428;996.6611352140271;861.6036623153357;979.1432496565506;980.9656662016866;981.0336818234034;989.3964681544252;711.2602892991283;724.2214619284238;730.5981710059499;732.9010583571203;738.8695296196828;14037.22795246261;14245.358958846877;14261.64345891361;15484;16574.419895303607;14501.129932204101;14627.70744585113;14655.706885862222;14702.705945881129;14911.552653420415;9851.704448866545;11459.598914038052;11586.304821710724;11631.6510504685;11961.64115076549;3685.870994515206;3720.4233343831747;3760.341940160461;3775.3581891078584;3883.2427676603074;51730.87786126001;62768;87762.56118719366;106962.46518767356;107138.46430767796;9537.713868583953;11447.54209831614;11450.370229637283;11525.88474115265;12223.755524889453;24216;24406.145784897442;24464;24468.26595202147;24471.265862024167;7535.962320188364;7701;7759.57322347265;7892.723754668674;7939.841203175904;4164;4237.216115018731;4241.172971270573;4245.5542168072525;4247.129338485603;3144.6698096699974;3175.95193586116;3180.777345585787;3204.0548038328748;3209.0533292678715;525.5322762741164;620.5407998081387;626.8150895485843;628.0547775597696;636.2873581588558;564.4722184757265;572.7399720614582;612.5712001598898;613.4052955996161;635.6345101566525;8608.612612432456;9166.633334666672;9656.855147172799;9733;9733.464659443798;541.6552786543081;600.891839468891;620.7051650465993;668.3149771484268;672.5393105722595;4297.90403447119;4428.716478528397;4711.505291944365;4796.251343069744;4861.70829750209;91458;98049.50975245079;103976.48011760044;104896;105182;87723;87830.46034475775;87856.12143878479;88490.55754721315;88668.55665721631;62154.68922655358;72421.6378918102;79039;79193.20806791974;79228;7800.297973182441;9044.276457883485;9071.546422678972;9158.58786354629;9236.861447078434;43845;45964.54035459736;47739;48581;49343.013139736286;68036;68725.3127468739;69520.6523967377;69740.30259697339;70755;11134.3876086816;13153.01352398593;13578.592642220749;13958.323961473021;14274.785878212042;14205.928970355495;14238.359273832495;14450.060746051473;14461.961949527957;14657.706845863237;13410.396532156272;13631.931840340734;13799;14082.507112251022;14113.435462581381;13178.538751143664;13423.127496712683;13516.86483135156;13520.729585408433;13982;13187.406566704329;13335.133216340906;13359.398827052612;13614.18314901109;13730.794038089636;10653.254272201182;10824.67525974222;10833.729156771144;11012.889871101186;11562.826557601475;7876.199788477967;9510.239180865652;11167.218294719292;11271.492782824957;11333.206675532634 10:54:57 INFO - PROCESS | 2228 | __end_tp_report 10:54:57 INFO - PROCESS | 2228 | __start_cc_report 10:54:57 INFO - PROCESS | 2228 | _x_x_mozilla_cycle_collect,428 10:54:57 INFO - PROCESS | 2228 | __end_cc_report 10:54:57 INFO - PROCESS | 2228 | __startTimestamp1489172097696__endTimestamp 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | ------- Summary: start ------- 10:54:57 INFO - PROCESS | 2228 | Number of tests: 6 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | [#0] dojo.html Cycles:165 Average:5913.67 Median:6183.85 stddev:655.59 (10.6%) stddev-sans-first:621.74 10:54:57 INFO - PROCESS | 2228 | Values: 3187.4 3431.0 3452.4 3467.5 3488.7 5858.8 6033.9 6077.6 6104.3 6107.6 5946.2 5972.2 6063.9 6064.9 6089.0 4819.3 5274.9 5404.6 5408.5 5443.1 5333.6 5428.0 5480.8 5500.6 5514.0 5419.8 5434.0 5437.3 5455.5 5465.3 5294.5 5321.8 5404.5 5405.3 5464.9 5289.8 5336.9 5349.0 5354.9 5360.6 5557.4 5772.4 5959.8 6100.4 6115.2 5452.4 6301.3 6313.1 6400.0 6405.4 5424.7 6457.0 6460.8 6490.6 6494.4 6132.0 6159.0 6168.6 6184.4 6187.1 6320.3 6367.4 6545.6 6545.7 6555.2 6170.1 6309.4 6350.6 6354.6 6358.2 6252.4 6295.1 6394.5 6459.4 6485.9 6380.1 6393.4 6395.4 6401.0 6401.6 6229.5 6232.8 6278.4 6291.8 6305.3 5157.1 5159.1 5168.2 5178.2 5195.2 4617.1 4619.7 4620.7 4642.0 4643.2 5951.7 6035.5 6106.4 6112.1 6209.1 6313.4 6354.0 6375.3 6383.3 6417.5 5140.4 5579.6 6125.7 6221.6 6235.7 5210.8 5718.3 5725.7 5734.8 5745.1 5333.3 6306.5 6356.1 6364.4 6377.5 6339.8 6344.9 6349.6 6361.3 6376.4 6406.6 6428.5 6444.3 6507.3 6537.5 6227.3 6260.9 6262.2 6286.0 6303.0 6411.6 6418.3 6418.9 6430.4 6458.1 6148.8 6167.2 6260.8 6304.2 6314.2 6269.9 6296.1 6343.1 6353.2 6361.9 6103.8 6124.7 6141.2 6161.5 6183.8 5254.7 6159.8 6318.0 6331.7 6345.0 6253.5 6290.6 6294.6 6298.4 6310.6 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | [#1] ext.html Cycles:180 Average:53383.92 Median:37399.81 stddev:103811.70 (277.6%) stddev-sans-first:104027.32 10:54:57 INFO - PROCESS | 2228 | Values: 617.3 909.0 911.5 914.4 936.6 36784.4 37424.8 37447.9 39024.0 39076.0 37670.0 37904.6 37914.0 37942.8 38126.8 9093.9 9277.4 9319.4 9340.9 9347.6 9188.6 9282.1 9303.0 9303.6 9328.8 9324.8 9338.0 9343.8 9347.1 9359.6 9272.4 9311.8 9316.9 9320.1 9326.3 9116.4 9160.3 9202.4 9206.9 9239.7 37908.8 38160.0 38242.4 38269.4 38341.6 3804.8 3836.8 3850.5 3850.6 3866.2 27405.0 27489.6 27820.9 28020.4 28213.0 3116.6 3160.3 3174.7 3197.7 3205.3 277000.0 340449.0 343750.3 348227.0 348640.8 41470.8 48241.8 49061.0 49069.5 49126.3 53006.5 53066.2 53085.0 53144.7 53334.2 14288.7 14349.4 14397.4 14408.2 14408.9 11489.2 11700.6 11704.6 11728.2 11731.8 11071.9 11103.9 11696.5 13740.8 13914.8 6046.4 6056.6 6060.7 6070.2 6072.5 1119.1 1121.9 1124.8 1144.3 1164.2 25162.0 26311.5 26622.7 26825.5 26877.2 1169.6 1220.2 1223.1 1230.1 1249.3 13510.1 13762.7 13772.3 13811.6 13960.6 428796.0 428949.0 434709.0 435407.0 436230.0 55288.2 55485.4 55506.4 55881.7 56363.7 1377.5 1440.2 1440.9 1442.7 1442.9 24628.5 25444.0 25676.6 25850.6 25917.1 44852.8 45180.5 45210.3 45222.5 45279.0 400408.0 403965.0 405260.0 406991.0 407848.0 32801.5 33269.7 33830.0 35512.5 35538.6 43235.1 43715.0 43740.1 44900.0 44952.8 35586.5 36156.6 36447.8 36822.8 37374.8 35539.3 35592.0 36176.0 36550.1 36733.9 34739.8 35276.8 35424.0 35904.1 35908.5 28275.4 30307.7 31638.7 31658.5 31874.4 22197.4 23859.0 24398.0 24941.8 25123.0 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | [#2] jquery.html Cycles:180 Average:37021.64 Median:23084.04 stddev:92519.26 (400.8%) stddev-sans-first:92737.88 10:54:57 INFO - PROCESS | 2228 | Values: 374.6 379.6 401.3 420.0 428.4 11498.9 14645.8 18470.7 19257.5 22436.8 20612.0 21229.2 22331.9 22379.2 23067.8 6346.6 7210.0 7495.2 7690.9 7711.4 5784.7 7607.7 7628.5 7685.7 7690.7 6600.2 7434.7 7676.0 7690.2 7692.8 7600.7 7723.7 7724.5 7758.6 7764.0 7351.2 7461.4 7484.6 7519.2 7526.8 25616.5 25798.6 26805.6 26843.2 27251.6 3215.5 3339.9 3360.8 3398.6 3490.1 15715.9 16066.0 16177.3 16499.0 17116.8 1641.6 1898.4 1927.7 1933.4 1968.3 155159.0 161605.0 164068.0 166398.0 168689.2 23287.3 23439.5 23559.0 23574.4 23742.0 36177.0 36191.9 36280.5 36320.3 36380.3 10369.8 10434.2 10663.3 10684.9 10779.5 8456.7 8527.8 8529.1 8551.4 8687.4 10674.5 10735.2 10817.2 10869.0 10905.8 3952.7 4101.6 4113.3 4114.3 4129.9 876.4 879.5 918.9 928.1 931.6 20579.0 21730.2 21879.9 21998.3 23100.3 731.7 732.9 881.9 907.4 933.7 10136.5 11781.8 11886.8 11891.6 11941.3 391534.0 394849.0 621592.9 622069.0 622282.0 97747.0 114215.0 128862.0 152065.0 154702.0 1274.4 1280.0 1344.3 1344.8 1347.3 21079.7 21136.9 21192.7 21339.7 21432.4 47572.5 60809.4 62501.0 62603.0 62782.0 88913.8 88919.0 89665.1 90202.5 90857.5 11999.6 12028.8 12154.1 12289.3 12453.4 12467.6 13088.3 13605.7 13728.6 14078.4 9973.0 11744.5 11765.4 11867.4 11893.8 11670.7 11926.0 11940.9 12007.1 12028.3 9805.0 11748.1 11820.9 12039.6 12175.9 11822.8 12158.2 12271.6 12309.9 12315.6 11171.2 11709.2 11849.4 11913.3 12082.2 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | [#3] mootools.html Cycles:180 Average:6724.81 Median:3411.10 stddev:4252.10 (124.7%) stddev-sans-first:4244.81 10:54:57 INFO - PROCESS | 2228 | Values: 1345.9 1356.1 1509.1 1555.2 1586.9 10778.8 11056.8 11380.8 11416.3 11428.2 8735.4 9732.7 9939.3 10758.5 10766.2 2301.2 2328.1 2336.7 2340.8 2342.4 2273.7 2305.5 2312.0 2313.3 2320.2 2270.0 2283.4 2286.7 2288.1 2295.8 2223.6 2233.5 2235.7 2245.0 2259.1 2282.3 2323.7 2332.7 2350.4 2351.4 8964.4 11244.3 11296.5 11304.8 11356.8 5747.2 5837.0 5949.2 5963.3 5963.5 3360.7 3461.5 3638.9 3660.8 3666.9 974.6 1156.0 1177.5 1215.9 1216.1 15177.0 15296.9 15406.1 15423.2 15430.2 4407.9 4444.5 4708.5 4778.7 4784.8 10673.7 11510.7 11727.6 11787.3 11824.4 5667.8 5719.8 5751.3 5755.1 5759.7 5081.7 5140.4 5193.1 5251.5 5291.3 3763.1 3842.2 3845.3 3909.6 3940.0 1018.5 1021.5 1027.6 1028.2 1044.7 888.8 900.6 921.3 945.4 954.5 6592.6 6605.9 6606.4 6629.0 6695.8 952.0 959.9 986.8 997.3 1047.7 4096.9 4201.7 4204.4 4324.3 4340.1 13457.7 13692.2 13894.4 13913.5 13915.7 12858.4 13655.7 13818.6 13834.2 13847.8 9993.5 10366.4 10376.9 10397.7 10399.6 5736.4 6612.4 6711.5 6798.8 6953.5 12065.0 12400.9 12413.4 12421.6 12434.6 12339.7 12805.7 12807.7 12832.9 12870.0 9112.6 9442.2 9454.1 9461.6 9465.9 10160.4 10337.0 10406.5 10417.0 10448.3 8476.3 8492.4 9023.5 9106.9 9368.6 9014.3 9052.0 9055.1 9130.8 9147.0 7721.9 7848.5 7851.9 7889.5 7893.0 4676.9 5831.2 5833.5 5989.9 6017.8 5563.3 5785.3 5973.3 6048.9 6119.2 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | [#4] prototype.html Cycles:180 Average:4554.89 Median:4877.44 stddev:1285.63 (26.4%) stddev-sans-first:1249.58 10:54:57 INFO - PROCESS | 2228 | Values: 333.4 367.9 377.1 386.4 390.6 4432.3 4688.6 5041.6 5311.1 5329.9 4473.6 5182.9 5197.4 5266.7 5344.9 3524.0 3646.6 3880.8 3958.0 4326.3 3549.9 3591.8 3758.3 4269.0 4316.7 4236.2 4248.1 4281.6 4291.7 4303.4 3709.3 4077.2 4262.9 4291.2 4317.6 3533.1 3587.4 3971.0 3974.9 4008.9 4420.5 4516.9 4691.8 4964.0 5144.0 4801.0 4905.9 4931.5 5022.5 5105.8 4668.5 5267.6 5489.4 5632.4 5691.0 4158.2 4193.6 4339.3 4356.9 4423.5 4802.7 5445.6 5483.4 5841.0 5866.1 4411.4 4426.8 4432.2 4441.9 4482.4 4316.5 4532.4 4581.5 4584.7 4659.1 4237.0 4299.6 4352.6 4919.3 4978.0 4640.9 5443.8 5559.9 5588.8 5601.9 1450.7 1477.8 1575.4 1576.6 1581.0 1054.9 1077.2 1167.5 1191.6 1200.5 4532.4 4754.7 5214.3 5222.5 5374.8 4773.0 4878.0 5325.4 5463.9 5764.2 4299.0 4591.4 4601.6 4757.7 5189.3 2640.4 2708.3 2795.7 2842.6 3020.8 5573.8 5901.4 5918.8 5968.9 5985.5 4904.5 5069.0 5354.8 5390.8 5997.7 5195.0 5505.1 5514.0 5939.5 5982.5 5362.5 5478.8 5609.2 5744.6 5782.2 5320.2 5350.9 5390.6 5577.3 5743.0 5201.8 5884.8 5892.3 5961.3 5969.5 3770.6 4007.3 4447.5 4520.9 4562.5 4739.7 4935.3 5129.6 5598.9 5806.9 4692.0 4727.4 5185.5 5336.4 5577.8 4787.9 4820.8 4909.7 5240.8 5600.1 4974.5 5367.0 5466.6 5521.5 5561.8 4921.2 5203.8 5220.3 5562.5 5646.3 4876.9 5422.6 5455.4 5461.4 5554.0 10:54:57 INFO - PROCESS | 2228 | 10:54:57 INFO - PROCESS | 2228 | [#5] yui.html Cycles:180 Average:19679.20 Median:26225.25 stddev:27600.53 (105.2%) stddev-sans-first:27640.67 10:54:57 INFO - PROCESS | 2228 | Values: 572.8 722.5 735.1 768.6 807.8 14944.3 15630.3 16168.2 16300.7 16366.7 13288.7 14497.0 14960.6 14973.8 15170.0 902.5 915.9 925.3 939.8 942.5 904.9 938.0 938.3 941.9 945.5 967.4 993.3 993.5 996.1 996.7 861.6 979.1 981.0 981.0 989.4 711.3 724.2 730.6 732.9 738.9 14037.2 14245.4 14261.6 15484.0 16574.4 14501.1 14627.7 14655.7 14702.7 14911.6 9851.7 11459.6 11586.3 11631.7 11961.6 3685.9 3720.4 3760.3 3775.4 3883.2 51730.9 62768.0 87762.6 106962.5 107138.5 9537.7 11447.5 11450.4 11525.9 12223.8 24216.0 24406.1 24464.0 24468.3 24471.3 7536.0 7701.0 7759.6 7892.7 7939.8 4164.0 4237.2 4241.2 4245.6 4247.1 3144.7 3176.0 3180.8 3204.1 3209.1 525.5 620.5 626.8 628.1 636.3 564.5 572.7 612.6 613.4 635.6 8608.6 9166.6 9656.9 9733.0 9733.5 541.7 600.9 620.7 668.3 672.5 4297.9 4428.7 4711.5 4796.3 4861.7 91458.0 98049.5 103976.5 104896.0 105182.0 87723.0 87830.5 87856.1 88490.6 88668.6 62154.7 72421.6 79039.0 79193.2 79228.0 7800.3 9044.3 9071.5 9158.6 9236.9 43845.0 45964.5 47739.0 48581.0 49343.0 68036.0 68725.3 69520.7 69740.3 70755.0 11134.4 13153.0 13578.6 13958.3 14274.8 14205.9 14238.4 14450.1 14462.0 14657.7 13410.4 13631.9 13799.0 14082.5 14113.4 13178.5 13423.1 13516.9 13520.7 13982.0 13187.4 13335.1 13359.4 13614.2 13730.8 10653.3 10824.7 10833.7 11012.9 11562.8 7876.2 9510.2 11167.2 11271.5 11333.2 10:54:57 INFO - PROCESS | 2228 | -------- Summary: end -------- 10:54:57 INFO - PROCESS | 2228 | 10:54:58 INFO - TEST-INFO | 2228: exit 0 10:54:58 INFO - TEST-OK | dromaeo_css | took 1117222ms 10:54:58 INFO - TEST-START | kraken 10:54:58 INFO - operating with platform_type : mac_ 10:54:58 INFO - Initialising browser for kraken test... 10:54:58 INFO - TEST-INFO | started process 2234 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpZgyI1m/profile http://localhost:53094/getInfo.html) 10:55:01 INFO - PROCESS | 2234 | 2017-03-10 10:55:01.337 plugin-container[2235:19498] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 10:55:01 INFO - PROCESS | 2234 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:55:01 INFO - PROCESS | 2234 | 2017-03-10 10:55:01.341 plugin-container[2235:19498] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 10:55:01 INFO - PROCESS | 2234 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:55:01 INFO - PROCESS | 2234 | 2017-03-10 10:55:01.341 plugin-container[2235:19498] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:55:01 INFO - PROCESS | 2234 | __metrics Screen width/height:1600/1200 10:55:01 INFO - PROCESS | 2234 | colorDepth:24 10:55:01 INFO - PROCESS | 2234 | Browser inner width/height: 1024/689 10:55:01 INFO - PROCESS | 2234 | __metrics 10:55:01 ERROR - PROCESS | 2234 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 10:55:02 INFO - TEST-INFO | 2234: exit 0 10:55:02 INFO - Browser initialized. 10:55:02 INFO - Running cycle 1/1 for kraken test... 10:55:02 INFO - TEST-INFO | started process 2236 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpZgyI1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:04 INFO - PROCESS | 2236 | 2017-03-10 10:55:04.984 plugin-container[2237:19620] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 10:55:04 INFO - PROCESS | 2236 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:55:04 INFO - PROCESS | 2236 | 2017-03-10 10:55:04.984 plugin-container[2237:19620] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 10:55:04 INFO - PROCESS | 2236 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:55:04 INFO - PROCESS | 2236 | 2017-03-10 10:55:04.984 plugin-container[2237:19620] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:55:14 INFO - PROCESS | 2236 | RSS: Main: 227295232 10:55:14 INFO - PROCESS | 2236 | 10:55:17 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53094/tests/kraken/driver.html?testName=audio-beat-detection) 10:55:18 INFO - PROCESS | 2236 | RSS: Main: 241537024 10:55:18 INFO - PROCESS | 2236 | 10:55:21 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53094/tests/kraken/driver.html?testName=audio-dft) 10:55:21 INFO - PROCESS | 2236 | RSS: Main: 250044416 10:55:21 INFO - PROCESS | 2236 | 10:55:25 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53094/tests/kraken/driver.html?testName=audio-fft) 10:55:25 INFO - PROCESS | 2236 | RSS: Main: 252661760 10:55:25 INFO - PROCESS | 2236 | 10:55:28 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53094/tests/kraken/driver.html?testName=audio-oscillator) 10:55:28 INFO - PROCESS | 2236 | RSS: Main: 254816256 10:55:28 INFO - PROCESS | 2236 | 10:55:30 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53094/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:55:31 INFO - PROCESS | 2236 | RSS: Main: 255516672 10:55:31 INFO - PROCESS | 2236 | 10:55:34 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53094/tests/kraken/driver.html?testName=imaging-darkroom) 10:55:34 INFO - PROCESS | 2236 | RSS: Main: 260919296 10:55:34 INFO - PROCESS | 2236 | 10:55:38 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53094/tests/kraken/driver.html?testName=imaging-desaturate) 10:55:38 INFO - PROCESS | 2236 | RSS: Main: 259776512 10:55:38 INFO - PROCESS | 2236 | 10:55:42 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53094/tests/kraken/driver.html?testName=json-parse-financial) 10:55:42 INFO - PROCESS | 2236 | RSS: Main: 260866048 10:55:42 INFO - PROCESS | 2236 | 10:55:44 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53094/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:55:45 INFO - PROCESS | 2236 | RSS: Main: 260538368 10:55:45 INFO - PROCESS | 2236 | 10:55:47 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:47 INFO - PROCESS | 2236 | RSS: Main: 260554752 10:55:47 INFO - PROCESS | 2236 | 10:55:49 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:55:50 INFO - PROCESS | 2236 | RSS: Main: 260608000 10:55:50 INFO - PROCESS | 2236 | 10:55:53 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:55:54 INFO - PROCESS | 2236 | RSS: Main: 261165056 10:55:54 INFO - PROCESS | 2236 | 10:55:57 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:55:58 INFO - PROCESS | 2236 | RSS: Main: 260956160 10:55:58 INFO - PROCESS | 2236 | 10:55:59 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53094/tests/kraken/driver.html?testName=ai-astar) 10:56:00 INFO - PROCESS | 2236 | RSS: Main: 263905280 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | __start_tp_report 10:56:00 INFO - PROCESS | 2236 | _x_x_mozilla_page_load 10:56:00 INFO - PROCESS | 2236 | _x_x_mozilla_page_load_details 10:56:00 INFO - PROCESS | 2236 | |i|pagename|runs| 10:56:00 INFO - PROCESS | 2236 | |0;ai-astar;107;121;127;118;121;119;120;128;119;104 10:56:00 INFO - PROCESS | 2236 | |1;audio-beat-detection;142;111;129;187;140;98;135;146;163;107 10:56:00 INFO - PROCESS | 2236 | |2;audio-dft;195;213;248;231;222;200;288;246;190;203 10:56:00 INFO - PROCESS | 2236 | |3;audio-fft;85;58;62;88;64;76;59;59;101;88 10:56:00 INFO - PROCESS | 2236 | |4;audio-oscillator;87;71;87;72;69;74;95;105;70;85 10:56:00 INFO - PROCESS | 2236 | |5;imaging-gaussian-blur;89;89;89;89;105;89;88;88;94;96 10:56:00 INFO - PROCESS | 2236 | |6;imaging-darkroom;157;144;97;125;156;133;99;143;146;97 10:56:00 INFO - PROCESS | 2236 | |7;imaging-desaturate;148;96;148;94;147;91;142;151;92;91 10:56:00 INFO - PROCESS | 2236 | |8;json-parse-financial;67;66;66;68;71;67;68;68;68;67 10:56:00 INFO - PROCESS | 2236 | |9;json-stringify-tinderbox;58;65;60;63;66;65;58;67;55;59 10:56:00 INFO - PROCESS | 2236 | |10;stanford-crypto-aes;86;88;87;85;88;78;99;81;93;108 10:56:00 INFO - PROCESS | 2236 | |11;stanford-crypto-ccm;140;142;162;149;153;149;160;177;205;165 10:56:00 INFO - PROCESS | 2236 | |12;stanford-crypto-pbkdf2;176;172;175;171;173;184;171;176;187;244 10:56:00 INFO - PROCESS | 2236 | |13;stanford-crypto-sha256-iterative;66;71;66;67;67;66;66;76;86;90 10:56:00 INFO - PROCESS | 2236 | __end_tp_report 10:56:00 INFO - PROCESS | 2236 | __start_cc_report 10:56:00 INFO - PROCESS | 2236 | _x_x_mozilla_cycle_collect,995 10:56:00 INFO - PROCESS | 2236 | __end_cc_report 10:56:00 INFO - PROCESS | 2236 | __startTimestamp1489172160039__endTimestamp 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | ------- Summary: start ------- 10:56:00 INFO - PROCESS | 2236 | Number of tests: 14 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#0] ai-astar Cycles:10 Average:118.40 Median:120.50 stddev:7.60 (6.3%) stddev-sans-first:6.86 10:56:00 INFO - PROCESS | 2236 | Values: 107.0 121.0 127.0 118.0 121.0 119.0 120.0 128.0 119.0 104.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:144.00 stddev:26.75 (18.6%) stddev-sans-first:28.28 10:56:00 INFO - PROCESS | 2236 | Values: 142.0 111.0 129.0 187.0 140.0 98.0 135.0 146.0 163.0 107.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#2] audio-dft Cycles:10 Average:223.60 Median:226.50 stddev:30.45 (13.4%) stddev-sans-first:30.48 10:56:00 INFO - PROCESS | 2236 | Values: 195.0 213.0 248.0 231.0 222.0 200.0 288.0 246.0 190.0 203.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#3] audio-fft Cycles:10 Average:74.00 Median:70.00 stddev:15.62 (22.3%) stddev-sans-first:16.05 10:56:00 INFO - PROCESS | 2236 | Values: 85.0 58.0 62.0 88.0 64.0 76.0 59.0 59.0 101.0 88.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#4] audio-oscillator Cycles:10 Average:81.50 Median:79.50 stddev:12.26 (15.4%) stddev-sans-first:12.84 10:56:00 INFO - PROCESS | 2236 | Values: 87.0 71.0 87.0 72.0 69.0 74.0 95.0 105.0 70.0 85.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:89.00 stddev:5.42 (6.1%) stddev-sans-first:5.67 10:56:00 INFO - PROCESS | 2236 | Values: 89.0 89.0 89.0 89.0 105.0 89.0 88.0 88.0 94.0 96.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#6] imaging-darkroom Cycles:10 Average:129.70 Median:156.50 stddev:24.03 (15.4%) stddev-sans-first:23.37 10:56:00 INFO - PROCESS | 2236 | Values: 157.0 144.0 97.0 125.0 156.0 133.0 99.0 143.0 146.0 97.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#7] imaging-desaturate Cycles:10 Average:120.00 Median:91.00 stddev:28.79 (31.6%) stddev-sans-first:28.70 10:56:00 INFO - PROCESS | 2236 | Values: 148.0 96.0 148.0 94.0 147.0 91.0 142.0 151.0 92.0 91.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.50 10:56:00 INFO - PROCESS | 2236 | Values: 67.0 66.0 66.0 68.0 71.0 67.0 68.0 68.0 68.0 67.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:64.00 stddev:4.12 (6.4%) stddev-sans-first:4.15 10:56:00 INFO - PROCESS | 2236 | Values: 58.0 65.0 60.0 63.0 66.0 65.0 58.0 67.0 55.0 59.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:87.50 stddev:8.77 (10.0%) stddev-sans-first:9.22 10:56:00 INFO - PROCESS | 2236 | Values: 86.0 88.0 87.0 85.0 88.0 78.0 99.0 81.0 93.0 108.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:161.00 stddev:19.31 (12.0%) stddev-sans-first:19.05 10:56:00 INFO - PROCESS | 2236 | Values: 140.0 142.0 162.0 149.0 153.0 149.0 160.0 177.0 205.0 165.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:176.00 stddev:22.13 (12.6%) stddev-sans-first:23.33 10:56:00 INFO - PROCESS | 2236 | Values: 176.0 172.0 175.0 171.0 173.0 184.0 171.0 176.0 187.0 244.0 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - PROCESS | 2236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:69.00 stddev:9.01 (13.1%) stddev-sans-first:9.28 10:56:00 INFO - PROCESS | 2236 | Values: 66.0 71.0 66.0 67.0 67.0 66.0 66.0 76.0 86.0 90.0 10:56:00 INFO - PROCESS | 2236 | -------- Summary: end -------- 10:56:00 INFO - PROCESS | 2236 | 10:56:00 INFO - TEST-INFO | 2236: exit 0 10:56:00 INFO - TEST-OK | kraken | took 62598ms 10:56:00 INFO - SUITE-END | took 1179s 10:56:01 INFO - Completed test suite (00:19:40) 10:56:01 INFO - javascript benchmark 10:56:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7668.790099454697, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.4103290891185, 3431.0, 3452.413089774738, 3467.497212904129, 3488.7034602058825, 5858.7949421770245, 6033.939660603392, 6077.574569780118, 6104.267487901452, 6107.633541987484, 5946.167536544887, 5972.223610930584, 6063.939360606392, 6064.9090263646085, 6089.0, 4819.2771084337455, 5274.92087618686, 5404.6486978346475, 5408.4591540845995, 5443.101888188464, 5333.599980001496, 5428.0, 5480.808171713991, 5500.5874559408, 5513.972430137864, 5419.783208671648, 5434.0, 5437.34751829779, 5455.481729235717, 5465.262189604412, 5294.470552944713, 5321.787128514855, 5404.4595540446035, 5405.27028851104, 5464.863378415532, 5289.761960711778, 5336.919946200771, 5348.973255133699, 5354.946450535523, 5360.624756267063, 5557.41647127054, 5772.365039845614, 5959.791407300767, 6100.389961003909, 6115.235595550556, 5452.372977107644, 6301.306856245809, 6313.116163737081, 6399.968000160016, 6405.359464053604, 5424.674519528841, 6456.999165129412, 6460.773872914426, 6490.578112422678, 6494.441334079834, 6131.9882219434185, 6158.969205153946, 6168.629882207082, 6184.350643182401, 6187.102870083812, 6320.336364681734, 6367.395097465734, 6545.639989800607, 6545.738170473128, 6555.180602424697, 6170.10533472644, 6309.432151106423, 6350.555461117678, 6354.555181137276, 6358.237011558643, 6252.406021427957, 6295.118683384329, 6394.456471199907, 6459.386358295955, 6485.902711459332, 6380.138681278061, 6393.360663933569, 6395.360463953567, 6401.03984402334, 6401.615903045832, 6229.501639868799, 6232.8130156095385, 6278.4035516625845, 6291.779787707408, 6305.306416294204, 5157.123289040872, 5159.148740457783, 5168.173092305288, 5178.223266510054, 5195.19474481456, 4617.12274667812, 4619.69971951822, 4620.745858977722, 4641.953580464152, 4643.187442197602, 5951.732172052268, 6035.517158627299, 6106.389361063858, 6112.113743507167, 6209.0996805462955, 6313.368663133741, 6353.96823015882, 6375.330590288046, 6383.2978372379, 6417.486601071903, 5140.383154021467, 5579.637323574036, 6125.693715314216, 6221.626702397871, 6235.688215589203, 5210.76551555181, 5718.313802343662, 5725.6850873202375, 5734.770609175586, 5745.080787074048, 5333.306670132858, 6306.4639505642535, 6356.078368636429, 6364.427201551883, 6377.489800816016, 6339.841503962438, 6344.873102538016, 6349.587276826992, 6361.332060133619, 6376.39424254695, 6406.615603063831, 6428.4857211423905, 6444.323346048597, 6507.349265073455, 6537.5096867734155, 6227.314995350417, 6260.937390626035, 6262.248530176408, 6286.0, 6302.968485157545, 6411.647359395091, 6418.29398766126, 6418.871622567616, 6430.421262086435, 6458.128152699325, 6148.815535533941, 6167.229096362955, 6260.780872669617, 6304.211973503312, 6314.242290924934, 6269.937300626935, 6296.087067375113, 6343.111964324906, 6353.174087368612, 6361.904571431525, 6103.822585931194, 6124.693765311806, 6141.232345956755, 6161.476274516537, 6183.84540386494, 5254.710990895537, 6159.784407545714, 6317.968410158103, 6331.651759153291, 6345.0482427636225, 6253.468455181361, 6290.622562646073, 6294.590851594632, 6298.433141017331, 6310.5898116622275], "value": 5872.863367669023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.3456136495315, 909.0, 911.5123408976197, 914.391929366971, 936.5598168860637, 36784.44823327649, 37424.81287593562, 37447.876563703096, 39024.0, 39076.0, 37670.0, 37904.62095379045, 37914.0, 37942.8102859486, 38126.8093659532, 9093.863592046124, 9277.396969196981, 9319.440833550008, 9340.906590934072, 9347.626094956193, 9188.58651360687, 9282.118198771106, 9302.953485232565, 9303.581338839735, 9328.766780830465, 9324.834395700538, 9337.953310233439, 9343.813123737522, 9347.112024357675, 9359.578818953129, 9272.443653380818, 9311.813763724755, 9316.8602470963, 9320.114589114057, 9326.300527460467, 9116.361854670176, 9160.267178625694, 9202.401843880127, 9206.907930920672, 9239.676611318639, 37908.81045594755, 38160.0, 38242.426363604565, 38269.425958610365, 38341.616583834366, 3804.7907365094907, 3836.827342769554, 3850.4801851750217, 3850.6330252760426, 3866.168773713637, 27405.0, 27489.587656185173, 27820.860895695594, 28020.439591208265, 28213.0, 3116.630143657159, 3160.288934989632, 3174.6984036516724, 3197.7441804655573, 3205.3268813549184, 276999.99999999796, 340449.0, 343750.28124859463, 348227.0, 348640.77038844436, 41470.79264603658, 48241.75879120582, 49061.0, 49069.50930490721, 49126.26310605272, 53006.46993530093, 53066.20400693993, 53085.0, 53144.734276328374, 53334.199987000226, 14288.714225715428, 14349.354279057468, 14397.42410303576, 14408.20754858493, 14408.927955360155, 11489.195756297146, 11700.590479333183, 11704.590339338083, 11728.179027467995, 11731.824022639667, 11071.944640276908, 11103.944480277547, 11696.47365868538, 13740.793888091686, 13914.791278130837, 6046.425589568984, 6056.576039677268, 6060.696965151813, 6070.180525629072, 6072.483838873745, 1119.1270808769173, 1121.9046381057537, 1124.7637996020765, 1144.3477217985835, 1164.1850704506878, 25161.993520258984, 26311.47377052448, 26622.733772662414, 26825.463490730075, 26877.193684189504, 1169.561414469574, 1220.1519943639264, 1223.1254652923203, 1230.1020255213743, 1249.2504497301547, 13510.121842080232, 13762.724745505035, 13772.311384430739, 13811.585652430444, 13960.58118256454, 428796.0, 428949.0, 434709.0, 435407.0, 436230.0, 55288.17067743987, 55485.44514554803, 55506.444935550935, 55881.7205913976, 56363.71818140883, 1377.5109836008273, 1440.2438719672257, 1440.8703216710546, 1442.725882082401, 1442.898997070216, 24628.50742985166, 25444.0, 25676.614850777627, 25850.612240816026, 25917.092901748347, 44852.77573612111, 45180.548194517636, 45210.32184517169, 45222.54777452183, 45279.0, 400408.0, 403965.0, 405260.0, 406991.0, 407848.0, 32801.50797737988, 33269.667303326656, 33830.0, 35512.46731298981, 35538.64461355354, 43235.13529729451, 43715.0, 43740.12519749523, 44900.0, 44952.77523612361, 35586.46620300749, 36156.63843361638, 36447.81776091103, 36822.8158859204, 37374.8131259342, 35539.28921421505, 35592.0, 36176.0, 36550.08624784402, 36733.89798306055, 34739.826300868335, 35276.82361588176, 35424.0, 35904.10239744027, 35908.4613730789, 28275.43449131047, 30307.696923030486, 31638.683613163576, 31658.525122123647, 31874.362512750078, 22197.445063873532, 23859.045638174277, 24398.02407903735, 24941.750582494667, 25123.0], "value": 18578.956127808586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.6232595212593, 379.5748761387247, 401.3297792686214, 420.02554074547055, 428.3574638042935, 11498.850114988498, 14645.780313295283, 18470.722939155905, 19257.518562035937, 22436.775632243694, 20612.0, 21229.15083396662, 22331.883405829725, 22379.216727414543, 23067.769322306773, 6346.587471814329, 7209.963950180242, 7495.175530691647, 7690.884636730426, 7711.383089352838, 5784.710764461781, 7607.65765540552, 7628.466007379486, 7685.654145563463, 7690.692372305101, 6600.2409722882, 7434.739784107557, 7676.0, 7690.230976902321, 7692.846143077163, 7600.657970391318, 7723.691052357899, 7724.497907635986, 7758.612069396508, 7763.961180194119, 7351.154617218981, 7461.440391970624, 7484.588347640877, 7519.248075192437, 7526.774196774106, 25616.487670246675, 25798.613020804703, 26805.597916031275, 26843.19470415891, 27251.591226131426, 3215.469447541153, 3339.883104091345, 3360.7647464677484, 3398.6261511233743, 3490.075130090528, 15715.921420392939, 16066.036037837766, 16177.272022759003, 16499.010059396354, 17116.828831711773, 1641.5813967438346, 1898.4399602117408, 1927.7397551330532, 1933.3909818407158, 1968.3406058970263, 155159.0, 161604.99999999884, 164068.0, 166398.0, 168689.15655421643, 23287.301380958597, 23439.531209375717, 23559.0, 23574.410639734146, 23742.0, 36177.0, 36191.91424257276, 36280.45579316312, 36320.27359452849, 36380.27239455196, 10369.792604147875, 10434.21743369235, 10663.306885052602, 10684.893151068545, 10779.461026948622, 8456.746297611082, 8527.786805329917, 8529.061803201643, 8551.401401901807, 8687.39188256816, 10674.466276686135, 10735.248532602644, 10817.242793004572, 10869.0, 10905.83641245366, 3952.703547233969, 4101.589841015874, 4113.259613269581, 4114.300568903233, 4129.946863549776, 876.3952872517942, 879.4986857491297, 918.9448633082036, 928.0811996123789, 931.5528546297815, 20579.0, 21730.239441619466, 21879.890600546896, 21998.34004979853, 23100.306990790305, 731.6524650790939, 732.9083864516936, 881.8853549038712, 907.3648446087633, 933.7432206143229, 10136.493175341204, 11781.764364712657, 11886.821697674543, 11891.643250702493, 11941.343226122646, 391534.0, 394849.0, 621592.911518782, 622069.0, 622282.0, 97747.0, 114215.0, 128862.0, 152065.0, 154702.0, 1274.4265080713717, 1279.9552015679405, 1344.253939063829, 1344.7915573086384, 1347.3398034962797, 21079.683804743247, 21136.894315528323, 21192.682109768673, 21339.67990480175, 21432.357029289145, 47572.52427475681, 60809.391906080375, 62501.0, 62603.0, 62782.0, 88913.7749158855, 88919.0, 89665.10334896567, 90202.54898725465, 90857.54571227102, 11999.580014699444, 12028.819567706316, 12154.088443366605, 12289.262644241375, 12453.377331133226, 12467.625971220878, 13088.345582721016, 13605.727885442433, 13728.588142355746, 14078.366473508511, 9972.9528399517, 11744.471498782405, 11765.352905590275, 11867.406629668654, 11893.82159267629, 11670.70823229426, 11925.986291165349, 11940.880591193976, 12007.099467540143, 12028.27830330183, 9804.988888611679, 11748.060155187735, 11820.881791181979, 12039.63881083569, 12175.939120304341, 11822.763544729229, 12158.209716368408, 12271.631851044483, 12309.907315756522, 12315.568955086886, 11171.218014739216, 11709.180357374902, 11849.407529623657, 11913.285202887855, 12082.214656047328], "value": 11789.676290709012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.8519562848087, 1356.0981947005241, 1509.1171664576223, 1555.152441919154, 1586.920653967302, 10778.838317425245, 11056.778864422708, 11380.829287560693, 11416.31502109874, 11428.200025998183, 8735.388522803407, 9732.65935692251, 9939.260629389864, 10758.515866785994, 10766.192535559825, 2301.171578231835, 2328.057136859566, 2336.719593648756, 2340.754220806816, 2342.3792694935855, 2273.6816845641624, 2305.538892221554, 2311.9884400578057, 2313.3406979010983, 2320.1995311617466, 2270.035235025116, 2283.360659015478, 2286.748457669655, 2288.0504590594883, 2295.8392912496133, 2223.5997520446313, 2233.4528040630066, 2235.698180745595, 2245.0, 2259.0963614554144, 2282.2540756321428, 2323.7211534615785, 2332.685087513198, 2350.4006478348083, 2351.4356554426986, 8964.417312874642, 11244.325340479598, 11296.491657875333, 11304.830427543593, 11356.772864542745, 5747.166660834156, 5837.007708689533, 5949.1968584241, 5963.28440587128, 5963.52291816658, 3360.6639336066196, 3461.532693086426, 3638.8908332749793, 3660.835262413171, 3666.926661466782, 974.6446202053581, 1155.9768804623861, 1177.4995626858636, 1215.866254711981, 1216.0818581970555, 15176.964607078518, 15296.929214954958, 15406.075635461908, 15423.22883855814, 15430.228488575527, 4407.920059585358, 4444.488883778342, 4708.505606911293, 4778.713277203379, 4784.7607619619575, 10673.733156671145, 11510.654680359603, 11727.648170554898, 11787.292762434281, 11824.408779560987, 5667.801626943037, 5719.7712091516705, 5751.309842818889, 5755.136729490526, 5759.654420734685, 5081.695098294114, 5140.40885298188, 5193.143131383355, 5251.474852514718, 5291.285676433632, 3763.096856754359, 3842.193139440693, 3845.2693988142164, 3909.6090390961244, 3940.014996250937, 1018.5314755212685, 1021.5198856537415, 1027.6300531808542, 1028.187731691955, 1044.7127040064042, 888.8044630181349, 900.6217388696763, 921.3228277216241, 945.4053300957341, 954.5418199264392, 6592.637404942774, 6605.933940660628, 6606.405423511907, 6628.972509261072, 6695.765648202289, 951.9952400238093, 959.9184069354183, 986.7681094942683, 997.2919227348664, 1047.711879233217, 4096.856610018635, 4201.68487363449, 4204.411382406465, 4324.308110702273, 4340.131973605292, 13457.730845383037, 13692.178469291874, 13894.4442222312, 13913.513027044004, 13915.652108697364, 12858.421371038326, 13655.726885462234, 13818.585442436743, 13834.169949803045, 13847.79228311556, 9993.500324983866, 10366.393209052609, 10376.896231037594, 10397.740056498647, 10399.584016639401, 5736.368999410145, 6612.371824676648, 6711.46308295345, 6798.830029249309, 6953.513254072166, 12065.0, 12400.875991240333, 12413.379331033231, 12421.627351179479, 12434.564790232298, 12339.69150771238, 12805.679858003625, 12807.679808004874, 12832.935835320764, 12869.9704023676, 9112.589933453142, 9442.15020648145, 9454.05459454049, 9461.574229159842, 9465.911420186767, 10160.390376577428, 10336.966303369903, 10406.531706073396, 10417.0, 10448.268621196443, 8476.32189424857, 8492.447990880573, 9023.458592484209, 9106.908930910606, 9368.625254989724, 9014.2788576915, 9051.95474022652, 9055.139761722627, 9130.817383652156, 9147.0, 7721.884171737541, 7848.450608457353, 7851.882221766792, 7889.4871833332945, 7893.0, 4676.92984605238, 5831.212786273799, 5833.4749872511675, 5989.910151347821, 6017.849553761191, 5563.304586926634, 5785.304453135831, 5973.313068996948, 6048.939510604838, 6119.2350956130485], "value": 5090.992886621958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.36161251203936, 367.90548119344953, 377.0893292698134, 386.3875756925273, 390.5801263641585, 4432.34059564262, 4688.6249100072, 5041.563154500964, 5311.131988726088, 5329.946700532993, 4473.552644735525, 5182.922256166161, 5197.428282888879, 5266.736663166836, 5344.866378340544, 3523.9647603523895, 3646.6171052039617, 3880.7865567393783, 3957.9604203958024, 4326.329418940069, 3549.94675079874, 3591.8204089795404, 3758.3422900992355, 4268.954106243959, 4316.719413238129, 4236.19512292665, 4248.086661367805, 4281.571842815724, 4291.721038132527, 4303.419038429804, 3709.332320182366, 4077.2060293470927, 4262.893427664302, 4291.163223171498, 4317.589828966243, 3533.0637381093775, 3587.3542762302777, 3971.0, 3974.920501589952, 4008.8997775055564, 4420.535843736426, 4516.864494065183, 4691.812327506896, 4963.975180124076, 5143.974280128613, 4800.951990480085, 4905.8773530661665, 4931.482194369575, 5022.497750224985, 5105.770240339194, 4668.486466488684, 5267.604929630293, 5489.368722596912, 5632.35227948787, 5691.0, 4158.2307273154565, 4193.643540299078, 4339.284018137004, 4356.886909848721, 4423.451791872819, 4802.7118372897385, 5445.564354851642, 5483.369412517532, 5841.0, 5866.120081987693, 4411.382406463098, 4426.778661066934, 4432.1634154141375, 4441.936192740279, 4482.439695038121, 4316.503602085801, 4532.388127602731, 4581.518940511265, 4584.6561507887045, 4659.088069956278, 4236.978815105905, 4299.634531064895, 4352.585409741847, 4919.2867034279825, 4977.954629527767, 4640.86077417678, 5443.7881649826, 5559.943610713952, 5588.776448941997, 5601.915971260434, 1450.6590951126477, 1477.7955965887982, 1575.3855996161506, 1576.5979675182755, 1580.9841901581067, 1054.8997845204694, 1077.2136340471343, 1167.4629670351565, 1191.5948577483698, 1200.4837919694442, 4532.410786597721, 4754.7147171169145, 5214.32213812202, 5222.503862133167, 5374.758135883894, 4772.95227047732, 4877.951240483313, 5325.3875804282225, 5463.945360546344, 5764.155470249564, 4298.9570104298555, 4591.357209990604, 4601.608863246594, 4757.714537127784, 5189.273501709688, 2640.379510814957, 2708.268767432782, 2795.720427957229, 2842.616246806696, 3020.758339332848, 5573.832785016456, 5901.436119428355, 5918.7928422505, 5968.910466343008, 5985.46130848217, 4904.485029071896, 5069.0, 5354.788445403314, 5390.784368625289, 5997.7001149942325, 5195.0, 5505.054286784056, 5514.007478653881, 5939.46544810969, 5982.54300546096, 5362.51737343641, 5478.781093657075, 5609.157726957047, 5744.597878148489, 5782.2194003808945, 5320.153717760979, 5350.92981403713, 5390.595705322038, 5577.295011919297, 5742.966266072147, 5201.777582268088, 5884.762970661117, 5892.292924849045, 5961.254843144607, 5969.4627483524955, 3770.585235624134, 4007.2786898358577, 4447.508016902887, 4520.864374068652, 4562.520935301745, 4739.739314337607, 4935.333729946555, 5129.563987061141, 5598.916016259678, 5806.854828629149, 4692.038132182963, 4727.3854398927915, 5185.451566823614, 5336.439673834191, 5577.804776832953, 4787.8563643090765, 4820.758962051954, 4909.729964851967, 5240.842774716764, 5600.131979543177, 4974.482782751295, 5367.0, 5466.5900057495055, 5521.475459831309, 5561.777528898799, 4921.188003979303, 5203.843884683465, 5220.295260139833, 5562.527185189304, 5646.2942132233475, 4876.926846097383, 5422.566194704493, 5455.372632147354, 5461.42655021233, 5554.028045092174], "value": 4180.863162375245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8367415286644, 722.4798145335359, 735.1435577552155, 768.6387397922978, 807.7617102954626, 14944.327505262263, 15630.29663665135, 16168.191590420462, 16300.673986520278, 16366.672666546661, 13288.667783305422, 14496.985211035231, 14960.625984350396, 14973.77539336908, 15170.013949093302, 902.467544148952, 915.945043297401, 925.2875286029753, 939.7556635274809, 942.5004747483845, 904.8914130304373, 937.9812403751921, 938.2681508423441, 941.8728471656307, 945.4988855906346, 967.4292167621102, 993.3344659078399, 993.5429702336897, 996.0587245053428, 996.6611352140271, 861.6036623153357, 979.1432496565506, 980.9656662016866, 981.0336818234034, 989.3964681544252, 711.2602892991283, 724.2214619284238, 730.5981710059499, 732.9010583571203, 738.8695296196828, 14037.22795246261, 14245.358958846877, 14261.64345891361, 15484.0, 16574.419895303607, 14501.129932204101, 14627.70744585113, 14655.706885862222, 14702.705945881129, 14911.552653420415, 9851.704448866545, 11459.598914038052, 11586.304821710724, 11631.6510504685, 11961.64115076549, 3685.870994515206, 3720.4233343831747, 3760.341940160461, 3775.3581891078584, 3883.2427676603074, 51730.87786126001, 62768.0, 87762.56118719366, 106962.46518767356, 107138.46430767796, 9537.713868583953, 11447.54209831614, 11450.370229637283, 11525.88474115265, 12223.755524889453, 24216.0, 24406.145784897442, 24464.0, 24468.26595202147, 24471.265862024167, 7535.962320188364, 7701.0, 7759.57322347265, 7892.723754668674, 7939.841203175904, 4164.0, 4237.216115018731, 4241.172971270573, 4245.5542168072525, 4247.129338485603, 3144.6698096699974, 3175.95193586116, 3180.777345585787, 3204.0548038328748, 3209.0533292678715, 525.5322762741164, 620.5407998081387, 626.8150895485843, 628.0547775597696, 636.2873581588558, 564.4722184757265, 572.7399720614582, 612.5712001598898, 613.4052955996161, 635.6345101566525, 8608.612612432456, 9166.633334666672, 9656.855147172799, 9733.0, 9733.464659443798, 541.6552786543081, 600.891839468891, 620.7051650465993, 668.3149771484268, 672.5393105722595, 4297.90403447119, 4428.716478528397, 4711.505291944365, 4796.251343069744, 4861.70829750209, 91458.0, 98049.50975245079, 103976.48011760044, 104896.0, 105182.0, 87723.0, 87830.46034475775, 87856.12143878479, 88490.55754721315, 88668.55665721631, 62154.68922655358, 72421.6378918102, 79039.0, 79193.20806791974, 79228.0, 7800.297973182441, 9044.276457883485, 9071.546422678972, 9158.58786354629, 9236.861447078434, 43845.0, 45964.54035459736, 47739.0, 48581.0, 49343.013139736286, 68036.0, 68725.3127468739, 69520.6523967377, 69740.30259697339, 70755.0, 11134.3876086816, 13153.01352398593, 13578.592642220749, 13958.323961473021, 14274.785878212042, 14205.928970355495, 14238.359273832495, 14450.060746051473, 14461.961949527957, 14657.706845863237, 13410.396532156272, 13631.931840340734, 13799.0, 14082.507112251022, 14113.435462581381, 13178.538751143664, 13423.127496712683, 13516.86483135156, 13520.729585408433, 13982.0, 13187.406566704329, 13335.133216340906, 13359.398827052612, 13614.18314901109, 13730.794038089636, 10653.254272201182, 10824.67525974222, 10833.729156771144, 11012.889871101186, 11562.826557601475, 7876.199788477967, 9510.239180865652, 11167.218294719292, 11271.492782824957, 11333.206675532634], "value": 7428.096943809697, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1608.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 121.0, 127.0, 118.0, 121.0, 119.0, 120.0, 128.0, 119.0, 104.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 129.0, 187.0, 140.0, 98.0, 135.0, 146.0, 163.0, 107.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 213.0, 248.0, 231.0, 222.0, 200.0, 288.0, 246.0, 190.0, 203.0], "value": 223.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 58.0, 62.0, 88.0, 64.0, 76.0, 59.0, 59.0, 101.0, 88.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 87.0, 72.0, 69.0, 74.0, 95.0, 105.0, 70.0, 85.0], "value": 81.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 105.0, 89.0, 88.0, 88.0, 94.0, 96.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 144.0, 97.0, 125.0, 156.0, 133.0, 99.0, 143.0, 146.0, 97.0], "value": 129.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 96.0, 148.0, 94.0, 147.0, 91.0, 142.0, 151.0, 92.0, 91.0], "value": 120.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 68.0, 71.0, 67.0, 68.0, 68.0, 68.0, 67.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 60.0, 63.0, 66.0, 65.0, 58.0, 67.0, 55.0, 59.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 87.0, 85.0, 88.0, 78.0, 99.0, 81.0, 93.0, 108.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 162.0, 149.0, 153.0, 149.0, 160.0, 177.0, 205.0, 165.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 175.0, 171.0, 173.0, 184.0, 171.0, 176.0, 187.0, 244.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 66.0, 67.0, 67.0, 66.0, 66.0, 76.0, 86.0, 90.0], "value": 72.1, "unit": "score"}]}]} 10:56:01 INFO - Return code: 0 10:56:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:56:01 ERROR - # TBPL SUCCESS # 10:56:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:56:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:56:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:56:01 INFO - 2017-03-10 10:56:01.354 screenresolution[2241:20016] starting screenresolution argv=screenresolution get 10:56:01 INFO - 2017-03-10 10:56:01.358 screenresolution[2241:20016] Display 0: 1600x1200x32@60 10:56:01 INFO - 2017-03-10 10:56:01.365 screenresolution[2242:20019] starting screenresolution argv=screenresolution list 10:56:01 INFO - Available Modes on Display 0 10:56:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:56:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:56:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:56:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:56:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:56:01 INFO - Intel Iris: 10:56:01 INFO - Chipset Model: Intel Iris 10:56:01 INFO - Type: GPU 10:56:01 INFO - Bus: Built-In 10:56:01 INFO - VRAM (Dynamic, Max): 1536 MB 10:56:01 INFO - Vendor: Intel (0x8086) 10:56:01 INFO - Device ID: 0x0a2e 10:56:01 INFO - Revision ID: 0x0009 10:56:01 INFO - Displays: 10:56:01 INFO - Display: 10:56:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:56:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:56:01 INFO - Display Serial Number: 1600x1200 60 10:56:01 INFO - Main Display: Yes 10:56:01 INFO - Mirror: Off 10:56:01 INFO - Online: Yes 10:56:01 INFO - Rotation: Supported 10:56:01 INFO - Return code: 0 10:56:01 INFO - Running post-action listener: _resource_record_post_action 10:56:01 INFO - [mozharness: 2017-03-10 18:56:01.602636Z] Finished run-tests step (success) 10:56:01 INFO - Running post-run listener: _resource_record_post_run 10:56:01 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 287232; Write bytes: 515668992; Read time: 3; Write time: 1665 10:56:01 INFO - TinderboxPrint: CPU usage
55.0% 10:56:01 INFO - TinderboxPrint: I/O read bytes / time
287,232 / 3 10:56:01 INFO - TinderboxPrint: I/O write bytes / time
515,668,992 / 1,665 10:56:01 INFO - TinderboxPrint: CPU idle
2,164.5 (45.0%) 10:56:01 INFO - TinderboxPrint: CPU system
973.4 (20.3%) 10:56:01 INFO - TinderboxPrint: CPU user
1,667.8 (34.7%) 10:56:01 INFO - TinderboxPrint: Swap in / out
209,608,704 / 0 10:56:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205163008; Write bytes: 202029056; Read time: 15636; Write time: 452 10:56:01 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 286720; Write bytes: 302760960; Read time: 3; Write time: 1177 10:56:02 INFO - Running post-run listener: _upload_blobber_files 10:56:02 INFO - Blob upload gear active. 10:56:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:56:02 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 10:56:02 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'] 10:56:02 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 10:56:02 INFO - (blobuploader) - INFO - Open directory for files ... 10:56:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:56:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:03 INFO - (blobuploader) - INFO - Done attempting. 10:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:56:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:04 INFO - (blobuploader) - INFO - Done attempting. 10:56:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:56:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:56:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:05 INFO - (blobuploader) - INFO - Done attempting. 10:56:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:56:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:56:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:07 INFO - (blobuploader) - INFO - Done attempting. 10:56:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:56:07 INFO - Return code: 0 10:56:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:56:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:56:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e3abc3e449564656c2d0bdae1d302281aea81b60f92d78b77cf94c6c85dec3194d45de2c8a78e2c5297b618a0c8c5d54926f45e07a7aa076da9776be22b550b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b769b3d6b82abc6d3f677ef796a7dc34bc39b94405cf5b4f21c7a6b0b0d5e787224e17920c31e060c50f89052f7391c77e8d13a5c62365989e4b819f1a3962ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/060590cfe33226b2f70efca7fbcb9c6ad298997520b56be97ab582b421fd11c7101a8f70ff718786c0aaed8583a5c7157913cf7541079d6296f6f1a3723aab1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85f280b68801a47c81f38cb53882a0149be9348068152a89404c9904c31de67563a45f8c8f5d6a4b307e070c3e4f2286eaaaa3085dbd77923b1dc556cd9e9d00"} 10:56:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:56:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:56:07 INFO - Contents: 10:56:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e3abc3e449564656c2d0bdae1d302281aea81b60f92d78b77cf94c6c85dec3194d45de2c8a78e2c5297b618a0c8c5d54926f45e07a7aa076da9776be22b550b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b769b3d6b82abc6d3f677ef796a7dc34bc39b94405cf5b4f21c7a6b0b0d5e787224e17920c31e060c50f89052f7391c77e8d13a5c62365989e4b819f1a3962ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/060590cfe33226b2f70efca7fbcb9c6ad298997520b56be97ab582b421fd11c7101a8f70ff718786c0aaed8583a5c7157913cf7541079d6296f6f1a3723aab1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85f280b68801a47c81f38cb53882a0149be9348068152a89404c9904c31de67563a45f8c8f5d6a4b307e070c3e4f2286eaaaa3085dbd77923b1dc556cd9e9d00"} 10:56:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:56:07 INFO - Copying logs to upload dir... 10:56:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:56:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.762414 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-10 10:56:07.694293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 10:56:07.698101) ========= 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.HpPeaz5sOz/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.hODPzPOFKn/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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/1e3abc3e449564656c2d0bdae1d302281aea81b60f92d78b77cf94c6c85dec3194d45de2c8a78e2c5297b618a0c8c5d54926f45e07a7aa076da9776be22b550b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b769b3d6b82abc6d3f677ef796a7dc34bc39b94405cf5b4f21c7a6b0b0d5e787224e17920c31e060c50f89052f7391c77e8d13a5c62365989e4b819f1a3962ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/060590cfe33226b2f70efca7fbcb9c6ad298997520b56be97ab582b421fd11c7101a8f70ff718786c0aaed8583a5c7157913cf7541079d6296f6f1a3723aab1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85f280b68801a47c81f38cb53882a0149be9348068152a89404c9904c31de67563a45f8c8f5d6a4b307e070c3e4f2286eaaaa3085dbd77923b1dc556cd9e9d00"} build_url:https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/OrXGIFCKTiO8PcA7Jv2ZLw/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/1e3abc3e449564656c2d0bdae1d302281aea81b60f92d78b77cf94c6c85dec3194d45de2c8a78e2c5297b618a0c8c5d54926f45e07a7aa076da9776be22b550b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b769b3d6b82abc6d3f677ef796a7dc34bc39b94405cf5b4f21c7a6b0b0d5e787224e17920c31e060c50f89052f7391c77e8d13a5c62365989e4b819f1a3962ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/060590cfe33226b2f70efca7fbcb9c6ad298997520b56be97ab582b421fd11c7101a8f70ff718786c0aaed8583a5c7157913cf7541079d6296f6f1a3723aab1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85f280b68801a47c81f38cb53882a0149be9348068152a89404c9904c31de67563a45f8c8f5d6a4b307e070c3e4f2286eaaaa3085dbd77923b1dc556cd9e9d00"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 10:56:07.732955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:56:07.733279) ========= 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.HpPeaz5sOz/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.hODPzPOFKn/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005130 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 10:56:07.781556) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 10:56:07.781874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 10:56:07.782191) ========= ========= Total master_lag: 0.18 =========