[56.018286] Initializing watchdogs [56.018332] /dev/watchdog0 [56.032225] [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] [56.036596] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.038794] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.042131] [001/131] (960s left) syncobj_wait (reset-multiple-signaled) [56.124258] Starting subtest: reset-multiple-signaled [56.126659] Subtest reset-multiple-signaled: SUCCESS (0.000s) [56.241182] [002/131] (960s left) kms_color (legacy-gamma) [56.331809] Starting subtest: legacy-gamma [56.334102] Starting dynamic subtest: pipe-A-eDP-1 [57.072832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s) [57.081551] Starting dynamic subtest: pipe-B-eDP-1 [58.577202] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s) [58.585849] Starting dynamic subtest: pipe-C-eDP-1 [59.937221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s) [59.944735] Starting dynamic subtest: pipe-D-eDP-1 [61.281374] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s) [61.283683] Subtest legacy-gamma: SUCCESS (4.900s) [62.104596] [003/131] (954s left) drm_read (empty-block) [62.269063] Starting subtest: empty-block [63.270456] Subtest empty-block: SUCCESS (0.995s) [63.448644] [004/131] (953s left) sw_sync (sync_merge_same) [63.485499] Starting subtest: sync_merge_same [63.487396] Subtest sync_merge_same: SUCCESS (0.000s) [63.556231] [005/131] (953s left) sysfs_preempt_timeout (timeout) [63.613631] Starting subtest: timeout [63.615740] Starting dynamic subtest: vecs0 [72.935702] Dynamic subtest vecs0: SUCCESS (9.290s) [72.945249] Starting dynamic subtest: ccs0 [74.248227] Dynamic subtest ccs0: SUCCESS (1.312s) [74.257539] Starting dynamic subtest: vcs0 [83.943040] Dynamic subtest vcs0: SUCCESS (9.685s) [83.952681] Starting dynamic subtest: bcs0 [85.211507] Dynamic subtest bcs0: SUCCESS (1.268s) [85.221129] Starting dynamic subtest: rcs0 [86.538448] Dynamic subtest rcs0: SUCCESS (1.326s) [86.548322] Starting dynamic subtest: vcs1 [95.884830] Dynamic subtest vcs1: SUCCESS (9.340s) [95.887198] Subtest timeout: SUCCESS (32.227s) [95.966666] [006/131] (920s left) kms_addfb_basic (basic-x-tiled-legacy) [96.035643] Starting subtest: basic-x-tiled-legacy [96.040420] Subtest basic-x-tiled-legacy: SKIP (0.000s) [96.208827] [007/131] (920s left) kms_vblank (ts-continuation-modeset-hang) [96.294607] Starting subtest: ts-continuation-modeset-hang [96.296753] Starting dynamic subtest: pipe-A-eDP-1 [122.659893] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.359s) [122.674171] Starting dynamic subtest: pipe-D-eDP-1 [137.696273] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.033s) [137.698307] Subtest ts-continuation-modeset-hang: SUCCESS (41.396s) [138.503228] [008/131] (878s left) i915_module_load (reload) [138.539415] Starting subtest: reload [141.935181] Subtest reload: SUCCESS (3.397s) [141.972027] [009/131] (874s left) gem_exec_reloc (basic-active) [143.881312] Subtest basic-active: SKIP (0.000s) [143.960652] [010/131] (872s left) kms_psr (fbc-psr-sprite-blt) [144.050192] Starting subtest: fbc-psr-sprite-blt [144.052095] Starting dynamic subtest: eDP-1 [144.056207] Dynamic subtest eDP-1: SKIP (0.000s) [144.060248] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [144.130175] [011/131] (872s left) kms_chamelium_frames (hdmi-crc-fast) [144.530586] Subtest hdmi-crc-fast: SKIP (0.000s) [145.305906] [012/131] (871s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [145.401217] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [145.403536] Starting dynamic subtest: pipe-A-eDP-1 [145.426804] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [145.434364] Starting dynamic subtest: pipe-B-eDP-1 [145.455714] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [145.462549] Starting dynamic subtest: pipe-C-eDP-1 [145.483439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [145.490218] Starting dynamic subtest: pipe-D-eDP-1 [145.511705] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [145.515952] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s) [147.624880] [013/131] (869s left) gem_flink_basic (basic) [147.682068] Starting subtest: basic [147.684424] Subtest basic: SUCCESS (0.000s) [147.797698] [014/131] (869s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [147.901303] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [147.905644] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [148.048997] [015/131] (869s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [148.139865] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [148.142184] Starting dynamic subtest: pipe-A-eDP-1 [148.647061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s) [148.656072] Starting dynamic subtest: pipe-B-eDP-1 [150.106089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s) [150.115083] Starting dynamic subtest: pipe-C-eDP-1 [151.545341] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.436s) [151.554848] Starting dynamic subtest: pipe-D-eDP-1 [152.961539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s) [152.963832] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.795s) [154.139259] [016/131] (862s left) kms_big_fb (4-tiled-8bpp-rotate-270) [154.246280] Starting subtest: 4-tiled-8bpp-rotate-270 [154.266684] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [154.435115] [017/131] (862s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [154.529020] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [154.531284] Starting dynamic subtest: pipe-A [154.642665] Dynamic subtest pipe-A: SKIP (0.107s) [154.650697] Starting dynamic subtest: pipe-B [155.785093] Dynamic subtest pipe-B: SKIP (1.143s) [155.793599] Starting dynamic subtest: pipe-C [156.927380] Dynamic subtest pipe-C: SUCCESS (1.148s) [156.942064] Starting dynamic subtest: pipe-D [158.161102] Dynamic subtest pipe-D: SUCCESS (1.233s) [158.163570] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.634s) [159.386690] [018/131] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [159.484446] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [159.488836] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [159.605361] [019/131] (857s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [159.703363] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [163.370106] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.670s) [164.579268] [020/131] (852s left) gem_render_copy (y-tiled-ccs-to-linear) [164.636423] Starting subtest: y-tiled-ccs-to-linear [164.640948] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [164.829718] [021/131] (852s left) kms_big_fb (linear-16bpp-rotate-90) [164.931671] Starting subtest: linear-16bpp-rotate-90 [164.951516] Subtest linear-16bpp-rotate-90: SKIP (0.018s) [165.107564] [022/131] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [165.208605] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [172.586262] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.379s) [172.753904] [023/131] (844s left) gem_exec_suspend (basic-s3) [172.813363] Starting subtest: basic-S3 [172.815782] Starting dynamic subtest: smem [193.325324] Dynamic subtest smem: SUCCESS (7.018s) [193.328371] Subtest basic-S3: SUCCESS (7.019s) [193.533679] [024/131] (823s left) perf (oa-formats) [193.682316] Starting subtest: oa-formats [193.684629] Starting dynamic subtest: 0-rcs0 [193.694620] Dynamic subtest 0-rcs0: SUCCESS (0.014s) [193.703837] Starting dynamic subtest: 1-vcs1 [193.717226] Dynamic subtest 1-vcs1: SUCCESS (0.022s) [193.719588] Subtest oa-formats: SUCCESS (0.036s) [193.765648] [025/131] (823s left) sw_sync (sync_merge) [193.799328] Starting subtest: sync_merge [193.801652] Subtest sync_merge: SUCCESS (0.000s) [193.882493] [026/131] (823s left) kms_feature_discovery (dp-mst) [193.976582] Starting subtest: dp-mst [193.981167] Subtest dp-mst: SKIP (0.000s) [194.059609] [027/131] (823s left) kms_cursor_crc (cursor-onscreen-32x10) [194.225208] Starting subtest: cursor-onscreen-32x10 [194.275371] Subtest cursor-onscreen-32x10: SKIP (0.044s) [194.545308] [028/131] (823s left) gem_mmap_gtt (medium-copy) [194.604996] Subtest medium-copy: SKIP (0.000s) [194.662653] [029/131] (822s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [194.757443] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [198.889739] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.082s) [200.025616] [030/131] (817s left) perf (polling) [200.137171] Starting subtest: polling [200.139792] Starting dynamic subtest: 0-rcs0 [210.163740] Dynamic subtest 0-rcs0: SUCCESS (9.975s) [210.173160] Starting dynamic subtest: 1-vcs1 [220.174416] Dynamic subtest 1-vcs1: SUCCESS (9.994s) [220.177229] Subtest polling: SUCCESS (19.971s) [220.222073] [031/131] (797s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [220.329295] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [225.023363] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.694s) [226.197478] [032/131] (791s left) api_intel_bb (add-remove-objects) [226.255793] Starting subtest: add-remove-objects [226.261950] Subtest add-remove-objects: SUCCESS (0.007s) [226.383072] [033/131] (791s left) kms_plane_cursor (primary) [226.482685] Starting subtest: primary [226.487269] Starting dynamic subtest: pipe-A-eDP-1-size-64 [229.334385] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.851s) [229.358836] Starting dynamic subtest: pipe-A-eDP-1-size-128 [232.193158] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.840s) [232.217272] Starting dynamic subtest: pipe-A-eDP-1-size-256 [235.062337] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.850s) [235.381862] Starting dynamic subtest: pipe-B-eDP-1-size-64 [238.910379] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.537s) [238.934120] Starting dynamic subtest: pipe-B-eDP-1-size-128 [241.790307] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.860s) [241.814758] Starting dynamic subtest: pipe-B-eDP-1-size-256 [244.682393] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.872s) [244.997288] Starting dynamic subtest: pipe-C-eDP-1-size-64 [248.139270] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.151s) [248.165517] Starting dynamic subtest: pipe-C-eDP-1-size-128 [250.539385] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.380s) [250.566111] Starting dynamic subtest: pipe-C-eDP-1-size-256 [252.931378] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.369s) [253.256178] Starting dynamic subtest: pipe-D-eDP-1-size-64 [256.465500] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.219s) [256.492195] Starting dynamic subtest: pipe-D-eDP-1-size-128 [258.933137] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.447s) [258.960434] Starting dynamic subtest: pipe-D-eDP-1-size-256 [261.312748] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.358s) [261.622693] Subtest primary: SUCCESS (35.121s) [262.516300] [034/131] (755s left) gem_mmap_offset (mmap-boundaries) [262.578082] Starting subtest: mmap-boundaries [262.580434] Starting dynamic subtest: smem0 [262.853941] Dynamic subtest smem0: SUCCESS (0.276s) [262.856556] Subtest mmap-boundaries: SUCCESS (0.277s) [263.004089] [035/131] (754s left) kms_dp_link_training (uhbr-sst) [263.105396] Starting subtest: uhbr-sst [263.113827] Subtest uhbr-sst: SKIP (0.000s) [263.227961] [036/131] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [263.318699] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [263.323035] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [263.468574] [037/131] (754s left) kms_hdmi_inject (inject-audio) [263.806866] Starting subtest: inject-audio [264.082352] Subtest inject-audio: SUCCESS (0.276s) [264.680825] [038/131] (753s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [264.778727] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [264.782786] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [264.890848] [039/131] (753s left) kms_properties (get_properties-sanity-atomic) [264.989852] Starting subtest: get_properties-sanity-atomic [264.992067] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [265.074615] [040/131] (753s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [265.168278] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [271.669530] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.501s) [271.796391] [041/131] (746s left) kms_cursor_crc (cursor-sliding-32x10) [271.960125] Starting subtest: cursor-sliding-32x10 [272.010849] Subtest cursor-sliding-32x10: SKIP (0.045s) [272.304961] [042/131] (745s left) gem_mmap_gtt (big-bo-tiledy) [272.355665] Subtest big-bo-tiledY: SKIP (0.000s) [272.421957] [043/131] (745s left) gem_ctx_freq (sysfs) [272.490577] Starting subtest: sysfs [272.492884] Starting dynamic subtest: gt0 [278.021264] Dynamic subtest gt0: SUCCESS (5.527s) [278.031176] Starting dynamic subtest: gt1 [319.340388] Dynamic subtest gt1: SUCCESS (41.319s) [319.343395] Subtest sysfs: SUCCESS (46.849s) [319.499053] [044/131] (698s left) syncobj_timeline (wait-delayed-signal) [319.546961] Starting subtest: wait-delayed-signal [319.647768] Subtest wait-delayed-signal: SUCCESS (0.102s) [319.754423] [045/131] (698s left) kms_prop_blob (invalid-get-prop) [319.810899] Starting subtest: invalid-get-prop [319.812912] Subtest invalid-get-prop: SUCCESS (0.000s) [319.925455] [046/131] (698s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [320.026742] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [324.261392] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.238s) [325.444184] [047/131] (692s left) kms_big_fb (y-tiled-32bpp-rotate-270) [325.552366] Starting subtest: y-tiled-32bpp-rotate-270 [325.556971] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [325.673497] [048/131] (692s left) gem_ctx_param (set-priority-invalid-size) [325.726042] Starting subtest: set-priority-invalid-size [325.728311] Subtest set-priority-invalid-size: SUCCESS (0.000s) [325.810662] [049/131] (692s left) i915_pm_rc6_residency (media-rc6-accuracy) [325.870686] Starting subtest: media-rc6-accuracy [325.874897] Subtest media-rc6-accuracy: SKIP (0.000s) [325.992740] [050/131] (692s left) gem_exec_schedule (u-submit-late-slice) [326.054697] Starting subtest: u-submit-late-slice [326.057116] Starting dynamic subtest: rcs0 [326.084952] Dynamic subtest rcs0: SUCCESS (0.033s) [326.096982] Starting dynamic subtest: bcs0 [326.112613] Dynamic subtest bcs0: SUCCESS (0.027s) [326.122607] Starting dynamic subtest: vcs0 [326.140395] Dynamic subtest vcs0: SUCCESS (0.027s) [326.150728] Starting dynamic subtest: vcs1 [326.168711] Dynamic subtest vcs1: SUCCESS (0.028s) [326.180241] Starting dynamic subtest: vecs0 [326.201743] Dynamic subtest vecs0: SUCCESS (0.032s) [326.217191] Starting dynamic subtest: ccs0 [326.231771] Dynamic subtest ccs0: SUCCESS (0.030s) [326.234096] Subtest u-submit-late-slice: SUCCESS (0.181s) [327.525645] [051/131] (691s left) kms_pipe_crc_basic (disable-crc-after-crtc) [327.616219] Starting subtest: disable-crc-after-crtc [327.618500] Starting dynamic subtest: pipe-A-eDP-1 [329.245338] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.625s) [329.255441] Starting dynamic subtest: pipe-B-eDP-1 [331.642068] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.395s) [331.652789] Starting dynamic subtest: pipe-C-eDP-1 [334.022403] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.378s) [334.032939] Starting dynamic subtest: pipe-D-eDP-1 [336.325627] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.302s) [336.327881] Subtest disable-crc-after-crtc: SUCCESS (8.706s) [337.142069] [052/131] (681s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [337.232390] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [337.234655] Starting dynamic subtest: pipe-A-eDP-1 [339.507529] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.261s) [339.518690] Starting dynamic subtest: pipe-B-eDP-1 [341.934057] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.437s) [341.943215] Starting dynamic subtest: pipe-C-eDP-1 [344.144409] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.209s) [344.155424] Starting dynamic subtest: pipe-D-eDP-1 [346.315610] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s) [346.317553] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.083s) [347.537583] [053/131] (671s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [347.590923] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [347.592874] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [347.705774] [054/131] (670s left) gem_pxp (create-regular-context-2) [347.821832] Starting subtest: create-regular-context-2 [347.824350] Subtest create-regular-context-2: SUCCESS (0.002s) [347.969586] [055/131] (670s left) vgem_basic (second-client) [348.075440] Starting subtest: second-client [348.097477] Subtest second-client: SUCCESS (0.022s) [348.174551] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true [348.177963] [056/131] (670s left) gen9_exec_parse (allowed-single) [348.238069] Subtest allowed-single: SKIP (0.000s) [348.319926] [057/131] (670s left) kms_psr (psr-sprite-render) [348.407387] Starting subtest: psr-sprite-render [348.409734] Starting dynamic subtest: eDP-1 [350.138042] Dynamic subtest eDP-1: SUCCESS (1.728s) [350.140093] Subtest psr-sprite-render: SUCCESS (1.729s) [350.951392] [058/131] (667s left) gem_exec_schedule (independent) [351.022894] Starting subtest: independent [351.025245] Starting dynamic subtest: rcs0 [352.367727] Dynamic subtest rcs0: SUCCESS (1.353s) [352.380137] Starting dynamic subtest: vcs0 [354.359748] Dynamic subtest vcs0: SUCCESS (1.989s) [354.372303] Starting dynamic subtest: vcs1 [356.407560] Dynamic subtest vcs1: SUCCESS (2.045s) [356.419344] Starting dynamic subtest: vecs0 [358.390725] Dynamic subtest vecs0: SUCCESS (1.981s) [358.403268] Starting dynamic subtest: ccs0 [360.364709] Dynamic subtest ccs0: SUCCESS (1.971s) [360.367163] Subtest independent: SUCCESS (9.350s) [360.688774] [059/131] (658s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [360.796430] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [360.805579] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [360.930115] [060/131] (658s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [361.024570] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [361.039590] Starting dynamic subtest: pipe-A-eDP-1 [361.048737] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [361.060190] Starting dynamic subtest: pipe-B-eDP-1 [361.068531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [361.077592] Starting dynamic subtest: pipe-C-eDP-1 [361.086012] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [361.094969] Starting dynamic subtest: pipe-D-eDP-1 [361.103217] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [361.107424] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s) [363.245123] [061/131] (655s left) kms_invalid_mode (bad-hsync-end) [363.345843] Starting subtest: bad-hsync-end [363.348125] Starting dynamic subtest: pipe-A-eDP-1 [363.643255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s) [363.652685] Starting dynamic subtest: pipe-B-eDP-1 [363.654561] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [363.663954] Starting dynamic subtest: pipe-C-eDP-1 [363.666088] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [363.675397] Starting dynamic subtest: pipe-D-eDP-1 [363.677378] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [363.679310] Subtest bad-hsync-end: SUCCESS (0.308s) [364.462722] [062/131] (654s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [364.521493] Starting subtest: yf-tiled-ccs-to-yf-tiled [364.525937] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [364.730804] [063/131] (654s left) drm_read (short-buffer-block) [364.876451] Starting subtest: short-buffer-block [364.878796] Subtest short-buffer-block: SUCCESS (0.000s) [365.017248] [064/131] (654s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [365.124350] Starting subtest: switch-modeset-ultra-joiner-big-joiner [365.128744] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [365.193060] [065/131] (653s left) i915_drm_fdinfo (busy-idle) [365.225713] Starting subtest: busy-idle [365.227604] Starting dynamic subtest: rcs0 [365.255547] Dynamic subtest rcs0: SKIP (0.028s) [365.267001] Starting dynamic subtest: bcs0 [365.271521] Dynamic subtest bcs0: SKIP (0.001s) [365.280680] Starting dynamic subtest: vcs0 [365.285333] Dynamic subtest vcs0: SKIP (0.000s) [365.300332] Starting dynamic subtest: vcs1 [365.304838] Dynamic subtest vcs1: SKIP (0.000s) [365.316413] Starting dynamic subtest: vecs0 [365.320603] Dynamic subtest vecs0: SKIP (0.000s) [365.329784] Starting dynamic subtest: ccs0 [365.334105] Dynamic subtest ccs0: SKIP (0.000s) [365.338546] Subtest busy-idle: SKIP (0.034s) [365.376923] [066/131] (653s left) gem_ccs (block-copy-compressed) [365.427574] Starting subtest: block-copy-compressed [365.432052] Subtest block-copy-compressed: SKIP (0.000s) [365.549246] [067/131] (653s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [365.653447] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [365.656853] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [365.774529] [068/131] (653s left) kms_big_fb (x-tiled-64bpp-rotate-270) [365.877459] Starting subtest: x-tiled-64bpp-rotate-270 [365.897485] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [366.060883] [069/131] (653s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [366.155551] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [372.883762] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.728s) [373.033791] [070/131] (646s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [373.129068] Starting subtest: planes-downscale-factor-0-75-unity-scaling [373.131342] Starting dynamic subtest: pipe-A [373.191520] Dynamic subtest pipe-A: SUCCESS (0.065s) [373.203753] Starting dynamic subtest: pipe-B [374.323025] Dynamic subtest pipe-B: SUCCESS (1.130s) [374.333958] Starting dynamic subtest: pipe-C [375.497493] Dynamic subtest pipe-C: SUCCESS (1.172s) [375.507747] Starting dynamic subtest: pipe-D [376.595967] Dynamic subtest pipe-D: SUCCESS (1.097s) [376.598383] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.469s) [377.771270] [071/131] (641s left) kms_sequence (get-forked) [377.870629] Starting subtest: get-forked [377.872946] Starting dynamic subtest: pipe-A-eDP-1 [379.741627] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.866s) [379.751355] Starting dynamic subtest: pipe-B-eDP-1 [382.251886] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.509s) [382.263276] Starting dynamic subtest: pipe-C-eDP-1 [384.833915] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.579s) [384.846449] Starting dynamic subtest: pipe-D-eDP-1 [387.364788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s) [387.367110] Subtest get-forked: SUCCESS (9.490s) [388.244750] [072/131] (631s left) gem_wait (busy) [388.308693] Starting subtest: busy [388.311029] Starting dynamic subtest: all-engines [390.381386] Dynamic subtest all-engines: SUCCESS (2.069s) [390.394199] Starting dynamic subtest: rcs0 [390.923385] Dynamic subtest rcs0: SUCCESS (0.541s) [390.934659] Starting dynamic subtest: bcs0 [391.463716] Dynamic subtest bcs0: SUCCESS (0.539s) [391.475864] Starting dynamic subtest: vcs0 [393.388795] Dynamic subtest vcs0: SUCCESS (1.921s) [393.401432] Starting dynamic subtest: vcs1 [395.372709] Dynamic subtest vcs1: SUCCESS (1.981s) [395.384595] Starting dynamic subtest: vecs0 [397.356703] Dynamic subtest vecs0: SUCCESS (1.980s) [397.369449] Starting dynamic subtest: ccs0 [397.898652] Dynamic subtest ccs0: SUCCESS (0.541s) [397.901089] Subtest busy: SUCCESS (9.587s) [398.109957] [073/131] (621s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [398.207408] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [405.529175] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.324s) [405.693010] [074/131] (613s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [405.820849] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [437.246295] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.426s) [438.148250] [075/131] (581s left) gem_userptr_blits (process-exit) [438.207396] Starting subtest: process-exit [438.213068] Subtest process-exit: SUCCESS (0.008s) [438.377578] [076/131] (581s left) kms_psr (psr-cursor-mmap-gtt) [438.471333] Starting subtest: psr-cursor-mmap-gtt [438.473640] Starting dynamic subtest: eDP-1 [440.191394] Dynamic subtest eDP-1: SUCCESS (1.718s) [440.193911] Subtest psr-cursor-mmap-gtt: SUCCESS (1.720s) [441.041732] [077/131] (578s left) gem_ctx_exec (basic-close-race) [441.103923] Starting subtest: basic-close-race [446.819837] Subtest basic-close-race: SUCCESS (5.715s) [446.982153] [078/131] (572s left) syncobj_wait (invalid-signal-illegal-handle) [447.036840] Starting subtest: invalid-signal-illegal-handle [447.039150] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [447.169272] [079/131] (572s left) kms_display_modes (extended-mode-basic) [447.282737] Starting subtest: extended-mode-basic [447.287347] Subtest extended-mode-basic: SKIP (0.000s) [447.329370] [080/131] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [447.429216] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [453.642105] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.216s) [454.858273] [081/131] (564s left) gem_ctx_persistence (saturated-hostile-nopreempt) [454.922170] Starting subtest: saturated-hostile-nopreempt [454.924549] Starting dynamic subtest: rcs0 [455.000029] Dynamic subtest rcs0: SKIP (0.075s) [455.012144] Starting dynamic subtest: bcs0 [455.022953] Dynamic subtest bcs0: SKIP (0.022s) [455.032539] Starting dynamic subtest: vcs0 [455.044915] Dynamic subtest vcs0: SKIP (0.020s) [455.054414] Starting dynamic subtest: vcs1 [455.067952] Dynamic subtest vcs1: SKIP (0.022s) [455.077458] Starting dynamic subtest: vecs0 [455.088994] Dynamic subtest vecs0: SKIP (0.020s) [455.098491] Starting dynamic subtest: ccs0 [455.111973] Dynamic subtest ccs0: SKIP (0.022s) [455.116466] Subtest saturated-hostile-nopreempt: SKIP (0.189s) [455.216493] [082/131] (564s left) gem_eio (unwedge-stress) [455.446952] Starting subtest: unwedge-stress [455.449355] Starting dynamic subtest: render [460.476585] Dynamic subtest render: SUCCESS (5.027s) [460.495281] Starting dynamic subtest: bsd1 [478.890566] Dynamic subtest bsd1: SUCCESS (18.412s) [478.907505] Starting dynamic subtest: bsd2 [496.901563] Dynamic subtest bsd2: SUCCESS (18.009s) [496.918556] Starting dynamic subtest: blt [496.922724] Dynamic subtest blt: SKIP (0.000s) [496.932359] Starting dynamic subtest: vebox [514.864675] Dynamic subtest vebox: SUCCESS (17.958s) [514.867145] Subtest unwedge-stress: SUCCESS (59.412s) [516.463929] [083/131] (503s left) dmabuf_sync_file (import-multiple-read-write) [516.509483] Starting subtest: import-multiple-read-write [516.511954] Subtest import-multiple-read-write: SUCCESS (0.003s) [516.582552] [084/131] (503s left) gem_exec_schedule (u-lateslice) [516.654034] Starting subtest: u-lateslice [516.656379] Starting dynamic subtest: rcs0 [516.663684] Dynamic subtest rcs0: SUCCESS (0.021s) [516.675291] Starting dynamic subtest: bcs0 [516.681347] Dynamic subtest bcs0: SUCCESS (0.017s) [516.691543] Starting dynamic subtest: vcs0 [516.700192] Dynamic subtest vcs0: SUCCESS (0.018s) [516.710636] Starting dynamic subtest: vcs1 [516.717083] Dynamic subtest vcs1: SUCCESS (0.016s) [516.727464] Starting dynamic subtest: vecs0 [516.734634] Dynamic subtest vecs0: SUCCESS (0.017s) [516.744536] Starting dynamic subtest: ccs0 [516.752971] Dynamic subtest ccs0: SUCCESS (0.018s) [516.755300] Subtest u-lateslice: SUCCESS (0.111s) [518.482960] [085/131] (501s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [523.507244] Starting subtest: psr2-plane-move-sf-dmg-area [523.509204] Starting dynamic subtest: pipe-A-eDP-1 [528.666011] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.158s) [528.676613] Starting dynamic subtest: pipe-B-eDP-1 [533.877700] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.206s) [533.880094] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.369s) [534.741312] [086/131] (485s left) kms_cursor_legacy (cursor-vs-flip-toggle) [534.852681] Starting subtest: cursor-vs-flip-toggle [565.661757] Subtest cursor-vs-flip-toggle: SUCCESS (30.804s) [566.541773] [087/131] (453s left) syncobj_timeline (signal-array) [566.598414] Starting subtest: signal-array [566.600786] Subtest signal-array: SUCCESS (0.000s) [566.720168] [088/131] (453s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [566.821645] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [573.332166] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.511s) [573.506612] [089/131] (446s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [573.561271] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [573.636003] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.013s) [573.712589] [090/131] (446s left) kms_psr (fbc-psr2-cursor-render) [573.801638] Starting subtest: fbc-psr2-cursor-render [573.803850] Starting dynamic subtest: eDP-1 [573.807766] Dynamic subtest eDP-1: SKIP (0.000s) [573.811706] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [573.888490] [091/131] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [573.991504] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [573.995438] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [574.126964] [092/131] (446s left) gem_exec_balancer (smoke) [574.189114] Starting subtest: smoke [596.771073] Subtest smoke: SUCCESS (22.574s) [598.528419] [093/131] (421s left) kms_atomic (plane-immutable-zpos) [598.620697] Starting subtest: plane-immutable-zpos [598.623086] Starting dynamic subtest: pipe-A-eDP-1 [599.257753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.635s) [599.259712] Subtest plane-immutable-zpos: SUCCESS (0.637s) [600.135089] [094/131] (420s left) kms_cursor_crc (cursor-rapid-movement-32x10) [600.298545] Starting subtest: cursor-rapid-movement-32x10 [600.347399] Subtest cursor-rapid-movement-32x10: SKIP (0.044s) [600.638399] [095/131] (419s left) gem_exec_suspend (basic-s4-devices) [600.698781] Starting subtest: basic-S4-devices [600.701144] Starting dynamic subtest: smem [612.398371] Dynamic subtest smem: SUCCESS (11.694s) [612.401221] Subtest basic-S4-devices: SUCCESS (11.696s) [612.586246] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [612.603189] [FACT gem_exec_suspend (basic-s4-devices)] new: kernel.is_tainted.taint_warn: true [612.604046] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: kms_color results: parsing output: 2/ for test: drm_read results: parsing output: 3/ for test: sw_sync results: parsing output: 4/ for test: sysfs_preempt_timeout results: parsing output: 5/ for test: kms_addfb_basic results: parsing output: 6/ for test: kms_vblank results: parsing output: 7/ for test: i915_module_load results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: kms_chamelium_frames results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: gem_flink_basic results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_plane_scaling results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_render_copy results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_exec_suspend results: parsing output: 23/ for test: perf results: parsing output: 24/ for test: sw_sync results: parsing output: 25/ for test: kms_feature_discovery results: parsing output: 26/ for test: kms_cursor_crc results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: perf results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: api_intel_bb results: parsing output: 32/ for test: kms_plane_cursor results: parsing output: 33/ for test: gem_mmap_offset results: parsing output: 34/ for test: kms_dp_link_training results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_hdmi_inject results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_properties results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_cursor_crc results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: gem_ctx_freq results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: kms_prop_blob results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: gem_ctx_param results: parsing output: 48/ for test: i915_pm_rc6_residency results: parsing output: 49/ for test: gem_exec_schedule results: parsing output: 50/ for test: kms_pipe_crc_basic results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: gem_pxp results: parsing output: 54/ for test: vgem_basic results: parsing output: 55/ for test: gen9_exec_parse results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: gem_exec_schedule results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: kms_invalid_mode results: parsing output: 61/ for test: gem_render_copy results: parsing output: 62/ for test: drm_read results: parsing output: 63/ for test: kms_joiner results: parsing output: 64/ for test: i915_drm_fdinfo results: parsing output: 65/ for test: gem_ccs results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_plane_scaling results: parsing output: 70/ for test: kms_sequence results: parsing output: 71/ for test: gem_wait results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_cursor_legacy results: parsing output: 74/ for test: gem_userptr_blits results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: gem_ctx_exec results: parsing output: 77/ for test: syncobj_wait results: parsing output: 78/ for test: kms_display_modes results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_ctx_persistence results: parsing output: 81/ for test: gem_eio results: parsing output: 82/ for test: dmabuf_sync_file results: parsing output: 83/ for test: gem_exec_schedule results: parsing output: 84/ for test: kms_psr2_sf results: parsing output: 85/ for test: kms_cursor_legacy results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: sriov_basic results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_exec_balancer results: parsing output: 92/ for test: kms_atomic results: parsing output: 93/ for test: kms_cursor_crc results: parsing output: 94/ for test: gem_exec_suspend results: parsing output: 95/ for test: gem_softpin results: no output, setting notrun results: parsing output: 96/ for test: kms_pm_rpm results: no output, setting notrun results: parsing output: 97/ for test: gem_workarounds results: no output, setting notrun results: parsing output: 98/ for test: api_intel_bb results: no output, setting notrun results: parsing output: 99/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 100/ for test: kms_chamelium_hpd results: no output, setting notrun results: parsing output: 101/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 102/ for test: template results: no output, setting notrun results: parsing output: 103/ for test: kms_cdclk results: no output, setting notrun results: parsing output: 104/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 105/ for test: gem_exec_fence results: no output, setting notrun results: parsing output: 106/ for test: kms_psr2_su results: no output, setting notrun results: parsing output: 107/ for test: kms_ccs results: no output, setting notrun results: parsing output: 108/ for test: kms_flip results: no output, setting notrun results: parsing output: 109/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 110/ for test: perf_pmu results: no output, setting notrun results: parsing output: 111/ for test: perf results: no output, setting notrun results: parsing output: 112/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 113/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 114/ for test: gem_exec_nop results: no output, setting notrun results: parsing output: 115/ for test: kms_psr2_sf results: no output, setting notrun results: parsing output: 116/ for test: gem_exec_await results: no output, setting notrun results: parsing output: 117/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 118/ for test: gem_ctx_param results: no output, setting notrun results: parsing output: 119/ for test: perf results: no output, setting notrun results: parsing output: 120/ for test: gem_exec_alignment results: no output, setting notrun results: parsing output: 121/ for test: kms_panel_fitting results: no output, setting notrun results: parsing output: 122/ for test: kms_psr results: no output, setting notrun results: parsing output: 123/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 124/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 125/ for test: gem_exec_balancer results: no output, setting notrun results: parsing output: 126/ for test: i915_selftest results: no output, setting notrun results: parsing output: 127/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 128/ for test: gem_huc_copy results: no output, setting notrun results: parsing output: 129/ for test: syncobj_eventfd results: no output, setting notrun results: parsing output: 130/ for test: kms_frontbuffer_tracking results: no output, setting notrun Done.