From: Marcel Raad [mailto:marcel.r...@teamviewer.com] Sent: Thursday, March 14, 2019 3:59 PM To: libcurl development <curl-library@cool.haxx.se> Cc: Michael Schultz <michael.schu...@microfocus.com> Subject: RE: Test failures on aix 7.2
Hi Michael, > -----Original Message----- > From: curl-library <curl-library-boun...@cool.haxx.se> On Behalf Of > Michael Schultz via curl-library > Sent: Donnerstag, 14. März 2019 20:59 > To: libcurl development <curl-library@cool.haxx.se> > Cc: Michael Schultz <michael.schu...@microfocus.com> > Subject: Test failures on aix 7.2 > > All the tests run except for 1435 and 1436. I cannot comment on the SMB server verification failure, but can you please run the failing tests in verbose mode with ./runtests.pl -a -v -p 1435 1436 Thanks, Marcel ======= Of course! [aix72v1-hub]./runtests.pl -a -v -p 1435 1436 CMD (0): ../src/curl --version 1>log/curlverout.log 2>log/curlvererr.log ********* System characteristics ******** * curl 7.64.0 (powerpc64-ibm-aix7.2.0.0) * libcurl/7.64.0 OpenSSL/1.1.1a * Features: AsynchDNS Largefile NTLM NTLM_WB SSL TLS-SRP UnixSockets HTTPS-proxy * Host: aix72v1 * System: AIX aix72v1 2 7 00FAA87F4C00 * Servers: HTTP-unix * Env: * Ports: * HTTP/8990 FTP/8992 FTP2/8995 RTSP/9007 * TFTP/8997 * GOPHER/9009 * SSH/8999 SOCKS/9000 POP3/9001 IMAP/9003 SMTP/9005 * Unix socket paths: * HTTP-Unix:http.sock ***************************************** startnew: perl -I. ./httpserver.pl --pidfile ".http_unix_server.pid" --logfile "log/http_unix_server.log" --unix-socket 'http.sock' --srcdir "." RUN: ../src/curl --max-time 13 --output log/http_unix_verify.out --silent --verbose --globoff --unix-socket 'http.sock' "http://127.0.0.1:80/verifiedserver"; 2>log/http_unix_verify.log CMD (0): ../src/curl --max-time 13 --output log/http_unix_verify.out --silent --verbose --globoff --unix-socket 'http.sock' "http://127.0.0.1:80/verifiedserver"; 2>log/http_unix_verify.log RUN: HTTP-unix server is now running PID 15597844 * pid http-unix => 15597844 15597844 test 1435...[simple HTTP GET over Unix socket] ../src/curl --output log/curl1435.out --include --trace-ascii log/trace1435 --trace-time --unix-socket http.sock http://server-interpreted.example.com/1435 >log/stdout1435 2>log/stderr1435 CMD (0): ../src/curl --output log/curl1435.out --include --trace-ascii log/trace1435 --trace-time --unix-socket http.sock http://server-interpreted.example.com/1435 >log/stdout1435 2>log/stderr1435 1435: data FAILED: --- log/check-expected 2019-03-14 21:21:45.000000000 +0000 +++ log/check-generated 2019-03-14 21:21:45.000000000 +0000 @@ -1,5 +1 @@ - HTTP/1.1 200 OK[LF] - Date: Sun, 16 Nov 2014 23:47:38 GMT[LF] - Content-Length: 17[LF] - [LF] Based on test300[LF] == Contents of files in the log/ dir after test 1435 === Start of file check-expected HTTP/1.1 200 OK[LF] Date: Sun, 16 Nov 2014 23:47:38 GMT[LF] Content-Length: 17[LF] [LF] Based on test300[LF] === End of file check-expected === Start of file check-generated Based on test300[LF] === End of file check-generated === Start of file curl.log ../src/curl --output log/curl1435.out --include --trace-ascii log/trace1435 --trace-time --unix-socket http.sock http://server-interpreted.example.com/1435 >log/stdout1435 2>log/stderr1435 === End of file curl.log === Start of file curl1435.out Based on test300 === End of file curl1435.out === Start of file curlverout.log curl 7.64.0 (powerpc64-ibm-aix7.2.0.0) libcurl/7.64.0 OpenSSL/1.1.1a Release-Date: 2019-02-06 Protocols: dict file ftp ftps gopher http https imap imaps pop3 pop3s rtsp smb smbs smtp smtps telnet tftp Features: AsynchDNS Largefile NTLM NTLM_WB SSL TLS-SRP UnixSockets HTTPS-proxy === End of file curlverout.log === Start of file http_unix_server.log 21:21:43.035625 Running HTTP unix version on http.sock 21:21:43.036675 Wrote pid 15597844 to .http_unix_server.pid 21:21:44.027364 ====> Client connect 21:21:44.027402 accept_connection 3 returned 4 21:21:44.027421 accept_connection 3 returned 0 21:21:44.027453 Read 87 bytes 21:21:44.027471 Process 87 bytes request 21:21:44.027555 Got request: GET /verifiedserver HTTP/1.1 21:21:44.027573 Are-we-friendly question received 21:21:44.027894 Wrote request (87 bytes) input to log/server.input 21:21:44.027939 Identifying ourselves as friends 21:21:44.028360 Response sent (59 bytes) and written to log/server.response 21:21:44.028380 special request received, no persistency 21:21:44.028397 ====> Client disconnect 0 21:21:45.048544 ====> Client connect 21:21:45.048580 accept_connection 3 returned 4 21:21:45.048600 accept_connection 3 returned 0 21:21:45.048633 Read 98 bytes 21:21:45.048651 Process 98 bytes request 21:21:45.048682 Got request: GET /1435 HTTP/1.1 21:21:45.048699 Requested test number 1435 part 0 21:21:45.048744 - request found to be complete 21:21:45.049072 Wrote request (98 bytes) input to log/server.input 21:21:45.049110 Send response test1435 section <data> 21:21:45.049191 Response sent (89 bytes) and written to log/server.response 21:21:45.049209 => persistent connection request ended, awaits new request 21:21:45.050030 Connection closed by client 21:21:45.050050 ====> Client disconnect 0 === End of file http_unix_server.log === Start of file http_unix_verify.log * Expire in 0 ms for 6 (transfer 0x11008f050) * Expire in 13000 ms for 8 (transfer 0x11008f050) * Trying http.sock... * Expire in 200 ms for 4 (transfer 0x11008f050) * ssloc inet_ntop() failed with errno 66: Addr family not supported by protocol * Connected to 127.0.0.1 (http.sock) port 80 (#0) > GET /verifiedserver HTTP/1.1 > Host: 127.0.0.1 > User-Agent: curl/7.64.0 > Accept: */* > < HTTP/1.1 200 OK < Content-Length: 20 < { [20 bytes data] * Connection #0 to host 127.0.0.1 left intact === End of file http_unix_verify.log === Start of file http_unix_verify.out WE ROOLZ: 15597844 === End of file http_unix_verify.out === Start of file server.input GET /1435 HTTP/1.1 Host: server-interpreted.example.com User-Agent: curl/7.64.0 Accept: */* === End of file server.input === Start of file server.response HTTP/1.1 200 OK Content-Length: 20 WE ROOLZ: 15597844 HTTP/1.1 200 OK Date: Sun, 16 Nov 2014 23:47:38 GMT Content-Length: 17 Based on test300 === End of file server.response === Start of file stderr1435 % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 17 100 17 0 0 8500 0 --:--:-- --:--:-- --:--:-- 8500 === End of file stderr1435 === Start of file trace1435 21:21:45.046266 == Info: Expire in 0 ms for 6 (transfer 0x11008f050) 21:21:45.046914 == Info: Trying http.sock... 21:21:45.046965 == Info: Expire in 200 ms for 4 (transfer 0x11008f050) 21:21:45.047814 == Info: ssloc inet_ntop() failed with errno 66: Addr family not supported by protocol 21:21:45.047819 == Info: Connected to server-interpreted.example.com (http.sock) port 80 (#0) 21:21:45.047841 => Send header, 98 bytes (0x62) 0000: GET /1435 HTTP/1.1 0014: Host: server-interpreted.example.com 003a: User-Agent: curl/7.64.0 0053: Accept: */* 0060: 21:21:45.049267 <= Recv header, 16 bytes (0x10) 0000: HTTP/1.1 200 OK. 21:21:45.049280 <= Recv header, 36 bytes (0x24) 0000: Date: Sun, 16 Nov 2014 23:47:38 GMT. 21:21:45.049291 <= Recv header, 19 bytes (0x13) 0000: Content-Length: 17. 21:21:45.049301 <= Recv header, 1 bytes (0x1) 0000: . 21:21:45.049309 <= Recv data, 17 bytes (0x11) 0000: Based on test300. 21:21:45.049910 == Info: Connection #0 to host server-interpreted.example.com left intact === End of file trace1435 test 1436...[HTTP requests with multiple connections over Unix socket] ../src/curl --include --trace-ascii log/trace1436 --trace-time --unix-socket http.sock http://one.example.com/14360001 http://two.example.com/14360002 http://one.example.com/14360003 >log/stdout1436 2>log/stderr1436 CMD (0): ../src/curl --include --trace-ascii log/trace1436 --trace-time --unix-socket http.sock http://one.example.com/14360001 http://two.example.com/14360002 http://one.example.com/14360003 >log/stdout1436 2>log/stderr1436 1436: stdout FAILED: --- log/check-expected 2019-03-14 21:21:45.000000000 +0000 +++ log/check-generated 2019-03-14 21:21:45.000000000 +0000 @@ -1,12 +1,4 @@ - HTTP/1.1 200 OK[LF] - Date: Mon, 17 Nov 2014 13:42:47 GMT[LF] - Content-Length: 6[LF] - [LF] First[LF] - HTTP/1.1 200 OK[LF] - Date: Mon, 17 Nov 2014 13:42:48 GMT[LF] - Content-Length: 7[LF] - [LF] Second[LF] HTTP/1.1 200 OK[LF] Date: Mon, 17 Nov 2014 13:42:49 GMT[LF] == Contents of files in the log/ dir after test 1436 === Start of file check-expected HTTP/1.1 200 OK[LF] Date: Mon, 17 Nov 2014 13:42:47 GMT[LF] Content-Length: 6[LF] [LF] First[LF] HTTP/1.1 200 OK[LF] Date: Mon, 17 Nov 2014 13:42:48 GMT[LF] Content-Length: 7[LF] [LF] Second[LF] HTTP/1.1 200 OK[LF] Date: Mon, 17 Nov 2014 13:42:49 GMT[LF] Content-Length: 6[LF] [LF] Third[LF] === End of file check-expected === Start of file check-generated First[LF] Second[LF] HTTP/1.1 200 OK[LF] Date: Mon, 17 Nov 2014 13:42:49 GMT[LF] Content-Length: 6[LF] [LF] Third[LF] === End of file check-generated === Start of file curl.log ../src/curl --output log/curl1435.out --include --trace-ascii log/trace1435 --trace-time --unix-socket http.sock http://server-interpreted.example.com/1435 >log/stdout1435 2>log/stderr1435 ../src/curl --include --trace-ascii log/trace1436 --trace-time --unix-socket http.sock http://one.example.com/14360001 http://two.example.com/14360002 http://one.example.com/14360003 >log/stdout1436 2>log/stderr1436 === End of file curl.log === Start of file curlverout.log curl 7.64.0 (powerpc64-ibm-aix7.2.0.0) libcurl/7.64.0 OpenSSL/1.1.1a Release-Date: 2019-02-06 Protocols: dict file ftp ftps gopher http https imap imaps pop3 pop3s rtsp smb smbs smtp smtps telnet tftp Features: AsynchDNS Largefile NTLM NTLM_WB SSL TLS-SRP UnixSockets HTTPS-proxy === End of file curlverout.log === Start of file http_unix_server.log 21:21:43.035625 Running HTTP unix version on http.sock 21:21:43.036675 Wrote pid 15597844 to .http_unix_server.pid 21:21:44.027364 ====> Client connect 21:21:44.027402 accept_connection 3 returned 4 21:21:44.027421 accept_connection 3 returned 0 21:21:44.027453 Read 87 bytes 21:21:44.027471 Process 87 bytes request 21:21:44.027555 Got request: GET /verifiedserver HTTP/1.1 21:21:44.027573 Are-we-friendly question received 21:21:44.027894 Wrote request (87 bytes) input to log/server.input 21:21:44.027939 Identifying ourselves as friends 21:21:44.028360 Response sent (59 bytes) and written to log/server.response 21:21:44.028380 special request received, no persistency 21:21:44.028397 ====> Client disconnect 0 21:21:45.048544 ====> Client connect 21:21:45.048580 accept_connection 3 returned 4 21:21:45.048600 accept_connection 3 returned 0 21:21:45.048633 Read 98 bytes 21:21:45.048651 Process 98 bytes request 21:21:45.048682 Got request: GET /1435 HTTP/1.1 21:21:45.048699 Requested test number 1435 part 0 21:21:45.048744 - request found to be complete 21:21:45.049072 Wrote request (98 bytes) input to log/server.input 21:21:45.049110 Send response test1435 section <data> 21:21:45.049191 Response sent (89 bytes) and written to log/server.response 21:21:45.049209 => persistent connection request ended, awaits new request 21:21:45.050030 Connection closed by client 21:21:45.050050 ====> Client disconnect 0 21:21:45.081466 ====> Client connect 21:21:45.081503 accept_connection 3 returned 4 21:21:45.081526 accept_connection 3 returned 0 21:21:45.082136 Read 87 bytes 21:21:45.082163 Process 87 bytes request 21:21:45.082200 Got request: GET /14360001 HTTP/1.1 21:21:45.082218 Requested test number 1436 part 1 21:21:45.082265 - request found to be complete 21:21:45.082612 Wrote request (87 bytes) input to log/server.input 21:21:45.082648 Send response test1436 section <data1> 21:21:45.082734 Response sent (77 bytes) and written to log/server.response 21:21:45.082758 => persistent connection request ended, awaits new request 21:21:45.083234 ====> Client connect 21:21:45.083258 accept_connection 3 returned 5 21:21:45.083282 accept_connection 3 returned 0 21:21:45.083317 Read 87 bytes 21:21:45.083335 Process 87 bytes request 21:21:45.083355 Got request: GET /14360002 HTTP/1.1 21:21:45.083372 Requested test number 1436 part 2 21:21:45.083412 - request found to be complete 21:21:45.083437 Wrote request (87 bytes) input to log/server.input 21:21:45.083461 Send response test1436 section <data2> 21:21:45.083545 Response sent (78 bytes) and written to log/server.response 21:21:45.083571 => persistent connection request ended, awaits new request 21:21:45.083998 Read 87 bytes 21:21:45.084023 Process 87 bytes request 21:21:45.084049 Got request: GET /14360003 HTTP/1.1 21:21:45.084069 Requested test number 1436 part 3 21:21:45.084109 - request found to be complete 21:21:45.084133 Wrote request (87 bytes) input to log/server.input 21:21:45.084157 Send response test1436 section <data3> 21:21:45.084241 Response sent (77 bytes) and written to log/server.response 21:21:45.084264 => persistent connection request ended, awaits new request 21:21:45.084639 Connection closed by client 21:21:45.084664 ====> Client disconnect 0 21:21:45.084698 Connection closed by client 21:21:45.084722 ====> Client disconnect 0 === End of file http_unix_server.log === Start of file http_unix_verify.log * Expire in 0 ms for 6 (transfer 0x11008f050) * Expire in 13000 ms for 8 (transfer 0x11008f050) * Trying http.sock... * Expire in 200 ms for 4 (transfer 0x11008f050) * ssloc inet_ntop() failed with errno 66: Addr family not supported by protocol * Connected to 127.0.0.1 (http.sock) port 80 (#0) > GET /verifiedserver HTTP/1.1 > Host: 127.0.0.1 > User-Agent: curl/7.64.0 > Accept: */* > < HTTP/1.1 200 OK < Content-Length: 20 < { [20 bytes data] * Connection #0 to host 127.0.0.1 left intact === End of file http_unix_verify.log === Start of file http_unix_verify.out WE ROOLZ: 15597844 === End of file http_unix_verify.out === Start of file server.input GET /14360001 HTTP/1.1 Host: one.example.com User-Agent: curl/7.64.0 Accept: */* GET /14360002 HTTP/1.1 Host: two.example.com User-Agent: curl/7.64.0 Accept: */* GET /14360003 HTTP/1.1 Host: one.example.com User-Agent: curl/7.64.0 Accept: */* === End of file server.input === Start of file server.response HTTP/1.1 200 OK Content-Length: 20 WE ROOLZ: 15597844 HTTP/1.1 200 OK Date: Sun, 16 Nov 2014 23:47:38 GMT Content-Length: 17 Based on test300 HTTP/1.1 200 OK Date: Mon, 17 Nov 2014 13:42:47 GMT Content-Length: 6 First HTTP/1.1 200 OK Date: Mon, 17 Nov 2014 13:42:48 GMT Content-Length: 7 Second HTTP/1.1 200 OK Date: Mon, 17 Nov 2014 13:42:49 GMT Content-Length: 6 Third === End of file server.response === Start of file stderr1436 % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 6 100 6 0 0 6000 0 --:--:-- --:--:-- --:--:-- 6000 100 7 100 7 0 0 7000 0 --:--:-- --:--:-- --:--:-- 7000 100 6 100 6 0 0 6000 0 --:--:-- --:--:-- --:--:-- 6000 === End of file stderr1436 === Start of file stdout1436 First Second HTTP/1.1 200 OK Date: Mon, 17 Nov 2014 13:42:49 GMT Content-Length: 6 Third === End of file stdout1436 === Start of file trace1436 21:21:45.080418 == Info: Expire in 0 ms for 6 (transfer 0x11008f050) 21:21:45.081076 == Info: Trying http.sock... 21:21:45.081134 == Info: Expire in 200 ms for 4 (transfer 0x11008f050) 21:21:45.082092 == Info: ssloc inet_ntop() failed with errno 66: Addr family not supported by protocol 21:21:45.082097 == Info: Connected to one.example.com (http.sock) port 80 (#0) 21:21:45.082120 => Send header, 87 bytes (0x57) 0000: GET /14360001 HTTP/1.1 0018: Host: one.example.com 002f: User-Agent: curl/7.64.0 0048: Accept: */* 0055: 21:21:45.082760 <= Recv header, 16 bytes (0x10) 0000: HTTP/1.1 200 OK. 21:21:45.082775 <= Recv header, 36 bytes (0x24) 0000: Date: Mon, 17 Nov 2014 13:42:47 GMT. 21:21:45.082791 <= Recv header, 18 bytes (0x12) 0000: Content-Length: 6. 21:21:45.082802 <= Recv header, 1 bytes (0x1) 0000: . 21:21:45.082810 <= Recv data, 6 bytes (0x6) 0000: First. 21:21:45.083108 == Info: Connection #0 to host one.example.com left intact 21:21:45.083157 == Info: Expire in 0 ms for 6 (transfer 0x11008f050) 21:21:45.083191 == Info: Trying http.sock... 21:21:45.083215 == Info: Expire in 200 ms for 4 (transfer 0x11008f050) 21:21:45.083238 == Info: ssloc inet_ntop() failed with errno 66: Addr family not supported by protocol 21:21:45.083244 == Info: Connected to two.example.com (http.sock) port 80 (#1) 21:21:45.083261 => Send header, 87 bytes (0x57) 0000: GET /14360002 HTTP/1.1 0018: Host: two.example.com 002f: User-Agent: curl/7.64.0 0048: Accept: */* 0055: 21:21:45.083548 <= Recv header, 16 bytes (0x10) 0000: HTTP/1.1 200 OK. 21:21:45.083564 <= Recv header, 36 bytes (0x24) 0000: Date: Mon, 17 Nov 2014 13:42:48 GMT. 21:21:45.083579 <= Recv header, 18 bytes (0x12) 0000: Content-Length: 7. 21:21:45.083591 <= Recv header, 1 bytes (0x1) 0000: . 21:21:45.083601 <= Recv data, 7 bytes (0x7) 0000: Second. 21:21:45.083884 == Info: Connection #1 to host two.example.com left intact 21:21:45.083920 == Info: Expire in 0 ms for 6 (transfer 0x11008f050) 21:21:45.083955 == Info: Found bundle for host one.example.com: 0x110094690 [can pipeline] 21:21:45.083964 == Info: Re-using existing connection! (#0) with host one.example.com 21:21:45.083970 == Info: Connected to one.example.com (http.sock) port 80 (#0) 21:21:45.083974 == Info: Expire in 0 ms for 6 (transfer 0x11008f050) 21:21:45.083988 => Send header, 87 bytes (0x57) 0000: GET /14360003 HTTP/1.1 0018: Host: one.example.com 002f: User-Agent: curl/7.64.0 0048: Accept: */* 0055: 21:21:45.084246 <= Recv header, 16 bytes (0x10) 0000: HTTP/1.1 200 OK. 21:21:45.084259 <= Recv header, 36 bytes (0x24) 0000: Date: Mon, 17 Nov 2014 13:42:49 GMT. 21:21:45.084275 <= Recv header, 18 bytes (0x12) 0000: Content-Length: 6. 21:21:45.084288 <= Recv header, 1 bytes (0x1) 0000: . 21:21:45.084298 <= Recv data, 6 bytes (0x6) 0000: Third. 21:21:45.084595 == Info: Connection #0 to host one.example.com left intact === End of file trace1436 * kill pid for http-unix => 15597844 RUN: Process with pid 15597844 signalled to die RUN: Process with pid 15597844 forced to die with SIGKILL TESTDONE: 0 tests out of 2 reported OK: 0% TESTFAIL: These test cases failed: 1435 1436 TESTDONE: 2 tests were considered during 2 seconds. [aix72v1-hub] Mike S ------------------------------------------------------------------- Unsubscribe: https://cool.haxx.se/list/listinfo/curl-library Etiquette: https://curl.haxx.se/mail/etiquette.html
