> Can you also test v5.0 .. v5.3 ? Mainline would be best (not v5.0.x but v5.0) ?
I was unable to build those Kernels with my build-system:
Kernel | Hash | Bug | Comment
Version | (date) | present |
----------|--------------------------------------------|---------|--------------
v5.0 | 1c163f4c7b3f621efff9b28a47abb36f7378d783 | | git://git.kernel.org/pub/scm/linux/kernel/git/stable/linux.git
| (3. March 2019) | | The build system was unable to compile the kernel
| | | scripts/dtc/dtc-parser.tab.o:(.bss+0x20):
| | | multiple definition of `yylloc';
| | | scripts/dtc/dtc-lexer.lex.o:(.bss+0x0)
----------|--------------------------------------------|---------|--------------
v5.3 | 4d856f72c10ecb060868ed10ff1b1453943fc6c8 | | git://git.kernel.org/pub/scm/linux/kernel/git/stable/linux.git
| (15. September 2019) | | The build system was unable to compile the kernel
| | | scripts/dtc/dtc-parser.tab.o:(.bss+0x20):
| | | multiple definition of `yylloc';
| | | scripts/dtc/dtc-lexer.lex.o:(.bss+0x0)
----------|--------------------------------------------|---------|--------------
> You should find the logs in /sys/debug/kernel/usb/tcpm-<index>.
I was able to retrieve these Logs for the 5.15.74 and 4.19.72 Kernel. Unfortunately I am not familiar enough with this subsystem to find the problem myself.
Regardless, what stands out to me (as it already did when I posted the I2C communication) is that the module in the old kernel is doing much more things when a cable gets attached. To me it seams as if a vital handling method is not being called in case a non-PD capable cable gets attached. As you can see in the log at the end the PD-capable power supplies work just fine.
=============================================================================
First the log from the old Kernel 4.19.72:
USB-PD Init:
------------
[ 2.381046] Setting voltage/current limit 0 mV 0 mA
[ 2.381069] polarity 0
[ 2.383125] Requesting mux state 0, usb-role 0, orientation 0
[ 2.384739] state change INVALID_STATE -> SNK_UNATTACHED
[ 2.385636] CC1: 0 -> 0, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, disconnected]
[ 2.385759] 3-0050: registered
[ 2.390858] Setting voltage/current limit 0 mV 0 mA
[ 2.390875] polarity 0
[ 2.405734] Requesting mux state 0, usb-role 0, orientation 0
[ 2.406435] cc:=0
[ 2.407098] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms
[ 2.408069] CC1: 0 -> 0, CC2: 0 -> 0 [state PORT_RESET, polarity 0, disconnected]
[ 2.408098] state change PORT_RESET -> SNK_UNATTACHED
[ 2.408139] Start DRP toggling
[ 2.411694] CC1: 0 -> 0, CC2: 0 -> 0 [state DRP_TOGGLING, polarity 0, disconnected]
USB-A to USB-C Cable attach event:
----------------------------------
[ 565.271076] VBUS on
[ 565.274567] VBUS on
[ 565.276331] VBUS on
[ 565.362693] CC1: 0 -> 3, CC2: 0 -> 0 [state DRP_TOGGLING, polarity 0, connected]
[ 565.362731] state change DRP_TOGGLING -> SNK_ATTACH_WAIT
[ 565.362775] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms
[ 565.565761] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 565.565797] state change SNK_DEBOUNCED -> SNK_ATTACHED
[ 565.565807] polarity 0
[ 565.567832] Requesting mux state 1, usb-role 2, orientation 1
[ 565.568544] state change SNK_ATTACHED -> SNK_STARTUP
[ 565.568567] state change SNK_STARTUP -> SNK_DISCOVERY
[ 565.568591] Setting voltage/current limit 5000 mV 0 mA
[ 565.568602] vbus=0 charge:=1
[ 565.569961] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES
[ 565.570651] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 240 ms
[ 565.813787] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND [delayed 240 ms]
[ 565.813817] PD TX, type: 0x5
[ 565.818135] PD TX complete, status: 0
[ 565.818238] state change HARD_RESET_SEND -> HARD_RESET_START
[ 565.820586] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF
[ 565.820611] vconn:=0
[ 565.823265] vbus=0 charge:=0
[ 565.828697] Requesting mux state 1, usb-role 2, orientation 1
[ 565.830910] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms
[ 565.837525] Setting voltage/current limit 0 mV 0 mA
[ 565.837673] polarity 0
[ 565.839715] Requesting mux state 0, usb-role 0, orientation 0
[ 565.841235] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED
[ 565.842167] CC1: 3 -> 3, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 565.842188] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT
[ 565.842221] state change SNK_ATTACH_WAIT -> PORT_RESET
[ 565.848450] Setting voltage/current limit 0 mV 0 mA
[ 565.848475] polarity 0
[ 565.850847] Requesting mux state 0, usb-role 0, orientation 0
[ 565.851570] cc:=0
[ 565.852307] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms
[ 565.855180] CC1: 3 -> 0, CC2: 0 -> 0 [state PORT_RESET, polarity 0, disconnected]
[ 565.855214] state change PORT_RESET -> SNK_UNATTACHED
[ 565.855253] Start DRP toggling
[ 565.860451] CC1: 0 -> 3, CC2: 0 -> 0 [state DRP_TOGGLING, polarity 0, connected]
[ 565.860480] state change DRP_TOGGLING -> SNK_ATTACH_WAIT
[ 565.860520] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms
[ 566.061736] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 566.061767] state change SNK_DEBOUNCED -> SNK_ATTACHED
[ 566.061775] polarity 0
[ 566.063833] Requesting mux state 1, usb-role 2, orientation 1
[ 566.064551] state change SNK_ATTACHED -> SNK_STARTUP
[ 566.064570] state change SNK_STARTUP -> SNK_DISCOVERY
[ 566.064581] Setting voltage/current limit 5000 mV 0 mA
[ 566.064590] vbus=0 charge:=1
[ 566.065949] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES
[ 566.066641] pending state change SNK_WAIT_CAPABILITIES -> SOFT_RESET_SEND @ 240 ms
[ 566.309824] state change SNK_WAIT_CAPABILITIES -> SOFT_RESET_SEND [delayed 240 ms]
[ 566.309854] PD TX, header: 0x8d
[ 566.319938] PD TX complete, status: 2
[ 566.320007] state change SOFT_RESET_SEND -> HARD_RESET_SEND
[ 566.320019] PD TX, type: 0x5
[ 566.324321] PD TX complete, status: 0
[ 566.324430] state change HARD_RESET_SEND -> HARD_RESET_START
[ 566.326885] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF
[ 566.326909] vconn:=0
[ 566.329797] vbus=0 charge:=0
[ 566.335128] Requesting mux state 1, usb-role 2, orientation 1
[ 566.336565] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms
[ 566.342930] Setting voltage/current limit 0 mV 0 mA
[ 566.342956] polarity 0
[ 566.344941] Requesting mux state 0, usb-role 0, orientation 0
[ 566.346586] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED
[ 566.347405] CC1: 3 -> 3, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 566.347432] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT
[ 566.347465] state change SNK_ATTACH_WAIT -> PORT_RESET
[ 566.352157] Setting voltage/current limit 0 mV 0 mA
[ 566.352182] polarity 0
[ 566.354530] Requesting mux state 0, usb-role 0, orientation 0
[ 566.355274] cc:=0
[ 566.356035] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms
[ 566.359164] CC1: 3 -> 0, CC2: 0 -> 0 [state PORT_RESET, polarity 0, disconnected]
[ 566.359198] state change PORT_RESET -> SNK_UNATTACHED
[ 566.359240] Start DRP toggling
[ 566.364575] CC1: 0 -> 3, CC2: 0 -> 0 [state DRP_TOGGLING, polarity 0, connected]
[ 566.364607] state change DRP_TOGGLING -> SNK_ATTACH_WAIT
[ 566.364646] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms
[ 566.565769] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 566.565797] state change SNK_DEBOUNCED -> SNK_ATTACHED
[ 566.565806] polarity 0
[ 566.568370] Requesting mux state 1, usb-role 2, orientation 1
[ 566.569046] state change SNK_ATTACHED -> SNK_STARTUP
[ 566.569064] state change SNK_STARTUP -> SNK_DISCOVERY
[ 566.569074] Setting voltage/current limit 5000 mV 0 mA
[ 566.569083] vbus=0 charge:=1
[ 566.570939] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES
[ 566.571660] pending state change SNK_WAIT_CAPABILITIES -> SOFT_RESET_SEND @ 240 ms
[ 566.813804] state change SNK_WAIT_CAPABILITIES -> SOFT_RESET_SEND [delayed 240 ms]
[ 566.813834] PD TX, header: 0x8d
[ 566.824392] PD TX complete, status: 2
[ 566.824461] state change SOFT_RESET_SEND -> SNK_UNATTACHED
[ 566.827325] Setting voltage/current limit 0 mV 0 mA
[ 566.827349] polarity 0
[ 566.829479] Requesting mux state 0, usb-role 0, orientation 0
[ 566.830186] Start DRP toggling
[ 566.834009] state change SNK_UNATTACHED -> DRP_TOGGLING
[ 566.837862] CC1: 3 -> 3, CC2: 0 -> 0 [state DRP_TOGGLING, polarity 0, connected]
[ 566.837895] state change DRP_TOGGLING -> SNK_ATTACH_WAIT
[ 566.837936] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms
[ 567.041827] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 567.041856] state change SNK_DEBOUNCED -> SNK_ATTACHED
[ 567.041865] polarity 0
[ 567.043932] Requesting mux state 1, usb-role 2, orientation 1
[ 567.045164] state change SNK_ATTACHED -> SNK_STARTUP
[ 567.045187] state change SNK_STARTUP -> SNK_DISCOVERY
[ 567.045199] Setting voltage/current limit 5000 mV 0 mA
[ 567.045208] vbus=0 charge:=1
[ 567.046615] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES
[ 567.047289] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 240 ms
[ 567.289820] state change SNK_WAIT_CAPABILITIES -> SNK_READY [delayed 240 ms]
=============================================================================
Now the log from the new Kernel 5.15.74:
USB-PD Init:
------------
[ 256.784494] Setting usb_comm capable false
[ 256.791647] Setting voltage/current limit 0 mV 0 mA
[ 256.794207] polarity 0
[ 256.809727] Requesting mux state 0, usb-role 0, orientation 0
[ 256.837483] state change INVALID_STATE -> SNK_UNATTACHED [rev1 NONE_AMS]
[ 256.846618] CC1: 0 -> 0, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, disconnected]
[ 256.846836] Setting usb_comm capable false
[ 256.846766] 3-0050: registered
[ 256.856301] Setting voltage/current limit 0 mV 0 mA
[ 256.857922] polarity 0
[ 256.865372] Requesting mux state 0, usb-role 0, orientation 0
[ 256.872658] cc:=0
[ 256.875081] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev1 NONE_AMS]
[ 256.876241] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 256.876283] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev1 NONE_AMS]
[ 256.876306] Start toggling
[ 256.893542] CC1: 0 -> 0, CC2: 0 -> 0 [state TOGGLING, polarity 0, disconnected]
USB-A to USB-C Cable attach event:
----------------------------------
[ 446.745172] IPv6: ADDRCONF(NETDEV_CHANGE): usb1: link becomes ready
[ 446.347606] VBUS on
[ 446.359827] VBUS on
[ 446.365643] VBUS on
[ 446.443772] CC1: 0 -> 3, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 446.443853] state change TOGGLING -> SNK_ATTACH_WAIT [rev1 NONE_AMS]
[ 446.443975] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev1 NONE_AMS]
[ 446.647478] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 446.647634] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev1 NONE_AMS]
[ 446.647687] polarity 0
[ 446.660017] Requesting mux state 1, usb-role 2, orientation 1
[ 446.665130] state change SNK_ATTACHED -> SNK_STARTUP [rev1 NONE_AMS]
[ 446.665218] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 446.665635] Setting voltage/current limit 5000 mV 0 mA
[ 446.665810] vbus=0 charge:=1
[ 446.670562] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 446.672741] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 446.983091] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND [delayed 310 ms]
[ 446.983189] AMS HARD_RESET start
[ 446.983210] PD TX, type: 0x5
[ 446.992857] PD TX complete, status: 0
[ 446.994940] state change HARD_RESET_SEND -> HARD_RESET_START [rev3 HARD_RESET]
[ 447.007365] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 447.007412] vconn:=0
[ 447.008918] Requesting mux state 1, usb-role 2, orientation 1
[ 447.014308] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 447.664993] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 447.665082] AMS HARD_RESET finished
[ 447.671853] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 447.671932] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 447.671987] Setting voltage/current limit 5000 mV 0 mA
[ 447.672176] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 447.674498] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 447.985276] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND [delayed 310 ms]
[ 447.985359] AMS HARD_RESET start
[ 447.985406] PD TX, type: 0x5
[ 448.010616] PD TX complete, status: 0
[ 448.011377] state change HARD_RESET_SEND -> HARD_RESET_START [rev3 HARD_RESET]
[ 448.031719] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 448.031797] vconn:=0
[ 448.034634] Requesting mux state 1, usb-role 2, orientation 1
[ 448.044759] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 448.695410] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 448.695503] AMS HARD_RESET finished
[ 448.702988] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 448.703071] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 448.703123] Setting voltage/current limit 5000 mV 0 mA
[ 448.703257] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 448.705602] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 310 ms [rev3 NONE_AMS]
[ 449.016365] state change SNK_WAIT_CAPABILITIES -> SNK_READY [delayed 310 ms]
### ISR is blocking the system at this point. Only after detaching the cable was I able to read the log
[ 463.230666] CC1: 3 -> 0, CC2: 0 -> 0 [state SNK_READY, polarity 0, disconnected]
[ 463.230768] state change SNK_READY -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 463.292143] Start toggling
[ 463.352318] CC1: 0 -> 0, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, disconnected]
[ 463.353156] Setting usb_comm capable false
[ 463.368588] Setting voltage/current limit 0 mV 0 mA
[ 463.368710] polarity 0
[ 463.381744] Requesting mux state 0, usb-role 0, orientation 0
[ 463.390057] cc:=0
[ 463.395516] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev3 NONE_AMS]
[ 463.395680] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 463.395733] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 463.395786] Start toggling
[ 463.412692] CC1: 0 -> 0, CC2: 0 -> 0 [state TOGGLING, polarity 0, disconnected]
[ 463.418218] CC1: 0 -> 0, CC2: 0 -> 0 [state TOGGLING, polarity 0, disconnected]
USB-PD capable power supply attach event:
-----------------------------------------
[ 826.768426] CC1: 0 -> 5, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 826.768509] state change TOGGLING -> SNK_ATTACH_WAIT [rev3 HARD_RESET]
[ 826.768627] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev3 HARD_RESET]
[ 826.893156] VBUS on
[ 826.904557] VBUS on
[ 826.910508] VBUS on
[ 826.971690] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 826.971726] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev3 HARD_RESET]
[ 826.971741] polarity 0
[ 826.980352] Requesting mux state 1, usb-role 2, orientation 1
[ 826.981887] state change SNK_ATTACHED -> SNK_STARTUP [rev3 HARD_RESET]
[ 826.981917] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 HARD_RESET]
[ 826.981935] Setting voltage/current limit 5000 mV 3000 mA
[ 826.982003] vbus=0 charge:=1
[ 826.984458] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 HARD_RESET]
[ 826.985671] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 HARD_RESET]
[ 827.108627] PD RX, header: 0x61a1 [1]
[ 827.108711] PDO 0: type 0, 5000 mV, 3000 mA [DE]
[ 827.108760] PDO 1: type 0, 9000 mV, 3000 mA []
[ 827.108801] PDO 2: type 0, 12000 mV, 3000 mA []
[ 827.108841] PDO 3: type 0, 15000 mV, 3000 mA []
[ 827.108881] PDO 4: type 0, 18900 mV, 3000 mA []
[ 827.108921] PDO 5: type 0, 20000 mV, 3000 mA []
[ 827.108957] state change SNK_WAIT_CAPABILITIES -> SNK_NEGOTIATE_CAPABILITIES [rev3 POWER_NEGOTIATION]
[ 827.109079] Setting usb_comm capable false
[ 827.109216] cc=0 cc1=5 cc2=0 vbus=0 vconn=sink polarity=0
[ 827.109263] Requesting PDO 5: 20000 mV, 3000 mA
[ 827.109298] PD TX, header: 0x1082
[ 827.159596] Setting usb_comm capable false
[ 827.169005] Setting voltage/current limit 0 mV 0 mA
[ 827.169099] polarity 0
[ 827.182015] Requesting mux state 0, usb-role 0, orientation 0
[ 827.192980] state change SNK_NEGOTIATE_CAPABILITIES -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 827.198398] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 827.198464] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 827.198499] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 827.198540] PD TX complete, status: 2
[ 827.198852] state change PORT_RESET -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 827.201434] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 827.201597] Received hard reset
[ 827.201625] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 827.209157] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 827.209224] vconn:=0
[ 827.212481] Requesting mux state 1, usb-role 2, orientation 1
[ 827.215281] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 827.868854] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 827.868923] AMS HARD_RESET finished
[ 827.871858] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 827.871918] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 827.871956] pending state change SNK_DISCOVERY -> HARD_RESET_SEND @ 10000 ms [rev3 NONE_AMS]
[ 827.961711] VBUS on
[ 827.961769] state change SNK_DISCOVERY -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 827.961898] Setting voltage/current limit 5000 mV 3000 mA
[ 827.962048] vbus=0 charge:=1
[ 827.972701] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 827.975008] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 827.983446] VBUS on
[ 827.986223] VBUS on
[ 827.997210] VBUS on
[ 828.175355] PD RX, header: 0x61a1 [0]
[ 828.181699] Received hard reset
[ 828.181749] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 828.202553] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 828.202621] vconn:=0
[ 828.205308] Requesting mux state 1, usb-role 2, orientation 1
[ 828.214671] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 828.229807] Setting usb_comm capable false
[ 828.239381] Setting voltage/current limit 0 mV 0 mA
[ 828.239534] polarity 0
[ 828.252334] Requesting mux state 0, usb-role 0, orientation 0
[ 828.263656] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 828.269095] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 828.269159] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 828.269218] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 828.269522] Setting usb_comm capable false
[ 828.279409] Setting voltage/current limit 0 mV 0 mA
[ 828.279506] polarity 0
[ 828.292304] Requesting mux state 0, usb-role 0, orientation 0
[ 828.300793] cc:=0
[ 828.305888] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev3 NONE_AMS]
[ 828.306038] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 828.306079] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 828.306117] Start toggling
[ 828.310980] state change SNK_UNATTACHED -> TOGGLING [rev3 NONE_AMS]
[ 828.322643] CC1: 5 -> 5, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 828.322713] state change TOGGLING -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 828.322837] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev3 NONE_AMS]
[ 828.526334] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 829.027912] VBUS on
[ 829.027969] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev3 NONE_AMS]
[ 829.028081] polarity 0
[ 829.052206] Requesting mux state 1, usb-role 2, orientation 1
[ 829.055175] state change SNK_ATTACHED -> SNK_STARTUP [rev3 NONE_AMS]
[ 829.055233] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 829.055273] Setting voltage/current limit 5000 mV 3000 mA
[ 829.055419] vbus=0 charge:=1
[ 829.059645] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 829.062077] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 310 ms [rev3 NONE_AMS]
[ 829.064903] VBUS on
[ 829.241900] PD RX, header: 0x61a1 [1]
[ 829.241980] PDO 0: type 0, 5000 mV, 3000 mA [DE]
[ 829.242025] PDO 1: type 0, 9000 mV, 3000 mA []
[ 829.242066] PDO 2: type 0, 12000 mV, 3000 mA []
[ 829.242107] PDO 3: type 0, 15000 mV, 3000 mA []
[ 829.242147] PDO 4: type 0, 18900 mV, 3000 mA []
[ 829.242187] PDO 5: type 0, 20000 mV, 3000 mA []
[ 829.242223] state change SNK_WAIT_CAPABILITIES -> SNK_NEGOTIATE_CAPABILITIES [rev3 POWER_NEGOTIATION]
[ 829.242346] Setting usb_comm capable false
[ 829.242487] cc=0 cc1=5 cc2=0 vbus=0 vconn=sink polarity=0
[ 829.242531] Requesting PDO 5: 20000 mV, 3000 mA
[ 829.242567] PD TX, header: 0x1082
[ 829.293636] Setting usb_comm capable false
[ 829.303004] Setting voltage/current limit 0 mV 0 mA
[ 829.303099] polarity 0
[ 829.315711] Requesting mux state 0, usb-role 0, orientation 0
[ 829.326763] state change SNK_NEGOTIATE_CAPABILITIES -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 829.332550] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 829.332619] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 829.332654] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 829.332692] PD TX complete, status: 2
[ 829.333002] state change PORT_RESET -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 829.335248] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 829.335405] Received hard reset
[ 829.335433] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 829.343489] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 829.343548] vconn:=0
[ 829.346261] Requesting mux state 1, usb-role 2, orientation 1
[ 829.349054] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 830.002616] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 830.002685] AMS HARD_RESET finished
[ 830.005098] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 830.005156] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 830.005197] pending state change SNK_DISCOVERY -> HARD_RESET_SEND @ 10000 ms [rev3 NONE_AMS]
[ 830.092822] VBUS on
[ 830.092880] state change SNK_DISCOVERY -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 830.093011] Setting voltage/current limit 5000 mV 3000 mA
[ 830.093162] vbus=0 charge:=1
[ 830.103484] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 830.105769] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 830.114579] VBUS on
[ 830.117251] VBUS on
[ 830.128552] VBUS on
[ 830.308729] PD RX, header: 0x61a1 [0]
[ 830.315066] Received hard reset
[ 830.315115] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 830.335975] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 830.336043] vconn:=0
[ 830.338846] Requesting mux state 1, usb-role 2, orientation 1
[ 830.348224] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 830.363848] Setting usb_comm capable false
[ 830.373342] Setting voltage/current limit 0 mV 0 mA
[ 830.373492] polarity 0
[ 830.386127] Requesting mux state 0, usb-role 0, orientation 0
[ 830.397083] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 830.402808] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 830.402878] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 830.402936] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 830.403243] Setting usb_comm capable false
[ 830.412686] Setting voltage/current limit 0 mV 0 mA
[ 830.412787] polarity 0
[ 830.425143] Requesting mux state 0, usb-role 0, orientation 0
[ 830.433883] cc:=0
[ 830.438861] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev3 NONE_AMS]
[ 830.439010] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 830.439050] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 830.439087] Start toggling
[ 830.444098] state change SNK_UNATTACHED -> TOGGLING [rev3 NONE_AMS]
[ 830.455846] CC1: 5 -> 5, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 830.455917] state change TOGGLING -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 830.456045] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev3 NONE_AMS]
[ 830.659546] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 831.160863] VBUS on
[ 831.160920] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev3 NONE_AMS]
[ 831.161028] polarity 0
[ 831.185034] Requesting mux state 1, usb-role 2, orientation 1
[ 831.188004] state change SNK_ATTACHED -> SNK_STARTUP [rev3 NONE_AMS]
[ 831.188062] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 831.188102] Setting voltage/current limit 5000 mV 3000 mA
[ 831.188250] vbus=0 charge:=1
[ 831.192929] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 831.195063] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 310 ms [rev3 NONE_AMS]
[ 831.197744] VBUS on
[ 831.374580] PD RX, header: 0x61a1 [1]
[ 831.374660] PDO 0: type 0, 5000 mV, 3000 mA [DE]
[ 831.374707] PDO 1: type 0, 9000 mV, 3000 mA []
[ 831.374748] PDO 2: type 0, 12000 mV, 3000 mA []
[ 831.374790] PDO 3: type 0, 15000 mV, 3000 mA []
[ 831.374830] PDO 4: type 0, 18900 mV, 3000 mA []
[ 831.374870] PDO 5: type 0, 20000 mV, 3000 mA []
[ 831.374906] state change SNK_WAIT_CAPABILITIES -> SNK_NEGOTIATE_CAPABILITIES [rev3 POWER_NEGOTIATION]
[ 831.375032] Setting usb_comm capable false
[ 831.375177] cc=0 cc1=5 cc2=0 vbus=0 vconn=sink polarity=0
[ 831.375221] Requesting PDO 5: 20000 mV, 3000 mA
[ 831.375258] PD TX, header: 0x1082
[ 831.426768] Setting usb_comm capable false
[ 831.436181] Setting voltage/current limit 0 mV 0 mA
[ 831.436279] polarity 0
[ 831.448776] Requesting mux state 0, usb-role 0, orientation 0
[ 831.459690] state change SNK_NEGOTIATE_CAPABILITIES -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 831.465398] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 831.465468] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 831.465503] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 831.465541] PD TX complete, status: 2
[ 831.465853] state change PORT_RESET -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 831.468123] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 831.468279] Received hard reset
[ 831.468308] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 831.476495] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 831.476558] vconn:=0
[ 831.479360] Requesting mux state 1, usb-role 2, orientation 1
[ 831.482403] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 832.135981] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 832.136053] AMS HARD_RESET finished
[ 832.138377] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 832.138433] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 832.138472] pending state change SNK_DISCOVERY -> HARD_RESET_SEND @ 10000 ms [rev3 NONE_AMS]
[ 832.228209] VBUS on
[ 832.228265] state change SNK_DISCOVERY -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 832.228395] Setting voltage/current limit 5000 mV 3000 mA
[ 832.228544] vbus=0 charge:=1
[ 832.239282] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 832.241912] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 832.250466] VBUS on
[ 832.253173] VBUS on
[ 832.264235] VBUS on
[ 832.442716] PD RX, header: 0x61a1 [0]
[ 832.448663] Received hard reset
[ 832.448708] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 832.469385] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 832.469449] vconn:=0
[ 832.472224] Requesting mux state 1, usb-role 2, orientation 1
[ 832.481771] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 832.496945] Setting usb_comm capable false
[ 832.506399] Setting voltage/current limit 0 mV 0 mA
[ 832.506554] polarity 0
[ 832.519367] Requesting mux state 0, usb-role 0, orientation 0
[ 832.530881] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 832.536387] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 832.536452] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 832.536510] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 832.536812] Setting usb_comm capable false
[ 832.546428] Setting voltage/current limit 0 mV 0 mA
[ 832.546527] polarity 0
[ 832.559025] Requesting mux state 0, usb-role 0, orientation 0
[ 832.567562] cc:=0
[ 832.572992] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev3 NONE_AMS]
[ 832.573138] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 832.573179] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 832.573219] Start toggling
[ 832.577847] state change SNK_UNATTACHED -> TOGGLING [rev3 NONE_AMS]
[ 832.589556] CC1: 5 -> 5, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 832.589625] state change TOGGLING -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 832.589754] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev3 NONE_AMS]
[ 832.793127] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 833.292447] VBUS on
[ 833.292505] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev3 NONE_AMS]
[ 833.292615] polarity 0
[ 833.316496] Requesting mux state 1, usb-role 2, orientation 1
[ 833.319533] state change SNK_ATTACHED -> SNK_STARTUP [rev3 NONE_AMS]
[ 833.319592] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 833.319630] Setting voltage/current limit 5000 mV 3000 mA
[ 833.319781] vbus=0 charge:=1
[ 833.324316] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 833.326456] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 310 ms [rev3 NONE_AMS]
[ 833.329106] VBUS on
[ 833.508682] PD RX, header: 0x61a1 [1]
[ 833.508766] PDO 0: type 0, 5000 mV, 3000 mA [DE]
[ 833.508813] PDO 1: type 0, 9000 mV, 3000 mA []
[ 833.508855] PDO 2: type 0, 12000 mV, 3000 mA []
[ 833.508895] PDO 3: type 0, 15000 mV, 3000 mA []
[ 833.508935] PDO 4: type 0, 18900 mV, 3000 mA []
[ 833.508975] PDO 5: type 0, 20000 mV, 3000 mA []
[ 833.509011] state change SNK_WAIT_CAPABILITIES -> SNK_NEGOTIATE_CAPABILITIES [rev3 POWER_NEGOTIATION]
[ 833.509133] Setting usb_comm capable false
[ 833.509274] cc=0 cc1=5 cc2=0 vbus=0 vconn=sink polarity=0
[ 833.509319] Requesting PDO 5: 20000 mV, 3000 mA
[ 833.509356] PD TX, header: 0x1082
[ 833.559278] Setting usb_comm capable false
[ 833.568621] Setting voltage/current limit 0 mV 0 mA
[ 833.568715] polarity 0
[ 833.581360] Requesting mux state 0, usb-role 0, orientation 0
[ 833.592425] state change SNK_NEGOTIATE_CAPABILITIES -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 833.597768] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 833.597832] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 833.597866] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 833.597907] PD TX complete, status: 2
[ 833.598219] state change PORT_RESET -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 833.600853] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 833.601013] Received hard reset
[ 833.601042] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 833.608667] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 833.608724] vconn:=0
[ 833.611758] Requesting mux state 1, usb-role 2, orientation 1
[ 833.614525] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 834.268087] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 834.268158] AMS HARD_RESET finished
[ 834.270888] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 834.270942] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 834.270978] pending state change SNK_DISCOVERY -> HARD_RESET_SEND @ 10000 ms [rev3 NONE_AMS]
[ 834.361893] VBUS on
[ 834.361950] state change SNK_DISCOVERY -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 834.362079] Setting voltage/current limit 5000 mV 3000 mA
[ 834.362232] vbus=0 charge:=1
[ 834.373148] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 834.375423] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 834.383993] VBUS on
[ 834.386675] VBUS on
[ 834.397691] VBUS on
[ 834.576163] PD RX, header: 0x61a1 [0]
[ 834.582359] Received hard reset
[ 834.582406] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 834.602442] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 834.602503] vconn:=0
[ 834.605196] Requesting mux state 1, usb-role 2, orientation 1
[ 834.614511] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 834.629493] Setting usb_comm capable false
[ 834.638823] Setting voltage/current limit 0 mV 0 mA
[ 834.638994] polarity 0
[ 834.651863] Requesting mux state 0, usb-role 0, orientation 0
[ 834.662953] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 834.668385] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 834.668462] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 834.668523] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 834.668852] Setting usb_comm capable false
[ 834.678503] Setting voltage/current limit 0 mV 0 mA
[ 834.678600] polarity 0
[ 834.691321] Requesting mux state 0, usb-role 0, orientation 0
[ 834.699426] cc:=0
[ 834.704750] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev3 NONE_AMS]
[ 834.704893] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 834.704933] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 834.704972] Start toggling
[ 834.709557] state change SNK_UNATTACHED -> TOGGLING [rev3 NONE_AMS]
[ 834.721353] CC1: 5 -> 5, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 834.721424] state change TOGGLING -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 834.721553] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev3 NONE_AMS]
[ 834.925070] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 835.428159] VBUS on
[ 835.428217] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev3 NONE_AMS]
[ 835.428345] polarity 0
[ 835.452702] Requesting mux state 1, usb-role 2, orientation 1
[ 835.455663] state change SNK_ATTACHED -> SNK_STARTUP [rev3 NONE_AMS]
[ 835.455720] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 835.455759] Setting voltage/current limit 5000 mV 3000 mA
[ 835.455910] vbus=0 charge:=1
[ 835.460564] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 835.462704] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 310 ms [rev3 NONE_AMS]
[ 835.465371] VBUS on
[ 835.642076] PD RX, header: 0x61a1 [1]
[ 835.642159] PDO 0: type 0, 5000 mV, 3000 mA [DE]
[ 835.642205] PDO 1: type 0, 9000 mV, 3000 mA []
[ 835.642247] PDO 2: type 0, 12000 mV, 3000 mA []
[ 835.642287] PDO 3: type 0, 15000 mV, 3000 mA []
[ 835.642328] PDO 4: type 0, 18900 mV, 3000 mA []
[ 835.642368] PDO 5: type 0, 20000 mV, 3000 mA []
[ 835.642405] state change SNK_WAIT_CAPABILITIES -> SNK_NEGOTIATE_CAPABILITIES [rev3 POWER_NEGOTIATION]
[ 835.642528] Setting usb_comm capable false
[ 835.642671] cc=0 cc1=5 cc2=0 vbus=0 vconn=sink polarity=0
[ 835.642716] Requesting PDO 5: 20000 mV, 3000 mA
[ 835.642751] PD TX, header: 0x1082
[ 835.693384] Setting usb_comm capable false
[ 835.702717] Setting voltage/current limit 0 mV 0 mA
[ 835.702814] polarity 0
[ 835.715221] Requesting mux state 0, usb-role 0, orientation 0
[ 835.726392] state change SNK_NEGOTIATE_CAPABILITIES -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 835.732286] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 835.732362] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 835.732403] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 835.732449] PD TX complete, status: 2
[ 835.732791] state change PORT_RESET -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 835.735053] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 835.735209] Received hard reset
[ 835.735237] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 835.743140] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 835.743198] vconn:=0
[ 835.745877] Requesting mux state 1, usb-role 2, orientation 1
[ 835.748830] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 836.402423] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 836.402492] AMS HARD_RESET finished
[ 836.404809] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 836.404861] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 836.404899] pending state change SNK_DISCOVERY -> HARD_RESET_SEND @ 10000 ms [rev3 NONE_AMS]
[ 836.492168] VBUS on
[ 836.492229] state change SNK_DISCOVERY -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 836.492376] Setting voltage/current limit 5000 mV 3000 mA
[ 836.492535] vbus=0 charge:=1
[ 836.503274] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 836.505544] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 836.514069] VBUS on
[ 836.516750] VBUS on
[ 836.527817] VBUS on
[ 836.707649] PD RX, header: 0x61a1 [0]
[ 836.713553] Received hard reset
[ 836.713599] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 836.733083] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 836.733145] vconn:=0
[ 836.735857] Requesting mux state 1, usb-role 2, orientation 1
[ 836.744888] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 836.760542] Setting usb_comm capable false
[ 836.769399] Setting voltage/current limit 0 mV 0 mA
[ 836.769563] polarity 0
[ 836.782089] Requesting mux state 0, usb-role 0, orientation 0
[ 836.792748] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 836.798194] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 836.798260] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 836.798318] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 836.798617] Setting usb_comm capable false
[ 836.807762] Setting voltage/current limit 0 mV 0 mA
[ 836.807855] polarity 0
[ 836.819915] Requesting mux state 0, usb-role 0, orientation 0
[ 836.828230] cc:=0
[ 836.833634] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev3 NONE_AMS]
[ 836.833789] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 836.833829] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 836.833868] Start toggling
[ 836.838410] state change SNK_UNATTACHED -> TOGGLING [rev3 NONE_AMS]
[ 836.849857] CC1: 5 -> 5, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 836.849929] state change TOGGLING -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 836.850061] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev3 NONE_AMS]
[ 837.053117] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 837.561556] VBUS on
[ 837.561614] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev3 NONE_AMS]
[ 837.561721] polarity 0
[ 837.585787] Requesting mux state 1, usb-role 2, orientation 1
[ 837.588793] state change SNK_ATTACHED -> SNK_STARTUP [rev3 NONE_AMS]
[ 837.588852] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 837.588891] Setting voltage/current limit 5000 mV 3000 mA
[ 837.589041] vbus=0 charge:=1
[ 837.593658] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 837.595772] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 310 ms [rev3 NONE_AMS]
[ 837.598462] VBUS on
[ 837.776218] PD RX, header: 0x61a1 [1]
[ 837.776298] PDO 0: type 0, 5000 mV, 3000 mA [DE]
[ 837.776345] PDO 1: type 0, 9000 mV, 3000 mA []
[ 837.776387] PDO 2: type 0, 12000 mV, 3000 mA []
[ 837.776428] PDO 3: type 0, 15000 mV, 3000 mA []
[ 837.776468] PDO 4: type 0, 18900 mV, 3000 mA []
[ 837.776508] PDO 5: type 0, 20000 mV, 3000 mA []
[ 837.776543] state change SNK_WAIT_CAPABILITIES -> SNK_NEGOTIATE_CAPABILITIES [rev3 POWER_NEGOTIATION]
[ 837.776665] Setting usb_comm capable false
[ 837.776800] cc=0 cc1=5 cc2=0 vbus=0 vconn=sink polarity=0
[ 837.776844] Requesting PDO 5: 20000 mV, 3000 mA
[ 837.776879] PD TX, header: 0x1082
[ 837.825886] Setting usb_comm capable false
[ 837.835072] Setting voltage/current limit 0 mV 0 mA
[ 837.835173] polarity 0
[ 837.847308] Requesting mux state 0, usb-role 0, orientation 0
[ 837.858190] state change SNK_NEGOTIATE_CAPABILITIES -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 837.863918] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 837.863988] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 837.864023] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 837.864063] PD TX complete, status: 2
[ 837.864374] state change PORT_RESET -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 837.866579] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 837.866735] Received hard reset
[ 837.866764] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 837.874698] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 837.874766] vconn:=0
[ 837.877384] Requesting mux state 1, usb-role 2, orientation 1
[ 837.880541] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 838.533408] state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON [delayed 650 ms]
[ 838.533476] AMS HARD_RESET finished
[ 838.536041] state change SNK_HARD_RESET_SINK_ON -> SNK_STARTUP [rev3 NONE_AMS]
[ 838.536096] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 838.536132] pending state change SNK_DISCOVERY -> HARD_RESET_SEND @ 10000 ms [rev3 NONE_AMS]
[ 838.625719] VBUS on
[ 838.625777] state change SNK_DISCOVERY -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 838.625909] Setting voltage/current limit 5000 mV 3000 mA
[ 838.626117] vbus=0 charge:=1
[ 838.636737] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 838.638997] pending state change SNK_WAIT_CAPABILITIES -> HARD_RESET_SEND @ 310 ms [rev3 NONE_AMS]
[ 838.647388] VBUS on
[ 838.650058] VBUS on
[ 838.661358] VBUS on
[ 838.841466] PD RX, header: 0x61a1 [0]
[ 838.847267] Received hard reset
[ 838.847310] state change SNK_WAIT_CAPABILITIES -> HARD_RESET_START [rev3 HARD_RESET]
[ 838.867145] state change HARD_RESET_START -> SNK_HARD_RESET_SINK_OFF [rev3 HARD_RESET]
[ 838.867209] vconn:=0
[ 838.869904] Requesting mux state 1, usb-role 2, orientation 1
[ 838.879143] pending state change SNK_HARD_RESET_SINK_OFF -> SNK_HARD_RESET_SINK_ON @ 650 ms [rev3 HARD_RESET]
[ 838.894564] Setting usb_comm capable false
[ 838.903822] Setting voltage/current limit 0 mV 0 mA
[ 838.903978] polarity 0
[ 838.916640] Requesting mux state 0, usb-role 0, orientation 0
[ 838.927675] state change SNK_HARD_RESET_SINK_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 838.933416] CC1: 5 -> 5, CC2: 0 -> 0 [state SNK_UNATTACHED, polarity 0, connected]
[ 838.933486] state change SNK_UNATTACHED -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 838.933545] state change SNK_ATTACH_WAIT -> PORT_RESET [rev3 NONE_AMS]
[ 838.933854] Setting usb_comm capable false
[ 838.943491] Setting voltage/current limit 0 mV 0 mA
[ 838.943597] polarity 0
[ 838.956130] Requesting mux state 0, usb-role 0, orientation 0
[ 838.964257] cc:=0
[ 838.969176] pending state change PORT_RESET -> PORT_RESET_WAIT_OFF @ 100 ms [rev3 NONE_AMS]
[ 838.969321] state change PORT_RESET -> PORT_RESET_WAIT_OFF [delayed 100 ms]
[ 838.969361] state change PORT_RESET_WAIT_OFF -> SNK_UNATTACHED [rev3 NONE_AMS]
[ 838.969399] Start toggling
[ 838.974114] state change SNK_UNATTACHED -> TOGGLING [rev3 NONE_AMS]
[ 838.985743] CC1: 5 -> 5, CC2: 0 -> 0 [state TOGGLING, polarity 0, connected]
[ 838.985816] state change TOGGLING -> SNK_ATTACH_WAIT [rev3 NONE_AMS]
[ 838.985953] pending state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED @ 200 ms [rev3 NONE_AMS]
[ 839.189282] state change SNK_ATTACH_WAIT -> SNK_DEBOUNCED [delayed 200 ms]
[ 839.695231] VBUS on
[ 839.695287] state change SNK_DEBOUNCED -> SNK_ATTACHED [rev3 NONE_AMS]
[ 839.695395] polarity 0
[ 839.719424] Requesting mux state 1, usb-role 2, orientation 1
[ 839.722649] state change SNK_ATTACHED -> SNK_STARTUP [rev3 NONE_AMS]
[ 839.722708] state change SNK_STARTUP -> SNK_DISCOVERY [rev3 NONE_AMS]
[ 839.722747] Setting voltage/current limit 5000 mV 3000 mA
[ 839.722899] vbus=0 charge:=1
[ 839.727145] state change SNK_DISCOVERY -> SNK_WAIT_CAPABILITIES [rev3 NONE_AMS]
[ 839.729327] pending state change SNK_WAIT_CAPABILITIES -> SNK_READY @ 310 ms [rev3 NONE_AMS]
[ 839.732221] VBUS on
[ 839.894447] PD RX, header: 0x61a1 [1]
[ 839.894486] PDO 0: type 0, 5000 mV, 3000 mA [DE]
[ 839.894509] PDO 1: type 0, 9000 mV, 3000 mA []
[ 839.894526] PDO 2: type 0, 12000 mV, 3000 mA []
[ 839.894542] PDO 3: type 0, 15000 mV, 3000 mA []
[ 839.894558] PDO 4: type 0, 18900 mV, 3000 mA []
[ 839.894573] PDO 5: type 0, 20000 mV, 3000 mA []
[ 839.894592] state change SNK_WAIT_CAPABILITIES -> SNK_NEGOTIATE_CAPABILITIES [rev3 POWER_NEGOTIATION]
[ 839.894646] Setting usb_comm capable false
[ 839.894750] cc=0 cc1=5 cc2=0 vbus=0 vconn=sink polarity=0
[ 839.894772] Requesting PDO 5: 20000 mV, 3000 mA
[ 839.894787] PD TX, header: 0x1082
[ 839.905398] PD TX complete, status: 0
[ 839.905668] pending state change SNK_NEGOTIATE_CAPABILITIES -> HARD_RESET_SEND @ 60 ms [rev3 POWER_NEGOTIATION]
[ 839.914091] PD RX, header: 0x3a3 [1]
[ 839.914126] state change SNK_NEGOTIATE_CAPABILITIES -> SNK_TRANSITION_SINK [rev3 POWER_NEGOTIATION]
[ 839.914181] Setting standby current 5000 mV @ 500 mA
[ 839.914195] Setting voltage/current limit 5000 mV 500 mA
[ 839.914299] pending state change SNK_TRANSITION_SINK -> HARD_RESET_SEND @ 500 ms [rev3 POWER_NEGOTIATION]
[ 840.189160] PD RX, header: 0x5a6 [1]
[ 840.189224] Setting voltage/current limit 20000 mV 3000 mA
[ 840.189362] state change SNK_TRANSITION_SINK -> SNK_READY [rev3 POWER_NEGOTIATION]
[ 840.192758] AMS POWER_NEGOTIATION finished
[ 840.193054] AMS DISCOVER_IDENTITY start
[ 840.193140] PD TX, header: 0x128f
[ 840.211568] PD TX complete, status: 0
[ 840.234728] PD RX, header: 0x47af [1]
[ 840.234788] Rx VDM cmd 0xff00a041 type 1 cmd 1 len 4
[ 840.234871] AMS DISCOVER_IDENTITY finished
[ 840.235846] Identity: 03f0:0000.f603
[ 840.236012] AMS DISCOVER_SVIDS start
[ 840.236097] PD TX, header: 0x148f
[ 840.266351] PD TX complete, status: 0
[ 840.266753] PD RX, header: 0x19af [1]
[ 840.266799] Rx VDM cmd 0xff00a081 type 2 cmd 1 len 1
[ 840.266881] AMS DISCOVER_SVIDS finished
[ 840.293192] AMS GET_SINK_CAPABILITIES start
[ 840.293222] state change SNK_READY -> AMS_START [rev3 GET_SINK_CAPABILITIES]
[ 840.293262] state change AMS_START -> GET_SINK_CAP [rev3 GET_SINK_CAPABILITIES]
[ 840.293279] PD TX, header: 0x688
[ 840.301621] PD TX complete, status: 0
[ 840.301892] pending state change GET_SINK_CAP -> GET_SINK_CAP_TIMEOUT @ 60 ms [rev3 GET_SINK_CAPABILITIES]
[ 840.309127] PD RX, header: 0xbb0 [1]
[ 840.309161] state change GET_SINK_CAP -> SNK_READY [rev3 GET_SINK_CAPABILITIES]
[ 840.309226] AMS GET_SINK_CAPABILITIES finished
