Hi, It seems that Kannel receives the MMS notification, but instead of passing it to Mbuni (see doc), you pass it to a PHP script (smsd.php). Looks like a kannel configuration error. On Nov 10, 2010, at 14:12, Druss Drenai wrote:
> I noticed too late that in my previous post my logs where so long that it > required an admin approval. > For this reason,i'm gonna create 2 post where i'm going to paste my logs (not > anymore with precision=0,but with precision=1 because i noticed that many > things reported seem to be ok): > > (1)(BEARERBOX) > 2010-11-10 11:53:47 [3469] [0] INFO: Debug_lvl = 1, log_file = <none>, > log_lvl = 0 > 2010-11-10 11:53:47 [3469] [0] WARNING: DLR: using default 'internal' for > storage type. > 2010-11-10 11:53:47 [3469] [0] INFO: DLR using storage type: internal > 2010-11-10 11:53:47 [3469] [0] INFO: Added logfile > `/etc/kannel/log/kannel.log' with level `0'. > 2010-11-10 11:53:47 [3469] [0] INFO: SSL not supported, no SSL initialization > done. > 2010-11-10 11:53:47 [3469] [0] INFO: HTTP: Opening server at port 13000. > 2010-11-10 11:53:47 [3469] [0] INFO: BOXC: 'smsbox-max-pending' not set, > using default (100). > 2010-11-10 11:53:47 [3469] [0] INFO: Set SMS resend frequency to 60 seconds. > 2010-11-10 11:53:47 [3469] [0] INFO: SMS resend retry set to unlimited. > 2010-11-10 11:53:47 [3469] [0] INFO: DLR rerouting for smsc id <3453361361> > disabled. > 2010-11-10 11:53:47 [3469] [0] INFO: AT2[3453361361]: configuration doesn't > show modemtype. will autodetect > 2010-11-10 11:53:47 [3469] [6] INFO: AT2[3453361361]: opening device > 2010-11-10 11:53:47 [3469] [0] INFO: Adding interface * > 2010-11-10 11:53:47 [3469] [0] INFO: ---------------------------------------- > 2010-11-10 11:53:47 [3469] [0] INFO: Kannel bearerbox II version 1.4.3 > starting > 2010-11-10 11:53:47 [3469] [0] INFO: MAIN: Start-up done, entering mainloop > 2010-11-10 11:53:48 [3469] [6] INFO: AT2[3453361361]: speed set to 9600 > 2010-11-10 11:53:50 [3469] [6] INFO: AT2[3453361361]: Phase 2+ is supported > 2010-11-10 11:53:50 [3469] [6] INFO: AT2[3453361361]: Closing device > 2010-11-10 11:53:50 [3469] [6] INFO: AT2[3453361361]: opening device > 2010-11-10 11:53:50 [3469] [6] INFO: AT2[3453361361]: Logging in > 2010-11-10 11:53:50 [3469] [6] INFO: AT2[3453361361]: init device > 2010-11-10 11:53:50 [3469] [6] INFO: AT2[3453361361]: speed set to 9600 > 2010-11-10 11:53:52 [3469] [6] INFO: AT2[3453361361]: Phase 2+ is supported > 2010-11-10 11:53:52 [3469] [6] INFO: AT2[3453361361]: AT SMSC successfully > opened. > 2010-11-10 11:54:05 [3469] [13] INFO: Client connected from <127.0.0.1> > 2010-11-10 11:54:54 [3469] [5] INFO: Client connected from <127.0.0.1> > > (2)(SMSBOX) > > 2010-11-10 11:54:54 [3529] [0] INFO: Debug_lvl = 0, log_file = <none>, > log_lvl = 0 > 2010-11-10 11:54:54 [3529] [0] DEBUG: Loading include file > `/etc/kannel/core.conf' (on line 1 of file /etc/kannel/kannel.conf). > 2010-11-10 11:54:54 [3529] [0] DEBUG: Loading include file > `/etc/kannel/modems.conf' (on line 3 of file /etc/kannel/core.conf). > 2010-11-10 11:54:54 [3529] [0] DEBUG: Kannel smsbox version `1.4.3'. > Build `Nov 2 2010 15:25:35', compiler `4.3.2'. > System Linux, release 2.6.26-2-686, version #1 SMP Thu Sep 16 19:35:51 UTC > 2010, machine i686. > Hostname debian.kalilab.it, IP 127.0.0.1. > Libxml version 2.6.32. > Using native malloc. > > 2010-11-10 11:54:54 [3529] [0] INFO: Starting to log to file > /etc/kannel/log/smsbox.log level 0 > 2010-11-10 11:54:54 [3529] [0] INFO: Added logfile > `/etc/kannel/log/smsbox.log' with level `0'. > 2010-11-10 11:54:54 [3529] [0] INFO: HTTP: Opening server at port 13013. > 2010-11-10 11:54:54 [3529] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller) > 2010-11-10 11:54:54 [3529] [0] DEBUG: Started thread 2 > (gwlib/http.c:server_thread) > 2010-11-10 11:54:54 [3529] [0] INFO: Set up send sms service at port 13013 > 2010-11-10 11:54:54 [3529] [0] DEBUG: Started thread 3 > (gw/smsbox.c:sendsms_thread) > 2010-11-10 11:54:54 [3529] [0] DEBUG: > ---------------------------------------------- > 2010-11-10 11:54:54 [3529] [0] DEBUG: Kannel smsbox version 1.4.3 starting > 2010-11-10 11:54:54 [3529] [0] DEBUG: dumping group (sendsms-user): > 2010-11-10 11:54:54 [3529] [0] DEBUG: <group> = <sendsms-user> > 2010-11-10 11:54:54 [3529] [0] DEBUG: <username> = <diego> > 2010-11-10 11:54:54 [3529] [0] DEBUG: <password> = <diego> > 2010-11-10 11:54:54 [3529] [0] DEBUG: Started thread 4 > (gw/smsbox.c:obey_request_thread) > 2010-11-10 11:54:54 [3529] [0] DEBUG: Started thread 5 > (gw/smsbox.c:url_result_thread) > 2010-11-10 11:54:54 [3529] [0] DEBUG: Started thread 6 > (gw/smsbox.c:http_queue_thread) > 2010-11-10 11:54:54 [3529] [4] DEBUG: Thread 4 > (gw/smsbox.c:obey_request_thread) maps to pid 3529. > 2010-11-10 11:54:54 [3529] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps to > pid 3529. > 2010-11-10 11:54:54 [3529] [5] DEBUG: Thread 5 > (gw/smsbox.c:url_result_thread) maps to pid 3529. > 2010-11-10 11:54:54 [3529] [3] DEBUG: Thread 3 (gw/smsbox.c:sendsms_thread) > maps to pid 3529. > 2010-11-10 11:54:54 [3529] [6] DEBUG: Thread 6 > (gw/smsbox.c:http_queue_thread) maps to pid 3529. > 2010-11-10 11:54:54 [3529] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) > maps to pid 3529. > 2010-11-10 11:54:54 [3529] [0] INFO: Connected to bearerbox at 127.0.0.1 port > 13001. > 2010-11-10 11:54:54 [3529] [0] DEBUG: Started thread 7 > (gw/heartbeat.c:heartbeat_thread) > 2010-11-10 11:54:54 [3529] [7] DEBUG: Thread 7 > (gw/heartbeat.c:heartbeat_thread) maps to pid 3529. > 2010-11-10 11:55:27 [3529] [4] DEBUG: match found: ^[ ]*()[ ]* > 2010-11-10 11:55:27 [3529] [4] INFO: Starting to service > <"application/vnd.wap.mms-message> from <+503> to <1234> > 2010-11-10 11:55:27 [3529] [4] DEBUG: Started thread 8 (gwlib/fdset.c:poller) > 2010-11-10 11:55:27 [3529] [4] DEBUG: Started thread 9 > (gwlib/http.c:write_request_thread) > 2010-11-10 11:55:27 [3529] [9] DEBUG: Thread 9 > (gwlib/http.c:write_request_thread) maps to pid 3529. > 2010-11-10 11:55:27 [3529] [9] DEBUG: Queue contains 0 pending requests. > 2010-11-10 11:55:27 [3529] [9] DEBUG: Parsing URL > `http://localhost/smsd.php?to=%2B503&text=%01%06%22application%2Fvnd.wap.mms-message%00%AF%84%8C%82%98NOK5DDnraTMYSIIJjYQAAsHsv8-MHAAAAAAAA%00%8D%90%89%1F%1F%80mmsviaweb%40mms.net.vodafone.it%00%96Da%3A+kalilab+-+mmsprova%00%8A%80%8E%025Z%88%05%81%03+%3A%80%83http%3A%2F%2Fpromms%2Fservlets%2FNOK5DDnraTMYSIIJjYQAAsHsv8-MHAAAAAAAA%00&from=1234&sent=2010-11-10+10:55:10&smsc=3453361361': > 2010-11-10 11:55:27 [3529] [9] DEBUG: Scheme: http:// > 2010-11-10 11:55:27 [3529] [9] DEBUG: Host: localhost > 2010-11-10 11:55:27 [3529] [9] DEBUG: Port: 80 > 2010-11-10 11:55:27 [3529] [9] DEBUG: Username: (null) > 2010-11-10 11:55:27 [3529] [9] DEBUG: Password: (null) > 2010-11-10 11:55:27 [3529] [9] DEBUG: Path: /smsd.php > 2010-11-10 11:55:27 [3529] [9] DEBUG: Query: > to=%2B503&text=%01%06%22application%2Fvnd.wap.mms-message%00%AF%84%8C%82%98NOK5DDnraTMYSIIJjYQAAsHsv8-MHAAAAAAAA%00%8D%90%89%1F%1F%80mmsviaweb%40mms.net.vodafone.it%00%96Da%3A+kalilab+-+mmsprova%00%8A%80%8E%025Z%88%05%81%03+%3A%80%83http%3A%2F%2Fpromms%2Fservlets%2FNOK5DDnraTMYSIIJjYQAAsHsv8-MHAAAAAAAA%00&from=1234&sent=2010-11-10+10:55:10&smsc=3453361361 > 2010-11-10 11:55:27 [3529] [9] DEBUG: Fragment: (null) > 2010-11-10 11:55:27 [3529] [9] DEBUG: HTTP: Opening connection to > `localhost:80' (fd=27). > 2010-11-10 11:55:27 [3529] [9] DEBUG: Socket connecting > 2010-11-10 11:55:27 [3529] [8] DEBUG: Thread 8 (gwlib/fdset.c:poller) maps to > pid 3529. > 2010-11-10 11:55:27 [3529] [8] DEBUG: Get info about connecting socket > 2010-11-10 11:55:27 [3529] [8] DEBUG: HTTP: Sending request: > 2010-11-10 11:55:27 [3529] [8] DEBUG: Octet string at 0x82c0788: > 2010-11-10 11:55:27 [3529] [8] DEBUG: len: 451 > 2010-11-10 11:55:27 [3529] [8] DEBUG: size: 1024 > 2010-11-10 11:55:27 [3529] [8] DEBUG: immutable: 0 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 47 45 54 20 2f 73 6d 73 64 2e > 70 68 70 3f 74 6f GET /smsd.php?to > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 3d 25 32 42 35 30 33 26 74 65 > 78 74 3d 25 30 31 =%2B503&text=%01 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 25 30 36 25 32 32 61 70 70 6c > 69 63 61 74 69 6f %06%22applicatio > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6e 25 32 46 76 6e 64 2e 77 61 > 70 2e 6d 6d 73 2d n%2Fvnd.wap.mms- > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6d 65 73 73 61 67 65 25 30 30 > 25 41 46 25 38 34 message%00%AF%84 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 25 38 43 25 38 32 25 39 38 4e > 4f 4b 35 44 44 6e %8C%82%98NOK5DDn > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 72 61 54 4d 59 53 49 49 4a 6a > 59 51 41 41 73 48 raTMYSIIJjYQAAsH > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 73 76 38 2d 4d 48 41 41 41 41 > 41 41 41 41 25 30 sv8-MHAAAAAAAA%0 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 30 25 38 44 25 39 30 25 38 39 > 25 31 46 25 31 46 0%8D%90%89%1F%1F > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 25 38 30 6d 6d 73 76 69 61 77 > 65 62 25 34 30 6d %80mmsviaweb%40m > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6d 73 2e 6e 65 74 2e 76 6f 64 > 61 66 6f 6e 65 2e ms.net.vodafone. > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 69 74 25 30 30 25 39 36 44 61 > 25 33 41 2b 6b 61 it%00%96Da%3A+ka > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6c 69 6c 61 62 2b 2d 2b 6d 6d > 73 70 72 6f 76 61 lilab+-+mmsprova > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 25 30 30 25 38 41 25 38 30 25 > 38 45 25 30 32 35 %00%8A%80%8E%025 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 5a 25 38 38 25 30 35 25 38 31 > 25 30 33 2b 25 33 Z%88%05%81%03+%3 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 41 25 38 30 25 38 33 68 74 74 > 70 25 33 41 25 32 A%80%83http%3A%2 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 46 25 32 46 70 72 6f 6d 6d 73 > 25 32 46 73 65 72 F%2Fpromms%2Fser > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 76 6c 65 74 73 25 32 46 4e 4f > 4b 35 44 44 6e 72 vlets%2FNOK5DDnr > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 61 54 4d 59 53 49 49 4a 6a 59 > 51 41 41 73 48 73 aTMYSIIJjYQAAsHs > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 76 38 2d 4d 48 41 41 41 41 41 > 41 41 41 25 30 30 v8-MHAAAAAAAA%00 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 26 66 72 6f 6d 3d 31 32 33 34 > 26 73 65 6e 74 3d &from=1234&sent= > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 32 30 31 30 2d 31 31 2d 31 30 > 2b 31 30 3a 35 35 2010-11-10+10:55 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 3a 31 30 26 73 6d 73 63 3d 33 > 34 35 33 33 36 31 :10&smsc=3453361 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 33 36 31 20 48 54 54 50 2f 31 > 2e 31 0d 0a 48 6f 361 HTTP/1.1..Ho > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 73 74 3a 20 6c 6f 63 61 6c 68 > 6f 73 74 0d 0a 43 st: localhost..C > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6f 6e 6e 65 63 74 69 6f 6e 3a > 20 6b 65 65 70 2d onnection: keep- > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 61 6c 69 76 65 0d 0a 55 73 65 > 72 2d 41 67 65 6e alive..User-Agen > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 74 3a 20 4b 61 6e 6e 65 6c 2f > 31 2e 34 2e 33 0d t: Kannel/1.4.3. > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 0a 0d 0a > ... > 2010-11-10 11:55:27 [3529] [8] DEBUG: Octet string dump ends. > 2010-11-10 11:55:27 [3529] [8] DEBUG: HTTP: Status line: <HTTP/1.1 200 OK> > 2010-11-10 11:55:27 [3529] [8] DEBUG: HTTP: Received response: > 2010-11-10 11:55:27 [3529] [8] DEBUG: Octet string at 0x82c0788: > 2010-11-10 11:55:27 [3529] [8] DEBUG: len: 452 > 2010-11-10 11:55:27 [3529] [8] DEBUG: size: 1024 > 2010-11-10 11:55:27 [3529] [8] DEBUG: immutable: 0 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 44 61 74 65 3a 20 57 65 64 2c > 20 31 30 20 4e 6f Date: Wed, 10 No > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 76 20 32 30 31 30 20 31 30 3a > 35 35 3a 32 37 20 v 2010 10:55:27 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 47 4d 54 0d 0a 53 65 72 76 65 > 72 3a 20 41 70 61 GMT..Server: Apa > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 63 68 65 2f 32 2e 32 2e 39 20 > 28 44 65 62 69 61 che/2.2.9 (Debia > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6e 29 20 50 48 50 2f 35 2e 32 > 2e 36 2d 31 2b 6c n) PHP/5.2.6-1+l > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 65 6e 6e 79 39 20 77 69 74 68 > 20 53 75 68 6f 73 enny9 with Suhos > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 69 6e 2d 50 61 74 63 68 20 6d > 6f 64 5f 70 79 74 in-Patch mod_pyt > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 68 6f 6e 2f 33 2e 33 2e 31 20 > 50 79 74 68 6f 6e hon/3.3.1 Python > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 2f 32 2e 35 2e 32 20 6d 6f 64 > 5f 70 65 72 6c 2f /2.5.2 mod_perl/ > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 32 2e 30 2e 34 20 50 65 72 6c > 2f 76 35 2e 31 30 2.0.4 Perl/v5.10 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 2e 30 0d 0a 58 2d 50 6f 77 65 > 72 65 64 2d 42 79 .0..X-Powered-By > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 3a 20 50 48 50 2f 35 2e 32 2e > 36 2d 31 2b 6c 65 : PHP/5.2.6-1+le > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6e 6e 79 39 0d 0a 56 61 72 79 > 3a 20 41 63 63 65 nny9..Vary: Acce > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 70 74 2d 45 6e 63 6f 64 69 6e > 67 0d 0a 43 6f 6e pt-Encoding..Con > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 74 65 6e 74 2d 4c 65 6e 67 74 > 68 3a 20 31 32 36 tent-Length: 126 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 0d 0a 4b 65 65 70 2d 41 6c 69 > 76 65 3a 20 74 69 ..Keep-Alive: ti > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6d 65 6f 75 74 3d 31 35 2c 20 > 6d 61 78 3d 31 30 meout=15, max=10 > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 30 0d 0a 43 6f 6e 6e 65 63 74 > 69 6f 6e 3a 20 4b 0..Connection: K > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 65 65 70 2d 41 6c 69 76 65 0d > 0a 43 6f 6e 74 65 eep-Alive..Conte > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6e 74 2d 54 79 70 65 3a 20 74 > 65 78 74 2f 68 74 nt-Type: text/ht > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6d 6c 0d 0a 0d 0a 3c 68 74 6d > 6c 3e 0a 3c 68 65 ml....<html>.<he > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 61 64 3e 0a 3c 6d 65 74 61 20 > 68 74 74 70 2d 65 ad>.<meta http-e > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 71 75 69 76 3d 22 43 6f 6e 74 > 65 6e 74 2d 54 79 quiv="Content-Ty > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 70 65 22 20 63 6f 6e 74 65 6e > 74 3d 22 74 65 78 pe" content="tex > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 74 2f 68 74 6d 6c 3b 20 63 68 > 61 72 73 65 74 3d t/html; charset= > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 55 54 46 2d 38 22 2f 3e 20 0a > 3c 2f 68 65 61 64 UTF-8"/> .</head > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 3e 0a 3c 62 6f 64 79 3e 74 65 > 78 74 20 45 72 72 >.<body>text Err > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6f 72 65 21 3c 2f 62 6f 64 79 > 3e 0a 3c 2f 68 74 ore!</body>.</ht > 2010-11-10 11:55:27 [3529] [8] DEBUG: data: 6d 6c 3e 0a > ml>. > 2010-11-10 11:55:27 [3529] [8] DEBUG: Octet string dump ends. > 2010-11-10 11:55:27 [3529] [5] INFO: No reply sent, denied. > 2010-11-10 11:55:42 [3529] [8] DEBUG: HTTP: Server closed connection, > destroying it <localhost:80:0::><0x82bd110><fd:27>. > > (3)(WAPBOX) > > 2010-11-10 11:54:04 [3484] [0] INFO: Debug_lvl = 1, log_file = <none>, > log_lvl = 0 > 2010-11-10 11:54:05 [3484] [0] WARNING: 'map-url' config directive and > related are deprecated, please use wap-url-map group > 2010-11-10 11:54:05 [3484] [0] INFO: SSL not supported, no SSL initialization > done. > 2010-11-10 11:54:05 [3484] [0] INFO: Added logfile `/var/tmp/wapbox.log' with > level `-1'. > 2010-11-10 11:54:05 [3484] [0] INFO: Starting to log to file > /var/tmp/wapbox.log level -1 > 2010-11-10 11:54:05 [3484] [0] INFO: Logging accesses to > '/var/tmp/wapaccess.log'. > 2010-11-10 11:54:05 [3484] [0] INFO: Started access logfile > `/var/tmp/wapaccess.log'. > 2010-11-10 11:54:05 [3484] [0] INFO: > ------------------------------------------------------------ > 2010-11-10 11:54:05 [3484] [0] INFO: Kannel wapbox version 1.4.3 starting up. > 2010-11-10 11:54:05 [3484] [0] INFO: Connected to bearerbox at localhost port > 13002. > > > > _______________________________________________ > Users mailing list > Users@mbuni.org > http://lists.mbuni.org/mailman/listinfo/users
_______________________________________________ Users mailing list Users@mbuni.org http://lists.mbuni.org/mailman/listinfo/users
