I have 3 6739i phones. 2 work great - 1 of them reboots everyday at 11am, then normally 1-2 more times up until about 1pm then it works fine for the rest of the day.
I have reflashed the firmware - tried different ver. of firmware (currently on 3.3.1, same as the other 2 phones)
Any ideas?
PBX Firmware: 2.210.62-5
Thanks again.
How did you provision the phones?
Are you running XML scripts or the new REST apps?
If you are provisioning them via the EPM or XML do you have logging turned on in the tftp server config? If you do check the /var/log/messages and see if phone is downloading config just before it reboots.
Make sure any local configuartion is deleted in the admin web gui provisioning bit.
They supercedes any other provisioning.
i have provisioning done by EPM - I thought I had logging on, but I guess I missed it on this server - Just turned it on now. I will wait until the next reboot which shouldn’t be too long. When this started happening nothing had changed, provisioning has always been via EPM.
So,
Here is what the log has in it:
Apr 13 03:17:02 sipfo1 rsyslogd: [origin software=“rsyslogd” swVersion=“5.8.10” x-pid=“963” x-info=“http://www.rsyslog.com”] rsyslogd was HUPed
Apr 13 17:29:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:29:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:29:16 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:29:16 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:29:16 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:53:48 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:53:48 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:53:48 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:53:48 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:53:48 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:53:48 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:53:48 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:56:56 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:56:56 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:57:25 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:57:25 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 17:57:25 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:09:17 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:09:17 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:09:17 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:09:17 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:09:17 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:09:17 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:09:17 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 13 18:57:01 sipfo1 xinetd[1163]: Exiting…
Apr 13 18:57:01 sipfo1 xinetd[19775]: xinetd Version 2.3.14 started with libwrap loadavg labeled-networking options compiled in.
Apr 13 18:57:01 sipfo1 xinetd[19775]: Started working: 1 available service
Apr 14 07:58:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:58:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:58:56 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:58:56 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:58:56 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:58:56 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:58:59 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:58:59 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:59:29 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:59:29 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:59:29 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 07:59:29 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:06:21 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:06:21 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:06:32 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:06:32 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:06:32 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:06:32 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:16:44 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:16:44 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:17:46 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:17:54 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:17:54 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:18:58 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:18:58 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:18:58 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:18:58 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:18:58 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:18:58 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 08:18:58 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:04:45 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:04:45 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:05:08 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:05:08 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:05:53 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:05:53 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:05:53 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:05:53 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:05:53 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:06:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:06:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:06:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 10:06:11 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:03:15 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:03:15 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:03:39 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:03:39 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:04:24 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:04:24 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:04:24 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:04:24 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:04:24 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:05:44 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:05:44 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:05:44 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 11:05:44 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:23:07 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:23:07 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:23:30 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:23:30 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:15 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:15 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:15 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:15 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:15 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:35 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:35 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:35 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
Apr 14 12:24:35 sipfo1 asterisk[1665]: rc_avpair_new: unknown attribute 1490026597
You are not getting messages from phone, those are from Asterisk. Why would you post the same error so many times?
My bad, not paying attention must have hit ctrl-A before the coping it and then posting it. - meant to only post the few different lines that were in there - I will have to wait until tomorrow to see if anything new pops up from the phones - I have tftp verbose logging on and tail syslog is there anything else I should be doing to watch from requests from phones?
Thanks again - As much help as I have got from you, I think I owe you lunch or a drink sometime when Im up in Cleveland.
Well if you stop the radius application in Asterisk you will stop those errors.
Until you get messages from the phones IP don’t bother posting.
Did you setup syslog to listen to external devices? Do you have the levels mapped to the messages file and the firewall open to allow this traffic inbound?
About the radius errors - some searching led me to add noload => cdr_radius into /etc/asterisk/modules.conf - which I did, but the errors seem to still be appearing, any suggestions?
I opened port 514UDP, I found multiple threads online about what file to modify. I’ve seen /etc/sysconfig/syslog.conf , /etc/syslog , /etc/sysconfig/rsyslog - I only saw rsyslog on my box - which has syslogd_options="-c 5"
do I update this to syslogd_options="-c 5 -r" ?
you might need to also add
noload => cel_radius
if your system built it.
Thanks - I added that line also - which seem to stop the errors - until this morning then they reappeared - any ideas?
also - the only line I saw added about the time of the phone reboot was:
sipfo1 kernel: Out of memory: Kill process 7655 (w00t) score 639 or sacrifice child
I guess its looking for a blood sacrifice 
I think I have an issue with TFTP logging - I am not getting any TFTP messages in the message file.
Here is what I have done:
edited /etc/xinetd.d/tftp - server_args = -s /tftpboot -vvv
opened UDP 514
edited /etc/sysconfig/rsyslog - syslogd_options = “-c 5 -r” also tried "-c 2 -r"
service xinetd restart
Anything I missed?
Thanks again for your help
also - tried server_args = -s /tftpboot --verbose
There should be no “=” in that syntax
in the server_args command?
I ask because I just followed the file setup:
/etc/xinetd.d/tftp
service tftp
{
disable = no
socket_type = dgram
protocol = udp
wait = yes
user = root
server = /usr/sbin/in.tftpd
server_args = -s /tftpboot -vvv
per_source = 11
cps = 100 2
flags = IPv4
}
did you restart xinetd?
Change server_args = -s /tftpboot -vvv to server_args = -vvv -s /tftpboot
Do a tail -f /var/log/messages in one ssh session then restart xinetd in another and watch the log to see what is going on.
Also what about ps aux | grep -i tftp
OK, so I have found part of my issue - the reason this box is not reporting any tftp activity is the phones are provisioning via http
I took over managing this box recently, trying to help a friend (made assumption, it was tftp)
That being said, the httpd logs from the phone that keeps rebooting shows these errors:
File does not exist: /tftpboot/security.tuz
File does not exist: /tftpboot/6739i.cfg
File does not exist: /var/www/html/restapps (I figure this has to do w/ a trial of restapps and module not removed yet?)
File does not exist: /var/www/html/recordings/aastra
File does not exist: /tftpboot/aastra.lic
and successfully syncs its firmware
I have the same model phone in my office and I never see the TFTP request for most of the error files, are those normal to be requested via http, or any insight to why it reboots everyday at 11am?