[60.167637] Initializing watchdogs [60.167678] /dev/watchdog0 [60.181502] [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] [60.185849] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.188072] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.191227] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [60.311485] Starting subtest: addfb25-y-tiled-small-legacy [60.315987] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [60.420728] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [60.522678] Starting subtest: plane-downscale-factor-0-75-with-modifiers [60.524885] Starting dynamic subtest: pipe-A [60.907891] Dynamic subtest pipe-A: SUCCESS (0.385s) [60.916450] Starting dynamic subtest: pipe-B [62.365920] Dynamic subtest pipe-B: SUCCESS (1.452s) [62.373053] Starting dynamic subtest: pipe-C [63.793622] Dynamic subtest pipe-C: SUCCESS (1.422s) [63.802601] Starting dynamic subtest: pipe-D [65.237242] Dynamic subtest pipe-D: SUCCESS (1.438s) [65.239732] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.700s) [66.500959] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [66.542237] Starting subtest: virtual-idle [69.991551] Subtest virtual-idle: SUCCESS (3.438s) [70.087200] [004/134] (950s left) gem_userptr_blits (huge-split) [70.152995] Starting subtest: huge-split [70.165308] Subtest huge-split: SUCCESS (0.012s) [70.316918] [005/134] (950s left) kms_psr (fbc-pr-no-drrs) [70.414705] Starting subtest: fbc-pr-no-drrs [70.418821] Subtest fbc-pr-no-drrs: SKIP (0.000s) [70.504556] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [70.614443] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [77.560333] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.943s) [77.702087] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [77.835786] Starting subtest: cursorA-vs-flipA-legacy [89.025668] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.185s) [89.858375] [008/134] (931s left) kms_psr (psr2-primary-page-flip) [89.955622] Starting subtest: psr2-primary-page-flip [89.957970] Starting dynamic subtest: eDP-1 [91.987767] Dynamic subtest eDP-1: SUCCESS (2.032s) [91.990078] Subtest psr2-primary-page-flip: SUCCESS (2.032s) [92.874596] [009/134] (928s left) i915_pm_rc6_residency (rc6-accuracy) [92.939974] Starting subtest: rc6-accuracy [92.942393] Starting dynamic subtest: gt0 [96.115352] Dynamic subtest gt0: SUCCESS (3.170s) [96.125967] Starting dynamic subtest: gt1 [99.286236] Dynamic subtest gt1: SUCCESS (3.168s) [99.288726] Subtest rc6-accuracy: SUCCESS (6.341s) [99.384220] [010/134] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [99.504239] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [106.687858] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.185s) [106.867965] [011/134] (914s left) kms_feature_discovery (psr2) [106.977214] Starting subtest: psr2 [106.979577] Subtest psr2: SUCCESS (0.000s) [107.105609] [012/134] (914s left) syncobj_wait (single-wait-all-for-submit-submitted) [107.182076] Starting subtest: single-wait-all-for-submit-submitted [107.289080] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s) [107.386673] [013/134] (913s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [107.498554] Starting subtest: 2x-wf_vblank-ts-check-interruptible [107.510468] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [107.647737] [014/134] (913s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [107.751802] Starting subtest: flip-primary-invalidate-overlay [119.301152] Subtest flip-primary-invalidate-overlay: SUCCESS (11.550s) [119.449905] [015/134] (901s left) i915_drm_fdinfo (busy-idle) [119.495738] Starting subtest: busy-idle [119.497355] Starting dynamic subtest: rcs0 [119.506992] Dynamic subtest rcs0: SKIP (0.011s) [119.518949] Starting dynamic subtest: bcs0 [119.526243] Dynamic subtest bcs0: SKIP (0.019s) [119.534899] Starting dynamic subtest: vcs0 [119.538292] Dynamic subtest vcs0: SKIP (0.000s) [119.545198] Starting dynamic subtest: vcs1 [119.548711] Dynamic subtest vcs1: SKIP (0.000s) [119.555694] Starting dynamic subtest: vecs0 [119.559044] Dynamic subtest vecs0: SKIP (0.000s) [119.566184] Starting dynamic subtest: ccs0 [119.569499] Dynamic subtest ccs0: SKIP (0.000s) [119.572860] Subtest busy-idle: SKIP (0.033s) [119.618599] [016/134] (901s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [119.679428] Starting subtest: invalid-bsd2-flag-on-vebox [119.681409] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [119.814158] [017/134] (901s left) syncobj_wait (single-wait-all-for-submit-signaled) [119.861925] Starting subtest: single-wait-all-for-submit-signaled [119.863469] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [119.997414] [018/134] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [120.107464] Starting subtest: fbcpsr-rgb101010-draw-blt [126.876459] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.770s) [127.024912] [019/134] (894s left) kms_pm_rpm (modeset-lpsp) [129.058447] Starting subtest: modeset-lpsp [130.525753] Subtest modeset-lpsp: SUCCESS (1.469s) [130.632545] [020/134] (890s left) i915_suspend (sysfs-reader) [130.706273] Starting subtest: sysfs-reader [148.216538] Subtest sysfs-reader: SUCCESS (3.220s) [148.268468] [021/134] (873s left) prime_vgem (sync) [148.428899] Starting subtest: sync [148.431051] Starting dynamic subtest: rcs0 [148.483213] Dynamic subtest rcs0: SUCCESS (0.052s) [148.491535] Starting dynamic subtest: bcs0 [148.549616] Dynamic subtest bcs0: SUCCESS (0.064s) [148.557684] Starting dynamic subtest: vcs0 [148.597136] Dynamic subtest vcs0: SUCCESS (0.046s) [148.605466] Starting dynamic subtest: vcs1 [148.641309] Dynamic subtest vcs1: SUCCESS (0.042s) [148.649638] Starting dynamic subtest: vecs0 [148.687310] Dynamic subtest vecs0: SUCCESS (0.044s) [148.695624] Starting dynamic subtest: ccs0 [148.733979] Dynamic subtest ccs0: SUCCESS (0.045s) [148.736441] Subtest sync: SUCCESS (0.297s) [148.894408] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [148.897478] [022/134] (872s left) api_intel_allocator (two-level-inception) [148.955932] Starting subtest: two-level-inception [154.454367] Subtest two-level-inception: SUCCESS (5.399s) [154.613684] [023/134] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [154.730159] Starting subtest: psr-2p-primscrn-cur-indfb-move [154.734477] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [154.891861] [024/134] (866s left) sriov_basic (bind-unbind-vf) [154.957428] Starting subtest: bind-unbind-vf [154.960435] Starting dynamic subtest: vf-1 [155.041400] Dynamic subtest vf-1: FAIL (0.034s) [155.050653] Starting dynamic subtest: vf-2 [155.125647] Dynamic subtest vf-2: FAIL (0.005s) [155.136630] Starting dynamic subtest: vf-3 [155.211280] Dynamic subtest vf-3: FAIL (0.004s) [155.221076] Starting dynamic subtest: vf-4 [155.295653] Dynamic subtest vf-4: FAIL (0.004s) [155.305876] Starting dynamic subtest: vf-5 [155.378958] Dynamic subtest vf-5: FAIL (0.004s) [155.389167] Starting dynamic subtest: vf-6 [155.464056] Dynamic subtest vf-6: FAIL (0.004s) [155.473877] Starting dynamic subtest: vf-7 [155.537275] Dynamic subtest vf-7: FAIL (0.003s) [155.545935] Starting dynamic subtest: vf-random [155.606428] Dynamic subtest vf-random: FAIL (0.004s) [155.615942] Starting dynamic subtest: vf-last [155.683495] Dynamic subtest vf-last: FAIL (0.004s) [155.685594] Subtest bind-unbind-vf: FAIL (0.570s) [155.726571] [025/134] (865s left) gem_eio (hibernate) [155.966738] Starting subtest: hibernate [170.684303] Subtest hibernate: SUCCESS (14.644s) [177.871584] [026/134] (850s left) kms_vrr (seamless-rr-switch-virtual) [177.990628] Starting subtest: seamless-rr-switch-virtual [177.997042] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [178.085722] [027/134] (850s left) api_intel_bb (render) [178.143479] Starting subtest: render [178.145720] Starting dynamic subtest: render-none-512 [178.239597] Dynamic subtest render-none-512: SUCCESS (0.098s) [178.252199] Starting dynamic subtest: render-none-1024 [178.613430] Dynamic subtest render-none-1024: SUCCESS (0.372s) [178.625138] Starting dynamic subtest: render-x-512 [178.697267] Dynamic subtest render-x-512: SUCCESS (0.084s) [178.708771] Starting dynamic subtest: render-x-1024 [179.028292] Dynamic subtest render-x-1024: SUCCESS (0.331s) [179.041166] Starting dynamic subtest: render-y-512 [179.158632] Dynamic subtest render-y-512: SUCCESS (0.128s) [179.168288] Starting dynamic subtest: render-y-1024 [179.496185] Dynamic subtest render-y-1024: SUCCESS (0.336s) [179.498949] Subtest render: SUCCESS (1.353s) [179.650741] [028/134] (849s left) kms_cursor_legacy (torture-bo) [179.764930] Starting subtest: torture-bo [179.766819] Starting dynamic subtest: pipe-A [186.447519] Dynamic subtest pipe-A: SUCCESS (6.677s) [186.461063] Starting dynamic subtest: pipe-B [192.797689] Dynamic subtest pipe-B: SUCCESS (6.346s) [192.810461] Starting dynamic subtest: pipe-C [198.762100] Dynamic subtest pipe-C: SUCCESS (5.960s) [198.774452] Starting dynamic subtest: pipe-D [204.630519] Dynamic subtest pipe-D: SUCCESS (5.866s) [204.640686] Starting dynamic subtest: all-pipes [210.888464] Dynamic subtest all-pipes: SUCCESS (6.253s) [210.890940] Subtest torture-bo: SUCCESS (31.110s) [211.068928] [029/134] (817s left) kms_rotation_crc (sprite-rotation-270) [211.158488] Starting subtest: sprite-rotation-270 [211.162914] Subtest sprite-rotation-270: SKIP (0.001s) [211.255999] [030/134] (817s left) kms_prime (basic-modeset-hybrid) [211.345161] Subtest basic-modeset-hybrid: SKIP (0.000s) [211.459219] [031/134] (817s left) gem_ctx_persistence (many-contexts) [211.525985] Starting subtest: many-contexts [249.264391] Subtest many-contexts: SUCCESS (37.721s) [249.368179] [032/134] (779s left) gem_create (busy-create) [249.433049] Starting subtest: busy-create [249.435346] Starting dynamic subtest: smem0 [283.172937] Dynamic subtest smem0: SUCCESS (33.722s) [283.175503] Subtest busy-create: SUCCESS (33.723s) [283.382630] [033/134] (745s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [283.481624] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [283.485743] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [283.615485] [034/134] (745s left) kms_psr (fbc-psr-cursor-blt) [283.727598] Starting subtest: fbc-psr-cursor-blt [283.729885] Starting dynamic subtest: eDP-1 [283.733992] Dynamic subtest eDP-1: SKIP (0.000s) [283.738162] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [283.824013] [035/134] (745s left) gem_sync (basic-store-each) [283.898379] Starting subtest: basic-store-each [286.305901] Subtest basic-store-each: SUCCESS (2.416s) [286.515951] [036/134] (742s left) prime_mmap (test_userptr) [286.564412] Starting subtest: test_userptr [286.566737] Starting dynamic subtest: test_userptr-smem [286.568895] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [286.571142] Subtest test_userptr: SUCCESS (0.001s) [286.693162] [037/134] (742s left) kms_pipe_crc_basic (nonblocking-crc) [286.805419] Starting subtest: nonblocking-crc [286.807829] Starting dynamic subtest: pipe-A-eDP-1 [287.568084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s) [287.578967] Starting dynamic subtest: pipe-B-eDP-1 [289.015950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s) [289.026968] Starting dynamic subtest: pipe-C-eDP-1 [290.395195] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [290.406828] Starting dynamic subtest: pipe-D-eDP-1 [291.717995] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s) [291.720446] Subtest nonblocking-crc: SUCCESS (4.912s) [292.556697] [038/134] (736s left) perf (unprivileged-single-ctx-counters) [292.691313] Starting subtest: unprivileged-single-ctx-counters [292.695756] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [292.739227] [039/134] (736s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [297.705046] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [297.707328] Starting dynamic subtest: pipe-A-eDP-1 [304.311207] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.601s) [304.322151] Starting dynamic subtest: pipe-B-eDP-1 [310.867978] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.560s) [310.870219] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.165s) [311.765104] [040/134] (717s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [316.708964] Starting subtest: pr-overlay-plane-move-continuous-sf [316.713668] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [317.595116] [041/134] (711s left) kms_psr (fbc-psr-sprite-blt) [317.697255] Starting subtest: fbc-psr-sprite-blt [317.699514] Starting dynamic subtest: eDP-1 [317.703633] Dynamic subtest eDP-1: SKIP (0.000s) [317.707727] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [317.794426] [042/134] (711s left) sysfs_timeslice_duration (invalid) [317.866189] Starting subtest: invalid [317.868536] Starting dynamic subtest: vecs0 [317.870828] Dynamic subtest vecs0: SUCCESS (0.000s) [317.881141] Starting dynamic subtest: ccs0 [317.883355] Dynamic subtest ccs0: SUCCESS (0.000s) [317.892395] Starting dynamic subtest: vcs0 [317.894632] Dynamic subtest vcs0: SUCCESS (0.000s) [317.903311] Starting dynamic subtest: bcs0 [317.905523] Dynamic subtest bcs0: SUCCESS (0.000s) [317.914409] Starting dynamic subtest: rcs0 [317.916621] Dynamic subtest rcs0: SUCCESS (0.000s) [317.926068] Starting dynamic subtest: vcs1 [317.927964] Dynamic subtest vcs1: SUCCESS (0.000s) [317.929900] Subtest invalid: SUCCESS (0.005s) [318.001921] [043/134] (711s left) gem_barrier_race (remote-request) [318.073681] Starting subtest: remote-request [318.075598] Starting dynamic subtest: rcs0 [323.211301] Dynamic subtest rcs0: SUCCESS (5.143s) [323.215309] Subtest remote-request: SUCCESS (5.145s) [323.389480] [044/134] (706s left) kms_big_fb (yf-tiled-addfb-size-overflow) [323.505896] Starting subtest: yf-tiled-addfb-size-overflow [323.509715] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [323.626719] [045/134] (705s left) vgem_basic (busy-fence) [323.675011] Starting subtest: busy-fence [323.676989] Subtest busy-fence: SUCCESS (0.000s) [323.755973] [046/134] (705s left) gem_mmap (bad-object) [323.825851] Subtest bad-object: SKIP (0.000s) [323.894564] [047/134] (705s left) kms_big_fb (x-tiled-64bpp-rotate-180) [323.999643] Starting subtest: x-tiled-64bpp-rotate-180 [325.612149] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.612s) [325.839932] [048/134] (703s left) syncobj_timeline (etime-multi-wait-submitted) [325.891529] Starting subtest: etime-multi-wait-submitted [325.996645] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [326.099743] [049/134] (703s left) gem_readwrite (read-write) [326.165215] Subtest read-write: SKIP (0.000s) [326.233192] [050/134] (703s left) kms_content_protection (mei-interface) [326.368288] Starting subtest: mei-interface [326.372977] Subtest mei-interface: SKIP (0.001s) [326.529432] [051/134] (703s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [326.623925] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [327.302848] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [327.495729] [052/134] (702s left) gem_mmap_gtt (isolation) [327.551989] Subtest isolation: SKIP (0.000s) [327.626881] [053/134] (702s left) kms_cursor_edge_walk (64x64-top-edge) [327.723439] Starting subtest: 64x64-top-edge [327.725716] Starting dynamic subtest: pipe-A-eDP-1 [331.236739] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.514s) [331.246276] Starting dynamic subtest: pipe-D-eDP-1 [334.343856] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s) [334.346127] Subtest 64x64-top-edge: SUCCESS (6.626s) [335.183064] [054/134] (694s left) syncobj_wait (wait-all-snapshot) [335.247981] Starting subtest: wait-all-snapshot [335.329611] Subtest wait-all-snapshot: SUCCESS (0.081s) [335.428806] [055/134] (694s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [335.523873] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [335.527758] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [335.657184] [056/134] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [335.775187] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [335.779291] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [335.897399] [057/134] (694s left) gem_create (create-invalid-size) [335.962231] Starting subtest: create-invalid-size [335.964637] Subtest create-invalid-size: SUCCESS (0.000s) [336.181307] [058/134] (693s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [336.242823] Starting subtest: y-tiled-ccs-to-yf-tiled [336.247220] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [336.447712] [059/134] (693s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [336.550168] Starting subtest: psr-argb161616f-draw-mmap-wc [336.554502] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [336.695413] [060/134] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [336.806521] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [336.810514] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [336.945447] [061/134] (693s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [337.047824] Starting subtest: switch-modeset-ultra-joiner-big-joiner [337.051910] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [337.132378] [062/134] (693s left) sw_sync (sync_merge_same) [337.167628] Starting subtest: sync_merge_same [337.169617] Subtest sync_merge_same: SUCCESS (0.000s) [337.248574] [063/134] (693s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [337.346987] Starting subtest: planes-downscale-factor-0-75-unity-scaling [337.349294] Starting dynamic subtest: pipe-A [337.408793] Dynamic subtest pipe-A: SUCCESS (0.064s) [337.421278] Starting dynamic subtest: pipe-B [338.577236] Dynamic subtest pipe-B: SUCCESS (1.166s) [338.594152] Starting dynamic subtest: pipe-C [339.686870] Dynamic subtest pipe-C: SUCCESS (1.108s) [339.701757] Starting dynamic subtest: pipe-D [340.814928] Dynamic subtest pipe-D: SUCCESS (1.126s) [340.817347] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.472s) [341.998955] [064/134] (688s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [342.070834] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [342.072710] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [342.203028] [065/134] (688s left) gem_render_copy (linear-to-vebox-yf-tiled) [342.272816] Starting subtest: linear-to-vebox-yf-tiled [342.277207] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [342.476409] [066/134] (687s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [342.577964] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [342.580222] Starting dynamic subtest: A-eDP1 [346.193824] Dynamic subtest A-eDP1: SUCCESS (3.613s) [346.204616] Starting dynamic subtest: B-eDP1 [349.388803] Dynamic subtest B-eDP1: SUCCESS (3.195s) [349.398800] Starting dynamic subtest: C-eDP1 [352.500154] Dynamic subtest C-eDP1: SUCCESS (3.109s) [352.511592] Starting dynamic subtest: D-eDP1 [355.584332] Dynamic subtest D-eDP1: SUCCESS (3.086s) [355.586676] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.011s) [356.412605] [067/134] (674s left) kms_chamelium_color (ctm-limited-range) [356.532807] Subtest ctm-limited-range: SKIP (0.000s) [356.577378] [068/134] (673s left) gem_mmap_wc (write) [356.632500] Subtest write: SKIP (0.000s) [356.693240] [069/134] (673s left) prime_mmap (test_correct) [356.745618] Starting subtest: test_correct [356.747528] Starting dynamic subtest: test_correct-smem [356.773152] Dynamic subtest test_correct-smem: SUCCESS (0.030s) [356.775608] Subtest test_correct: SUCCESS (0.030s) [356.895699] [070/134] (673s left) device_reset (cold-reset-bound) [356.947388] Starting subtest: cold-reset-bound [356.952118] Subtest cold-reset-bound: SKIP (0.000s) [357.043467] [071/134] (673s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [357.143040] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [364.267402] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.127s) [364.444972] [072/134] (666s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [364.551917] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [368.753487] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.205s) [369.934801] [073/134] (660s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [370.028644] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [370.030921] Starting dynamic subtest: pipe-A-eDP-1 [370.054202] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [370.066825] Starting dynamic subtest: pipe-B-eDP-1 [370.088180] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [370.097825] Starting dynamic subtest: pipe-C-eDP-1 [370.119314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [370.129649] Starting dynamic subtest: pipe-D-eDP-1 [370.150723] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [370.154990] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s) [372.219481] [074/134] (658s left) gem_exec_fence (syncobj-channel) [372.663481] Starting subtest: syncobj-channel [373.679143] Subtest syncobj-channel: SUCCESS (1.015s) [374.263993] [075/134] (656s left) gem_exec_reloc (basic-gtt-noreloc) [374.323895] Subtest basic-gtt-noreloc: SKIP (0.000s) [374.416165] [076/134] (656s left) kms_flip (dpms-off-confusion-interruptible) [374.513612] Starting subtest: dpms-off-confusion-interruptible [374.515942] Starting dynamic subtest: A-eDP1 [383.206333] Dynamic subtest A-eDP1: SUCCESS (8.692s) [383.217701] Starting dynamic subtest: B-eDP1 [391.843735] Dynamic subtest B-eDP1: SUCCESS (8.634s) [391.858173] Starting dynamic subtest: C-eDP1 [400.472640] Dynamic subtest C-eDP1: SUCCESS (8.626s) [400.485942] Starting dynamic subtest: D-eDP1 [409.098849] Dynamic subtest D-eDP1: SUCCESS (8.623s) [409.101218] Subtest dpms-off-confusion-interruptible: SUCCESS (34.585s) [410.385491] [077/134] (620s left) kms_vblank (wait-forked-busy) [410.488840] Starting subtest: wait-forked-busy [410.490809] Starting dynamic subtest: pipe-A-eDP-1 [412.375138] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s) [412.390910] Starting dynamic subtest: pipe-D-eDP-1 [414.919888] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s) [414.921764] Subtest wait-forked-busy: SUCCESS (4.430s) [415.756105] [078/134] (615s left) kms_chamelium_frames (dp-frame-dump) [416.140174] Subtest dp-frame-dump: SKIP (0.000s) [416.931859] [079/134] (614s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [417.027284] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [417.029604] Starting dynamic subtest: pipe-A-eDP-1 [417.087617] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [417.098793] Starting dynamic subtest: pipe-B-eDP-1 [417.157609] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [417.168806] Starting dynamic subtest: pipe-C-eDP-1 [417.226111] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [417.236662] Starting dynamic subtest: pipe-D-eDP-1 [417.290682] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [417.294986] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [419.331146] [080/134] (611s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [419.433031] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [419.437331] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [419.579318] [081/134] (611s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [419.688132] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [419.692341] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [419.811275] [082/134] (611s left) gen7_exec_parse (cmd-crossing-page) [419.871271] Subtest cmd-crossing-page: SKIP (0.000s) [419.953565] [083/134] (611s left) kms_atomic_transition (modeset-transition-nonblocking) [420.051234] Starting subtest: modeset-transition-nonblocking [420.053477] Starting dynamic subtest: 1x-outputs [431.068531] Dynamic subtest 1x-outputs: SUCCESS (11.017s) [431.071113] Subtest modeset-transition-nonblocking: SUCCESS (11.018s) [431.942073] [084/134] (599s left) kms_draw_crc (draw-method-mmap-cpu) [432.050236] Starting subtest: draw-method-mmap-cpu [432.052460] Starting dynamic subtest: xrgb8888-untiled [432.271514] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s) [432.281666] Starting dynamic subtest: rgb565-untiled [432.471621] Dynamic subtest rgb565-untiled: SUCCESS (0.199s) [432.481918] Starting dynamic subtest: xrgb2101010-untiled [432.682760] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [432.695311] Starting dynamic subtest: xbgr16161616f-untiled [432.915477] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s) [432.925613] Starting dynamic subtest: xrgb8888-xtiled [433.048988] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [433.059504] Starting dynamic subtest: rgb565-xtiled [433.182417] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [433.191763] Starting dynamic subtest: xrgb2101010-xtiled [433.293410] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [433.302615] Starting dynamic subtest: xbgr16161616f-xtiled [433.427026] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [433.437075] Starting dynamic subtest: xrgb8888-4tiled [433.560204] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s) [433.571787] Starting dynamic subtest: rgb565-4tiled [433.693615] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s) [433.705437] Starting dynamic subtest: xrgb2101010-4tiled [433.826826] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s) [433.836886] Starting dynamic subtest: xbgr16161616f-4tiled [433.971323] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [433.973118] Subtest draw-method-mmap-cpu: SUCCESS (1.923s) [434.101689] [085/134] (597s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [434.197773] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [434.199330] Starting dynamic subtest: pipe-A-eDP-1 [434.342411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s) [434.351701] Starting dynamic subtest: pipe-B-eDP-1 [434.366972] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [434.376030] Starting dynamic subtest: pipe-C-eDP-1 [434.392379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [434.401520] Starting dynamic subtest: pipe-D-eDP-1 [434.417022] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [434.418634] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s) [436.689476] [086/134] (594s left) gem_exec_schedule (u-semaphore-user) [436.760741] Starting subtest: u-semaphore-user [436.809636] Subtest u-semaphore-user: SUCCESS (0.057s) [438.229608] [087/134] (593s left) gem_exec_fence (basic-await) [438.405179] Starting subtest: basic-await [438.407811] Starting dynamic subtest: rcs0 [438.480200] Dynamic subtest rcs0: SUCCESS (0.075s) [438.493222] Starting dynamic subtest: bcs0 [438.552809] Dynamic subtest bcs0: SUCCESS (0.071s) [438.565053] Starting dynamic subtest: vcs0 [438.625620] Dynamic subtest vcs0: SUCCESS (0.071s) [438.638408] Starting dynamic subtest: vcs1 [438.696809] Dynamic subtest vcs1: SUCCESS (0.070s) [438.709320] Starting dynamic subtest: vecs0 [438.768548] Dynamic subtest vecs0: SUCCESS (0.070s) [438.782516] Starting dynamic subtest: ccs0 [438.841154] Dynamic subtest ccs0: SUCCESS (0.070s) [438.843630] Subtest basic-await: SUCCESS (0.437s) [440.285256] [088/134] (591s left) kms_rotation_crc (cursor-rotation-180) [440.394216] Starting subtest: cursor-rotation-180 [441.944747] Subtest cursor-rotation-180: SUCCESS (1.551s) [443.145300] [089/134] (588s left) kms_cursor_crc (cursor-onscreen-512x170) [443.430793] Starting subtest: cursor-onscreen-512x170 [443.435393] Subtest cursor-onscreen-512x170: SKIP (0.001s) [443.618904] [090/134] (587s left) kms_big_fb (linear-addfb) [443.735542] Starting subtest: linear-addfb [443.737916] Subtest linear-addfb: SUCCESS (0.000s) [443.875617] [091/134] (587s left) gem_exec_whisper (basic-queues) [443.944508] Starting subtest: basic-queues [450.552659] Subtest basic-queues: SUCCESS (6.605s) [450.761342] [092/134] (580s left) gem_exec_reloc (basic-scanout) [450.824359] Subtest basic-scanout: SKIP (0.000s) [450.903415] [093/134] (580s left) kms_plane_lowres (tiling-4) [450.994710] Starting subtest: tiling-4 [450.996969] Starting dynamic subtest: pipe-A-eDP-1 [451.001592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [451.296881] Starting dynamic subtest: pipe-B-eDP-1 [451.301327] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [451.311024] Starting dynamic subtest: pipe-C-eDP-1 [451.315424] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [451.325097] Starting dynamic subtest: pipe-D-eDP-1 [451.329060] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [451.333048] Subtest tiling-4: SKIP (0.301s) [452.173112] [094/134] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [452.274404] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [459.355640] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.085s) [459.549637] [095/134] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [459.656882] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [463.283146] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.630s) [464.491037] [096/134] (567s left) gem_ctx_create (basic) [464.551233] Starting subtest: basic [464.553572] Subtest basic: SUCCESS (0.000s) [464.764387] [097/134] (566s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [464.864325] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [464.866585] Starting dynamic subtest: pipe-A-default-mode [466.015005] Dynamic subtest pipe-A-default-mode: SKIP (1.148s) [466.019328] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.150s) [466.188627] [098/134] (565s left) gem_pwrite (basic-exhaustion) [466.249910] Subtest basic-exhaustion: SKIP (0.000s) [466.310101] [099/134] (565s left) kms_atomic_transition (plane-all-transition-nonblocking) [466.412034] Starting subtest: plane-all-transition-nonblocking [466.414142] Starting dynamic subtest: pipe-A-eDP-1 [468.905229] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [469.237309] Starting dynamic subtest: pipe-B-eDP-1 [472.426807] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.200s) [472.728765] Subtest plane-all-transition-nonblocking: SUCCESS (6.316s) [473.579479] [100/134] (558s left) kms_color_pipeline (plane-lut1d-lut1d) [473.699879] Starting subtest: plane-lut1d-lut1d [473.712918] Starting dynamic subtest: pipe-A-eDP-1 [474.434278] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s) [475.136294] Starting dynamic subtest: pipe-B-eDP-1 [475.952841] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s) [476.466896] Starting dynamic subtest: pipe-C-eDP-1 [477.343605] Dynamic subtest pipe-C-eDP-1: FAIL (0.291s) [477.786015] Starting dynamic subtest: pipe-D-eDP-1 [478.617525] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s) [478.619896] Subtest plane-lut1d-lut1d: FAIL (4.633s) [479.201064] [101/134] (552s left) gem_lmem_swapping (verify-random) [479.245721] Subtest verify-random: SKIP (0.000s) [479.293165] [102/134] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [479.404726] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [479.408951] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [479.514058] [103/134] (552s left) sw_sync (sync_random_merge) [479.555397] Starting subtest: sync_random_merge [479.589963] Subtest sync_random_merge: SUCCESS (0.038s) [479.677583] [104/134] (552s left) syncobj_timeline (invalid-signal-bad-pad) [479.736903] Starting subtest: invalid-signal-bad-pad [479.738815] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [479.854693] [105/134] (552s left) gem_mmap_gtt (basic) [479.910245] Subtest basic: SKIP (0.000s) [479.979316] [106/134] (552s left) gem_exec_balancer (invalid-balancer) [480.037916] Starting subtest: invalid-balancer [480.919841] Subtest invalid-balancer: SUCCESS (0.880s) [481.247845] [107/134] (550s left) kms_big_fb (y-tiled-8bpp-rotate-90) [481.362061] Starting subtest: y-tiled-8bpp-rotate-90 [481.366014] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [481.484622] [108/134] (550s left) gem_render_linear_blits (basic) [481.548519] Starting subtest: basic [481.571311] Subtest basic: SUCCESS (0.023s) [481.658045] [109/134] (550s left) gem_ctx_shared (q-promotion) [481.731718] Starting subtest: Q-promotion [481.734054] Starting dynamic subtest: rcs0 [481.835901] Dynamic subtest rcs0: SUCCESS (0.103s) [481.856479] Starting dynamic subtest: vcs0 [481.920859] Dynamic subtest vcs0: SUCCESS (0.084s) [481.937810] Starting dynamic subtest: vcs1 [482.003230] Dynamic subtest vcs1: SUCCESS (0.081s) [482.019312] Starting dynamic subtest: vecs0 [482.081142] Dynamic subtest vecs0: SUCCESS (0.077s) [482.098109] Starting dynamic subtest: ccs0 [482.174178] Dynamic subtest ccs0: SUCCESS (0.092s) [482.176407] Subtest Q-promotion: SUCCESS (0.443s) [483.302816] [110/134] (548s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [483.415118] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [483.419532] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [483.563834] [111/134] (548s left) syncobj_timeline (single-wait-for-submit-available-submitted) [483.627388] Starting subtest: single-wait-for-submit-available-submitted [483.629883] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [483.766941] [112/134] (548s left) gem_flink_basic (bad-open) [483.831877] Starting subtest: bad-open [483.833793] Subtest bad-open: SUCCESS (0.000s) [483.985943] [113/134] (548s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [484.095720] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [484.098047] Starting dynamic subtest: pipe-A-eDP-1 [484.908499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s) [484.918835] Starting dynamic subtest: pipe-B-eDP-1 [486.459542] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s) [486.470959] Starting dynamic subtest: pipe-C-eDP-1 [488.006979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s) [488.018480] Starting dynamic subtest: pipe-D-eDP-1 [489.550297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s) [489.552613] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.447s) [490.750083] [114/134] (541s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [490.857148] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [490.861625] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [490.994472] [115/134] (541s left) kms_hdr (bpc-switch-dpms) [491.082762] Starting subtest: bpc-switch-dpms [492.194730] Starting dynamic subtest: pipe-A-eDP-1 [496.725887] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.531s) [496.728309] Subtest bpc-switch-dpms: SUCCESS (5.644s) [496.899496] [116/134] (535s left) kms_chamelium_hpd (hdmi-hpd) [497.287450] Subtest hdmi-hpd: SKIP (0.000s) [498.093441] [117/134] (534s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [498.197515] Starting subtest: primary-yf-tiled-reflect-x-270 [498.201932] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [498.297215] [118/134] (534s left) prime_vgem (basic-write) [498.390438] Starting subtest: basic-write [498.398218] Subtest basic-write: SKIP (0.006s) [498.550416] [119/134] (534s left) gem_ctx_freq (sysfs) [498.621135] Starting subtest: sysfs [498.623489] Starting dynamic subtest: gt0 [504.162797] Dynamic subtest gt0: SUCCESS (5.540s) [504.176506] Starting dynamic subtest: gt1 [546.199908] Dynamic subtest gt1: SUCCESS (42.029s) [546.202505] Subtest sysfs: SUCCESS (47.574s) [546.348533] [120/134] (486s left) kms_cursor_crc (cursor-onscreen-max-size) [546.657286] Starting subtest: cursor-onscreen-max-size [546.663349] Subtest cursor-onscreen-max-size: SKIP (0.000s) [546.803984] [121/134] (485s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [546.906833] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [546.910727] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [547.032094] [122/134] (485s left) perf (per-context-mode-unprivileged) [547.135577] Starting subtest: per-context-mode-unprivileged [547.140249] Subtest per-context-mode-unprivileged: SKIP (0.000s) [547.183111] [123/134] (485s left) kms_setmode (basic) [547.257677] Starting subtest: basic [547.581619] Starting dynamic subtest: pipe-A-eDP-1 [549.628028] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.042s) [549.969514] Starting dynamic subtest: pipe-B-eDP-1 [552.045465] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.081s) [552.361111] Subtest basic: SUCCESS (5.099s) [553.221445] [124/134] (479s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [553.330891] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [554.000079] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [554.234642] [125/134] (478s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [554.344318] Starting subtest: plane-use-after-nonblocking-unbind [554.346545] Starting dynamic subtest: pipe-A-eDP-1 [554.412130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s) [554.719429] Starting dynamic subtest: pipe-B-eDP-1 [555.498876] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.791s) [555.792520] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.447s) [556.689467] [126/134] (476s left) kms_atomic_interruptible (universal-setplane-primary) [556.799551] Starting subtest: universal-setplane-primary [556.801928] Starting dynamic subtest: pipe-A-eDP-1 [564.179791] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.380s) [564.182204] Subtest universal-setplane-primary: SUCCESS (7.381s) [565.052723] [127/134] (467s left) kms_pm_backlight (fade-with-dpms) [565.152602] Starting subtest: fade-with-dpms [567.707429] Starting dynamic subtest: eDP-1 [570.381780] Dynamic subtest eDP-1: SUCCESS (2.672s) [570.384066] Subtest fade-with-dpms: SUCCESS (5.229s) [571.214228] [128/134] (461s left) perf_pmu (event-wait) [571.254325] Starting subtest: event-wait [571.256635] Starting dynamic subtest: rcs0 [571.261171] Dynamic subtest rcs0: SKIP (0.000s) [571.265552] Subtest event-wait: SKIP (0.001s) [571.410792] [129/134] (461s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [571.510169] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [571.514581] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [571.654169] [130/134] (461s left) gem_exec_whisper (basic-contexts-all) [571.723339] Starting subtest: basic-contexts-all [581.114317] Subtest basic-contexts-all: SUCCESS (9.385s) [581.323724] [131/134] (451s left) gem_spin_batch (spin-each) [581.378284] Starting subtest: spin-each [584.748339] Subtest spin-each: SUCCESS (3.368s) [586.337970] [132/134] (446s left) kms_universal_plane (disable-primary-vs-flip) [586.437462] Starting subtest: disable-primary-vs-flip [586.439728] Starting dynamic subtest: pipe-A-eDP-1 [587.944451] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.506s) [587.955217] Starting dynamic subtest: pipe-B-eDP-1 [590.152398] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.206s) [590.163840] Starting dynamic subtest: pipe-C-eDP-1 [592.381526] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.227s) [592.393835] Starting dynamic subtest: pipe-D-eDP-1 [594.555539] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.172s) [594.557756] Subtest disable-primary-vs-flip: SUCCESS (8.117s) [595.381492] [133/134] (437s left) gem_exec_schedule (preemptive-hang) [595.566866] Starting subtest: preemptive-hang [595.569477] Starting dynamic subtest: rcs0 [604.296494] Dynamic subtest rcs0: SUCCESS (8.726s) [604.309031] Starting dynamic subtest: bcs0 [613.314611] Dynamic subtest bcs0: SUCCESS (9.018s) [613.328292] Starting dynamic subtest: vcs0 [622.272015] Dynamic subtest vcs0: SUCCESS (8.950s) [622.283966] Starting dynamic subtest: vcs1 [631.294516] Dynamic subtest vcs1: SUCCESS (9.021s) [631.308106] Starting dynamic subtest: vecs0 [640.314599] Dynamic subtest vecs0: SUCCESS (9.015s) [640.326927] Starting dynamic subtest: ccs0 [649.279385] Dynamic subtest ccs0: SUCCESS (8.963s) [649.282018] Subtest preemptive-hang: SUCCESS (53.703s) [649.556902] [134/134] (383s left) syncobj_wait (invalid-signal-bad-pad) [649.616061] Starting subtest: invalid-signal-bad-pad [649.618319] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [649.748020] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_plane_scaling results: parsing output: 2/ for test: i915_drm_fdinfo results: parsing output: 3/ for test: gem_userptr_blits results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: i915_pm_rc6_residency results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_feature_discovery results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_psr_stress_test results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: gem_exec_params results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_pm_rpm results: parsing output: 19/ for test: i915_suspend results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: api_intel_allocator results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: sriov_basic results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: kms_vrr results: parsing output: 26/ for test: api_intel_bb results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_rotation_crc results: parsing output: 29/ for test: kms_prime results: parsing output: 30/ for test: gem_ctx_persistence results: parsing output: 31/ for test: gem_create results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: gem_sync results: parsing output: 35/ for test: prime_mmap results: parsing output: 36/ for test: kms_pipe_crc_basic results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_psr2_sf results: parsing output: 39/ for test: kms_psr2_sf results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: sysfs_timeslice_duration results: parsing output: 42/ for test: gem_barrier_race results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: vgem_basic results: parsing output: 45/ for test: gem_mmap results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_readwrite results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: kms_cursor_edge_walk results: parsing output: 53/ for test: syncobj_wait results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_create results: parsing output: 57/ for test: gem_render_copy results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_joiner results: parsing output: 61/ for test: sw_sync results: parsing output: 62/ for test: kms_plane_scaling results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_chamelium_color results: parsing output: 67/ for test: gem_mmap_wc results: parsing output: 68/ for test: prime_mmap results: parsing output: 69/ for test: device_reset results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_vblank results: parsing output: 77/ for test: kms_chamelium_frames results: parsing output: 78/ for test: kms_ccs results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gen7_exec_parse results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: kms_draw_crc results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: gem_exec_fence results: parsing output: 87/ for test: kms_rotation_crc results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: gem_exec_whisper results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: kms_plane_lowres results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_ctx_create results: parsing output: 96/ for test: kms_flip_scaled_crc results: parsing output: 97/ for test: gem_pwrite results: parsing output: 98/ for test: kms_atomic_transition results: parsing output: 99/ for test: kms_color_pipeline results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: sw_sync results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: gem_mmap_gtt results: parsing output: 105/ for test: gem_exec_balancer results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_render_linear_blits results: parsing output: 108/ for test: gem_ctx_shared results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_flink_basic results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_hdr results: parsing output: 115/ for test: kms_chamelium_hpd results: parsing output: 116/ for test: kms_rotation_crc results: parsing output: 117/ for test: prime_vgem results: parsing output: 118/ for test: gem_ctx_freq results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: perf results: parsing output: 122/ for test: kms_setmode results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_atomic_transition results: parsing output: 125/ for test: kms_atomic_interruptible results: parsing output: 126/ for test: kms_pm_backlight results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_exec_whisper results: parsing output: 130/ for test: gem_spin_batch results: parsing output: 131/ for test: kms_universal_plane results: parsing output: 132/ for test: gem_exec_schedule results: parsing output: 133/ for test: syncobj_wait Done.