From: Marcel Raad [mailto:Marcel.Raad_at_teamviewer.com]
Sent: Thursday, March 14, 2019 3:59 PM
To: libcurl development <curl-library_at_cool.haxx.se>
Cc: Michael Schultz <Michael.Schultz_at_microfocus.com>
Subject: RE: Test failures on aix 7.2

Hi Michael,

> -----Original Message-----
> From: curl-library <curl-library-bounces_at_cool.haxx.se> On Behalf Of
> Michael Schultz via curl-library
> Sent: Donnerstag, 14. März 2019 20:59
> To: libcurl development <curl-library_at_cool.haxx.se>
> Cc: Michael Schultz <Michael.Schultz_at_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
Received on 2019-03-14