Status: Unconfirmed
Owner: ----
Labels: Type-Bug Pri-2 OS-All Area-Misc
New issue 23169 by dan.burd: Normal bookmark sync activities force
continued use of debug.log
http://code.google.com/p/chromium/issues/detail?id=23169
Chrome Version : <Copy from: 'about:version'>
URLs (if applicable) :
Other browsers tested:
Add OK or FAIL after other browsers where you have tested this issue:
Safari 4:
Firefox 3.x:
IE 7:
IE 8:
What steps will reproduce the problem?
1. Open bookmark sync box and log in, enabling bookmark sync
2. Open Chromium program folder
3.
What is the expected result?
Debug.log shouldn't be created or used unless something is wrong.
What happens instead?
Debug.log is always in use by chromium, and contains the mundane activities
of what seems to be an entirely functional syncing system. Grows by several
lines every time syncing is required.
Please provide any additional information below. Attach a screenshot if
possible.
Here is the log:
[0926/120536:INFO:syncapi.cc(94)] starting the address watch thread
[0926/120536:INFO:syncer_thread.cc(307)] In thread main loop.
[0926/120536:INFO:syncer_thread.cc(243)] SyncerThread started.
[0926/120536:INFO:syncer_thread.cc(322)] Syncer thread waiting for
connection.
[0926/120536:INFO:directory_backing_store.cc(399)] DB created at 1253843399
by version Unknown
[0926/120536:INFO:syncer_thread.cc(518)] Handling a directory manager event
[0926/120536:INFO:syncer_thread.cc(521)] Syncer starting up for:
**[email protected]
[0926/120536:INFO:syncer_thread.cc(325)] Syncer thread found connection.
[0926/120536:INFO:auth_watcher.cc(144)] Auth returned email **[email protected]
for gaia email **[email protected]
[0926/120536:INFO:syncer_thread.cc(343)] end_wait is 60000000
[0926/120536:INFO:auth_watcher.cc(367)]
LoadDirectoryListAndOpen(**[email protected])
[0926/120536:INFO:syncer_thread.cc(344)] next_poll is 60000000
[0926/120536:INFO:auth_watcher.cc(375)] LoadDirectoryListAndOpen returning
1
[0926/120536:INFO:syncer_thread.cc(370)] Calling Sync Main at time
12898454736593750
[0926/120536:INFO:auth_watcher.cc(290)] NotifyAuthSucceeded
[0926/120536:INFO:syncer.cc(123)] Syncer Begin
[0926/120536:INFO:syncer.cc(127)] Downloading Updates
[0926/120536:INFO:download_updates_command.cc(41)] Getting updates from ts
2513
[0926/120536:INFO:mediator_thread_impl.cc(123)] P2P: Thread logging into
talk network.
[0926/120536:INFO:xmpp_connection_generator.cc(73)]
XmppConnectionGenerator::StartGenerating
[0926/120536:INFO:async_network_alive_win32.cc(162)] calling WSAStartup
[0926/120536:INFO:xmpp_connection_generator.cc(105)]
XmppConnectionGenerator::OnProxyDetect
[0926/120536:INFO:async_dns_lookup.cc(52)] (talk.google.com)
[0926/120536:INFO:async_dns_lookup.cc(71)] (talk.google.com) resolved to:
64.233.169.125
[0926/120536:INFO:xmpp_connection_generator.cc(147)]
XmppConnectionGenerator::OnServerDNSResolved
[0926/120536:INFO:xmpp_connection_generator.cc(150)] server:
talk.google.com:5222 error: 0
[0926/120536:INFO:xmpp_connection_generator.cc(162)] ip 0 :
64.233.169.125
[0926/120536:INFO:xmpp_connection_generator.cc(190)]
XmppConnectionGenerator::UseCurrentConnection
[0926/120536:INFO:xmpp_connection_generator.cc(193)] *** Attempting tcp
connection to talk.google.com:5222 (via none proxy @ 0.0.0.0:0)
[0926/120536:INFO:async_network_alive_win32.cc(105)] alive: 1
[0926/120536:INFO:gaiaauth.cc(76)] GaiaAuth Begin
[0926/120536:INFO:gaiaauth.cc(79)] Reusing auth
token:DQAAAIoAAABnsn66iqQoeSUYXpbFuhJ-
6hiIK4obgxbpyoRDG6cdZnDEzt_SP7kNplGPjC-A126Iix-
id38UUwaExPlSBp5eBq3WtZQznSAz8Gfk42GbjQD5aXhaISicvrnr0HVm1cwV7Z25sEybf1VKNJ
jrCn7J9juk894oPKoJQEp9EqjdsbWrcnwDP_-xWEiKXtU7Jxo
[0926/120536:INFO:async_network_alive_win32.cc(131)] calling WSANSPIoctl
[0926/120536:INFO:xmpp_socket_adapter.cc(78)]
XmppSocketAdapter::Connect(talk.google.com:5222)
[0926/120536:INFO:async_network_alive_win32.cc(152)] waiting
[0926/120536:INFO:xmpp_socket_adapter.cc(277)]
XmppSocketAdapter::OnConnectEvent - STATE_OPEN
[0926/120536:INFO:syncer_proto_util.cc(89)] Server response trace: user
lookup: 0ms meta write: 0ms meta read: 22ms file write: 0ms file read: 0ms
total time: 38ms
[0926/120536:INFO:syncer.cc(134)] Processing Client Command
[0926/120536:INFO:syncer.cc(140)] Verifying Updates
[0926/120536:INFO:verify_updates_command.cc(31)] Beginning Update
Verification
[0926/120536:INFO:verify_updates_command.cc(41)] 0 entries to verify
[0926/120536:INFO:syncer.cc(147)] Processing Updates
[0926/120536:INFO:process_updates_command.cc(37)] Get updates from ts 2513
returned 0 updates.
[0926/120536:INFO:syncer.cc(160)] Applying Updates
[0926/120536:INFO:update_applicator.cc(24)] UpdateApplicator created for 0
items.
[0926/120536:INFO:syncer.cc(172)] Processing Commit Request
[0926/120536:INFO:syncer.cc(181)] Getting the Commit IDs
[0926/120536:INFO:syncer.cc(212)] Building and Processing Conflict Sets
[0926/120536:INFO:syncer.cc(222)] Resolving Conflicts
[0926/120536:INFO:syncer.cc(259)] Syncer End
[0926/120536:INFO:syncapi.cc(1425)] Didn't send XMPP notification!
event.last_session: 0311F8F4 event.last_session->items_committed(): 0
talk_mediator(): 01A9A660
[0926/120536:INFO:syncer_thread.cc(453)] Done looping in sync share
[0926/120536:INFO:syncer_thread.cc(374)] Updating the next polling time
after SyncMain
[0926/120536:INFO:syncer_thread.cc(397)] syncer_has_work_to_do is 0
[0926/120536:INFO:syncer_thread.cc(432)] Sync wait: idle 60 non-idle or
backoff 60.
[0926/120536:INFO:syncer_thread.cc(343)] end_wait is 6457499000
[0926/120536:INFO:syncer_thread.cc(344)] next_poll is 6457499000
[0926/120536:INFO:xmpp_socket_adapter.cc(282)]
XmppSocketAdapter::OnConnectEvent - STATE_TLS_OPEN
[0926/120536:INFO:talk_mediator_impl.cc(198)] P2P: MediatorThread has
passed a message
[0926/120536:INFO:talk_mediator_impl.cc(225)] P2P: Logged in.
[0926/120536:INFO:syncer_thread.cc(614)] P2P: Login succeeded.
[0926/120536:INFO:listen_task.cc(26)] P2P: Listener task started.
[0926/120536:INFO:listen_task.cc(31)] P2P: Listener response received.
[0926/120536:INFO:subscribe_task.cc(34)] P2P: Subscription task started.
[0926/120536:INFO:subscribe_task.cc(45)] P2P: Subscription response
received.
[0926/120536:INFO:subscribe_task.cc(45)] P2P: Subscription response
received.
[0926/120536:INFO:talk_mediator_impl.cc(198)] P2P: MediatorThread has
passed a message
[0926/120536:INFO:talk_mediator_impl.cc(245)] P2P: Update subscription
active.
[0926/120536:INFO:syncer_thread.cc(622)] P2P: Subscriptions successfully
enabled.
[0926/120536:INFO:syncer_thread.cc(625)] Subscriptions on. Nudging syncer
for initial push.
[0926/120536:INFO:syncer_thread.cc(343)] end_wait is 6397751000
[0926/120536:INFO:syncer_thread.cc(344)] next_poll is 6457499000
[0926/120536:INFO:syncer_thread.cc(370)] Calling Sync Main at time
12898454736956750
[0926/120536:INFO:syncer.cc(123)] Syncer Begin
[0926/120536:INFO:syncer.cc(127)] Downloading Updates
[0926/120536:INFO:download_updates_command.cc(41)] Getting updates from ts
2513
[0926/120537:INFO:syncer_proto_util.cc(89)] Server response trace: user
lookup: 0ms meta write: 0ms meta read: 22ms file write: 0ms file read: 0ms
total time: 37ms
[0926/120537:INFO:syncer.cc(134)] Processing Client Command
[0926/120537:INFO:syncer.cc(140)] Verifying Updates
[0926/120537:INFO:verify_updates_command.cc(31)] Beginning Update
Verification
[0926/120537:INFO:verify_updates_command.cc(41)] 0 entries to verify
[0926/120537:INFO:syncer.cc(147)] Processing Updates
[0926/120537:INFO:process_updates_command.cc(37)] Get updates from ts 2513
returned 0 updates.
[0926/120537:INFO:syncer.cc(160)] Applying Updates
[0926/120537:INFO:update_applicator.cc(24)] UpdateApplicator created for 0
items.
[0926/120537:INFO:syncer.cc(172)] Processing Commit Request
[0926/120537:INFO:syncer.cc(181)] Getting the Commit IDs
[0926/120537:INFO:syncer.cc(212)] Building and Processing Conflict Sets
[0926/120537:INFO:syncer.cc(222)] Resolving Conflicts
[0926/120537:INFO:syncer.cc(259)] Syncer End
[0926/120537:INFO:syncapi.cc(1425)] Didn't send XMPP notification!
event.last_session: 0311F8F4 event.last_session->items_committed(): 0
talk_mediator(): 01A9A660
[0926/120537:INFO:syncer_thread.cc(453)] Done looping in sync share
[0926/120537:INFO:syncer_thread.cc(374)] Updating the next polling time
after SyncMain
[0926/120537:INFO:syncer_thread.cc(397)] syncer_has_work_to_do is 0
[0926/120537:INFO:syncer_thread.cc(432)] Sync wait: idle 3600 non-idle or
backoff 3600.
[0926/120537:INFO:syncer_thread.cc(343)] end_wait is 9997862000
[0926/120537:INFO:syncer_thread.cc(344)] next_poll is 9997862000
--
You received this message because you are listed in the owner
or CC fields of this issue, or because you starred this issue.
You may adjust your issue notification preferences at:
http://code.google.com/hosting/settings
--~--~---------~--~----~------------~-------~--~----~
Automated mail from issue updates at http://crbug.com/
Subscription options: http://groups.google.com/group/chromium-bugs
-~----------~----~----~----~------~----~------~--~---
