I am getting a coredump on the latest release of homestead with an MAA. excerpt is here: 14-07-2016 15:42:02.637 UTC Debug diameterstack.cpp:888: Processing a received diameter message 14-07-2016 15:42:02.637 UTC Debug diameterstack.cpp:901: Got existing trail ID: 2 14-07-2016 15:42:02.637 UTC Debug diameterstack.cpp:969: Raising correlating marker with diameter session ID = homestead01.example.com;1468510914;2 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Peer timeout reset to 30 seconds (+/- 2) 14-07-2016 15:42:02.637 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_OPEN' waiting for next event. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of AVP: 'Vendor-Specific-Application-Id'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of AVP: 'SIP-Digest-Authenticate'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of AVP: 'SIP-Auth-Data-Item'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of COMMAND: '3GPP/Multimedia-Auth-Answer'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Calling callback registered when query was sent (0x45b880, 0x7f6a8c01a440) 14-07-2016 15:42:02.637 UTC Verbose diameterstack.cpp:1097: Got Diameter response of type 303 - calling callback on transaction 0x7f6a8c01a440 14-07-2016 15:42:02.637 UTC Debug handlers.cpp:343: Received Multimedia-Auth answer with result code 2001 14-07-2016 15:42:02.637 UTC Error freeDiameter: ERROR: Invalid parameter '(((avp) && (((struct msg_avp_chain *)(avp))->type == MSG_AVP) && (((struct avp *)(avp))->avp_eyec == (0x11355467))) && pdata)', 22
Signal 11 caught Basic stack dump: /usr/share/clearwater/bin/homestead[0x492bbd] /usr/share/clearwater/bin/homestead[0x493d7d] /usr/share/clearwater/bin/homestead[0x4a9cec] /lib/x86_64-linux-gnu/libc.so.6(+0x36cb0)[0x7f6acf2c2cb0] /usr/share/clearwater/bin/homestead[0x4534f5] /usr/share/clearwater/bin/homestead[0x4778f9] /usr/share/clearwater/bin/homestead[0x47d8a1] /usr/share/clearwater/bin/homestead[0x45b911] /usr/share/clearwater/homestead/lib/libfdcore.so.6(+0x30656)[0x7f6ad1811656] /usr/share/clearwater/homestead/lib/libfdcore.so.6(+0x3225c)[0x7f6ad181325c] /lib/x86_64-linux-gnu/libpthread.so.0(+0x8184)[0x7f6ad083c184] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d)[0x7f6acf38637d] Attached is the full startup and error, any ideas what may cause this? I cannot attach a capture/core as it has private data in it.
14-07-2016 15:41:53.994 UTC Status utils.cpp:591: Log level set to 5 14-07-2016 15:41:53.994 UTC Info main.cpp:577: Command-line options were: /usr/share/clearwater/bin/homestead --localhost=XXX.XXX.XXX.101 --home-domain=example.com --diameter-conf=/var/lib/homestead/homestead.conf --dns-server=127.0.0.1 --http=XXX.XXX.XXX.101 --http-threads=100 --dest-realm=example1.com --dest-host=hss.example1.com --hss-peer=XXX.XXX.XXX.100 --max-peers=2 --server-name=sip:scscf.sprout.example.com:5054;transport=TCP --impu-cache-ttl=0 --hss-reregistration-time=1800 --sprout-http-name=sprout.example.com:9888 --access-log=/var/log/homestead --log-file=/var/log/homestead --log-level=5 --sas=0.0.0.0,[email protected] --pidfile=/var/run/homestead/homestead.pid --daemon 14-07-2016 15:41:53.994 UTC Info main.cpp:276: Local host: XXX.XXX.XXX.101 14-07-2016 15:41:53.994 UTC Info main.cpp:281: Home domain: example.com 14-07-2016 15:41:53.994 UTC Info main.cpp:286: Diameter configuration file: /var/lib/homestead/homestead.conf 14-07-2016 15:41:53.994 UTC Info main.cpp:389: 1 DNS servers passed on the command line 14-07-2016 15:41:53.994 UTC Info main.cpp:291: HTTP address: XXX.XXX.XXX.101 14-07-2016 15:41:53.994 UTC Info main.cpp:296: HTTP threads: 100 14-07-2016 15:41:53.994 UTC Info main.cpp:311: Destination realm: example1.com 14-07-2016 15:41:53.994 UTC Info main.cpp:316: Destination host: hss.example1.com 14-07-2016 15:41:53.994 UTC Info main.cpp:321: Maximum peers: 2 14-07-2016 15:41:53.994 UTC Info main.cpp:326: Server name: sip:scscf.sprout.example.com:5054;transport=TCP 14-07-2016 15:41:53.994 UTC Info main.cpp:331: IMPU cache TTL: 0 14-07-2016 15:41:53.994 UTC Info main.cpp:336: HSS reregistration time: 1800 14-07-2016 15:41:53.994 UTC Info main.cpp:341: Sprout HTTP name: sprout.example.com:9888 14-07-2016 15:41:53.994 UTC Info main.cpp:361: Access log: /var/log/homestead 14-07-2016 15:41:53.994 UTC Info main.cpp:374: SAS set to 0.0.0.0 14-07-2016 15:41:53.994 UTC Info main.cpp:375: System name is set to [email protected] 14-07-2016 15:41:53.994 UTC Status main.cpp:598: Access logging enabled to /var/log/homestead 14-07-2016 15:41:53.994 UTC Warning main.cpp:604: SAS server option was invalid or not configured - SAS is disabled 14-07-2016 15:41:53.995 UTC Status snmp_agent.cpp:117: AgentX agent initialised 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_latency_us 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_hss_latency_us 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_cache_latency_us 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_hss_digest_latency_us 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_hss_subscription_latency_us 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_incoming_requests 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_rejected_overload 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_diameter_invalid_dest_realm 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table H_diameter_invalid_dest_host 14-07-2016 15:41:53.995 UTC Info snmp_table.h:87: Registering SNMP table cx_mar_results 14-07-2016 15:41:53.996 UTC Info snmp_table.h:87: Registering SNMP table cx_sar_results 14-07-2016 15:41:53.997 UTC Info snmp_table.h:87: Registering SNMP table cx_uar_results 14-07-2016 15:41:53.998 UTC Info snmp_table.h:87: Registering SNMP table cx_lir_results 14-07-2016 15:41:53.999 UTC Info snmp_table.h:87: Registering SNMP table cx_ppr_results 14-07-2016 15:41:54.000 UTC Info snmp_table.h:87: Registering SNMP table cx_rtr_results 14-07-2016 15:41:54.001 UTC Info (Net-SNMP): NET-SNMP version 5.7.2 AgentX subagent connected 14-07-2016 15:41:54.003 UTC Status load_monitor.cpp:105: Constructing LoadMonitor 14-07-2016 15:41:54.003 UTC Status load_monitor.cpp:106: Target latency (usecs) : 100000 14-07-2016 15:41:54.003 UTC Status load_monitor.cpp:107: Max bucket size : 1000 14-07-2016 15:41:54.003 UTC Status load_monitor.cpp:108: Initial token fill rate/s: 100.000000 14-07-2016 15:41:54.003 UTC Status load_monitor.cpp:109: Min token fill rate/s : 10.000000 14-07-2016 15:41:54.003 UTC Status dnscachedresolver.cpp:144: Creating Cached Resolver using servers: 14-07-2016 15:41:54.003 UTC Status dnscachedresolver.cpp:154: 127.0.0.1 14-07-2016 15:41:54.003 UTC Debug alarm.cpp:241: Started reraising alarms every 30 seconds 14-07-2016 15:41:54.003 UTC Debug alarm.cpp:253: Reraising all alarms with a known state 14-07-2016 15:41:54.003 UTC Debug httpresolver.cpp:46: Creating HTTP resolver 14-07-2016 15:41:54.003 UTC Debug baseresolver.cpp:93: Create black list 14-07-2016 15:41:54.003 UTC Status httpresolver.cpp:51: Created HTTP resolver 14-07-2016 15:41:54.003 UTC Status cassandra_store.cpp:154: Configuring store connection 14-07-2016 15:41:54.003 UTC Status cassandra_store.cpp:155: Hostname: localhost 14-07-2016 15:41:54.003 UTC Status cassandra_store.cpp:156: Port: 9160 14-07-2016 15:41:54.003 UTC Status cassandra_store.cpp:206: Configuring store worker pool 14-07-2016 15:41:54.003 UTC Status cassandra_store.cpp:207: Threads: 10 14-07-2016 15:41:54.003 UTC Status cassandra_store.cpp:208: Max Queue: 0 14-07-2016 15:41:54.003 UTC Debug cassandra_store.cpp:170: Testing cassandra connection 14-07-2016 15:41:54.003 UTC Debug cassandra_store.cpp:284: Getting thread-local Client 14-07-2016 15:41:54.003 UTC Debug cassandra_store.cpp:289: No thread-local Client - creating one 14-07-2016 15:41:54.003 UTC Debug cassandra_store.cpp:309: Looking to release thread-local client 14-07-2016 15:41:54.003 UTC Debug cassandra_store.cpp:314: Found thread-local client - destroying 14-07-2016 15:41:54.003 UTC Status cassandra_store.cpp:223: Starting store 14-07-2016 15:41:54.005 UTC Status httpconnection.cpp:146: Configuring HTTP Connection 14-07-2016 15:41:54.005 UTC Status httpconnection.cpp:147: Connection created for server sprout.example.com:9888 14-07-2016 15:41:54.005 UTC Status httpconnection.cpp:148: Connection will use a response timeout of 500ms 14-07-2016 15:41:54.005 UTC Status diameterstack.cpp:78: Initializing Diameter stack 14-07-2016 15:41:54.006 UTC Status diameterstack.cpp:415: Configuring Diameter stack from file /var/lib/homestead/homestead.conf 14-07-2016 15:41:54.006 UTC Debug freeDiameter: Parsing configuration file: /var/lib/homestead/homestead.conf 14-07-2016 15:41:54.007 UTC Debug freeDiameter: Extension /usr/share/clearwater/homestead/lib/freeDiameter//dbg_monitor.fdx added to the list. 14-07-2016 15:41:54.007 UTC Debug freeDiameter: Extension /usr/share/clearwater/homestead/lib/freeDiameter//dict_nasreq.fdx added to the list. 14-07-2016 15:41:54.007 UTC Debug freeDiameter: Extension /usr/share/clearwater/homestead/lib/freeDiameter//dict_sip.fdx added to the list. 14-07-2016 15:41:54.007 UTC Debug freeDiameter: Extension /usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca.fdx added to the list. 14-07-2016 15:41:54.007 UTC Debug freeDiameter: Extension /usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca_3gpp.fdx added to the list. 14-07-2016 15:41:54.007 UTC Debug freeDiameter: Generating fresh Diffie-Hellman parameters of size 1024 (this takes some time)... 14-07-2016 15:41:54.225 UTC Debug freeDiameter: Loading : /usr/share/clearwater/homestead/lib/freeDiameter//dbg_monitor.fdx 14-07-2016 15:41:54.225 UTC Debug freeDiameter: Checking dependencies for 'dbg_monitor'... 14-07-2016 15:41:54.225 UTC Debug freeDiameter: Extension [/usr/share/clearwater/homestead/lib/freeDiameter//dbg_monitor.fdx] fd_ext_fini has been resolved successfully. 14-07-2016 15:41:54.225 UTC Debug freeDiameter: Loading : /usr/share/clearwater/homestead/lib/freeDiameter//dict_nasreq.fdx 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Checking dependencies for 'dict_nasreq'... 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Extension [/usr/share/clearwater/homestead/lib/freeDiameter//dict_nasreq.fdx] has no fd_ext_fini function. 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Extension 'Dictionary definitions for NASREQ' initialized 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Loading : /usr/share/clearwater/homestead/lib/freeDiameter//dict_sip.fdx 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Checking dependencies for 'dict_sip'... 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Extension [/usr/share/clearwater/homestead/lib/freeDiameter//dict_sip.fdx] has no fd_ext_fini function. 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Extension 'Dictionary definitions for SIP' initialized 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Loading : /usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca.fdx 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Checking dependencies for 'dict_dcca'... 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Extension [/usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca.fdx] has no fd_ext_fini function. 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Extension 'Dictionary definitions for DCCA (rfc4006)' initialized 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Loading : /usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca_3gpp.fdx 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Checking dependencies for 'dict_dcca_3gpp'... 14-07-2016 15:41:54.226 UTC Debug freeDiameter: Extension [/usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca_3gpp.fdx] has no fd_ext_fini function. 14-07-2016 15:41:54.229 UTC Debug freeDiameter: An existing object with the same data was found, ignoring the error... 14-07-2016 15:41:54.229 UTC Debug freeDiameter: An existing object with the same data was found, ignoring the error... 14-07-2016 15:41:54.229 UTC Debug freeDiameter: An existing object with the same data was found, ignoring the error... 14-07-2016 15:41:54.230 UTC Debug freeDiameter: Extension 'Dictionary definitions for DCCA 3GPP' initialized 14-07-2016 15:41:54.230 UTC Status freeDiameter: All extensions loaded. 14-07-2016 15:41:54.230 UTC Status freeDiameter: freeDiameter configuration: 14-07-2016 15:41:54.230 UTC Status freeDiameter: Default trace level .... : +3 14-07-2016 15:41:54.230 UTC Status freeDiameter: Configuration file ..... : /var/lib/homestead/homestead.conf 14-07-2016 15:41:54.230 UTC Status freeDiameter: Diameter Identity ...... : homestead01.example.com (l:27) 14-07-2016 15:41:54.230 UTC Status freeDiameter: Diameter Realm ......... : homestead.example.com (l:25) 14-07-2016 15:41:54.230 UTC Status freeDiameter: Tc Timer ............... : 30 14-07-2016 15:41:54.230 UTC Status freeDiameter: Tw Timer ............... : 30 14-07-2016 15:41:54.230 UTC Status freeDiameter: Local port ............. : 3868 14-07-2016 15:41:54.230 UTC Status freeDiameter: Local secure port ...... : 5658 14-07-2016 15:41:54.230 UTC Status freeDiameter: Number of SCTP streams . : 3 14-07-2016 15:41:54.230 UTC Status freeDiameter: Number of clients thr .. : 5 14-07-2016 15:41:54.230 UTC Status freeDiameter: Number of app threads .. : 4 14-07-2016 15:41:54.230 UTC Status freeDiameter: Local endpoints ........ : Default (use all available) 14-07-2016 15:41:54.230 UTC Status freeDiameter: Local applications ..... : (none) 14-07-2016 15:41:54.230 UTC Status freeDiameter: Flags : - IP ........... : Enabled 14-07-2016 15:41:54.230 UTC Status freeDiameter: - IPv6 ......... : Enabled 14-07-2016 15:41:54.230 UTC Status freeDiameter: - Relay app .... : Enabled 14-07-2016 15:41:54.230 UTC Status freeDiameter: - TCP .......... : Enabled 14-07-2016 15:41:54.230 UTC Status freeDiameter: - SCTP ......... : Enabled 14-07-2016 15:41:54.230 UTC Status freeDiameter: - Pref. proto .. : SCTP 14-07-2016 15:41:54.230 UTC Status freeDiameter: - TLS method ... : Separate port 14-07-2016 15:41:54.230 UTC Status freeDiameter: TLS : - Certificate .. : /var/lib/homestead/cert.pem 14-07-2016 15:41:54.230 UTC Status freeDiameter: - Private key .. : /var/lib/homestead/privkey.pem 14-07-2016 15:41:54.230 UTC Status freeDiameter: - CA (trust) ... : /var/lib/homestead/ca.pem (1 certs) 14-07-2016 15:41:54.230 UTC Status freeDiameter: - CRL .......... : (none) 14-07-2016 15:41:54.230 UTC Status freeDiameter: - Priority ..... : (default: 'NORMAL') 14-07-2016 15:41:54.230 UTC Status freeDiameter: - DH bits ...... : 1024 14-07-2016 15:41:54.230 UTC Status freeDiameter: Origin-State-Id ........ : 1468510914 14-07-2016 15:41:54.230 UTC Status freeDiameter: Loaded extensions: '/usr/share/clearwater/homestead/lib/freeDiameter//dbg_monitor.fdx'[(no config file)], loaded 14-07-2016 15:41:54.230 UTC Status freeDiameter: Loaded extensions: '/usr/share/clearwater/homestead/lib/freeDiameter//dict_nasreq.fdx'[(no config file)], loaded 14-07-2016 15:41:54.230 UTC Status freeDiameter: Loaded extensions: '/usr/share/clearwater/homestead/lib/freeDiameter//dict_sip.fdx'[(no config file)], loaded 14-07-2016 15:41:54.230 UTC Status freeDiameter: Loaded extensions: '/usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca.fdx'[(no config file)], loaded 14-07-2016 15:41:54.230 UTC Status freeDiameter: Loaded extensions: '/usr/share/clearwater/homestead/lib/freeDiameter//dict_dcca_3gpp.fdx'[(no config file)], loaded 14-07-2016 15:41:54.230 UTC Status freeDiameter: {signal:12}'dbg_monitor'->0x7f6abc5f5e70 14-07-2016 15:41:54.230 UTC Debug freeDiameter: Core state: 1 -> 2 14-07-2016 15:41:54.230 UTC Status diameterstack.cpp:573: Starting Diameter stack 14-07-2016 15:41:54.231 UTC Status freeDiameter: Local server address(es): 172.26.0.51{---L-} XXX.XXX.XXX.101{---L-} 14-07-2016 15:41:54.231 UTC Debug freeDiameter: Core state: 2 -> 3 14-07-2016 15:41:54.231 UTC Status handlers.cpp:85: Configuring HssCacheTask 14-07-2016 15:41:54.231 UTC Status handlers.cpp:86: Dest-Realm: example1.com 14-07-2016 15:41:54.231 UTC Status handlers.cpp:87: Dest-Host: hss.example1.com 14-07-2016 15:41:54.231 UTC Status handlers.cpp:88: Server-Name: sip:scscf.sprout.example.com:5054;transport=TCP 14-07-2016 15:41:54.231 UTC Status httpstack.cpp:136: Configuring HTTP stack 14-07-2016 15:41:54.231 UTC Status httpstack.cpp:137: Bind address: XXX.XXX.XXX.101 14-07-2016 15:41:54.231 UTC Status httpstack.cpp:138: Bind port: 8888 14-07-2016 15:41:54.231 UTC Status httpstack.cpp:139: Num threads: 100 14-07-2016 15:41:54.739 UTC Debug diameterresolver.cpp:46: Creating Diameter resolver 14-07-2016 15:41:54.739 UTC Debug baseresolver.cpp:75: Create NAPTR cache 14-07-2016 15:41:54.739 UTC Debug baseresolver.cpp:84: Create SRV cache 14-07-2016 15:41:54.739 UTC Debug baseresolver.cpp:93: Create black list 14-07-2016 15:41:54.739 UTC Status diameterresolver.cpp:62: Created Diameter resolver 14-07-2016 15:41:54.739 UTC Status main.cpp:853: Start-up complete - wait for termination signal 14-07-2016 15:41:54.739 UTC Debug diameterresolver.cpp:91: DiameterResolver::resolve for realm , host XXX.XXX.XXX.100, family 2 14-07-2016 15:41:54.739 UTC Debug baseresolver.cpp:514: Attempt to parse XXX.XXX.XXX.100 as IP address 14-07-2016 15:41:54.739 UTC Debug diameterresolver.cpp:175: Target is an IP address - default port/transport 14-07-2016 15:41:54.739 UTC Debug realmmanager.cpp:381: Adding peer: XXX.XXX.XXX.100 14-07-2016 15:41:54.739 UTC Debug freeDiameter: Diameter peer XXX.XXX.XXX.100 added 14-07-2016 15:41:54.739 UTC Debug freeDiameter: Peer timeout reset to 0 seconds (+/- 2) 14-07-2016 15:41:54.740 UTC Warning diameterstack.cpp:858: No connected Diameter peers have been found 14-07-2016 15:41:54.740 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_CLOSED' waiting for next event. 14-07-2016 15:41:57.757 UTC Debug freeDiameter: 'STATE_CLOSED' <-- 'FDEVP_PSM_TIMEOUT' ((nil),0) 'XXX.XXX.XXX.100' 14-07-2016 15:41:57.757 UTC Debug freeDiameter: XXX.XXX.XXX.100: Connecting... 14-07-2016 15:41:57.757 UTC Debug freeDiameter: 'STATE_CLOSED' -> 'STATE_WAITCNXACK' 'XXX.XXX.XXX.100' 14-07-2016 15:41:57.757 UTC Debug freeDiameter: Peer timeout reset to 10 seconds 14-07-2016 15:41:57.757 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_WAITCNXACK' waiting for next event. 14-07-2016 15:41:57.757 UTC Debug freeDiameter: Prepared 1 sets of connection parameters to peer XXX.XXX.XXX.100 14-07-2016 15:41:57.757 UTC Debug freeDiameter: Connecting to TCP XXX.XXX.XXX.100(3868)... 14-07-2016 15:41:57.828 UTC Debug freeDiameter: 'STATE_WAITCNXACK' <-- 'FDEVP_CNX_ESTABLISHED' (0x7f6aa000ac50,0) 'XXX.XXX.XXX.100' 14-07-2016 15:41:57.828 UTC Debug freeDiameter: XXX.XXX.XXX.100: Connection established, {----} TCP,#636->XXX.XXX.XXX.100(3868) 14-07-2016 15:41:57.828 UTC Debug freeDiameter: GOING TO SEND TO 'XXX.XXX.XXX.100': 'Capabilities-Exchange-Request'0/257 f:R--- src:'(nil)' len:20 {C:264/l:8,C:296/l:8,C:278/l:12,C:257/l:8,C:257/l:8,C:266/l:12,C:269/l:8,C:267/l:12,C:299/l:12,C:260/l:8,C:258/l:12,C:265/l:12,C:265/l:12,C:265/l:12} 14-07-2016 15:41:57.828 UTC Debug freeDiameter: Sending 272b data on connection {----} TCP,#636->XXX.XXX.XXX.100(3868) 14-07-2016 15:41:57.828 UTC Debug freeDiameter: 'STATE_WAITCNXACK' -> 'STATE_WAITCEA' 'XXX.XXX.XXX.100' 14-07-2016 15:41:57.828 UTC Debug freeDiameter: Peer timeout reset to 10 seconds 14-07-2016 15:41:57.828 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_WAITCEA' waiting for next event. 14-07-2016 15:41:57.912 UTC Debug freeDiameter: Thread terminated 14-07-2016 15:41:57.912 UTC Debug freeDiameter: 'STATE_WAITCEA' <-- 'FDEVP_CNX_MSG_RECV' (0x7f6aac00ab70,268) 'XXX.XXX.XXX.100' 14-07-2016 15:41:57.912 UTC Debug freeDiameter: Iterating on rules of AVP: 'Vendor-Specific-Application-Id'. 14-07-2016 15:41:57.912 UTC Debug freeDiameter: Iterating on rules of AVP: 'Vendor-Specific-Application-Id'. 14-07-2016 15:41:57.912 UTC Debug freeDiameter: Iterating on rules of AVP: 'Vendor-Specific-Application-Id'. 14-07-2016 15:41:57.912 UTC Debug freeDiameter: Iterating on rules of COMMAND: 'Capabilities-Exchange-Answer'. 14-07-2016 15:41:57.912 UTC Debug diameterstack.cpp:371: Callback (type 12) from freeDiameter: XXX.XXX.XXX.100 14-07-2016 15:41:57.912 UTC Info realmmanager.cpp:118: Successfully connected to XXX.XXX.XXX.100 in realm example1.com 14-07-2016 15:41:57.912 UTC Status freeDiameter: No TLS protection negotiated with peer 'XXX.XXX.XXX.100'. 14-07-2016 15:41:57.912 UTC Status freeDiameter: 'STATE_WAITCEA' -> 'STATE_OPEN' 'XXX.XXX.XXX.100' 14-07-2016 15:41:57.912 UTC Debug freeDiameter: Peer timeout reset to 30 seconds (+/- 2) 14-07-2016 15:41:57.912 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_OPEN' waiting for next event. 14-07-2016 15:41:59.740 UTC Debug diameterresolver.cpp:91: DiameterResolver::resolve for realm , host XXX.XXX.XXX.100, family 2 14-07-2016 15:41:59.740 UTC Debug baseresolver.cpp:514: Attempt to parse XXX.XXX.XXX.100 as IP address 14-07-2016 15:41:59.740 UTC Debug diameterresolver.cpp:175: Target is an IP address - default port/transport 14-07-2016 15:42:02.365 UTC Verbose httpstack.cpp:293: Process request for URL /impi/123456789012345%40ims.mncXXX.mccXXX.3gppnetwork.org/registration-status, args impu=sip%3A19998887777%40example.com&visited-network=example.com&auth-type=REG 14-07-2016 15:42:02.376 UTC Debug handlers.cpp:591: Parsed HTTP request: private ID [email protected], public ID sip:[email protected], visited network example.com, authorization type REG 14-07-2016 15:42:02.376 UTC Debug cx.cpp:109: Building User-Authorization request for [email protected]/sip:[email protected] 14-07-2016 15:42:02.376 UTC Debug freeDiameter: No Session-Id AVP found in message 0x7f6a7c0315d0 14-07-2016 15:42:02.376 UTC Verbose diameterstack.cpp:1427: Sending Diameter message of type 300 on transaction 0x7f6a7c032190 with timeout 200 14-07-2016 15:42:02.376 UTC Debug diameterstack.cpp:397: Routing out callback from freeDiameter 14-07-2016 15:42:02.376 UTC Debug realmmanager.cpp:189: freeDiameter routing score for candidate XXX.XXX.XXX.100 is changing from 98 to 97 14-07-2016 15:42:02.376 UTC Debug freeDiameter: GOING TO SEND TO 'XXX.XXX.XXX.100': '3GPP/User-Authorization-Request'16777216/300 f:RP-- src:'(nil)' len:20 {C:263/l:8,C:260/l:8,C:277/l:12,C:264/l:8,C:296/l:8,C:293/l:8,C:283/l:8,C:1/l:8,V:10415/C:601/l:12,V:10415/C:600/l:12,V:10415/C:623/l:16} 14-07-2016 15:42:02.376 UTC Debug diameterstack.cpp:908: Processing a sent diameter message 14-07-2016 15:42:02.376 UTC Debug diameterstack.cpp:910: Got existing trail ID: 1 14-07-2016 15:42:02.376 UTC Debug diameterstack.cpp:969: Raising correlating marker with diameter session ID = homestead01.example.com;1468510914;1 14-07-2016 15:42:02.376 UTC Debug freeDiameter: Sending 376b data on connection {----} TCP,#636->XXX.XXX.XXX.100(3868) 14-07-2016 15:42:02.485 UTC Debug freeDiameter: 'STATE_OPEN' <-- 'FDEVP_CNX_MSG_RECV' (0x7f6aac00ab70,252) 'XXX.XXX.XXX.100' 14-07-2016 15:42:02.485 UTC Debug diameterstack.cpp:888: Processing a received diameter message 14-07-2016 15:42:02.485 UTC Debug diameterstack.cpp:901: Got existing trail ID: 1 14-07-2016 15:42:02.485 UTC Debug diameterstack.cpp:969: Raising correlating marker with diameter session ID = homestead01.example.com;1468510914;1 14-07-2016 15:42:02.486 UTC Debug freeDiameter: Peer timeout reset to 30 seconds (+/- 2) 14-07-2016 15:42:02.486 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_OPEN' waiting for next event. 14-07-2016 15:42:02.486 UTC Debug freeDiameter: Iterating on rules of AVP: 'Vendor-Specific-Application-Id'. 14-07-2016 15:42:02.486 UTC Debug freeDiameter: Iterating on rules of AVP: 'Experimental-Result'. 14-07-2016 15:42:02.486 UTC Debug freeDiameter: Iterating on rules of COMMAND: '3GPP/User-Authorization-Answer'. 14-07-2016 15:42:02.486 UTC Debug freeDiameter: Calling callback registered when query was sent (0x45b880, 0x7f6a7c032190) 14-07-2016 15:42:02.486 UTC Verbose diameterstack.cpp:1097: Got Diameter response of type 300 - calling callback on transaction 0x7f6a7c032190 14-07-2016 15:42:02.486 UTC Debug diameterstack.cpp:1375: Got Experimental-Result-Code 2002 14-07-2016 15:42:02.486 UTC Debug handlers.cpp:647: Received User-Authorization answer with result 0/2002 14-07-2016 15:42:02.486 UTC Debug handlers.cpp:662: Got Server-Name sip:scscf.sprout.example.com:5054;transport=TCP 14-07-2016 15:42:02.486 UTC Verbose httpstack.cpp:69: Sending response 200 to request for URL /impi/123456789012345%40ims.mncXXX.mccXXX.3gppnetwork.org/registration-status, args impu=sip%3A19998887777%40example.com&visited-network=example.com&auth-type=REG 14-07-2016 15:42:02.498 UTC Verbose httpstack.cpp:293: Process request for URL /impi/123456789012345%40ims.mncXXX.mccXXX.3gppnetwork.org/av, args impu=sip%3A19998887777%40example.com 14-07-2016 15:42:02.498 UTC Debug handlers.cpp:148: Parsed HTTP request: private ID [email protected], public ID sip:[email protected], scheme Unknown, authorization 14-07-2016 15:42:02.498 UTC Debug handlers.cpp:155: Authentication vector cache query disabled - query HSS 14-07-2016 15:42:02.498 UTC Debug cx.cpp:366: Building Multimedia-Auth request for [email protected]/sip:[email protected] 14-07-2016 15:42:02.498 UTC Debug freeDiameter: No Session-Id AVP found in message 0x7f6a8c019760 14-07-2016 15:42:02.498 UTC Verbose diameterstack.cpp:1427: Sending Diameter message of type 303 on transaction 0x7f6a8c01a440 with timeout 200 14-07-2016 15:42:02.498 UTC Debug diameterstack.cpp:397: Routing out callback from freeDiameter 14-07-2016 15:42:02.498 UTC Debug realmmanager.cpp:189: freeDiameter routing score for candidate XXX.XXX.XXX.100 is changing from 98 to 97 14-07-2016 15:42:02.498 UTC Debug freeDiameter: GOING TO SEND TO 'XXX.XXX.XXX.100': '3GPP/Multimedia-Auth-Request'16777216/303 f:RP-- src:'(nil)' len:20 {C:263/l:8,C:260/l:8,C:277/l:12,C:283/l:8,C:293/l:8,C:264/l:8,C:296/l:8,C:1/l:8,V:10415/C:601/l:12,V:10415/C:612/l:12,V:10415/C:607/l:16,V:10415/C:602/l:12} 14-07-2016 15:42:02.498 UTC Debug diameterstack.cpp:908: Processing a sent diameter message 14-07-2016 15:42:02.498 UTC Debug diameterstack.cpp:910: Got existing trail ID: 2 14-07-2016 15:42:02.498 UTC Debug diameterstack.cpp:969: Raising correlating marker with diameter session ID = homestead01.example.com;1468510914;2 14-07-2016 15:42:02.498 UTC Debug freeDiameter: Sending 444b data on connection {----} TCP,#636->XXX.XXX.XXX.100(3868) 14-07-2016 15:42:02.637 UTC Debug freeDiameter: 'STATE_OPEN' <-- 'FDEVP_CNX_MSG_RECV' (0x7f6aac00ad30,516) 'XXX.XXX.XXX.100' 14-07-2016 15:42:02.637 UTC Debug diameterstack.cpp:888: Processing a received diameter message 14-07-2016 15:42:02.637 UTC Debug diameterstack.cpp:901: Got existing trail ID: 2 14-07-2016 15:42:02.637 UTC Debug diameterstack.cpp:969: Raising correlating marker with diameter session ID = homestead01.example.com;1468510914;2 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Peer timeout reset to 30 seconds (+/- 2) 14-07-2016 15:42:02.637 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_OPEN' waiting for next event. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of AVP: 'Vendor-Specific-Application-Id'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of AVP: 'SIP-Digest-Authenticate'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of AVP: 'SIP-Auth-Data-Item'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Iterating on rules of COMMAND: '3GPP/Multimedia-Auth-Answer'. 14-07-2016 15:42:02.637 UTC Debug freeDiameter: Calling callback registered when query was sent (0x45b880, 0x7f6a8c01a440) 14-07-2016 15:42:02.637 UTC Verbose diameterstack.cpp:1097: Got Diameter response of type 303 - calling callback on transaction 0x7f6a8c01a440 14-07-2016 15:42:02.637 UTC Debug handlers.cpp:343: Received Multimedia-Auth answer with result code 2001 14-07-2016 15:42:02.637 UTC Error freeDiameter: ERROR: Invalid parameter '(((avp) && (((struct msg_avp_chain *)(avp))->type == MSG_AVP) && (((struct avp *)(avp))->avp_eyec == (0x11355467))) && pdata)', 22 Signal 11 caught Basic stack dump: /usr/share/clearwater/bin/homestead[0x492bbd] /usr/share/clearwater/bin/homestead[0x493d7d] /usr/share/clearwater/bin/homestead[0x4a9cec] /lib/x86_64-linux-gnu/libc.so.6(+0x36cb0)[0x7f6acf2c2cb0] /usr/share/clearwater/bin/homestead[0x4534f5] /usr/share/clearwater/bin/homestead[0x4778f9] /usr/share/clearwater/bin/homestead[0x47d8a1] /usr/share/clearwater/bin/homestead[0x45b911] /usr/share/clearwater/homestead/lib/libfdcore.so.6(+0x30656)[0x7f6ad1811656] /usr/share/clearwater/homestead/lib/libfdcore.so.6(+0x3225c)[0x7f6ad181325c] /lib/x86_64-linux-gnu/libpthread.so.0(+0x8184)[0x7f6ad083c184] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d)[0x7f6acf38637d] Advanced stack dump (requires gdb): 14-07-2016 15:42:02.999 UTC Verbose httpstack.cpp:293: Process request for URL /impi/123456789012345%40ims.mncXXX.mccXXX.3gppnetwork.org/av, args impu=sip%3A19998887777%40example.com 14-07-2016 15:42:02.999 UTC Debug handlers.cpp:148: Parsed HTTP request: private ID [email protected], public ID sip:[email protected], scheme Unknown, authorization 14-07-2016 15:42:02.999 UTC Debug handlers.cpp:155: Authentication vector cache query disabled - query HSS 14-07-2016 15:42:02.999 UTC Debug cx.cpp:366: Building Multimedia-Auth request for [email protected]/sip:[email protected] 14-07-2016 15:42:02.999 UTC Debug freeDiameter: No Session-Id AVP found in message 0x7f6a88018fb0 14-07-2016 15:42:02.999 UTC Verbose diameterstack.cpp:1427: Sending Diameter message of type 303 on transaction 0x7f6a88019c90 with timeout 200 14-07-2016 15:42:02.999 UTC Debug diameterstack.cpp:397: Routing out callback from freeDiameter 14-07-2016 15:42:02.999 UTC Debug realmmanager.cpp:189: freeDiameter routing score for candidate XXX.XXX.XXX.100 is changing from 98 to 97 14-07-2016 15:42:02.999 UTC Debug freeDiameter: GOING TO SEND TO 'XXX.XXX.XXX.100': '3GPP/Multimedia-Auth-Request'16777216/303 f:RP-- src:'(nil)' len:20 {C:263/l:8,C:260/l:8,C:277/l:12,C:283/l:8,C:293/l:8,C:264/l:8,C:296/l:8,C:1/l:8,V:10415/C:601/l:12,V:10415/C:612/l:12,V:10415/C:607/l:16,V:10415/C:602/l:12} 14-07-2016 15:42:02.999 UTC Debug diameterstack.cpp:908: Processing a sent diameter message 14-07-2016 15:42:02.999 UTC Debug diameterstack.cpp:910: Got existing trail ID: 3 14-07-2016 15:42:02.999 UTC Debug diameterstack.cpp:969: Raising correlating marker with diameter session ID = homestead01.example.com;1468510914;3 14-07-2016 15:42:03.000 UTC Debug freeDiameter: Sending 444b data on connection {----} TCP,#636->XXX.XXX.XXX.100(3868) 14-07-2016 15:42:03.136 UTC Debug freeDiameter: 'STATE_OPEN' <-- 'FDEVP_CNX_MSG_RECV' (0x7f6aac00ab70,516) 'XXX.XXX.XXX.100' 14-07-2016 15:42:03.136 UTC Debug diameterstack.cpp:888: Processing a received diameter message 14-07-2016 15:42:03.136 UTC Debug diameterstack.cpp:901: Got existing trail ID: 3 14-07-2016 15:42:03.136 UTC Debug diameterstack.cpp:969: Raising correlating marker with diameter session ID = homestead01.example.com;1468510914;3 14-07-2016 15:42:03.136 UTC Debug freeDiameter: Peer timeout reset to 30 seconds (+/- 2) 14-07-2016 15:42:03.136 UTC Debug freeDiameter: 'XXX.XXX.XXX.100' in state 'STATE_OPEN' waiting for next event. 14-07-2016 15:42:03.136 UTC Debug freeDiameter: Iterating on rules of AVP: 'Vendor-Specific-Application-Id'. 14-07-2016 15:42:03.136 UTC Debug freeDiameter: Iterating on rules of AVP: 'SIP-Digest-Authenticate'. 14-07-2016 15:42:03.136 UTC Debug freeDiameter: Iterating on rules of AVP: 'SIP-Auth-Data-Item'. 14-07-2016 15:42:03.136 UTC Debug freeDiameter: Iterating on rules of COMMAND: '3GPP/Multimedia-Auth-Answer'. 14-07-2016 15:42:03.136 UTC Debug freeDiameter: Calling callback registered when query was sent (0x45b880, 0x7f6a88019c90) 14-07-2016 15:42:03.136 UTC Verbose diameterstack.cpp:1097: Got Diameter response of type 303 - calling callback on transaction 0x7f6a88019c90 14-07-2016 15:42:03.136 UTC Debug handlers.cpp:343: Received Multimedia-Auth answer with result code 2001 14-07-2016 15:42:03.136 UTC Error freeDiameter: ERROR: Invalid parameter '(((avp) && (((struct msg_avp_chain *)(avp))->type == MSG_AVP) && (((struct avp *)(avp))->avp_eyec == (0x11355467))) && pdata)', 22 Signal 11 caught Basic stack dump: /usr/share/clearwater/bin/homestead[0x492bbd] /usr/share/clearwater/bin/homestead[0x493d7d] /usr/share/clearwater/bin/homestead[0x4a9cec] /lib/x86_64-linux-gnu/libc.so.6(+0x36cb0)[0x7f6acf2c2cb0] /usr/share/clearwater/bin/homestead[0x4534f5] /usr/share/clearwater/bin/homestead[0x4778f9] /usr/share/clearwater/bin/homestead[0x47d8a1] /usr/share/clearwater/bin/homestead[0x45b911] /usr/share/clearwater/homestead/lib/libfdcore.so.6(+0x30656)[0x7f6ad1811656] /usr/share/clearwater/homestead/lib/libfdcore.so.6(+0x3225c)[0x7f6ad181325c] /lib/x86_64-linux-gnu/libpthread.so.0(+0x8184)[0x7f6ad083c184] /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d)[0x7f6acf38637d] Advanced stack dump (requires gdb): Could not attach to process. If your uid matches the uid of the target process, check the setting of /proc/sys/kernel/yama/ptrace_scope, or try again as the root user. For more details, see /etc/sysctl.d/10-ptrace.conf warning: process 32224 is already traced by process 32454 ptrace: Operation not permitted. /etc/clearwater/32224: No such file or directory. warning: td_ta_new failed: generic error warning: File "/lib/x86_64-linux-gnu/libthread_db-1.0.so" auto-loading has been declined by your `auto-load safe-path' set to "$debugdir:$datadir/auto-load". To enable execution of this file add add-auto-load-safe-path /lib/x86_64-linux-gnu/libthread_db-1.0.so line to your configuration file "/nonexistent/.gdbinit". To completely disable this security protection add set auto-load safe-path / line to your configuration file "/nonexistent/.gdbinit". For more information about this security protection see the "Auto-loading safe path" section in the GDB manual. E.g., run from the shell: info "(gdb)Auto-loading safe path" warning: Unable to find libthread_db matching inferior's thread library, thread debugging will not be available. Cannot access memory at address 0x7f6ad24e11a8 warning: td_ta_new failed: generic error warning: File "/lib/x86_64-linux-gnu/libthread_db-1.0.so" auto-loading has been declined by your `auto-load safe-path' set to "$debugdir:$datadir/auto-load". warning: Unable to find libthread_db matching inferior's thread library, thread debugging will not be available. Failed to read a valid object file image from memory. sem_wait () at ../nptl/sysdeps/unix/sysv/linux/x86_64/sem_wait.S:85 85 ../nptl/sysdeps/unix/sysv/linux/x86_64/sem_wait.S: No such file or directory. Python Exception <class 'gdb.MemoryError'> Cannot access memory at address 0x7ffe99f12278: Thread 1 (process 32224): #0 sem_wait () at ../nptl/sysdeps/unix/sysv/linux/x86_64/sem_wait.S:85 Cannot access memory at address 0x7ffe99f12278 ptrace: No such process.
_______________________________________________ Clearwater mailing list [email protected] http://lists.projectclearwater.org/mailman/listinfo/clearwater_lists.projectclearwater.org
