|
Home > Archive > SQL Anywhere Mobile > August 2005 > Synchronization hangs
You are viewing an archived Text-only version of the thread.
To view this thread in it's original format and/or if you want to reply to
this thread please [click here]
| Author |
Synchronization hangs
|
|
| Chris Werner 2005-08-25, 9:24 am |
| Hi,
occasionally a synchronization between an ASA 9.0.2 3044 consolidatet and a
remote of the same version hangs. This is a initial synchronization, so I
expect no uploads which is confirmed by the logs. Both database engines run
on the same workstation. In fact there are two syncs which are started after
each other, first with version name "Benutzer", second with version name
"Auftrag". The second sync causes the problem. Looking at the windows task
manager seems to show, that the db engine of the remote database works
heavy, CPU load is 50%. The outputwindow from dbmlsync shows on its bottom
line: "Buffering download stream 5407067 bytes". The number is almost the
same but not in every case (remember yesterday it was something like
3203042). This synchronization runs without problems for several weeks but
is seldom used because its usage is for remote database initialization only.
I've no idea where to search for the problem. I append snippets from the
logs.
TIA for every help.
Chris Werner
Consolidated log:
============
I. 08/25 13:43:31. Adaptive Server Anywhere MobiLink Version 9.0.2.3044
I. 08/25 13:43:31.
I. 08/25 13:43:31. Copyright © 1989-2004 Sybase, Inc.
Portions Copyright © 2002-2004, iAnywhere Solutions, Inc.
I. 08/25 13:43:31. All rights reserved. All unpublished rights reserved.
I. 08/25 13:43:31.
I. 08/25 13:43:31. This software contains confidential and trade secret
information of
I. 08/25 13:43:31. iAnywhere Solutions, Inc.
Use, duplication or disclosure of the software and
documentation
I. 08/25 13:43:31. by the U.S. Government is subject to restrictions set
forth in a license
I. 08/25 13:43:31. agreement between the Government and iAnywhere Solutions,
Inc. or
I. 08/25 13:43:31. other written agreement specifying the Government's
rights to use the
I. 08/25 13:43:31. software and any applicable FAR provisions, for example,
FAR 52.227-19.
I. 08/25 13:43:31.
I. 08/25 13:43:31. iAnywhere Solutions, Inc., One Sybase Drive, Dublin, CA
94568, USA
I. 08/25 13:43:31.
I. 08/25 13:43:31. Networked Seat (per-seat) model. Access to the server is
limited to 1 seat(s).
This server is licensed to:
I. 08/25 13:43:31. Chris Werner
I. 08/25 13:43:31. f+s software gmbh
I. 08/25 13:43:31. <Main>: MobiLink server started
I. 08/25 13:43:31. <Main>: Option 1: -c
I. 08/25 13:43:31. <Main>: Option 2: DSN=mfm_zntr_cw;uid=
DBA;pwd=********
I. 08/25 13:43:31. <Main>: Option 3: -fr
I. 08/25 13:43:31. <Main>: Option 4: -vnsu
I. 08/25 13:43:31. <Main>: Option 5: -zu+
I. 08/25 13:43:31. <Main>: Verbose logging: show script names when invoked
I. 08/25 13:43:31. <Main>: Verbose logging: show rowcount values
I. 08/25 13:43:31. <Main>: Individual database connections will be closed
after synchronization errors.
I. 08/25 13:43:31. <Main>: BLOB cache size: 524288
I. 08/25 13:43:31. <Main>: Maximum number of BLOB bytes to compare:
4294967295
I. 08/25 13:43:31. <Main>: Maximum number of database connections: 6
I. 08/25 13:43:31. <Main>: Maximum number of deadlock retries: 10
I. 08/25 13:43:31. <Main>: Timeout for inactive database connections: 60
minutes
I. 08/25 13:43:31. <Main>: Maximum delay between retries after deadlock: 30
seconds
I. 08/25 13:43:31. <Main>: Rowset size: 10
I. 08/25 13:43:31. <Main>: Upload cache size: 524288 bytes
I. 08/25 13:43:31. <Main>: Download cache memory size: 1048576 bytes
I. 08/25 13:43:31. <Main>: Download cache directory size: 10485760 bytes
I. 08/25 13:43:31. <Main>: Number of worker threads: 5
I. 08/25 13:43:31. <Main>: Maximum number of threads uploading concurrently:
5
W. 08/25 13:43:31. <Main>: Warning: Unknown users will be added
automatically (when there is no authenticate_user script).
I. 08/25 13:43:31. <Main>: Example scripts will not be automatically
generated for unknown versions.
I. 08/25 13:43:31. <Main>: Local file for remote synchronization logs:
'dbmlsrv.mle'
I. 08/25 13:43:31. <Main>: Stream specifier 1: TCPIP
I. 08/25 13:43:31. <Main>: ODBC DBMS Name: Adaptive Server Anywhere
I. 08/25 13:43:31. <Main>: ODBC DBMS Version: 09.00.0002
I. 08/25 13:43:31. <Main>: ODBC DBMS Driver Version: 09.00.0002
I. 08/25 13:43:31. <Main>: ODBC Version supported by the driver: 3.52
I. 08/25 13:43:31. <Main>: Collation sequence of the consolidated database
is 'cp1252'
I. 08/25 13:43:31. <Main>: ODBC isolation set to: Read Committed
I. 08/25 13:43:31. <Main>: Connected
I. 08/25 13:43:31. <thread 1.1>: Ready to handle requests
I. 08/25 13:43:31. <thread 1.2>: Ready to handle requests
I. 08/25 13:43:31. <thread 1.3>: Ready to handle requests
I. 08/25 13:43:31. <thread 1.4>: Ready to handle requests
I. 08/25 13:43:31. <thread 1.5>: Ready to handle requests
I. 08/25 13:44:04. <thread 1.5>: Working on a request
I. 08/25 13:44:04. <thread 1.5>: ASA synchronization request from: e800_01
(version: Benutzer)
I. 08/25 13:44:04. <1.5> [e800_01]: ODBC isolation set to: Read Committed
I. 08/25 13:44:04. <1.5> [e800_01]: COMMIT Transaction: begin_connection
I. 08/25 13:44:04. <1.5> [e800_01]: User name 'e800_01' not found in the
ml_user table, inserting a new entry
I. 08/25 13:44:04. <1.5> [e800_01]: begin_synchronizatio
n mfm_bedn_mobl (no
script)
I. 08/25 13:44:04. <1.5> [e800_01]: COMMIT Transaction:
begin_synchronizatio
n
I. 08/25 13:44:04. <1.5> [e800_01]: begin_upload mfm_bedn_mobl (no script)
I. 08/25 13:44:04. <1.5> [e800_01]: begin_upload_rows mfm_bedn_mobl (no
script)
I. 08/25 13:44:04. <1.5> [e800_01]: end_upload_rows mfm_bedn_mobl (no
script)
I. 08/25 13:44:04. <1.5> [e800_01]: end_upload mfm_bedn_mobl (no script)
I. 08/25 13:44:04. <1.5> [e800_01]: # rows uploaded into table mfm_bedn_mobl
: 0
I. 08/25 13:44:04. <1.5> [e800_01]: # rows inserted into table mfm_bedn_mobl
: 0
I. 08/25 13:44:04. <1.5> [e800_01]: # rows deleted in table mfm_bedn_mobl :
0
I. 08/25 13:44:04. <1.5> [e800_01]: # rows updated into table mfm_bedn_mobl
: 0
I. 08/25 13:44:04. <1.5> [e800_01]: # rows conflicted in table mfm_bedn_mobl
: 0
I. 08/25 13:44:04. <1.5> [e800_01]: # rows ignored in table mfm_bedn_mobl :
0
I. 08/25 13:44:04. <1.5> [e800_01]: COMMIT Transaction: end_upload
I. 08/25 13:44:04. <1.5> [e800_01]: begin_download mfm_bedn_mobl (no script)
I. 08/25 13:44:04. <1.5> [e800_01]: Sending the download to the remote
database.
I. 08/25 13:44:04. <1.5> [e800_01]: begin_download_delet
es mfm_bedn_mobl (no
script)
I. 08/25 13:44:04. <1.5> [e800_01]: end_download_deletes
mfm_bedn_mobl (no
script)
I. 08/25 13:44:04. <1.5> [e800_01]: begin_download_rows mfm_bedn_mobl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: end_download_rows mfm_bedn_mobl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: end_download mfm_bedn_mobl (no script)
I. 08/25 13:44:05. <1.5> [e800_01]: # rows downloaded for delete from table
mfm_bedn_mobl : 0
I. 08/25 13:44:05. <1.5> [e800_01]: # rows downloaded for insert/update from
table mfm_bedn_mobl : 3
I. 08/25 13:44:05. <1.5> [e800_01]: # rows filtered for download from table
mfm_bedn_mobl : 0
I. 08/25 13:44:05. <1.5> [e800_01]: # rows downloaded to remote from table
mfm_bedn_mobl : 3
I. 08/25 13:44:05. <1.5> [e800_01]: COMMIT Transaction: end_download
I. 08/25 13:44:05. <1.5> [e800_01]: end_synchronization mfm_bedn_mobl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: COMMIT Transaction: end_synchronization
I. 08/25 13:44:05. <1.5> [e800_01]: Synchronization complete
I. 08/25 13:44:05. <thread 1.5>: Working on a request
I. 08/25 13:44:05. <thread 1.5>: ASA synchronization request from: e800_01
(version: Auftrag)
I. 08/25 13:44:05. <1.5> [e800_01]: ODBC isolation set to: Read Committed
I. 08/25 13:44:05. <1.5> [e800_01]: COMMIT Transaction: begin_connection
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n
mfm_mobl_vorggpslog (no script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n fs_mobl_gpslog (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_mobl_adrs (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_fmstmngl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_fmstentf (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n MCL_DATA_MOBL (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n MCL_BLOB (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mcl_datatype (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mcl_dataklss_mobl
(no script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_text_mobl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_kmpx_mobl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mcl_dw (no script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_invtaufn_mobl
(no script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_prjt_mobl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_objt_mobl (no
script)
I. 08/25 13:44:05. <1.5> [e800_01]: begin_synchronizatio
n mfm_mobl_fmstmmal
(no script)
=== ... and so on.... ====
I. 08/25 13:44:06. <1.5> [e800_01]: # rows updated into table mfm_bmrk_mobl
: 0
I. 08/25 13:44:06. <1.5> [e800_01]: # rows conflicted in table mfm_bmrk_mobl
: 0
I. 08/25 13:44:06. <1.5> [e800_01]: # rows ignored in table mfm_bmrk_mobl :
0
I. 08/25 13:44:06. <1.5> [e800_01]: COMMIT Transaction: end_upload
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download mfm_mobl_vorggpslog (no
script)
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download fs_mobl_gpslog (no
script)
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download mfm_mobl_adrs (no script)
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download mfm_fmstmngl (no script)
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download mfm_fmstentf (no script)
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download MCL_DATA_MOBL (no script)
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download MCL_BLOB (no script)
I. 08/25 13:44:06. <1.5> [e800_01]: begin_download mcl_datatype (no script)
=== ... and so on.... ====
I. 08/25 13:44:11. <1.5> [e800_01]: end_download_rows mfm_objt_mobl (no
script)
I. 08/25 13:44:11. <1.5> [e800_01]: begin_download_delet
es mfm_mobl_fmstmmal
(no script)
I. 08/25 13:44:11. <1.5> [e800_01]: end_download_deletes
mfm_mobl_fmstmmal
(no script)
I. 08/25 13:44:11. <1.5> [e800_01]: begin_download_rows mfm_mobl_fmstmmal
(no script)
I. 08/25 13:44:11. <1.5> [e800_01]: end_download_rows mfm_mobl_fmstmmal (no
script)
I. 08/25 13:44:11. <1.5> [e800_01]: begin_download_delet
es mfm_objthier_mobl
(no script)
I. 08/25 13:44:11. <1.5> [e800_01]: end_download_deletes
mfm_objthier_mobl
(no script)
I. 08/25 13:44:11. <1.5> [e800_01]: begin_download_rows mfm_objthier_mobl
(no script)
=== ... here it stops. ====
Remote log:
============
I. 08/25 13:44:05. Synchronization Started
I. 08/25 13:44:05. 1: -n
I. 08/25 13:44:05. 2: pub_mfm_auft
I. 08/25 13:44:05. 3: -c
I. 08/25 13:44:05. 4: dsn=mfm_mgrt;uid=DBA
;pwd=SQL
I. 08/25 13:44:05. 5: -e
I. 08/25 13:44:05. 6: sv=Auftrag;sa=on
I. 08/25 13:44:05. 7: -vcno
I. 08/25 13:44:05. Adaptive Server Anywhere MobiLink Synchronization Version
9.0.2.3044
I. 08/25 13:44:05.
I. 08/25 13:44:05. Copyright © 1989-2004 Sybase, Inc.
Portions Copyright © 2002-2004, iAnywhere Solutions, Inc.
I. 08/25 13:44:05. All rights reserved. All unpublished rights reserved.
I. 08/25 13:44:05.
I. 08/25 13:44:05. This software contains confidential and trade secret
information of
I. 08/25 13:44:05. iAnywhere Solutions, Inc.
Use, duplication or disclosure of the software and
documentation
I. 08/25 13:44:05. by the U.S. Government is subject to restrictions set
forth in a license
I. 08/25 13:44:05. agreement between the Government and iAnywhere Solutions,
Inc. or
I. 08/25 13:44:05. other written agreement specifying the Government's
rights to use the
I. 08/25 13:44:05. software and any applicable FAR provisions, for example,
FAR 52.227-19.
I. 08/25 13:44:05.
I. 08/25 13:44:05. iAnywhere Solutions, Inc., One Sybase Drive, Dublin, CA
94568, USA
I. 08/25 13:44:05.
I. 08/25 13:44:05. Connecting to remote database
I. 08/25 13:44:05. Loading synchronization information
I. 08/25 13:44:05. Begin synchronizing 'pub_mfm_auft' for MobiLink user
'e800_01'
I. 08/25 13:44:05. Options for this synchronization:
I. 08/25 13:44:05.
SV='Auftrag',SA='YES
',CTP='TCPIP',ADR='h
ost=localhost'
I. 08/25 13:44:05. Log scan starting at offset 0000392492
I. 08/25 13:44:05. Processing transaction logs from directory
" C:\Entwicklung\PB9\m
FM\DB\mgrt\"
I. 08/25 13:44:05. Processing transactions from active transaction log
I. 08/25 13:44:05. Hovering at end of active log
I. 08/25 13:44:05. Connecting to MobiLink server at 'host=localhost' using
'dbmlsock9.dll'
I. 08/25 13:44:05. Uploading header
I. 08/25 13:44:05. Begin upload
I. 08/25 13:44:05. Uploading table operations
I. 08/25 13:44:05. # rows inserted in table mfm_mobl_vorggpslog : 0
I. 08/25 13:44:05. # rows deleted in table mfm_mobl_vorggpslog : 0
I. 08/25 13:44:05. # rows updated in table mfm_mobl_vorggpslog : 0
I. 08/25 13:44:05. # rows inserted in table fs_mobl_gpslog : 0
=== ... and so on.... ====
I. 08/25 13:44:05. # rows deleted in table mfm_bmrk_mobl : 0
I. 08/25 13:44:05. # rows updated in table mfm_bmrk_mobl : 0
I. 08/25 13:44:05. Log scan ended at offset 0000393362
I. 08/25 13:44:05. Waiting for MobiLink to apply upload
I. 08/25 13:44:06. The user authentication value is 1000.
I. 08/25 13:44:06. COMMIT
=== ... here it stops. ====
| |
| Graham Hurst 2005-08-25, 9:24 am |
| How long did you wait for it to complete? It may take quite a while to
transfer and apply a 5MB download. Since the remote's CPU usage is high
(is it a dual processor machine?) it would seem that the remote is
taking a long time to apply the download.
I'd try to figure out what is keeping the remote db so busy, and also
check if there is still network activity. Using -v+ for dbmlsync and
dbmlsrv9 might help too (the log output doesn't get as far as what you
saw in the dbmlsync window).
BTW, it would have been better to start a new topic rather than
replying to a 3 year old one.
Cheers,
Graham
Chris Werner wrote:
> Hi,
>
> occasionally a synchronization between an ASA 9.0.2 3044 consolidatet and a
> remote of the same version hangs. This is a initial synchronization, so I
> expect no uploads which is confirmed by the logs. Both database engines run
> on the same workstation. In fact there are two syncs which are started after
> each other, first with version name "Benutzer", second with version name
> "Auftrag". The second sync causes the problem. Looking at the windows task
> manager seems to show, that the db engine of the remote database works
> heavy, CPU load is 50%. The outputwindow from dbmlsync shows on its bottom
> line: "Buffering download stream 5407067 bytes". The number is almost the
> same but not in every case (remember yesterday it was something like
> 3203042). This synchronization runs without problems for several weeks but
> is seldom used because its usage is for remote database initialization only.
> I've no idea where to search for the problem. I append snippets from the
> logs.
>
> TIA for every help.
>
> Chris Werner
| |
| Chris Werner 2005-08-25, 9:24 am |
| Hi Graham,
thanks for the fast reply. I've waited for a long time (not for an answer
but for the termination of the sync <g> ). The workstation is a single
processor one but rather powerfull and were not stressed by other processes
at sync time. Any hints how to "figure out what is keeping the remote db so
busy"?
BTW, I've started a new thread. Maybe the topic accidental equals a 3 year
old one and your reader identifies threads only by topic name? My browser
shows my message as a thread root.
Thanks again
and - of course - cheers,
Chris Werner
"Graham Hurst" < spam_guard_hurst@ian
ywhere.com> schrieb im Newsbeitrag
news:430dcc5d$1@foru
ms-1-dub...[color=darkred]
> How long did you wait for it to complete? It may take quite a while to
> transfer and apply a 5MB download. Since the remote's CPU usage is high
> (is it a dual processor machine?) it would seem that the remote is taking
> a long time to apply the download.
>
> I'd try to figure out what is keeping the remote db so busy, and also
> check if there is still network activity. Using -v+ for dbmlsync and
> dbmlsrv9 might help too (the log output doesn't get as far as what you saw
> in the dbmlsync window).
>
> BTW, it would have been better to start a new topic rather than replying
> to a 3 year old one.
>
> Cheers,
>
> Graham
>
> Chris Werner wrote:
| |
| Graham Hurst 2005-08-26, 3:24 am |
| > Any hints how to "figure out what is keeping the remote db so
> busy"?
I was afraid you'd ask that! ;-) Have a look at:
ASA SQL User's Guide
Monitoring and Improving Performance
Monitoring database performance
Also, I forgot to mention it last time but you might find the MobiLink
Monitor helpful if you are not already using it.
> BTW, I've started a new thread. Maybe the topic accidental equals a 3 year
> old one and your reader identifies threads only by topic name? My browser
> shows my message as a thread root.
I don't think my newsreader does that (though I know some, like Agent,
do do that). When I look at the source for your post it indicates that
it was posted as a reply, since it has:
>Xref: forums-1-dub sybase.public.sqlanywhere.mobilink:14760
Cheers,
Graham
| |
| Chris Werner 2005-08-26, 7:24 am |
| Thanks Graham.
> I was afraid you'd ask that! ;-) Have a look at:
It's depressing to be so predictable. ;-)
Will try to follow your tips ...
Regards
Chris Werner
"Graham Hurst" < spam_guard_hurst@ian
ywhere.com> schrieb im Newsbeitrag
news:430e77e1$1@foru
ms-1-dub...
>
> I was afraid you'd ask that! ;-) Have a look at:
>
> ASA SQL User's Guide
> Monitoring and Improving Performance
> Monitoring database performance
>
> Also, I forgot to mention it last time but you might find the MobiLink
> Monitor helpful if you are not already using it.
>
>
> I don't think my newsreader does that (though I know some, like Agent, do
> do that). When I look at the source for your post it indicates that it was
> posted as a reply, since it has:
>
>
> Cheers,
>
> Graham
|
|
|
|
|