4.0.7.1510 Android MTP regression [#9959]

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: 4.0.7.1510 Android MTP regression [#9959]

Re: 4.0.7.1510 tested on anything but iPhone? -Android MTP p

by rusty » Mon Nov 12, 2012 11:28 am

Thanks!

-Rusty

Re: 4.0.7.1510 tested on anything but iPhone? -Android MTP p

by mgillespie » Mon Nov 12, 2012 2:38 am

Can confirm that 1511 works correctly and its no longer a regression,

Re: 4.0.7.1510 tested on anything but iPhone? -Android MTP p

by rusty » Sun Nov 11, 2012 10:28 pm

Hi,

Can you give this build a try and let us know if it resolves the issue for you? (if not, another debug log would be helpful)
http://www.mediamonkey.com/sw/MediaMonk ... _Debug.exe

Thanks!

-Russell

Re: 4.0.7.1510 tested on anything but iPhone? -Android MTP p

by Ludek » Sun Nov 11, 2012 4:20 pm

Thank you for the log, it will be fixed as http://www.ventismedia.com/mantis/view.php?id=9959 in the next build

Re: 4.0.7.1510 tested on anything but iPhone? -Android MTP p

by mgillespie » Sun Nov 11, 2012 5:47 am

Attaching the device (Xperia S) before starring MediaMonkey makes no difference.

Log below:
(I left it until after it did the startup media scan, then disconnected the device and reconnected)

Code: Select all

00000001	0.00000000	[1624] WMDM: Device change message	
00000002	0.00006154	[1624] WMDM: Queueing action id:0	
00000003	0.00010215	[1624] Media: Returned value: 1	
00000004	0.00020102	[1624] WMDM: Starting action id: 0	
00000005	0.00025846	[1624] WMDM: Looking for device changes...	
00000006	0.00033148	[1624] Winamp Playlist sim - message 537 left to the default processing	
00000007	0.00040697	[1624] Winamp simulation window received messsage 537	
00000008	0.00045333	[1624] Winamp sim - message left to the default processing	
00000009	0.00049927	[1624] Winamp sim - message processing finished	
00000010	0.00064245	[1624] WMDM: Is Inserted: , \\?\usb#vid_0fce&pid_5169&mi_00#6&57afabd&0&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0!USB@\\?\usb#vid_0fce&pid_5169&mi_00#6&57afabd&0&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0, \\?\usb#vid_0fce&pid_5169&mi_00#6&57afabd&0&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0	
00000011	0.00067445	[1624] WMDM: Empty device caption, ignore this device.	
00000012	0.00071958	[1624] WMDM: Finished action id: 0	
00000013	0.01669184	[1624] WMDM: Device change notification	
00000014	0.01673573	[1624] WMDM: Queueing action id:0	
00000015	0.01681614	[1624] WMDM: Starting action id: 0	
00000016	0.01684117	[1624] WMDM: Looking for device changes...	
00000017	0.01770146	[1624] WMDM: Finished action id: 0	
00000018	8.01369953	[1624] WMDM: Device change message	
00000019	8.01376820	[1624] WMDM: Queueing action id:0	
00000020	8.01378727	[1624] Media: Returned value: 1	
00000021	8.01388264	[1624] WMDM: Starting action id: 0	
00000022	8.01392841	[1624] Winamp Playlist sim - message 537 left to the default processing	
00000023	8.01396751	[1624] WMDM: Looking for device changes...	
00000024	8.01402760	[1624] Winamp simulation window received messsage 537	
00000025	8.01404667	[1624] Winamp sim - message left to the default processing	
00000026	8.01407528	[1624] WMDM: Finished action id: 0	
00000027	8.01411915	[1624] Winamp sim - message processing finished	
00000028	8.02498055	[1624] WMDM: Device change message	
00000029	8.02511024	[1624] WMDM: Queueing action id:0	
00000030	8.02518272	[1624] Media: Returned value: 1	
00000031	8.02522087	[1624] WMDM: Starting action id: 0	
00000032	8.02529526	[1624] Winamp Playlist sim - message 537 left to the default processing	
00000033	8.02533722	[1624] WMDM: Looking for device changes...	
00000034	8.02537346	[1624] Winamp simulation window received messsage 537	
00000035	8.02541447	[1624] WMDM: Finished action id: 0	
00000036	8.02543831	[1624] Winamp sim - message left to the default processing	
00000037	8.02548122	[1624] Winamp sim - message processing finished	
00000038	8.10839748	[1624] WMDM: Device change message	
00000039	8.10851574	[1624] WMDM: Queueing action id:0	
00000040	8.10857582	[1624] Media: Returned value: 1	
00000041	8.10861111	[1624] WMDM: Starting action id: 0	
00000042	8.10867023	[1624] WMDM: Looking for device changes...	
00000043	8.10873604	[1624] WMDM: Finished action id: 0	
00000044	8.10878658	[1624] Winamp Playlist sim - message 537 left to the default processing	
00000045	8.10882950	[1624] Winamp simulation window received messsage 537	
00000046	8.10886860	[1624] Winamp sim - message left to the default processing	
00000047	8.10891438	[1624] Winamp sim - message processing finished	
00000048	8.39093876	[1624] WMDM: Device change notification	
00000049	8.39096928	[1624] WMDM: Queueing action id:0	
00000050	8.39105701	[1624] WMDM: Starting action id: 0	
00000051	8.39107513	[1624] WMDM: Looking for device changes...	
00000052	8.39568901	[1624] WMDM: Is Inserted: Xperia S, 0:CB511WKRXX!USB@\\?\USB#VID_0FCE&PID_5169&MI_00#6&57afabd&0&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0, \\?\USB#VID_0FCE&PID_5169&MI_00#6&57afabd&0&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0	
00000053	8.40788841	[1624] WMDM: Device change message	
00000054	8.40797615	[1624] WMDM: Queueing action id:0	
00000055	8.40807819	[1624] Media: Returned value: 1	
00000056	8.40819836	[1624] Winamp Playlist sim - message 537 left to the default processing	
00000057	8.40825939	[1624] Winamp simulation window received messsage 537	
00000058	8.40830421	[1624] Winamp sim - message left to the default processing	
00000059	8.40838051	[1624] Winamp sim - message processing finished	
00000060	8.41727352	[1624] WMDM: Device change message	
00000061	8.41735363	[1624] Media: Returned value: 1	
00000062	8.41749477	[1624] Winamp Playlist sim - message 537 left to the default processing	
00000063	8.41757488	[1624] Winamp simulation window received messsage 537	
00000064	8.41761398	[1624] Winamp sim - message left to the default processing	
00000065	8.41767406	[1624] Winamp sim - message processing finished	
00000066	8.43695068	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000067	8.45388603	[1624] WMDM: Looking for profile for USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, drive: 	
00000068	8.45394135	[1624] WMDM: It's a new device - adding	
00000069	8.49184036	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000070	8.55009079	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000071	8.69021988	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000072	8.82555771	[1624] WMDM: Querying device capabilities.	
00000073	8.86674500	[1624] -------------------------------------------------------- 	
00000074	8.86674500	[1624] New exception: 	
00000075	8.86674500	[1624] Exception code: 3221225477 	
00000076	8.86674500	[1624] Exception flags: 2 	
00000077	8.86674500	[1624] Number of parameters: 2 	
00000078	8.86779213	[1624] -------------------------------------------------------- 	
00000079	8.86779213	[1624] New exception: 	
00000080	8.86779213	[1624] Exception code: 2460516 	
00000081	8.86779213	[1624] Exception flags: 1677721600 	
00000082	8.86779213	[1624] Number of parameters: 1360477 	
00000083	8.86808681	[1624] WMDM: Exception on action handling: Access violation at address 0D5E730F in module 'd_WMDM.dll'. Read of address 00000011	
00000084	8.86812687	[1624] WMDM: Finished action id: 0	
00000085	8.86816502	[1624] WMDM: Starting action id: 0	
00000086	8.86820030	[1624] WMDM: Looking for device changes...	
00000087	8.87253761	[1624] WMDM: Is Inserted: Xperia S, 0:CB511WKRXX!USB@\\?\USB#VID_0FCE&PID_5169&MI_00#6&57afabd&0&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0, \\?\USB#VID_0FCE&PID_5169&MI_00#6&57afabd&0&0000#{f33fdc04-d1ac-4e8e-9a30-19bbd4b108ae}$0	
00000088	8.91120720	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000089	8.92927170	[1624] WMDM: Looking for profile for USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, drive: 	
00000090	8.92934322	[1624] WMDM: It's a new device - adding	
00000091	8.96622372	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000092	9.01723957	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000093	9.06265736	[1624] Device scan found (PossDev): USB\VID_0FCE&PID_5169&MI_00\6&57AFABD&0&0000, Inst: 6524, Drive: -1	
00000094	9.07348633	[1624] WMDM: Querying device capabilities.	
00000095	9.11680031	[1624] -------------------------------------------------------- 	
00000096	9.11680031	[1624] New exception: 	
00000097	9.11680031	[1624] Exception code: 3221225477 	
00000098	9.11680031	[1624] Exception flags: 2 	
00000099	9.11680031	[1624] Number of parameters: 2 	
00000100	9.34063625	[1624] -------------------------------------------------------- 	
00000101	9.34063625	[1624] New exception: 	
00000102	9.34063625	[1624] Exception code: 2460516 	
00000103	9.34063625	[1624] Exception flags: 1677721600 	
00000104	9.34063625	[1624] Number of parameters: 1360477 	
00000105	9.41800880	[1624] WMDM: Exception on action handling: Access violation at address 0D5E730F in module 'd_WMDM.dll'. Read of address 00000011	
00000106	9.41805363	[1624] WMDM: Finished action id: 0	
00000107	11.56916523	[1624] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 29	
00000108	11.57247734	[1624] Thread 'UpdateDriveLetters_Var' has started 4496	
00000109	11.57253361	[1624] Thread registered, going to initialize 4496	
00000110	11.57257366	[1624] Thread initialized 4496	
00000111	11.58000565	[1624] CDPlayer.ini location: C:\Users\Mark\AppData\Roaming\MediaMonkey\CDPlayer.ini	
00000112	11.58028889	[1624] Going 'UpdateDriveLetters_Var'to make final callback 4496	
00000113	11.58035946	[1624] Thread 'UpdateDriveLetters_Var'has finished 4496	
00000114	41.58427429	[1624] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 27	
00000115	41.58762360	[1624] Thread 'UpdateDriveLetters_Var' has started 1456	
00000116	41.58767319	[1624] Thread registered, going to initialize 1456	
00000117	41.58770752	[1624] Thread initialized 1456	
00000118	41.59469986	[1624] CDPlayer.ini location: C:\Users\Mark\AppData\Roaming\MediaMonkey\CDPlayer.ini	
00000119	41.59497070	[1624] Going 'UpdateDriveLetters_Var'to make final callback 1456	
00000120	41.59503937	[1624] Thread 'UpdateDriveLetters_Var'has finished 1456	
00000121	71.59758759	[1624] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 27	
00000122	71.60073853	[1624] Thread 'UpdateDriveLetters_Var' has started 4776	
00000123	71.60077667	[1624] Thread registered, going to initialize 4776	
00000124	71.60080719	[1624] Thread initialized 4776	
00000125	71.60836792	[1624] CDPlayer.ini location: C:\Users\Mark\AppData\Roaming\MediaMonkey\CDPlayer.ini	
00000126	71.60863495	[1624] Going 'UpdateDriveLetters_Var'to make final callback 4776	
00000127	71.60868835	[1624] Thread 'UpdateDriveLetters_Var'has finished 4776	
00000128	101.61176300	[1624] TGenThread.Create: ThreadName: UpdateDriveLetters_Var , Running Threads: Internal: 0, All: 28	
00000129	101.61579132	[1624] Thread 'UpdateDriveLetters_Var' has started 1868	
00000130	101.61585236	[1624] Thread registered, going to initialize 1868	
00000131	101.61589813	[1624] Thread initialized 1868	
00000132	101.62330627	[1624] CDPlayer.ini location: C:\Users\Mark\AppData\Roaming\MediaMonkey\CDPlayer.ini	
00000133	101.62373352	[1624] Going 'UpdateDriveLetters_Var'to make final callback 1868	
00000134	101.62382507	[1624] Thread 'UpdateDriveLetters_Var'has finished 1868	
00000135	107.33834839	[1624] Forms: Received WM_ACTIVATEAPP	
00000136	107.33837128	[1624] Forms: Accepted WM_ACTIVATEAPP +	
00000137	107.33840942	[1624] Forms: RestoreTopMost: Level: 1	
00000138	107.33844757	[1624] Forms: RestoreTopMost: Starting	
00000139	107.33877563	[1624] Winamp sim - ignoring.	
00000140	107.33881378	[1624] Winamp simulation window received messsage 28	
00000141	107.33884430	[1624] Winamp sim - ignoring.	
00000142	107.33936310	[1624] MainForm: NC Activate +	
00000143	108.96921539	[1624] MainForm: NC Activate -	
00000144	108.96948242	[1624] Forms: Received WM_ACTIVATEAPP	
00000145	108.96951294	[1624] Forms: Accepted WM_ACTIVATEAPP -	
00000146	108.96955109	[1624] Forms: NormalizeTopMosts: Level: 0	
00000147	108.97128296	[1624] Forms: NormalizeTopMost: Starting	
00000148	108.97172546	[1624] Winamp sim - ignoring.	
00000149	108.97176361	[1624] Winamp simulation window received messsage 28	
00000150	108.97180176	[1624] Winamp sim - ignoring.

Re: 4.0.7.1510 tested on anything but iPhone? -Android MTP p

by Peke » Sun Nov 11, 2012 4:43 am

Hi, Can you please test on more thing.

Can you please confirm that if you connect devices before you start MM and see if MM detect device on startup?

Re: Did you test 4.0.7.1510 on anything but iPhones?

by rusty » Sun Nov 11, 2012 2:03 am

I haven't seen any problems either (tested on Nexus 4 MTP, and Xperio Pro in USB MSC mode). Anyone else seeing a regression?

If yes, PLEASE give us details, and send a debug log as requested by Ludek above.

Thanks.

-Rusty

Re: Did you test 4.0.7.1510 on anything but iPhones?

by Ludek » Sat Nov 10, 2012 1:25 pm

Sure, we tested it, but we haven't noticed any issue like this.

I also cannot replicate the issue with my MTP device (Samsung Galaxy Nexus), the device is recognized just fine with 4.0.7.1510 even if I delete the device profile or with fresh install.

What is your MTP device?
Could you generate debug log?

- Download the DbgView application from: http://technet.microsoft.com/en-us/sysi ... s/bb896647
- Plug in your device
- Execute DbgView.
- Execute MediaMonkey.exe (from build 1510_Debug)
- You'll see logs being generated in DbgView, attach it here.

Thank you!

4.0.7.1510 Android MTP regression [#9959]

by mgillespie » Sat Nov 10, 2012 9:14 am

It doesn't detect my MTP Android device. Reverting to 4.0.6 works, going back to 4.0.7, it's broken again.

Seems bizzare situation that you care more for your iPhone support than anything else.

Top