[55.374781] Initializing watchdogs [55.374826] /dev/watchdog0 [55.387572] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [55.391583] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.393571] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.396719] [001/131] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [55.504123] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [56.759818] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.278s) [57.042610] [002/131] (958s left) kms_feature_discovery (chamelium) [57.145767] Starting subtest: chamelium [57.149961] Subtest chamelium: SKIP (0.000s) [57.205760] [003/131] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [57.304240] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [57.308679] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [57.377921] [004/131] (958s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [57.478849] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [58.488658] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.022s) [58.667282] [005/131] (957s left) kms_cursor_edge_walk (64x64-top-bottom) [58.770903] Starting subtest: 64x64-top-bottom [58.774629] Starting dynamic subtest: pipe-A-eDP-1 [62.184128] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s) [62.190641] Starting dynamic subtest: pipe-D-eDP-1 [65.275559] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s) [65.277896] Subtest 64x64-top-bottom: SUCCESS (6.551s) [66.080954] [006/131] (949s left) kms_flip (dpms-vs-vblank-race-interruptible) [66.174901] Starting subtest: dpms-vs-vblank-race-interruptible [66.177148] Starting dynamic subtest: A-eDP1 [71.153257] Dynamic subtest A-eDP1: SUCCESS (4.989s) [71.161654] Starting dynamic subtest: B-eDP1 [75.752656] Dynamic subtest B-eDP1: SUCCESS (4.605s) [75.760854] Starting dynamic subtest: C-eDP1 [80.330357] Dynamic subtest C-eDP1: SUCCESS (4.584s) [80.338720] Starting dynamic subtest: D-eDP1 [84.930608] Dynamic subtest D-eDP1: SUCCESS (4.599s) [84.933143] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.783s) [85.712821] [007/131] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [85.832342] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [85.836779] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [85.935216] [008/131] (930s left) kms_getfb (getfb2-handle-closed) [85.987985] Starting subtest: getfb2-handle-closed [85.990458] Subtest getfb2-handle-closed: SUCCESS (0.000s) [86.069713] [009/131] (929s left) syncobj_timeline (wait-all-interrupted) [86.126819] Starting subtest: wait-all-interrupted [86.231344] Subtest wait-all-interrupted: SUCCESS (0.102s) [86.297237] [010/131] (929s left) gem_gpgpu_fill (basic) [86.355611] Starting subtest: basic [86.357813] Starting dynamic subtest: smem [86.361923] Dynamic subtest smem: SUCCESS (0.008s) [86.364197] Subtest basic: SUCCESS (0.008s) [86.492312] [011/131] (929s left) kms_psr (psr-cursor-plane-move) [86.584087] Starting subtest: psr-cursor-plane-move [86.586469] Starting dynamic subtest: eDP-1 [88.305944] Dynamic subtest eDP-1: SUCCESS (1.719s) [88.308110] Subtest psr-cursor-plane-move: SUCCESS (1.719s) [89.158307] [012/131] (926s left) device_reset (unbind-reset-rebind) [89.205907] Starting subtest: unbind-reset-rebind [93.883948] Subtest unbind-reset-rebind: SUCCESS (4.674s) [93.912801] [013/131] (922s left) kms_big_fb (linear-addfb) [94.025491] Starting subtest: linear-addfb [94.027846] Subtest linear-addfb: SUCCESS (0.000s) [94.127932] [014/131] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [94.237592] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [98.564506] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.329s) [98.674201] [015/131] (917s left) gem_exec_params (no-bsd) [98.741552] Starting subtest: no-bsd [98.743741] Subtest no-bsd: SUCCESS (0.002s) [100.038534] [016/131] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [105.038863] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [105.041231] Starting dynamic subtest: pipe-A-eDP-1 [105.819938] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s) [105.828170] Starting dynamic subtest: pipe-B-eDP-1 [106.940072] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s) [106.944344] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.899s) [108.105161] [017/131] (908s left) kms_rotation_crc (sprite-rotation-270) [108.220036] Starting subtest: sprite-rotation-270 [108.224502] Subtest sprite-rotation-270: SKIP (0.001s) [108.285711] [018/131] (908s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [108.389967] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [108.394295] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [108.477950] [019/131] (907s left) kms_scaling_modes (scaling-mode-full-aspect) [108.575028] Starting subtest: scaling-mode-full-aspect [108.577317] Starting dynamic subtest: pipe-A-eDP-1 [108.685028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s) [108.691953] Starting dynamic subtest: pipe-B-eDP-1 [109.836675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s) [109.844444] Starting dynamic subtest: pipe-C-eDP-1 [110.946172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s) [110.956622] Starting dynamic subtest: pipe-D-eDP-1 [112.072485] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [112.074974] Subtest scaling-mode-full-aspect: SUCCESS (3.497s) [113.214190] [020/131] (903s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [118.266312] Starting subtest: pr-overlay-plane-move-continuous-sf [118.271377] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [119.114749] [021/131] (897s left) kms_async_flips (test-cursor) [119.211770] Starting subtest: test-cursor [119.216135] Subtest test-cursor: SKIP (0.000s) [120.439604] [022/131] (895s left) gem_mmap_offset (clear) [120.500104] Starting subtest: clear [120.502276] Starting dynamic subtest: smem0 [145.396755] Dynamic subtest smem0: SUCCESS (24.892s) [145.399086] Subtest clear: SUCCESS (24.893s) [145.689798] [023/131] (870s left) kms_flip (2x-flip-vs-rmfb-interruptible) [145.835778] Starting subtest: 2x-flip-vs-rmfb-interruptible [145.848468] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s) [145.913408] [024/131] (870s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [146.014955] Starting subtest: bad-rotation-90-y-tiled-ccs [146.017322] Starting dynamic subtest: pipe-A-eDP-1 [146.047228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [146.055646] Starting dynamic subtest: pipe-B-eDP-1 [146.076688] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [146.083989] Starting dynamic subtest: pipe-C-eDP-1 [146.105211] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [146.112420] Starting dynamic subtest: pipe-D-eDP-1 [146.135091] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [146.139719] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s) [148.187052] [025/131] (868s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [148.286764] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [148.289109] Starting dynamic subtest: pipe-A-eDP-1 [148.312136] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [148.321372] Starting dynamic subtest: pipe-B-eDP-1 [148.343762] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [148.350552] Starting dynamic subtest: pipe-C-eDP-1 [148.372808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [148.379661] Starting dynamic subtest: pipe-D-eDP-1 [148.402113] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [148.406620] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s) [150.435809] [026/131] (866s left) kms_addfb_basic (addfb25-bad-modifier) [150.541085] Starting subtest: addfb25-bad-modifier [150.543323] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [150.645543] [027/131] (865s left) gem_exec_alignment (forked) [150.703984] Starting subtest: forked [186.733752] Subtest forked: SUCCESS (36.025s) [186.796964] [028/131] (829s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [186.927029] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [191.517132] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.593s) [191.630488] [029/131] (825s left) kms_flip (plain-flip-fb-recreate) [191.722935] Starting subtest: plain-flip-fb-recreate [191.725250] Starting dynamic subtest: A-eDP1 [200.674032] Dynamic subtest A-eDP1: SUCCESS (8.949s) [200.682404] Starting dynamic subtest: B-eDP1 [209.597219] Dynamic subtest B-eDP1: SUCCESS (8.922s) [209.605949] Starting dynamic subtest: C-eDP1 [218.506434] Dynamic subtest C-eDP1: SUCCESS (8.908s) [218.514722] Starting dynamic subtest: D-eDP1 [227.327636] Dynamic subtest D-eDP1: SUCCESS (8.820s) [227.329677] Subtest plain-flip-fb-recreate: SUCCESS (35.608s) [228.503423] [030/131] (788s left) sysfs_heartbeat_interval (invalid) [228.569118] Starting subtest: invalid [228.571705] Starting dynamic subtest: vecs0 [228.574208] Dynamic subtest vecs0: SUCCESS (0.000s) [228.583707] Starting dynamic subtest: ccs0 [228.585647] Dynamic subtest ccs0: SUCCESS (0.000s) [228.593074] Starting dynamic subtest: vcs0 [228.595175] Dynamic subtest vcs0: SUCCESS (0.000s) [228.604361] Starting dynamic subtest: bcs0 [228.606339] Dynamic subtest bcs0: SUCCESS (0.000s) [228.613263] Starting dynamic subtest: rcs0 [228.615216] Dynamic subtest rcs0: SUCCESS (0.000s) [228.622053] Starting dynamic subtest: vcs1 [228.624077] Dynamic subtest vcs1: SUCCESS (0.000s) [228.626038] Subtest invalid: SUCCESS (0.004s) [228.679811] [031/131] (788s left) gem_exec_whisper (basic-forked-all) [228.741845] Starting subtest: basic-forked-all [241.902264] Subtest basic-forked-all: SUCCESS (13.156s) [242.085979] [032/131] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [242.199501] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [246.738471] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.542s) [246.884825] [033/131] (769s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [247.003680] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [247.008161] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [247.093527] [034/131] (769s left) kms_psr (fbc-psr2-sprite-blt) [247.186353] Starting subtest: fbc-psr2-sprite-blt [247.188678] Starting dynamic subtest: eDP-1 [247.193063] Dynamic subtest eDP-1: SKIP (0.000s) [247.197411] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [247.254325] [035/131] (769s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [247.362122] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [247.364448] Starting dynamic subtest: pipe-A [248.903535] Dynamic subtest pipe-A: SUCCESS (1.544s) [248.912349] Starting dynamic subtest: pipe-B [251.469091] Dynamic subtest pipe-B: SUCCESS (2.565s) [251.478826] Starting dynamic subtest: pipe-C [252.658208] Dynamic subtest pipe-C: SUCCESS (1.188s) [252.667753] Starting dynamic subtest: pipe-D [253.822245] Dynamic subtest pipe-D: SUCCESS (1.164s) [253.824561] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.463s) [254.974506] [036/131] (761s left) gem_exec_fence (basic-busy) [255.156830] Starting subtest: basic-busy [255.159212] Starting dynamic subtest: rcs0 [255.241016] Dynamic subtest rcs0: SUCCESS (0.083s) [255.250415] Starting dynamic subtest: bcs0 [255.306331] Dynamic subtest bcs0: SUCCESS (0.064s) [255.315847] Starting dynamic subtest: vcs0 [255.374129] Dynamic subtest vcs0: SUCCESS (0.066s) [255.383566] Starting dynamic subtest: vcs1 [255.437963] Dynamic subtest vcs1: SUCCESS (0.062s) [255.447628] Starting dynamic subtest: vecs0 [255.500627] Dynamic subtest vecs0: SUCCESS (0.061s) [255.510889] Starting dynamic subtest: ccs0 [255.561412] Dynamic subtest ccs0: SUCCESS (0.059s) [255.563903] Subtest basic-busy: SUCCESS (0.405s) [256.934134] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [256.937455] [037/131] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [257.033439] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [257.037968] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [257.133267] [038/131] (759s left) perf (unprivileged-single-ctx-counters) [257.258549] Starting subtest: unprivileged-single-ctx-counters [257.263115] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [257.292775] [039/131] (759s left) perf (gen12-mi-rpc) [257.375403] Starting subtest: gen12-mi-rpc [257.377851] Starting dynamic subtest: rcs0 [257.403506] Dynamic subtest rcs0: SUCCESS (0.025s) [257.405873] Subtest gen12-mi-rpc: SUCCESS (0.026s) [257.436707] [040/131] (759s left) gem_wait (wait) [257.512354] Starting subtest: wait [257.514768] Starting dynamic subtest: all-engines [258.922092] Dynamic subtest all-engines: SUCCESS (1.408s) [258.931749] Starting dynamic subtest: rcs0 [259.969041] Dynamic subtest rcs0: SUCCESS (1.046s) [259.980310] Starting dynamic subtest: bcs0 [261.015591] Dynamic subtest bcs0: SUCCESS (1.045s) [261.025559] Starting dynamic subtest: vcs0 [262.060577] Dynamic subtest vcs0: SUCCESS (1.043s) [262.071539] Starting dynamic subtest: vcs1 [263.104485] Dynamic subtest vcs1: SUCCESS (1.042s) [263.115110] Starting dynamic subtest: vecs0 [264.149809] Dynamic subtest vecs0: SUCCESS (1.042s) [264.161593] Starting dynamic subtest: ccs0 [265.197727] Dynamic subtest ccs0: SUCCESS (1.046s) [265.200376] Subtest wait: SUCCESS (7.686s) [265.402257] [041/131] (751s left) kms_psr (fbc-pr-primary-mmap-cpu) [265.503362] Starting subtest: fbc-pr-primary-mmap-cpu [265.507459] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [265.574071] [042/131] (751s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [265.678989] Starting subtest: psr-2p-primscrn-cur-indfb-move [265.683294] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [265.766038] [043/131] (751s left) kms_lease (empty-lease) [265.857147] Starting subtest: empty-lease [265.859743] Starting dynamic subtest: pipe-A-eDP-1 [265.862165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [265.871807] Starting dynamic subtest: pipe-B-eDP-1 [265.874690] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [265.892408] Starting dynamic subtest: pipe-C-eDP-1 [265.894913] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [265.912314] Starting dynamic subtest: pipe-D-eDP-1 [265.914917] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [265.916945] Subtest empty-lease: SUCCESS (0.009s) [265.969194] [044/131] (751s left) gem_exec_schedule (reorder-wide) [266.155641] Subtest reorder-wide: SKIP (0.000s) [266.327518] [045/131] (750s left) kms_addfb_basic (addfb25-y-tiled-legacy) [266.426438] Starting subtest: addfb25-y-tiled-legacy [266.428682] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [266.523458] [046/131] (750s left) gem_pxp (fail-invalid-protected-context) [266.652321] Starting subtest: fail-invalid-protected-context [266.654779] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [266.778342] [047/131] (750s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [266.886199] Starting subtest: fbc-rgb565-draw-mmap-wc [269.992927] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.111s) [270.111586] [048/131] (747s left) kms_properties (connector-properties-atomic) [270.214691] Starting subtest: connector-properties-atomic [270.216698] Starting dynamic subtest: pipe-A-eDP-1 [277.821660] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.602s) [277.830725] Starting dynamic subtest: pipe-None-DP-1 [277.835310] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [277.843661] Starting dynamic subtest: pipe-None-HDMI-A-1 [277.847862] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [277.855519] Starting dynamic subtest: pipe-None-DP-2 [277.859573] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [277.867249] Starting dynamic subtest: pipe-None-HDMI-A-2 [277.871801] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [277.880069] Starting dynamic subtest: pipe-None-DP-3 [277.884560] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [277.892634] Starting dynamic subtest: pipe-None-DP-4 [277.897175] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [277.899451] Subtest connector-properties-atomic: SUCCESS (7.612s) [278.682336] [049/131] (738s left) syncobj_basic (bad-fd-to-handle) [278.739783] Starting subtest: bad-fd-to-handle [278.742058] Subtest bad-fd-to-handle: SUCCESS (0.000s) [278.831425] [050/131] (738s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [278.893916] Starting subtest: invalid-multi-wait-unsubmitted-submitted [278.896134] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [278.979049] [051/131] (738s left) gen9_exec_parse (bb-secure) [279.034220] Subtest bb-secure: SKIP (0.000s) [279.115130] [052/131] (738s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [279.219221] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [279.223250] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [279.332766] [053/131] (738s left) gem_ctx_bad_destroy (invalid-pad) [279.390636] Starting subtest: invalid-pad [279.393084] Subtest invalid-pad: SUCCESS (0.000s) [279.462039] [054/131] (738s left) kms_chamelium_audio (hdmi-audio-edid) [279.839595] Subtest hdmi-audio-edid: SKIP (0.000s) [280.711100] [055/131] (736s left) gem_ctx_shared (q-out-order) [280.778976] Starting subtest: Q-out-order [280.781561] Starting dynamic subtest: rcs0 [280.872746] Dynamic subtest rcs0: SUCCESS (0.093s) [280.887752] Starting dynamic subtest: vcs0 [280.946251] Dynamic subtest vcs0: SUCCESS (0.073s) [280.960463] Starting dynamic subtest: vcs1 [281.018214] Dynamic subtest vcs1: SUCCESS (0.071s) [281.030627] Starting dynamic subtest: vecs0 [281.095848] Dynamic subtest vecs0: SUCCESS (0.077s) [281.113019] Starting dynamic subtest: ccs0 [281.172738] Dynamic subtest ccs0: SUCCESS (0.074s) [281.175524] Subtest Q-out-order: SUCCESS (0.394s) [283.012113] [056/131] (734s left) gem_ctx_freq (sysfs) [283.072643] Starting subtest: sysfs [283.075145] Starting dynamic subtest: gt0 [288.573256] Dynamic subtest gt0: SUCCESS (5.500s) [288.584049] Starting dynamic subtest: gt1 [329.962076] Dynamic subtest gt1: SUCCESS (41.384s) [329.965324] Subtest sysfs: SUCCESS (46.886s) [330.035774] [057/131] (687s left) kms_vblank (wait-busy-hang) [330.141437] Starting subtest: wait-busy-hang [330.143451] Starting dynamic subtest: pipe-A-eDP-1 [356.706504] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.562s) [356.721443] Starting dynamic subtest: pipe-D-eDP-1 [381.665320] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.959s) [381.667609] Subtest wait-busy-hang: SUCCESS (51.526s) [382.451203] [058/131] (635s left) gem_mmap_gtt (cpuset-medium-copy) [382.502548] Subtest cpuset-medium-copy: SKIP (0.000s) [382.561139] [059/131] (635s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [382.626750] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [382.628883] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [382.721043] [060/131] (635s left) gem_exec_fence (syncobj-channel) [383.126809] Starting subtest: syncobj-channel [384.152871] Subtest syncobj-channel: SUCCESS (1.023s) [385.027414] [061/131] (632s left) prime_vgem (sync) [385.101649] Starting subtest: sync [385.104087] Starting dynamic subtest: rcs0 [385.151849] Dynamic subtest rcs0: SUCCESS (0.050s) [385.160237] Starting dynamic subtest: bcs0 [385.219676] Dynamic subtest bcs0: SUCCESS (0.067s) [385.228142] Starting dynamic subtest: vcs0 [385.267132] Dynamic subtest vcs0: SUCCESS (0.047s) [385.275283] Starting dynamic subtest: vcs1 [385.315150] Dynamic subtest vcs1: SUCCESS (0.047s) [385.323660] Starting dynamic subtest: vecs0 [385.361718] Dynamic subtest vecs0: SUCCESS (0.046s) [385.370212] Starting dynamic subtest: ccs0 [385.410554] Dynamic subtest ccs0: SUCCESS (0.048s) [385.412821] Subtest sync: SUCCESS (0.309s) [385.537116] [062/131] (632s left) kms_big_fb (4-tiled-8bpp-rotate-180) [385.635569] Starting subtest: 4-tiled-8bpp-rotate-180 [386.758343] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.124s) [386.946372] [063/131] (630s left) gem_exec_reloc (basic-gtt-read-noreloc) [387.012775] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [387.083144] [064/131] (630s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [387.172802] Starting subtest: plane-use-after-nonblocking-unbind-fencing [387.174768] Starting dynamic subtest: pipe-A-eDP-1 [387.243260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.069s) [387.531357] Starting dynamic subtest: pipe-B-eDP-1 [388.353701] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.831s) [388.627952] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.454s) [389.492961] [065/131] (628s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [389.547489] Starting subtest: multi-wait-available-unsubmitted-signaled [389.549807] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [389.648068] [066/131] (628s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [389.706119] Starting subtest: single-wait-all-for-submit-available-submitted [389.708392] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [389.802515] [067/131] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [389.907440] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [393.383298] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.480s) [393.542014] [068/131] (624s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [393.643659] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [393.645496] Starting dynamic subtest: pipe-A-default-mode [393.935630] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [393.940349] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.287s) [394.737731] [069/131] (623s left) kms_cursor_crc (cursor-rapid-movement-512x170) [394.998601] Starting subtest: cursor-rapid-movement-512x170 [395.002835] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [395.146457] [070/131] (622s left) gem_exec_flush (basic-wb-ro-before-default) [395.219504] Starting subtest: basic-wb-ro-before-default [400.689765] Subtest basic-wb-ro-before-default: SUCCESS (5.472s) [400.872343] [071/131] (617s left) gem_exec_balancer (invalid-bonds) [400.929337] Starting subtest: invalid-bonds [400.933713] Subtest invalid-bonds: SKIP (0.000s) [401.218971] [072/131] (616s left) api_intel_allocator (reloc-allocator) [401.284515] Starting subtest: reloc-allocator [401.286873] Starting dynamic subtest: basic [401.292368] Dynamic subtest basic: SUCCESS (0.008s) [401.302399] Starting dynamic subtest: parallel-one [401.304729] Dynamic subtest parallel-one: SUCCESS (0.008s) [401.312732] Starting dynamic subtest: print [401.314767] Dynamic subtest print: SUCCESS (0.000s) [401.322886] Starting dynamic subtest: reuse [401.325088] Dynamic subtest reuse: SUCCESS (0.000s) [401.332860] Starting dynamic subtest: fork-reopen-allocator [401.335129] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s) [401.337291] Subtest reloc-allocator: SUCCESS (0.034s) [401.446028] [073/131] (616s left) gem_workarounds (suspend-resume-fd) [401.526951] Starting subtest: suspend-resume-fd [417.539103] Subtest suspend-resume-fd: SUCCESS (1.253s) [417.674573] [074/131] (615s left) kms_cursor_crc (cursor-onscreen-64x64) [417.830777] Starting subtest: cursor-onscreen-64x64 [417.833106] Starting dynamic subtest: pipe-A-eDP-1 [420.028082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.250s) [420.057771] Starting dynamic subtest: pipe-D-eDP-1 [422.900990] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.909s) [422.903716] Subtest cursor-onscreen-64x64: SUCCESS (5.186s) [423.704441] [075/131] (609s left) perf_pmu (semaphore-busy) [423.744761] Starting subtest: semaphore-busy [423.746995] Starting dynamic subtest: rcs0 [425.397314] Dynamic subtest rcs0: SUCCESS (1.671s) [425.407514] Starting dynamic subtest: bcs0 [427.028718] Dynamic subtest bcs0: SUCCESS (1.646s) [427.041092] Starting dynamic subtest: vcs0 [427.653106] Dynamic subtest vcs0: FAIL (0.576s) [427.663026] Starting dynamic subtest: vcs1 [429.269367] Dynamic subtest vcs1: FAIL (1.612s) [429.280095] Starting dynamic subtest: vecs0 [431.250658] Dynamic subtest vecs0: FAIL (1.995s) [431.259720] Starting dynamic subtest: ccs0 [433.301485] Dynamic subtest ccs0: FAIL (2.059s) [433.303455] Subtest semaphore-busy: FAIL (9.567s) [433.338410] [076/131] (599s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [433.449383] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [433.453395] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [433.566144] [077/131] (599s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [433.949321] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [434.716390] [078/131] (598s left) kms_color (ctm-0-25) [434.818983] Starting subtest: ctm-0-25 [434.821409] Starting dynamic subtest: pipe-A-eDP-1 [438.189345] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.380s) [438.200841] Starting dynamic subtest: pipe-B-eDP-1 [442.190465] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.008s) [442.200787] Starting dynamic subtest: pipe-C-eDP-1 [446.102354] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.915s) [446.113288] Starting dynamic subtest: pipe-D-eDP-1 [450.068528] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.972s) [450.070949] Subtest ctm-0-25: SUCCESS (15.278s) [450.908913] [079/131] (581s left) i915_pm_rc6_residency (rc6-idle) [450.968802] Starting subtest: rc6-idle [450.994441] Starting dynamic subtest: gt0-rcs0 [463.211148] Dynamic subtest gt0-rcs0: SUCCESS (12.225s) [463.220195] Starting dynamic subtest: gt0-bcs0 [475.465989] Dynamic subtest gt0-bcs0: SUCCESS (12.261s) [475.475078] Starting dynamic subtest: gt0-ccs0 [487.719613] Dynamic subtest gt0-ccs0: SUCCESS (12.259s) [487.729342] Starting dynamic subtest: gt1-vcs0 [499.938345] Dynamic subtest gt1-vcs0: SUCCESS (12.224s) [499.947206] Starting dynamic subtest: gt1-vecs0 [512.833061] Dynamic subtest gt1-vecs0: SUCCESS (12.900s) [512.835621] Subtest rc6-idle: SUCCESS (61.902s) [513.647891] [080/131] (519s left) kms_psr (psr2-basic) [513.752578] Starting subtest: psr2-basic [513.754891] Starting dynamic subtest: eDP-1 [515.326299] Dynamic subtest eDP-1: SUCCESS (1.570s) [515.328522] Subtest psr2-basic: SUCCESS (1.571s) [516.115319] [081/131] (516s left) gem_exec_flush (basic-uc-pro-default) [516.175678] Starting subtest: basic-uc-pro-default [521.663537] Subtest basic-uc-pro-default: SUCCESS (5.485s) [521.845394] [082/131] (511s left) gem_wait (invalid-buf) [521.906326] Starting subtest: invalid-buf [521.908754] Subtest invalid-buf: SUCCESS (0.000s) [522.152628] [083/131] (510s left) gem_exec_reloc (basic-wc-read) [522.226535] Subtest basic-wc-read: SKIP (0.000s) [522.298631] [084/131] (510s left) kms_vblank (query-idle-hang) [522.397375] Starting subtest: query-idle-hang [522.399683] Starting dynamic subtest: pipe-A-eDP-1 [548.421640] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.016s) [548.436352] Starting dynamic subtest: pipe-D-eDP-1 [573.450916] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.030s) [573.453224] Subtest query-idle-hang: SUCCESS (51.050s) [574.264343] [085/131] (458s left) api_intel_bb (reset-flags) [574.326888] Starting subtest: reset-flags [574.335418] Subtest reset-flags: SUCCESS (0.011s) [574.472518] [086/131] (458s left) gem_basic (multigpu-create-close) [574.525284] Starting subtest: multigpu-create-close [574.530093] Subtest multigpu-create-close: SKIP (0.000s) [574.614859] [087/131] (458s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [574.708682] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [574.712857] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [574.784258] [088/131] (458s left) kms_prop_blob (basic) [574.840956] Starting subtest: basic [574.842870] Subtest basic: SUCCESS (0.000s) [574.936613] [089/131] (458s left) gem_mmap_gtt (big-copy-xy) [574.991999] Subtest big-copy-XY: SKIP (0.000s) [575.054572] [090/131] (458s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [575.119471] Starting subtest: y-tiled-to-vebox-yf-tiled [575.124099] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [575.304835] [091/131] (457s left) gem_exec_params (rel-constants-invalid-rel-gen5) [575.366332] Starting subtest: rel-constants-invalid-rel-gen5 [575.368701] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [575.466160] [092/131] (457s left) gem_exec_flush (basic-batch-kernel-default-wb) [575.526661] Starting subtest: basic-batch-kernel-default-wb [582.640671] Subtest basic-batch-kernel-default-wb: SUCCESS (7.116s) [582.827763] [093/131] (450s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [582.885892] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [582.938613] [094/131] (450s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [582.995469] Starting subtest: y-tiled-ccs-to-y-tiled [582.999401] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [583.173988] [095/131] (450s left) kms_plane_alpha_blend (alpha-transparent-fb) [583.280335] Starting subtest: alpha-transparent-fb [583.688387] Starting dynamic subtest: pipe-A-eDP-1 [584.260250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s) [584.270489] Starting dynamic subtest: pipe-D-eDP-1 [585.586009] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s) [585.588451] Subtest alpha-transparent-fb: SUCCESS (2.303s) [586.408002] [096/131] (447s left) kms_pm_dc (dc9-dpms) [587.506989] Starting subtest: dc9-dpms [588.905567] Subtest dc9-dpms: SUCCESS (1.400s) [588.966325] [097/131] (444s left) kms_joiner (basic-max-non-joiner) [589.081322] Starting subtest: basic-max-non-joiner [589.085563] Subtest basic-max-non-joiner: SKIP (0.000s) [589.138590] [098/131] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [589.248878] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [589.253289] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [589.347724] [099/131] (444s left) kms_frontbuffer_tracking (psr-slowdraw) [589.436774] Starting subtest: psr-slowdraw [612.485885] Subtest psr-slowdraw: SUCCESS (23.059s) [612.607040] [100/131] (420s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [612.668955] Starting subtest: x-tiled-to-vebox-yf-tiled [612.673337] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [612.851350] [101/131] (420s left) gem_exec_reloc (basic-gtt-wc) [612.910134] Subtest basic-gtt-wc: SKIP (0.000s) [612.990970] [102/131] (420s left) kms_dsc (dsc-with-formats) [613.092489] Starting subtest: dsc-with-formats [613.132022] Subtest dsc-with-formats: SKIP (0.001s) [613.164500] [103/131] (420s left) gem_softpin (safe-alignment) [613.223872] Starting subtest: safe-alignment [613.245323] Subtest safe-alignment: SUCCESS (0.021s) [614.702693] [104/131] (419s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [614.805339] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [614.807729] Starting dynamic subtest: pipe-A-default-mode [615.121927] Dynamic subtest pipe-A-default-mode: SKIP (0.313s) [615.126245] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.315s) [615.909404] [105/131] (417s left) kms_properties (get_properties-sanity-atomic) [616.001967] Starting subtest: get_properties-sanity-atomic [616.006848] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [616.073055] [106/131] (417s left) kms_big_fb (y-tiled-16bpp-rotate-180) [616.168254] Starting subtest: y-tiled-16bpp-rotate-180 [616.172390] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [616.252524] [107/131] (417s left) kms_flip (flip-vs-dpms-off-vs-modeset) [616.355279] Starting subtest: flip-vs-dpms-off-vs-modeset [616.357547] Starting dynamic subtest: A-eDP1 [619.814798] Dynamic subtest A-eDP1: SUCCESS (3.456s) [619.825735] Starting dynamic subtest: B-eDP1 [622.889181] Dynamic subtest B-eDP1: SUCCESS (3.078s) [622.897927] Starting dynamic subtest: C-eDP1 [625.956766] Dynamic subtest C-eDP1: SUCCESS (3.067s) [625.966742] Starting dynamic subtest: D-eDP1 [629.024837] Dynamic subtest D-eDP1: SUCCESS (3.069s) [629.027288] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.677s) [629.825085] [108/131] (404s left) kms_chamelium_hpd (dp-hpd) [630.214867] Subtest dp-hpd: SKIP (0.000s) [631.019151] [109/131] (402s left) syncobj_wait (reset-during-wait-for-submit) [631.074741] Starting subtest: reset-during-wait-for-submit [631.179288] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [631.249104] [110/131] (402s left) kms_force_connector_basic (force-load-detect) [631.336910] Starting subtest: force-load-detect [631.341753] Subtest force-load-detect: SKIP (0.000s) [631.461305] [111/131] (402s left) gem_exec_schedule (noreorder) [631.650037] Starting subtest: noreorder [631.652430] Starting dynamic subtest: rcs0 [631.722251] Dynamic subtest rcs0: SUCCESS (0.072s) [631.734282] Starting dynamic subtest: vcs0 [633.690904] Dynamic subtest vcs0: SUCCESS (1.966s) [633.703110] Starting dynamic subtest: vcs1 [635.685594] Dynamic subtest vcs1: SUCCESS (1.994s) [635.705407] Starting dynamic subtest: vecs0 [637.727775] Dynamic subtest vecs0: SUCCESS (2.041s) [637.737773] Starting dynamic subtest: ccs0 [637.802654] Dynamic subtest ccs0: SUCCESS (0.074s) [637.805769] Subtest noreorder: SUCCESS (6.155s) [637.982150] [112/131] (396s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [638.086686] Starting subtest: yf-tiled-32bpp-rotate-0 [638.091002] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [638.171272] [113/131] (395s left) kms_flip (flip-vs-rmfb) [638.273449] Starting subtest: flip-vs-rmfb [638.275850] Starting dynamic subtest: A-eDP1 [646.938987] Dynamic subtest A-eDP1: SUCCESS (8.658s) [646.949738] Starting dynamic subtest: B-eDP1 [655.674539] Dynamic subtest B-eDP1: SUCCESS (8.725s) [655.683825] Starting dynamic subtest: C-eDP1 [664.397108] Dynamic subtest C-eDP1: SUCCESS (8.715s) [664.412833] Starting dynamic subtest: D-eDP1 [673.027624] Dynamic subtest D-eDP1: SUCCESS (8.625s) [673.032062] Subtest flip-vs-rmfb: SUCCESS (34.731s) [674.196497] [114/131] (359s left) kms_psr (pr-primary-page-flip) [674.301056] Starting subtest: pr-primary-page-flip [674.304988] Subtest pr-primary-page-flip: SKIP (0.000s) [674.366573] [115/131] (359s left) gem_exec_reloc (basic-cpu) [674.423169] Subtest basic-cpu: SKIP (0.000s) [674.494284] [116/131] (359s left) gem_ctx_persistence (engines-hostile) [674.550483] Starting subtest: engines-hostile [674.552755] Starting dynamic subtest: rcs0 [674.633110] Dynamic subtest rcs0: SUCCESS (0.081s) [674.645796] Starting dynamic subtest: bcs0 [674.750053] Dynamic subtest bcs0: SUCCESS (0.116s) [674.762153] Starting dynamic subtest: vcs0 [674.824929] Dynamic subtest vcs0: SUCCESS (0.073s) [674.834303] Starting dynamic subtest: vcs1 [674.963905] Dynamic subtest vcs1: SUCCESS (0.137s) [674.974294] Starting dynamic subtest: vecs0 [675.070932] Dynamic subtest vecs0: SUCCESS (0.105s) [675.083195] Starting dynamic subtest: ccs0 [675.174849] Dynamic subtest ccs0: SUCCESS (0.102s) [675.177066] Subtest engines-hostile: SUCCESS (0.625s) [675.247680] [117/131] (358s left) fbdev (nullptr) [675.282487] Starting subtest: nullptr [675.284429] Subtest nullptr: SUCCESS (0.000s) [675.336548] [118/131] (358s left) gem_mmap_wc (write-gtt-read-wc) [675.399984] Subtest write-gtt-read-wc: SKIP (0.000s) [675.463586] [119/131] (358s left) i915_pm_sseu (full-enable) [675.529939] Subtest full-enable: SKIP (0.000s) [675.616438] [120/131] (358s left) kms_atomic_transition (plane-all-transition-nonblocking) [675.716967] Starting subtest: plane-all-transition-nonblocking [675.718866] Starting dynamic subtest: pipe-A-eDP-1 [678.222637] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s) [678.510889] Starting dynamic subtest: pipe-B-eDP-1 [681.732290] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.230s) [682.006259] Subtest plane-all-transition-nonblocking: SUCCESS (6.286s) [682.841469] [121/131] (351s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [682.939326] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [682.943743] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [683.054320] [122/131] (351s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [683.163300] Starting subtest: bad-aux-stride-yf-tiled-ccs [683.165474] Starting dynamic subtest: pipe-A-eDP-1 [683.187634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [683.198518] Starting dynamic subtest: pipe-B-eDP-1 [683.219847] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [683.228697] Starting dynamic subtest: pipe-C-eDP-1 [683.250704] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [683.259445] Starting dynamic subtest: pipe-D-eDP-1 [683.281670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [683.285823] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.006s) [685.299850] [123/131] (349s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [685.398608] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [685.401006] Starting dynamic subtest: pipe-A-eDP-1 [685.410112] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [685.419720] Starting dynamic subtest: pipe-B-eDP-1 [685.428637] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [685.437759] Starting dynamic subtest: pipe-C-eDP-1 [685.446314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [685.454863] Starting dynamic subtest: pipe-D-eDP-1 [685.463501] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [685.467531] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [687.554714] [124/131] (346s left) gem_exec_schedule (submit-late-slice) [687.627187] Starting subtest: submit-late-slice [687.629259] Starting dynamic subtest: rcs0 [687.647905] Dynamic subtest rcs0: SUCCESS (0.030s) [687.664532] Starting dynamic subtest: bcs0 [687.675146] Dynamic subtest bcs0: SUCCESS (0.026s) [687.684452] Starting dynamic subtest: vcs0 [687.702747] Dynamic subtest vcs0: SUCCESS (0.027s) [687.714149] Starting dynamic subtest: vcs1 [687.732394] Dynamic subtest vcs1: SUCCESS (0.029s) [687.741585] Starting dynamic subtest: vecs0 [687.764908] Dynamic subtest vecs0: SUCCESS (0.032s) [687.774083] Starting dynamic subtest: ccs0 [687.793981] Dynamic subtest ccs0: SUCCESS (0.028s) [687.796441] Subtest submit-late-slice: SUCCESS (0.176s) [689.782375] [125/131] (344s left) kms_pm_dc (dc5-retention-flops) [690.884300] Starting subtest: dc5-retention-flops [690.888534] Subtest dc5-retention-flops: SKIP (0.000s) [690.949046] [126/131] (343s left) kms_content_protection (lic-type-1) [691.125531] Starting subtest: lic-type-1 [694.399799] Subtest lic-type-1: SKIP (3.271s) [695.565409] [127/131] (338s left) tools_test (sysfs_l3_parity) [695.616067] Starting subtest: sysfs_l3_parity [695.691126] Subtest sysfs_l3_parity: SKIP (0.089s) [695.739243] [128/131] (338s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [695.791253] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [695.895982] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [695.966011] [129/131] (338s left) gem_eio (wait-wedge-1us) [696.194871] Starting subtest: wait-wedge-1us [697.750546] Subtest wait-wedge-1us: SUCCESS (1.556s) [697.899532] [130/131] (336s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [698.004105] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [702.577289] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.577s) [702.732226] [131/131] (331s left) kms_plane_multiple (tiling-none) [702.823928] Starting subtest: tiling-none [702.826328] Starting dynamic subtest: pipe-A-eDP-1 [706.513572] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.688s) [706.523609] Starting dynamic subtest: pipe-B-eDP-1 [710.918898] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.404s) [710.929242] Starting dynamic subtest: pipe-C-eDP-1 [715.199879] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.281s) [715.209942] Starting dynamic subtest: pipe-D-eDP-1 [719.503286] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.302s) [719.505575] Subtest tiling-none: SUCCESS (16.679s) [720.305269] Closing watchdogs Done.