[57.024992] Initializing watchdogs [57.025083] /dev/watchdog0 [57.043854] [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.047611] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.049724] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.053107] [001/127] (960s left) gem_flink_basic (basic) [57.157847] Starting subtest: basic [57.160371] Subtest basic: SUCCESS (0.000s) [57.252136] [002/127] (960s left) kms_frontbuffer_tracking (psr-suspend) [57.364334] Starting subtest: psr-suspend [92.992556] Subtest psr-suspend: SUCCESS (5.666s) [93.127040] [003/127] (954s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [93.231657] Starting subtest: plane-downscale-factor-0-75-with-modifiers [93.234212] Starting dynamic subtest: pipe-A [93.733161] Dynamic subtest pipe-A: SUCCESS (0.506s) [93.743065] Starting dynamic subtest: pipe-B [95.333395] Dynamic subtest pipe-B: SUCCESS (1.613s) [95.341887] Starting dynamic subtest: pipe-C [96.861891] Dynamic subtest pipe-C: SUCCESS (1.539s) [96.873226] Starting dynamic subtest: pipe-D [98.482011] Dynamic subtest pipe-D: SUCCESS (1.628s) [98.484377] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (5.286s) [99.657943] [004/127] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [99.770410] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [102.891085] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.136s) [103.020205] [005/127] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [103.129926] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [103.133642] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [103.244960] [006/127] (944s left) gem_lmem_swapping (random-engines) [103.293486] Subtest random-engines: SKIP (0.000s) [103.328378] [007/127] (944s left) kms_atomic_transition (modeset-transition-fencing) [103.412495] Starting subtest: modeset-transition-fencing [103.414491] Starting dynamic subtest: 1x-outputs [113.952888] Dynamic subtest 1x-outputs: SUCCESS (10.556s) [114.228713] Subtest modeset-transition-fencing: SUCCESS (10.831s) [115.071605] [008/127] (932s left) kms_cursor_edge_walk (64x64-right-edge) [115.159568] Starting subtest: 64x64-right-edge [115.161812] Starting dynamic subtest: pipe-A-eDP-1 [118.645241] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s) [118.652059] Starting dynamic subtest: pipe-D-eDP-1 [121.760558] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s) [121.763254] Subtest 64x64-right-edge: SUCCESS (6.605s) [122.555386] [009/127] (925s left) kms_psr (psr-primary-blt) [122.654646] Starting subtest: psr-primary-blt [122.656895] Starting dynamic subtest: eDP-1 [124.447953] Dynamic subtest eDP-1: SUCCESS (1.794s) [124.450636] Subtest psr-primary-blt: SUCCESS (1.794s) [125.299547] [010/127] (922s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [130.349675] Starting subtest: pr-overlay-plane-update-continuous-sf [130.355045] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [131.198924] [011/127] (916s left) prime_vgem (basic-blt) [131.312680] Starting subtest: basic-blt [131.336839] Subtest basic-blt: SUCCESS (0.026s) [131.477734] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true [131.481351] [012/127] (916s left) kms_addfb_basic (addfb25-bad-modifier) [131.588884] Starting subtest: addfb25-bad-modifier [131.591223] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [131.703564] [013/127] (916s left) gem_exec_reloc (basic-wc-noreloc) [131.783993] Subtest basic-wc-noreloc: SKIP (0.000s) [131.853471] [014/127] (916s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [131.953569] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [136.546058] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.594s) [136.685049] [015/127] (911s left) perf_pmu (busy-check-all) [136.730824] Starting subtest: busy-check-all [136.732847] Starting dynamic subtest: rcs0 [137.299993] Dynamic subtest rcs0: SUCCESS (0.571s) [137.310701] Starting dynamic subtest: bcs0 [137.848394] Dynamic subtest bcs0: SUCCESS (0.548s) [137.861644] Starting dynamic subtest: vcs0 [139.912038] Dynamic subtest vcs0: SUCCESS (2.061s) [139.922683] Starting dynamic subtest: vcs1 [141.897999] Dynamic subtest vcs1: SUCCESS (1.985s) [141.908552] Starting dynamic subtest: vecs0 [143.945187] Dynamic subtest vecs0: SUCCESS (2.046s) [143.955688] Starting dynamic subtest: ccs0 [144.500191] Dynamic subtest ccs0: SUCCESS (0.556s) [144.502616] Subtest busy-check-all: SUCCESS (7.772s) [144.613599] [016/127] (903s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render) [144.721552] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render [147.962447] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (3.245s) [148.092114] [017/127] (899s left) kms_cursor_crc (cursor-rapid-movement-128x128) [148.282067] Starting subtest: cursor-rapid-movement-128x128 [148.286125] Starting dynamic subtest: pipe-A-eDP-1 [148.838261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s) [148.860119] Starting dynamic subtest: pipe-D-eDP-1 [150.081552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [150.083572] Subtest cursor-rapid-movement-128x128: SUCCESS (1.796s) [150.919873] [018/127] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [151.028364] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [156.203109] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.180s) [156.336260] [019/127] (891s left) gem_pxp (reject-modify-context-protection-off-1) [156.462774] Starting subtest: reject-modify-context-protection-off-1 [156.465273] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s) [156.583190] [020/127] (891s left) syncobj_wait (invalid-signal-one-illegal-handle) [156.634025] Starting subtest: invalid-signal-one-illegal-handle [156.636052] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [156.735689] [021/127] (891s left) gem_exec_params (invalid-ring) [156.797313] Starting subtest: invalid-ring [156.799519] Subtest invalid-ring: SUCCESS (0.000s) [156.901621] [022/127] (891s left) gem_exec_parallel (fds) [156.972042] Starting subtest: fds [156.974213] Starting dynamic subtest: rcs0 [159.417966] Dynamic subtest rcs0: SUCCESS (2.444s) [159.429591] Starting dynamic subtest: bcs0 [162.400659] Dynamic subtest bcs0: SUCCESS (2.983s) [162.409291] Starting dynamic subtest: vcs0 [166.218061] Dynamic subtest vcs0: SUCCESS (3.817s) [166.227818] Starting dynamic subtest: vcs1 [170.101354] Dynamic subtest vcs1: SUCCESS (3.884s) [170.111554] Starting dynamic subtest: vecs0 [174.141424] Dynamic subtest vecs0: SUCCESS (4.040s) [174.152522] Starting dynamic subtest: ccs0 [177.266801] Dynamic subtest ccs0: SUCCESS (3.126s) [177.268959] Subtest fds: SUCCESS (20.300s) [177.453694] [023/127] (870s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [177.575310] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [178.809574] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.237s) [179.100112] [024/127] (869s left) gem_ctx_param (invalid-set-ringsize) [179.163252] Starting subtest: invalid-set-ringsize [179.165953] Subtest invalid-set-ringsize: SUCCESS (0.000s) [179.231900] [025/127] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [179.332007] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [179.336373] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [179.429771] [026/127] (868s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [179.536699] Starting subtest: yf-tiled-64bpp-rotate-90 [179.541004] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [179.644021] [027/127] (868s left) gem_mmap_gtt (basic-write-gtt) [179.703669] Subtest basic-write-gtt: SKIP (0.000s) [179.760368] [028/127] (868s left) kms_psr (pr-cursor-mmap-gtt) [179.849008] Starting subtest: pr-cursor-mmap-gtt [179.853525] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [179.924783] [029/127] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [180.023143] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [180.027280] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [180.122783] [030/127] (868s left) syncobj_timeline (invalid-query-bad-pad) [180.188517] Starting subtest: invalid-query-bad-pad [180.190517] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [180.281640] [031/127] (868s left) kms_pwrite_crc [181.880888] [032/127] (866s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [181.942201] Starting subtest: verify-pxp-execution-after-suspend-resume [188.839237] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.898s) [188.949151] [033/127] (859s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [189.070329] Starting subtest: cursorB-vs-flipA-atomic [189.074343] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [189.200607] [034/127] (859s left) api_intel_bb (simple-bb) [189.253953] Starting subtest: simple-bb [189.258508] Subtest simple-bb: SUCCESS (0.006s) [189.387059] [035/127] (859s left) vgem_basic (unload) [189.422986] Starting subtest: unload [218.676353] Subtest unload: SUCCESS (29.247s) [218.766455] [036/127] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [218.876104] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [218.880641] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [218.973268] [037/127] (829s left) kms_flip (2x-plain-flip-fb-recreate) [219.067909] Starting subtest: 2x-plain-flip-fb-recreate [219.079146] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s) [219.156709] [038/127] (829s left) prime_vgem (basic-fence-read) [219.236364] Starting subtest: basic-fence-read [219.244310] Subtest basic-fence-read: SKIP (0.005s) [219.367496] [039/127] (829s left) kms_psr (fbc-psr2-sprite-plane-move) [219.458048] Starting subtest: fbc-psr2-sprite-plane-move [219.460416] Starting dynamic subtest: eDP-1 [219.464868] Dynamic subtest eDP-1: SKIP (0.000s) [219.469294] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [219.526656] [040/127] (829s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [219.918562] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [220.765720] [041/127] (828s left) kms_big_fb (x-tiled-32bpp-rotate-180) [220.879799] Starting subtest: x-tiled-32bpp-rotate-180 [222.625359] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.745s) [222.817113] [042/127] (826s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [222.880057] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [222.932227] [043/127] (825s left) syncobj_wait (invalid-single-wait-unsubmitted) [222.984603] Starting subtest: invalid-single-wait-unsubmitted [222.987038] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [223.096930] [044/127] (825s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [223.197108] Starting subtest: crc-primary-basic-y-tiled-ccs [223.199483] Starting dynamic subtest: pipe-A-eDP-1 [223.222296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [223.232817] Starting dynamic subtest: pipe-B-eDP-1 [223.253434] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [223.260717] Starting dynamic subtest: pipe-C-eDP-1 [223.281409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [223.288368] Starting dynamic subtest: pipe-D-eDP-1 [223.309122] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [223.313365] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s) [225.343343] [045/127] (823s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt) [225.448349] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt [225.452817] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [225.533233] [046/127] (823s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [225.582198] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [225.682782] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s) [225.754975] [047/127] (823s left) kms_frontbuffer_tracking (fbc-tiling-y) [225.864118] Starting subtest: fbc-tiling-y [225.868249] Subtest fbc-tiling-y: SKIP (0.000s) [225.967910] [048/127] (823s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [226.072161] Starting subtest: fbc-rgb565-draw-mmap-cpu [229.122713] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.054s) [229.243457] [049/127] (819s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [229.353636] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [229.363692] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s) [229.444051] [050/127] (819s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [229.560423] Starting subtest: cursorA-vs-flipA-varying-size [240.716610] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.153s) [241.589867] [051/127] (807s left) gem_exec_whisper (basic-contexts-priority) [241.654280] Starting subtest: basic-contexts-priority [266.134695] Subtest basic-contexts-priority: SUCCESS (24.481s) [266.310811] [052/127] (782s left) kms_dither (fb-8bpc-vs-panel-8bpc) [266.403772] Starting subtest: fb-8bpc-vs-panel-8bpc [266.405974] Starting dynamic subtest: pipe-A-eDP-1 [267.775261] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.369s) [267.777587] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.371s) [268.637656] [053/127] (780s left) gem_create (create-ext-placement-sanity-check) [268.801514] Starting subtest: create-ext-placement-sanity-check [268.804132] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s) [268.901106] [054/127] (780s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [268.999152] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [269.001775] Starting dynamic subtest: A-eDP1 [277.880841] Dynamic subtest A-eDP1: SUCCESS (8.882s) [277.890720] Starting dynamic subtest: B-eDP1 [286.802879] Dynamic subtest B-eDP1: SUCCESS (8.921s) [286.813041] Starting dynamic subtest: C-eDP1 [295.716581] Dynamic subtest C-eDP1: SUCCESS (8.914s) [295.727441] Starting dynamic subtest: D-eDP1 [304.640535] Dynamic subtest D-eDP1: SUCCESS (8.925s) [304.643087] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.651s) [305.858377] [055/127] (743s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [305.922599] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [305.927431] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [306.100648] [056/127] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [306.196048] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [306.200425] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [306.310272] [057/127] (743s left) kms_scaling_modes (scaling-mode-full-aspect) [306.401800] Starting subtest: scaling-mode-full-aspect [306.404052] Starting dynamic subtest: pipe-A-eDP-1 [306.515160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.113s) [306.523097] Starting dynamic subtest: pipe-B-eDP-1 [307.675913] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s) [307.684969] Starting dynamic subtest: pipe-C-eDP-1 [308.784725] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s) [308.795134] Starting dynamic subtest: pipe-D-eDP-1 [309.910292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [309.912595] Subtest scaling-mode-full-aspect: SUCCESS (3.510s) [311.061125] [058/127] (738s left) kms_vblank (ts-continuation-suspend) [311.165491] Starting subtest: ts-continuation-suspend [311.167799] Starting dynamic subtest: pipe-A-eDP-1 [328.070278] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.567s) [328.087077] Starting dynamic subtest: pipe-D-eDP-1 [345.014280] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.095s) [345.016979] Subtest ts-continuation-suspend: SUCCESS (3.665s) [345.860932] [059/127] (733s left) gen3_render_tiledx_blits [345.984286] [060/127] (733s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [346.086705] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [346.089564] Starting dynamic subtest: pipe-A-eDP-1 [346.137693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.051s) [346.147232] Starting dynamic subtest: pipe-B-eDP-1 [346.188619] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.050s) [346.197387] Starting dynamic subtest: pipe-C-eDP-1 [346.244383] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.055s) [346.253441] Starting dynamic subtest: pipe-D-eDP-1 [346.294730] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.050s) [346.297574] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.211s) [348.411002] [061/127] (731s left) kms_lease (lease-invalid-connector) [348.514593] Starting subtest: lease-invalid-connector [348.517569] Starting dynamic subtest: pipe-A-eDP-1 [348.520571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [348.529940] Starting dynamic subtest: pipe-B-eDP-1 [348.532312] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [348.540596] Starting dynamic subtest: pipe-C-eDP-1 [348.543531] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [348.551476] Starting dynamic subtest: pipe-D-eDP-1 [348.554172] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [348.556762] Subtest lease-invalid-connector: SUCCESS (0.004s) [348.588668] [062/127] (731s left) perf_pmu (semaphore-busy) [348.634609] Starting subtest: semaphore-busy [348.637530] Starting dynamic subtest: rcs0 [350.280018] Dynamic subtest rcs0: SUCCESS (1.652s) [350.291343] Starting dynamic subtest: bcs0 [350.917707] Dynamic subtest bcs0: FAIL (0.563s) [350.926118] Starting dynamic subtest: vcs0 [351.479656] Dynamic subtest vcs0: FAIL (0.551s) [351.488932] Starting dynamic subtest: vcs1 [352.722102] Dynamic subtest vcs1: FAIL (1.251s) [352.730633] Starting dynamic subtest: vecs0 [354.713519] Dynamic subtest vecs0: FAIL (1.990s) [354.732306] Starting dynamic subtest: ccs0 [356.690318] Dynamic subtest ccs0: FAIL (1.987s) [356.693064] Subtest semaphore-busy: FAIL (8.001s) [356.728042] [063/127] (722s left) gem_vm_create (invalid-destroy) [356.788511] Starting subtest: invalid-destroy [356.790995] Subtest invalid-destroy: SUCCESS (0.002s) [356.898588] [064/127] (722s left) gem_shrink (reclaim) [356.972518] Starting subtest: reclaim [359.463991] Subtest reclaim: SUCCESS (2.496s) [359.627087] [065/127] (720s left) kms_invalid_mode (overflow-vrefresh) [359.737600] Starting subtest: overflow-vrefresh [359.740442] Starting dynamic subtest: pipe-A-eDP-1 [360.017284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s) [360.028929] Starting dynamic subtest: pipe-B-eDP-1 [360.031615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [360.039703] Starting dynamic subtest: pipe-C-eDP-1 [360.042232] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [360.050153] Starting dynamic subtest: pipe-D-eDP-1 [360.052753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [360.055663] Subtest overflow-vrefresh: SUCCESS (0.285s) [360.800140] [066/127] (719s left) gem_exec_schedule (preempt-user) [360.876433] Starting subtest: preempt-user [360.879709] Starting dynamic subtest: rcs0 [360.889684] Dynamic subtest rcs0: SUCCESS (0.024s) [360.900455] Starting dynamic subtest: bcs0 [360.910669] Dynamic subtest bcs0: SUCCESS (0.019s) [360.924238] Starting dynamic subtest: vcs0 [360.931279] Dynamic subtest vcs0: SUCCESS (0.018s) [360.940614] Starting dynamic subtest: vcs1 [360.949451] Dynamic subtest vcs1: SUCCESS (0.020s) [360.958568] Starting dynamic subtest: vecs0 [360.969357] Dynamic subtest vecs0: SUCCESS (0.019s) [360.978981] Starting dynamic subtest: ccs0 [360.987696] Dynamic subtest ccs0: SUCCESS (0.018s) [360.990458] Subtest preempt-user: SUCCESS (0.123s) [362.197739] [067/127] (717s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [362.264633] Starting subtest: invalid-bsd2-flag-on-vebox [362.267698] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [362.378118] [068/127] (717s left) gem_exec_reloc (basic-cpu-wc-active) [362.445476] Subtest basic-cpu-wc-active: SKIP (0.000s) [362.526062] [069/127] (717s left) kms_flip (flip-vs-wf_vblank-interruptible) [362.632399] Starting subtest: flip-vs-wf_vblank-interruptible [362.634974] Starting dynamic subtest: A-eDP1 [364.545066] Dynamic subtest A-eDP1: SUCCESS (1.913s) [364.555464] Starting dynamic subtest: B-eDP1 [366.469511] Dynamic subtest B-eDP1: SUCCESS (1.926s) [366.478364] Starting dynamic subtest: C-eDP1 [368.376501] Dynamic subtest C-eDP1: SUCCESS (1.907s) [368.388634] Starting dynamic subtest: D-eDP1 [370.301489] Dynamic subtest D-eDP1: SUCCESS (1.925s) [370.304036] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.680s) [371.512937] [070/127] (708s left) sw_sync (alloc_fence) [371.554695] Starting subtest: alloc_fence [371.557054] Subtest alloc_fence: SUCCESS (0.000s) [371.599597] [071/127] (708s left) gem_exec_fence (concurrent) [371.789602] Starting subtest: concurrent [371.795461] Subtest concurrent: SKIP (0.000s) [373.190685] [072/127] (706s left) gem_set_tiling_vs_pwrite [373.322244] [073/127] (706s left) gem_ctx_shared (q-independent) [373.388603] Starting subtest: Q-independent [373.391427] Starting dynamic subtest: rcs0 [373.466305] Dynamic subtest rcs0: SUCCESS (0.077s) [373.477494] Starting dynamic subtest: vcs0 [373.508052] Dynamic subtest vcs0: SUCCESS (0.042s) [373.517290] Starting dynamic subtest: vcs1 [373.543546] Dynamic subtest vcs1: SUCCESS (0.035s) [373.552657] Starting dynamic subtest: vecs0 [373.584727] Dynamic subtest vecs0: SUCCESS (0.041s) [373.594155] Starting dynamic subtest: ccs0 [373.627429] Dynamic subtest ccs0: SUCCESS (0.042s) [373.630007] Subtest Q-independent: SUCCESS (0.239s) [375.203555] [074/127] (704s left) vgem_basic (bad-flag) [375.244296] Starting subtest: bad-flag [375.246736] Subtest bad-flag: SUCCESS (0.000s) [375.296615] [075/127] (704s left) gem_ppgtt (blt-vs-render-ctxn) [375.359310] Starting subtest: blt-vs-render-ctxN [408.515678] Subtest blt-vs-render-ctxN: SUCCESS (33.158s) [408.662899] [076/127] (671s left) syncobj_timeline (single-wait-for-submit-available-signaled) [408.789436] Starting subtest: single-wait-for-submit-available-signaled [408.792430] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [408.859748] [077/127] (671s left) gem_exec_schedule (wide) [409.059759] Starting subtest: wide [409.062690] Starting dynamic subtest: rcs0 [419.760217] Dynamic subtest rcs0: SUCCESS (10.703s) [419.774120] Starting dynamic subtest: vcs0 [430.067201] Dynamic subtest vcs0: SUCCESS (10.311s) [430.078033] Starting dynamic subtest: vcs1 [439.589369] Dynamic subtest vcs1: SUCCESS (9.525s) [439.601716] Starting dynamic subtest: vecs0 [451.006004] Dynamic subtest vecs0: SUCCESS (11.411s) [451.015318] Starting dynamic subtest: ccs0 [462.823627] Dynamic subtest ccs0: SUCCESS (11.813s) [462.826958] Subtest wide: SUCCESS (53.767s) [464.080883] [078/127] (616s left) kms_pipe_stress (stress-xrgb8888-ytiled) [464.178719] Starting subtest: stress-xrgb8888-ytiled [464.184477] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [464.242695] [079/127] (616s left) kms_cursor_crc (cursor-offscreen-max-size) [464.553146] Starting subtest: cursor-offscreen-max-size [464.561513] Subtest cursor-offscreen-max-size: SKIP (0.000s) [464.660913] [080/127] (615s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [464.755120] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [464.757445] Starting dynamic subtest: pipe-A-default-mode [465.122270] Dynamic subtest pipe-A-default-mode: SKIP (0.363s) [465.127034] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.365s) [465.911941] [081/127] (614s left) kms_psr (fbc-psr2-cursor-plane-move) [466.018424] Starting subtest: fbc-psr2-cursor-plane-move [466.021005] Starting dynamic subtest: eDP-1 [466.025719] Dynamic subtest eDP-1: SKIP (0.000s) [466.030658] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [466.086511] [082/127] (614s left) gem_pread (snoop) [466.142460] Subtest snoop: SKIP (0.000s) [466.199359] [083/127] (614s left) kms_psr (psr2-cursor-blt) [466.298584] Starting subtest: psr2-cursor-blt [466.301560] Starting dynamic subtest: eDP-1 [468.001684] Dynamic subtest eDP-1: SUCCESS (1.701s) [468.004171] Subtest psr2-cursor-blt: SUCCESS (1.701s) [468.788569] [084/127] (611s left) syncobj_timeline (reset-unsignaled) [468.849931] Starting subtest: reset-unsignaled [468.852210] Subtest reset-unsignaled: SUCCESS (0.000s) [468.958140] [085/127] (611s left) gem_exec_gttfill (engines) [469.030776] Starting subtest: engines [469.033636] Starting dynamic subtest: rcs0 [493.567200] Dynamic subtest rcs0: SUCCESS (24.535s) [493.578823] Starting dynamic subtest: bcs0 [518.894306] Dynamic subtest bcs0: SUCCESS (25.331s) [518.903844] Starting dynamic subtest: vcs0 [544.294031] Dynamic subtest vcs0: SUCCESS (25.403s) [544.305501] Starting dynamic subtest: vcs1 [569.709102] Dynamic subtest vcs1: SUCCESS (25.420s) [569.719313] Starting dynamic subtest: vecs0 [595.106636] Dynamic subtest vecs0: SUCCESS (25.385s) [595.116968] Starting dynamic subtest: ccs0 [620.763388] Dynamic subtest ccs0: SUCCESS (25.650s) [620.766218] Subtest engines: SUCCESS (151.736s) [620.951072] [086/127] (459s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [621.092580] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [621.095455] Starting dynamic subtest: pipe-A-eDP-1 [621.120455] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [621.129431] Starting dynamic subtest: pipe-B-eDP-1 [621.154280] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [621.163427] Starting dynamic subtest: pipe-C-eDP-1 [621.190087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [621.200112] Starting dynamic subtest: pipe-D-eDP-1 [621.226047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [621.231408] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [623.202072] [087/127] (457s left) i915_fb_tiling (basic-x-tiling) [623.279928] Subtest basic-x-tiling: SKIP (0.000s) [623.339003] [088/127] (457s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [623.438553] Starting subtest: primary-yf-tiled-reflect-x-90 [623.444488] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [623.507036] [089/127] (457s left) kms_big_fb (linear-16bpp-rotate-180) [623.623263] Starting subtest: linear-16bpp-rotate-180 [625.165123] Subtest linear-16bpp-rotate-180: SUCCESS (1.544s) [625.340381] [090/127] (455s left) dumb_buffer (map-valid) [625.402510] Starting subtest: map-valid [625.404911] Subtest map-valid: SUCCESS (0.000s) [625.508873] [091/127] (455s left) kms_color (ctm-0-50) [625.611942] Starting subtest: ctm-0-50 [625.614372] Starting dynamic subtest: pipe-A-eDP-1 [628.994713] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.380s) [629.004378] Starting dynamic subtest: pipe-B-eDP-1 [633.069829] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.074s) [633.081471] Starting dynamic subtest: pipe-C-eDP-1 [637.040686] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.971s) [637.051774] Starting dynamic subtest: pipe-D-eDP-1 [640.960548] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.921s) [640.963511] Subtest ctm-0-50: SUCCESS (15.347s) [641.810153] [092/127] (438s left) kms_chamelium_audio (hdmi-audio-edid) [642.209861] Subtest hdmi-audio-edid: SKIP (0.000s) [643.018855] [093/127] (437s left) i915_pm_rc6_residency (media-rc6-accuracy) [643.072743] Starting subtest: media-rc6-accuracy [643.077285] Subtest media-rc6-accuracy: SKIP (0.000s) [643.181963] [094/127] (437s left) kms_async_flips (test-cursor-atomic) [643.272433] Starting subtest: test-cursor-atomic [643.277590] Subtest test-cursor-atomic: SKIP (0.000s) [644.464268] [095/127] (436s left) gem_exec_schedule (implicit-boths) [644.561961] Starting subtest: implicit-boths [644.564226] Starting dynamic subtest: rcs0 [644.659870] Dynamic subtest rcs0: SUCCESS (0.110s) [644.672279] Starting dynamic subtest: vcs0 [644.751201] Dynamic subtest vcs0: SUCCESS (0.090s) [644.762996] Starting dynamic subtest: vcs1 [644.823158] Dynamic subtest vcs1: SUCCESS (0.072s) [644.835871] Starting dynamic subtest: vecs0 [644.895988] Dynamic subtest vecs0: SUCCESS (0.072s) [644.908072] Starting dynamic subtest: ccs0 [644.969951] Dynamic subtest ccs0: SUCCESS (0.073s) [644.973186] Subtest implicit-boths: SUCCESS (0.420s) [646.222320] [096/127] (434s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [646.325189] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [646.327420] Starting dynamic subtest: pipe-A [646.336847] Dynamic subtest pipe-A: SKIP (0.004s) [646.345576] Starting dynamic subtest: pipe-B [646.356558] Dynamic subtest pipe-B: SKIP (0.015s) [646.367276] Starting dynamic subtest: pipe-C [646.376410] Dynamic subtest pipe-C: SKIP (0.016s) [646.385076] Starting dynamic subtest: pipe-D [646.392998] Dynamic subtest pipe-D: SKIP (0.015s) [646.396912] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.052s) [646.475229] [097/127] (434s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [646.587221] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [651.205916] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.623s) [651.324754] [098/127] (429s left) gem_exec_reloc (basic-gtt) [651.394483] Subtest basic-gtt: SKIP (0.000s) [651.480973] [099/127] (429s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [651.595118] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [651.600265] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [651.687391] [100/127] (429s left) i915_pm_rps (engine-order) [651.752618] Starting subtest: engine-order [656.357698] Subtest engine-order: SUCCESS (4.604s) [656.443057] [101/127] (424s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [656.581381] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [656.583916] Starting dynamic subtest: pipe-A [656.593979] Dynamic subtest pipe-A: SKIP (0.005s) [656.603266] Starting dynamic subtest: pipe-B [656.612536] Dynamic subtest pipe-B: SKIP (0.017s) [656.621724] Starting dynamic subtest: pipe-C [656.631813] Dynamic subtest pipe-C: SKIP (0.016s) [656.640619] Starting dynamic subtest: pipe-D [656.649260] Dynamic subtest pipe-D: SKIP (0.016s) [656.653487] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.056s) [656.742051] [102/127] (424s left) kms_big_fb (y-tiled-16bpp-rotate-270) [656.855589] Starting subtest: y-tiled-16bpp-rotate-270 [656.860940] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [656.945701] [103/127] (424s left) gem_bad_reloc (negative-reloc) [657.013521] Subtest negative-reloc: SKIP (0.000s) [657.061914] [104/127] (424s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [657.162203] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [662.016622] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.858s) [662.138986] [105/127] (419s left) gem_softpin (full) [662.198380] Starting subtest: full [662.207451] Subtest full: SUCCESS (0.009s) [662.345785] [106/127] (418s left) kms_vrr (flipline) [662.451091] Starting subtest: flipline [662.459345] Subtest flipline: SKIP (0.000s) [662.519088] [107/127] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [662.629506] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [662.634621] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [662.713343] [108/127] (418s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [662.811276] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [662.813712] Starting dynamic subtest: pipe-A-eDP-1 [663.245261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s) [663.254453] Starting dynamic subtest: pipe-B-eDP-1 [664.662785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s) [664.673608] Starting dynamic subtest: pipe-C-eDP-1 [666.064319] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s) [666.073265] Starting dynamic subtest: pipe-D-eDP-1 [667.393533] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [667.396232] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.543s) [668.562381] [109/127] (412s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [668.656500] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [668.659235] Starting dynamic subtest: pipe-A-default-mode [668.966149] Dynamic subtest pipe-A-default-mode: SKIP (0.305s) [668.971740] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.306s) [669.789706] [110/127] (411s left) gem_exec_reloc (basic-gtt-read) [669.853578] Subtest basic-gtt-read: SKIP (0.000s) [669.943054] [111/127] (411s left) gem_render_copy_redux (flink-interruptible) [670.006386] Starting subtest: flink-interruptible [670.892052] Subtest flink-interruptible: SUCCESS (0.887s) [671.031100] [112/127] (410s left) gem_mmap_offset (close-race) [671.095210] Starting subtest: close-race [691.235695] Subtest close-race: SUCCESS (20.142s) [691.367425] [113/127] (390s left) syncobj_wait (single-wait-for-submit-unsubmitted) [691.425607] Starting subtest: single-wait-for-submit-unsubmitted [691.527730] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s) [691.599602] [114/127] (389s left) gem_exec_balancer (semaphore) [691.669268] Starting subtest: semaphore [693.136548] Subtest semaphore: SUCCESS (1.466s) [693.470804] [115/127] (388s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [693.578562] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [693.583603] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [693.662764] [116/127] (387s left) kms_content_protection (dp-mst-lic-type-0) [693.839201] Starting subtest: dp-mst-lic-type-0 [693.844748] Subtest dp-mst-lic-type-0: SKIP (0.000s) [693.971561] [117/127] (387s left) gem_mmap_gtt (basic-copy) [694.032734] Subtest basic-copy: SKIP (0.000s) [694.101955] [118/127] (387s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [694.222288] Starting subtest: basic-busy-flip-before-cursor-legacy [694.227343] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [694.316946] [119/127] (387s left) drm_fdinfo (context-close-stress) [694.364091] Starting subtest: context-close-stress [705.109570] Subtest context-close-stress: SUCCESS (10.746s) [705.388048] [120/127] (376s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [705.902331] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [706.709809] [121/127] (375s left) intel_hwmon (hwmon-read) [706.772575] Subtest hwmon-read: SKIP (0.000s) [706.856616] [122/127] (374s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [711.855364] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [711.858056] Starting dynamic subtest: pipe-A-eDP-1 [723.595990] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.739s) [723.611755] Starting dynamic subtest: pipe-B-eDP-1 [735.314384] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.721s) [735.316712] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.463s) [736.148924] [123/127] (345s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [736.257799] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [736.262668] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [736.364024] [124/127] (345s left) api_intel_allocator (reloc-allocator) [736.429683] Starting subtest: reloc-allocator [736.432563] Starting dynamic subtest: basic [736.435157] Dynamic subtest basic: SUCCESS (0.004s) [736.446157] Starting dynamic subtest: parallel-one [736.449084] Dynamic subtest parallel-one: SUCCESS (0.008s) [736.461228] Starting dynamic subtest: print [736.463546] Dynamic subtest print: SUCCESS (0.000s) [736.472202] Starting dynamic subtest: reuse [736.474445] Dynamic subtest reuse: SUCCESS (0.000s) [736.482970] Starting dynamic subtest: fork-reopen-allocator [736.485361] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [736.487592] Subtest reloc-allocator: SUCCESS (0.029s) [736.563116] [125/127] (345s left) syncobj_timeline (invalid-wait-bad-flags) [736.623721] Starting subtest: invalid-wait-bad-flags [736.626321] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [736.706702] [126/127] (345s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [736.814323] Starting subtest: fbcpsr-modesetfrombusy [740.838679] Subtest fbcpsr-modesetfrombusy: SUCCESS (4.032s) [740.993934] [127/127] (340s left) syncobj_wait (wait-for-submit-complex) [741.056452] Starting subtest: wait-for-submit-complex [741.119378] Subtest wait-for-submit-complex: SUCCESS (0.063s) [741.188962] Closing watchdogs Done.