[60.594347] Initializing watchdogs [60.594480] /dev/watchdog0 [60.608319] [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.612354] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.614357] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.616239] [001/130] (960s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [60.783347] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [60.795203] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [60.861484] [002/130] (960s left) kms_atomic_transition (plane-all-transition) [60.954936] Starting subtest: plane-all-transition [60.956085] Starting dynamic subtest: pipe-A-eDP-1 [63.486041] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [63.772561] Starting dynamic subtest: pipe-B-eDP-1 [67.076488] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.286s) [67.352070] Subtest plane-all-transition: SUCCESS (6.346s) [68.186337] [003/130] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [68.280115] Starting subtest: fbc-1p-primscrn-spr-indfb-move [71.876906] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.585s) [72.139011] [004/130] (949s left) gem_pread (self) [72.200258] Subtest self: SKIP (0.000s) [72.256649] [005/130] (949s left) kms_pipe_crc_basic (read-crc-frame-sequence) [72.354717] Starting subtest: read-crc-frame-sequence [72.355779] Starting dynamic subtest: pipe-A-eDP-1 [73.062967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s) [73.069345] Starting dynamic subtest: pipe-B-eDP-1 [74.399416] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s) [74.405381] Starting dynamic subtest: pipe-C-eDP-1 [75.686204] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s) [75.693481] Starting dynamic subtest: pipe-D-eDP-1 [76.989395] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [76.990624] Subtest read-crc-frame-sequence: SUCCESS (4.625s) [77.846581] [006/130] (943s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [77.934589] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [77.935580] Starting dynamic subtest: pipe-A-eDP-1 [77.945824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [77.951921] Starting dynamic subtest: pipe-B-eDP-1 [77.961100] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [77.966175] Starting dynamic subtest: pipe-C-eDP-1 [77.975172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [77.979986] Starting dynamic subtest: pipe-D-eDP-1 [77.989115] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [77.990781] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s) [80.100629] [007/130] (941s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [80.206447] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [81.110342] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.903s) [81.281239] [008/130] (940s left) i915_pm_rps (waitboost) [81.341705] Starting subtest: waitboost [81.369214] Subtest waitboost: FAIL (0.008s) [81.404936] [009/130] (940s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [81.488824] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [81.489892] Starting dynamic subtest: pipe-A-eDP-1 [81.498870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [81.504294] Starting dynamic subtest: pipe-B-eDP-1 [81.512941] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [81.518214] Starting dynamic subtest: pipe-C-eDP-1 [81.526156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [81.531117] Starting dynamic subtest: pipe-D-eDP-1 [81.539139] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [81.540813] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s) [83.653189] [010/130] (937s left) syncobj_wait (multi-wait-signaled) [83.705405] Starting subtest: multi-wait-signaled [83.706430] Subtest multi-wait-signaled: SUCCESS (0.000s) [83.801987] [011/130] (937s left) syncobj_timeline (etime-single-wait-submitted) [83.854701] Starting subtest: etime-single-wait-submitted [83.959681] Subtest etime-single-wait-submitted: SUCCESS (0.102s) [84.027175] [012/130] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [84.128170] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [84.130113] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [84.223757] [013/130] (937s left) perf (unprivileged-single-ctx-counters) [84.323928] Starting subtest: unprivileged-single-ctx-counters [84.325741] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [84.352720] [014/130] (937s left) drm_read (invalid-buffer) [84.504355] Starting subtest: invalid-buffer [84.505418] Subtest invalid-buffer: SUCCESS (0.000s) [84.623808] [015/130] (936s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [84.724768] Starting subtest: fbc-rgb101010-draw-mmap-gtt [84.726609] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [84.817059] [016/130] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [84.913387] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [84.915197] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [85.009797] [017/130] (936s left) kms_pm_rpm (modeset-lpsp) [87.147410] Starting subtest: modeset-lpsp [88.612278] Subtest modeset-lpsp: SUCCESS (1.465s) [88.690204] [018/130] (933s left) perf_pmu (idle) [88.723699] Starting subtest: idle [88.724625] Starting dynamic subtest: rcs0 [89.308362] Dynamic subtest rcs0: SUCCESS (0.581s) [89.315529] Starting dynamic subtest: bcs0 [89.837610] Dynamic subtest bcs0: SUCCESS (0.527s) [89.844685] Starting dynamic subtest: vcs0 [90.358658] Dynamic subtest vcs0: SUCCESS (0.522s) [90.365493] Starting dynamic subtest: vcs1 [90.880831] Dynamic subtest vcs1: SUCCESS (0.521s) [90.888513] Starting dynamic subtest: vecs0 [91.408935] Dynamic subtest vecs0: SUCCESS (0.529s) [91.417612] Starting dynamic subtest: ccs0 [91.928726] Dynamic subtest ccs0: SUCCESS (0.517s) [91.930430] Subtest idle: SUCCESS (3.199s) [92.045644] [019/130] (929s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [92.103656] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [92.104839] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [92.195591] [020/130] (929s left) gem_exec_params (invalid-bsd1-flag-on-blt) [92.256879] Starting subtest: invalid-bsd1-flag-on-blt [92.257995] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [92.344750] [021/130] (929s left) gem_ctx_shared (exec-single-timeline) [92.399581] Starting subtest: exec-single-timeline [92.400823] Starting dynamic subtest: rcs0 [93.449714] Dynamic subtest rcs0: SUCCESS (1.046s) [93.458909] Starting dynamic subtest: bcs0 [94.536124] Dynamic subtest bcs0: SUCCESS (1.085s) [94.544607] Starting dynamic subtest: vcs0 [95.625486] Dynamic subtest vcs0: SUCCESS (1.088s) [95.634421] Starting dynamic subtest: vcs1 [96.713839] Dynamic subtest vcs1: SUCCESS (1.087s) [96.726438] Starting dynamic subtest: vecs0 [97.800581] Dynamic subtest vecs0: SUCCESS (1.086s) [97.809199] Starting dynamic subtest: ccs0 [98.888980] Dynamic subtest ccs0: SUCCESS (1.087s) [98.890949] Subtest exec-single-timeline: SUCCESS (6.483s) [99.067095] [022/130] (922s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [99.173732] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [99.174821] Starting dynamic subtest: pipe-A-eDP-1 [99.182884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [99.189978] Starting dynamic subtest: pipe-B-eDP-1 [99.197631] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [99.204490] Starting dynamic subtest: pipe-C-eDP-1 [99.211971] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [99.217600] Starting dynamic subtest: pipe-D-eDP-1 [99.225441] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [99.226343] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s) [101.361614] [023/130] (920s left) kms_content_protection (lic-type-1) [101.536422] Starting subtest: lic-type-1 [104.847253] Subtest lic-type-1: SKIP (3.309s) [106.011607] [024/130] (915s left) kms_writeback (writeback-check-output) [106.097697] Subtest writeback-check-output: SKIP (0.000s) [106.132254] [025/130] (915s left) prime_mmap_coherency (read) [106.193060] Starting subtest: read [111.575995] Subtest read: SUCCESS (5.379s) [111.700100] [026/130] (910s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [116.706194] Starting subtest: pr-primary-plane-update-sf-dmg-area [116.709710] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [117.536240] [027/130] (904s left) api_intel_allocator (fork-simple-stress) [117.590552] Starting subtest: fork-simple-stress [122.998731] Subtest fork-simple-stress: SUCCESS (5.405s) [123.110279] [028/130] (898s left) gem_blits (basic) [123.180169] Starting subtest: basic [125.330990] Subtest basic: SUCCESS (2.149s) [125.466166] [029/130] (896s left) kms_lease (possible-crtcs-filtering) [125.568769] Starting subtest: possible-crtcs-filtering [125.574356] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [125.695517] [030/130] (896s left) gem_spin_batch (legacy) [125.763073] Starting subtest: legacy [125.764391] Starting dynamic subtest: default [128.997850] Dynamic subtest default: SUCCESS (3.229s) [129.006374] Starting dynamic subtest: render [132.232395] Dynamic subtest render: SUCCESS (3.233s) [132.240594] Starting dynamic subtest: bsd [135.468768] Dynamic subtest bsd: SUCCESS (3.234s) [135.477849] Starting dynamic subtest: bsd1 [138.702750] Dynamic subtest bsd1: SUCCESS (3.233s) [138.709897] Starting dynamic subtest: bsd2 [141.937602] Dynamic subtest bsd2: SUCCESS (3.233s) [141.951444] Starting dynamic subtest: blt [145.169485] Dynamic subtest blt: SUCCESS (3.231s) [145.175975] Starting dynamic subtest: vebox [148.401635] Dynamic subtest vebox: SUCCESS (3.231s) [148.402863] Subtest legacy: SUCCESS (22.632s) [148.985533] [031/130] (873s left) prime_mmap (test_map_unmap) [149.042496] Starting subtest: test_map_unmap [149.043479] Starting dynamic subtest: test_map_unmap-smem [149.077217] Dynamic subtest test_map_unmap-smem: SUCCESS (0.036s) [149.078414] Subtest test_map_unmap: SUCCESS (0.036s) [149.182700] [032/130] (872s left) gem_mmap_wc (read-write) [149.237097] Subtest read-write: SKIP (0.000s) [149.295281] [033/130] (872s left) perf_pmu (busy-idle-check-all) [149.332719] Starting subtest: busy-idle-check-all [149.333773] Starting dynamic subtest: rcs0 [150.008732] Dynamic subtest rcs0: SUCCESS (0.675s) [150.017771] Starting dynamic subtest: bcs0 [150.664108] Dynamic subtest bcs0: SUCCESS (0.655s) [150.672872] Starting dynamic subtest: vcs0 [151.916406] Dynamic subtest vcs0: SUCCESS (1.249s) [151.928595] Starting dynamic subtest: vcs1 [153.900824] Dynamic subtest vcs1: SUCCESS (1.983s) [153.909436] Starting dynamic subtest: vecs0 [155.947589] Dynamic subtest vecs0: SUCCESS (2.046s) [155.956077] Starting dynamic subtest: ccs0 [156.601346] Dynamic subtest ccs0: SUCCESS (0.655s) [156.602809] Subtest busy-idle-check-all: SUCCESS (7.269s) [156.703697] [034/130] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [156.806066] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [156.807822] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [156.913597] [035/130] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [157.040956] Starting subtest: psr-1p-primscrn-cur-indfb-move [162.169764] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.131s) [162.285796] [036/130] (859s left) kms_flip (2x-absolute-wf_vblank) [162.376483] Starting subtest: 2x-absolute-wf_vblank [162.387950] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [162.506195] [037/130] (859s left) gem_exec_whisper (basic-contexts-forked-all) [162.575585] Starting subtest: basic-contexts-forked-all [181.053276] Subtest basic-contexts-forked-all: SUCCESS (18.473s) [181.225465] [038/130] (841s left) drm_fdinfo (isolation) [181.259128] Starting subtest: isolation [181.260029] Starting dynamic subtest: rcs0 [181.291726] Dynamic subtest rcs0: SKIP (0.031s) [181.298796] Starting dynamic subtest: bcs0 [181.300703] Dynamic subtest bcs0: SKIP (0.000s) [181.306865] Starting dynamic subtest: vcs0 [181.308753] Dynamic subtest vcs0: SKIP (0.000s) [181.315173] Starting dynamic subtest: vcs1 [181.317068] Dynamic subtest vcs1: SKIP (0.000s) [181.323760] Starting dynamic subtest: vecs0 [181.325680] Dynamic subtest vecs0: SKIP (0.000s) [181.331645] Starting dynamic subtest: ccs0 [181.333520] Dynamic subtest ccs0: SKIP (0.000s) [181.335363] Subtest isolation: SKIP (0.035s) [181.358666] [039/130] (840s left) kms_color (legacy-gamma-reset) [181.455720] Starting subtest: legacy-gamma-reset [181.456679] Starting dynamic subtest: pipe-A-eDP-1 [181.839162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.383s) [181.847322] Starting dynamic subtest: pipe-B-eDP-1 [181.849497] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [181.856361] Starting dynamic subtest: pipe-C-eDP-1 [181.860403] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [181.866468] Starting dynamic subtest: pipe-D-eDP-1 [181.871164] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [181.872050] Subtest legacy-gamma-reset: SUCCESS (0.416s) [182.622172] [040/130] (839s left) kms_cursor_crc (cursor-rapid-movement-32x32) [182.752984] Starting subtest: cursor-rapid-movement-32x32 [182.788948] Subtest cursor-rapid-movement-32x32: SKIP (0.034s) [183.061087] [041/130] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [183.164713] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [187.498949] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.336s) [187.614275] [042/130] (834s left) kms_flip (modeset-vs-vblank-race) [187.718310] Starting subtest: modeset-vs-vblank-race [187.720158] Starting dynamic subtest: A-eDP1 [192.380441] Dynamic subtest A-eDP1: SUCCESS (4.660s) [192.389114] Starting dynamic subtest: B-eDP1 [197.094072] Dynamic subtest B-eDP1: SUCCESS (4.712s) [197.104400] Starting dynamic subtest: C-eDP1 [201.768068] Dynamic subtest C-eDP1: SUCCESS (4.672s) [201.775496] Starting dynamic subtest: D-eDP1 [206.377398] Dynamic subtest D-eDP1: SUCCESS (4.608s) [206.379528] Subtest modeset-vs-vblank-race: SUCCESS (18.660s) [207.534824] [043/130] (814s left) gem_mmap_offset (partial-remap) [207.587798] Starting subtest: partial-remap [207.588954] Starting dynamic subtest: smem0 [207.596263] Dynamic subtest smem0: SUCCESS (0.005s) [207.597134] Subtest partial-remap: SUCCESS (0.006s) [207.705879] [044/130] (814s left) kms_psr2_sf (pr-cursor-plane-update-sf) [212.785647] Starting subtest: pr-cursor-plane-update-sf [212.790022] Subtest pr-cursor-plane-update-sf: SKIP (0.002s) [213.630408] [045/130] (808s left) gem_ctx_param (set-priority-invalid-size) [213.678460] Starting subtest: set-priority-invalid-size [213.679624] Subtest set-priority-invalid-size: SUCCESS (0.000s) [213.744431] [046/130] (808s left) kms_addfb_basic (addfb25-x-tiled-legacy) [213.848747] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [213.950550] [047/130] (808s left) core_getversion (basic) [213.983765] Starting subtest: basic [213.985810] Subtest basic: SUCCESS (0.000s) [214.038675] [048/130] (808s left) kms_sequence (queue-busy) [214.125838] Starting subtest: queue-busy [214.126905] Starting dynamic subtest: pipe-A-eDP-1 [216.063461] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s) [216.071851] Starting dynamic subtest: pipe-B-eDP-1 [218.634632] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.571s) [218.643873] Starting dynamic subtest: pipe-C-eDP-1 [221.237570] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s) [221.246853] Starting dynamic subtest: pipe-D-eDP-1 [223.759429] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s) [223.760436] Subtest queue-busy: SUCCESS (9.632s) [224.529860] [049/130] (798s left) kms_psr (pr-primary-mmap-cpu) [224.627387] Starting subtest: pr-primary-mmap-cpu [224.629248] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [224.690224] [050/130] (797s left) kms_pm_dc (dc6-dpms) [225.789463] Starting subtest: dc6-dpms [232.555290] Subtest dc6-dpms: FAIL (6.634s) [232.720241] [051/130] (789s left) gem_exec_flush (basic-batch-kernel-default-wb) [232.779702] Starting subtest: basic-batch-kernel-default-wb [239.528945] Subtest basic-batch-kernel-default-wb: SUCCESS (6.748s) [239.708086] [052/130] (783s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [244.680823] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [244.684036] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [245.514641] [053/130] (777s left) gem_sync (basic-many-each) [245.567654] Starting subtest: basic-many-each [247.864575] Subtest basic-many-each: SUCCESS (2.297s) [248.037469] [054/130] (774s left) kms_psr (fbc-psr2-primary-page-flip) [248.134947] Starting subtest: fbc-psr2-primary-page-flip [248.135869] Starting dynamic subtest: eDP-1 [248.137585] Dynamic subtest eDP-1: SKIP (0.000s) [248.139222] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [248.198767] [055/130] (774s left) gem_lmem_swapping (basic) [248.231700] Subtest basic: SKIP (0.000s) [248.273091] [056/130] (774s left) kms_psr (fbc-pr-sprite-render) [248.361953] Starting subtest: fbc-pr-sprite-render [248.363904] Subtest fbc-pr-sprite-render: SKIP (0.000s) [248.428068] [057/130] (774s left) i915_pm_rpm (debugfs-read) [250.058389] Starting subtest: debugfs-read [251.214802] Subtest debugfs-read: SUCCESS (1.154s) [251.563367] [058/130] (771s left) sysfs_heartbeat_interval (idempotent) [251.618666] Starting subtest: idempotent [251.619811] Starting dynamic subtest: vecs0 [251.620826] Dynamic subtest vecs0: SUCCESS (0.001s) [251.629211] Starting dynamic subtest: ccs0 [251.630325] Dynamic subtest ccs0: SUCCESS (0.001s) [251.636495] Starting dynamic subtest: vcs0 [251.637360] Dynamic subtest vcs0: SUCCESS (0.000s) [251.643668] Starting dynamic subtest: bcs0 [251.644625] Dynamic subtest bcs0: SUCCESS (0.001s) [251.650605] Starting dynamic subtest: rcs0 [251.651534] Dynamic subtest rcs0: SUCCESS (0.000s) [251.657844] Starting dynamic subtest: vcs1 [251.658768] Dynamic subtest vcs1: SUCCESS (0.000s) [251.659666] Subtest idempotent: SUCCESS (0.007s) [251.688381] [059/130] (771s left) kms_rmfb (close-fd) [251.783073] Starting subtest: close-fd [251.784206] Starting dynamic subtest: pipe-A-eDP-1 [251.899059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.115s) [251.907376] Starting dynamic subtest: pipe-B-eDP-1 [253.127197] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s) [253.134876] Starting dynamic subtest: pipe-C-eDP-1 [254.330467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s) [254.337752] Starting dynamic subtest: pipe-D-eDP-1 [255.472041] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [255.473061] Subtest close-fd: SUCCESS (3.687s) [256.656409] [060/130] (766s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [256.718799] Starting subtest: y-tiled-ccs-to-yf-tiled [256.720875] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [256.890762] [061/130] (766s left) kms_lease (cursor-implicit-plane) [256.974848] Starting subtest: cursor-implicit-plane [256.975886] Starting dynamic subtest: pipe-A-eDP-1 [257.443032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s) [257.449824] Starting dynamic subtest: pipe-B-eDP-1 [258.574673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s) [258.581125] Starting dynamic subtest: pipe-C-eDP-1 [259.693608] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s) [259.700304] Starting dynamic subtest: pipe-D-eDP-1 [260.822372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s) [260.823479] Subtest cursor-implicit-plane: SUCCESS (3.846s) [261.673060] [062/130] (761s left) syncobj_timeline (invalid-transfer-non-existent-point) [261.724686] Starting subtest: invalid-transfer-non-existent-point [261.725654] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [261.822673] [063/130] (761s left) kms_async_flips (crc-atomic) [261.918056] Starting subtest: crc-atomic [262.280302] Starting dynamic subtest: pipe-A-eDP-1 [265.169094] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.888s) [265.542142] Starting dynamic subtest: pipe-B-eDP-1 [268.387876] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.852s) [268.753805] Starting dynamic subtest: pipe-C-eDP-1 [271.599297] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.850s) [271.961479] Starting dynamic subtest: pipe-D-eDP-1 [274.825857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s) [274.827097] Subtest crc-atomic: SUCCESS (12.907s) [275.988379] [064/130] (747s left) gem_exec_balancer (bonded-semaphore) [276.055104] Starting subtest: bonded-semaphore [276.057116] Subtest bonded-semaphore: SKIP (0.000s) [276.340589] [065/130] (746s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [276.444956] Starting subtest: fbc-rgb101010-draw-mmap-cpu [279.959287] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.515s) [280.088076] [066/130] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [280.194324] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [284.719147] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.527s) [284.868570] [067/130] (738s left) gem_exec_schedule (noreorder-corked) [285.052571] Starting subtest: noreorder-corked [285.053728] Starting dynamic subtest: rcs0 [286.196531] Dynamic subtest rcs0: SUCCESS (1.143s) [286.207088] Starting dynamic subtest: vcs0 [287.919979] Dynamic subtest vcs0: SUCCESS (1.719s) [287.929777] Starting dynamic subtest: vcs1 [289.918413] Dynamic subtest vcs1: SUCCESS (1.996s) [289.928297] Starting dynamic subtest: vecs0 [291.955389] Dynamic subtest vecs0: SUCCESS (2.035s) [291.962817] Starting dynamic subtest: ccs0 [293.106530] Dynamic subtest ccs0: SUCCESS (1.152s) [293.107618] Subtest noreorder-corked: SUCCESS (8.055s) [293.286095] [068/130] (729s left) kms_getfb (getfb2-accept-ccs) [293.351579] Starting subtest: getfb2-accept-ccs [293.352636] Subtest getfb2-accept-ccs: SUCCESS (0.000s) [293.463406] [069/130] (729s left) gem_exec_reloc (basic-range-active) [293.522311] Subtest basic-range-active: SKIP (0.000s) [293.599851] [070/130] (729s left) syncobj_timeline (signal-array) [293.646426] Starting subtest: signal-array [293.647442] Subtest signal-array: SUCCESS (0.000s) [293.753727] [071/130] (729s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [294.139663] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [294.969087] [072/130] (728s left) kms_rotation_crc (bad-pixel-format) [295.060868] Starting subtest: bad-pixel-format [295.063098] Subtest bad-pixel-format: SKIP (0.001s) [295.125570] [073/130] (728s left) kms_psr (psr-sprite-mmap-gtt) [295.217421] Starting subtest: psr-sprite-mmap-gtt [295.218340] Starting dynamic subtest: eDP-1 [296.715865] Dynamic subtest eDP-1: SKIP (1.495s) [296.718277] Subtest psr-sprite-mmap-gtt: SKIP (1.497s) [296.884702] [074/130] (726s left) kms_big_fb (linear-8bpp-rotate-270) [296.989555] Starting subtest: linear-8bpp-rotate-270 [297.009261] Subtest linear-8bpp-rotate-270: SKIP (0.019s) [297.135427] [075/130] (726s left) kms_cursor_crc (cursor-random-max-size) [297.397580] Starting subtest: cursor-random-max-size [297.400213] Subtest cursor-random-max-size: SKIP (0.000s) [297.532443] [076/130] (725s left) syncobj_wait (wait-all-complex) [297.586111] Starting subtest: wait-all-complex [297.802047] Subtest wait-all-complex: SUCCESS (0.214s) [297.868290] [077/130] (725s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [297.961999] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [297.963047] Starting dynamic subtest: pipe-A-eDP-1 [300.069143] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.106s) [300.077345] Starting dynamic subtest: pipe-B-eDP-1 [302.142825] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.073s) [302.150533] Starting dynamic subtest: pipe-C-eDP-1 [304.155184] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.011s) [304.162731] Starting dynamic subtest: pipe-D-eDP-1 [306.175151] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.019s) [306.176142] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.214s) [307.315524] [078/130] (716s left) gem_workarounds (suspend-resume) [307.387683] Starting subtest: suspend-resume [324.955711] Subtest suspend-resume: SUCCESS (3.514s) [335.113651] [079/130] (712s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [335.218115] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [335.219192] Starting dynamic subtest: pipe-A-default-mode [335.516316] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [335.518071] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.286s) [336.378272] [080/130] (711s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [336.489970] Starting subtest: yf-tiled-32bpp-rotate-90 [336.492095] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [336.576506] [081/130] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [336.722397] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [341.424615] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.622s) [341.547481] [082/130] (706s left) kms_psr (psr2-primary-mmap-gtt) [341.645257] Starting subtest: psr2-primary-mmap-gtt [341.646351] Starting dynamic subtest: eDP-1 [343.087029] Dynamic subtest eDP-1: SKIP (1.413s) [343.089379] Subtest psr2-primary-mmap-gtt: SKIP (1.415s) [343.220293] [083/130] (704s left) gem_softpin (evict-snoop-interruptible) [343.279346] Starting subtest: evict-snoop-interruptible [343.282020] Subtest evict-snoop-interruptible: SKIP (0.000s) [343.405339] [084/130] (704s left) kms_flip (plain-flip-ts-check) [343.500065] Starting subtest: plain-flip-ts-check [343.501270] Starting dynamic subtest: A-eDP1 [351.388854] Dynamic subtest A-eDP1: FAIL (7.707s) [351.396301] Starting dynamic subtest: B-eDP1 [363.483174] Dynamic subtest B-eDP1: FAIL (12.053s) [363.490575] Starting dynamic subtest: C-eDP1 [372.261677] Dynamic subtest C-eDP1: SUCCESS (8.882s) [372.273563] Starting dynamic subtest: D-eDP1 [381.091065] Dynamic subtest D-eDP1: SUCCESS (8.823s) [381.096874] Subtest plain-flip-ts-check: FAIL (37.478s) [382.269293] [085/130] (665s left) kms_cursor_edge_walk (128x128-right-edge) [382.363812] Starting subtest: 128x128-right-edge [382.365156] Starting dynamic subtest: pipe-A-eDP-1 [385.827374] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s) [385.835113] Starting dynamic subtest: pipe-D-eDP-1 [388.953060] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [388.954285] Subtest 128x128-right-edge: SUCCESS (6.585s) [389.743914] [086/130] (658s left) kms_setmode (basic) [389.803031] Starting subtest: basic [390.136782] Starting dynamic subtest: pipe-A-eDP-1 [392.160005] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.018s) [392.512352] Starting dynamic subtest: pipe-B-eDP-1 [394.588568] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.078s) [394.891424] Subtest basic: SUCCESS (5.084s) [395.723368] [087/130] (652s left) gem_ctx_engines (invalid-engines) [395.791973] Starting subtest: invalid-engines [395.800952] Subtest invalid-engines: SUCCESS (0.009s) [396.012971] [088/130] (652s left) gem_exec_fence (syncobj-timeline-export) [396.611017] Starting subtest: syncobj-timeline-export [396.618600] Subtest syncobj-timeline-export: SUCCESS (0.010s) [398.047936] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true [398.050445] [089/130] (650s left) kms_vblank (ts-continuation-dpms-suspend) [398.146571] Starting subtest: ts-continuation-dpms-suspend [398.147804] Starting dynamic subtest: pipe-A-eDP-1 [417.480484] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.157s) [417.491644] Starting dynamic subtest: pipe-D-eDP-1 [437.463940] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.701s) [437.465074] Subtest ts-continuation-dpms-suspend: SUCCESS (8.862s) [446.279049] [090/130] (640s left) kms_display_modes (extended-mode-basic) [446.383093] Starting subtest: extended-mode-basic [446.385046] Subtest extended-mode-basic: SKIP (0.000s) [446.424212] [091/130] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [446.525126] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [446.527039] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [446.648314] [092/130] (640s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [446.751451] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [446.753374] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [446.847422] [093/130] (640s left) sw_sync (sync_random_merge) [446.881478] Starting subtest: sync_random_merge [446.922336] Subtest sync_random_merge: SUCCESS (0.038s) [446.977694] [094/130] (639s left) gem_exec_schedule (u-submit-early-slice) [447.031050] Starting subtest: u-submit-early-slice [447.032107] Starting dynamic subtest: rcs0 [447.070832] Dynamic subtest rcs0: SUCCESS (0.038s) [447.081274] Starting dynamic subtest: bcs0 [447.104991] Dynamic subtest bcs0: SUCCESS (0.032s) [447.113171] Starting dynamic subtest: vcs0 [447.137986] Dynamic subtest vcs0: SUCCESS (0.031s) [447.146137] Starting dynamic subtest: vcs1 [447.180140] Dynamic subtest vcs1: SUCCESS (0.040s) [447.189314] Starting dynamic subtest: vecs0 [447.212385] Dynamic subtest vecs0: SUCCESS (0.030s) [447.223124] Starting dynamic subtest: ccs0 [447.250205] Dynamic subtest ccs0: SUCCESS (0.036s) [447.251228] Subtest u-submit-early-slice: SUCCESS (0.211s) [448.572147] [095/130] (638s left) gem_exec_balancer (parallel-ordering) [448.831112] Starting subtest: parallel-ordering [449.665219] Subtest parallel-ordering: SUCCESS (0.810s) [449.815340] [096/130] (637s left) gem_watchdog (default-virtual) [449.874443] Starting subtest: default-virtual [455.927125] Subtest default-virtual: SUCCESS (5.938s) [456.034848] [097/130] (631s left) gem_ctx_param (invalid-get-ringsize) [456.094984] Starting subtest: invalid-get-ringsize [456.095927] Subtest invalid-get-ringsize: SUCCESS (0.001s) [456.203510] [098/130] (631s left) gem_reg_read (timestamp-moving) [456.253668] Starting subtest: timestamp-moving [457.256957] Subtest timestamp-moving: SUCCESS (0.990s) [457.338539] [099/130] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [457.439076] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [457.440839] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [457.532148] [100/130] (629s left) template (b) [457.575612] Starting subtest: B [457.576920] Subtest B: SUCCESS (0.000s) [457.679228] [101/130] (629s left) gen9_exec_parse (unaligned-access) [457.736328] Subtest unaligned-access: SKIP (0.000s) [457.815249] [102/130] (629s left) kms_chamelium_edid (dp-edid-change-during-suspend) [458.191347] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [459.034840] [103/130] (628s left) kms_big_fb (4-tiled-8bpp-rotate-0) [459.132701] Starting subtest: 4-tiled-8bpp-rotate-0 [460.298265] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.157s) [460.473297] [104/130] (627s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [460.527076] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [460.528116] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [460.626001] [105/130] (626s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [460.685292] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [460.687502] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [460.862199] [106/130] (626s left) sw_sync (sync_multi_timeline_wait) [460.892859] Starting subtest: sync_multi_timeline_wait [460.894621] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [460.940803] [107/130] (626s left) api_intel_bb (intel-bb-blit-none) [460.989101] Starting subtest: intel-bb-blit-none [464.864225] Subtest intel-bb-blit-none: SUCCESS (3.853s) [464.986424] [108/130] (622s left) kms_plane (planar-pixel-format-settings) [465.084774] Starting subtest: planar-pixel-format-settings [465.112764] Subtest planar-pixel-format-settings: SUCCESS (0.028s) [465.207708] [109/130] (622s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [465.268347] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [465.315815] [110/130] (622s left) gem_sync (basic-store-each) [465.382160] Starting subtest: basic-store-each [467.730622] Subtest basic-store-each: SUCCESS (2.341s) [467.913251] [111/130] (619s left) prime_busy (hang) [467.973482] Starting subtest: hang [467.975843] Starting dynamic subtest: rcs0 [493.982101] Dynamic subtest rcs0: SUCCESS (25.981s) [493.989526] Starting dynamic subtest: bcs0 [501.071464] Dynamic subtest bcs0: SUCCESS (7.084s) [501.080840] Starting dynamic subtest: vcs0 [508.113906] Dynamic subtest vcs0: SUCCESS (7.038s) [508.123292] Starting dynamic subtest: vcs1 [515.087878] Dynamic subtest vcs1: SUCCESS (6.974s) [515.097092] Starting dynamic subtest: vecs0 [522.067338] Dynamic subtest vecs0: SUCCESS (6.979s) [522.077563] Starting dynamic subtest: ccs0 [535.965400] Dynamic subtest ccs0: SUCCESS (13.892s) [535.966637] Subtest hang: SUCCESS (67.955s) [536.076661] [112/130] (551s left) gem_fenced_exec_thrash (no-spare-fences) [536.146093] Subtest no-spare-fences: SKIP (0.000s) [536.209875] [113/130] (551s left) kms_plane_scaling (planes-downscale-factor-0-75) [536.314783] Starting subtest: planes-downscale-factor-0-75 [536.315824] Starting dynamic subtest: pipe-A [536.332083] Dynamic subtest pipe-A: SKIP (0.015s) [536.339762] Starting dynamic subtest: pipe-B [536.357315] Dynamic subtest pipe-B: SKIP (0.025s) [536.364973] Starting dynamic subtest: pipe-C [536.384235] Dynamic subtest pipe-C: SKIP (0.026s) [536.391835] Starting dynamic subtest: pipe-D [536.410859] Dynamic subtest pipe-D: SKIP (0.026s) [536.412430] Subtest planes-downscale-factor-0-75: SKIP (0.094s) [536.515527] [114/130] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [536.567184] Starting subtest: etime-multi-wait-all-for-submit-submitted [536.674918] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s) [536.743060] [115/130] (551s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [536.827131] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [536.828251] Starting dynamic subtest: pipe-A-default-mode [537.134637] Dynamic subtest pipe-A-default-mode: SKIP (0.305s) [537.136689] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.306s) [537.963606] [116/130] (550s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [538.063569] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [538.065411] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [538.168969] [117/130] (549s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [538.259237] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [545.630980] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.369s) [545.749367] [118/130] (542s left) gem_flink_basic (double-flink) [545.799288] Starting subtest: double-flink [545.800228] Subtest double-flink: SUCCESS (0.000s) [545.896234] [119/130] (542s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [545.982045] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [545.983223] Starting dynamic subtest: pipe-A-eDP-1 [546.005271] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [546.013336] Starting dynamic subtest: pipe-B-eDP-1 [546.034699] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [546.042212] Starting dynamic subtest: pipe-C-eDP-1 [546.065611] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [546.073640] Starting dynamic subtest: pipe-D-eDP-1 [546.095893] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [546.097589] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s) [548.123563] [120/130] (539s left) kms_big_fb (y-tiled-8bpp-rotate-180) [548.228555] Starting subtest: y-tiled-8bpp-rotate-180 [548.230274] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [548.335294] [121/130] (539s left) gem_eio (wait-wedge-10ms) [548.609145] Starting subtest: wait-wedge-10ms [550.462826] Subtest wait-wedge-10ms: SUCCESS (1.853s) [550.592463] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [550.607762] [FACT gem_eio (wait-wedge-10ms)] new: kernel.is_tainted.taint_warn: true [550.608639] Closing watchdogs Done.