[56.490823] Initializing watchdogs [56.490974] /dev/watchdog0 [56.507654] [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.512453] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.514894] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.519685] [001/133] (960s left) fbdev (nullptr) [56.586616] Starting subtest: nullptr [56.589246] Subtest nullptr: SUCCESS (0.000s) [56.662447] [002/133] (960s left) gem_set_tiling_vs_pwrite [56.786575] [003/133] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [56.895922] Starting subtest: missing-ccs-buffer-y-tiled-ccs [56.898337] Starting dynamic subtest: pipe-A-eDP-1 [56.922077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [56.933064] Starting dynamic subtest: pipe-B-eDP-1 [56.955302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [56.962803] Starting dynamic subtest: pipe-C-eDP-1 [56.988205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [56.995855] Starting dynamic subtest: pipe-D-eDP-1 [57.019149] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [57.023734] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [59.365880] [004/133] (957s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [59.464220] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [59.466788] Starting dynamic subtest: pipe-A-default-mode [60.637975] Dynamic subtest pipe-A-default-mode: SKIP (1.153s) [60.642480] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.154s) [60.795025] [005/133] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [60.894614] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [60.898690] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [60.998723] [006/133] (956s left) dmabuf_sync_file (import-multiple-read-only) [61.067774] Starting subtest: import-multiple-read-only [61.069959] Subtest import-multiple-read-only: SUCCESS (0.003s) [61.120179] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true [61.123514] [007/133] (956s left) gem_fence_thrash (bo-write-verify-threaded-x) [61.156095] Starting subtest: bo-write-verify-threaded-x [61.179042] Subtest bo-write-verify-threaded-x: SKIP (0.020s) [61.237070] [008/133] (956s left) gem_mmap_gtt (big-bo) [61.290184] Subtest big-bo: SKIP (0.000s) [61.364303] [009/133] (955s left) vgem_basic (second-client) [61.407664] Starting subtest: second-client [61.429172] Subtest second-client: SUCCESS (0.022s) [61.487810] [010/133] (955s left) gem_fence_thrash (bo-write-verify-threaded-y) [61.518401] Starting subtest: bo-write-verify-threaded-y [61.542543] Subtest bo-write-verify-threaded-y: SKIP (0.020s) [61.598405] [011/133] (955s left) tools_test (tools_test) [61.646889] Starting subtest: tools_test [61.705062] Subtest tools_test: SUCCESS (0.070s) [61.776479] [012/133] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [61.862618] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [65.764889] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.862s) [66.967212] [013/133] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [67.069663] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [71.603935] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.514s) [72.821922] [014/133] (944s left) i915_drm_fdinfo (memory-info-resident) [72.900425] Starting subtest: memory-info-resident [72.903508] Starting dynamic subtest: smem0 [75.784480] Dynamic subtest smem0: SUCCESS (2.878s) [75.786825] Subtest memory-info-resident: SUCCESS (2.878s) [75.862596] [015/133] (941s left) gem_exec_fence (submit) [76.050342] Starting subtest: submit [76.055321] Subtest submit: SKIP (0.000s) [77.411038] [016/133] (940s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [77.469369] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [77.473886] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [77.670873] [017/133] (940s left) kms_psr (fbc-pr-dpms) [77.773146] Starting subtest: fbc-pr-dpms [77.777470] Subtest fbc-pr-dpms: SKIP (0.000s) [77.844495] [018/133] (939s left) kms_plane (pixel-format-linear-modifier) [77.937352] Starting subtest: pixel-format-linear-modifier [77.962809] Starting dynamic subtest: pipe-A-plane-0 [78.541442] Dynamic subtest pipe-A-plane-0: SUCCESS (0.578s) [78.550344] Starting dynamic subtest: pipe-A-plane-3 [78.986084] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s) [78.994573] Starting dynamic subtest: pipe-A-plane-5 [79.197655] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [80.289734] Starting dynamic subtest: pipe-B-plane-0 [80.860304] Dynamic subtest pipe-B-plane-0: SUCCESS (0.578s) [80.870319] Starting dynamic subtest: pipe-B-plane-3 [81.293223] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s) [81.302086] Starting dynamic subtest: pipe-B-plane-5 [81.504966] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s) [81.819402] Subtest pixel-format-linear-modifier: SUCCESS (3.877s) [82.655831] [019/133] (935s left) gem_exec_balancer (bonded-sync) [82.712500] Starting subtest: bonded-sync [82.717213] Subtest bonded-sync: SKIP (0.000s) [83.024132] [020/133] (934s left) kms_legacy_colorkey (basic) [83.125354] Starting subtest: basic [83.127729] Starting dynamic subtest: pipe-A [83.168406] Dynamic subtest pipe-A: SUCCESS (0.045s) [83.179998] Starting dynamic subtest: pipe-B [83.181997] Dynamic subtest pipe-B: SUCCESS (0.001s) [83.190390] Starting dynamic subtest: pipe-C [83.192549] Dynamic subtest pipe-C: SUCCESS (0.000s) [83.200819] Starting dynamic subtest: pipe-D [83.202911] Dynamic subtest pipe-D: SUCCESS (0.001s) [83.205059] Subtest basic: SUCCESS (0.049s) [83.251038] [021/133] (934s left) kms_flip (plain-flip-ts-check) [83.343331] Starting subtest: plain-flip-ts-check [83.345353] Starting dynamic subtest: A-eDP1 [92.255898] Dynamic subtest A-eDP1: SUCCESS (8.903s) [92.268102] Starting dynamic subtest: B-eDP1 [101.094572] Dynamic subtest B-eDP1: SUCCESS (8.833s) [101.106192] Starting dynamic subtest: C-eDP1 [109.916270] Dynamic subtest C-eDP1: SUCCESS (8.818s) [109.925250] Starting dynamic subtest: D-eDP1 [118.757931] Dynamic subtest D-eDP1: SUCCESS (8.838s) [118.760342] Subtest plain-flip-ts-check: SUCCESS (35.400s) [119.943452] [022/133] (897s left) prime_mmap (test_invalid_sync_flags) [119.991656] Starting subtest: test_invalid_sync_flags [119.993949] Starting dynamic subtest: test_invalid_sync_flags-smem [119.996340] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [119.998565] Subtest test_invalid_sync_flags: SUCCESS (0.000s) [120.102204] [023/133] (897s left) kms_prop_blob (blob-prop-validate) [120.148765] Starting subtest: blob-prop-validate [120.150626] Subtest blob-prop-validate: SUCCESS (0.000s) [120.247604] [024/133] (897s left) kms_cursor_crc (cursor-onscreen-256x256) [120.483842] Starting subtest: cursor-onscreen-256x256 [120.489351] Starting dynamic subtest: pipe-A-eDP-1 [122.596927] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s) [122.626821] Starting dynamic subtest: pipe-D-eDP-1 [125.439670] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.818s) [125.442055] Subtest cursor-onscreen-256x256: SUCCESS (4.954s) [126.322386] [025/133] (891s left) kms_psr (psr-sprite-plane-move) [126.409190] Starting subtest: psr-sprite-plane-move [126.411464] Starting dynamic subtest: eDP-1 [128.127749] Dynamic subtest eDP-1: SUCCESS (1.718s) [128.129668] Subtest psr-sprite-plane-move: SUCCESS (1.719s) [128.973629] [026/133] (889s left) gem_wait (busy) [129.046375] Starting subtest: busy [129.048770] Starting dynamic subtest: all-engines [130.305397] Dynamic subtest all-engines: SUCCESS (1.257s) [130.314611] Starting dynamic subtest: rcs0 [130.846605] Dynamic subtest rcs0: SUCCESS (0.541s) [130.857359] Starting dynamic subtest: bcs0 [131.384887] Dynamic subtest bcs0: SUCCESS (0.538s) [131.395955] Starting dynamic subtest: vcs0 [133.312333] Dynamic subtest vcs0: SUCCESS (1.925s) [133.324898] Starting dynamic subtest: vcs1 [135.296045] Dynamic subtest vcs1: SUCCESS (1.982s) [135.306975] Starting dynamic subtest: vecs0 [137.280749] Dynamic subtest vecs0: SUCCESS (1.983s) [137.292332] Starting dynamic subtest: ccs0 [137.822571] Dynamic subtest ccs0: SUCCESS (0.541s) [137.825064] Subtest busy: SUCCESS (8.775s) [138.027394] [027/133] (880s left) gem_exec_store (pages) [138.099189] Starting subtest: pages [138.101589] Starting dynamic subtest: rcs0 [138.207585] Dynamic subtest rcs0: SUCCESS (0.109s) [138.218783] Starting dynamic subtest: bcs0 [138.285047] Dynamic subtest bcs0: SUCCESS (0.077s) [138.295384] Starting dynamic subtest: vcs0 [138.357864] Dynamic subtest vcs0: SUCCESS (0.072s) [138.368202] Starting dynamic subtest: vcs1 [138.421099] Dynamic subtest vcs1: SUCCESS (0.064s) [138.431756] Starting dynamic subtest: vecs0 [138.495042] Dynamic subtest vecs0: SUCCESS (0.073s) [138.507444] Starting dynamic subtest: ccs0 [138.568195] Dynamic subtest ccs0: SUCCESS (0.073s) [138.570484] Subtest pages: SUCCESS (0.470s) [138.765250] [028/133] (879s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [138.821904] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [138.824170] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s) [138.926553] [029/133] (879s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [139.020698] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [139.855609] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s) [140.016333] [030/133] (878s left) gem_ctx_isolation (dirty-create) [140.083500] Starting subtest: dirty-create [140.085807] Starting dynamic subtest: rcs0 [140.277637] Dynamic subtest rcs0: SUCCESS (0.195s) [140.288729] Starting dynamic subtest: bcs0 [140.490370] Dynamic subtest bcs0: SUCCESS (0.212s) [140.502188] Starting dynamic subtest: vcs0 [140.707817] Dynamic subtest vcs0: SUCCESS (0.217s) [140.717131] Starting dynamic subtest: vcs1 [142.446557] Dynamic subtest vcs1: SUCCESS (1.738s) [142.457802] Starting dynamic subtest: vecs0 [144.530874] Dynamic subtest vecs0: SUCCESS (2.083s) [144.540642] Starting dynamic subtest: ccs0 [146.521637] Dynamic subtest ccs0: SUCCESS (1.990s) [146.524131] Subtest dirty-create: SUCCESS (6.438s) [146.759993] [031/133] (871s left) kms_big_fb (linear-16bpp-rotate-0) [146.863349] Starting subtest: linear-16bpp-rotate-0 [148.208896] Subtest linear-16bpp-rotate-0: SUCCESS (1.346s) [148.320950] [032/133] (870s left) gem_exec_params (no-bsd) [148.373609] Starting subtest: no-bsd [148.375602] Subtest no-bsd: SUCCESS (0.002s) [150.335858] [033/133] (868s left) api_intel_bb (delta-check) [150.381018] Starting subtest: delta-check [150.385507] Subtest delta-check: SUCCESS (0.006s) [150.504961] [034/133] (867s left) gem_mmap_offset (oob-read) [150.565692] Starting subtest: oob-read [150.567743] Subtest oob-read: SUCCESS (0.000s) [150.693126] [035/133] (867s left) kms_cursor_crc (cursor-random-32x10) [150.839968] Starting subtest: cursor-random-32x10 [150.889613] Subtest cursor-random-32x10: SKIP (0.045s) [151.174092] [036/133] (867s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [151.232342] Starting subtest: mixed-tiled-to-y-tiled-ccs [151.236919] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [151.415843] [037/133] (867s left) kms_chamelium_hpd (hdmi-hpd) [151.822404] Subtest hdmi-hpd: SKIP (0.000s) [152.604781] [038/133] (865s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [152.702425] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [159.627877] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.930s) [159.750154] [039/133] (858s left) i915_drm_fdinfo (virtual-busy-idle-all) [159.789467] Starting subtest: virtual-busy-idle-all [159.794056] Subtest virtual-busy-idle-all: SKIP (0.000s) [159.850024] [040/133] (858s left) perf (mi-rpc) [159.977265] Starting subtest: mi-rpc [159.981683] Subtest mi-rpc: SKIP (0.000s) [160.019313] [041/133] (858s left) kms_flip (absolute-wf_vblank) [160.104108] Starting subtest: absolute-wf_vblank [160.106414] Starting dynamic subtest: A-eDP1 [168.818418] Dynamic subtest A-eDP1: SUCCESS (8.714s) [168.830157] Starting dynamic subtest: B-eDP1 [177.541740] Dynamic subtest B-eDP1: SUCCESS (8.722s) [177.551713] Starting dynamic subtest: C-eDP1 [186.263819] Dynamic subtest C-eDP1: SUCCESS (8.719s) [186.274600] Starting dynamic subtest: D-eDP1 [195.000790] Dynamic subtest D-eDP1: SUCCESS (8.736s) [195.006375] Subtest absolute-wf_vblank: SUCCESS (34.901s) [196.209506] [042/133] (822s left) kms_psr (psr-cursor-render) [196.299829] Starting subtest: psr-cursor-render [196.302663] Starting dynamic subtest: eDP-1 [198.001065] Dynamic subtest eDP-1: SUCCESS (1.702s) [198.003291] Subtest psr-cursor-render: SUCCESS (1.702s) [198.864099] [043/133] (819s left) gem_exec_schedule (u-independent) [198.931389] Starting subtest: u-independent [198.933400] Starting dynamic subtest: rcs0 [200.321690] Dynamic subtest rcs0: SUCCESS (1.398s) [200.334669] Starting dynamic subtest: vcs0 [202.314135] Dynamic subtest vcs0: SUCCESS (1.991s) [202.324830] Starting dynamic subtest: vcs1 [204.288774] Dynamic subtest vcs1: SUCCESS (1.973s) [204.302270] Starting dynamic subtest: vecs0 [206.280520] Dynamic subtest vecs0: SUCCESS (1.989s) [206.293383] Starting dynamic subtest: ccs0 [208.323091] Dynamic subtest ccs0: SUCCESS (2.040s) [208.325957] Subtest u-independent: SUCCESS (9.400s) [208.627937] [044/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [208.724723] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [208.729270] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [208.820076] [045/133] (810s left) kms_sequence (queue-idle) [208.914360] Starting subtest: queue-idle [208.916304] Starting dynamic subtest: pipe-A-eDP-1 [210.709933] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.794s) [210.721233] Starting dynamic subtest: pipe-B-eDP-1 [213.158565] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.448s) [213.168174] Starting dynamic subtest: pipe-C-eDP-1 [215.664291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.505s) [215.674299] Starting dynamic subtest: pipe-D-eDP-1 [218.092919] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s) [218.095082] Subtest queue-idle: SUCCESS (9.181s) [218.911344] [046/133] (800s left) gem_close (many-handles-one-vma) [218.965807] Starting subtest: many-handles-one-vma [218.985764] Subtest many-handles-one-vma: SUCCESS (0.021s) [219.111844] [047/133] (799s left) kms_pm_rpm (system-suspend-idle) [220.640481] Starting subtest: system-suspend-idle [242.096913] Subtest system-suspend-idle: SUCCESS (7.143s) [249.506295] [048/133] (776s left) kms_psr (fbc-psr2-primary-blt) [249.622783] Starting subtest: fbc-psr2-primary-blt [249.625114] Starting dynamic subtest: eDP-1 [249.629677] Dynamic subtest eDP-1: SKIP (0.000s) [249.634420] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [249.712382] [049/133] (776s left) perf_pmu (init-sema) [249.751789] Starting subtest: init-sema [249.754055] Starting dynamic subtest: rcs0 [249.756582] Dynamic subtest rcs0: SUCCESS (0.002s) [249.768054] Starting dynamic subtest: bcs0 [249.770025] Dynamic subtest bcs0: SUCCESS (0.000s) [249.779688] Starting dynamic subtest: vcs0 [249.781583] Dynamic subtest vcs0: SUCCESS (0.001s) [249.791221] Starting dynamic subtest: vcs1 [249.793172] Dynamic subtest vcs1: SUCCESS (0.001s) [249.803081] Starting dynamic subtest: vecs0 [249.805318] Dynamic subtest vecs0: SUCCESS (0.001s) [249.815246] Starting dynamic subtest: ccs0 [249.817285] Dynamic subtest ccs0: SUCCESS (0.000s) [249.819254] Subtest init-sema: SUCCESS (0.008s) [249.866682] [050/133] (776s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [249.960347] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [249.964807] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [251.176738] [051/133] (774s left) gem_exec_flush (basic-uc-rw-default) [251.248059] Starting subtest: basic-uc-rw-default [256.846991] Subtest basic-uc-rw-default: SUCCESS (5.456s) [257.055768] [052/133] (769s left) kms_content_protection (atomic-dpms-hdcp14) [257.205090] Starting subtest: atomic-dpms-hdcp14 [257.209862] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [257.341772] [053/133] (768s left) gem_mmap_wc (write-prefaulted) [257.396610] Subtest write-prefaulted: SKIP (0.000s) [257.456114] [054/133] (768s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [257.557312] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [261.646352] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.042s) [262.814650] [055/133] (763s left) kms_atomic (atomic-invalid-params) [262.916824] Starting subtest: atomic-invalid-params [262.919189] Starting dynamic subtest: pipe-A-eDP-1 [263.322390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s) [263.324620] Subtest atomic-invalid-params: SUCCESS (0.403s) [264.150213] [056/133] (762s left) gem_ctx_engines (execute-oneforall) [264.212305] Starting subtest: execute-oneforall [264.770763] Subtest execute-oneforall: SUCCESS (0.554s) [265.698906] [057/133] (760s left) i915_query (query-topology-garbage-items) [265.750785] Starting subtest: query-topology-garbage-items [265.753048] Subtest query-topology-garbage-items: SUCCESS (0.000s) [265.862334] [058/133] (760s left) kms_invalid_mode (bad-vsync-end) [265.958534] Starting subtest: bad-vsync-end [265.960874] Starting dynamic subtest: pipe-A-eDP-1 [266.244700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [266.255450] Starting dynamic subtest: pipe-B-eDP-1 [266.257358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [266.267015] Starting dynamic subtest: pipe-C-eDP-1 [266.269257] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [266.282147] Starting dynamic subtest: pipe-D-eDP-1 [266.284574] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [266.286965] Subtest bad-vsync-end: SUCCESS (0.292s) [267.106107] [059/133] (759s left) kms_busy (basic-hang) [267.203468] Starting subtest: basic-hang [267.205820] Starting dynamic subtest: flip-pipe-A [267.784576] Dynamic subtest flip-pipe-A: SUCCESS (0.577s) [267.795689] Starting dynamic subtest: modeset-pipe-A [271.256107] Dynamic subtest modeset-pipe-A: SUCCESS (3.459s) [271.268002] Starting dynamic subtest: flip-pipe-D [272.466512] Dynamic subtest flip-pipe-D: SUCCESS (1.205s) [272.477592] Starting dynamic subtest: modeset-pipe-D [275.800000] Dynamic subtest modeset-pipe-D: SUCCESS (3.326s) [275.802337] Subtest basic-hang: SUCCESS (8.573s) [276.618817] [060/133] (749s left) api_intel_bb (full-batch) [276.671728] Starting subtest: full-batch [276.676362] Subtest full-batch: SUCCESS (0.005s) [276.817683] [061/133] (749s left) gem_spin_batch (legacy-resubmit) [276.875972] Starting subtest: legacy-resubmit [276.878249] Starting dynamic subtest: default [276.883035] Dynamic subtest default: SUCCESS (0.005s) [276.894010] Starting dynamic subtest: render [276.896311] Dynamic subtest render: SUCCESS (0.001s) [276.906027] Starting dynamic subtest: bsd [276.907946] Dynamic subtest bsd: SUCCESS (0.002s) [276.917163] Starting dynamic subtest: bsd1 [276.919074] Dynamic subtest bsd1: SUCCESS (0.002s) [276.928331] Starting dynamic subtest: bsd2 [276.930294] Dynamic subtest bsd2: SUCCESS (0.001s) [276.939606] Starting dynamic subtest: blt [276.941492] Dynamic subtest blt: SUCCESS (0.002s) [276.950778] Starting dynamic subtest: vebox [276.952686] Dynamic subtest vebox: SUCCESS (0.003s) [276.954600] Subtest legacy-resubmit: SUCCESS (0.022s) [277.133065] [062/133] (749s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [277.227589] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [277.229887] Starting dynamic subtest: pipe-A-eDP-1 [277.253084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [277.266129] Starting dynamic subtest: pipe-B-eDP-1 [277.288568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [277.297901] Starting dynamic subtest: pipe-C-eDP-1 [277.320632] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [277.330061] Starting dynamic subtest: pipe-D-eDP-1 [277.352465] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [277.356540] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s) [279.496338] [063/133] (747s left) gem_lmem_swapping (heavy-verify-multi) [279.541086] Subtest heavy-verify-multi: SKIP (0.000s) [279.589128] [064/133] (747s left) gem_request_retire (retire-vma-not-inactive) [279.646602] Starting subtest: retire-vma-not-inactive [279.704887] Subtest retire-vma-not-inactive: SUCCESS (0.057s) [279.834177] [065/133] (746s left) gem_lmem_swapping (random) [279.875429] Subtest random: SKIP (0.000s) [279.916617] [066/133] (746s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [280.025253] Starting subtest: psr-indfb-scaledprimary [285.741093] Subtest psr-indfb-scaledprimary: SUCCESS (5.714s) [285.868563] [067/133] (740s left) gem_exec_schedule (preempt-contexts) [285.947091] Starting subtest: preempt-contexts [285.949452] Starting dynamic subtest: rcs0 [286.000329] Dynamic subtest rcs0: SUCCESS (0.060s) [286.011148] Starting dynamic subtest: bcs0 [286.053458] Dynamic subtest bcs0: SUCCESS (0.052s) [286.064338] Starting dynamic subtest: vcs0 [286.106781] Dynamic subtest vcs0: SUCCESS (0.053s) [286.117909] Starting dynamic subtest: vcs1 [286.150749] Dynamic subtest vcs1: SUCCESS (0.043s) [286.161754] Starting dynamic subtest: vecs0 [286.199741] Dynamic subtest vecs0: SUCCESS (0.048s) [286.210343] Starting dynamic subtest: ccs0 [286.250021] Dynamic subtest ccs0: SUCCESS (0.048s) [286.252181] Subtest preempt-contexts: SUCCESS (0.310s) [287.696777] [068/133] (739s left) kms_plane_multiple (tiling-yf) [287.796308] Starting subtest: tiling-yf [287.800307] Subtest tiling-yf: SKIP (0.000s) [287.881347] [069/133] (739s left) gem_ctx_param (set-priority-invalid-size) [287.949144] Starting subtest: set-priority-invalid-size [287.951351] Subtest set-priority-invalid-size: SUCCESS (0.000s) [288.021020] [070/133] (738s left) kms_addfb_basic (bad-pitch-1024) [288.076860] Starting subtest: bad-pitch-1024 [288.078688] Subtest bad-pitch-1024: SUCCESS (0.000s) [288.205984] [071/133] (738s left) gem_set_tiling_vs_blt (tiled-to-untiled) [288.266563] Subtest tiled-to-untiled: SKIP (0.000s) [288.330307] [072/133] (738s left) gem_exec_nop (basic-sequential) [288.401265] Starting subtest: basic-sequential [303.054679] Subtest basic-sequential: SUCCESS (14.653s) [303.273354] [073/133] (723s left) prime_busy (hang) [303.328858] Starting subtest: hang [303.331205] Starting dynamic subtest: rcs0 [329.178182] Dynamic subtest rcs0: SUCCESS (25.833s) [329.188052] Starting dynamic subtest: bcs0 [336.252748] Dynamic subtest bcs0: SUCCESS (7.068s) [336.264877] Starting dynamic subtest: vcs0 [343.282726] Dynamic subtest vcs0: SUCCESS (7.032s) [343.292996] Starting dynamic subtest: vcs1 [350.260109] Dynamic subtest vcs1: SUCCESS (6.979s) [350.270182] Starting dynamic subtest: vecs0 [357.239270] Dynamic subtest vecs0: SUCCESS (6.976s) [357.249010] Starting dynamic subtest: ccs0 [371.140728] Dynamic subtest ccs0: SUCCESS (13.900s) [371.142973] Subtest hang: SUCCESS (67.795s) [371.258534] [074/133] (655s left) kms_flip (2x-dpms-vs-vblank-race) [371.358315] Starting subtest: 2x-dpms-vs-vblank-race [371.368667] Subtest 2x-dpms-vs-vblank-race: SKIP (0.012s) [371.449306] [075/133] (655s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [371.542009] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [371.544462] Starting dynamic subtest: pipe-A [371.605034] Dynamic subtest pipe-A: SUCCESS (0.066s) [371.617428] Starting dynamic subtest: pipe-B [372.739852] Dynamic subtest pipe-B: SUCCESS (1.134s) [372.750764] Starting dynamic subtest: pipe-C [373.853023] Dynamic subtest pipe-C: SUCCESS (1.111s) [373.869023] Starting dynamic subtest: pipe-D [374.985467] Dynamic subtest pipe-D: SUCCESS (1.131s) [374.987776] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.447s) [376.158222] [076/133] (651s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [376.262925] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [376.265033] Starting dynamic subtest: pipe-A-eDP-1 [386.947173] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.685s) [386.958230] Starting dynamic subtest: pipe-B-eDP-1 [398.379765] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.430s) [398.382028] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.118s) [399.242801] [077/133] (628s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [399.351701] Starting subtest: psr-2p-primscrn-cur-indfb-move [399.355987] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [399.463213] [078/133] (627s left) gem_exec_alignment (many) [399.521072] Starting subtest: many [422.867668] Subtest many: SUCCESS (23.338s) [424.795240] [079/133] (602s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [424.952739] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [432.011727] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.060s) [432.141689] [080/133] (595s left) syncobj_timeline (invalid-signal-illegal-handle) [432.200820] Starting subtest: invalid-signal-illegal-handle [432.203221] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [432.276823] [081/133] (595s left) kms_color (legacy-gamma) [432.368582] Starting subtest: legacy-gamma [432.370819] Starting dynamic subtest: pipe-A-eDP-1 [433.150605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s) [433.163112] Starting dynamic subtest: pipe-B-eDP-1 [434.540216] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s) [434.551326] Starting dynamic subtest: pipe-C-eDP-1 [435.895392] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s) [435.906227] Starting dynamic subtest: pipe-D-eDP-1 [437.235083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s) [437.237765] Subtest legacy-gamma: SUCCESS (4.867s) [438.042406] [082/133] (589s left) kms_chamelium_frames (dp-crc-single) [438.426108] Subtest dp-crc-single: SKIP (0.000s) [439.244535] [083/133] (588s left) syncobj_basic (bad-create-flags) [439.304428] Starting subtest: bad-create-flags [439.306560] Subtest bad-create-flags: SUCCESS (0.000s) [439.413138] [084/133] (588s left) gem_madvise (dontneed-before-exec) [439.450162] Starting subtest: dontneed-before-exec [439.467013] Subtest dontneed-before-exec: SKIP (0.018s) [439.534825] [085/133] (588s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [439.601040] Subtest writes-after-reads: SKIP (0.000s) [439.676343] [086/133] (587s left) kms_addfb_basic (framebuffer-vs-set-tiling) [439.732178] Starting subtest: framebuffer-vs-set-tiling [439.736547] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [439.897149] [087/133] (587s left) kms_flip (2x-flip-vs-dpms-on-nop) [439.992440] Starting subtest: 2x-flip-vs-dpms-on-nop [440.001128] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [440.095626] [088/133] (587s left) gen9_exec_parse (batch-zero-length) [440.161340] Subtest batch-zero-length: SKIP (0.000s) [440.249995] [089/133] (587s left) gem_ctx_param (basic) [440.306249] Starting subtest: basic [440.307955] Subtest basic: SUCCESS (0.001s) [440.409586] [090/133] (587s left) gem_exec_schedule (fairslice) [440.471594] Starting subtest: fairslice [440.473258] Starting dynamic subtest: rcs0 [442.491475] Dynamic subtest rcs0: SUCCESS (2.018s) [442.505812] Starting dynamic subtest: bcs0 [444.512084] Dynamic subtest bcs0: SUCCESS (2.020s) [444.523011] Starting dynamic subtest: vcs0 [446.533384] Dynamic subtest vcs0: SUCCESS (2.018s) [446.549076] Starting dynamic subtest: vcs1 [448.553041] Dynamic subtest vcs1: SUCCESS (2.017s) [448.564524] Starting dynamic subtest: vecs0 [450.568593] Dynamic subtest vecs0: SUCCESS (2.016s) [450.579083] Starting dynamic subtest: ccs0 [452.588112] Dynamic subtest ccs0: SUCCESS (2.018s) [452.590252] Subtest fairslice: SUCCESS (12.113s) [452.901438] [091/133] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [453.015252] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [460.772666] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.758s) [460.889778] [092/133] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [460.986421] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [468.013592] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.029s) [468.131185] [093/133] (559s left) prime_vgem (basic-write) [468.194894] Starting subtest: basic-write [468.215617] Subtest basic-write: SKIP (0.019s) [468.336032] [094/133] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [468.430878] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [468.435169] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [468.538931] [095/133] (559s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [468.645632] Starting subtest: plane-downscale-factor-0-5-with-rotation [468.647890] Starting dynamic subtest: pipe-A [468.668405] Dynamic subtest pipe-A: SKIP (0.018s) [468.679909] Starting dynamic subtest: pipe-B [468.701264] Dynamic subtest pipe-B: SKIP (0.031s) [468.713690] Starting dynamic subtest: pipe-C [468.734163] Dynamic subtest pipe-C: SKIP (0.032s) [468.744924] Starting dynamic subtest: pipe-D [468.765650] Dynamic subtest pipe-D: SKIP (0.032s) [468.769980] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.115s) [468.857463] [096/133] (559s left) gem_exec_basic (basic) [468.909924] Starting subtest: basic [468.912284] Starting dynamic subtest: rcs0-smem [468.914618] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [468.927338] Starting dynamic subtest: bcs0-smem [468.929536] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [468.939496] Starting dynamic subtest: vcs0-smem [468.941658] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [468.951531] Starting dynamic subtest: vcs1-smem [468.953447] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [468.963313] Starting dynamic subtest: vecs0-smem [468.965229] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [468.975218] Starting dynamic subtest: ccs0-smem [468.977130] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [468.979067] Subtest basic: SUCCESS (0.016s) [470.676961] [097/133] (557s left) gem_ctx_persistence (legacy-engines-mixed-process) [470.732980] Starting subtest: legacy-engines-mixed-process [470.735247] Starting dynamic subtest: render [472.632530] Dynamic subtest render: SUCCESS (1.901s) [472.643934] Starting dynamic subtest: bsd1 [474.693137] Dynamic subtest bsd1: SUCCESS (2.060s) [474.703484] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [474.707871] Starting dynamic subtest: bsd2 [476.591060] Dynamic subtest bsd2: SUCCESS (1.900s) [476.593634] Starting dynamic subtest: blt [478.563510] Dynamic subtest blt: SUCCESS (1.973s) [478.565911] Starting dynamic subtest: vebox [480.617348] Dynamic subtest vebox: SUCCESS (2.055s) [480.620010] Subtest legacy-engines-mixed-process: SUCCESS (9.897s) [480.683229] [FACT gem_ctx_persistence (legacy-engines-mixed-process)] new: kernel.is_tainted.taint_warn: true [480.684183] Closing watchdogs results: parsing output: 0/ for test: fbdev results: parsing output: 1/ for test: gem_set_tiling_vs_pwrite results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: kms_flip_scaled_crc results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: dmabuf_sync_file results: parsing output: 6/ for test: gem_fence_thrash results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: vgem_basic results: parsing output: 9/ for test: gem_fence_thrash results: parsing output: 10/ for test: tools_test results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: i915_drm_fdinfo results: parsing output: 14/ for test: gem_exec_fence results: parsing output: 15/ for test: gem_render_copy results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: kms_plane results: parsing output: 18/ for test: gem_exec_balancer results: parsing output: 19/ for test: kms_legacy_colorkey results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: prime_mmap results: parsing output: 22/ for test: kms_prop_blob results: parsing output: 23/ for test: kms_cursor_crc results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: gem_wait results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: gem_ctx_isolation results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: gem_exec_params results: parsing output: 32/ for test: api_intel_bb results: parsing output: 33/ for test: gem_mmap_offset results: parsing output: 34/ for test: kms_cursor_crc results: parsing output: 35/ for test: gem_render_copy results: parsing output: 36/ for test: kms_chamelium_hpd results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: i915_drm_fdinfo results: parsing output: 39/ for test: perf results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: gem_exec_schedule results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_sequence results: parsing output: 45/ for test: gem_close results: parsing output: 46/ for test: kms_pm_rpm results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: perf_pmu results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: gem_exec_flush results: parsing output: 51/ for test: kms_content_protection results: parsing output: 52/ for test: gem_mmap_wc results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_atomic results: parsing output: 55/ for test: gem_ctx_engines results: parsing output: 56/ for test: i915_query results: parsing output: 57/ for test: kms_invalid_mode results: parsing output: 58/ for test: kms_busy results: parsing output: 59/ for test: api_intel_bb results: parsing output: 60/ for test: gem_spin_batch results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: gem_lmem_swapping results: parsing output: 63/ for test: gem_request_retire results: parsing output: 64/ for test: gem_lmem_swapping results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: kms_plane_multiple results: parsing output: 68/ for test: gem_ctx_param results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: gem_set_tiling_vs_blt results: parsing output: 71/ for test: gem_exec_nop results: parsing output: 72/ for test: prime_busy results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_plane_scaling results: parsing output: 75/ for test: kms_psr2_sf results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_alignment results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: kms_color results: parsing output: 81/ for test: kms_chamelium_frames results: parsing output: 82/ for test: syncobj_basic results: parsing output: 83/ for test: gem_madvise results: parsing output: 84/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: gen9_exec_parse results: parsing output: 88/ for test: gem_ctx_param results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: prime_vgem results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_plane_scaling results: parsing output: 95/ for test: gem_exec_basic results: parsing output: 96/ for test: gem_ctx_persistence results: parsing output: 97/ for test: prime_udl results: no output, setting notrun results: parsing output: 98/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 99/ for test: syncobj_eventfd results: no output, setting notrun results: parsing output: 100/ for test: kms_psr results: no output, setting notrun results: parsing output: 101/ for test: i915_pm_rps results: no output, setting notrun results: parsing output: 102/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 103/ for test: kms_psr results: no output, setting notrun results: parsing output: 104/ for test: gem_partial_pwrite_pread results: no output, setting notrun results: parsing output: 105/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 106/ for test: kms_plane_cursor results: no output, setting notrun results: parsing output: 107/ for test: kms_draw_crc results: no output, setting notrun results: parsing output: 108/ for test: kms_dp_link_training results: no output, setting notrun results: parsing output: 109/ for test: kms_dsc results: no output, setting notrun results: parsing output: 110/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 111/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 112/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 113/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 114/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 115/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 116/ for test: kms_async_flips results: no output, setting notrun results: parsing output: 117/ for test: gem_softpin results: no output, setting notrun results: parsing output: 118/ for test: kms_ccs results: no output, setting notrun results: parsing output: 119/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 120/ for test: kms_chamelium_color results: no output, setting notrun results: parsing output: 121/ for test: kms_pm_rpm results: no output, setting notrun results: parsing output: 122/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 123/ for test: gem_exec_params results: no output, setting notrun results: parsing output: 124/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 125/ for test: sysfs_preempt_timeout results: no output, setting notrun results: parsing output: 126/ for test: kms_vrr results: no output, setting notrun results: parsing output: 127/ for test: gem_madvise results: no output, setting notrun results: parsing output: 128/ for test: kms_vblank results: no output, setting notrun results: parsing output: 129/ for test: kms_cursor_edge_walk results: no output, setting notrun results: parsing output: 130/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 131/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 132/ for test: kms_big_fb results: no output, setting notrun Done.