[Spce-user] SQL Errors

Andreas Granig agranig at sipwise.com
Fri Feb 8 13:22:32 EST 2013


Hi,

Other people on the list have experienced this issue, and it was always 
related to hard-disk issues. Is it by any chance a VM you are running?

Also check /var/log/mysql/mysqld.err for errors during this time.

Andreas

On 02/07/2013 02:19 AM, Maxwell Power wrote:
> The system load is minimal. There are no mysql or system errors. A recent
> registration error shows:
> Feb  6 19:56:38 mci1 /usr/sbin/kamailio[31172]: ERROR: db_mysql
> [km_dbase.c:122]: driver error on query: Lost connection to MySQL server
> during query
> Feb  6 19:56:38 mci1 /usr/sbin/kamailio[31172]: ERROR: <core>
> [db_query.c:312]: error while submitting query
> Feb  6 19:56:38 mci1 /usr/sbin/kamailio[31172]: ERROR: usrloc
> [ucontact.c:732]: updating database failed
> Feb  6 19:56:38 mci1 /usr/sbin/kamailio[31172]: ERROR: usrloc
> [ucontact.c:916]: failed to update database
> Feb  6 19:56:38 mci1 /usr/sbin/kamailio[31172]: ERROR: registrar
> [save.c:731]: failed to update contact
>
> Mysql appears to be running just fine the whole time.
>
> Use of uninitialized value in formline at /usr/bin/mysqlreport line 1236.
> Use of uninitialized value in formline at /usr/bin/mysqlreport line 1238.
> MySQL 5.1.57-rel12.8-lo  uptime 0 4:19:32       Wed Feb  6 20:10:29 2013
>
> __ Key _________________________________________________________________
> Buffer used     5.00k of 256.00M  %Used:   0.00
>    Current      46.69M            %Usage:  18.24
> Write hit     100.00%
> Read hit       90.48%
>
> __ Questions ___________________________________________________________
> Total          17.70k     1.1/s
>    DMS          10.64k     0.7/s  %Total:  60.09
>    Com_          8.81k     0.6/s           49.75
>    -Unknown      5.26k     0.3/s           29.69
>    COM_QUIT      3.52k     0.2/s           19.86
> Slow 5 s           18     0.0/s            0.10  %DMS:   0.17  Log:  ON
> DMS            10.64k     0.7/s           60.09
>    SELECT        9.27k     0.6/s           52.39         87.19
>    DELETE        1.26k     0.1/s            7.11         11.84
>    UPDATE           64     0.0/s            0.36          0.60
>    INSERT           40     0.0/s            0.23          0.38
>    REPLACE           0       0/s            0.00          0.00
> Com_            8.81k     0.6/s           49.75
>    admin_comma   3.61k     0.2/s           20.38
>    set_option    2.14k     0.1/s           12.07
>    show_status   1.50k     0.1/s            8.50
>
> __ SELECT and Sort _____________________________________________________
> Scan            3.77k     0.2/s %SELECT:  40.63
> Range              24     0.0/s            0.26
> Full join         159     0.0/s            1.71
> Range check         0       0/s            0.00
> Full rng join       0       0/s            0.00
> Sort scan       1.58k     0.1/s
> Sort range      1.60k     0.1/s
> Sort mrg pass       0       0/s
>
> __ Table Locks _________________________________________________________
> Waited              0       0/s  %Total:   0.00
> Immediate      11.87k     0.8/s
>
> __ Tables ______________________________________________________________
> Open              200 of 4096    %Cache:   4.88
> Opened            765     0.0/s
>
> __ Connections _________________________________________________________
> Max used           29 of 2048      %Max:   1.42
> Total           3.66k     0.2/s
>
> __ Created Temp ________________________________________________________
> Disk table      1.61k     0.1/s
> Table           1.87k     0.1/s    Size:  64.0M
> File                5     0.0/s
>
> __ Threads _____________________________________________________________
> Running             1 of    6
> Cached             23 of   64      %Hit:  99.21
> Created            29     0.0/s
> Slow                0       0/s
>
> __ Aborted _____________________________________________________________
> Clients           279     0.0/s
> Connects            0       0/s
>
> __ Bytes _______________________________________________________________
> Sent            6.34M   407.3/s
> Received        1.97M   126.4/s
>
> __ InnoDB Buffer Pool __________________________________________________
> Usage          11.55M of   6.01G  %Used:   0.19
> Read hit       99.97%
> Pages
>    Free        393.31k            %Total:  99.81
>    Data            736                      0.19 %Drty:   0.00
>    Misc              3                      0.00
>    Latched           0                      0.00
> Reads         172.96k    11.1/s
>    From file        54     0.0/s            0.03
>    Ahead Rnd                 0/s
>    Ahead Sql                 0/s
> Writes          1.01k     0.1/s
> Flushes           420     0.0/s
> Wait Free           0       0/s
>
> __ InnoDB Lock _________________________________________________________
> Waits               6     0.0/s
> Current             0
> Time acquiring
>    Total         55937 ms
>    Average        9322 ms
>    Max           22228 ms
>
> __ InnoDB Data, Pages, Rows ____________________________________________
> Data
>    Reads           450     0.0/s
>    Writes          702     0.0/s
>    fsync           516     0.0/s
>    Pending
>      Reads           0
>      Writes          0
>      fsync           0
>
> Pages
>    Created           1     0.0/s
>    Read            735     0.0/s
>    Written         420     0.0/s
>
> Rows
>    Deleted          25     0.0/s
>    Inserted         56     0.0/s
>    Read         54.33k     3.5/s
>    Updated          52     0.0/s
>
> Date: Wed, 6 Feb 2013 23:23:42 +0100
> From: Jon Bonilla (Manwe) <jbonilla at sipwise.com>
> Subject: Re: [Spce-user] SQL Errors
> To: spce-user at lists.sipwise.com
> Message-ID: <20130206232342.476a85eb at quenya>
> Content-Type: text/plain; charset="utf-8"
>
> El Wed, 6 Feb 2013 13:44:13 -0700
> "Maxwell Power" <mpower at entelit.ca> escribi?:
>
>> Hello,
>>
>>
>>
>> We have been experiencing intermittent SQL errors:
>>
>>
>>
>> Feb  6 15:38:51 mci1 /usr/sbin/kamailio[2316]: INFO: <script>: New
>> request - M=BYE R=sip:mod_sofia at 69.147.236.18:5060
>> F=sip:17804178484 at sip.altatel.ca T=sip:7804535973 at sip.altatel.ca
>> IP=127.0.0.1:5080 (127.0.0.1:5080)
>> ID=bdb9c21d-eb3f-1230-1b8f-f978dce378cb
>>
>> Feb  6 15:38:51 mci1 /usr/sbin/kamailio[2316]: INFO: <script>: Stop
>> mediaproxy for all branches - R=sip:mod_sofia at 69.147.236.18:5060
>> ID=bdb9c21d-eb3f-1230-1b8f-f978dce378cb
>>
>> Feb  6 15:38:51 mci1 /usr/sbin/kamailio[2316]: INFO: <script>:
>> Relaying request,
>> du='sip:127.0.0.1;r2=on;lr=on;ftag=jQ8BB4Zrt72Dr;ngcplb=yes' -
>> R=sip:mod_sofia at 69.147.236.18:5060
>> ID=bdb9c21d-eb3f-1230-1b8f-f978dce378cb
>>
>> Feb  6 15:38:51 mci1 /usr/sbin/kamailio[2305]: INFO: <script>:
>> NAT-Reply -
>> S=200 - OK M=BYE IP=127.0.0.1:5080 (127.0.0.1:5060)
>> ID=bdb9c21d-eb3f-1230-1b8f-f978dce378cb
>>
>> Feb  6 15:38:57 mci1 /usr/sbin/kamailio[2305]: ERROR: db_mysql
>> [km_dbase.c:122]: driver error on query: Lost connection to MySQL
>> server during query
>>
>> Feb  6 15:38:57 mci1 /usr/sbin/kamailio[2305]: ERROR: <core>
>> [db_query.c:210]: error while submitting query
>>
>> Feb  6 15:38:57 mci1 /usr/sbin/kamailio[2305]: ERROR: acc [acc.c:435]:
>> failed to insert into database
>>
>>
>>
>> We have tried reinstalling from scratch but still continue to get
>> these errors on calls and registrations. Call logs sometimes get
>> duplicated and registrations fail intermittently.
>>
>
>
> Any check about high load? Errors in mysql log? Anything in the system logs?
>
> -------------- next part --------------
> A non-text attachment was scrubbed...
> Name: signature.asc
> Type: application/pgp-signature
> Size: 836 bytes
> Desc: not available
> URL:
> <http://lists.sipwise.com/pipermail/spce-user/attachments/20130206/1afb7504/
> attachment-0001.pgp>
>
>
> _______________________________________________
> Spce-user mailing list
> Spce-user at lists.sipwise.com
> http://lists.sipwise.com/listinfo/spce-user
>




More information about the Spce-user mailing list