[60.061273] Initializing watchdogs [60.061333] /dev/watchdog0 [60.075535] [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.080032] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.082205] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.084315] [001/134] (960s left) kms_properties (connector-properties-legacy) [60.172982] Starting subtest: connector-properties-legacy [60.173909] Starting dynamic subtest: pipe-A-eDP-1 [67.986161] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.829s) [67.992879] Starting dynamic subtest: pipe-None-DP-1 [67.994997] Dynamic subtest pipe-None-DP-1: SUCCESS (0.003s) [68.000885] Starting dynamic subtest: pipe-None-HDMI-A-1 [68.002808] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [68.008079] Starting dynamic subtest: pipe-None-DP-2 [68.009958] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [68.015799] Starting dynamic subtest: pipe-None-HDMI-A-2 [68.017783] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [68.022981] Starting dynamic subtest: pipe-None-DP-3 [68.024875] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [68.030067] Starting dynamic subtest: pipe-None-DP-4 [68.031921] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [68.032911] Subtest connector-properties-legacy: SUCCESS (7.842s) [68.860570] [002/134] (951s left) kms_cursor_legacy (cursor-vs-flip-toggle) [68.988626] Starting subtest: cursor-vs-flip-toggle [99.823119] Subtest cursor-vs-flip-toggle: SUCCESS (30.838s) [100.679566] [003/134] (919s left) kms_psr (psr2-cursor-render) [100.791929] Starting subtest: psr2-cursor-render [100.792756] Starting dynamic subtest: eDP-1 [102.463296] Dynamic subtest eDP-1: SUCCESS (1.671s) [102.464136] Subtest psr2-cursor-render: SUCCESS (1.671s) [103.271306] [004/134] (917s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [103.370462] Starting subtest: fbcpsr-rgb565-draw-render [110.355449] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.986s) [110.528050] [005/134] (910s left) kms_vblank (ts-continuation-dpms-suspend) [110.628708] Starting subtest: ts-continuation-dpms-suspend [110.629574] Starting dynamic subtest: pipe-A-eDP-1 [128.330820] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.389s) [128.339893] Starting dynamic subtest: pipe-D-eDP-1 [146.329952] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.863s) [146.330870] Subtest ts-continuation-dpms-suspend: SUCCESS (5.255s) [153.151971] [006/134] (873s left) gem_userptr_blits (sync-unmap-after-close) [153.224017] Starting subtest: sync-unmap-after-close [153.238755] Subtest sync-unmap-after-close: SUCCESS (0.015s) [153.384826] [007/134] (873s left) kms_addfb_basic (no-handle) [153.437672] Starting subtest: no-handle [153.438658] Subtest no-handle: SUCCESS (0.000s) [153.577768] [008/134] (873s left) kms_flip (modeset-vs-vblank-race) [153.666206] Starting subtest: modeset-vs-vblank-race [153.668252] Starting dynamic subtest: A-eDP1 [158.272480] Dynamic subtest A-eDP1: SUCCESS (4.686s) [158.281561] Starting dynamic subtest: B-eDP1 [162.975822] Dynamic subtest B-eDP1: SUCCESS (4.749s) [162.986338] Starting dynamic subtest: C-eDP1 [167.562094] Dynamic subtest C-eDP1: SUCCESS (4.610s) [167.581630] Starting dynamic subtest: D-eDP1 [172.202895] Dynamic subtest D-eDP1: SUCCESS (4.654s) [172.205272] Subtest modeset-vs-vblank-race: SUCCESS (18.709s) [173.376518] [009/134] (853s left) gem_mmap_gtt (cpuset-big-copy) [173.441797] Subtest cpuset-big-copy: SKIP (0.000s) [173.503911] [010/134] (853s left) gem_userptr_blits (dmabuf-sync) [173.585680] Starting subtest: dmabuf-sync [173.590544] Subtest dmabuf-sync: SKIP (0.005s) [173.742569] [011/134] (853s left) gem_huc_copy (huc-copy) [173.804612] Starting subtest: huc-copy [173.807862] Subtest huc-copy: SUCCESS (0.003s) [173.936948] [012/134] (852s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [174.045658] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [174.047322] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [174.171887] [013/134] (852s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [174.268671] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [174.269611] Starting dynamic subtest: pipe-A-eDP-1 [176.506785] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.243s) [176.514483] Starting dynamic subtest: pipe-B-eDP-1 [178.637215] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.133s) [178.644723] Starting dynamic subtest: pipe-C-eDP-1 [180.841405] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.206s) [180.849156] Starting dynamic subtest: pipe-D-eDP-1 [182.864288] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.024s) [182.865199] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.609s) [184.097651] [014/134] (842s left) gem_ctx_persistence (engines-cleanup) [184.167098] Starting subtest: engines-cleanup [184.168050] Starting dynamic subtest: rcs0 [184.265807] Dynamic subtest rcs0: SUCCESS (0.098s) [184.277689] Starting dynamic subtest: bcs0 [184.333170] Dynamic subtest bcs0: SUCCESS (0.064s) [184.343626] Starting dynamic subtest: vcs0 [184.366599] Dynamic subtest vcs0: SUCCESS (0.031s) [184.374246] Starting dynamic subtest: vcs1 [184.456962] Dynamic subtest vcs1: SUCCESS (0.088s) [184.467285] Starting dynamic subtest: vecs0 [184.515102] Dynamic subtest vecs0: SUCCESS (0.056s) [184.525052] Starting dynamic subtest: ccs0 [184.576990] Dynamic subtest ccs0: SUCCESS (0.060s) [184.578285] Subtest engines-cleanup: SUCCESS (0.410s) [184.658883] [015/134] (842s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [184.764053] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [184.765862] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [184.859757] [016/134] (842s left) kms_cursor_legacy (cursor-vs-flip-legacy) [184.974553] Starting subtest: cursor-vs-flip-legacy [214.277416] Subtest cursor-vs-flip-legacy: SUCCESS (29.301s) [215.131778] [017/134] (811s left) gem_busy (close-race) [215.198572] Starting subtest: close-race [240.325337] Subtest close-race: SUCCESS (25.132s) [240.732943] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true [240.736012] [018/134] (786s left) gem_mmap_offset (mmap-boundaries) [240.825323] Starting subtest: mmap-boundaries [240.826409] Starting dynamic subtest: smem0 [241.107626] Dynamic subtest smem0: SUCCESS (0.283s) [241.108769] Subtest mmap-boundaries: SUCCESS (0.284s) [241.242005] [019/134] (785s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [241.347809] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [241.349870] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [241.475960] [020/134] (785s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [241.577634] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [241.578521] Starting dynamic subtest: pipe-A [241.598004] Dynamic subtest pipe-A: SKIP (0.018s) [241.605259] Starting dynamic subtest: pipe-B [241.628151] Dynamic subtest pipe-B: SKIP (0.030s) [241.635048] Starting dynamic subtest: pipe-C [241.658083] Dynamic subtest pipe-C: SKIP (0.030s) [241.665050] Starting dynamic subtest: pipe-D [241.687888] Dynamic subtest pipe-D: SKIP (0.029s) [241.689640] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.109s) [241.816920] [021/134] (785s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [241.912838] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [241.914637] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [242.016194] [022/134] (785s left) kms_pm_rpm (pm-caching) [243.559446] Starting subtest: pm-caching [243.561934] Subtest pm-caching: SKIP (0.000s) [244.270289] [023/134] (783s left) kms_cursor_crc (cursor-sliding-512x512) [244.528942] Starting subtest: cursor-sliding-512x512 [244.530660] Subtest cursor-sliding-512x512: SKIP (0.001s) [244.719892] [024/134] (782s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [244.782890] Starting subtest: etime-multi-wait-for-submit-unsubmitted [244.889854] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s) [244.969940] [025/134] (782s left) kms_psr (fbc-pr-cursor-plane-onoff) [245.067632] Starting subtest: fbc-pr-cursor-plane-onoff [245.069284] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [245.150995] [026/134] (782s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [245.242924] Starting subtest: plane-downscale-factor-0-5-with-modifiers [245.243877] Starting dynamic subtest: pipe-A [245.259486] Dynamic subtest pipe-A: SKIP (0.015s) [245.268100] Starting dynamic subtest: pipe-B [245.287282] Dynamic subtest pipe-B: SKIP (0.028s) [245.294216] Starting dynamic subtest: pipe-C [245.317083] Dynamic subtest pipe-C: SKIP (0.029s) [245.324026] Starting dynamic subtest: pipe-D [245.345669] Dynamic subtest pipe-D: SKIP (0.028s) [245.347369] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.102s) [245.457409] [027/134] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [245.551961] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [245.553801] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [245.697597] [028/134] (781s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [245.801125] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [245.802139] Starting dynamic subtest: pipe-A-eDP-1 [245.865970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s) [245.874600] Starting dynamic subtest: pipe-B-eDP-1 [245.928232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s) [245.936719] Starting dynamic subtest: pipe-C-eDP-1 [245.993177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.064s) [246.001492] Starting dynamic subtest: pipe-D-eDP-1 [246.055567] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s) [246.056363] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.257s) [248.234198] [029/134] (779s left) kms_hdr (static-toggle-suspend) [248.317598] Starting subtest: static-toggle-suspend [248.320030] Subtest static-toggle-suspend: SKIP (0.000s) [248.405157] [030/134] (779s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [248.472130] Starting subtest: single-wait-all-for-submit-available-signaled [248.473136] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [248.593777] [031/134] (778s left) prime_mmap (test_map_unmap) [248.651851] Starting subtest: test_map_unmap [248.652867] Starting dynamic subtest: test_map_unmap-smem [248.685457] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s) [248.686541] Subtest test_map_unmap: SUCCESS (0.034s) [248.808085] [032/134] (778s left) kms_plane (pixel-format-x-tiled-modifier) [248.898843] Starting subtest: pixel-format-x-tiled-modifier [248.926062] Starting dynamic subtest: pipe-A-plane-0 [249.526016] Dynamic subtest pipe-A-plane-0: SUCCESS (0.600s) [249.533384] Starting dynamic subtest: pipe-A-plane-3 [249.927099] Dynamic subtest pipe-A-plane-3: SUCCESS (0.400s) [249.934417] Starting dynamic subtest: pipe-A-plane-5 [249.936294] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [251.021881] Starting dynamic subtest: pipe-B-plane-0 [251.604232] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s) [251.612977] Starting dynamic subtest: pipe-B-plane-3 [252.004336] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s) [252.011603] Starting dynamic subtest: pipe-B-plane-5 [252.013214] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [252.310315] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.410s) [253.218443] [033/134] (774s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [253.276952] Starting subtest: multi-wait-for-submit-submitted-signaled [253.277864] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [253.389793] [034/134] (774s left) api_intel_bb (offset-control) [253.444451] Starting subtest: offset-control [253.450405] Subtest offset-control: SUCCESS (0.007s) [253.584263] [035/134] (774s left) kms_pm_rpm (basic-rte) [253.610636] Starting subtest: basic-rte [256.961633] Subtest basic-rte: SUCCESS (3.349s) [258.768150] [036/134] (768s left) kms_addfb_basic (master-rmfb) [258.818890] Starting subtest: master-rmfb [258.819755] Subtest master-rmfb: SUCCESS (0.001s) [258.977718] [037/134] (768s left) kms_cursor_crc (cursor-rapid-movement-128x128) [259.172177] Starting subtest: cursor-rapid-movement-128x128 [259.175827] Starting dynamic subtest: pipe-A-eDP-1 [259.705097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s) [259.732615] Starting dynamic subtest: pipe-D-eDP-1 [260.978856] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.253s) [260.979741] Subtest cursor-rapid-movement-128x128: SUCCESS (1.806s) [261.832247] [038/134] (765s left) gem_userptr_blits (map-fixed-invalidate-busy) [261.901732] Starting subtest: map-fixed-invalidate-busy [261.903514] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [262.047024] [039/134] (765s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [262.107945] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [262.108938] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [262.225057] [040/134] (765s left) gem_exec_schedule (preempt-contexts) [262.296493] Starting subtest: preempt-contexts [262.297308] Starting dynamic subtest: rcs0 [262.347852] Dynamic subtest rcs0: SUCCESS (0.052s) [262.355585] Starting dynamic subtest: bcs0 [262.395510] Dynamic subtest bcs0: SUCCESS (0.047s) [262.402667] Starting dynamic subtest: vcs0 [262.441693] Dynamic subtest vcs0: SUCCESS (0.046s) [262.449110] Starting dynamic subtest: vcs1 [262.484097] Dynamic subtest vcs1: SUCCESS (0.041s) [262.493169] Starting dynamic subtest: vecs0 [262.524635] Dynamic subtest vecs0: SUCCESS (0.040s) [262.531686] Starting dynamic subtest: ccs0 [262.569276] Dynamic subtest ccs0: SUCCESS (0.044s) [262.570134] Subtest preempt-contexts: SUCCESS (0.275s) [264.517506] [041/134] (763s left) gem_eio (kms) [264.798628] Starting subtest: kms [285.542576] Subtest kms: SUCCESS (20.741s) [285.678218] [042/134] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [285.779285] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [285.781078] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [285.885937] [043/134] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [285.974887] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [285.976466] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [286.078663] [044/134] (741s left) gen9_exec_parse (bb-start-param) [286.138289] Subtest bb-start-param: SKIP (0.000s) [286.220280] [045/134] (741s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [286.342427] Starting subtest: flip-vs-cursor-atomic-transitions [293.920005] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.578s) [294.723064] [046/134] (733s left) sriov_basic (enable-vfs-autoprobe-off) [294.783781] Starting subtest: enable-vfs-autoprobe-off [294.784740] Starting dynamic subtest: numvfs-1 [294.818579] Dynamic subtest numvfs-1: FAIL (0.016s) [294.827202] Starting dynamic subtest: numvfs-2 [294.854052] Dynamic subtest numvfs-2: FAIL (0.004s) [294.861871] Starting dynamic subtest: numvfs-3 [294.889284] Dynamic subtest numvfs-3: FAIL (0.003s) [294.896947] Starting dynamic subtest: numvfs-4 [294.923943] Dynamic subtest numvfs-4: FAIL (0.004s) [294.931147] Starting dynamic subtest: numvfs-5 [294.958460] Dynamic subtest numvfs-5: FAIL (0.003s) [294.966184] Starting dynamic subtest: numvfs-6 [294.996806] Dynamic subtest numvfs-6: FAIL (0.004s) [295.004963] Starting dynamic subtest: numvfs-7 [295.033219] Dynamic subtest numvfs-7: FAIL (0.003s) [295.040356] Starting dynamic subtest: numvfs-random [295.072924] Dynamic subtest numvfs-random: FAIL (0.003s) [295.080205] Starting dynamic subtest: numvfs-all [295.107314] Dynamic subtest numvfs-all: FAIL (0.003s) [295.108147] Subtest enable-vfs-autoprobe-off: FAIL (0.050s) [295.136541] [047/134] (732s left) gem_userptr_blits (nohangcheck) [295.214225] Starting subtest: nohangcheck [295.486621] Subtest nohangcheck: SUCCESS (0.269s) [295.625583] [048/134] (732s left) sysfs_defaults (readonly) [295.685046] Starting subtest: readonly [295.686042] Starting dynamic subtest: vecs0 [295.687021] Dynamic subtest vecs0: SUCCESS (0.000s) [295.696559] Starting dynamic subtest: ccs0 [295.697401] Dynamic subtest ccs0: SUCCESS (0.000s) [295.704576] Starting dynamic subtest: vcs0 [295.705407] Dynamic subtest vcs0: SUCCESS (0.000s) [295.712595] Starting dynamic subtest: bcs0 [295.713486] Dynamic subtest bcs0: SUCCESS (0.000s) [295.720823] Starting dynamic subtest: rcs0 [295.721710] Dynamic subtest rcs0: SUCCESS (0.000s) [295.728935] Starting dynamic subtest: vcs1 [295.729825] Dynamic subtest vcs1: SUCCESS (0.000s) [295.730674] Subtest readonly: SUCCESS (0.006s) [295.812207] [049/134] (732s left) kms_chamelium_frames (hdmi-crc-fast) [296.186364] Subtest hdmi-crc-fast: SKIP (0.000s) [297.011807] [050/134] (731s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [297.091668] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [297.092490] Starting dynamic subtest: pipe-A-eDP-1 [297.232803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s) [297.242711] Starting dynamic subtest: pipe-B-eDP-1 [297.250617] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [297.258510] Starting dynamic subtest: pipe-C-eDP-1 [297.266066] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [297.273369] Starting dynamic subtest: pipe-D-eDP-1 [297.280712] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [297.281538] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s) [299.501847] [051/134] (728s left) kms_flip (flip-vs-fences-interruptible) [299.599372] Starting subtest: flip-vs-fences-interruptible [299.601150] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [299.718488] [052/134] (728s left) perf (global-sseu-config) [299.853238] Starting subtest: global-sseu-config [299.854957] Subtest global-sseu-config: SKIP (0.000s) [299.895055] [053/134] (728s left) kms_color (ctm-0-25) [299.979371] Starting subtest: ctm-0-25 [299.980287] Starting dynamic subtest: pipe-A-eDP-1 [303.399715] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s) [303.407839] Starting dynamic subtest: pipe-B-eDP-1 [307.590660] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.189s) [307.599288] Starting dynamic subtest: pipe-C-eDP-1 [311.525373] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.936s) [311.533121] Starting dynamic subtest: pipe-D-eDP-1 [315.565011] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.039s) [315.565903] Subtest ctm-0-25: SUCCESS (15.587s) [316.384622] [054/134] (711s left) perf (invalid-remove-userspace-config) [316.492280] Starting subtest: invalid-remove-userspace-config [316.500122] Subtest invalid-remove-userspace-config: SUCCESS (0.008s) [316.537189] [055/134] (711s left) kms_cdclk (mode-transition-all-outputs) [316.633163] Starting subtest: mode-transition-all-outputs [316.916108] Subtest mode-transition-all-outputs: SKIP (0.284s) [317.729743] [056/134] (710s left) gem_ctx_persistence (engines-queued) [317.790612] Starting subtest: engines-queued [317.791583] Starting dynamic subtest: rcs0 [317.907167] Dynamic subtest rcs0: SUCCESS (0.116s) [317.919185] Starting dynamic subtest: bcs0 [317.980246] Dynamic subtest bcs0: SUCCESS (0.071s) [317.992023] Starting dynamic subtest: vcs0 [319.334636] Dynamic subtest vcs0: SUCCESS (1.350s) [319.345410] Starting dynamic subtest: vcs1 [321.315158] Dynamic subtest vcs1: SUCCESS (1.978s) [321.325925] Starting dynamic subtest: vecs0 [323.299395] Dynamic subtest vecs0: SUCCESS (1.982s) [323.309883] Starting dynamic subtest: ccs0 [323.473300] Dynamic subtest ccs0: SUCCESS (0.173s) [323.474358] Subtest engines-queued: SUCCESS (5.683s) [323.621426] [057/134] (704s left) gem_set_tiling_vs_blt (tiled-to-untiled) [323.692511] Subtest tiled-to-untiled: SKIP (0.000s) [323.774288] [058/134] (704s left) kms_addfb_basic (bad-pitch-999) [323.830918] Starting subtest: bad-pitch-999 [323.831887] Subtest bad-pitch-999: SUCCESS (0.000s) [323.985882] [059/134] (704s left) kms_cursor_crc (cursor-offscreen-128x42) [324.208757] Starting subtest: cursor-offscreen-128x42 [324.248966] Subtest cursor-offscreen-128x42: SKIP (0.038s) [324.480475] [060/134] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [324.573061] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [324.574843] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [324.672666] [061/134] (703s left) kms_content_protection (suspend-resume) [324.818853] Starting subtest: suspend-resume [324.820827] Subtest suspend-resume: SKIP (0.000s) [324.987358] [062/134] (703s left) syncobj_timeline (invalid-wait-bad-flags) [325.040510] Starting subtest: invalid-wait-bad-flags [325.041477] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [325.131985] [063/134] (703s left) syncobj_wait (multi-wait-submitted-signaled) [325.192854] Starting subtest: multi-wait-submitted-signaled [325.193813] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [325.306119] [064/134] (703s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [325.401375] Starting subtest: crc-primary-suspend-y-tiled-ccs [325.402341] Starting dynamic subtest: pipe-A-eDP-1 [325.406091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [325.418903] Starting dynamic subtest: pipe-B-eDP-1 [325.422869] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [325.432236] Starting dynamic subtest: pipe-C-eDP-1 [325.435640] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [325.442806] Starting dynamic subtest: pipe-D-eDP-1 [325.446047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [325.447734] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [327.588916] [065/134] (701s left) kms_flip (dpms-vs-vblank-race-interruptible) [327.677628] Starting subtest: dpms-vs-vblank-race-interruptible [327.680417] Starting dynamic subtest: A-eDP1 [332.658617] Dynamic subtest A-eDP1: SUCCESS (4.978s) [332.666560] Starting dynamic subtest: B-eDP1 [336.164197] Dynamic subtest B-eDP1: SUCCESS (3.506s) [336.176883] Starting dynamic subtest: C-eDP1 [340.786330] Dynamic subtest C-eDP1: SUCCESS (4.622s) [340.794411] Starting dynamic subtest: D-eDP1 [345.418456] Dynamic subtest D-eDP1: SUCCESS (4.632s) [345.422764] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.749s) [346.296836] [066/134] (682s left) kms_rotation_crc (exhaust-fences) [346.388698] Starting subtest: exhaust-fences [346.390383] Subtest exhaust-fences: SKIP (0.000s) [346.469933] [067/134] (682s left) kms_cursor_legacy (forked-move) [346.587427] Starting subtest: forked-move [346.588243] Starting dynamic subtest: pipe-A [352.034826] Dynamic subtest pipe-A: SUCCESS (5.446s) [352.045235] Starting dynamic subtest: pipe-B [357.523575] Dynamic subtest pipe-B: SUCCESS (5.488s) [357.536785] Starting dynamic subtest: pipe-C [362.996692] Dynamic subtest pipe-C: SUCCESS (5.472s) [363.009910] Starting dynamic subtest: pipe-D [368.450576] Dynamic subtest pipe-D: SUCCESS (5.455s) [368.465964] Starting dynamic subtest: all-pipes [373.974742] Dynamic subtest all-pipes: SUCCESS (5.523s) [373.975849] Subtest forked-move: SUCCESS (27.393s) [374.121745] [068/134] (654s left) gem_exec_schedule (smoketest) [374.320629] Starting subtest: smoketest [374.321736] Starting dynamic subtest: rcs0 [379.851675] Dynamic subtest rcs0: SUCCESS (5.507s) [379.860063] Starting dynamic subtest: bcs0 [385.390840] Dynamic subtest bcs0: SUCCESS (5.537s) [385.399328] Starting dynamic subtest: vcs0 [390.898916] Dynamic subtest vcs0: SUCCESS (5.501s) [390.907728] Starting dynamic subtest: vcs1 [396.398327] Dynamic subtest vcs1: SUCCESS (5.496s) [396.407610] Starting dynamic subtest: vecs0 [401.893572] Dynamic subtest vecs0: SUCCESS (5.493s) [401.903126] Starting dynamic subtest: ccs0 [407.415158] Dynamic subtest ccs0: SUCCESS (5.519s) [407.416000] Subtest smoketest: SUCCESS (33.064s) [407.672670] [069/134] (621s left) kms_feature_discovery (psr1) [407.781358] Starting subtest: psr1 [407.782228] Subtest psr1: SUCCESS (0.000s) [407.860709] [070/134] (621s left) gem_exec_balancer (parallel-contexts) [408.120892] Starting subtest: parallel-contexts [411.109237] Subtest parallel-contexts: SUCCESS (2.988s) [411.540186] [071/134] (617s left) drm_read (short-buffer-nonblock) [411.695200] Starting subtest: short-buffer-nonblock [411.696310] Subtest short-buffer-nonblock: SUCCESS (0.000s) [411.835312] [072/134] (617s left) gem_exec_fence (syncobj-export) [412.282099] Starting subtest: syncobj-export [412.284987] Subtest syncobj-export: SUCCESS (0.005s) [413.510419] [073/134] (615s left) syncobj_timeline (multi-wait-for-submit-signaled) [413.566994] Starting subtest: multi-wait-for-submit-signaled [413.568202] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [413.713690] [074/134] (615s left) kms_flip_event_leak (basic) [413.802999] Starting subtest: basic [413.803915] Starting dynamic subtest: pipe-A-eDP-1 [414.222568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s) [414.230875] Starting dynamic subtest: pipe-B-eDP-1 [415.313895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s) [415.322029] Starting dynamic subtest: pipe-C-eDP-1 [416.477500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.163s) [416.488079] Starting dynamic subtest: pipe-D-eDP-1 [417.566415] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.085s) [417.567346] Subtest basic: SUCCESS (3.764s) [418.445305] [075/134] (610s left) gem_softpin (reverse) [418.503739] Starting subtest: reverse [418.509665] Subtest reverse: SUCCESS (0.006s) [418.638205] [076/134] (610s left) kms_psr (fbc-pr-suspend) [418.722497] Starting subtest: fbc-pr-suspend [418.724188] Subtest fbc-pr-suspend: SKIP (0.000s) [418.801668] [077/134] (610s left) kms_draw_crc (fill-fb) [418.885496] Starting subtest: fill-fb [419.338775] Subtest fill-fb: SUCCESS (0.453s) [419.442535] [078/134] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [419.544307] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [419.546043] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [419.652823] [079/134] (609s left) kms_atomic (plane-overlay-legacy) [419.748373] Starting subtest: plane-overlay-legacy [419.749243] Starting dynamic subtest: pipe-A-eDP-1 [420.158568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s) [420.159400] Subtest plane-overlay-legacy: SUCCESS (0.410s) [420.974687] [080/134] (608s left) kms_chamelium_hpd (dp-hpd-fast) [421.364282] Subtest dp-hpd-fast: SKIP (0.000s) [422.179895] [081/134] (607s left) i915_query (hwconfig_table) [422.231301] Starting subtest: hwconfig_table [422.348944] Subtest hwconfig_table: SUCCESS (0.001s) [422.379862] [082/134] (606s left) api_intel_allocator (default-alignment) [422.423053] Starting subtest: default-alignment [422.424379] Subtest default-alignment: SUCCESS (0.003s) [422.564779] [083/134] (606s left) kms_invalid_mode (zero-clock) [422.660581] Starting subtest: zero-clock [422.661448] Starting dynamic subtest: pipe-A-eDP-1 [422.957731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [422.967776] Starting dynamic subtest: pipe-B-eDP-1 [422.968647] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [422.976162] Starting dynamic subtest: pipe-C-eDP-1 [422.977011] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [422.984808] Starting dynamic subtest: pipe-D-eDP-1 [422.985690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [422.986491] Subtest zero-clock: SUCCESS (0.307s) [423.767481] [084/134] (605s left) syncobj_wait (multi-wait-submitted) [423.827996] Starting subtest: multi-wait-submitted [423.937537] Subtest multi-wait-submitted: SUCCESS (0.108s) [424.016218] [085/134] (605s left) gem_ctx_engines (execute-oneforall) [424.080697] Starting subtest: execute-oneforall [424.715351] Subtest execute-oneforall: SUCCESS (0.633s) [426.500019] [086/134] (602s left) gem_exec_balancer (hog) [426.557712] Starting subtest: hog [426.559649] Subtest hog: SKIP (0.000s) [426.873901] [087/134] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [426.976053] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [426.977827] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [427.073842] [088/134] (602s left) kms_psr (pr-primary-blt) [427.161601] Starting subtest: pr-primary-blt [427.163296] Subtest pr-primary-blt: SKIP (0.000s) [427.243415] [089/134] (602s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [427.348835] Starting subtest: yf-tiled-32bpp-rotate-0 [427.350652] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [427.478892] [090/134] (602s left) gem_exec_gttfill (engines) [427.559256] Starting subtest: engines [427.560451] Starting dynamic subtest: rcs0 [450.412677] Dynamic subtest rcs0: SUCCESS (22.850s) [450.422854] Starting dynamic subtest: bcs0 [473.764701] Dynamic subtest bcs0: SUCCESS (23.352s) [473.777645] Starting dynamic subtest: vcs0 [497.140371] Dynamic subtest vcs0: SUCCESS (23.373s) [497.151074] Starting dynamic subtest: vcs1 [520.552709] Dynamic subtest vcs1: SUCCESS (23.413s) [520.562637] Starting dynamic subtest: vecs0 [543.920476] Dynamic subtest vecs0: SUCCESS (23.368s) [543.929677] Starting dynamic subtest: ccs0 [567.325063] Dynamic subtest ccs0: SUCCESS (23.409s) [567.326367] Subtest engines: SUCCESS (139.779s) [567.530765] [091/134] (462s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [567.623672] Starting subtest: y-tiled-to-vebox-x-tiled [567.625548] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [567.822036] [092/134] (461s left) perf_pmu (enable-race) [567.861914] Starting subtest: enable-race [567.862868] Starting dynamic subtest: rcs0 [580.648193] Dynamic subtest rcs0: SUCCESS (12.788s) [580.657401] Starting dynamic subtest: bcs0 [593.390268] Dynamic subtest bcs0: SUCCESS (12.742s) [593.402022] Starting dynamic subtest: vcs0 [609.349778] Dynamic subtest vcs0: SUCCESS (15.958s) [609.360829] Starting dynamic subtest: vcs1 [625.349857] Dynamic subtest vcs1: SUCCESS (16.000s) [625.360183] Starting dynamic subtest: vecs0 [641.349963] Dynamic subtest vecs0: SUCCESS (15.990s) [641.359753] Starting dynamic subtest: ccs0 [654.096209] Dynamic subtest ccs0: SUCCESS (12.738s) [654.098220] Subtest enable-race: SUCCESS (86.230s) [654.191473] [093/134] (375s left) gem_ccs (block-copy-uncompressed) [654.252233] Starting subtest: block-copy-uncompressed [654.253193] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [654.283548] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.031s) [654.293639] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [654.302247] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s) [654.309916] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [654.321221] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s) [654.328849] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [654.340374] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s) [654.341706] Subtest block-copy-uncompressed: SUCCESS (0.089s) [654.494319] [094/134] (375s left) prime_self_import (export-vs-gem_close-race) [654.530667] Starting subtest: export-vs-gem_close-race [659.623570] Subtest export-vs-gem_close-race: SUCCESS (5.090s) [659.709522] [095/134] (370s left) syncobj_wait (single-wait-for-submit-signaled) [659.788315] Starting subtest: single-wait-for-submit-signaled [659.789720] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [659.911367] [096/134] (369s left) syncobj_eventfd (invalid-illegal-handle) [659.974714] Starting subtest: invalid-illegal-handle [659.975655] Subtest invalid-illegal-handle: SUCCESS (0.000s) [660.104843] [097/134] (369s left) gem_exec_whisper (basic-contexts-forked) [660.185709] Starting subtest: basic-contexts-forked [683.684635] Subtest basic-contexts-forked: SUCCESS (23.485s) [683.874203] [098/134] (346s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [683.964191] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [683.965971] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [684.055850] [099/134] (345s left) kms_big_fb (linear-16bpp-rotate-180) [684.154471] Starting subtest: linear-16bpp-rotate-180 [685.633820] Subtest linear-16bpp-rotate-180: SUCCESS (1.479s) [685.785910] [100/134] (344s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [685.877023] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [685.878855] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [685.971591] [101/134] (344s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [686.065896] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [686.067636] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [686.189089] [102/134] (343s left) i915_drm_fdinfo (memory-info-resident) [686.224737] Starting subtest: memory-info-resident [686.225580] Starting dynamic subtest: smem0 [688.931242] Dynamic subtest smem0: SUCCESS (2.705s) [688.932385] Subtest memory-info-resident: SUCCESS (2.706s) [689.012865] [103/134] (341s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [689.114624] Starting subtest: primary-x-tiled-reflect-x-180 [696.174815] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.058s) [697.412574] [104/134] (332s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [697.505415] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [697.506291] Starting dynamic subtest: pipe-A-default-mode [698.670528] Dynamic subtest pipe-A-default-mode: SKIP (1.163s) [698.672189] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.164s) [698.861933] [105/134] (331s left) kms_plane_lowres (tiling-y) [698.957684] Starting subtest: tiling-y [698.959355] Subtest tiling-y: SKIP (0.000s) [699.042299] [106/134] (331s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [704.010295] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [704.014269] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [704.870385] [107/134] (325s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [704.966650] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [706.067608] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.101s) [706.208975] [108/134] (324s left) core_setmaster (master-drop-set-shared-fd) [706.286120] Starting subtest: master-drop-set-shared-fd [706.307894] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [706.339706] [109/134] (323s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [706.422589] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [706.423551] Starting dynamic subtest: pipe-A-eDP-1 [706.431525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [706.440886] Starting dynamic subtest: pipe-B-eDP-1 [706.448462] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [706.457144] Starting dynamic subtest: pipe-C-eDP-1 [706.464484] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [706.472659] Starting dynamic subtest: pipe-D-eDP-1 [706.480238] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [706.481138] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [708.652018] [110/134] (321s left) gem_exec_flush (basic-uc-pro-default) [708.716454] Starting subtest: basic-uc-pro-default [714.172536] Subtest basic-uc-pro-default: SUCCESS (5.455s) [714.367730] [111/134] (315s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [714.453167] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [714.455017] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [714.566627] [112/134] (315s left) kms_flip (flip-vs-panning-interruptible) [714.674351] Starting subtest: flip-vs-panning-interruptible [714.676762] Starting dynamic subtest: A-eDP1 [723.363250] Dynamic subtest A-eDP1: SUCCESS (8.685s) [723.374257] Starting dynamic subtest: B-eDP1 [732.083905] Dynamic subtest B-eDP1: SUCCESS (8.718s) [732.095285] Starting dynamic subtest: C-eDP1 [740.797041] Dynamic subtest C-eDP1: SUCCESS (8.710s) [740.807602] Starting dynamic subtest: D-eDP1 [749.528143] Dynamic subtest D-eDP1: SUCCESS (8.729s) [749.530670] Subtest flip-vs-panning-interruptible: SUCCESS (34.851s) [750.718389] [113/134] (279s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [750.820951] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [751.800491] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.979s) [751.953734] [114/134] (278s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [752.046126] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [752.047860] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [752.149747] [115/134] (278s left) i915_pm_rps (min-max-config-loaded) [752.214389] Starting subtest: min-max-config-loaded [752.216312] Subtest min-max-config-loaded: SKIP (0.001s) [752.316185] [116/134] (278s left) kms_frontbuffer_tracking (fbcpsr-suspend) [752.402002] Starting subtest: fbcpsr-suspend [793.371176] Subtest fbcpsr-suspend: SUCCESS (10.771s) [798.561625] [117/134] (236s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [803.601454] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [803.602323] Starting dynamic subtest: pipe-A-eDP-1 [815.631102] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.012s) [815.641291] Starting dynamic subtest: pipe-B-eDP-1 [827.665480] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.025s) [827.666413] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.041s) [828.539029] [118/134] (207s left) gem_pread (self) [828.606315] Subtest self: SKIP (0.000s) [828.674547] [119/134] (206s left) gem_ppgtt (blt-vs-render-ctxn) [828.745650] Starting subtest: blt-vs-render-ctxN [861.753031] Subtest blt-vs-render-ctxN: SUCCESS (33.004s) [861.930180] [120/134] (173s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [862.056306] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [866.234200] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.177s) [867.443978] [121/134] (168s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [867.558653] Starting subtest: verify-pxp-execution-after-suspend-resume [874.621779] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.039s) [882.769873] [122/134] (160s left) kms_pipe_crc_basic (suspend-read-crc) [882.860929] Starting subtest: suspend-read-crc [882.861996] Starting dynamic subtest: pipe-A-eDP-1 [900.659944] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.947s) [900.668679] Starting dynamic subtest: pipe-B-eDP-1 [919.662749] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.450s) [919.673215] Starting dynamic subtest: pipe-C-eDP-1 [938.596835] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.347s) [938.606953] Starting dynamic subtest: pipe-D-eDP-1 [957.633459] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.422s) [957.634286] Subtest suspend-read-crc: SUCCESS (13.172s) [967.488539] [123/134] ( 85s left) gem_mmap_wc (read-write-distinct) [967.547921] Subtest read-write-distinct: SKIP (0.000s) [967.627373] [124/134] ( 85s left) kms_selftest (drm_plane_helper) [967.665389] Starting subtest: drm_plane_helper [967.707743] Starting dynamic subtest: drm_test_check_plane_state [967.853919] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.146s) [967.864104] Starting dynamic subtest: drm_test_check_invalid_plane_state [967.999625] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.145s) [968.000786] Subtest drm_plane_helper: SUCCESS (0.334s) [968.211982] [125/134] ( 84s left) gem_userptr_blits (usage-restrictions) [968.270481] Starting subtest: usage-restrictions [968.271443] Subtest usage-restrictions: SUCCESS (0.000s) [968.421399] [126/134] ( 84s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [968.537541] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [968.539267] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [968.663096] [127/134] ( 84s left) kms_lease (lease-unleased-connector) [968.755832] Starting subtest: lease-unleased-connector [968.756787] Starting dynamic subtest: pipe-A-eDP-1 [968.762891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [968.772192] Starting dynamic subtest: pipe-B-eDP-1 [968.773076] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [968.782269] Starting dynamic subtest: pipe-C-eDP-1 [968.783154] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [968.792236] Starting dynamic subtest: pipe-D-eDP-1 [968.793225] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s) [968.794119] Subtest lease-unleased-connector: SUCCESS (0.030s) [968.922224] [128/134] ( 84s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [969.022750] Starting subtest: yf-tiled-32bpp-rotate-90 [969.024695] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [969.143918] [129/134] ( 83s left) kms_psr (fbc-psr-sprite-mmap-cpu) [969.232397] Starting subtest: fbc-psr-sprite-mmap-cpu [969.233241] Starting dynamic subtest: eDP-1 [969.234964] Dynamic subtest eDP-1: SKIP (0.000s) [969.236561] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [969.315955] [130/134] ( 83s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [969.407157] Starting subtest: fbc-2p-primscrn-cur-indfb-move [969.408761] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [969.511510] [131/134] ( 83s left) i915_module_load (fault-injection) [969.546865] Starting subtest: fault-injection [969.582904] Starting dynamic subtest: __uc_init [972.574830] Dynamic subtest __uc_init: SUCCESS (2.981s) [972.585926] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [972.587654] Starting dynamic subtest: i915_driver_mmio_probe [972.755371] Dynamic subtest i915_driver_mmio_probe: SUCCESS (0.179s) [972.756262] Starting dynamic subtest: i915_driver_hw_probe [972.942579] Dynamic subtest i915_driver_hw_probe: SUCCESS (0.186s) [972.943570] Starting dynamic subtest: i915_pci_probe [973.079711] Dynamic subtest i915_pci_probe: SUCCESS (0.135s) [973.082892] Starting dynamic subtest: __fw_domain_init [973.266621] Dynamic subtest __fw_domain_init: SUCCESS (0.184s) [973.267680] Starting dynamic subtest: intel_connector_register [975.260587] Dynamic subtest intel_connector_register: SUCCESS (1.988s) [975.263504] Starting dynamic subtest: i915_driver_early_probe [975.393505] Dynamic subtest i915_driver_early_probe: SUCCESS (0.130s) [975.394472] Starting dynamic subtest: intel_gt_init-ENODEV [976.512831] Dynamic subtest intel_gt_init-ENODEV: SUCCESS (1.116s) [976.513886] Starting dynamic subtest: intel_guc_ct_init [977.732887] Dynamic subtest intel_guc_ct_init: SUCCESS (1.216s) [977.734220] Starting dynamic subtest: uc_fw_rsa_data_create [978.886187] Dynamic subtest uc_fw_rsa_data_create: SUCCESS (1.149s) [1068.678755] Killing the test because the kernel is tainted. [1069.080684] [FACT i915_module_load (fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [1069.080748] [FACT i915_module_load (fault-injection)] new: kernel.is_tainted.taint_warn: true [1069.081535] Closing watchdogs results: parsing output: 0/ for test: kms_properties results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_vblank results: parsing output: 5/ for test: gem_userptr_blits results: parsing output: 6/ for test: kms_addfb_basic results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: gem_userptr_blits results: parsing output: 10/ for test: gem_huc_copy results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: gem_ctx_persistence results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: kms_cursor_legacy results: parsing output: 16/ for test: gem_busy results: parsing output: 17/ for test: gem_mmap_offset results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_plane_scaling results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_pm_rpm results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_plane_scaling results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_hdr results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: prime_mmap results: parsing output: 31/ for test: kms_plane results: parsing output: 32/ for test: syncobj_wait results: parsing output: 33/ for test: api_intel_bb results: parsing output: 34/ for test: kms_pm_rpm results: parsing output: 35/ for test: kms_addfb_basic results: parsing output: 36/ for test: kms_cursor_crc results: parsing output: 37/ for test: gem_userptr_blits results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: gem_exec_schedule results: parsing output: 40/ for test: gem_eio results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gen9_exec_parse results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: sriov_basic results: parsing output: 46/ for test: gem_userptr_blits results: parsing output: 47/ for test: sysfs_defaults results: parsing output: 48/ for test: kms_chamelium_frames results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_flip results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_color results: parsing output: 53/ for test: perf results: parsing output: 54/ for test: kms_cdclk results: parsing output: 55/ for test: gem_ctx_persistence results: parsing output: 56/ for test: gem_set_tiling_vs_blt results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_content_protection results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: syncobj_wait results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_rotation_crc results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: gem_exec_schedule results: parsing output: 68/ for test: kms_feature_discovery results: parsing output: 69/ for test: gem_exec_balancer results: parsing output: 70/ for test: drm_read results: parsing output: 71/ for test: gem_exec_fence results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_flip_event_leak results: parsing output: 74/ for test: gem_softpin results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_draw_crc results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_atomic results: parsing output: 79/ for test: kms_chamelium_hpd results: parsing output: 80/ for test: i915_query results: parsing output: 81/ for test: api_intel_allocator results: parsing output: 82/ for test: kms_invalid_mode results: parsing output: 83/ for test: syncobj_wait results: parsing output: 84/ for test: gem_ctx_engines results: parsing output: 85/ for test: gem_exec_balancer results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: gem_exec_gttfill results: parsing output: 90/ for test: gem_render_copy results: parsing output: 91/ for test: perf_pmu results: parsing output: 92/ for test: gem_ccs results: parsing output: 93/ for test: prime_self_import results: parsing output: 94/ for test: syncobj_wait results: parsing output: 95/ for test: syncobj_eventfd results: parsing output: 96/ for test: gem_exec_whisper results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: i915_drm_fdinfo results: parsing output: 102/ for test: kms_rotation_crc results: parsing output: 103/ for test: kms_flip_scaled_crc results: parsing output: 104/ for test: kms_plane_lowres results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: core_setmaster results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: gem_exec_flush results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_flip results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: i915_pm_rps results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: gem_pread results: parsing output: 118/ for test: gem_ppgtt results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_pxp results: parsing output: 121/ for test: kms_pipe_crc_basic results: parsing output: 122/ for test: gem_mmap_wc results: parsing output: 123/ for test: kms_selftest results: parsing output: 124/ for test: gem_userptr_blits results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_lease results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: kms_psr results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: i915_module_load igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*' results: parsing output: 131/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 132/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 133/ for test: kms_psr results: no output, setting notrun Done.