Timeout [#14333]

Post a reply

Smilies
:D :) :( :o :-? 8) :lol: :x :P :oops: :cry: :evil: :roll: :wink:

BBCode is ON
[img] is ON
[url] is ON
Smilies are ON

Topic review
   

Expand view Topic review: Timeout [#14333]

Re: Timeout [#14333]

by Peke » Fri Aug 11, 2017 6:37 pm

You should try it with newest MMW beta.

Re: Timeout [#14333]

by DocMAX » Fri Aug 11, 2017 1:58 pm

With the latest Android update from Playstore it seems to work better...
It's probably about this: http://www.ventismedia.com/mantis/view.php?id=14336

Re: Timeout

by DocMAX » Thu Aug 03, 2017 4:02 pm

Thanks :-) great support!

Re: Timeout

by Ludek » Thu Aug 03, 2017 2:48 pm

Thanks for the MMW log!

I see the reason for the timeout now, to be fixed as http://www.ventismedia.com/mantis/view.php?id=14333

Re: Timeout

by DocMAX » Thu Aug 03, 2017 5:03 am

There you go thanks.
Ticket #LEN-367-76635

This is what i get on Android. A timeout! Where can i increase the timeout time??

My playlist hast a limit of 1000 titles. When i set it to 500 the sync works.

Code: Select all

08-03 10:23:30.777: I/org.fourthline.cling.transport.spi.StreamClient(578): Timeout of 19 seconds while waiting for HTTP request to complete, aborting: (OutgoingActionRequestMessage) POST http://192.168.1.2:60259/ContentDirectory/1031d41a-2978-4070-98c5-bc66ace53282/control.xml
08-03 10:23:30.791: E/java.lang.Class(578): Upnp query failed: Error: Current state of service prevents invoking that action. Connection error or no response received.[a():186]
08-03 10:23:30.793: E/java.lang.Class(578): org.fourthline.cling.model.action.ActionException: Current state of service prevents invoking that action. Connection error or no response received.
08-03 10:23:30.793: E/org.fourthline.cling.protocol.sync.SendingAction(578): 	at [invokeRemote:77]
08-03 10:23:30.793: E/org.fourthline.cling.protocol.sync.SendingAction(578): 	at [executeSync:63]
08-03 10:23:30.793: E/org.fourthline.cling.protocol.sync.SendingAction(578): 	at [executeSync:51]
08-03 10:23:30.793: E/org.fourthline.cling.protocol.SendingSync(578): 	at [execute:54]
08-03 10:23:30.793: E/org.fourthline.cling.protocol.SendingAsync(578): 	at [run:54]
08-03 10:23:30.793: E/org.fourthline.cling.controlpoint.ActionCallback(578): 	at [run:151]
08-03 10:23:30.793: E/com.ventismedia.android.mediamonkey.upnp.bx(578): 	at [run:129]
08-03 10:23:30.793: E/java.util.concurrent.Executors$RunnableAdapter(578): 	at [call:428]
08-03 10:23:30.793: E/java.util.concurrent.FutureTask(578): 	at [run:237]
08-03 10:23:30.793: E/java.util.concurrent.ThreadPoolExecutor(578): 	at [runWorker:1133]
08-03 10:23:30.793: E/java.util.concurrent.ThreadPoolExecutor$Worker(578): 	at [run:607]

Re: Timeout

by Ludek » Mon Jul 31, 2017 2:14 pm

DocMAX wrote:Hello,

when running MM on slow low power computer the sync timeouts.
Can i adjust the timeout value somewhere?

Thx,
DocMAX
Could you please download debug build of MMW and generate debug log?
It is item 4b here: http://www.mediamonkey.com/forum/viewto ... ?f=6&t=341

Thanks!

Re: Timeout

by rusty » Fri Jul 28, 2017 1:58 pm

I've merged the two topics.

Re: Timeout

by DocMAX » Fri Jul 28, 2017 4:23 am

Re: Timeout

by Peke » Thu Jul 27, 2017 12:45 pm

Can you be bit more specific where you see timeout MSGs?

Also Some hardware specs would be more than welcome.

"Preparing confirmation dialog.." and then "Sync incomplete"

by DocMAX » Wed Jul 26, 2017 2:56 pm

The first sync is ok (fresh install of MM), the second sync fails with "Sync incomplete".
I've attached the log... can you help please?

Code: Select all

07-26 19:54:27.453: D/com.ventismedia.android.mediamonkey.upnp.a.e$b(1331): Remote device updated: Ventis Media, Inc. MediaMonkey Media Server 4.0 (URL:http://192.168.1.2:60259/DeviceDescription.xml, model name:MediaMonkey Media Server)[remoteDeviceUpdated():49]
07-26 19:54:27.769: D/com.ventismedia.android.mediamonkey.upnp.a.a(1): Progress stop[handleMessage():43]
07-26 19:54:27.774: W/com.ventismedia.android.mediamonkey.cast.upnp.w(1): sheduleNextScanIfNeeded[b():81]
07-26 19:54:27.778: W/com.ventismedia.android.mediamonkey.cast.upnp.w(1): sheduleNextScan delay: 60000[b():1075]
07-26 19:54:27.784: W/com.ventismedia.android.mediamonkey.upnp.UpnpBrowseService(1): service is use[a():168]
07-26 19:54:27.868: D/com.ventismedia.android.mediamonkey.upnp.a.e$b(1332): Remote device updated: Ventis Media, Inc. MediaMonkey Media Server 4.0 (URL:http://192.168.1.2:60259/DeviceDescription.xml, model name:MediaMonkey Media Server)[remoteDeviceUpdated():49]
07-26 19:54:30.114: W/org.fourthline.cling.transport.spi.StreamClient(1324): HTTP request took a long time (11455ms): (OutgoingActionRequestMessage) POST http://192.168.1.2:60259/ContentDirectory/1031d41a-2978-4070-98c5-bc66ace53282/control.xml
07-26 19:54:30.124: I/com.ventismedia.android.mediamonkey.upnp.bq(1324): Response: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:sec="http://www.sec.co.kr/dlna/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/"></DIDL-Lite>[a():467]
07-26 19:54:30.127: D/com.ventismedia.android.mediamonkey.upnp.bq(1324): Response processing...[a():357]
07-26 19:54:30.127: D/com.ventismedia.android.mediamonkey.upnp.bq(1324): State is processing. Continue..[a():366]
07-26 19:54:30.127: D/com.ventismedia.android.mediamonkey.upnp.bq(1324): Processing 0 items[a():398]
07-26 19:54:30.127: D/com.ventismedia.android.mediamonkey.upnp.bq(1324): No DIDL[a():345]
07-26 19:54:30.127: I/com.ventismedia.android.mediamonkey.upnp.bq(1334): Finished completely: 0 items, 0 containers[a():233]
07-26 19:54:30.130: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): Sync: Server -> Device: GetDeleteTracks: No tracks[b():2864]
07-26 19:54:30.133: D/com.ventismedia.android.mediamonkey.sync.wifi.utils.l(1334): Delete media[a():58]
07-26 19:54:30.133: D/com.ventismedia.android.mediamonkey.sync.wifi.utils.l(1334): Media to delete without confirmation:[][a():132]
07-26 19:54:30.138: D/com.ventismedia.android.mediamonkey.db.bk(1339): acquireWakeLock[run():6637]
07-26 19:54:30.139: D/com.ventismedia.android.mediamonkey.sync.wifi.utils.l(1334): Delete playlists[a():54]
07-26 19:54:30.141: D/com.ventismedia.android.mediamonkey.sync.wifi.utils.l(1334): Playlists to delete without confirmation:[][a():1077]
07-26 19:54:30.144: W/com.ventismedia.android.mediamonkey.db.bk(1339): New ThreadSerializer id from -1 to 1339[run():1671]
07-26 19:54:30.145: D/com.ventismedia.android.mediamonkey.sync.wifi.utils.c(1334): Confirm: {CONFIRM_TRACK_DELETE_NEW=[], CONFIRM_TRACK_DELETE_DESYNCED=[], CONFIRM_PLAYLIST_UPDATE=[], CONFIRM_PLAYLIST_UPLOAD=[], CONFIRM_TRACK_UPDATE=[], CONFIRM_PLAYLIST_DELETE=[], CURRENT_TRACK_DETAIL=[], CONFIRM_TRACK_UPLOAD=[]}[a():40]
07-26 19:54:30.154: D/com.ventismedia.android.mediamonkey.sync.wifi.utils.c(1334): Nothing to confirm[a():57]
07-26 19:54:30.158: D/com.ventismedia.android.mediamonkey.sync.wifi.aq(1334): isHashVersionUpdated() = false[b():744]
07-26 19:54:30.806: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): Sync: Device -> Server: com.ventismedia.android.mediamonkey.sync.wifi.utils.j: <?xml version='1.0' encoding='UTF-8' standalone='yes' ?><Storage availableSpace="93233" totalSpace="122603" /><Tracks>55817,42797,54955,42991,54150,55873,53989,42150,53865,42789,54950,62302,55615,55909,56030,42216,53987,55796,55772,55723,55621,62305,42275,55600,55603,42251,54433,55608,55641,55839,56020,55884,42530,54703,55721,55789,42569,54738,42454,54622,55791,42575,54745,55797,55779,42495,54669,56081,42804,54961,42531,54704,55982,42774,54937,55609,42213,54012,55639,55971,43170,54335,43164,54336,42992,54151,42589,54746,41689,53424,43070,54242,55809,42950,53953,43110,54281,42993,54152,55758,43194,54344,42900,54064,62289,62268,62261,62277,62262,62310,62313,62290,43023,54195,42766,54903,62270,41921,53649,62307,62293,62296,43080,54252,43131,54302,42820,54979,62303,62264,62294,62265,42836,54995,55756,54741,55688,55617,42740,54904,62254,55877,43058,54230,54648,42270,54452,43119,54290,43221,53949,42333,54507,54508,43165,54337,55871,42865,54026,42562,54734,42407,54580,43096,54267,42860,54039,43166,54338,56015,42669,54831,43091,54261,42887,54065,56067,56053,56130,56111,42666,54832,42957,54131,43132,54303,42873,54052,42741,42335,55643,54509,54510,42512,54685,42455,54623,62273,42970,54138,42742,55963,42888,54066,43133,43150,54304,42847,54027,54553,41981,56169,55889,42686,54849,42421,42253,54434,62251,62299,62304,43047,54219,43121,54292,42936,54112,42590,54747,42588,54744,54748,42682,53973,41631,53977,54394,54013,55637,42620,54788,42234,54416,42101,53817,42889,54067,62306,42976,54153,54749,42576,54750,42927,54103,42973,54147,42546,54705,54624,42336,54511,54557,42532,54706,55016,54751,42829,42830,54988,55606,42994,54154,42324,54502,41983,43024,54196,55753,41961,56171,56170,54645,42621,54789,43035,54207,42848,54028,42397,42651,54815,54512,42717,54880,42403,54578,55759,42730,54893,42408,54581,55924,42723,54886,42500,54674,42901,54068,43130,42457,54625,42570,54739,42662,54827,55694,55647,41984,42402,53943,62147,53761,62150,53762,61896,62153,61895,62154,43225,53951,42879,54057,42389,54563,55953,55879,56068,55918,55902,55907,42657,42656,54822,43033,54204,42520,54693,43151,54306,42385,54560,42890,54069,42036,53725,42737,54900,55658,55773,54707,54708,42931,54104,42166,53881,42526,42529,54702,54699,41757,53489,42794,54951,55777,55864,42802,54962,42677,54842,55710,42235,54417,55869,42928,54105,42963,54137,55892,43055,54226,42805,54963,56004,42935,54111,55671,41761,53493,56021,55711,55942,55894,55795,43084,54254,43134,54307,56078,55752,54996,56082,42995,54155,54387,55734,62286,62266,62298,55598,42654,54820,62258,41923,53651,55948,56000,42379,42338,54554,54513,42382,54558,55687,41886,53616,42425,54600,55691,43235,54392,53586,53585,42693,54856,55619,42339,54514,42340,56095,53986,42795,54956,53978,42280,54462,42452,54636,55644,56062,55781,54390,55897,55640,42849,54029,55921,42298,54479,55987,54515,42959,54133,42924,54100,42141,53856,55852,43092,54262,55616,43085,54255,42660,54825,42549,54709,42810,54969,55882,42678,54843,42932,54106,55733,43219,54385,42481,54655,41660,53396,54752,55846,42601,54770,54463,54710,43111,54282,42320,54498,42831,54990,55764,42684,54847,42729,54891,42923,54098,42743,42218,54401,42605,54774,42638,54790,55951,42138,43074,53853,54246,43095,53945,55699,55620,54833,42606,54775,42681,54846,42806,54964,42807,54965,42700,54863,42767,42564,53967,55705,42254,42609,54781,42497,54670,42779,54942,55646,55749,62276,62312,55775,62279,42255,54436,55730,55891,42850,54030,43082,54256,55751,55996,55681,55601,42344,55724,54517,42837,54997,42619,54787,42345,54518,55911,41940,53665,42799,54958,55857,43065,54237,43173,43211,54380,54345,41830,53561,42325,54503,43135,54308,43102,54273,62253,62267,42738,54901,42851,54031,42458,54626,42622,54791,42906,54083,55649,55946,55665,56094,41787,53522,55788,41851,53579,42293,54475,42301,54483,42282,54464,42676,54841,42996,54156,42938,54114,54662,42608,54777,41680,53416,43136,54309,43075,54247,42617,54786,42577,54753,56027,42960,54134,42409,54582,41986,56166,55684,42667,54834,42326,5[c():48]
07-26 19:54:30.806: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): 4504,42236,54418,56066,42410,54583,43036,54208,41750,53485,56177,53498,42595,54754,55642,55820,55983,43174,54346,42744,54909,42237,54419,42746,42745,54910,42116,53831,55917,55967,54755,42808,54966,62300,55012,42639,54792,43097,54268,55965,43063,54235,55955,62297,41633,53979,54395,54014,62255,62285,42522,54695,42768,54912,42428,54601,56005,55786,42883,54061,55810,42302,54484,55626,42506,53965,62260,55717,54711,43081,54253,55727,55829,55893,55922,42866,54032,43050,54222,55816,42997,54157,42204,42998,53918,54158,42390,54564,43060,54232,42563,54735,41634,54389,42493,54667,42818,54977,56006,55743,42910,54089,43042,54214,42523,54696,42861,54040,42291,54473,42614,54783,54571,55818,55863,42784,54945,43103,54274,55854,62291,42273,54456,42303,54485,43195,53980,43196,43197,53955,56060,42803,54967,43104,54275,42181,53896,55771,42470,54646,55985,43068,54240,55803,54519,41733,53471,55695,42832,54991,43115,54285,42411,54584,42953,54126,42902,54070,42623,54793,42511,54684,42790,54952,55645,42533,54712,42958,54132,55674,53760,55790,54594,55828,42219,54402,42825,42824,54983,42891,54071,55834,43040,54212,56001,43077,54249,43078,54250,55872,42881,54059,42518,54691,41781,56176,43137,43152,54310,42834,54992,56059,56123,42937,54113,55994,55678,42347,54520,54664,56024,56035,56152,55805,42412,54585,43210,54379,54839,42747,54913,42552,54713,42610,54778,55944,43153,54312,55715,42477,55989,41862,42075,53596,53792,42852,54033,41864,53598,55662,43198,54348,42748,54914,42783,53969,42534,54714,54676,43048,54220,42679,54844,43059,54231,43062,54234,43199,54349,56034,56073,43154,54313,42226,42220,54409,54403,42177,53892,43155,54314,56080,55881,42948,54124,42172,53887,42640,54794,42833,54993,55009,55736,42977,54159,42694,54857,43156,54315,43218,53947,42233,54415,42422,54597,43100,54269,54620,42722,54885,54521,56063,55693,55832,42884,54062,43138,54316,42489,54665,56041,42508,54681,56037,43086,54257,55876,55858,55862,55815,42535,54715,55635,43025,54197,42611,54779,42668,42671,54835,55762,55916,43175,54350,43157,54317,42465,54640,42624,54795,43127,54293,43139,54318,43026,54198,42707,54870,55908,54386,43176,54351,42798,54957,55821,55827,42892,54072,42972,54146,54522,55745,54612,56011,42157,42615,54784,42862,54041,42918,54092,42304,54486,42398,54573,43212,54381,42231,54413,42942,54118,43122,54294,56036,56136,43167,54339,42999,54160,55614,55768,55785,55770,56175,42791,54953,42426,54602,56018,55939,42769,54915,41647,53935,42507,54680,42105,42104,61810,53823,62191,42877,54056,55910,55978,42238,54420,42978,54161,55685,42925,54101,56025,55683,43177,54352,55774,55961,54627,43123,54295,41988,43168,54340,55870,41661,53397,55867,55905,42350,54523,42625,53970,54437,42919,54093,53758,42578,54756,54677,54593,42712,54875,42579,42749,54916,42221,54404,62287,42351,56093,56052,56055,55719,55808,55610,43000,54162,55956,55760,43120,43172,54291,54343,56019,42527,54700,56159,42939,54115,42941,54116,55804,42612,55713,43178,42423,54598,54353,43128,42515,54687,54688,43001,54163,42580,54758,55599,43140,54319,42724,54887,56061,55677,55722,53991,43213,54382,43027,54199,55868,42279,54461,55744,53497,42222,54405,42260,54442,42626,53972,55676,43037,54209,55880,55998,42607,54776,42352,53968,42239,54421,42240,54422,42464,54639,42920,53988,42627,54796,55776,62269,62309,62272,62263,62271,62282,62288,43180,43179,54354,42353,54525,42703,54865,55648,55913,43200,54356,42914,54091,53956,43002,54164,43089,54263,54505,62256,62308,42867,54034,55663,55653,43223,53950,56010,62157,53764,42496,54671,55716,42461,54628,54629,42276,54458,43003,54165,41635,53981,54396,54015,55896,42322,54500,42956,54130,42835,54994,42499,54673,42504,54678,43028,42354,56092,43141,54320,55780,53587,43004,54166,55830,42801,54959,55668,62280,42321,54499,42750,54917,41990,56164,55748,42751,54918,55739,42815,54974,43005,53957,42979,53958,55981,55675,42305,54487,43142,43158,54321,55807,42448,42447,54630,42355,54527,54819,55966,62274,56065,41636,53982,54397,54016,54716,54642,54845,53496,42357,56091,54529,56054,56074,42714,42713,54876,42715,54878,42129,53844,42628,54797,55928,42687,54850,4[c():48]
07-26 19:54:30.806: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): 2683,53983,54438,55709,53636,56090,42424,54599,42399,42399,54574,42882,54060,41969,53695,41917,53645,55799,42947,54123,42893,54073,43043,54215,42648,54814,41991,56163,42964,54139,42655,54821,42268,54450,56033,42811,54970,42283,54465,43112,54283,42446,54621,42400,54576,56007,42306,54488,55812,54603,42915,54094,55999,41992,62159,53734,42770,54919,54490,56089,54666,54530,42929,54107,42672,54837,42241,54423,55945,43181,54357,42232,54414,43051,54223,43054,54227,55836,42752,55915,42284,54466,42442,54617,56026,42863,54042,42217,54400,42916,54095,55943,43093,54264,42688,54851,55623,42315,54493,42855,42854,54043,55746,56058,42753,54921,42952,54127,43032,54205,54798,42828,54987,42894,54074,43143,54323,53990,56056,43105,54276,55769,42554,54717,42652,54818,55954,55923,42482,54656,43006,54167,41637,53984,54398,54017,55901,42856,54045,55729,42629,54799,43144,54324,42630,54800,42739,54902,42965,54140,55763,55613,55672,55622,55972,54531,42360,54532,42296,54478,55689,42361,54533,42439,54614,42386,54561,56047,56153,42471,54647,42391,54565,42505,54679,56002,55940,55602,56050,56051,55638,55005,42875,54054,55664,42537,42536,54718,55865,54534,56040,43052,54224,42775,54938,43171,54341,42285,54467,54759,42699,54862,42787,54948,56072,55793,43041,54213,55947,54998,55936,42663,54828,43064,54236,42581,54760,42933,54108,42565,53962,42642,54801,55938,55925,43101,54272,55851,56049,41652,53388,43169,54342,42658,54824,42227,53961,55937,55970,43007,54168,55840,43114,54286,56038,42631,54802,55958,55597,55728,42718,54881,42513,54686,55629,56046,55926,55669,42786,54946,42250,54432,55903,53425,42286,54468,55930,42598,54761,42708,54871,42754,54922,55778,43145,54325,53409,42907,54084,42107,42417,43182,54358,42582,54762,55935,43183,54359,43098,54270,54019,56023,42307,54489,42857,54046,55755,42911,54085,42903,54075,62283,62278,62311,62275,42913,54090,42292,54474,62281,62284,62301,62259,42363,56088,55969,42483,54657,42966,54141,54694,42632,54803,42945,54119,54412,55697,42392,54566,42393,54567,54020,42287,54469,54536,55656,42583,42599,54763,42643,54804,55964,41994,62162,53736,43217,53946,55007,55811,56087,43129,54297,62292,55835,42486,54660,42895,54076,55859,42449,54632,42463,54638,43146,54326,42904,54077,43113,54284,54637,42909,54088,42484,54658,42487,54661,55611,42940,43008,54169,43087,54258,55823,55941,42780,54943,42781,54944,55844,55949,42845,54021,42567,54736,42874,54053,54611,42876,54055,42242,54424,42868,54035,42633,54805,42755,54923,42538,54720,54852,42896,54078,43201,54360,42704,54866,54737,56086,54537,43117,54287,42756,54924,42776,54939,42777,54940,42380,54555,55718,56042,55853,55625,42871,54050,42869,54036,55707,55933,43009,54170,43124,56012,42384,54559,42174,53889,42381,54556,56085,42728,54892,42792,54954,42039,53728,42692,54854,42413,54586,55692,42440,54615,42872,54051,42897,54079,42905,54080,42267,54449,55670,42827,54986,42539,54721,55875,42414,54587,55794,55784,55632,42492,54663,55679,56045,43067,54239,55651,42271,54453,55883,42261,54443,56028,55738,42771,54925,56008,55732,42930,54109,55988,42366,56084,41679,53415,55633,42772,54926,55957,42584,54765,43076,54248,55813,55787,54539,43147,54327,55792,55826,56022,42954,54128,55696,42405,54588,55652,55861,42697,54859,42696,54860,42961,54135,55726,55849,42725,54888,56077,42265,54447,55825,55624,43053,54225,55842,55850,41790,53525,55974,56016,55856,55680,43148,54328,42634,54806,42571,54740,42782,53959,42823,54982,56039,56109,42450,54633,54722,43072,54244,55934,42719,54882,42934,54110,43149,54329,55706,55968,43159,54330,41845,53575,56174,55010,42243,54425,42394,54568,42980,54171,55740,42297,54481,42814,54973,41819,53551,61961,43202,54361,43088,54260,55754,55761,55906,43125,54299,55950,43109,54280,55833,42223,54406,41735,53462,42921,54096,55627,42278,54460,42880,54058,43106,54277,53992,42300,54482,42494,54668,55914,42812,54971,55612,56017,42314,54491,54492,56083,42949,54125,54388,55824,42757,54927,42898,54081,55977,42277,54459,55959,42732,54895,42635,54807,55919,42525,54698,55890,42720,54883,42821,54980,42955,54129,54976,42702,54867,42258,54439,55630,43203,54362,5[c():48]
07-26 19:54:30.806: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): 5666,54540,55650,54848,55661,55607,55618,42316,54494,42636,54808,42049,56161,56014,43029,54201,43184,54363,41915,53643,42269,54451,42951,53954,42734,54897,42758,54928,54541,42038,53727,42962,54136,42721,54884,55995,55801,55698,54542,43034,54206,55960,41763,53495,55690,42431,54606,56057,55002,43073,54245,42813,54972,43083,54259,42308,53963,54391,55991,42691,42690,54853,54855,42435,54610,55003,42613,54782,41638,53985,54399,54018,55932,42485,54659,42885,53944,56032,42556,54723,54724,55997,55720,55979,42675,54840,55973,42600,54766,55927,54725,55822,55976,42778,54941,42319,54497,42559,54726,42853,54037,42981,54172,42433,42528,54608,54701,55673,42809,54968,42406,54589,43160,56031,54331,55993,55898,42733,54896,55704,43185,54364,55783,42637,54809,42858,42864,54047,42759,54929,43161,54332,42644,42711,54873,54999,55011,55682,54609,42736,42735,54898,43079,54251,55782,42262,54444,42441,54616,55843,43186,54365,43204,54366,42616,54785,42466,54641,42603,54772,43205,54367,55845,55838,42372,42371,54543,53994,42899,54082,42207,53921,42701,54864,55819,43030,54202,43187,54368,42645,54811,43010,54173,42709,54872,54552,55920,42819,54978,56070,42788,54949,55931,55014,43011,54174,43056,54228,56029,55895,42967,54142,42540,54727,55628,55878,55701,55800,55848,43012,54175,43013,54176,42274,54455,42244,54426,42041,42982,54177,42846,54025,41693,53429,56069,56115,43038,54210,43014,54178,42983,54179,42420,54595,55904,42451,54634,42922,54099,43015,54180,42317,54495,42501,43016,54181,55757,42541,54728,42309,53960,55765,55605,42524,54697,55714,43220,53948,42984,54182,42985,54183,55700,54729,42585,54767,42859,42760,54930,42943,54120,56071,55986,42731,54894,42604,54773,42395,54569,42542,54730,42480,54654,42986,54184,42245,54427,43017,54185,42716,54879,41914,53642,43057,54229,42566,53971,42288,54470,43206,54369,42246,54428,56044,42197,53923,54384,42059,53778,42373,54545,42247,54429,55855,42311,53966,42443,54618,42987,54186,42870,54038,55866,42710,55000,54861,42988,54187,42289,54471,43099,54271,42427,54604,55604,54546,43018,54188,42785,54947,56076,42248,54430,55015,43188,54370,55686,42224,54407,56013,55017,55874,42375,54547,56075,42664,54829,42705,54868,55929,42946,54121,55660,43046,54218,42816,54975,55900,42917,54097,42971,54143,55802,56064,55655,43044,54216,43233,53952,55885,55837,54683,54445,43061,54233,42474,54649,56079,42822,54981,42299,54480,55008,62215,62227,62239,62224,62236,62248,62225,62237,62249,62226,62238,62250,62216,62228,62240,62217,62229,62241,62218,62230,62242,42329,54551,62219,62231,62243,62220,62232,62244,62221,62233,62245,62222,62234,62246,62223,62235,62247,42968,54144,42415,54590,42376,54548,55899,54742,42661,54826,55702,54549,42586,54768,41694,53430,43207,54371,42826,54985,42665,54830,43019,54189,42290,54472,55992,55735,54613,42388,54570,42252,54441,42318,54496,43108,54279,56048,62295,42878,54393,43189,54372,42761,54931,55962,43116,54289,43069,54241,42975,42974,54148,42249,54431,53795,55725,54619,43208,54373,42467,54643,54506,42225,54408,42416,54591,43190,54374,41932,41931,53759,42543,54731,43045,54217,54410,42214,53975,54446,42519,54692,42208,53922,54838,43191,54375,43020,54190,54411,43071,54243,42762,54932,55731,42773,54933,55747,56162,42800,54960,42310,53964,55703,42726,54889,42727,54890,41696,42646,53432,54812,43066,54238,43118,54288,42509,54682,42647,54813,42838,54022,42544,54732,43162,54333,42602,54771,42989,54191,55654,41939,53664,41770,53506,56043,42430,54605,42912,54086,42969,54145,43021,54192,42215,53976,42587,54769,42763,54934,42764,54935,55667,55887,55708,54607,43090,54265,42706,54869,55806,43039,54211,42401,54577,42649,54816,54644,43022,54193,42479,54651,54454,54550,42266,54448,55657,55001,55975,55952,53993,42561,53974,42498,54672,41769,53505,43192,54376,55841,42295,54476,54477,55860,42462,54635,54562,54689,54690,42404,54579,42574,54743,55847,42695,54858,43049,54221,55004,43107,54278,55831,42545,54733,55886,56003,55990,56009,55659,56160,43163,54334,43209,54377,55767,55814,43031,54203,55798,42944,54122,53995,42908,54087,55634,43126,54300,55013,42926,54102,55766,42990,54194,42839,5[c():48]
07-26 19:54:30.806: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): 4023,42840,54024,42475,54653,43193,54378,43214,54383,41879,56173,56172,55636,42886,54063,55006,41999,53722,42259,54440,42765,54936,43094,54266,55742,53640,55912,55984,42650,54817,62204,42323,54501</Tracks>[c():48]
07-26 19:54:30.807: D/com.ventismedia.android.mediamonkey.upnp.bk(1334): Post file to http://192.168.1.2:60259[a():973]
07-26 19:54:30.888: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): Sync: Device -> Server: com.ventismedia.android.mediamonkey.sync.wifi.utils.j: Successfull[c():48]
07-26 19:54:30.963: D/com.ventismedia.android.mediamonkey.sync.wifi.al(1334): SyncListQuery - start[a():57]
07-26 19:54:30.964: I/com.ventismedia.android.mediamonkey.sync.wifi.bj(1334): Request: id:SyncList:DeviceID:fd59f6d8.0.926f3cd6-7846-4b38-bda8-7521bb9bfd7e,filter:*, flag:DIRECT_CHILDREN, Items: 0-100[a():271]
07-26 19:54:34.964: I/com.ventismedia.android.mediamonkey.db.bk(1339): notifyChange[b():139]
07-26 19:54:35.037: D/com.ventismedia.android.mediamonkey.db.bk(1339): ThreadSerializer exiting[run():1889]
07-26 19:54:35.038: D/com.ventismedia.android.mediamonkey.db.bk(1339): releaseWakeLock[h():1646]
07-26 19:54:35.043: I/com.ventismedia.android.mediamonkey.db.bk(1339): ThreadSerializer exit[run():1986]
07-26 19:54:49.971: I/org.fourthline.cling.transport.spi.StreamClient(1324): Timeout of 19 seconds while waiting for HTTP request to complete, aborting: (OutgoingActionRequestMessage) POST http://192.168.1.2:60259/ContentDirectory/1031d41a-2978-4070-98c5-bc66ace53282/control.xml
07-26 19:54:49.979: E/java.lang.Class(1324): Upnp query failed: Error: Current state of service prevents invoking that action. Connection error or no response received.[a():186]
07-26 19:54:49.984: E/java.lang.Class(1324): org.fourthline.cling.model.action.ActionException: Current state of service prevents invoking that action. Connection error or no response received.
07-26 19:54:49.984: E/org.fourthline.cling.protocol.sync.SendingAction(1324): 	at [invokeRemote:77]
07-26 19:54:49.984: E/org.fourthline.cling.protocol.sync.SendingAction(1324): 	at [executeSync:63]
07-26 19:54:49.984: E/org.fourthline.cling.protocol.sync.SendingAction(1324): 	at [executeSync:51]
07-26 19:54:49.984: E/org.fourthline.cling.protocol.SendingSync(1324): 	at [execute:54]
07-26 19:54:49.984: E/org.fourthline.cling.protocol.SendingAsync(1324): 	at [run:54]
07-26 19:54:49.984: E/org.fourthline.cling.controlpoint.ActionCallback(1324): 	at [run:151]
07-26 19:54:49.984: E/com.ventismedia.android.mediamonkey.upnp.bx(1324): 	at [run:129]
07-26 19:54:49.984: E/java.util.concurrent.Executors$RunnableAdapter(1324): 	at [call:428]
07-26 19:54:49.984: E/java.util.concurrent.FutureTask(1324): 	at [run:237]
07-26 19:54:49.984: E/java.util.concurrent.ThreadPoolExecutor(1324): 	at [runWorker:1133]
07-26 19:54:49.984: E/java.util.concurrent.ThreadPoolExecutor$Worker(1324): 	at [run:607]
07-26 19:54:49.984: E/java.lang.Thread(1324): 	at [run:761]
07-26 19:54:49.986: E/com.ventismedia.android.mediamonkey.sync.wifi.bj(1324): Upnp query failure[a():446]
07-26 19:54:49.988: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): onFinally[b():734]
07-26 19:54:49.994: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): Sync: Device -> Server: com.ventismedia.android.mediamonkey.sync.wifi.utils.i: <?xml version='1.0' encoding='UTF-8' standalone='yes' ?><SyncSummary succeed="1" />[c():48]
07-26 19:54:49.998: D/com.ventismedia.android.mediamonkey.upnp.bk(1334): Post file to http://192.168.1.2:60259[a():973]
07-26 19:54:50.136: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): Sync: Device -> Server: com.ventismedia.android.mediamonkey.sync.wifi.utils.i: Successfull[c():48]
07-26 19:54:50.143: E/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): Sync: Device Ventis Media, Inc. MediaMonkey Media Server 4.0: Synchronization timeout[a():383]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): java.util.concurrent.TimeoutException: Upnp query timeout
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.upnp.bq(1334): 	at [a:299]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.upnp.bq(1334): 	at [c:245]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.sync.wifi.al(1334): 	at [a:61]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): 	at [b:749]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): 	at [b:7944]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.sync.wifi.bc(1334): 	at [a:355]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.upnp.cv(1334): 	at [run:403]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.b.c(1334): 	at [processTask:18]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.b.a(1334): 	at [processTaskInner:182]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.b.a(1334): 	at [pollQueue:308]
07-26 19:54:50.145: E/com.ventismedia.android.mediamonkey.b.a$c(1334): 	at [run:437]
07-26 19:54:50.151: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1): handleMessage 3[handleMessage():1197]
07-26 19:54:50.151: E/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1): Sync failed - unknown[handleMessage():1252]
07-26 19:54:50.154: D/com.ventismedia.android.mediamonkey.sync.wifi.WifiSyncService(1334): Hide notification[a():409]
07-26 19:54:50.195: D/com.ventismedia.android.mediamonkey.upnp.cq(1): Disconnect UPnP connection[k():226]
07-26 19:54:50.223: D/com.ventismedia.android.mediamonkey.ui.phone.HomeActivity(1): Intent command received[onReceive():34]
07-26 19:54:50.224: D/com.ventismedia.android.mediamonkey.sync.ContentService(1): SYNC_TASK_STOPPED_ACTION received[onReceive():69]
07-26 19:54:50.225: D/com.ventismedia.android.mediamonkey.app.a(1): Clearing caches is not needed.[a():87]
07-26 19:54:50.227: I/com.ventismedia.android.mediamonkey.sync.ContentService(1): doNextAction[e():319]
07-26 19:54:50.228: D/com.ventismedia.android.mediamonkey.sync.ContentService(1): No task in queue[e():326]
07-26 19:54:50.229: D/com.ventismedia.android.mediamonkey.upnp.UpnpBrowseService(1): onUnbind[onUnbind():403]
07-26 19:54:50.230: D/com.ventismedia.android.mediamonkey.upnp.UpnpBrowseService(1): stopDelay[onUnbind():1412]
07-26 19:54:50.267: D/com.ventismedia.android.mediamonkey.sync.ms.MediaStoreSyncService(1): Service is not running[a():82]
07-26 19:54:50.268: D/com.ventismedia.android.mediamonkey.storage.StorageObserverService(1): Publish database event received.[onReceive():125]
07-26 19:54:50.269: D/com.ventismedia.android.mediamonkey.storage.StorageObserverService(1): Start observers[d():253]
07-26 19:54:50.271: D/com.ventismedia.android.mediamonkey.db.bg(1): onStart[b():406]
07-26 19:54:50.279: I/com.ventismedia.android.mediamonkey.sync.ContentService(1): Service is not running[a():148]
07-26 19:54:50.280: D/com.ventismedia.android.mediamonkey.storage.aj(1): start[a():32]
07-26 19:54:50.303: D/com.ventismedia.android.mediamonkey.ui.phone.HomeActivity(1): Intent command received[onReceive():34]
07-26 19:54:50.304: D/com.ventismedia.android.mediamonkey.ui.BaseService(1): onStartCommand com.ventismedia.android.mediamonkey.BackgroundProcessService, intent:com.ventismedia.android.mediamonkey.CREATE_THUMBNAILS_ACTION, flags:0, startId:1[onStartCommand():72]
07-26 19:54:50.309: D/com.ventismedia.android.mediamonkey.db.bk(1343): acquireWakeLock[run():6637]
07-26 19:54:50.312: W/com.ventismedia.android.mediamonkey.db.bk(1343): New ThreadSerializer id from -1 to 1343[run():1671]
07-26 19:54:51.327: D/com.ventismedia.android.mediamonkey.db.bk(1343): ThreadSerializer exiting[run():1889]
07-26 19:54:51.330: D/com.ventismedia.android.mediamonkey.db.bk(1343): releaseWakeLock[h():1646]
07-26 19:54:51.350: I/com.ventismedia.android.mediamonkey.db.bk(1343): ThreadSerializer exit[run():1986]
07-26 19:54:51.539: I/com.ventismedia.android.mediamonkey.billing.i(1): clearFlag[a():29]
07-26 19:54:51.548: W/com.ventismedia.android.mediamonkey.ui.ah(1): Activity is not active[b():144]
07-26 19:54:51.566: D/com.ventismedia.android.mediamonkey.storage.StorageObserverService(1): stopServiceDelayed in 180000[c():225]
07-26 19:54:51.571: D/com.ventismedia.android.mediamonkey.storage.aj(1): App goes to background[e():65]
07-26 19:54:51.574: I/com.ventismedia.android.mediamonkey.player.tracklist.b.d(1): Stored: STOPPED:2017-07-26 19:54:51, position:00:00:00.000[a():234]
07-26 19:54:51.581: D/com.ventismedia.android.mediamonkey.ui.BaseActivity(1): mUseLockScreenPlayer false[b():2169]
07-26 19:54:51.581: D/com.ventismedia.android.mediamonkey.ui.BaseActivity(1): receiverRegistered false[b():2170]
07-26 19:54:51.593: D/com.ventismedia.android.mediamonkey.ui.phone.MiniPlayerActivity(1): ACTION_USER_PRESENT registerReceiver[b():68]
07-26 19:54:51.597: I/com.ventismedia.android.mediamonkey.player.tracklist.b.d(1): Stored: STOPPED:2017-07-26 19:54:51, position:00:00:00.000[a():234]
07-26 19:54:51.600: I/com.ventismedia.android.mediamonkey.sync.ContentService(1): Service is not running[a():148]
07-26 19:54:51.637: D/com.ventismedia.android.mediamonkey.storage.StorageObserverService(1): cancelStopService[b():2240]
07-26 19:54:51.640: D/com.ventismedia.android.mediamonkey.storage.aj(1): App goes to foreground[f():74]
07-26 19:54:51.641: D/com.ventismedia.android.mediamonkey.storage.aj(1): On wake up[a():130]
07-26 19:54:51.641: D/com.ventismedia.android.mediamonkey.sync.SyncLauncher(1): Application goes to foreground[onReceive():143]
07-26 19:54:51.641: I/com.ventismedia.android.mediamonkey.storage.StorageObserverService(1): Service is running[a():169]
07-26 19:54:51.644: D/com.ventismedia.android.mediamonkey.cast.chromecast.ui.a(1): WIFI connectivity changed to enabled[a():544]
07-26 19:54:51.888: D/com.ventismedia.android.mediamonkey.cast.chromecast.ui.a$a(1): onUiVisibilityChanged true[b():468]
07-26 19:54:55.236: D/com.ventismedia.android.mediamonkey.upnp.UpnpBrowseService(1): Delayed stop of UpnpBrowseService[handleMessage():472]
07-26 19:54:55.236: D/com.ventismedia.android.mediamonkey.upnp.UpnpBrowseService(1): UpnpBrowseService stopped[handleMessage():488]
07-26 19:54:55.239: I/org.fourthline.cling.UpnpServiceImpl(1345): >>> Shutting down UPnP service...
07-26 19:55:00.280: D/com.ventismedia.android.mediamonkey.storage.StorageObserverService(1): DelayedDatabaseCopyHandler: Call PublishDatabase start[handleMessage():449]
07-26 19:55:00.283: W/com.ventismedia.android.mediamonkey.db.bk(1): UI thread is putting request to TM![a():872]
07-26 19:55:00.285: D/com.ventismedia.android.mediamonkey.storage.StorageObserverService(1): DelayedDatabaseCopyHandler: Call PublishDatabase end[handleMessage():451]
07-26 19:55:00.286: D/com.ventismedia.android.mediamonkey.db.bk(1347): acquireWakeLock[run():6637]
07-26 19:55:00.290: W/com.ventismedia.android.mediamonkey.db.bk(1347): New ThreadSerializer id from -1 to 1347[run():1671]
07-26 19:55:00.291: I/com.ventismedia.android.mediamonkey.db.bk(1347): Command: PublishDatabase[a():1398]
07-26 19:55:00.299: D/com.ventismedia.android.mediamonkey.db.ac(1347): Checkpoint result:0,9,9[a():1497]
07-26 19:55:00.316: D/com.ventismedia.android.mediamonkey.db.ab(1347): Creating DB copy [c():4304]
07-26 19:55:00.321: W/com.ventismedia.android.mediamonkey.storage.bq(1347): Delete file: /storage/emulated/0/MediaMonkey/files/mmstore.db-wal[a():2053]
07-26 19:55:00.322: W/com.ventismedia.android.mediamonkey.storage.bq(1347): Delete file: /storage/emulated/0/MediaMonkey/files/mmstore.db-shm[a():2053]
07-26 19:55:00.324: W/com.ventismedia.android.mediamonkey.storage.bq(1347): Delete file: /storage/emulated/0/MediaMonkey/files/mmstore.db-journal[a():2053]
07-26 19:55:00.326: W/com.ventismedia.android.mediamonkey.storage.bq(1347): Delete file: /storage/emulated/0/MediaMonkey/files/mmstore.db[a():2053]
07-26 19:55:00.332: W/com.ventismedia.android.mediamonkey.db.b.b.c(1347): Delete file from MediaStore: /storage/emulated/0/MediaMonkey/files/mmstore.db[a():36]
07-26 19:55:00.573: D/com.ventismedia.android.mediamonkey.db.ab(1347): DB copy created from /data/user/0/com.ventismedia.android.mediamonkey/databases/mmstore.db to /storage/emulated/0/MediaMonkey/files/mmstore.db[c():4345]
07-26 19:55:00.575: D/com.ventismedia.android.mediamonkey.storage.bq(1347): Scan files: [/storage/emulated/0/MediaMonkey/files/mmstore.db][a():255]
07-26 19:55:00.583: D/com.ventismedia.android.mediamonkey.storage.bq(1347): Scan files: [/storage/emulated/0/MediaMonkey/files/storageInfo.xml][a():255]
07-26 19:55:00.586: D/com.ventismedia.android.mediamonkey.db.ab(1347): publishDatabase finished[c():4367]
07-26 19:55:00.638: D/com.ventismedia.android.mediamonkey.storage.bq(475): Scanned /storage/emulated/0/MediaMonkey/files/mmstore.db, uri=content://media/external/file/64011[onScanCompleted():1123]
07-26 19:55:00.662: D/com.ventismedia.android.mediamonkey.storage.bq(568): Scanned /storage/emulated/0/MediaMonkey/files/storageInfo.xml, uri=content://media/external/file/6097[onScanCompleted():1123]
07-26 19:55:01.593: D/com.ventismedia.android.mediamonkey.db.bk(1347): ThreadSerializer exiting[run():1889]
07-26 19:55:01.600: D/com.ventismedia.android.mediamonkey.db.bk(1347): releaseWakeLock[h():1646]
07-26 19:55:01.605: I/com.ventismedia.android.mediamonkey.db.bk(1347): ThreadSerializer exit[run():1986]

Timeout [#14333]

by DocMAX » Wed Jul 26, 2017 9:26 am

Hello,

when running MM on slow low power computer the sync timeouts.
Can i adjust the timeout value somewhere?

Thx,
DocMAX

Top