This post is older than 2 years and might not be relevant anymore
More Info: Consider searching for newer posts

nrf52840 gsm modem sim800 tcp client socket send error

Hi,

I created an example using gsm_modem application, after network connected, I create tcp client socket then send data to the server. After several sendings, I got the packet allocation failed.

char buff[10] = "abcdef\n";
int len = sizeof(buff);

// ... after network connected in main function

int sockfd, connfd;
struct sockaddr_in servaddr, cli;
  
// socket create and varification
sockfd = socket(AF_INET, SOCK_STREAM, 0);
if (sockfd == -1) {
    printk("socket creation failed...\n");
    return;
}

printk("Socket successfully created..\n");

int  IP = 104*256*256*256 + 168*256*256 + 98*256 + 15;   // 104.168.98.15

// assign IP, PORT
servaddr.sin_family = AF_INET;
servaddr.sin_addr.s_addr = htonl(IP);
servaddr.sin_port = htons(2120);

// connect the client socket to server socket
if (connect(sockfd, (struct sockaddr_in*) & servaddr, sizeof(servaddr)) != 0)
{
    printk("connection with the server failed...\n");
    return;
}

printk("connected to the server..\n");

while (1) 
{
    send(sockfd, buff, 10, 0);
    k_sleep(K_SECONDS(2));
}


Error log:
[00:00:29.692,749] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:29.892,944] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:30.093,139] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:30.293,334] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:30.493,530] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:30.693,725] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:30.893,920] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:31.094,116] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:31.294,311] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:31.494,506] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m
[00:00:31.694,702] [1;31m<err> net_tcp: conn: 0x200133c0 packet allocation failed, len=10[0m

Do you know how to fix this issue?
Thanks.

  • I 've got more debug log:

    [00:00:40.922,241] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:40.922,271] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:40.964,965] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 40
    [00:00:40.965,026] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 40 (requested 40)
    [00:00:40.965,087] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 1 (net_pkt_clone():1765)
    [00:00:40.965,118] <dbg> net_pkt.net_pkt_skip: (sysworkq): pkt 0x2001d010 skip 20
    [00:00:40.965,148] <dbg> net_pkt.net_pkt_clone: (sysworkq): Cloned 0x2001d0a0 to 0x2001d010
    [00:00:40.965,179] <dbg> net_pkt.net_pkt_ref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:40.965,240] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 1 frags 0x2001d2b0 (tcp_send():325)
    [00:00:41.122,619] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:41.122,650] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:41.122,680] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:41.165,344] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 40
    [00:00:41.165,374] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 40 (requested 40)
    [00:00:41.165,435] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 1 (net_pkt_clone():1765)
    [00:00:41.165,466] <dbg> net_pkt.net_pkt_skip: (sysworkq): pkt 0x2001d010 skip 20
    [00:00:41.165,527] <dbg> net_pkt.net_pkt_clone: (sysworkq): Cloned 0x2001d0a0 to 0x2001d010
    [00:00:41.165,557] <dbg> net_pkt.net_pkt_ref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:41.165,588] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 1 frags 0x2001d2b0 (tcp_send():325)
    [00:00:41.322,906] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:41.322,937] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:41.322,967] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:41.365,722] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 40
    [00:00:41.365,753] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 40 (requested 40)
    [00:00:41.365,814] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 1 (net_pkt_clone():1765)
    [00:00:41.365,844] <dbg> net_pkt.net_pkt_skip: (sysworkq): pkt 0x2001d010 skip 20
    [00:00:41.365,905] <dbg> net_pkt.net_pkt_clone: (sysworkq): Cloned 0x2001d0a0 to 0x2001d010
    [00:00:41.365,936] <dbg> net_pkt.net_pkt_ref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:41.365,966] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 1 frags 0x2001d2b0 (tcp_send():325)
    [00:00:41.523,406] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:41.523,437] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:41.523,468] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:41.566,101] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 40
    [00:00:41.566,131] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 40 (requested 40)
    [00:00:41.566,192] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 1 (net_pkt_clone():1765)
    [00:00:41.566,253] <dbg> net_pkt.net_pkt_skip: (sysworkq): pkt 0x2001d010 skip 20
    [00:00:41.566,284] <dbg> net_pkt.net_pkt_clone: (sysworkq): Cloned 0x2001d0a0 to 0x2001d010
    [00:00:41.566,314] <dbg> net_pkt.net_pkt_ref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:41.566,375] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 1 frags 0x2001d2b0 (tcp_send():325)
    [00:00:41.723,754] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:41.723,785] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:41.723,815] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:41.766,479] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 40
    [00:00:41.766,510] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 40 (requested 40)
    [00:00:41.766,571] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 1 (net_pkt_clone():1765)
    [00:00:41.766,601] <dbg> net_pkt.net_pkt_skip: (sysworkq): pkt 0x2001d010 skip 20
    [00:00:41.766,662] <dbg> net_pkt.net_pkt_clone: (sysworkq): Cloned 0x2001d0a0 to 0x2001d010
    [00:00:41.766,693] <dbg> net_pkt.net_pkt_ref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:41.766,723] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 1 frags 0x2001d2b0 (tcp_send():325)
    [00:00:41.924,102] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:41.924,133] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:41.924,163] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:41.966,857] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 40
    [00:00:41.966,888] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 40 (requested 40)
    [00:00:41.966,949] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 1 (net_pkt_clone():1765)
    [00:00:41.966,979] <dbg> net_pkt.net_pkt_skip: (sysworkq): pkt 0x2001d010 skip 20
    [00:00:41.967,041] <dbg> net_pkt.net_pkt_clone: (sysworkq): Cloned 0x2001d0a0 to 0x2001d010
    [00:00:41.967,071] <dbg> net_pkt.net_pkt_ref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:41.967,102] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TX [1] pkt 0x2001d010 ref 1 frags 0x2001d2b0 (tcp_send():325)
    [00:00:42.124,572] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:42.124,603] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:42.124,633] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    --- 60 messages dropped ---
    [00:00:42.850,097] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    --- 3 messages dropped ---
    [00:00:42.850,250] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:42.850,280] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:42.850,402] <dbg> net_pkt.net_pkt_read: (rx_q[0]): pkt 0x2001cf38 data 0x20006ad4 length 2
    [00:00:42.850,463] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:42.850,494] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 12
    [00:00:42.850,524] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 8
    [00:00:42.850,585] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001cf38 data 0x2001f04d length 20
    [00:00:42.850,616] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:42.850,646] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:42.850,708] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:42.850,738] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:42.850,769] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 40
    [00:00:42.850,830] <dbg> net_pkt.net_pkt_read: (rx_q[0]): pkt 0x2001cf38 data 0x200069c8 length 4
    [00:00:42.850,860] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:42.850,921] <dbg> net_pkt.pkt_alloc_with_buffer: (rx_q[0]): On iface 0x20000730 size 20
    [00:00:42.850,952] <dbg> net_pkt.pkt_estimate_headers_length: (rx_q[0]): HDRs length estimation 48
    [00:00:42.850,982] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (rx_q[0]): Data allocation maximum size 68 (requested 20)
    [00:00:42.851,043] <dbg> net_pkt.pkt_alloc_buffer: (rx_q[0]): TDATA (?) [0] frag 0x2001d298 ref 1 (tcp_out_ext():776)
    [00:00:42.851,074] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d0a0 data 0x2001f935 length 20
    [00:00:42.851,104] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d0a0 skip 20
    [00:00:42.851,165] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d0a0 data 0x2001f949 length 20
    [00:00:42.851,196] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d0a0 skip 20
    [00:00:42.851,226] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d0a0 data 0x2001f935 length 20
    [00:00:42.851,257] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d0a0 skip 20
    [00:00:42.851,318] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d0a0 skip 12
    --- 3 messages dropped ---
    [00:00:42.851,440] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d0a0 skip 20
    [00:00:42.851,501] <dbg> net_pkt.net_pkt_ref_debug: (rx_q[0]): TX [2] pkt 0x2001d0a0 ref 2 (tcp_send():284)
    [00:00:42.851,562] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): TX [2] pkt 0x2001d0a0 ref 1 frags 0x2001d298 (tcp_send():325)
    [00:00:42.851,593] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RX [2] pkt 0x2001cf38 ref 0 frags 0x2001d0e8 (processing_data():139)
    --- 60 messages dropped ---
    [00:00:43.257,080] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 20
    [00:00:43.257,141] <dbg> net_pkt.pkt_estimate_headers_length: (sysworkq): HDRs length estimation 48
    [00:00:43.257,171] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 68 (requested 20)
    [00:00:43.257,202] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d280 ref 1 (tcp_out_ext():776)
    [00:00:43.257,263] <dbg> net_pkt.net_pkt_write: (sysworkq): pkt 0x2001d0a0 data 0x2001f8b5 length 20
    [00:00:43.257,293] <dbg> net_pkt.net_pkt_skip: (sysworkq): pkt 0x2001d0a0 skip 20
    --- 58 messages dropped ---
    [00:00:43.639,068] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,099] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,099] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,129] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,160] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,160] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,190] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,190] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,221] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,251] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,282] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,282] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,312] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,343] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,343] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,373] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,373] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,404] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,404] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,434] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,465] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,465] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,495] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,495] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,556] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,617] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,678] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,739] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,801] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,862] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,923] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.639,984] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.640,045] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.640,106] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.640,197] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.640,258] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.640,289] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:43.640,350] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    --- 32 messages dropped ---
    [00:00:43.642,700] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 8
    [00:00:43.642,761] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d010 data 0x2001fa49 length 20
    [00:00:43.642,822] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 20
    [00:00:43.642,883] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 20
    [00:00:43.642,944] <dbg> net_pkt.net_pkt_ref_debug: (rx_q[0]): TX [0] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:43.643,005] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): TX [0] pkt 0x2001d010 ref 1 frags 0x2001d2c8 (tcp_send():325)
    [00:00:43.643,127] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RX [2] pkt 0x2001cf38 ref 0 frags 0x2001d0e8 (processing_data():139)
    [00:00:43.643,188] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 frags (nil) (processing_data():139)
    [00:00:43.643,249] <dbg> net_pkt.net_pkt_frag_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 (net_pkt_unref_debug():586)
    [00:00:43.643,310] <dbg> net_pkt.net_pkt_print: (rx_q[0]): TX 0 RX 3 RDATA 0 TDATA 0
    [00:00:43.647,186] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [0] pkt 0x2001cfc8 ref 0 frags 0x2001d280 (ppp_send():172)
    [00:00:43.647,247] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d280 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:43.647,308] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:43.647,369] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d280 ref 0 (net_pkt_unref_debug():586)
    [00:00:43.658,416] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 10
    [00:00:43.658,447] <dbg> net_pkt.pkt_estimate_headers_length: (sysworkq): HDRs length estimation 48
    [00:00:43.658,508] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 58 (requested 10)
    [00:00:43.658,569] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 1 (tcp_send_data():897)
    [00:00:43.658,630] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 20
    [00:00:43.758,728] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TX [0] pkt 0x2001cfc8 ref 0 frags 0x2001d2b0 (tcp_send_data():928)
    [00:00:43.758,789] <dbg> net_pkt.net_pkt_unref_debug: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (tcp_send_data():928)
    [00:00:43.758,819] <dbg> net_pkt.net_pkt_frag_unref_debug: (sysworkq): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:43.802,215] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001d010 ref 0 frags 0x2001d2c8 (ppp_send():172)
    [00:00:43.802,246] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2c8 ref 0 frags (nil) (ppp_send():172)
    [00:00:43.802,276] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2c8 ref 0 (net_pkt_unref_debug():586)
    [00:00:43.958,953] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 10
    [00:00:43.958,984] <dbg> net_pkt.pkt_estimate_headers_length: (sysworkq): HDRs length estimation 48
    [00:00:43.959,045] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 58 (requested 10)
    [00:00:43.959,075] <dbg> net_pkt.pkt_alloc_buffer: (sysworkq): TDATA (?) [0] frag 0x2001d2c8 ref 1 (tcp_send_data():897)
    [00:00:43.959,136] <dbg> net_pkt.pkt_alloc_with_buffer: (sysworkq): On iface 0x20000730 size 20
    [00:00:43.959,197] <dbg> net_pkt.pkt_estimate_headers_length: (sysworkq): HDRs length estimation 48
    [00:00:43.959,228] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (sysworkq): Data allocation maximum size 68 (requested 20)
    --- 63 messages dropped ---
    [00:00:44.019,927] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.020,294] <dbg> net_pkt.net_pkt_read: (rx_q[0]): pkt 0x2001cf38 data 0x20006ad4 length 2
    [00:00:44.020,355] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.020,416] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 12
    [00:00:44.020,477] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 8
    [00:00:44.020,507] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x2001f04d length 20
    [00:00:44.020,538] <dbg> net_pkt.net_pkt_skip: (<log_strdup alloc failed>): pkt 0x2001cf38 skip 20
    [00:00:44.020,568] <dbg> net_pkt.net_pkt_skip: (<log_strdup alloc failed>): pkt 0x2001cf38 skip 20
    [00:00:44.020,660] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.020,690] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.020,751] <dbg> net_pkt.net_pkt_skip: (<log_strdup alloc failed>): pkt 0x2001cf38 skip 20
    [00:00:44.020,843] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RX [2] pkt 0x2001cf38 ref 0 frags 0x2001d0e8 (processing_data():139)
    [00:00:44.020,935] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 frags (nil) (processing_data():139)
    [00:00:44.020,996] <dbg> net_pkt.net_pkt_frag_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 (net_pkt_unref_debug():586)
    [00:00:44.021,087] <dbg> net_pkt.net_pkt_print: (rx_q[0]): TX 1 RX 3 RDATA 0 TDATA 0
    [00:00:44.088,256] <dbg> net_pkt.pkt_alloc_with_buffer: (ppp_workq): On iface 0x20000730 size 128
    [00:00:44.088,317] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (ppp_workq): Data allocation maximum size 128 (requested 128)
    [00:00:44.088,348] <dbg> net_pkt.pkt_alloc_buffer: (ppp_workq): RDATA (?) [0] frag 0x2001d0e8 ref 1 (ppp_save_byte():103)
    [00:00:44.088,409] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,439] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,500] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,562] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,623] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,653] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,684] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,714] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,745] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,775] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,806] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,836] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,897] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,928] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.088,958] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,019] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,080] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,141] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,202] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,263] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,324] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,385] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,447] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,508] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,599] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,660] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,721] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,782] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,843] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,874] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,935] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,965] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.089,996] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,026] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,057] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,087] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,118] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,148] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,179] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,209] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,240] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,301] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,362] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,423] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,484] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,545] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.090,911] <dbg> net_pkt.net_pkt_read: (rx_q[0]): pkt 0x2001cf38 data 0x20006ad4 length 2
    [00:00:44.090,972] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.091,033] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 12
    [00:00:44.091,094] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 8
    [00:00:44.091,156] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001cf38 data 0x2001f04d length 20
    [00:00:44.091,217] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.091,278] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.091,339] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.091,400] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.091,430] <dbg> net_pkt.net_pkt_skip: (<log_strdup alloc failed>): pkt 0x2001cf38 skip 20
    [00:00:44.091,491] <dbg> net_pkt.net_pkt_unref_debug: (<log_strdup alloc failed>): RX [2] pkt 0x2001cf38 ref 0 frags 0x2001d0e8 (processing_data():139)
    [00:00:44.091,491] <dbg> net_pkt.net_pkt_unref_debug: (<log_strdup alloc failed>): RDATA (?) [0] frag 0x2001d0e8 ref 0 frags (nil) (processing_data():139)
    [00:00:44.091,522] <dbg> net_pkt.net_pkt_frag_unref_debug: (<log_strdup alloc failed>): RDATA (?) [0] frag 0x2001d0e8 ref 0 (net_pkt_unref_debug():586)
    [00:00:44.091,583] <dbg> net_pkt.net_pkt_print: (<log_strdup alloc failed>): TX 1 RX 3 RDATA 0 TDATA 0
    [00:00:44.150,299] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [1] pkt 0x2001cfc8 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:44.150,329] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags 0x2001d2c8 (ppp_send():172)
    [00:00:44.150,360] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2c8 ref 0 frags (nil) (ppp_send():172)
    [00:00:44.150,421] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:44.581,146] <dbg> net_pkt.pkt_alloc_with_buffer: (ppp_workq): On iface 0x20000730 size 128
    [00:00:44.581,176] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (ppp_workq): Data allocation maximum size 128 (requested 128)
    [00:00:44.581,207] <dbg> net_pkt.pkt_alloc_buffer: (ppp_workq): RDATA (?) [0] frag 0x2001d0e8 ref 1 (ppp_save_byte():103)
    [00:00:44.581,268] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,298] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,329] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,359] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,420] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,451] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,481] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,481] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,512] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,512] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,542] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,542] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,573] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,604] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,604] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,634] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,665] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,665] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,695] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,695] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,726] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,756] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,756] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,787] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,787] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,817] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,817] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,848] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,878] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,909] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.581,970] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,031] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,092] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,153] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,214] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,275] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,336] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,397] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,458] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,519] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,580] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,611] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,672] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,733] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,794] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.582,855] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.583,007] <dbg> net_pkt.net_pkt_read: (rx_q[0]): pkt 0x2001cf38 data 0x20006ad4 length 2
    [00:00:44.583,068] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.583,129] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 12
    [00:00:44.583,190] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 8
    [00:00:44.583,251] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001cf38 data 0x2001f04d length 20
    [00:00:44.583,282] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.583,374] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.583,435] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.583,496] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.583,557] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.583,648] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RX [2] pkt 0x2001cf38 ref 0 frags 0x2001d0e8 (processing_data():139)
    [00:00:44.583,709] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 frags (nil) (processing_data():139)
    [00:00:44.583,770] <dbg> net_pkt.net_pkt_frag_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 (net_pkt_unref_debug():586)
    [00:00:44.583,831] <dbg> net_pkt.net_pkt_print: (rx_q[0]): TX 2 RX 3 RDATA 0 TDATA 0
    [00:00:44.991,485] <dbg> net_pkt.pkt_alloc_with_buffer: (ppp_workq): On iface 0x20000730 size 128
    [00:00:44.991,516] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (ppp_workq): Data allocation maximum size 128 (requested 128)
    [00:00:44.991,577] <dbg> net_pkt.pkt_alloc_buffer: (ppp_workq): RDATA (?) [0] frag 0x2001d0e8 ref 1 (ppp_save_byte():103)
    [00:00:44.991,638] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,668] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,699] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,760] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,790] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,821] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,851] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,912] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,943] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.991,973] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,004] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,065] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,095] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,126] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,187] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,218] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,248] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,309] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,340] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,401] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,431] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,462] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,523] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,553] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,584] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,645] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,675] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,706] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,736] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,797] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,828] <dbg> net_pkt.net_pkt_write: (<log_strdup alloc failed>): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,889] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.992,950] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,011] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,072] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,133] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,194] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,255] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,286] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,347] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,408] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,469] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,530] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,591] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,682] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,743] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,804] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,865] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,927] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.993,988] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.994,049] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.994,110] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.994,171] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.994,232] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.994,293] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.994,354] <dbg> net_pkt.net_pkt_write: (ppp_workq): pkt 0x2001cf38 data 0x20005cc7 length 1
    [00:00:44.994,476] <dbg> net_pkt.net_pkt_read: (rx_q[0]): pkt 0x2001cf38 data 0x20006ad4 length 2
    [00:00:44.994,537] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.994,598] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 12
    [00:00:44.994,659] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 8
    [00:00:44.994,720] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001cf38 data 0x2001f04d length 20
    [00:00:44.994,781] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.994,842] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.994,903] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.994,995] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.995,056] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cf38 skip 20
    [00:00:44.995,117] <dbg> net_pkt.pkt_alloc_with_buffer: (rx_q[0]): On iface 0x20000730 size 50
    [00:00:44.995,178] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (rx_q[0]): Data allocation maximum size 50 (requested 50)
    [00:00:44.995,269] <dbg> net_pkt.pkt_alloc_buffer: (rx_q[0]): TDATA (?) [0] frag 0x2001d2c8 ref 1 (net_pkt_clone():1765)
    [00:00:44.995,330] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cfc8 skip 20
    [00:00:44.995,391] <dbg> net_pkt.net_pkt_clone: (rx_q[0]): Cloned 0x2001cf38 to 0x2001cfc8
    [00:00:44.995,422] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001cfc8 skip 40
    [00:00:44.995,513] <dbg> net_pkt.pkt_alloc_with_buffer: (rx_q[0]): On iface 0x20000730 size 20
    [00:00:44.995,544] <dbg> net_pkt.pkt_estimate_headers_length: (rx_q[0]): HDRs length estimation 48
    [00:00:44.995,574] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (<log_strdup alloc failed>): Data allocation maximum size 68 (requested 20)
    [00:00:44.995,635] <dbg> net_pkt.pkt_alloc_buffer: (rx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 1 (tcp_out_ext():776)
    [00:00:44.995,697] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d010 data 0x2001f9b5 length 20
    [00:00:44.995,758] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 20
    [00:00:44.995,819] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d010 data 0x2001f9c9 length 20
    [00:00:44.995,880] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 20
    [00:00:44.995,941] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d010 data 0x2001f9b5 length 20
    [00:00:44.996,002] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 20
    [00:00:44.996,063] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 12
    [00:00:44.996,124] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 8
    [00:00:44.996,185] <dbg> net_pkt.net_pkt_write: (rx_q[0]): pkt 0x2001d010 data 0x2001f9c9 length 20
    [00:00:44.996,246] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 20
    [00:00:44.996,307] <dbg> net_pkt.net_pkt_skip: (rx_q[0]): pkt 0x2001d010 skip 20
    [00:00:44.996,368] <dbg> net_pkt.net_pkt_ref_debug: (rx_q[0]): TX [0] pkt 0x2001d010 ref 2 (tcp_send():284)
    [00:00:44.996,429] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): TX [0] pkt 0x2001d010 ref 1 frags 0x2001d2b0 (tcp_send():325)
    [00:00:44.996,520] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RX [2] pkt 0x2001cf38 ref 0 frags 0x2001d0e8 (processing_data():139)
    [00:00:44.996,612] <dbg> net_pkt.net_pkt_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 frags (nil) (processing_data():139)
    [00:00:44.996,673] <dbg> net_pkt.net_pkt_frag_unref_debug: (rx_q[0]): RDATA (?) [0] frag 0x2001d0e8 ref 0 (net_pkt_unref_debug():586)
    [00:00:44.996,734] <dbg> net_pkt.net_pkt_print: (rx_q[0]): TX 0 RX 3 RDATA 0 TDATA 0
    [00:00:45.057,983] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.150,238] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (ppp_send():172)
    [00:00:45.150,299] <dbg> net_pkt.net_pkt_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (ppp_send():172)
    [00:00:45.150,329] <dbg> net_pkt.net_pkt_frag_unref_debug: (tx_q[0]): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:45.150,421] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.150,451] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    [00:00:45.150,482] <dbg> net_pkt.pkt_alloc_buffer: (main): TDATA (?) [0] frag 0x2001d2b0 ref 1 (context_alloc_pkt():1361)
    [00:00:45.150,512] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.150,573] <dbg> net_pkt.net_pkt_write: (main): pkt 0x2001d010 data 0x2000ad20 length 10
    [00:00:45.150,604] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.250,640] <err> net_tcp: conn: 0x2001dc80 packet allocation failed, len=10
    [00:00:45.250,701] <dbg> net_pkt.net_pkt_unref_debug: (main): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (context_sendto():1715)
    [00:00:45.250,732] <dbg> net_pkt.net_pkt_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (context_sendto():1715)
    [00:00:45.250,762] <dbg> net_pkt.net_pkt_frag_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:45.350,921] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.350,952] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.351,013] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    [00:00:45.351,074] <dbg> net_pkt.pkt_alloc_buffer: (main): TDATA (?) [0] frag 0x2001d2b0 ref 1 (context_alloc_pkt():1361)
    [00:00:45.351,104] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.351,135] <dbg> net_pkt.net_pkt_write: (main): pkt 0x2001d010 data 0x2000ad20 length 10
    [00:00:45.351,165] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.451,232] <err> net_tcp: conn: 0x2001dc80 packet allocation failed, len=10
    [00:00:45.451,293] <dbg> net_pkt.net_pkt_unref_debug: (main): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (context_sendto():1715)
    [00:00:45.451,324] <dbg> net_pkt.net_pkt_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (context_sendto():1715)
    [00:00:45.451,354] <dbg> net_pkt.net_pkt_frag_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:45.551,513] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.551,544] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.551,574] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    [00:00:45.551,635] <dbg> net_pkt.pkt_alloc_buffer: (main): TDATA (?) [0] frag 0x2001d2b0 ref 1 (context_alloc_pkt():1361)
    [00:00:45.551,666] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.551,696] <dbg> net_pkt.net_pkt_write: (main): pkt 0x2001d010 data 0x2000ad20 length 10
    [00:00:45.551,727] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.651,794] <err> net_tcp: conn: 0x2001dc80 packet allocation failed, len=10
    [00:00:45.651,885] <dbg> net_pkt.net_pkt_unref_debug: (main): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (context_sendto():1715)
    [00:00:45.651,916] <dbg> net_pkt.net_pkt_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (context_sendto():1715)
    [00:00:45.651,947] <dbg> net_pkt.net_pkt_frag_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:45.752,075] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.752,105] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.752,136] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    [00:00:45.752,197] <dbg> net_pkt.pkt_alloc_buffer: (main): TDATA (?) [0] frag 0x2001d2b0 ref 1 (context_alloc_pkt():1361)
    [00:00:45.752,227] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.752,258] <dbg> net_pkt.net_pkt_write: (main): pkt 0x2001d010 data 0x2000ad20 length 10
    [00:00:45.752,288] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.852,355] <err> net_tcp: conn: 0x2001dc80 packet allocation failed, len=10
    [00:00:45.852,416] <dbg> net_pkt.net_pkt_unref_debug: (main): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (context_sendto():1715)
    [00:00:45.852,447] <dbg> net_pkt.net_pkt_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (context_sendto():1715)
    [00:00:45.852,478] <dbg> net_pkt.net_pkt_frag_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:45.952,636] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:45.952,667] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.952,697] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    [00:00:45.952,758] <dbg> net_pkt.pkt_alloc_buffer: (main): TDATA (?) [0] frag 0x2001d2b0 ref 1 (context_alloc_pkt():1361)
    [00:00:45.952,789] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:45.952,819] <dbg> net_pkt.net_pkt_write: (main): pkt 0x2001d010 data 0x2000ad20 length 10
    [00:00:45.952,880] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:46.052,917] <err> net_tcp: conn: 0x2001dc80 packet allocation failed, len=10
    [00:00:46.052,978] <dbg> net_pkt.net_pkt_unref_debug: (main): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (context_sendto():1715)
    [00:00:46.053,009] <dbg> net_pkt.net_pkt_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (context_sendto():1715)
    [00:00:46.053,039] <dbg> net_pkt.net_pkt_frag_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:46.153,198] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:46.153,228] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:46.153,259] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    [00:00:46.153,320] <dbg> net_pkt.pkt_alloc_buffer: (main): TDATA (?) [0] frag 0x2001d2b0 ref 1 (context_alloc_pkt():1361)
    [00:00:46.153,350] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:46.153,381] <dbg> net_pkt.net_pkt_write: (main): pkt 0x2001d010 data 0x2000ad20 length 10
    [00:00:46.153,411] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:46.253,479] <err> net_tcp: conn: 0x2001dc80 packet allocation failed, len=10
    [00:00:46.253,540] <dbg> net_pkt.net_pkt_unref_debug: (main): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (context_sendto():1715)
    [00:00:46.253,570] <dbg> net_pkt.net_pkt_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (context_sendto():1715)
    [00:00:46.253,601] <dbg> net_pkt.net_pkt_frag_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:46.353,759] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:46.353,790] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:46.353,820] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    [00:00:46.353,881] <dbg> net_pkt.pkt_alloc_buffer: (main): TDATA (?) [0] frag 0x2001d2b0 ref 1 (context_alloc_pkt():1361)
    [00:00:46.353,912] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:46.353,942] <dbg> net_pkt.net_pkt_write: (main): pkt 0x2001d010 data 0x2000ad20 length 10
    [00:00:46.354,003] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:46.454,040] <err> net_tcp: conn: 0x2001dc80 packet allocation failed, len=10
    [00:00:46.454,101] <dbg> net_pkt.net_pkt_unref_debug: (main): TX [0] pkt 0x2001d010 ref 0 frags 0x2001d2b0 (context_sendto():1715)
    [00:00:46.454,132] <dbg> net_pkt.net_pkt_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 frags (nil) (context_sendto():1715)
    [00:00:46.454,162] <dbg> net_pkt.net_pkt_frag_unref_debug: (main): TDATA (?) [0] frag 0x2001d2b0 ref 0 (net_pkt_unref_debug():586)
    [00:00:46.554,321] <dbg> net_pkt.pkt_alloc_with_buffer: (main): On iface 0x20000730 size 10
    [00:00:46.554,351] <dbg> net_pkt.pkt_estimate_headers_length: (main): HDRs length estimation 48
    [00:00:46.554,382] <dbg> net_pkt.net_pkt_alloc_buffer_debug: (main): Data allocation maximum size 58 (requested 10)
    

  • Hi,

    You have probably filled up an internal buffer in the socket/modem driver/modem.

    Is the modem connected to the network?

    Do you receive the packets in the other end?

    Does the modem provide you with any logs that could help you figure out what is wrong?

    Best regards,

    Didrik

  • Hi Didrik,

    Is the modem connected to the network?

    Yes, it connected to the internet.

    Do you receive the packets in the other end?

    Yes, I received some packages in the other end.

    Does the modem provide you with any logs that could help you figure out what is wrong?
    No, the modem in ppp mode, there is no error log.

    Do you know how to increase internal buffer size of gsm modem driver?

  • Buffer sizes in NCS and Zephyr are generally configured by Kconfig.

    So the best way to find what buffers you can change, and what options to set is to look through the Kconfig files of the relevant module (driver, library, subsystem, etc.).

    Note that the best practice is to set your desired values in the prj.conf file, not changing the defaults in the Kconfig files.

    Also, when setting an option in prj.conf, it must be prefixed with CONFIG_.

    After looking through some of the Kconfig files in the IP stack and GSM modem driver, these options seems most relevant:

    NET_TX_STACK_SIZE

    NET_BUF_DATA_SIZE or NET_BUF_DATA_POOL_SIZE

    HEAP_MEM_POOL_SIZE

  • I run debug mode on Segger Ide causing this issue. When I let the board running without debugging, it works well.

    Thanks for your support.

Related