Print

Please login or register.
1 Hour 1 Day 1 Week 1 Month Forever
Login with username, password and session length

[erez669]

hello everybody.
today i saw on the router dir-655 log file that "UDHCPD Received a SIGTERM" and "received signal 15, good-bye" and the ip address was renewd after 14 days.
i want to understand if it's normal behavior of the unit or not.
i'm connected to cable modem that is stable more than 15 days.
i'm from israel.

here is the log of my router:

Oct 23 17:49:48     debug     UDHCPD sending ACK to 192.168.0.3
Oct 23 04:01:15     debug     Debu: Joining group 224.0.0.252 upstream on IF address 46.117.1.47
Oct 23 04:01:15     debug     Debu: Leaving group 224.0.0.252 upstream on IF address 46.117.1.47
Oct 23 03:59:09     debug     Debu: Joining group 224.0.0.252 upstream on IF address 46.117.1.47
Oct 23 03:43:58     debug     gpio create pidfile /var/run/gpio_wan_green.pid
Oct 23 03:43:06     notice     HTTP listening on port 39828
Sep 21 20:03:31     debug     UDHCPD sending ACK to 192.168.0.5
Sep 21 20:03:27     debug     UDHCPD Received a SIGTERM
Sep 21 20:03:26     debug     Debu: Leaving group 224.0.0.252 upstream on IF address 46.117.1.47
Sep 21 20:03:26     notice     received signal 15, good-bye
Sep 21 20:03:25     debug     dhcpc sent restart signal  to rc (RESTART APP)
Sep 21 20:03:25     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:25     notice     HTTP listening on port 29308
Sep 21 20:03:23     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:22     debug     Debu: Joining group 224.0.0.252 upstream on IF address 46.117.1.47
Sep 21 20:03:22     debug     Debu: Leaving group 224.0.0.252 upstream on IF address 46.117.1.47
Sep 21 20:03:22     debug     Debu: Joining group 224.0.0.252 upstream on IF address 46.117.1.47
Sep 21 20:03:22     debug     Debu: Leaving group 224.0.0.252 upstream on IF address 46.117.1.47
Sep 21 20:03:22     debug     UDHCPD sending ACK to 192.168.0.2
Sep 21 20:03:21     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:19     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:17     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:15     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:14     debug     Debu: Joining group 224.0.0.252 upstream on IF address 46.117.1.47
Sep 21 20:03:13     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:12     debug     gpio create pidfile /var/run/gpio_wlan.pid
Sep 21 20:03:11     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:09     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:07     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:06     debug     UDHCPD sending ACK to 192.168.0.2
Sep 21 20:03:05     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:03     debug     dhcpc is waiting for rc to be idle.
Sep 21 20:03:03     debug     No DHCP ACK with MS_DHCP_STATIC_ROUTE (option 249)
Sep 21 20:03:03     debug     No DHCP ACK with option DHCPC_CLASSLESS_STATIC_ROUTE
Sep 21 20:03:03     debug     No DHCP ACK with option DHCP_STATIC_ROUTE
Sep 21 20:03:02     debug     Sending select for 46.117.1.47...
Sep 21 20:03:02     debug     DHCPC get gateway = 46.117.0.1
Sep 21 20:03:00     notice     [    3.860000] Freeing unused kernel memory: 5108k freed (0x403b4000 - 0x408b0000)
Sep 21 20:03:00     notice     [    3.810000] 6 cmdlinepart partitions found on MTD device ubicom32_boot_flash
Sep 21 20:03:00     debug     [    0.270000] Switched to high resolution mode on CPU 0
Sep 21 20:03:00     notice     [    0.270000] timer[34]: oneshot
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: hw_ep 5shared, max 64
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: hw_ep 4shared, max 512
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: hw_ep 3shared, max 512
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: hw_ep 2shared, max 1024
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: hw_ep 1shared, max 16
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: hw_ep 0shared, max 64
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: MHDRC RTL version 2.0
Sep 21 20:03:00     debug     [    0.220000] musb_hdrc: ConfigData=0x22 (UTMI-8, SoftConn)
Sep 21 20:03:00     notice     [    0.220000] SCSI subsystem initialized
Sep 21 20:03:00     debug     [    0.220000] pci 0000:00:00.0: reg 10 32bit mmio: [0x000000-0x00ffff]
Sep 21 20:03:00     notice     [    0.000000] timer[34]: periodic: 5000000 cycles
Sep 21 20:03:00     notice     [    0.000000] timer[34]: shutdown
Sep 21 20:03:00     notice     [    0.000000] timer[34]: timer-primary - created
Sep 21 20:03:00     notice     [    0.000000] Kernel command line: console=ttyUM0 console=ttyUS0 serdes=0x02004000,61,250000000 mtdparts=ubicom32_boot_flash:128k(bootloader),7360k(upgrade),384k(jffs2),64k(fw_env),192k(language_pack),64k(artblock)
Sep 21 20:03:00     debug     [    0.000000]   Movable zone: 0 pages used for memmap
Sep 21 20:03:00     debug     [    0.000000]   Normal zone: 16319 pages, LIFO batch:3
Sep 21 20:03:00     debug     [    0.000000]   Normal zone: 129 pages used for memmap
Sep 21 20:03:00     debug     [    0.000000]   DMA zone: 59 pages, LIFO batch:0
Sep 21 20:03:00     debug     [    0.000000]   DMA zone: 0 pages reserved
Sep 21 20:03:00     debug     [    0.000000]   DMA zone: 1 pages used for memmap
Sep 21 20:03:00     debug     [    0.000000] free_area_init_node: node 0, pgdat 403afb28, node_mem_map 40912800
Sep 21 20:03:00     debug     [    0.000000] On node 0 totalpages: 16508
Sep 21 20:03:00     notice     [    0.000000] Linux version 2.6.28.10 (matt@localhost.localdomain) (gcc version 4.4.1 20100320 (stable) (GCC) ) #17 Wed Jan 18 14:06:28 CST 2012
Sep 21 20:03:00     notice     klogd started: BusyBox v1.14.1 (2012-01-12 21:54:51 CST)

[FurryNutz]

What Hardware version is your router? Look at sticker under router.
Link>What Firmware version is currently loaded? Found on routers web page under status.

What ISP Modem do you have? Stand Alone or built in router?
What ISP Modem make and model do you have?

Possible that your ISP has rolled and changed the IP address that your router is getting? ISP change customers IPs ever so often. I might review the modems logs as well. I would contact your ISP and ask if this is the case for this time frame.

There isn't any specific details on status messages seen in the logs that D-Link publishes.

SIGTERM
The SIGTERM signal is sent to a process to request its termination. Unlike the SIGKILL signal, it can be caught and interpreted or ignored by the process. This allows the process to perform nice termination releasing resources and saving state if appropriate.

[erez669]

thanks for your reference.

Hardware Version: B1     
Firmware Version: 2.05
my modem is arris tm602a, a standart cable modem with telephone (no router).
i don't know how to get a modem log.
the isp is 013 netvision, the connection is dynamic ip (without any dialer) MPLS.

so from the log you can't find the reason for this?

[FurryNutz]

Only thing I can come up with is that the ISP modem or ISP services injected a new IP address and the router saw this and automatically restarted and acquired the new information.

I would keep an eye on this and see if this happens again. Are you noticing any problems when this happens?

I would ask your ISP if they and view the ISP Modems logs when this occurs and see if there is any information there. Not a big fan of Arris modems.
FAQ Library

[erez669]

i don't notice any problem, just interesting to understand the reason for this.

[davevt31]

I am pretty sure it means that the DHCP server in the router recieved a signal from the wireless client to terminate the signal to that client.  Most likely due to the client either shutting down or going into a power savings mode.  (Just a WAG though)

[FurryNutz]

Probably same thing as we see on some other status messages, "Client has been dis-associated" as seen in other model router. These are just status messages and are a function of the router.

[erez669]

ok, i just follow the 2 next week to see if it happen again.
i enabled the remote management and ddns in my router, how can i know if
someone else is getting my router settings?

[FurryNutz]

Nobody else should be able to access the routers management page if you have the Admin log in password protected and your the only one with this information.

[erez669]

hello to FurryNutz and all members.
the problem occurs again, and i saw this after i can't surfing on the net without re enable my
NIC, but the router log is empty

now i have the arris modem log, if you can see something from there i want to know:

DOCSIS(CM) Events 
Date Time Event ID Event Level Description
10/12/2012 8:17 20000200 3 No Ranging Response received - T3 time-out
10/12/2012 8:17 20000300 3 Ranging Request Retries exhausted
10/12/2012 8:18 20000200 3 No Ranging Response received - T3 time-out
10/12/2012 8:18 20000300 3 Ranging Request Retries exhausted
10/12/2012 8:19 20000200 3 No Ranging Response received - T3 time-out
10/12/2012 8:19 20000300 3 Ranging Request Retries exhausted
10/12/2012 8:20 20000200 3 No Ranging Response received - T3 time-out
10/12/2012 8:20 20000300 3 Ranging Request Retries exhausted
10/12/2012 8:20 18000200 3 UCD invalid or channel unusable
10/12/2012 8:20 17000100 3 SYNC Timing Synchronization failure - Failed to acquire QAM/QPSK symbol timing
10/23/2012 7:47 20000200 3 No Ranging Response received - T3 time-out
*****  13000300 5 DHCP WARNING - Non-critical field invalid in response
10/26/2012 18:24 8010300 5 DHCP RENEW WARNING - Field invalid in response
10/26/2012 18:24 13000300 5 DHCP WARNING - Non-critical field invalid in response
10/30/2012 6:24 8010300 5 DHCP RENEW WARNING - Field invalid in response
10/30/2012 6:24 13000300 5 DHCP WARNING - Non-critical field invalid in response
11/2/2012 18:24 8010300 5 DHCP RENEW WARNING - Field invalid in response
11/2/2012 18:24 13000300 5 DHCP WARNING - Non-critical field invalid in response
11/6/2012 6:24 8010300 5 DHCP RENEW WARNING - Field invalid in response
11/6/2012 6:24 13000300 5 DHCP WARNING - Non-critical field invalid in response

 PACKETCABLE(MTA) Events 
Date Time Event Level Enterprise Event ID Description MAC Address Endpoint Name
1/1/1970 0:00 5 4115 7 Voice Line Loop Current Change to High, Line Number = 1 00:15:CE:98:9C:99 AALN/1:/0.0.0.0
1/1/1970 0:00 5 4115 7 Voice Line Loop Current Change to High, Line Number = 2 00:15:CE:98:9C:99 AALN/2:/0.0.0.0
10/23/2012 22:22 5 4115 16 MTA TFTP: Successful 00:15:CE:98:9C:99 0015ce989c99.mta.hot.net.il/10.103.84.107
10/23/2012 22:22 5 4115 26 MTA PROV: Successful! 00:15:CE:98:9C:99 0015ce989c99.mta.hot.net.il/10.103.84.107
10/23/2012 22:22 5 4115 3 Voice Line State Change, Line Number = 1, Prev State = OOS, New State = IS 00:15:CE:98:9C:99 AALN/1:0015ce989c99.mta.hot.net.il/10.103.84.107
10/23/2012 22:22 5 4115 3 Voice Line State Change, Line Number = 2, Prev State = OOS, New State = IS 00:15:CE:98:9C:99 AALN/2:0015ce989c99.mta.hot.net.il/10.103.84.107
10/23/2012 22:25 2 4115 65530 Call Agent Loss of Communications 00:15:CE:98:9C:99 AALN/1:0015ce989c99.mta.hot.net.il/10.103.84.107

[FurryNutz]

I would contact your ISP and have them review these Arris modem logs. You might contact Arris directly and see if they have any input on this. Seems like the Arris modem is seeing something going on and seems to have some trouble getting DHCP by seme of those entries. You should ask your ISP if the No Ranging Response entries mean along with Call Agent Loss of Communications as well.

Let us know what they say.