[IQUG] start_server command hangs

Asif Arif asif.arif at sybaseproducts.com
Wed May 1 06:11:49 MST 2013


Hi,

 

The recovery will take approximately as long as the time your previous
checkpoint ran and depending on the amount of database activity since then.

 

For example, if your IQ server was shutdown unexpectedly while it was 10
hours into a backup, that means a checkpoint hasn't completed for at least
10 hours. So when IQ is restarted it has to replay all the transactions
since the last checkpoint I.e. perform the recovery. This can take a long
time. 

 

Just be aware of this next time and make sure that your IQ server does not
crash during a long running backup J 

 


Best regards,

Asif.  

 

From: iqug-bounces at iqug.org [mailto:iqug-bounces at iqug.org] On Behalf Of
Julie Nishimura
Sent: Wednesday, May 01, 2013 3:29 AM
To: Julie Nishimura; iqug at dssolutions.com; iqug at iqug.org;
iqug at googlegroups.com
Subject: Re: [IQUG] start_server command hangs

 

Hello everybody, the server came up eventuallyJ, just took very long time L

 

Thank you

 

 

From: iqug-bounces at iqug.org [mailto:iqug-bounces at iqug.org] On Behalf Of
Julie Nishimura
Sent: Sunday, April 28, 2013 8:52 AM
To: iqug at dssolutions.com; iqug at iqug.org; iqug at googlegroups.com
Subject: [IQUG] start_server command hangs

 

Hello everybody,

Our 12.7 server ran out of main space previously while performing weekly
regular backup. DBA on call killed all db processes and issued start_asiq
command. The recovery took more than 3 hours, this is the end of last srvlog
file:

 

I. 04/28 03:27:08. Starting database "iqpr04" (/opt/iq/db/iqpr04.db) at Sun
Apr 28 2013 03:27

I. 04/28 03:27:09. Database recovery in progress

I. 04/28 03:27:09.     Last checkpoint at Sat Apr 27 2013 13:00

I. 04/28 03:27:09.     Checkpoint log...

I. 04/28 03:27:17.     Transaction log: iqpr04.log...

I. 04/28 06:33:24.     Rollback log...

I. 04/28 06:33:24.     Checkpointing...

I. 04/28 06:33:24. Starting checkpoint of "iqpr04" (iqpr04.db) at Sun Apr 28
2013 06:33

I. 04/28 06:33:29. Finished checkpoint of "iqpr04" (iqpr04.db) at Sun Apr 28
2013 06:33

I. 04/28 06:33:29. Recovery complete

 

 

This is how the end of iqmsg file looks like:

 

I. 04/28 06:33:24. 0000000003 RcvPlaybck

I. 04/28 06:33:24. 0000000000 RcvyCmpl

I. 04/28 06:33:24. 0000000000 Chk

I. 04/28 06:33:27. 0000000000 ChkDone [NumTxnCP: 119856]

I. 04/28 06:33:27. 0000000000 PostChk

I. 04/28 06:33:29. 0000000000 Collation ISO_BINENG, Case Ignore, Blank
Padding On, Comparisons are Conditioned

I. 04/28 06:33:29. 0000000000 CloseDatabase

 

 

No files have been changes since 6:33 am - neither iqmsg, nor log, nor db,
not srvlog and stderr logs.

 

If I grep ps -ef processes, I still see multiple processes

 

 

sybiq    11505 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11506 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11507 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11508 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11509 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11510 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11511 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11512 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11513 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11514 11106  9 03:27 ?        00:29:18 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    11515 11106  0 03:27 ?        00:00:00 asiqsrv12
@/opt/iq/db/params.cfg -n iqpr04 -x tcpip{port=2314} /opt/iq/db/iqpr04.db 

sybiq    16668 22914  0 08:46 pts/2    00:00:00 ps -ef

 

 

Is the process just hanging? Should I stop it and try to restart again?
Thanks

 

iqhq001.shopzilla.laxhq:/opt/iq/db>./start_server

 

 

Starting server iqpr04 on iqhq001 at port 2314 (04/28 03:27:07)

 

Run Directory       : /opt/iq/db

Server Executable   : /opt/iq/ASIQ-12_7/bin/asiqsrv12

Server Output Log   : /opt/iq/ASIQ-12_7/logfiles/iqpr04.187.srvlog

Server Version      : 12.7.0/ESD 5

Open Client Version : 15.0/P-EBF13571 ESD #4

User Parameters     : '@/opt/iq/db/params.cfg' '-n' 'iqpr04' '-x'
'tcpip{port=2314}' '/opt/iq/db/iqpr04.db'

Default Parameters  : -hs -gn 55

 

 

 

=============================================================

IQ server starting with:

     50 connections         (       -gm )

     25 cmd resources       ( -iqgovern )

    341 threads             (     -iqmt )

    512 Kb thread stack size   (   -iqtss  )

  174592 Kb thread memory size ( -iqmt * -iqtss )

      4 IQ number of cpus  ( -iqnumbercpus )

=============================================================

 

I. 04/28 03:27:08.      Adaptive Server IQ

I. 04/28 03:27:08.       Version 12.7

I. 04/28 03:27:08.        (64bit mode)

I. 04/28 03:27:08. Copyright 1992-2008 by Sybase, Inc. All rights reserved

I. 04/28 03:27:08.

I. 04/28 03:27:08. 4 logical processor(s) on 2 physical processor(s)
detected.

I. 04/28 03:27:08. Running on Linux 2.6.9-89.ELsmp #1 SMP Mon Apr 20
10:33:05 EDT 2009 x

I. 04/28 03:27:08. 49152K of memory used for caching

I. 04/28 03:27:08. Minimum cache size: 49152K, maximum cache size: 262012K

I. 04/28 03:27:08. Using a maximum page size of 4096 bytes

I. 04/28 03:27:08. Starting database "iqpr04" (/opt/iq/db/iqpr04.db) at Sun
Apr 28 2013 03:27

I. 04/28 03:27:09. Database recovery in progress

I. 04/28 03:27:09.     Last checkpoint at Sat Apr 27 2013 13:00

I. 04/28 03:27:09.     Checkpoint log...

I. 04/28 03:27:17.     Transaction log: iqpr04.log...

I. 04/28 06:33:24.     Rollback log...

I. 04/28 06:33:24.     Checkpointing...

I. 04/28 06:33:24. Starting checkpoint of "iqpr04" (iqpr04.db) at Sun Apr 28
2013 06:33

I. 04/28 06:33:29. Finished checkpoint of "iqpr04" (iqpr04.db) at Sun Apr 28
2013 06:33

I. 04/28 06:33:29. Recovery complete

 


 

 

 

 

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://iqug.org/pipermail/iqug/attachments/20130501/bf1a3870/attachment-0003.html>


More information about the IQUG mailing list