[57.502374] Initializing watchdogs [57.502416] /dev/watchdog0 [57.515754] [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] [57.519806] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.521889] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.525331] [001/131] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [57.698944] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [59.020405] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.323s) [59.382814] [002/131] (958s left) kms_feature_discovery (chamelium) [59.481061] Starting subtest: chamelium [59.485633] Subtest chamelium: SKIP (0.000s) [59.545623] [003/131] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [59.653538] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [59.657898] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [59.745611] [004/131] (958s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [59.858258] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [61.047429] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.189s) [61.214233] [005/131] (956s left) kms_cursor_edge_walk (64x64-top-bottom) [61.314529] Starting subtest: 64x64-top-bottom [61.316480] Starting dynamic subtest: pipe-A-eDP-1 [64.781514] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s) [64.789348] Starting dynamic subtest: pipe-D-eDP-1 [67.891039] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s) [67.893365] Subtest 64x64-top-bottom: SUCCESS (6.575s) [68.696017] [006/131] (949s left) kms_flip (dpms-vs-vblank-race-interruptible) [68.802743] Starting subtest: dpms-vs-vblank-race-interruptible [68.805220] Starting dynamic subtest: A-eDP1 [73.745895] Dynamic subtest A-eDP1: SUCCESS (4.939s) [73.757999] Starting dynamic subtest: B-eDP1 [78.335561] Dynamic subtest B-eDP1: SUCCESS (4.590s) [78.343268] Starting dynamic subtest: C-eDP1 [82.920507] Dynamic subtest C-eDP1: SUCCESS (4.582s) [82.928592] Starting dynamic subtest: D-eDP1 [87.324056] Dynamic subtest D-eDP1: SUCCESS (4.405s) [87.326570] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.522s) [88.102581] [007/131] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [88.215073] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [88.219192] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [88.310417] [008/131] (929s left) kms_getfb (getfb2-handle-closed) [88.364943] Starting subtest: getfb2-handle-closed [88.367254] Subtest getfb2-handle-closed: SUCCESS (0.000s) [88.461276] [009/131] (929s left) syncobj_timeline (wait-all-interrupted) [88.510182] Starting subtest: wait-all-interrupted [88.616459] Subtest wait-all-interrupted: SUCCESS (0.105s) [88.684941] [010/131] (929s left) gem_gpgpu_fill (basic) [88.743623] Starting subtest: basic [88.745864] Starting dynamic subtest: smem [88.750495] Dynamic subtest smem: SUCCESS (0.008s) [88.752704] Subtest basic: SUCCESS (0.008s) [88.885216] [011/131] (929s left) kms_psr (psr-cursor-plane-move) [88.971380] Starting subtest: psr-cursor-plane-move [88.973707] Starting dynamic subtest: eDP-1 [90.691451] Dynamic subtest eDP-1: SUCCESS (1.718s) [90.693322] Subtest psr-cursor-plane-move: SUCCESS (1.718s) [91.549897] [012/131] (926s left) device_reset (unbind-reset-rebind) [91.595965] Starting subtest: unbind-reset-rebind [96.287723] Subtest unbind-reset-rebind: SUCCESS (4.687s) [96.328232] [013/131] (922s left) kms_big_fb (linear-addfb) [96.442851] Starting subtest: linear-addfb [96.445222] Subtest linear-addfb: SUCCESS (0.000s) [96.524535] [014/131] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [96.631731] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [100.995853] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.368s) [101.111154] [015/131] (917s left) gem_exec_params (no-bsd) [101.171429] Starting subtest: no-bsd [101.173788] Subtest no-bsd: SUCCESS (0.002s) [103.044389] [016/131] (915s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [108.043518] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [108.045824] Starting dynamic subtest: pipe-A-eDP-1 [108.846779] Dynamic subtest pipe-A-eDP-1: SKIP (0.800s) [108.853594] Starting dynamic subtest: pipe-B-eDP-1 [109.969416] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s) [109.973786] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.925s) [111.144259] [017/131] (907s left) kms_rotation_crc (sprite-rotation-270) [111.239807] Starting subtest: sprite-rotation-270 [111.244457] Subtest sprite-rotation-270: SKIP (0.001s) [111.307743] [018/131] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [111.404271] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [111.408630] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [111.509076] [019/131] (907s left) kms_scaling_modes (scaling-mode-full-aspect) [111.608014] Starting subtest: scaling-mode-full-aspect [111.610431] Starting dynamic subtest: pipe-A-eDP-1 [111.716756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s) [111.724307] Starting dynamic subtest: pipe-B-eDP-1 [112.875313] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s) [112.883836] Starting dynamic subtest: pipe-C-eDP-1 [113.975053] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s) [113.982841] Starting dynamic subtest: pipe-D-eDP-1 [115.104400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s) [115.106682] Subtest scaling-mode-full-aspect: SUCCESS (3.497s) [116.252851] [020/131] (902s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [121.287379] Starting subtest: pr-overlay-plane-move-continuous-sf [121.292199] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [122.137089] [021/131] (896s left) kms_async_flips (test-cursor) [122.238124] Starting subtest: test-cursor [122.242602] Subtest test-cursor: SKIP (0.000s) [123.461153] [022/131] (895s left) gem_mmap_offset (clear) [123.525742] Starting subtest: clear [123.528746] Starting dynamic subtest: smem0 [150.181669] Dynamic subtest smem0: SUCCESS (26.651s) [150.183652] Subtest clear: SUCCESS (26.651s) [150.440808] [023/131] (868s left) kms_flip (2x-flip-vs-rmfb-interruptible) [150.596433] Starting subtest: 2x-flip-vs-rmfb-interruptible [150.609413] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s) [150.674566] [024/131] (868s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [150.772726] Starting subtest: bad-rotation-90-y-tiled-ccs [150.775039] Starting dynamic subtest: pipe-A-eDP-1 [150.798516] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [150.806228] Starting dynamic subtest: pipe-B-eDP-1 [150.827873] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [150.835014] Starting dynamic subtest: pipe-C-eDP-1 [150.856700] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [150.864354] Starting dynamic subtest: pipe-D-eDP-1 [150.886192] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [150.890604] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s) [152.912077] [025/131] (865s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [153.017793] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [153.020082] Starting dynamic subtest: pipe-A-eDP-1 [153.042273] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [153.052620] Starting dynamic subtest: pipe-B-eDP-1 [153.073331] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [153.080961] Starting dynamic subtest: pipe-C-eDP-1 [153.102810] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [153.109845] Starting dynamic subtest: pipe-D-eDP-1 [153.131645] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [153.136101] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s) [155.156795] [026/131] (863s left) kms_addfb_basic (addfb25-bad-modifier) [155.251973] Starting subtest: addfb25-bad-modifier [155.254340] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [155.337232] [027/131] (863s left) gem_exec_alignment (forked) [155.396289] Starting subtest: forked [191.754024] Subtest forked: SUCCESS (36.354s) [191.823136] [028/131] (827s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [191.969165] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [196.636830] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.670s) [196.757068] [029/131] (822s left) kms_flip (plain-flip-fb-recreate) [196.871259] Starting subtest: plain-flip-fb-recreate [196.873683] Starting dynamic subtest: A-eDP1 [205.781316] Dynamic subtest A-eDP1: SUCCESS (8.910s) [205.790886] Starting dynamic subtest: B-eDP1 [214.708513] Dynamic subtest B-eDP1: SUCCESS (8.926s) [214.718095] Starting dynamic subtest: C-eDP1 [223.627711] Dynamic subtest C-eDP1: SUCCESS (8.919s) [223.635847] Starting dynamic subtest: D-eDP1 [232.464860] Dynamic subtest D-eDP1: SUCCESS (8.836s) [232.466795] Subtest plain-flip-fb-recreate: SUCCESS (35.597s) [233.631524] [030/131] (785s left) sysfs_heartbeat_interval (invalid) [233.689522] Starting subtest: invalid [233.691992] Starting dynamic subtest: vecs0 [233.694461] Dynamic subtest vecs0: SUCCESS (0.000s) [233.703223] Starting dynamic subtest: ccs0 [233.705475] Dynamic subtest ccs0: SUCCESS (0.000s) [233.712790] Starting dynamic subtest: vcs0 [233.715076] Dynamic subtest vcs0: SUCCESS (0.000s) [233.722530] Starting dynamic subtest: bcs0 [233.724824] Dynamic subtest bcs0: SUCCESS (0.000s) [233.732153] Starting dynamic subtest: rcs0 [233.734296] Dynamic subtest rcs0: SUCCESS (0.000s) [233.741691] Starting dynamic subtest: vcs1 [233.743604] Dynamic subtest vcs1: SUCCESS (0.000s) [233.745495] Subtest invalid: SUCCESS (0.004s) [233.793746] [031/131] (785s left) gem_exec_whisper (basic-forked-all) [233.866667] Starting subtest: basic-forked-all [246.082255] Subtest basic-forked-all: SUCCESS (12.213s) [246.262672] [032/131] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [246.369151] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [250.851074] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.483s) [250.982314] [033/131] (768s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [251.116812] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [251.121180] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [251.209955] [034/131] (767s left) kms_psr (fbc-psr2-sprite-blt) [251.312292] Starting subtest: fbc-psr2-sprite-blt [251.314582] Starting dynamic subtest: eDP-1 [251.318992] Dynamic subtest eDP-1: SKIP (0.000s) [251.323167] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [251.378328] [035/131] (767s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [251.464196] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [251.466479] Starting dynamic subtest: pipe-A [252.985726] Dynamic subtest pipe-A: SUCCESS (1.522s) [252.994500] Starting dynamic subtest: pipe-B [255.602389] Dynamic subtest pipe-B: SUCCESS (2.616s) [255.611702] Starting dynamic subtest: pipe-C [256.789690] Dynamic subtest pipe-C: SUCCESS (1.186s) [256.797989] Starting dynamic subtest: pipe-D [258.004275] Dynamic subtest pipe-D: SUCCESS (1.213s) [258.006884] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.540s) [259.185360] [036/131] (759s left) gem_exec_fence (basic-busy) [259.375953] Starting subtest: basic-busy [259.378531] Starting dynamic subtest: rcs0 [259.468650] Dynamic subtest rcs0: SUCCESS (0.092s) [259.479357] Starting dynamic subtest: bcs0 [259.530205] Dynamic subtest bcs0: SUCCESS (0.060s) [259.540556] Starting dynamic subtest: vcs0 [259.591202] Dynamic subtest vcs0: SUCCESS (0.059s) [259.599870] Starting dynamic subtest: vcs1 [259.657275] Dynamic subtest vcs1: SUCCESS (0.064s) [259.666067] Starting dynamic subtest: vecs0 [259.715117] Dynamic subtest vecs0: SUCCESS (0.056s) [259.723575] Starting dynamic subtest: ccs0 [259.775871] Dynamic subtest ccs0: SUCCESS (0.058s) [259.778503] Subtest basic-busy: SUCCESS (0.401s) [262.031039] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [262.034428] [037/131] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [262.137733] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [262.142052] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [262.248565] [038/131] (756s left) perf (unprivileged-single-ctx-counters) [262.371501] Starting subtest: unprivileged-single-ctx-counters [262.375531] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [262.406065] [039/131] (756s left) perf (gen12-mi-rpc) [262.487521] Starting subtest: gen12-mi-rpc [262.490088] Starting dynamic subtest: rcs0 [262.518465] Dynamic subtest rcs0: SUCCESS (0.027s) [262.520711] Subtest gen12-mi-rpc: SUCCESS (0.029s) [262.557768] [040/131] (756s left) gem_wait (wait) [262.628841] Starting subtest: wait [262.631288] Starting dynamic subtest: all-engines [263.916432] Dynamic subtest all-engines: SUCCESS (1.285s) [263.927235] Starting dynamic subtest: rcs0 [264.965737] Dynamic subtest rcs0: SUCCESS (1.046s) [264.977060] Starting dynamic subtest: bcs0 [266.010927] Dynamic subtest bcs0: SUCCESS (1.044s) [266.021284] Starting dynamic subtest: vcs0 [267.056562] Dynamic subtest vcs0: SUCCESS (1.044s) [267.067611] Starting dynamic subtest: vcs1 [268.101275] Dynamic subtest vcs1: SUCCESS (1.043s) [268.110429] Starting dynamic subtest: vecs0 [269.144939] Dynamic subtest vecs0: SUCCESS (1.042s) [269.156048] Starting dynamic subtest: ccs0 [270.192966] Dynamic subtest ccs0: SUCCESS (1.046s) [270.195782] Subtest wait: SUCCESS (7.564s) [270.398415] [041/131] (748s left) kms_psr (fbc-pr-primary-mmap-cpu) [270.495064] Starting subtest: fbc-pr-primary-mmap-cpu [270.499232] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [270.560093] [042/131] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [270.664692] Starting subtest: psr-2p-primscrn-cur-indfb-move [270.669057] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [270.764157] [043/131] (748s left) kms_lease (empty-lease) [270.855298] Starting subtest: empty-lease [270.857558] Starting dynamic subtest: pipe-A-eDP-1 [270.859810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [270.869114] Starting dynamic subtest: pipe-B-eDP-1 [270.870988] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [270.878825] Starting dynamic subtest: pipe-C-eDP-1 [270.880775] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [270.888392] Starting dynamic subtest: pipe-D-eDP-1 [270.890286] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [270.892148] Subtest empty-lease: SUCCESS (0.009s) [270.960605] [044/131] (748s left) gem_exec_schedule (reorder-wide) [271.150613] Subtest reorder-wide: SKIP (0.000s) [271.322819] [045/131] (748s left) kms_addfb_basic (addfb25-y-tiled-legacy) [271.426456] Starting subtest: addfb25-y-tiled-legacy [271.428599] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [271.530230] [046/131] (747s left) gem_pxp (fail-invalid-protected-context) [271.665068] Starting subtest: fail-invalid-protected-context [271.667715] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [271.765424] [047/131] (747s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [271.856731] Starting subtest: fbc-rgb565-draw-mmap-wc [274.846444] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.994s) [274.977711] [048/131] (744s left) kms_properties (connector-properties-atomic) [275.077562] Starting subtest: connector-properties-atomic [275.079596] Starting dynamic subtest: pipe-A-eDP-1 [282.978902] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.895s) [282.986837] Starting dynamic subtest: pipe-None-DP-1 [282.991104] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [282.998311] Starting dynamic subtest: pipe-None-HDMI-A-1 [283.002141] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [283.010344] Starting dynamic subtest: pipe-None-DP-2 [283.014607] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [283.022449] Starting dynamic subtest: pipe-None-HDMI-A-2 [283.026664] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [283.034638] Starting dynamic subtest: pipe-None-DP-3 [283.038855] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [283.046679] Starting dynamic subtest: pipe-None-DP-4 [283.050838] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [283.052973] Subtest connector-properties-atomic: SUCCESS (7.906s) [283.833664] [049/131] (735s left) syncobj_basic (bad-fd-to-handle) [283.895937] Starting subtest: bad-fd-to-handle [283.898482] Subtest bad-fd-to-handle: SUCCESS (0.000s) [283.986857] [050/131] (735s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [284.036736] Starting subtest: invalid-multi-wait-unsubmitted-submitted [284.039255] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [284.128425] [051/131] (735s left) gen9_exec_parse (bb-secure) [284.191342] Subtest bb-secure: SKIP (0.000s) [284.269943] [052/131] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [284.379676] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [284.384235] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [284.486030] [053/131] (735s left) gem_ctx_bad_destroy (invalid-pad) [284.540630] Starting subtest: invalid-pad [284.543121] Subtest invalid-pad: SUCCESS (0.000s) [284.608579] [054/131] (735s left) kms_chamelium_audio (hdmi-audio-edid) [285.002245] Subtest hdmi-audio-edid: SKIP (0.000s) [285.838488] [055/131] (733s left) gem_ctx_shared (q-out-order) [285.917627] Starting subtest: Q-out-order [285.920119] Starting dynamic subtest: rcs0 [286.009934] Dynamic subtest rcs0: SUCCESS (0.092s) [286.024964] Starting dynamic subtest: vcs0 [286.082025] Dynamic subtest vcs0: SUCCESS (0.072s) [286.097041] Starting dynamic subtest: vcs1 [286.149133] Dynamic subtest vcs1: SUCCESS (0.066s) [286.164107] Starting dynamic subtest: vecs0 [286.219524] Dynamic subtest vecs0: SUCCESS (0.069s) [286.235132] Starting dynamic subtest: ccs0 [286.293992] Dynamic subtest ccs0: SUCCESS (0.074s) [286.296509] Subtest Q-out-order: SUCCESS (0.376s) [288.039350] [056/131] (731s left) gem_ctx_freq (sysfs) [288.097416] Starting subtest: sysfs [288.100010] Starting dynamic subtest: gt0 [293.631025] Dynamic subtest gt0: SUCCESS (5.532s) [293.639225] Starting dynamic subtest: gt1 [334.955050] Dynamic subtest gt1: SUCCESS (41.318s) [334.957843] Subtest sysfs: SUCCESS (46.852s) [335.026951] [057/131] (684s left) kms_vblank (wait-busy-hang) [335.131202] Starting subtest: wait-busy-hang [335.133683] Starting dynamic subtest: pipe-A-eDP-1 [362.664050] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.528s) [362.678375] Starting dynamic subtest: pipe-D-eDP-1 [387.681039] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.013s) [387.683556] Subtest wait-busy-hang: SUCCESS (52.546s) [388.498312] [058/131] (631s left) gem_mmap_gtt (cpuset-medium-copy) [388.563335] Subtest cpuset-medium-copy: SKIP (0.000s) [388.627894] [059/131] (631s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [388.686625] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [388.688824] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [388.776597] [060/131] (631s left) gem_exec_fence (syncobj-channel) [389.184569] Starting subtest: syncobj-channel [390.207668] Subtest syncobj-channel: SUCCESS (1.020s) [391.019922] [061/131] (629s left) prime_vgem (sync) [391.091412] Starting subtest: sync [391.093628] Starting dynamic subtest: rcs0 [391.129849] Dynamic subtest rcs0: SUCCESS (0.041s) [391.138725] Starting dynamic subtest: bcs0 [391.197120] Dynamic subtest bcs0: SUCCESS (0.066s) [391.205750] Starting dynamic subtest: vcs0 [391.247154] Dynamic subtest vcs0: SUCCESS (0.049s) [391.255331] Starting dynamic subtest: vcs1 [391.293134] Dynamic subtest vcs1: SUCCESS (0.045s) [391.301569] Starting dynamic subtest: vecs0 [391.340732] Dynamic subtest vecs0: SUCCESS (0.047s) [391.349494] Starting dynamic subtest: ccs0 [391.387331] Dynamic subtest ccs0: SUCCESS (0.046s) [391.391649] Subtest sync: SUCCESS (0.299s) [391.520347] [062/131] (628s left) kms_big_fb (4-tiled-8bpp-rotate-180) [391.632078] Starting subtest: 4-tiled-8bpp-rotate-180 [392.735727] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.103s) [392.886396] [063/131] (627s left) gem_exec_reloc (basic-gtt-read-noreloc) [392.958172] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [393.026701] [064/131] (627s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [393.126349] Starting subtest: plane-use-after-nonblocking-unbind-fencing [393.128176] Starting dynamic subtest: pipe-A-eDP-1 [393.196112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.071s) [393.490039] Starting dynamic subtest: pipe-B-eDP-1 [394.299673] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.822s) [394.578966] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.450s) [395.444935] [065/131] (624s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [395.506166] Starting subtest: multi-wait-available-unsubmitted-signaled [395.508602] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [395.605512] [066/131] (624s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [395.657129] Starting subtest: single-wait-all-for-submit-available-submitted [395.659330] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [395.759276] [067/131] (624s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [395.867638] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [399.366940] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.503s) [399.490565] [068/131] (620s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [399.599912] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [399.602054] Starting dynamic subtest: pipe-A-default-mode [399.887629] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [399.892444] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.285s) [400.693703] [069/131] (619s left) kms_cursor_crc (cursor-rapid-movement-512x170) [400.965759] Starting subtest: cursor-rapid-movement-512x170 [400.970407] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [401.124525] [070/131] (619s left) gem_exec_flush (basic-wb-ro-before-default) [401.192705] Starting subtest: basic-wb-ro-before-default [406.678213] Subtest basic-wb-ro-before-default: SUCCESS (5.485s) [406.857922] [071/131] (613s left) gem_exec_balancer (invalid-bonds) [406.916019] Starting subtest: invalid-bonds [406.920431] Subtest invalid-bonds: SKIP (0.000s) [407.225494] [072/131] (613s left) api_intel_allocator (reloc-allocator) [407.277538] Starting subtest: reloc-allocator [407.279447] Starting dynamic subtest: basic [407.284360] Dynamic subtest basic: SUCCESS (0.008s) [407.294870] Starting dynamic subtest: parallel-one [407.296926] Dynamic subtest parallel-one: SUCCESS (0.008s) [407.307658] Starting dynamic subtest: print [407.309923] Dynamic subtest print: SUCCESS (0.000s) [407.317739] Starting dynamic subtest: reuse [407.319701] Dynamic subtest reuse: SUCCESS (0.000s) [407.327600] Starting dynamic subtest: fork-reopen-allocator [407.329582] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [407.331554] Subtest reloc-allocator: SUCCESS (0.031s) [407.451946] [073/131] (613s left) gem_workarounds (suspend-resume-fd) [407.522506] Starting subtest: suspend-resume-fd [423.286712] Subtest suspend-resume-fd: SUCCESS (1.225s) [423.428178] [074/131] (611s left) kms_cursor_crc (cursor-onscreen-64x64) [423.581621] Starting subtest: cursor-onscreen-64x64 [423.586310] Starting dynamic subtest: pipe-A-eDP-1 [425.914562] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.323s) [425.938955] Starting dynamic subtest: pipe-D-eDP-1 [428.888029] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.952s) [428.890444] Subtest cursor-onscreen-64x64: SUCCESS (5.297s) [429.695316] [075/131] (605s left) perf_pmu (semaphore-busy) [429.743050] Starting subtest: semaphore-busy [429.745074] Starting dynamic subtest: rcs0 [431.408739] Dynamic subtest rcs0: SUCCESS (1.661s) [431.419154] Starting dynamic subtest: bcs0 [433.039718] Dynamic subtest bcs0: SUCCESS (1.627s) [433.052302] Starting dynamic subtest: vcs0 [433.669756] Dynamic subtest vcs0: FAIL (0.574s) [433.679792] Starting dynamic subtest: vcs1 [435.068222] Dynamic subtest vcs1: FAIL (1.384s) [435.079357] Starting dynamic subtest: vecs0 [437.052972] Dynamic subtest vecs0: FAIL (1.986s) [437.063442] Starting dynamic subtest: ccs0 [439.037444] Dynamic subtest ccs0: FAIL (1.980s) [439.039592] Subtest semaphore-busy: FAIL (9.220s) [439.098631] [076/131] (596s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [439.213450] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [439.217503] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [439.316446] [077/131] (595s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [439.704089] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [440.504603] [078/131] (594s left) kms_color (ctm-0-25) [440.612806] Starting subtest: ctm-0-25 [440.615294] Starting dynamic subtest: pipe-A-eDP-1 [444.007004] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.390s) [444.017168] Starting dynamic subtest: pipe-B-eDP-1 [448.005933] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.998s) [448.016312] Starting dynamic subtest: pipe-C-eDP-1 [451.962789] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.955s) [451.972822] Starting dynamic subtest: pipe-D-eDP-1 [455.929079] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.964s) [455.931458] Subtest ctm-0-25: SUCCESS (15.310s) [456.784719] [079/131] (578s left) i915_pm_rc6_residency (rc6-idle) [456.849759] Starting subtest: rc6-idle [456.870254] Starting dynamic subtest: gt0-rcs0 [469.089480] Dynamic subtest gt0-rcs0: SUCCESS (12.215s) [469.098457] Starting dynamic subtest: gt0-bcs0 [481.345978] Dynamic subtest gt0-bcs0: SUCCESS (12.253s) [481.357820] Starting dynamic subtest: gt0-ccs0 [493.601253] Dynamic subtest gt0-ccs0: SUCCESS (12.251s) [493.612889] Starting dynamic subtest: gt1-vcs0 [505.822800] Dynamic subtest gt1-vcs0: SUCCESS (12.217s) [505.832269] Starting dynamic subtest: gt1-vecs0 [518.699627] Dynamic subtest gt1-vecs0: SUCCESS (12.872s) [518.703205] Subtest rc6-idle: SUCCESS (61.838s) [519.512851] [080/131] (515s left) kms_psr (psr2-basic) [519.624222] Starting subtest: psr2-basic [519.626552] Starting dynamic subtest: eDP-1 [521.259752] Dynamic subtest eDP-1: SUCCESS (1.636s) [521.262047] Subtest psr2-basic: SUCCESS (1.637s) [522.040360] [081/131] (513s left) gem_exec_flush (basic-uc-pro-default) [522.107743] Starting subtest: basic-uc-pro-default [527.595500] Subtest basic-uc-pro-default: SUCCESS (5.490s) [527.778728] [082/131] (507s left) gem_wait (invalid-buf) [527.841740] Starting subtest: invalid-buf [527.844237] Subtest invalid-buf: SUCCESS (0.000s) [528.088525] [083/131] (507s left) gem_exec_reloc (basic-wc-read) [528.155478] Subtest basic-wc-read: SKIP (0.000s) [528.240958] [084/131] (507s left) kms_vblank (query-idle-hang) [528.340437] Starting subtest: query-idle-hang [528.342848] Starting dynamic subtest: pipe-A-eDP-1 [555.246592] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.907s) [555.262781] Starting dynamic subtest: pipe-D-eDP-1 [580.212209] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.963s) [580.214468] Subtest query-idle-hang: SUCCESS (51.876s) [581.081315] [085/131] (454s left) api_intel_bb (reset-flags) [581.139436] Starting subtest: reset-flags [581.147439] Subtest reset-flags: SUCCESS (0.010s) [581.264556] [086/131] (454s left) gem_basic (multigpu-create-close) [581.320136] Starting subtest: multigpu-create-close [581.324721] Subtest multigpu-create-close: SKIP (0.000s) [581.410146] [087/131] (454s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [581.507503] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [581.511451] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [581.603971] [088/131] (453s left) kms_prop_blob (basic) [581.661007] Starting subtest: basic [581.663449] Subtest basic: SUCCESS (0.000s) [581.766716] [089/131] (453s left) gem_mmap_gtt (big-copy-xy) [581.823675] Subtest big-copy-XY: SKIP (0.000s) [581.876369] [090/131] (453s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [581.951770] Starting subtest: y-tiled-to-vebox-yf-tiled [581.956184] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [582.129818] [091/131] (453s left) gem_exec_params (rel-constants-invalid-rel-gen5) [582.186441] Starting subtest: rel-constants-invalid-rel-gen5 [582.188865] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [582.281007] [092/131] (453s left) gem_exec_flush (basic-batch-kernel-default-wb) [582.343649] Starting subtest: basic-batch-kernel-default-wb [589.481063] Subtest basic-batch-kernel-default-wb: SUCCESS (7.137s) [589.665248] [093/131] (446s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [589.715244] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [589.775575] [094/131] (446s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [589.834697] Starting subtest: y-tiled-ccs-to-y-tiled [589.839322] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [590.015912] [095/131] (445s left) kms_plane_alpha_blend (alpha-transparent-fb) [590.111811] Starting subtest: alpha-transparent-fb [590.529184] Starting dynamic subtest: pipe-A-eDP-1 [591.109558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s) [591.121352] Starting dynamic subtest: pipe-D-eDP-1 [592.400256] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s) [592.402557] Subtest alpha-transparent-fb: SUCCESS (2.287s) [593.233852] [096/131] (442s left) kms_pm_dc (dc9-dpms) [594.341552] Starting subtest: dc9-dpms [595.725896] Subtest dc9-dpms: SUCCESS (1.386s) [595.788614] [097/131] (440s left) kms_joiner (basic-max-non-joiner) [595.895670] Starting subtest: basic-max-non-joiner [595.899633] Subtest basic-max-non-joiner: SKIP (0.000s) [595.958825] [098/131] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [596.055434] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [596.059610] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [596.177915] [099/131] (439s left) kms_frontbuffer_tracking (psr-slowdraw) [596.284309] Starting subtest: psr-slowdraw [619.295313] Subtest psr-slowdraw: SUCCESS (23.012s) [619.426855] [100/131] (416s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [619.482441] Starting subtest: x-tiled-to-vebox-yf-tiled [619.487021] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [619.661425] [101/131] (416s left) gem_exec_reloc (basic-gtt-wc) [619.725258] Subtest basic-gtt-wc: SKIP (0.000s) [619.798343] [102/131] (416s left) kms_dsc (dsc-with-formats) [619.900747] Starting subtest: dsc-with-formats [619.940041] Subtest dsc-with-formats: SKIP (0.001s) [619.970953] [103/131] (416s left) gem_softpin (safe-alignment) [620.036002] Starting subtest: safe-alignment [620.055947] Subtest safe-alignment: SUCCESS (0.020s) [621.529639] [104/131] (414s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [621.631228] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [621.633453] Starting dynamic subtest: pipe-A-default-mode [621.944734] Dynamic subtest pipe-A-default-mode: SKIP (0.313s) [621.949243] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s) [622.740009] [105/131] (413s left) kms_properties (get_properties-sanity-atomic) [622.833420] Starting subtest: get_properties-sanity-atomic [622.838431] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [622.905633] [106/131] (413s left) kms_big_fb (y-tiled-16bpp-rotate-180) [623.018938] Starting subtest: y-tiled-16bpp-rotate-180 [623.023099] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [623.121188] [107/131] (413s left) kms_flip (flip-vs-dpms-off-vs-modeset) [623.228316] Starting subtest: flip-vs-dpms-off-vs-modeset [623.230666] Starting dynamic subtest: A-eDP1 [626.841244] Dynamic subtest A-eDP1: SUCCESS (3.610s) [626.851950] Starting dynamic subtest: B-eDP1 [630.017034] Dynamic subtest B-eDP1: SUCCESS (3.174s) [630.027865] Starting dynamic subtest: C-eDP1 [633.086989] Dynamic subtest C-eDP1: SUCCESS (3.069s) [633.101893] Starting dynamic subtest: D-eDP1 [636.159402] Dynamic subtest D-eDP1: SUCCESS (3.073s) [636.161804] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.932s) [636.956931] [108/131] (399s left) kms_chamelium_hpd (dp-hpd) [637.349569] Subtest dp-hpd: SKIP (0.000s) [638.153872] [109/131] (398s left) syncobj_wait (reset-during-wait-for-submit) [638.214593] Starting subtest: reset-during-wait-for-submit [638.316647] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [638.391355] [110/131] (397s left) kms_force_connector_basic (force-load-detect) [638.478084] Starting subtest: force-load-detect [638.482745] Subtest force-load-detect: SKIP (0.000s) [638.600809] [111/131] (397s left) gem_exec_schedule (noreorder) [638.787306] Starting subtest: noreorder [638.789927] Starting dynamic subtest: rcs0 [638.862424] Dynamic subtest rcs0: SUCCESS (0.075s) [638.875194] Starting dynamic subtest: vcs0 [640.422492] Dynamic subtest vcs0: SUCCESS (1.556s) [640.435414] Starting dynamic subtest: vcs1 [642.465709] Dynamic subtest vcs1: SUCCESS (2.042s) [642.476096] Starting dynamic subtest: vecs0 [644.489866] Dynamic subtest vecs0: SUCCESS (2.021s) [644.501445] Starting dynamic subtest: ccs0 [644.561193] Dynamic subtest ccs0: SUCCESS (0.071s) [644.563600] Subtest noreorder: SUCCESS (5.775s) [644.742735] [112/131] (391s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [644.853711] Starting subtest: yf-tiled-32bpp-rotate-0 [644.858056] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [644.969932] [113/131] (391s left) kms_flip (flip-vs-rmfb) [645.062602] Starting subtest: flip-vs-rmfb [645.064914] Starting dynamic subtest: A-eDP1 [653.759549] Dynamic subtest A-eDP1: SUCCESS (8.697s) [653.768738] Starting dynamic subtest: B-eDP1 [662.482442] Dynamic subtest B-eDP1: SUCCESS (8.723s) [662.493670] Starting dynamic subtest: C-eDP1 [671.226975] Dynamic subtest C-eDP1: SUCCESS (8.744s) [671.238647] Starting dynamic subtest: D-eDP1 [679.955645] Dynamic subtest D-eDP1: SUCCESS (8.728s) [679.960367] Subtest flip-vs-rmfb: SUCCESS (34.900s) [681.192499] [114/131] (355s left) kms_psr (pr-primary-page-flip) [681.288675] Starting subtest: pr-primary-page-flip [681.293106] Subtest pr-primary-page-flip: SKIP (0.000s) [681.371102] [115/131] (355s left) gem_exec_reloc (basic-cpu) [681.437988] Subtest basic-cpu: SKIP (0.000s) [681.528348] [116/131] (355s left) gem_ctx_persistence (engines-hostile) [681.603533] Starting subtest: engines-hostile [681.606031] Starting dynamic subtest: rcs0 [681.697074] Dynamic subtest rcs0: SUCCESS (0.093s) [681.709265] Starting dynamic subtest: bcs0 [681.772466] Dynamic subtest bcs0: SUCCESS (0.073s) [681.783427] Starting dynamic subtest: vcs0 [681.915054] Dynamic subtest vcs0: SUCCESS (0.141s) [681.925732] Starting dynamic subtest: vcs1 [681.991729] Dynamic subtest vcs1: SUCCESS (0.075s) [682.003407] Starting dynamic subtest: vecs0 [682.110282] Dynamic subtest vecs0: SUCCESS (0.116s) [682.121705] Starting dynamic subtest: ccs0 [682.211014] Dynamic subtest ccs0: SUCCESS (0.099s) [682.213292] Subtest engines-hostile: SUCCESS (0.608s) [682.339449] [117/131] (354s left) fbdev (nullptr) [682.379971] Starting subtest: nullptr [682.381984] Subtest nullptr: SUCCESS (0.000s) [682.434779] [118/131] (354s left) gem_mmap_wc (write-gtt-read-wc) [682.501485] Subtest write-gtt-read-wc: SKIP (0.000s) [682.550035] [119/131] (354s left) i915_pm_sseu (full-enable) [682.599007] Subtest full-enable: SKIP (0.000s) [682.682906] [120/131] (354s left) kms_atomic_transition (plane-all-transition-nonblocking) [682.775296] Starting subtest: plane-all-transition-nonblocking [682.777191] Starting dynamic subtest: pipe-A-eDP-1 [685.280793] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [685.581408] Starting dynamic subtest: pipe-B-eDP-1 [688.831204] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s) [689.111058] Subtest plane-all-transition-nonblocking: SUCCESS (6.332s) [689.944175] [121/131] (346s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [690.045736] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [690.050070] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [690.139075] [122/131] (346s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [690.248690] Starting subtest: bad-aux-stride-yf-tiled-ccs [690.250619] Starting dynamic subtest: pipe-A-eDP-1 [690.273454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [690.283282] Starting dynamic subtest: pipe-B-eDP-1 [690.305449] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [690.314848] Starting dynamic subtest: pipe-C-eDP-1 [690.337453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [690.346901] Starting dynamic subtest: pipe-D-eDP-1 [690.369195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [690.373362] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.006s) [692.394926] [123/131] (344s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [692.499523] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [692.501791] Starting dynamic subtest: pipe-A-eDP-1 [692.510845] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [692.521252] Starting dynamic subtest: pipe-B-eDP-1 [692.529890] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [692.539276] Starting dynamic subtest: pipe-C-eDP-1 [692.548247] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [692.558889] Starting dynamic subtest: pipe-D-eDP-1 [692.567165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [692.571203] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [694.849030] [124/131] (342s left) gem_exec_schedule (submit-late-slice) [694.927081] Starting subtest: submit-late-slice [694.929177] Starting dynamic subtest: rcs0 [694.947815] Dynamic subtest rcs0: SUCCESS (0.029s) [694.959794] Starting dynamic subtest: bcs0 [694.975818] Dynamic subtest bcs0: SUCCESS (0.028s) [694.985883] Starting dynamic subtest: vcs0 [695.006312] Dynamic subtest vcs0: SUCCESS (0.030s) [695.016154] Starting dynamic subtest: vcs1 [695.035235] Dynamic subtest vcs1: SUCCESS (0.028s) [695.045523] Starting dynamic subtest: vecs0 [695.063803] Dynamic subtest vecs0: SUCCESS (0.028s) [695.074101] Starting dynamic subtest: ccs0 [695.095872] Dynamic subtest ccs0: SUCCESS (0.032s) [695.098153] Subtest submit-late-slice: SUCCESS (0.178s) [696.523880] [125/131] (340s left) kms_pm_dc (dc5-retention-flops) [697.636542] Starting subtest: dc5-retention-flops [697.641191] Subtest dc5-retention-flops: SKIP (0.000s) [697.704218] [126/131] (339s left) kms_content_protection (lic-type-1) [697.884075] Starting subtest: lic-type-1 [701.282798] Subtest lic-type-1: SKIP (3.396s) [702.466640] [127/131] (334s left) tools_test (sysfs_l3_parity) [702.525893] Starting subtest: sysfs_l3_parity [702.593497] Subtest sysfs_l3_parity: SKIP (0.077s) [702.642522] [128/131] (334s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [702.701908] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [702.808875] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [702.880876] [129/131] (334s left) gem_eio (wait-wedge-1us) [703.155284] Starting subtest: wait-wedge-1us [704.580550] Subtest wait-wedge-1us: SUCCESS (1.425s) [704.729269] [130/131] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [704.835497] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [709.421234] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.588s) [709.573813] [131/131] (327s left) kms_plane_multiple (tiling-none) [709.684544] Starting subtest: tiling-none [709.686799] Starting dynamic subtest: pipe-A-eDP-1 [713.304182] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.618s) [713.320419] Starting dynamic subtest: pipe-B-eDP-1 [717.687523] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.381s) [717.697107] Starting dynamic subtest: pipe-C-eDP-1 [721.982877] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.295s) [721.994282] Starting dynamic subtest: pipe-D-eDP-1 [726.297548] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.313s) [726.299890] Subtest tiling-none: SUCCESS (16.611s) [727.105280] Closing watchdogs Done.