I1121 16:21:01.684251836 75933 ev_epoll_linux.c:86] epoll engine will be using signal: 40 D1121 16:21:01.684285365 75933 ev_posix.c:107] Using polling engine: epoll I1121 16:21:01.684385218 75933 init.c:216] grpc_init(void) I1121 16:21:01.684489786 75933 metadata_array.c:42] grpc_metadata_array_init(array=0x7ffb29cf6f10) I1121 16:21:01.934287252 75933 init.c:216] grpc_init(void) I1121 16:21:01.934335320 75933 ssl_credentials.c:127] grpc_ssl_credentials_create(pem_root_certs=-----BEGIN CERTIFICATE----- MIICSjCCAbOgAwIBAgIJAJHGGR4dGioHMA0GCSqGSIb3DQEBCwUAMFYxCzAJBgNV BAYTAkFVMRMwEQYDVQQIEwpTb21lLVN0YXRlMSEwHwYDVQQKExhJbnRlcm5ldCBX aWRnaXRzIFB0eSBMdGQxDzANBgNVBAMTBnRlc3RjYTAeFw0xNDExMTEyMjMxMjla Fw0yNDExMDgyMjMxMjlaMFYxCzAJBgNVBAYTAkFVMRMwEQYDVQQIEwpTb21lLVN0 YXRlMSEwHwYDVQQKExhJbnRlcm5ldCBXaWRnaXRzIFB0eSBMdGQxDzANBgNVBAMT BnRlc3RjYTCBnzANBgkqhkiG9w0BAQEFAAOBjQAwgYkCgYEAwEDfBV5MYdlHVHJ7 +L4nxrZy7mBfAVXpOc5vMYztssUI7mL2/iYujiIXM+weZYNTEpLdjyJdu7R5gGUu g1jSVK/EPHfc74O7AyZU34PNIP4Sh33N+/A5YexrNgJlPY+E3GdVYi4ldWJjgkAd Qah2PH5ACLrIIC6tRka9hcaBlIECAwEAAaMgMB4wDAYDVR0TBAUwAwEB/zAOBgNV HQ8BAf8EBAMCAgQwDQYJKoZIhvcNAQELBQADgYEAHzC7jdYlzAVmddi/gdAeKPau sPBG/C2HCWqHzpCUHcKuvMzDVkY/MP2o6JIW2DBbY64bO/FceExhjcykgaYtCH/m oIU63+CFOTtR7otyQAWHqXa7q4SbCDlG7DyRFxqG0txPtGvy12lgldA2+RgcigQG Dfcog5wrJytaQ6UA0wE= -----END CERTIFICATE----- , pem_key_cert_pair=(nil), reserved=(nil)) I1121 16:21:01.950220504 75933 init.c:216] grpc_init(void) I1121 16:21:01.950236284 75933 metadata_array.c:42] grpc_metadata_array_init(array=0x7ffb2a3dd0b0) I1121 16:21:01.950551187 75933 init.c:216] grpc_init(void) I1121 16:21:01.950563912 75933 init.c:216] grpc_init(void) I1121 16:21:01.950572140 75933 secure_channel_create.c:309] grpc_secure_channel_create(creds=0x7ffb2a2ffa30, target=127.0.0.1:27388, args=0x7ffb2a3dfcc0, reserved=(nil)) I1121 16:21:01.951043037 75933 init.c:216] grpc_init(void) I1121 16:21:01.951053713 75933 completion_queue.c:137] grpc_completion_queue_create(reserved=(nil)) I1121 16:21:01.951264710 75933 init.c:216] grpc_init(void) I1121 16:21:01.951282540 75933 metadata_array.c:42] grpc_metadata_array_init(array=0x7ffb2a3dd6f0) I1121 16:21:01.951289720 75933 init.c:216] grpc_init(void) I1121 16:21:01.951295349 75933 init.c:216] grpc_init(void) I1121 16:21:01.951298961 75933 init.c:216] grpc_init(void) I1121 16:21:01.951307052 75933 init.c:216] grpc_init(void) I1121 16:21:01.951311845 75933 init.c:216] grpc_init(void) I1121 16:21:01.951315004 75933 init.c:216] grpc_init(void) I1121 16:21:01.951318181 75933 metadata_array.c:42] grpc_metadata_array_init(array=0x7ffb2a3dd6a0) I1121 16:21:01.951323388 75933 init.c:216] grpc_init(void) I1121 16:21:01.951326692 75933 init.c:216] grpc_init(void) I1121 16:21:01.951330181 75933 init.c:216] grpc_init(void) I1121 16:21:01.951333371 75933 init.c:216] grpc_init(void) I1121 16:21:01.951336500 75933 metadata_array.c:42] grpc_metadata_array_init(array=0x7ffb2a3dd740) I1121 16:21:01.951344669 75933 init.c:216] grpc_init(void) I1121 16:21:01.951350707 75933 channel.c:228] grpc_channel_create_call(channel=0x7ffb2a081130, parent_call=(nil), propagation_mask=0, cq=0x7ffb2a033110, method=/grpc.testing.TestService/UnaryCall, host=(null), deadline=gpr_timespec { tv_sec: 9223372036854775807, tv_nsec: 0, clock_type: 1 }, reserved=(nil)) I1121 16:21:01.951611722 75933 init.c:216] grpc_init(void) I1121 16:21:01.951629003 75933 init.c:216] grpc_init(void) I1121 16:21:01.951649254 75933 call.c:1678] grpc_call_start_batch(call=0x7ffb29fdbfc0, ops=0x7ffb29cbc7d0, nops=6, tag=0x7ffb29f67d70, reserved=(nil)) I1121 16:21:01.951660132 75933 call.c:1351] ops[0]: SEND_INITIAL_METADATA key=x-GRPC-test-echo-initial value=74 65 73 74 5f 69 6e 69 74 69 61 6c 5f 6d 65 74 61 64 61 74 61 5f 76 61 6c 75 65 'test_initial_metadata_value' key=x-grpc-test-echo-trailing-bin value=0a 0b 0a 0b 0a 0b '......' I1121 16:21:01.951671286 75933 call.c:1351] ops[1]: SEND_MESSAGE ptr=0x7ffb29c6b480 I1121 16:21:01.951675495 75933 call.c:1351] ops[2]: SEND_CLOSE_FROM_CLIENT I1121 16:21:01.951663388 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774062, tv_nsec: 151656193, clock_type: 1 }, reserved=(nil)) I1121 16:21:01.951679157 75933 call.c:1351] ops[3]: RECV_INITIAL_METADATA ptr=0x7ffb2a3dd6a0 I1121 16:21:01.951699185 75933 call.c:1351] ops[4]: RECV_MESSAGE ptr=0x7ffb26acd238 I1121 16:21:01.951704316 75933 call.c:1351] ops[5]: RECV_STATUS_ON_CLIENT metadata=0x7ffb2a3dd740 status=0x7ffb29fa88a8 details=0x7ffb29fa88b0 E1121 16:21:01.951713364 75933 call.c:610] attempt to send invalid metadata key: x-GRPC-test-echo-initial I1121 16:21:01.951719511 75933 init.c:221] grpc_shutdown(void) I1121 16:21:02.151944311 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:02.151980255 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774062, tv_nsec: 351977290, clock_type: 1 }, reserved=(nil)) I1121 16:21:02.352245015 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:02.352293120 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774062, tv_nsec: 552288509, clock_type: 1 }, reserved=(nil)) I1121 16:21:02.552568681 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:02.552613250 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774062, tv_nsec: 752609044, clock_type: 1 }, reserved=(nil)) I1121 16:21:02.752858521 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:02.752901931 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774062, tv_nsec: 952897752, clock_type: 1 }, reserved=(nil)) I1121 16:21:02.953253270 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:02.953298601 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774063, tv_nsec: 153294228, clock_type: 1 }, reserved=(nil)) I1121 16:21:03.153386129 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:03.153431868 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774063, tv_nsec: 353427404, clock_type: 1 }, reserved=(nil)) I1121 16:21:03.353675957 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:03.353718237 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774063, tv_nsec: 553713830, clock_type: 1 }, reserved=(nil)) I1121 16:21:03.553980458 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:03.554011734 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774063, tv_nsec: 754008574, clock_type: 1 }, reserved=(nil)) I1121 16:21:03.754113422 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:03.754169381 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774063, tv_nsec: 954164898, clock_type: 1 }, reserved=(nil)) I1121 16:21:03.954460097 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:03.954519524 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774064, tv_nsec: 154514790, clock_type: 1 }, reserved=(nil)) I1121 16:21:04.154792894 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:04.154838916 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774064, tv_nsec: 354834593, clock_type: 1 }, reserved=(nil)) I1121 16:21:04.355095306 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:04.355151592 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774064, tv_nsec: 555145104, clock_type: 1 }, reserved=(nil)) I1121 16:21:04.555403559 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:04.555446318 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774064, tv_nsec: 755442158, clock_type: 1 }, reserved=(nil)) I1121 16:21:04.755692587 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:04.755736729 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774064, tv_nsec: 955732246, clock_type: 1 }, reserved=(nil)) I1121 16:21:04.956073831 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:04.956111912 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774065, tv_nsec: 156108172, clock_type: 1 }, reserved=(nil)) I1121 16:21:05.156355623 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:05.156407557 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774065, tv_nsec: 356401706, clock_type: 1 }, reserved=(nil)) I1121 16:21:05.356658097 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:05.356701079 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774065, tv_nsec: 556696729, clock_type: 1 }, reserved=(nil)) I1121 16:21:05.556946427 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:05.556991808 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774065, tv_nsec: 756987365, clock_type: 1 }, reserved=(nil)) I1121 16:21:05.757244119 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:05.757272874 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774065, tv_nsec: 957270259, clock_type: 1 }, reserved=(nil)) I1121 16:21:05.957595250 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:05.957653057 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774066, tv_nsec: 157646582, clock_type: 1 }, reserved=(nil)) I1121 16:21:06.158012863 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:06.158064465 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774066, tv_nsec: 358059917, clock_type: 1 }, reserved=(nil)) I1121 16:21:06.358320890 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:06.358359450 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774066, tv_nsec: 558356062, clock_type: 1 }, reserved=(nil)) I1121 16:21:06.558596451 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:06.558633375 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774066, tv_nsec: 758630759, clock_type: 1 }, reserved=(nil)) I1121 16:21:06.758709569 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:06.758757863 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774066, tv_nsec: 958753647, clock_type: 1 }, reserved=(nil)) I1121 16:21:06.959090509 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:06.959136442 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774067, tv_nsec: 159132122, clock_type: 1 }, reserved=(nil)) I1121 16:21:07.159288170 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:07.159333114 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774067, tv_nsec: 359328957, clock_type: 1 }, reserved=(nil)) I1121 16:21:07.359576371 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:07.359610239 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774067, tv_nsec: 559607484, clock_type: 1 }, reserved=(nil)) I1121 16:21:07.559851590 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:07.559898930 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774067, tv_nsec: 759894137, clock_type: 1 }, reserved=(nil)) I1121 16:21:07.760153445 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:07.760199518 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774067, tv_nsec: 960195228, clock_type: 1 }, reserved=(nil)) I1121 16:21:07.960529718 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:07.960578260 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774068, tv_nsec: 160573726, clock_type: 1 }, reserved=(nil)) I1121 16:21:08.160858047 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:08.160908212 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774068, tv_nsec: 360903695, clock_type: 1 }, reserved=(nil)) I1121 16:21:08.361163533 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:08.361213522 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774068, tv_nsec: 561208544, clock_type: 1 }, reserved=(nil)) I1121 16:21:08.561510910 76553 completion_queue.c:471] RETURN_EVENT[0x7ffb2a033110]: QUEUE_TIMEOUT I1121 16:21:08.561577353 76553 completion_queue.c:386] grpc_completion_queue_next(cc=0x7ffb2a033110, deadline=gpr_timespec { tv_sec: 1479774068, tv_nsec: 761570641, clock_type: 1 }, reserved=(nil))