======================================================
   taler-exchange 0.8.1: src/testing/test-suite.log
======================================================

# TOTAL: 11
# PASS:  8
# SKIP:  2
# XFAIL: 0
# FAIL:  1
# XPASS: 0
# ERROR: 0

.. contents:: :depth: 2

SKIP: test_bank_api_with_pybank
===============================

Dec 10 21:20:29-308160 test-bank-api-30472 INFO Flushing bank database
Dec 10 21:20:29-308340 util-os-installation-30472 INFO Could not find binary `taler-bank-manage' in PATH!
Dec 10 21:20:29-308359 test-bank-api-30472 ERROR Failed to flush the bank db.
Dec 10 21:20:29-308380 test-bank-api-30472 ERROR Assertion failed at test_bank_api.c:196.
SKIP test_bank_api_with_pybank (exit status: 77)

SKIP: test_bank_api_with_nexus
==============================

Dec 10 21:20:29-346000 util-30490 WARNING Error while determining the file size of `/home/ttn/local/.b/taler-exchange-0.8.1/src/testing/test_bank_api_nexus.conf'
Dec 10 21:20:29-346104 test-bank-api-30490 ERROR Assertion failed at testing_api_helpers_bank.c:347.
Dec 10 21:20:29-346121 test-bank-api-30490 ERROR Assertion failed at test_bank_api.c:219.
SKIP test_bank_api_with_nexus (exit status: 77)

FAIL: test_exchange_api_keys_cherry_picking
===========================================

cfg: 0x55c4bf8745e0
exchangedb_plugin.c:51: plugin_name = postgres
exchangedb_plugin.c:56: lib_name = libtaler_plugin_exchangedb_postgres
exchangedb_plugin.c:59: plugin = 0x55c4bf89a140
plugin: 0x55c4bf89a140
Waiting for `taler-exchange-httpd' to be ready (check with: wget -q -t 1 -T 1 http://localhost:8081/keys -o /dev/null -O /dev/null)
.
Dec 10 21:21:40-066545 taler-exchange-httpd-30748 INFO Launching exchange with public key `1HG23E'...
Dec 10 21:21:40-066991 taler-exchange-httpd-30748 INFO Loaded wire fees starting at Wed Jan 01 00:00:00 2020 from file
exchangedb_plugin.c:51: plugin_name = postgres
exchangedb_plugin.c:56: lib_name = libtaler_plugin_exchangedb_postgres
exchangedb_plugin.c:59: plugin = 0x55b785c04af0
Dec 10 21:21:40-072826 taler-exchange-httpd-30748 WARNING Configuration fails to specify option `TERMS_ETAG' in section `exchange'!
Dec 10 21:21:40-072853 taler-exchange-httpd-30748 WARNING Terms of service not configured
Dec 10 21:21:40-072867 taler-exchange-httpd-30748 WARNING Configuration fails to specify option `PRIVACY_ETAG' in section `exchange'!
Dec 10 21:21:40-072880 taler-exchange-httpd-30748 WARNING Privacy policy not configured
Dec 10 21:21:40-072928 taler-exchange-httpd-30748 INFO Loading keys from `/home/ttn/local/.b/taler-exchange-0.8.1/src/testing/test_exchange_api_keys_cherry_picking_home//.local/share/taler/exchange/live-keys/'
Dec 10 21:21:40-091111 taler-exchange-httpd-30748 INFO Adding denomination key `EUR_1-8XX192VWRR4145SA4MBK' (XB7GJ2Y3) to active set
Dec 10 21:21:40-092218 taler-exchange-httpd-30748 INFO Creating /keys for cherry pick date Wed Dec 31 19:00:00 1969
Dec 10 21:21:40-092622 taler-exchange-httpd-30748 INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:40-092964 taler-exchange-httpd-30748 INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:40-092985 taler-exchange-httpd-30748 INFO Creating /keys for cherry pick date Thu Dec 10 21:21:39 2020
Dec 10 21:21:40-093244 taler-exchange-httpd-30748 INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:40-093461 taler-exchange-httpd-30748 INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:41-067636 taler-exchange-httpd-30748 INFO Handling new request
Dec 10 21:21:41-067754 taler-exchange-httpd-30748(C24J2R7YNQXKV3ZJS7A0W60B88) INFO Handling request (GET) for URL '/keys'
Dec 10 21:21:41-067776 taler-exchange-httpd-30748(C24J2R7YNQXKV3ZJS7A0W60B88) INFO Handling request for /keys ((null)/(null))
Dec 10 21:21:41-067800 taler-exchange-httpd-30748(C24J2R7YNQXKV3ZJS7A0W60B88) INFO Filtering /keys by cherry pick date Wed Dec 31 19:00:00 1969 found entry 0/2
Dec 10 21:21:41-067888 taler-exchange-httpd-30748 INFO Request completed
Dec 10 21:21:41-069642 taler-exchange-httpd-30748 INFO Handling new request
Dec 10 21:21:41-069741 taler-exchange-httpd-30748(E0TRZ1ZRTE30GJRVTE3PBJQ0K0) INFO Handling request (GET) for URL '/keys'
Dec 10 21:21:41-069760 taler-exchange-httpd-30748(E0TRZ1ZRTE30GJRVTE3PBJQ0K0) INFO Handling request for /keys ((null)/(null))
Dec 10 21:21:41-069781 taler-exchange-httpd-30748(E0TRZ1ZRTE30GJRVTE3PBJQ0K0) INFO Filtering /keys by cherry pick date Wed Dec 31 19:00:00 1969 found entry 0/2
Dec 10 21:21:41-069864 taler-exchange-httpd-30748 INFO Request completed
Dec 10 21:21:41-070253 test-exchange-api-cherry-picking-30710 INFO Received keys from URL `http://localhost:8081/keys' with status 200.
Dec 10 21:21:41-073225 test-exchange-api-cherry-picking-30710 INFO Successfully downloaded exchange's keys
Dec 10 21:21:41-073281 test-exchange-api-cherry-picking-30710 INFO Connecting to auditor at URL `http://localhost:8083/' (0x56393d801e10).
Dec 10 21:21:41-073432 test-exchange-api-cherry-picking-30710 INFO Requesting auditor version with URL `http://localhost:8083/version'.
Dec 10 21:21:41-073474 test-exchange-api-cherry-picking-30710 INFO Running batched command: check-keys-1
Dec 10 21:21:41-073489 test-exchange-api-cherry-picking-30710 INFO cmd `check-keys-1' (ip: 0), key generation: 1
Dec 10 21:21:41-073612 test-exchange-api-cherry-picking-30710 INFO Running batched command: keyup-1
Dec 10 21:21:41-076131 test-exchange-api-cherry-picking-30710 INFO Received version from URL `http://localhost:8083/version' with status 0.
You must pass absolute time to the `time' option.
Dec 10 21:21:41-085974 test-exchange-api-cherry-picking-30710 INFO Running batched command: check-keys-2
Dec 10 21:21:41-086020 test-exchange-api-cherry-picking-30710 INFO cmd `check-keys-2' (ip: 0), key generation: 1
Dec 10 21:21:41-086035 test-exchange-api-cherry-picking-30710 INFO Triggering GET /keys, cmd `check-keys-2'
Dec 10 21:21:41-086055 test-exchange-api-cherry-picking-30710 INFO Forcing re-download of all exchange keys
Dec 10 21:21:41-095043 taler-exchange-httpd-30748 INFO Handling new request
Dec 10 21:21:41-095151 taler-exchange-httpd-30748(APE125XGXWYKN5CVRJXV1KPPK8) INFO Handling request (GET) for URL '/keys'
Dec 10 21:21:41-095178 taler-exchange-httpd-30748(APE125XGXWYKN5CVRJXV1KPPK8) INFO Handling request for /keys ((null)/1893474000)
Dec 10 21:21:41-095201 taler-exchange-httpd-30748(APE125XGXWYKN5CVRJXV1KPPK8) INFO Loading keys from `/home/ttn/local/.b/taler-exchange-0.8.1/src/testing/test_exchange_api_keys_cherry_picking_home//.local/share/taler/exchange/live-keys/'
Dec 10 21:21:41-096402 taler-exchange-httpd-30748(APE125XGXWYKN5CVRJXV1KPPK8) ERROR Have no denomination keys. Bad configuration.
Dec 10 21:21:41-096449 taler-exchange-httpd-30748(APE125XGXWYKN5CVRJXV1KPPK8) ERROR Failed to initialize key state
Dec 10 21:21:41-096590 taler-exchange-httpd-30748 INFO Request completed
Dec 10 21:21:41-096774 test-exchange-api-cherry-picking-30710 INFO Received keys from URL `http://localhost:8081/keys?now=1893474000' with status 500.
Dec 10 21:21:41-096807 test-exchange-api-cherry-picking-30710 ERROR Unexpected response code 500/1000
Dec 10 21:21:41-096820 test-exchange-api-cherry-picking-30710 INFO Exchange keys download failed
Dec 10 21:21:41-096883 test-exchange-api-cherry-picking-30710 WARNING Got NULL response for /keys during startup (500/1000), retrying!
Dec 10 21:21:41-096906 test-exchange-api-cherry-picking-30710 INFO Disconnecting from auditor at URL `http://localhost:8083/' (0x56393d801e10).
Dec 10 21:21:41-097169 taler-exchange-httpd-30748 INFO Handling new request
Dec 10 21:21:41-097240 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Handling request (GET) for URL '/keys'
Dec 10 21:21:41-097258 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Handling request for /keys ((null)/(null))
Dec 10 21:21:41-097275 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Loading keys from `/home/ttn/local/.b/taler-exchange-0.8.1/src/testing/test_exchange_api_keys_cherry_picking_home//.local/share/taler/exchange/live-keys/'
Dec 10 21:21:41-098757 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Adding denomination key `EUR_1-8XX192VWRR4145SA4MBK' (XB7GJ2Y3) to active set
Dec 10 21:21:41-099560 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Creating /keys for cherry pick date Wed Dec 31 19:00:00 1969
Dec 10 21:21:41-099966 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:41-100528 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:41-100558 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Creating /keys for cherry pick date Thu Dec 10 21:21:39 2020
Dec 10 21:21:41-100875 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:41-101150 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Setting /keys 'Expires' header to 'Fri, 11 Dec 2020 02:21:44 GMT'
Dec 10 21:21:41-101195 taler-exchange-httpd-30748(1M0T2X87CGSR56GJ0G5E3E371M) INFO Filtering /keys by cherry pick date Wed Dec 31 19:00:00 1969 found entry 0/2
Dec 10 21:21:41-101322 taler-exchange-httpd-30748 INFO Request completed
Dec 10 21:21:41-101651 test-exchange-api-cherry-picking-30710 INFO Received keys from URL `http://localhost:8081/keys' with status 200.
Dec 10 21:21:41-104453 test-exchange-api-cherry-picking-30710 INFO Successfully downloaded exchange's keys
Dec 10 21:21:41-104476 test-exchange-api-cherry-picking-30710 INFO Connecting to auditor at URL `http://localhost:8083/' (0x56393d804380).
Dec 10 21:21:41-104525 test-exchange-api-cherry-picking-30710 INFO Requesting auditor version with URL `http://localhost:8083/version'.
Dec 10 21:21:41-104558 test-exchange-api-cherry-picking-30710 INFO Running batched command: check-keys-2
Dec 10 21:21:41-104572 test-exchange-api-cherry-picking-30710 INFO cmd `check-keys-2' (ip: 0), key generation: 2
Dec 10 21:21:41-104586 test-exchange-api-cherry-picking-30710 ERROR Assertion failed at testing_api_cmd_check_keys.c:163.
Dec 10 21:21:41-104598 test-exchange-api-cherry-picking-30710 ERROR Got 1 keys in step check-keys-2, expected 2
Dec 10 21:21:41-104615 test-exchange-api-cherry-picking-30710 ERROR Failed at command `ordinary-cherry-pick'
Dec 10 21:21:41-104629 test-exchange-api-cherry-picking-30710 ERROR Batch is at command `check-keys-2'
Dec 10 21:21:41-104779 test-exchange-api-cherry-picking-30710 INFO Received version from URL `http://localhost:8083/version' with status 0.
Dec 10 21:21:41-104809 test-exchange-api-cherry-picking-30710 INFO Executing shutdown at `ordinary-cherry-pick'
Dec 10 21:21:41-104824 test-exchange-api-cherry-picking-30710 INFO Disconnecting from auditor at URL `http://localhost:8083/' (0x56393d804380).
FAIL test_exchange_api_keys_cherry_picking (exit status: 1)