Problem: FB5012 Hängt sich auf bei Callmonitor / sendmessage - Hilfe!

bsirius

Neuer User
Mitglied seit
19 Feb 2007
Beiträge
30
Punkte für Reaktionen
0
Punkte
0
Hallo Ihr lieben,

ich habe das aktuele ds-mod mit callmonitor 1.81 installiert und meine FB Fon 5012 hängt sich jedes mal auf sobald ich einen anruf ODER testanruf mache der einen der listeners matcht. :mad:

Das bekomme ich z.b am Syslog nachdem er messagesend 2x ausgeführt hat. Der Mailer ist der letzte der sich meldet, dann ist die box nicht mehr per sshd/telnet oder webinterface zu erreichen, auch wenn scheinbar das internet /idsn noch geht ... zumindest bis sie sich 30 sekunden später neustartet.

Code:
02-20-2007	13:25:44	User.Notice	192.168.0.1	kernel: klogd started: BusyBox v1.2.1 (2006.08.06-16:28+0000)
02-20-2007	13:25:43	Syslog.Info	192.168.0.1	syslogd started: BusyBox v1.2.1

02-20-2007	13:24:43	User.Info	192.168.0.1	mailer[1097]: csock: using poll
02-20-2007	13:24:23	Daemon.Debug	192.168.0.1	callmonitor: [8:0] FAILED
02-20-2007	13:24:23	Daemon.Debug	192.168.0.1	callmonitor: [8:0] event 'in:cancel' does NOT match pattern 'out:*'

Ich habe nur diese einfache rule im listener stehen::confused:

Code:
out:* ^ ^ mailmessage

aber es ist auch schon passiert wenn ich hangup $EXT als rule da stehen hatte und es passiert auch, wenn ich nur einen testanruf initiiere, z.b. an 123 von 123.

Hat jemand eine Idee wo das problem liegen könnte, oder wie ich am besten debuggen kann um dem problem näher zu kommen? :noidea:

Danke
Björn

Hier meine Konfiguration und am ende das komplete syslog von meinen letzten versuchen bis jetzt incl. neustarts:

Box
Firmware: 25.04.27ds-0.2.9
Branding: 1und1

Hauptspeicher
Gesamt: 14592 KB
Belegt: 11876 KB (ohne Cache)

Flash
tffs ist zu 59% belegt.

Nach Cleanup tffs:
Hauptspeicher
Gesamt: 14592 KB
Belegt: 12136 KB (ohne Cache)

Flash
tffs ist zu 23% belegt.

set:
Code:
ANNEX='B'
CONFIG_AB_COUNT='0'
CONFIG_ANNEX='B'
CONFIG_ASSIST='y'
CONFIG_ATA='y'
CONFIG_ATA_FULL='y'
CONFIG_AUDIO='n'
CONFIG_AURA='n'
CONFIG_BLUETOOTH='n'
CONFIG_BLUETOOTH_CTP='n'
CONFIG_BUTTON='n'
CONFIG_CAPI='y'
CONFIG_CAPI_MIPS='n'
CONFIG_CAPI_NT='y'
CONFIG_CAPI_POTS='n'
CONFIG_CAPI_TE='y'
CONFIG_CAPI_UBIK='n'
CONFIG_CAPI_XILINX='y'
CONFIG_CDROM='n'
CONFIG_CDROM_FALLBACK='n'
CONFIG_DECT='n'
CONFIG_DSL='y'
CONFIG_ENVIRONMENT_PATH='/proc/sys/dev/adam2'
CONFIG_ETH_COUNT='2'
CONFIG_FIRMWARE_URL='http://www.avm.de/fritzbox-firmware-update.php?hardware=89&oem=1und1&language=de&country='
CONFIG_FON='y'
CONFIG_HOMEI2C='n'
CONFIG_HOSTNAME='fritz.fon.box'
CONFIG_I2C='n'
CONFIG_INSTALL_TYPE='ar7_4MB_xilinx_isdn_nt_te_2eth_26950'
CONFIG_JFFS2='n'
CONFIG_LED_NO_DSL_LED='n'
CONFIG_MAILER='y'
CONFIG_MEDIACLI='n'
CONFIG_MEDIASRV='n'
CONFIG_NAND='n'
CONFIG_NFS='n'
CONFIG_OEM_DEFAULT='avm'
CONFIG_PRODUKT='Fritz_Box_5012'
CONFIG_PRODUKT_NAME='FRITZ!Box Fon 5012 (UI)'
CONFIG_RAMSIZE='16'
CONFIG_ROMSIZE='4'
CONFIG_SERVICEPORTAL_URL='http://www.avm.de/fritzbox-service-portal.php?hardware=89&oem=1und1&language=de&country=&version=25.04.27&subversion=0.2.9'
CONFIG_STOREUSRCFG='y'
CONFIG_SUBVERSION='ds-0.2.9'
CONFIG_TAM='n'
CONFIG_TAM_MODE='0'
CONFIG_TR069='y'
CONFIG_UBIK2='n'
CONFIG_UPNP='y'
CONFIG_USB='n'
CONFIG_USB_HOST_AVM='n'
CONFIG_USB_HOST_TI='n'
CONFIG_USB_PRINT_SERV='n'
CONFIG_USB_STORAGE='n'
CONFIG_USB_WLAN_AUTH='n'
CONFIG_VDSL='n'
CONFIG_VERSION='04.27'
CONFIG_VERSION_MAJOR='25'
CONFIG_VLYNQ='n'
CONFIG_VLYNQ0='0'
CONFIG_VLYNQ1='0'
CONFIG_VPN='n'
CONFIG_WLAN='n'
CONFIG_WLAN_1130TNET='n'
CONFIG_WLAN_1350TNET='n'
CONFIG_WLAN_GREEN='n'
CONFIG_WLAN_WDS='n'
CONFIG_XILINX='y'
Country='049'
ETC_CONFIG_PATH='/etc/init.d/rc.init'
HOME='/mod/root'
HWRevision='89'
HWRevision_ATA='1'
HWRevision_BitFileCount=''
HWRevision_Reserved1='0'
IFS='
'
LD_LIBRARY_PATH='/mod/lib'
LOGNAME='root'
Language='de'
MANUAL_TZ_ENABLED='no'
OEM='1und1'
OEM_DEFAULT_INDEX=''
OEM_tmp='1und1'
PATH='/sbin:/bin:/usr/sbin:/usr/bin:/mod/sbin:/mod/bin:/mod/usr/sbin:/mod/usr/bin'
PPID='676'
PS1='\w \$ '
PS2='> '
PS4='+ '
PWD='/var/mod/root'
SHELL='/bin/sh'
TERM='xterm'
TZ='CET-1CEST,M3.5.0,M10.5.0'
USER='root'
VERBOSE_RC_CONF='n'
_='Console Ausgaben auf dieses Terminal umgelenkt'
conf_exec_str='export CONFIG_TR069=y'
enable_ata='1'
i='89'
i_parse='TR069=y'
item_count='2'
parse_hw_revision='89[a-zA-Z]*'
parse_language='de'
parse_line=''
parse_oem='1und1'
tty='/dev/pts/0'
wlan_cal=''

Ausgabe von make für's ds-mod:
Code:
 ~/ds-mod/ds-0.2.9 $ make
STEP 1: UNPACK
unpacking firmware image
splitting kernel image
unpacking filesystem image
  created 763 files
  created 60 directories
  created 166 symlinks
  created 0 devices
  created 0 fifos
unpacking var.tar
done.

STEP 2: MODIFY
applying patches
  applying patches (fon_5012-de)
  creating symlink /tmp and /mod
  setting subversion 'ds-0.2.9'
  applying enum patch
  applying international patch
  removing assistant
  removing oem: none
installing mod base
  copying files
  installing libs
  adding favicons (dsl123)
replacing busybox
  replacing busybox-4mb
  installing symlinks
replacing kernel
  replacing kernel-4mb-04.06 (iln6)
  installing modules
  copying files
  installing libs
installing packages
  syslogd-cgi-0.2
  bftpd-zlib-1.3
  dropbear-sshd-0.48.1
  wol-cgi-0.5
  callmonitor-1.8.1 (addon)
invoking custom script
done.

STEP 3: PACK
squashfs blocksize
  hidden squashfs: 65536
  root filesystem: 65536
packing var.tar
creating filesystem image
merging kernel image
  kernel image size: 3693824 (max: 3866624)
packing firmware_fon_5012.de.image
done.

FINISHED

tar Version: (GNU tar) 1.15.1

load nach start: 13:49:22 up 23 min, load average: 0.02, 0.07, 0.09

ps -ef
Code:
  PID  Uid     VmSize Stat Command
    1 root        320 S   init
    2 root            SW  [keventd]
    3 root            RWN [ksoftirqd_CPU0]
    4 root            SW  [kswapd]
    5 root            SW  [bdflush]
    6 root            SW  [kupdated]
    7 root            SW  [mtdblockd]
    8 root            SW  [tffsd_mtd3]
  276 root            SW  [ubik2_tx[10]]
  277 root            SW  [capitransp]
  292 root       1204 S N ctlmgr
  295 root        880 S N websrv
  298 root       1104 S   igdd
  303 root       1072 S   multid
  332 root       1080 S   dsld -i -n
  339 root        624 S   telefon a127.0.0.1
  342 root        880 S N websrv
  343 root        880 S N websrv
  344 root        880 S N websrv
  349 root       1072 S < voipd
  350 root       1104 S   igdd
  351 root       1104 S   igdd
  352 root       1104 S   igdd
  354 root        176 S   /bin/run_clock -c /dev/tffs/mtd3 -d
  395 root        320 S   httpd -p 81 -c /mod/etc/httpd.conf -h /usr/mww/ -r DS
  421 root        352 S   syslogd -L -C -R 192.168.0.2
  425 root        312 S   /sbin/klogd
  457 root        248 S   dropbear -p 22 -s
  474 root        316 S   httpd -p 82 -c /mod/etc/httpd-wol.conf -h /mod/pkg/wo
  570 root        516 S   /bin/ash /usr/sbin/callmonitor --debug
  572 root        428 S   -sh
  573 root        268 S   logger -t callmonitor -p daemon.info
  574 root        300 S   logger -t callmonitor -p daemon.debug
  637 root        516 S   /bin/ash /usr/sbin/callmonitor --debug
  638 root        516 S   /bin/ash /usr/sbin/callmonitor --debug
  639 root        212 S   sleep 20000d
  640 root        276 S   nc 127.0.0.1 1012
  644 root        516 S   /bin/ash /usr/sbin/callmonitor --debug
  676 root        428 R   dropbear -p 22 -s
  677 root        440 S   -sh
  855 root        304 R   ps -ef

top
Code:
Mem: 14304K used, 288K free, 0K shrd, 120K buff, 2344K cached
Load average: 0.08 0.07 0.09  (Status: S=sleeping R=running, W=waiting)
  PID USER     STATUS   RSS  PPID %CPU %MEM COMMAND
  856 root     R        348   677  8.3  2.3 top
  676 root     S        428   457  5.2  2.9 dropbear
    3 root     SWN        0     0  5.2  0.0 ksoftirqd_CPU0
  292 root     S N     1204     1  0.0  8.2 ctlmgr
  298 root     S       1104     1  0.0  7.5 igdd
  350 root     S       1104   298  0.0  7.5 igdd
  351 root     S       1104   350  0.0  7.5 igdd
  352 root     S       1104   350  0.0  7.5 igdd
  332 root     S       1080     1  0.0  7.3 dsld
  303 root     S       1072     1  0.0  7.3 multid
  349 root     S <     1072     1  0.0  7.3 voipd
  295 root     S N      880     1  0.0  6.0 websrv
  342 root     S N      880   295  0.0  6.0 websrv
  343 root     S N      880   342  0.0  6.0 websrv
  344 root     S N      880   342  0.0  6.0 websrv
  339 root     S        624     1  0.0  4.2 telefon
  570 root     S        516     1  0.0  3.5 callmonitor
  644 root     S        516   570  0.0  3.5 callmonitor
  637 root     S        516   570  0.0  3.5 callmonitor
  638 root     S        516   570  0.0  3.5 callmonitor
  677 root     S        440   676  0.0  3.0 sh

Syslog (mit sensitiven Angaben als: ***)
Code:
2007-02-20 13:07:39	Syslog.Info	192.168.0.1	syslogd started: BusyBox v1.2.1
2007-02-20 13:07:39	User.Notice	192.168.0.1	kernel: klogd started: BusyBox v1.2.1 (2006.08.06-16:28+0000)
2007-02-20 13:10:05	Daemon.Info	192.168.0.1	callmonitor: Exiting ...
2007-02-20 13:10:08	Daemon.Debug	192.168.0.1	callmonitor: entering DEBUG mode
2007-02-20 13:10:08	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/config.sh
2007-02-20 13:10:08	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dboxlcd.sh
2007-02-20 13:10:08	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dial.sh
2007-02-20 13:10:09	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dropbear.sh
2007-02-20 13:10:09	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/mail.sh
2007-02-20 13:10:09	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/messages.sh
2007-02-20 13:10:09	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/roku.sh
2007-02-20 13:10:38	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:11:37 event=CALL id=1 ext=4 source=53****01 dest=0177******9 provider=ISDN
2007-02-20 13:10:38	Daemon.Debug	192.168.0.1	callmonitor: >>> out:request ID=1 TIMESTAMP=20.02.07 13:11:37 SOURCE=53****01 DEST=0177******9 EXT=4 DURATION= PROVIDER=ISDN
2007-02-20 13:10:39	Daemon.Info	192.168.0.1	callmonitor: [1] EVENT=out:request SOURCE='53****01' DEST='0177******9' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:10:39	Daemon.Info	192.168.0.1	callmonitor: [1+] SOURCE_DISP='53****01' DEST_DISP='0177******9' ID=1 EXT=4 DURATION= TIMESTAMP='20.02.07 13:11:37' PROVIDER=ISDN
2007-02-20 13:10:44	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:11:43 event=DISCONNECT id=1 duration=0
2007-02-20 13:10:44	Daemon.Debug	192.168.0.1	callmonitor: >>> out:cancel ID=1 TIMESTAMP=20.02.07 13:11:43 SOURCE=53****01 DEST=0177******9 EXT=4 DURATION=0 PROVIDER=ISDN
2007-02-20 13:10:44	Daemon.Info	192.168.0.1	callmonitor: [2] EVENT=out:cancel SOURCE='53****01' DEST='0177******9' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:10:44	Daemon.Info	192.168.0.1	callmonitor: [2+] SOURCE_DISP='53****01' DEST_DISP='0177******9' ID=1 EXT=4 DURATION=0 TIMESTAMP='20.02.07 13:11:43' PROVIDER=ISDN
2007-02-20 13:14:55	Syslog.Info	192.168.0.1	syslogd started: BusyBox v1.2.1
2007-02-20 13:14:55	User.Notice	192.168.0.1	kernel: klogd started: BusyBox v1.2.1 (2006.08.06-16:28+0000)
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: up)
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsld: cache_create(dnsmasqentry)
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsld: cache_create(dnsstaticentry)
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsld: cache_create(pingerentry)
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsld: cache_create(pingerwaiter)
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsld: cache_create(iprouteset)
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsld: DATAPIPE: with header optimization
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsldmod: init done
2007-02-20 13:14:55	User.Info	192.168.0.1	kernel: kdsld: PPP led: off (value=0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(usbrndis)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(usbrndis)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(tiwlan0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(tiwlan0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(tiwlan0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsup0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsup0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsup0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw0)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw1)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw1)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw1)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw2)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: [tiatm] DSL in training!
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw2)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw2)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw3)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw3)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(wdsdw3)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: request_module(usbrndis)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: AR7WDT: System Init UEberwachung abgeschlossen (204350 ms noch verfuegbar)
2007-02-20 13:14:55	User.Warning	192.168.0.1	kernel: [tiatm] DSL in training!
2007-02-20 13:15:00	System0.Info	192.168.0.1	dropbear[459]: Running in background
2007-02-20 13:15:04	User.Warning	192.168.0.1	kernel: [tiatm] DSL in Sync
2007-02-20 13:15:04	User.Info	192.168.0.1	kernel: kdsld: showtime
2007-02-20 13:15:08	User.Info	192.168.0.1	kernel: kdsld: unsetup done.
2007-02-20 13:15:08	User.Error	192.168.0.1	dsld[332]: voip: ppptarget voip disabled, ignored
2007-02-20 13:15:09	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:12	Daemon.Info	192.168.0.1	init: Starting pid 568, console /dev/tts/0: '/bin/sh'
2007-02-20 13:15:12	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:13	Daemon.Debug	192.168.0.1	callmonitor: entering DEBUG mode
2007-02-20 13:15:14	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/config.sh
2007-02-20 13:15:14	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dboxlcd.sh
2007-02-20 13:15:14	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dial.sh
2007-02-20 13:15:15	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dropbear.sh
2007-02-20 13:15:15	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/mail.sh
2007-02-20 13:15:15	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/messages.sh
2007-02-20 13:15:15	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/roku.sh
2007-02-20 13:15:15	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:18	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:22	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:25	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:28	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:31	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:34	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:37	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:40	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:43	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:46	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:49	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:52	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:53	User.Error	192.168.0.1	dsld[332]: packet_trim_RFC2364: LLC mismatch 0000  AAAA0300 80C20007 00000015 0CEF266B 00901A41  ...............k...A 0014  65668864 1100161F 00790021 45000077 74ED0000  ef.d.....y.!E..wt... 0028  7211E963 5600A4D9 55B29999 F26D8E03 006
2007-02-20 13:15:53	User.Error	192.168.0.1	dsld[332]: packet_trim_RFC2364: LLC mismatch 0000  AAAA0300 80C20007 00000015 0CEF266B 00901A41  ...............k...A 0014  65668864 1100161F 00320021 45000030 DE864000  ef.d.....2.!E..0..@. 0028  750618BD 589BC69D 55B29999 E0D811D2 249
2007-02-20 13:15:54	User.Error	192.168.0.1	dsld[332]: packet_trim_RFC2364: LLC mismatch 0000  AAAA0300 80C20007 00000015 0CEF266B 00901A41  ...............k...A 0014  65668864 1100161F 00320021 45000030 FF564000  ef.d.....2.!E..0.V@. 0028  70065C31 56806974 55B29999 04EE11D2 BBA
2007-02-20 13:15:55	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:15:58	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:01	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:04	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:07	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:10	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:13	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:16	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:19	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:22	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:25	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:28	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:31	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:34	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:37	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:40	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:43	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:47	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:48	User.Warning	192.168.0.1	kernel: /proc/tffs: info request: success
2007-02-20 13:16:50	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:53	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:56	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:16:59	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:17:03	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:17:06	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:17:08	User.Error	192.168.0.1	dsld[332]: autodetect: failed
2007-02-20 13:17:09	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:17:09	User.Info	192.168.0.1	kernel: kdsld: VCC 0: registered (1/32)
2007-02-20 13:17:09	User.Info	192.168.0.1	kernel: kdsld: 0: VPI/VCI 1/32 PPPoE internet 00:**:**:**:**:6b (32,0)
2007-02-20 13:17:09	User.Info	192.168.0.1	kernel: kdsld: internet: set_rcv_ipaddr: 192.168.179.1
2007-02-20 13:17:09	User.Info	192.168.0.1	kernel: kdsld: interface 0 created.
2007-02-20 13:17:09	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:17:09	User.Info	192.168.0.1	kernel: kdsld: setup done.
2007-02-20 13:17:09	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:17:09	User.Info	192.168.0.1	kernel: kdsld: Channel 0 up (physical outgoing)
2007-02-20 13:17:10	User.Info	192.168.0.1	kernel: kdsld: internet: set_snd_ipaddr: 85.***.***.243
2007-02-20 13:17:10	User.Info	192.168.0.1	kernel: kdsld: internet: set_snd_mtu: 1492
2007-02-20 13:17:10	User.Info	192.168.0.1	kernel: kdsld: internet: connected
2007-02-20 13:17:10	User.Info	192.168.0.1	kernel: kdsld: PPP led: on (value=1)
2007-02-20 13:17:12	User.Warning	192.168.0.1	kernel: request_module(binfmt-0000)
2007-02-20 13:17:12	User.Warning	192.168.0.1	kernel: request_module(binfmt-0000)
2007-02-20 13:18:58	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:19:55 event=RING id=2 source=03053****01 dest=53****01 provider=ISDN
2007-02-20 13:18:58	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:19:56 event=CALL id=1 ext=4 source=53****01 dest=53****01 provider=ISDN
2007-02-20 13:18:58	Daemon.Debug	192.168.0.1	callmonitor: >>> out:request ID=1 TIMESTAMP=20.02.07 13:19:56 SOURCE=53****01 DEST=53****01 EXT=4 DURATION= PROVIDER=ISDN
2007-02-20 13:18:58	Daemon.Debug	192.168.0.1	callmonitor: >>> in:request ID=2 TIMESTAMP=20.02.07 13:19:55 SOURCE=03053****01 DEST=53****01 EXT= DURATION= PROVIDER=ISDN
2007-02-20 13:18:59	Daemon.Info	192.168.0.1	callmonitor: [1] EVENT=in:request SOURCE='03053****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:18:59	Daemon.Info	192.168.0.1	callmonitor: [1+] SOURCE_DISP='03053****01' DEST_DISP='53****01' ID=2 EXT= DURATION= TIMESTAMP='20.02.07 13:19:55' PROVIDER=ISDN
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [1:0] processing rule 'out:*' '^' '^' 'hangup $EXT'
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [1:0] event 'in:request' does NOT match pattern 'out:*'
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [1:0] FAILED
2007-02-20 13:18:59	Daemon.Info	192.168.0.1	callmonitor: [2] EVENT=out:request SOURCE='53****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:18:59	Daemon.Info	192.168.0.1	callmonitor: [2+] SOURCE_DISP='53****01' DEST_DISP='53****01' ID=1 EXT=4 DURATION= TIMESTAMP='20.02.07 13:19:56' PROVIDER=ISDN
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [2:0] processing rule 'out:*' '^' '^' 'hangup $EXT'
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [2:0] event 'out:request' matches pattern 'out:*'
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [2:0] parameter SOURCE='53****01' matches pattern '^'
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [2:0] parameter DEST='53****01' matches pattern '^'
2007-02-20 13:18:59	Daemon.Debug	192.168.0.1	callmonitor: [2:0] SUCCEEDED
2007-02-20 13:18:59	Daemon.Info	192.168.0.1	callmonitor: [2:0] ACTION: 'hangup $EXT'
2007-02-20 13:19:06	User.Error	192.168.0.1	webcm[897]: Second instance already running
2007-02-20 13:19:08	User.Error	192.168.0.1	webcm[897]: Second instance already running
2007-02-20 13:19:09	User.Error	192.168.0.1	webcm[897]: Second instance already running
2007-02-20 13:19:10	User.Error	192.168.0.1	webcm[897]: Second instance already running
2007-02-20 13:19:11	User.Error	192.168.0.1	webcm[897]: Second instance already running
2007-02-20 13:19:12	User.Info	192.168.0.1	webcm[897]: MakeLanguagePath html=../html tail=login.html -> ../html/login.html
2007-02-20 13:19:13	User.Info	192.168.0.1	webcm[900]: MakeLanguagePath html=../html tail=login.html -> ../html/login.html
2007-02-20 13:19:14	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:20:12 event=DISCONNECT id=1 duration=0
2007-02-20 13:19:14	Daemon.Debug	192.168.0.1	callmonitor: >>> out:cancel ID=1 TIMESTAMP=20.02.07 13:20:12 SOURCE=53****01 DEST=53****01 EXT=4 DURATION=0 PROVIDER=ISDN
2007-02-20 13:19:14	Daemon.Info	192.168.0.1	callmonitor: [3] EVENT=out:cancel SOURCE='53****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:19:14	Daemon.Info	192.168.0.1	callmonitor: [3+] SOURCE_DISP='53****01' DEST_DISP='53****01' ID=1 EXT=4 DURATION=0 TIMESTAMP='20.02.07 13:20:12' PROVIDER=ISDN
2007-02-20 13:19:14	Daemon.Debug	192.168.0.1	callmonitor: [3:0] processing rule 'out:*' '^' '^' 'hangup $EXT'
2007-02-20 13:19:14	Daemon.Debug	192.168.0.1	callmonitor: [3:0] event 'out:cancel' matches pattern 'out:*'
2007-02-20 13:19:14	Daemon.Debug	192.168.0.1	callmonitor: [3:0] parameter SOURCE='53****01' matches pattern '^'
2007-02-20 13:19:14	Daemon.Debug	192.168.0.1	callmonitor: [3:0] parameter DEST='53****01' matches pattern '^'
2007-02-20 13:19:14	Daemon.Debug	192.168.0.1	callmonitor: [3:0] SUCCEEDED
2007-02-20 13:19:14	Daemon.Info	192.168.0.1	callmonitor: [3:0] ACTION: 'hangup $EXT'
2007-02-20 13:19:15	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:20:13 event=DISCONNECT id=2 duration=0
2007-02-20 13:19:15	Daemon.Debug	192.168.0.1	callmonitor: >>> in:cancel ID=2 TIMESTAMP=20.02.07 13:20:13 SOURCE=03053****01 DEST=53****01 EXT= DURATION=0 PROVIDER=ISDN
2007-02-20 13:19:17	Daemon.Info	192.168.0.1	callmonitor: [4] EVENT=in:cancel SOURCE='03053****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:19:17	Daemon.Info	192.168.0.1	callmonitor: [4+] SOURCE_DISP='03053****01' DEST_DISP='53****01' ID=2 EXT= DURATION=0 TIMESTAMP='20.02.07 13:20:13' PROVIDER=ISDN
2007-02-20 13:19:17	Daemon.Debug	192.168.0.1	callmonitor: [4:0] processing rule 'out:*' '^' '^' 'hangup $EXT'
2007-02-20 13:19:17	Daemon.Debug	192.168.0.1	callmonitor: [4:0] event 'in:cancel' does NOT match pattern 'out:*'
2007-02-20 13:19:17	Daemon.Debug	192.168.0.1	callmonitor: [4:0] FAILED
2007-02-20 13:19:22	User.Info	192.168.0.1	webcm[925]: MakeLanguagePath html=../html tail=login.html -> ../html/login.html
2007-02-20 13:19:23	User.Info	192.168.0.1	webcm[928]: MakeLanguagePath html=../html tail=login.html -> ../html/login.html
2007-02-20 13:24:14	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:25:11 event=RING id=2 source=03053****01 dest=53****01 provider=ISDN
2007-02-20 13:24:14	Daemon.Debug	192.168.0.1	callmonitor: >>> in:request ID=2 TIMESTAMP=20.02.07 13:25:11 SOURCE=03053****01 DEST=53****01 EXT= DURATION= PROVIDER=ISDN
2007-02-20 13:24:14	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:25:11 event=CALL id=1 ext=4 source=53****01 dest=53****01 provider=ISDN
2007-02-20 13:24:14	Daemon.Debug	192.168.0.1	callmonitor: >>> out:request ID=1 TIMESTAMP=20.02.07 13:25:11 SOURCE=53****01 DEST=53****01 EXT=4 DURATION= PROVIDER=ISDN
2007-02-20 13:24:15	Daemon.Info	192.168.0.1	callmonitor: [6] EVENT=out:request SOURCE='53****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:24:15	Daemon.Info	192.168.0.1	callmonitor: [6+] SOURCE_DISP='53****01' DEST_DISP='53****01' ID=1 EXT=4 DURATION= TIMESTAMP='20.02.07 13:25:11' PROVIDER=ISDN
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [6:0] processing rule 'out:*' '^' '^' 'mailmessage'
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [6:0] event 'out:request' matches pattern 'out:*'
2007-02-20 13:24:15	Daemon.Info	192.168.0.1	callmonitor: [5] EVENT=in:request SOURCE='03053****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:24:15	Daemon.Info	192.168.0.1	callmonitor: [5+] SOURCE_DISP='03053****01' DEST_DISP='53****01' ID=2 EXT= DURATION= TIMESTAMP='20.02.07 13:25:11' PROVIDER=ISDN
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [5:0] processing rule 'out:*' '^' '^' 'mailmessage'
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [5:0] event 'in:request' does NOT match pattern 'out:*'
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [5:0] FAILED
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [6:0] parameter SOURCE='53****01' matches pattern '^'
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [6:0] parameter DEST='53****01' matches pattern '^'
2007-02-20 13:24:15	Daemon.Debug	192.168.0.1	callmonitor: [6:0] SUCCEEDED
2007-02-20 13:24:15	Daemon.Info	192.168.0.1	callmonitor: [6:0] ACTION: 'mailmessage'
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:25:19 event=DISCONNECT id=1 duration=0
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: <<< timestamp=20.02.07 13:25:19 event=DISCONNECT id=2 duration=0
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: >>> out:cancel ID=1 TIMESTAMP=20.02.07 13:25:19 SOURCE=53****01 DEST=53****01 EXT=4 DURATION=0 PROVIDER=ISDN
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: >>> in:cancel ID=2 TIMESTAMP=20.02.07 13:25:19 SOURCE=03053****01 DEST=53****01 EXT= DURATION=0 PROVIDER=ISDN
2007-02-20 13:24:21	Daemon.Info	192.168.0.1	callmonitor: [7] EVENT=out:cancel SOURCE='53****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:24:21	Daemon.Info	192.168.0.1	callmonitor: [7+] SOURCE_DISP='53****01' DEST_DISP='53****01' ID=1 EXT=4 DURATION=0 TIMESTAMP='20.02.07 13:25:19' PROVIDER=ISDN
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: [7:0] processing rule 'out:*' '^' '^' 'mailmessage'
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: [7:0] event 'out:cancel' matches pattern 'out:*'
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: [7:0] parameter SOURCE='53****01' matches pattern '^'
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: [7:0] parameter DEST='53****01' matches pattern '^'
2007-02-20 13:24:21	Daemon.Debug	192.168.0.1	callmonitor: [7:0] SUCCEEDED
2007-02-20 13:24:21	Daemon.Info	192.168.0.1	callmonitor: [7:0] ACTION: 'mailmessage'
2007-02-20 13:24:23	Daemon.Info	192.168.0.1	callmonitor: [8] EVENT=in:cancel SOURCE='03053****01' DEST='53****01' SOURCE_NAME='' DEST_NAME=''
2007-02-20 13:24:23	Daemon.Info	192.168.0.1	callmonitor: [8+] SOURCE_DISP='03053****01' DEST_DISP='53****01' ID=2 EXT= DURATION=0 TIMESTAMP='20.02.07 13:25:19' PROVIDER=ISDN
2007-02-20 13:24:23	Daemon.Debug	192.168.0.1	callmonitor: [8:0] processing rule 'out:*' '^' '^' 'mailmessage'
2007-02-20 13:24:23	Daemon.Debug	192.168.0.1	callmonitor: [8:0] event 'in:cancel' does NOT match pattern 'out:*'
2007-02-20 13:24:23	Daemon.Debug	192.168.0.1	callmonitor: [8:0] FAILED
2007-02-20 13:24:43	User.Info	192.168.0.1	mailer[1097]: csock: using poll
2007-02-20 13:25:43	Syslog.Info	192.168.0.1	syslogd started: BusyBox v1.2.1
2007-02-20 13:25:44	User.Notice	192.168.0.1	kernel: klogd started: BusyBox v1.2.1 (2006.08.06-16:28+0000)
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: ld: cache_create(ipmasqmcgroup)
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsld: cache_create(dnsmasqentry)
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsld: cache_create(dnsstaticentry)
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsld: cache_create(pingerentry)
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsld: cache_create(pingerwaiter)
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsld: cache_create(iprouteset)
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsld: DATAPIPE: with header optimization
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsldmod: init done
2007-02-20 13:25:44	User.Info	192.168.0.1	kernel: kdsld: PPP led: off (value=0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(usbrndis)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(usbrndis)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(tiwlan0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(tiwlan0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(tiwlan0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsup0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsup0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsup0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw0)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw1)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw1)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw1)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw2)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: [tiatm] DSL in training!
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw2)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw2)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw3)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw3)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(wdsdw3)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: request_module(usbrndis)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: AR7WDT: System Init UEberwachung abgeschlossen (204570 ms noch verfuegbar)
2007-02-20 13:25:44	User.Warning	192.168.0.1	kernel: [tiatm] DSL in training!
2007-02-20 13:25:46	System0.Info	192.168.0.1	dropbear[457]: Running in background
2007-02-20 13:25:55	User.Warning	192.168.0.1	kernel: [tiatm] DSL in Sync
2007-02-20 13:25:55	User.Info	192.168.0.1	kernel: kdsld: showtime
2007-02-20 13:25:57	Daemon.Info	192.168.0.1	init: Starting pid 572, console /dev/tts/0: '/bin/sh'
2007-02-20 13:25:58	Daemon.Debug	192.168.0.1	callmonitor: entering DEBUG mode
2007-02-20 13:25:58	User.Info	192.168.0.1	kernel: kdsld: unsetup done.
2007-02-20 13:25:59	User.Error	192.168.0.1	dsld[332]: voip: ppptarget voip disabled, ignored
2007-02-20 13:25:59	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/config.sh
2007-02-20 13:25:59	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dboxlcd.sh
2007-02-20 13:25:59	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dial.sh
2007-02-20 13:26:00	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/dropbear.sh
2007-02-20 13:26:00	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/mail.sh
2007-02-20 13:26:00	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/messages.sh
2007-02-20 13:26:00	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:26:00	User.Debug	192.168.0.1	kernel: atm_connect (TX: cl 1,bw 0-0,sdu 1524; RX: cl 1,bw 0-0,sdu 1524,AAL 5)
2007-02-20 13:26:00	Daemon.Debug	192.168.0.1	callmonitor: including /usr/lib/callmonitor/actions.d/roku.sh
2007-02-20 13:26:01	User.Info	192.168.0.1	kernel: kdsld: VCC 0: registered (1/32)
2007-02-20 13:26:01	User.Info	192.168.0.1	kernel: kdsld: 0: VPI/VCI 1/32 PPPoE internet 00:**:**:**:**:6b (32,0)
2007-02-20 13:26:01	User.Info	192.168.0.1	kernel: kdsld: internet: set_rcv_ipaddr: 192.168.179.1
2007-02-20 13:26:01	User.Info	192.168.0.1	kernel: kdsld: interface 0 created.
2007-02-20 13:26:01	User.Info	192.168.0.1	kernel: kdsld: setup done.
2007-02-20 13:26:02	User.Info	192.168.0.1	kernel: kdsld: Channel 0 up (physical outgoing)
2007-02-20 13:26:02	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:26:02	User.Info	192.168.0.1	kernel: kdsld: internet: set_snd_ipaddr: 85.***.***.36
2007-02-20 13:26:02	User.Info	192.168.0.1	kernel: kdsld: internet: set_snd_mtu: 1492
2007-02-20 13:26:02	User.Info	192.168.0.1	kernel: kdsld: internet: connected
2007-02-20 13:26:02	User.Info	192.168.0.1	kernel: kdsld: PPP led: on (value=1)
2007-02-20 13:26:03	User.Warning	192.168.0.1	kernel: request_module(lan)
2007-02-20 13:26:06	User.Warning	192.168.0.1	kernel: request_module(binfmt-0000)
2007-02-20 13:26:06	User.Warning	192.168.0.1	kernel: request_module(binfmt-0000)
2007-02-20 13:31:31	System0.Info	192.168.0.1	dropbear[676]: Child connection from 192.168.0.2:3983
2007-02-20 13:31:34	System0.Notice	192.168.0.1	dropbear[676]: pubkey auth succeeded for 'root' with key md5 67:****************************:30 from 192.168.0.2:3983
2007-02-20 13:35:19	User.Warning	192.168.0.1	kernel: /proc/tffs: info request: success
2007-02-20 13:44:46	User.Warning	192.168.0.1	kernel: /proc/tffs: cleanup request: success
2007-02-20 13:44:51	User.Warning	192.168.0.1	kernel: /proc/tffs: info request: success
2007-02-20 13:45:43	Syslog.Info	192.168.0.1	-- MARK --
 
Hat dann keine eine Idee ? :-(

Hat dann keiner eine Idee? :bahnhof:

Ich würde mich ja selbst auf die Fehlersuche begeben, aber sobald eine Nummer ein "Match" ist, hängt die Box sich auf, d.h. ssh / telnet scheiden aus um dem Fehler näher zu kommen. Logfiles zum auswerten gibt es auch keine, da die Box ja nix speichert was man Ihr nicht ausführlich sagt.

Hat dann keiner der :ziggi: Entwickler eine rettende Idee?:idea:

Verzweifelter Gruß
Björn
 
Hallo Björn,

ich bin ehrlich gesagt etwas überfragt, woran es bei deiner Box hapern könnte. Kannst du das Problem etwas weiter eingrenzen? Tritt es auch bei anderen Aktionen als "mailmessage" und "hangup" auf? Oder geht bei anderen Aktionen alles regelmäßig gut? (Was ist zum Beispiel, wenn du etwas total harmloses wie "true" als Aktion nimmst?)

hangup und mailmessage haben als einzige Gemeinsamkeit, die ich im Moment sehe, dass sie AVM-Programme aufrufen, die auf die Konfiguration der Fritzbox zugreifen (webcm, allcfgconv; außerdem noch auf mailer). Wo da die Verbindung zu den Abstürzen ist, ist mir noch nicht klar.

Viele Grüße,
Andreas
 
Installed 1.8.2 - problem solved? Aber: mailer schlägt fehl!

Danke,

hab grade 1.8.2 installiert und es mit true und mailmessage probiert und bisher scheint das problem nicht wieder aufzutauchen *daumendrück*

Aber, mailmessage schlägt fehl, vieleicht kommt das script noch nicht mit smtp login zurecht? Ne fritzbox testmail geht problemlos, also scheint die allgemeine config nicht fehlerhaft zu sein.

Code:
02-24-2007	19:09:25	User.Info	192.168.0.1	mailer[2188]: mailer finished with 0, Mailer-Response=250 2.6.0 Message accepted {mp034}
02-24-2007	19:09:17	User.Info	192.168.0.1	mailer[2188]: Testmail sent
02-24-2007	19:09:02	User.Info	192.168.0.1	mailer[2188]: dns: mail.gmx.de: 213.165.64.21 ttl=368 from 127.0.0.1.
02-24-2007	19:09:01	User.Info	192.168.0.1	mailer[2188]: dns: mail.gmx.de: query
02-24-2007	19:09:01	User.Info	192.168.0.1	mailer[2188]: startup (Jul  6 2006 14:52:39) Mail: Subject: =?iso-8859-1?B?RlJJVFohQm94IFB1c2ggU2VydmljZTogVmVyYmluZHVuZ3P8YmVyc2ljaHQgdm9tIDI0LjAyLjIwMDc=?=, From: "FRITZ!Box" <[email protected]>, To: [email protected], Attachment: /var/tmp/Anru
02-24-2007	19:08:59	Syslog.Info	192.168.0.1	-- MARK --
02-24-2007	19:08:59	User.Info	192.168.0.1	mailer[2188]: avmssl_init: done
02-24-2007	19:08:46	User.Info	192.168.0.1	mailer[2188]: csock: using poll
02-24-2007	19:07:23	User.Info	192.168.0.1	mailer[2180]: EVENT(212): E-Mail-Zustellung gescheitert. SMTP-Server meldet: "535 5.7.0 Incorrect username or password {mp017}".
02-24-2007	19:07:23	User.Info	192.168.0.1	mailer[2180]: mailer finished with 8, Mailer-Response=535 5.7.0 Incorrect username or password {mp017}
02-24-2007	19:07:22	User.Error	192.168.0.1	mailer[2180]: SMTP-Session to ISP terminated unexpectly!!! (State=8)
02-24-2007	19:07:20	User.Error	192.168.0.1	mailer[2180]: Error in LmsoState_AuthPassSend, Server says 535 5.7.0 Incorrect username or password {mp017}
02-24-2007	19:07:20	User.Info	192.168.0.1	mailer[2180]: dns: mail.gmx.de: 213.165.64.21 ttl=368 from 127.0.0.1.
02-24-2007	19:07:20	User.Info	192.168.0.1	mailer[2180]: dns: mail.gmx.de: query
02-24-2007	19:07:20	User.Info	192.168.0.1	mailer[2180]: startup (Jul  6 2006 14:52:39) Mail: Subject: Verpasst: Anruf von 030******03 [in:cancel], From: "FRITZ!Box" <[email protected]>, To: [email protected], Attachment: Null
02-24-2007	19:07:19	User.Info	192.168.0.1	mailer[2180]: avmssl_init: done
02-24-2007	19:07:15	User.Info	192.168.0.1	mailer[2180]: csock: using poll
02-24-2007	19:07:09	Daemon.Info	192.168.0.1	callmonitor: [8:1] ACTION: 'mailmessage'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [8:1] SUCCEEDED
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [8:1] parameter DEST='******01' matches pattern '******01$'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [8:1] event 'in:cancel' matches pattern 'in:cancel'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [8:1] processing rule 'in:cancel' '^' '******01$' 'mailmessage'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [8:0] FAILED
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [8:0] event 'in:cancel' does NOT match pattern 'out:*'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [8:0] processing rule 'out:*' '^' '^' 'true'
02-24-2007	19:07:09	Daemon.Info	192.168.0.1	callmonitor: [8+] SOURCE_DISP='030******03' DEST_DISP='******01' ID=2 EXT= DURATION=0 TIMESTAMP='24.02.07 19:08:30' PROVIDER=ISDN
02-24-2007	19:07:09	Daemon.Info	192.168.0.1	callmonitor: [8] EVENT=in:cancel SOURCE='030******03' DEST='******01' SOURCE_NAME='' DEST_NAME=''
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [7:1] event 'out:cancel' does NOT match pattern 'in:cancel'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [7:1] processing rule 'in:cancel' '^' '******01$' 'mailmessage'
02-24-2007	19:07:09	Daemon.Info	192.168.0.1	callmonitor: [7:0] ACTION: 'true'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [7:0] SUCCEEDED
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [7:0] parameter DEST='******01' matches pattern '^'
02-24-2007	19:07:09	Daemon.Debug	192.168.0.1	callmonitor: [7:0] parameter SOURCE='******03' matches pattern '^'
02-24-2007	19:07:08	Daemon.Debug	192.168.0.1	callmonitor: [7:0] event 'out:cancel' matches pattern 'out:*'
02-24-2007	19:07:08	Daemon.Debug	192.168.0.1	callmonitor: [7:0] processing rule 'out:*' '^' '^' 'true'
02-24-2007	19:07:08	Daemon.Debug	192.168.0.1	callmonitor: >>> in:cancel ID=2 TIMESTAMP=24.02.07 19:08:30 SOURCE=030******03 DEST=******01 EXT= DURATION=0 PROVIDER=ISDN
02-24-2007	19:07:08	Daemon.Info	192.168.0.1	callmonitor: [7+] SOURCE_DISP='******03' DEST_DISP='******01' ID=1 EXT=4 DURATION=0 TIMESTAMP='24.02.07 19:08:30' PROVIDER=ISDN
02-24-2007	19:07:08	Daemon.Info	192.168.0.1	callmonitor: [7] EVENT=out:cancel SOURCE='******03' DEST='******01' SOURCE_NAME='' DEST_NAME=''

Any ideas?

Danke
Björn
 
Hmm, dann gibt es wahrscheinlich wieder eine neue Aufrufmöglichkeit von 'mailer', von der ich nichts weiß. Schaffst du es, mit [post=676615]diesem Ansatz[/post] mal die Argumente von mailer beim Aufruf durch mailmessage und durch den Push-Service zu vergleichen?

Andreas
 
habs versucht, bekomme aber folgende fehlermeldung:

# mount -o bind /var/tmp/skript /bin/mailer
mount: Mounting /var/tmp/skript on /bin/mailer failed: No such file or directory

hier der inhalt von /bin und ein paar weitere infos

Code:
/bin # ls
[                   head                setfactorydefaults
[[                  hexdump             sh
allcfgconv          hostid              sha1sum
ar7cfgchanged       hostname            sleep
ar7cfgctl           id                  sort
arping              install             strings
ash                 ip                  stty
awk                 kill                supportdata
basename            killall             sync
busybox             lang                tail
cat                 ln                  tar
chmod               logger              tee
chown               login               telnet
clear               logname             test
cmp                 ls                  tftp
cp                  md5sum              time
crontab             mkdir               top
cut                 mkfifo              touch
date                mknod               tr
dd                  more                traceroute
df                  mount               true
dhcpcipchanged      mv                  umount
dirname             nc                  uname
dmesg               netstat             uniq
du                  nohup               update_led_off
echo                nslookup            update_led_on
egrep               od                  uptime
env                 onlinechanged       usleep
ether-wake          passwd              uudecode
expr                pidof               uuencode
false               ping                vi
fgrep               prepare_fwupgrade   voipcfgchanged
find                printf              voipd
free                ps                  wc
ftpget              pwd                 wget
ftpput              realpath            which
getcons             reset               xargs
getopt              rm                  yes
grep                rmdir               zcat
gunzip              run_clock
gzip                sed


/bin # mount
/dev/mtdblock/0 on / type squashfs (ro)
none on /dev type devfs (rw)
proc on /proc type proc (rw)
ramfs on /var type ramfs (rw)


/bin # mount -?
mount: illegal option -- ?
BusyBox v1.2.1 (2006.08.06-16:28+0000) multi-call binary

Usage: mount [flags] DEVICE NODE [-o options,more-options]

Mount a filesystem.  Filesystem autodetection requires /proc be mounted.

Flags:
 -a:   Mount all filesystems in fstab
 -o option: One of many filesystem options, listed below
 -r:   Mount the filesystem read-only
 -t fs-type:  Specify the filesystem type
 -w:   Mount for reading and writing (default)

Options for use with the "-o" flag:
 async/sync:  Writes are asynchronous / synchronous
 atime/noatime: Enable / disable updates to inode access times
 dev/nodev: Allow use of special device files / disallow them
 exec/noexec: Allow use of executable files / disallow them
 suid/nosuid: Allow set-user-id-root programs / disallow them
 remount:  Re-mount a mounted filesystem, changing its flags
 ro/rw:  Mount for read-only / read-write
 bind:  Bind a directory to an additional location
 move:  Relocate an existing mount point.

There are EVEN MORE flags that are specific to each filesystem
You'll have to see the written documentation for those filesystems
 
mailer ergebnis, problem ist umgang mit sonderzeichen im passwort

Ergebnis von mailer.log
1. PUSH Service testen
2. mailmessage vom callmonitor

xxxxx@... meine email
yyyyyy mein benutzername
zzzzzz mein passwort
ZZZ mein passwort im zweiten versuch

Der fehler liegt daran, daß ich sonderzeichen in meinem Passwort habe und daher das passwort ab einer bestimmten stelle fehlt. Ich schicke dir mal eine PM mit den relevanten Stelle meines Passwortes ... das will ich hier natürlich nicht so hier hin schreiben.

Gruß
Björn

Code:
|/sbin/mailer|
|-sFRITZ!Box Push Service: Verbindungsübersicht vom 25.02.2007|
|-f"FRITZ!Box" <[email protected]>|
|[email protected]|
|-mmail.gmx.de|
|-ayyyyyy|
|-wzzzzzz|
|-i/var/tmp/detail.html,/var/tmp/alt_detail.txt,/usr/www/html/html/de/images/beck_lb.gif,/usr/www/html/html/de/images/beck_lm.gif,/usr/www/html/html/de/images/beck_rb.gif,/usr/www/html/html/de/images/beck_rm.gif,/usr/www/html/html/de/images/bg_ramp.jpg,/usr/www/html/html/de/images/brd_lb.gif,/usr/www/html/html/de/images/brd_lt.gif,/usr/www/html/html/de/images/brd_rb.gif,/usr/www/html/html/de/images/brd_rt.gif,/usr/www/html/html/de/images/fw_footer.gif,/usr/www/html/html/de/images/fw_header.gif,/etc/default/1und1/fw_bg_body_pushmail.gif,/usr/www/html/html/de/images/Callinfailed.gif,/usr/www/html/html/de/images/Callin.gif,/usr/www/html/html/de/images/Callout.gif,/usr/www/html/html/de/images/Callno.gif|
|-d/var/tmp/Anrufliste_vom_25.02.2007.csv|

|/sbin/mailer|
|-s|
|Verpasst: Anruf von 53604701 [in:cancel]|
|-f|
|"FRITZ!Box" <[email protected]>|
|-t|
|[email protected]|
|-m|
|mail.gmx.de|
|-a|
|yyyyyy|
|-w|
|ZZZ|
|-i|
|0/stdin.txt|
 
Holen Sie sich 3CX - völlig kostenlos!
Verbinden Sie Ihr Team und Ihre Kunden Telefonie Livechat Videokonferenzen

Gehostet oder selbst-verwaltet. Für bis zu 10 Nutzer dauerhaft kostenlos. Keine Kreditkartendetails erforderlich. Ohne Risiko testen.

3CX
Für diese E-Mail-Adresse besteht bereits ein 3CX-Konto. Sie werden zum Kundenportal weitergeleitet, wo Sie sich anmelden oder Ihr Passwort zurücksetzen können, falls Sie dieses vergessen haben.