[57.667332] Initializing watchdogs [57.667507] /dev/watchdog0 [57.689644] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.693778] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.696475] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.701795] [001/131] (960s left) gem_exec_schedule (preempt-user) [57.783571] Starting subtest: preempt-user [57.785523] Starting dynamic subtest: rcs0 [57.799956] Dynamic subtest rcs0: SUCCESS (0.022s) [57.809200] Starting dynamic subtest: bcs0 [57.817858] Dynamic subtest bcs0: SUCCESS (0.018s) [57.825092] Starting dynamic subtest: vcs0 [57.837625] Dynamic subtest vcs0: SUCCESS (0.019s) [57.846471] Starting dynamic subtest: vcs1 [57.859666] Dynamic subtest vcs1: SUCCESS (0.022s) [57.866196] Starting dynamic subtest: vecs0 [57.887032] Dynamic subtest vecs0: SUCCESS (0.028s) [57.893500] Starting dynamic subtest: ccs0 [57.925960] Dynamic subtest ccs0: SUCCESS (0.039s) [57.928430] Subtest preempt-user: SUCCESS (0.148s) [59.025396] [002/131] (959s left) gem_exec_schedule (u-lateslice) [59.109828] Starting subtest: u-lateslice [59.111939] Starting dynamic subtest: rcs0 [59.128019] Dynamic subtest rcs0: SUCCESS (0.027s) [59.136750] Starting dynamic subtest: bcs0 [59.148350] Dynamic subtest bcs0: SUCCESS (0.020s) [59.155183] Starting dynamic subtest: vcs0 [59.168221] Dynamic subtest vcs0: SUCCESS (0.020s) [59.174487] Starting dynamic subtest: vcs1 [59.187625] Dynamic subtest vcs1: SUCCESS (0.019s) [59.193887] Starting dynamic subtest: vecs0 [59.206907] Dynamic subtest vecs0: SUCCESS (0.019s) [59.213209] Starting dynamic subtest: ccs0 [59.227976] Dynamic subtest ccs0: SUCCESS (0.021s) [59.230339] Subtest u-lateslice: SUCCESS (0.127s) [60.978768] [003/131] (957s left) gem_exec_create (basic) [61.038697] Starting subtest: basic [61.041251] Starting dynamic subtest: smem [64.938931] Dynamic subtest smem: SUCCESS (3.898s) [64.941464] Subtest basic: SUCCESS (3.899s) [65.112061] [004/131] (953s left) gem_bad_reloc (negative-reloc-lut) [65.161204] Subtest negative-reloc-lut: SKIP (0.000s) [65.219508] [005/131] (953s left) gem_userptr_blits (input-checking) [65.286173] Starting subtest: input-checking [65.288092] Subtest input-checking: SUCCESS (0.000s) [65.410311] [006/131] (952s left) kms_atomic_interruptible (legacy-dpms) [65.502730] Starting subtest: legacy-dpms [65.505064] Starting dynamic subtest: pipe-A-eDP-1 [72.888270] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.385s) [72.890243] Subtest legacy-dpms: SUCCESS (7.386s) [73.709519] [007/131] (944s left) gem_exec_capture (capture-recoverable) [73.778687] Starting subtest: capture-recoverable [73.781180] Subtest capture-recoverable: SUCCESS (0.002s) [73.909031] [008/131] (944s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [74.035232] Starting subtest: verify-pxp-execution-after-suspend-resume [80.961240] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.927s) [81.095322] [009/131] (937s left) gem_mmap_gtt (zero-extend) [81.154862] Subtest zero-extend: SKIP (0.000s) [81.206395] [010/131] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [81.308976] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [87.864512] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.558s) [87.990796] [011/131] (930s left) kms_big_fb (yf-tiled-addfb-size-overflow) [88.091143] Starting subtest: yf-tiled-addfb-size-overflow [88.095107] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [88.202854] [012/131] (930s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [88.306723] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [95.301320] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.996s) [95.414633] [013/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [95.526589] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [102.153488] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.629s) [102.281825] [014/131] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25) [102.380091] Starting subtest: planes-upscale-20x20-downscale-factor-0-25 [102.382498] Starting dynamic subtest: pipe-A [102.398055] Dynamic subtest pipe-A: SKIP (0.012s) [102.405920] Starting dynamic subtest: pipe-B [102.423990] Dynamic subtest pipe-B: SKIP (0.026s) [102.433022] Starting dynamic subtest: pipe-C [102.447623] Dynamic subtest pipe-C: SKIP (0.024s) [102.454749] Starting dynamic subtest: pipe-D [102.473729] Dynamic subtest pipe-D: SKIP (0.024s) [102.478490] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.087s) [102.583947] [015/131] (916s left) kms_prime (d3hot) [104.716767] Subtest D3hot: SKIP (0.000s) [104.806017] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.amdgpu: true [104.806583] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true [104.806716] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.xe: true [104.809621] [016/131] (913s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [104.921038] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [106.202276] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.280s) [106.350334] [017/131] (912s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [106.408266] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [106.412374] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [106.585402] [018/131] (912s left) api_intel_bb (render) [106.646857] Starting subtest: render [106.649583] Starting dynamic subtest: render-none-512 [106.748454] Dynamic subtest render-none-512: SUCCESS (0.103s) [106.758040] Starting dynamic subtest: render-none-1024 [107.134996] Dynamic subtest render-none-1024: SUCCESS (0.384s) [107.144652] Starting dynamic subtest: render-x-512 [107.219632] Dynamic subtest render-x-512: SUCCESS (0.085s) [107.229582] Starting dynamic subtest: render-x-1024 [107.567409] Dynamic subtest render-x-1024: SUCCESS (0.346s) [107.577037] Starting dynamic subtest: render-y-512 [107.654828] Dynamic subtest render-y-512: SUCCESS (0.088s) [107.664988] Starting dynamic subtest: render-y-1024 [108.004446] Dynamic subtest render-y-1024: SUCCESS (0.348s) [108.006995] Subtest render: SUCCESS (1.357s) [108.139715] [019/131] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [108.253456] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [108.257960] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [108.344758] [020/131] (910s left) gem_exec_whisper (basic-queues-all) [108.413238] Starting subtest: basic-queues-all [118.969396] Subtest basic-queues-all: SUCCESS (10.556s) [119.145732] [021/131] (899s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [119.531608] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [120.374479] [022/131] (898s left) kms_psr (fbc-psr-primary-mmap-cpu) [120.465077] Starting subtest: fbc-psr-primary-mmap-cpu [120.467293] Starting dynamic subtest: eDP-1 [120.471364] Dynamic subtest eDP-1: SKIP (0.000s) [120.475571] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [120.533204] [023/131] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [120.634998] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [120.639589] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [120.736763] [024/131] (898s left) perf_pmu (init-sema) [120.779186] Starting subtest: init-sema [120.781927] Starting dynamic subtest: rcs0 [120.784573] Dynamic subtest rcs0: SUCCESS (0.002s) [120.794613] Starting dynamic subtest: bcs0 [120.796537] Dynamic subtest bcs0: SUCCESS (0.000s) [120.803703] Starting dynamic subtest: vcs0 [120.805643] Dynamic subtest vcs0: SUCCESS (0.001s) [120.812688] Starting dynamic subtest: vcs1 [120.814637] Dynamic subtest vcs1: SUCCESS (0.000s) [120.821661] Starting dynamic subtest: vecs0 [120.823601] Dynamic subtest vecs0: SUCCESS (0.001s) [120.831121] Starting dynamic subtest: ccs0 [120.833425] Dynamic subtest ccs0: SUCCESS (0.000s) [120.835686] Subtest init-sema: SUCCESS (0.005s) [120.881821] [025/131] (898s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [120.976076] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [120.978304] Starting dynamic subtest: pipe-A-default-mode [122.156425] Dynamic subtest pipe-A-default-mode: SKIP (1.175s) [122.160980] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.176s) [122.293648] [026/131] (896s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [122.668788] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [123.429138] [027/131] (895s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [123.530950] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [123.533369] Starting dynamic subtest: pipe-A-eDP-1 [123.563712] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [123.571576] Starting dynamic subtest: pipe-B-eDP-1 [123.592788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [123.599844] Starting dynamic subtest: pipe-C-eDP-1 [123.621647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [123.628758] Starting dynamic subtest: pipe-D-eDP-1 [123.650614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [123.655076] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s) [125.698767] [028/131] (893s left) kms_chamelium_audio (dp-audio) [126.086317] Subtest dp-audio: SKIP (0.000s) [126.899091] [029/131] (892s left) kms_async_flips (invalid-async-flip) [126.995103] Starting subtest: invalid-async-flip [126.999312] Subtest invalid-async-flip: SKIP (0.000s) [128.137560] [030/131] (891s left) gem_exec_params (secure-non-root) [128.194594] Starting subtest: secure-non-root [128.199045] Subtest secure-non-root: SKIP (0.000s) [128.297110] [031/131] (890s left) kms_properties (get_properties-sanity-atomic) [128.396901] Starting subtest: get_properties-sanity-atomic [128.401722] Subtest get_properties-sanity-atomic: SUCCESS (0.003s) [128.464472] [032/131] (890s left) gem_softpin (full) [128.517491] Starting subtest: full [128.526102] Subtest full: SUCCESS (0.008s) [128.672225] [033/131] (890s left) gem_close_race (basic-process) [128.733560] Starting subtest: basic-process [128.786400] Subtest basic-process: SUCCESS (0.053s) [128.967191] [034/131] (890s left) gem_userptr_blits (unsync-overlap) [129.042319] Subtest unsync-overlap: SKIP (0.000s) [129.182134] [035/131] (890s left) kms_flip (basic-flip-vs-modeset) [129.283039] Starting subtest: basic-flip-vs-modeset [129.285390] Starting dynamic subtest: A-eDP1 [131.816084] Dynamic subtest A-eDP1: SUCCESS (2.532s) [131.824898] Starting dynamic subtest: B-eDP1 [133.960580] Dynamic subtest B-eDP1: SUCCESS (2.144s) [133.969227] Starting dynamic subtest: C-eDP1 [136.117877] Dynamic subtest C-eDP1: SUCCESS (2.156s) [136.126379] Starting dynamic subtest: D-eDP1 [138.184185] Dynamic subtest D-eDP1: SUCCESS (2.066s) [138.186621] Subtest basic-flip-vs-modeset: SUCCESS (8.905s) [138.974712] [036/131] (880s left) kms_psr (psr-no-drrs) [139.074187] Starting subtest: psr-no-drrs [139.076467] Starting dynamic subtest: eDP-1 [140.751371] Dynamic subtest eDP-1: SUCCESS (1.677s) [140.753592] Subtest psr-no-drrs: SUCCESS (1.677s) [141.620882] [037/131] (877s left) syncobj_basic (bad-fd-to-handle) [141.679210] Starting subtest: bad-fd-to-handle [141.681646] Subtest bad-fd-to-handle: SUCCESS (0.000s) [141.785856] [038/131] (877s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [141.885929] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [141.890493] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [141.992998] [039/131] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [142.092227] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [142.096295] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [142.211473] [040/131] (877s left) perf_pmu (busy) [142.249497] Starting subtest: busy [142.251467] Starting dynamic subtest: rcs0 [142.863404] Dynamic subtest rcs0: SUCCESS (0.614s) [142.872726] Starting dynamic subtest: bcs0 [143.432918] Dynamic subtest bcs0: SUCCESS (0.569s) [143.442937] Starting dynamic subtest: vcs0 [144.939534] Dynamic subtest vcs0: SUCCESS (1.504s) [144.951348] Starting dynamic subtest: vcs1 [146.923364] Dynamic subtest vcs1: SUCCESS (1.983s) [146.932838] Starting dynamic subtest: vecs0 [148.907469] Dynamic subtest vecs0: SUCCESS (1.983s) [148.917483] Starting dynamic subtest: ccs0 [149.469240] Dynamic subtest ccs0: SUCCESS (0.563s) [149.472035] Subtest busy: SUCCESS (7.221s) [149.576686] [041/131] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [149.683470] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [149.687603] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [149.779261] [042/131] (869s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [154.762416] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [154.765018] Starting dynamic subtest: pipe-A-eDP-1 [161.281919] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.517s) [161.290882] Starting dynamic subtest: pipe-B-eDP-1 [167.804293] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.523s) [167.806751] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.043s) [168.675009] [043/131] (850s left) kms_cursor_crc (cursor-offscreen-128x42) [168.861983] Starting subtest: cursor-offscreen-128x42 [168.901543] Subtest cursor-offscreen-128x42: SKIP (0.033s) [169.085475] [044/131] (850s left) kms_cursor_crc (cursor-sliding-128x128) [169.260869] Starting subtest: cursor-sliding-128x128 [169.263356] Starting dynamic subtest: pipe-A-eDP-1 [172.824879] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.562s) [172.853426] Starting dynamic subtest: pipe-D-eDP-1 [176.868241] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.021s) [176.870678] Subtest cursor-sliding-128x128: SUCCESS (7.610s) [177.729200] [045/131] (841s left) gem_lmem_swapping (heavy-verify-multi) [177.782308] Subtest heavy-verify-multi: SKIP (0.000s) [177.823699] [046/131] (841s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [177.934708] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [177.936974] Starting dynamic subtest: A-eDP1 [181.523339] Dynamic subtest A-eDP1: SUCCESS (3.587s) [181.532379] Starting dynamic subtest: B-eDP1 [184.701824] Dynamic subtest B-eDP1: SUCCESS (3.177s) [184.710484] Starting dynamic subtest: C-eDP1 [187.763330] Dynamic subtest C-eDP1: SUCCESS (3.062s) [187.771830] Starting dynamic subtest: D-eDP1 [190.842875] Dynamic subtest D-eDP1: SUCCESS (3.078s) [190.845342] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.911s) [191.637256] [047/131] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [191.751604] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [191.756061] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [191.860996] [048/131] (827s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [191.918558] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [191.976746] [049/131] (827s left) api_intel_allocator (reloc-allocator) [192.034545] Starting subtest: reloc-allocator [192.037045] Starting dynamic subtest: basic [192.039403] Dynamic subtest basic: SUCCESS (0.003s) [192.050088] Starting dynamic subtest: parallel-one [192.052397] Dynamic subtest parallel-one: SUCCESS (0.008s) [192.060393] Starting dynamic subtest: print [192.062713] Dynamic subtest print: SUCCESS (0.000s) [192.070136] Starting dynamic subtest: reuse [192.072023] Dynamic subtest reuse: SUCCESS (0.000s) [192.079445] Starting dynamic subtest: fork-reopen-allocator [192.081424] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s) [192.083449] Subtest reloc-allocator: SUCCESS (0.029s) [192.198699] [050/131] (827s left) gem_render_copy_redux (normal) [192.262367] Starting subtest: normal [192.611074] Subtest normal: SUCCESS (0.349s) [192.744278] [051/131] (827s left) kms_big_fb (linear-32bpp-rotate-90) [192.849170] Starting subtest: linear-32bpp-rotate-90 [192.867082] Subtest linear-32bpp-rotate-90: SKIP (0.018s) [192.974616] [052/131] (826s left) gem_ctx_persistence (engines-queued) [193.026770] Starting subtest: engines-queued [193.028986] Starting dynamic subtest: rcs0 [193.115308] Dynamic subtest rcs0: SUCCESS (0.088s) [193.125887] Starting dynamic subtest: bcs0 [193.143313] Dynamic subtest bcs0: SUCCESS (0.027s) [193.150865] Starting dynamic subtest: vcs0 [194.889484] Dynamic subtest vcs0: SUCCESS (1.744s) [194.900293] Starting dynamic subtest: vcs1 [196.873363] Dynamic subtest vcs1: SUCCESS (1.981s) [196.883472] Starting dynamic subtest: vecs0 [198.920179] Dynamic subtest vecs0: SUCCESS (2.045s) [198.931370] Starting dynamic subtest: ccs0 [199.096708] Dynamic subtest ccs0: SUCCESS (0.176s) [199.099187] Subtest engines-queued: SUCCESS (6.069s) [199.228252] [053/131] (820s left) sw_sync (sync_merge) [199.268912] Starting subtest: sync_merge [199.271233] Subtest sync_merge: SUCCESS (0.000s) [199.321973] [054/131] (820s left) gem_exec_reloc (basic-cpu-noreloc) [199.389850] Subtest basic-cpu-noreloc: SKIP (0.000s) [199.449835] [055/131] (820s left) kms_psr (psr2-primary-mmap-cpu) [199.546429] Starting subtest: psr2-primary-mmap-cpu [199.548789] Starting dynamic subtest: eDP-1 [201.317642] Dynamic subtest eDP-1: SUCCESS (1.770s) [201.319980] Subtest psr2-primary-mmap-cpu: SUCCESS (1.770s) [202.186992] [056/131] (817s left) syncobj_timeline (single-wait-for-submit-available-signaled) [202.250474] Starting subtest: single-wait-for-submit-available-signaled [202.252924] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [202.361375] [057/131] (817s left) gem_exec_balancer (bonded-true-hang) [202.613125] Starting subtest: bonded-true-hang [202.618104] Subtest bonded-true-hang: SKIP (0.000s) [202.722068] [058/131] (817s left) kms_getfb (getfb2-handle-zero) [202.770309] Starting subtest: getfb2-handle-zero [202.772702] Subtest getfb2-handle-zero: SUCCESS (0.000s) [202.868157] [059/131] (817s left) gem_exec_schedule (noreorder) [203.059671] Starting subtest: noreorder [203.062113] Starting dynamic subtest: rcs0 [203.140818] Dynamic subtest rcs0: SUCCESS (0.081s) [203.149579] Starting dynamic subtest: vcs0 [204.929072] Dynamic subtest vcs0: SUCCESS (1.785s) [204.940770] Starting dynamic subtest: vcs1 [206.985362] Dynamic subtest vcs1: SUCCESS (2.054s) [206.996105] Starting dynamic subtest: vecs0 [208.970301] Dynamic subtest vecs0: SUCCESS (1.983s) [208.981880] Starting dynamic subtest: ccs0 [209.038637] Dynamic subtest ccs0: SUCCESS (0.068s) [209.041102] Subtest noreorder: SUCCESS (5.980s) [209.218409] [060/131] (811s left) sysfs_timeslice_duration (timeout) [209.287480] Starting subtest: timeout [209.289975] Starting dynamic subtest: vecs0 [218.940078] Dynamic subtest vecs0: SUCCESS (9.649s) [218.951576] Starting dynamic subtest: ccs0 [220.240463] Dynamic subtest ccs0: SUCCESS (1.299s) [220.250073] Starting dynamic subtest: vcs0 [229.953173] Dynamic subtest vcs0: SUCCESS (9.710s) [229.966287] Starting dynamic subtest: bcs0 [230.623119] Dynamic subtest bcs0: SUCCESS (0.670s) [230.632020] Starting dynamic subtest: rcs0 [231.980321] Dynamic subtest rcs0: SUCCESS (1.355s) [231.989456] Starting dynamic subtest: vcs1 [241.983456] Dynamic subtest vcs1: SUCCESS (9.999s) [241.985797] Subtest timeout: SUCCESS (32.694s) [242.050937] [061/131] (778s left) kms_joiner (basic-max-non-joiner) [242.155806] Starting subtest: basic-max-non-joiner [242.160339] Subtest basic-max-non-joiner: SKIP (0.000s) [242.221166] [062/131] (778s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [242.321354] Starting subtest: fbc-rgb565-draw-mmap-cpu [246.381884] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.064s) [247.561699] [063/131] (772s left) syncobj_timeline (signal-array) [247.619794] Starting subtest: signal-array [247.622095] Subtest signal-array: SUCCESS (0.000s) [247.725094] [064/131] (772s left) sriov_basic (enable-vfs-autoprobe-on) [247.786048] Starting subtest: enable-vfs-autoprobe-on [247.788388] Starting dynamic subtest: numvfs-1 [247.868281] Dynamic subtest numvfs-1: FAIL (0.033s) [247.878045] Starting dynamic subtest: numvfs-2 [247.952418] Dynamic subtest numvfs-2: FAIL (0.003s) [247.962968] Starting dynamic subtest: numvfs-3 [248.036970] Dynamic subtest numvfs-3: FAIL (0.003s) [248.046374] Starting dynamic subtest: numvfs-4 [248.119818] Dynamic subtest numvfs-4: FAIL (0.003s) [248.130286] Starting dynamic subtest: numvfs-5 [248.204436] Dynamic subtest numvfs-5: FAIL (0.003s) [248.213541] Starting dynamic subtest: numvfs-6 [248.287105] Dynamic subtest numvfs-6: FAIL (0.004s) [248.297272] Starting dynamic subtest: numvfs-7 [248.370697] Dynamic subtest numvfs-7: FAIL (0.003s) [248.378743] Starting dynamic subtest: numvfs-random [248.452050] Dynamic subtest numvfs-random: FAIL (0.004s) [248.461112] Starting dynamic subtest: numvfs-all [248.526947] Dynamic subtest numvfs-all: FAIL (0.515s) [248.528918] Subtest enable-vfs-autoprobe-on: FAIL (0.579s) [248.560614] [065/131] (771s left) gem_ctx_create (basic-files) [248.625914] Starting subtest: basic-files [250.638152] Subtest basic-files: SUCCESS (2.012s) [251.983421] [066/131] (768s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [252.080093] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [252.082377] Starting dynamic subtest: pipe-A-eDP-1 [252.595629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.514s) [252.605877] Starting dynamic subtest: pipe-B-eDP-1 [252.626366] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [252.636685] Starting dynamic subtest: pipe-C-eDP-1 [252.655831] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [252.663447] Starting dynamic subtest: pipe-D-eDP-1 [252.682806] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [252.684753] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.527s) [254.904591] [067/131] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [255.012565] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [259.600529] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.592s) [260.796126] [068/131] (759s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [260.902581] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [260.907094] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [260.987613] [069/131] (759s left) gen3_render_tiledx_blits [261.097322] [070/131] (759s left) perf (invalid-open-flags) [261.213116] Starting subtest: invalid-open-flags [261.215743] Subtest invalid-open-flags: SUCCESS (0.000s) [261.254410] [071/131] (759s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [261.347229] Starting subtest: fbc-rgb565-draw-mmap-gtt [261.351096] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [261.445692] [072/131] (759s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [261.544725] Starting subtest: coverage-vs-premult-vs-constant [261.960144] Starting dynamic subtest: pipe-A-eDP-1 [262.492512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [262.501471] Starting dynamic subtest: pipe-D-eDP-1 [263.797503] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s) [263.799385] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.255s) [264.639597] [073/131] (756s left) kms_flip (2x-flip-vs-wf_vblank) [264.738065] Starting subtest: 2x-flip-vs-wf_vblank [264.749423] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s) [264.824134] [074/131] (755s left) kms_rotation_crc (exhaust-fences) [264.912072] Starting subtest: exhaust-fences [264.916578] Subtest exhaust-fences: SKIP (0.000s) [264.980226] [075/131] (755s left) i915_pm_sseu (full-enable) [265.045163] Subtest full-enable: SKIP (0.000s) [265.145634] [076/131] (755s left) kms_cursor_edge_walk (128x128-right-edge) [265.233055] Starting subtest: 128x128-right-edge [265.235362] Starting dynamic subtest: pipe-A-eDP-1 [268.712163] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s) [268.723672] Starting dynamic subtest: pipe-D-eDP-1 [271.806015] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.090s) [271.808397] Subtest 128x128-right-edge: SUCCESS (6.572s) [272.629788] [077/131] (748s left) kms_lease (lease-get) [272.724158] Starting subtest: lease-get [272.726457] Starting dynamic subtest: pipe-A-eDP-1 [272.728749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [272.737585] Starting dynamic subtest: pipe-B-eDP-1 [272.739479] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [272.747142] Starting dynamic subtest: pipe-C-eDP-1 [272.749114] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [272.756798] Starting dynamic subtest: pipe-D-eDP-1 [272.758628] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [272.760499] Subtest lease-get: SUCCESS (0.008s) [272.841316] [078/131] (748s left) kms_pm_rpm (legacy-planes-dpms) [275.095114] Starting subtest: legacy-planes-dpms [275.098059] Starting dynamic subtest: plane-41 [283.364964] Dynamic subtest plane-41: SUCCESS (8.270s) [283.375864] Starting dynamic subtest: plane-50 [291.663781] Dynamic subtest plane-50: SUCCESS (8.296s) [291.675789] Starting dynamic subtest: plane-59 [299.951180] Dynamic subtest plane-59: SUCCESS (8.286s) [299.962963] Starting dynamic subtest: plane-68 [308.517841] Dynamic subtest plane-68: SUCCESS (8.565s) [308.520412] Subtest legacy-planes-dpms: SUCCESS (33.425s) [308.877730] [079/131] (712s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [313.926947] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [313.929355] Starting dynamic subtest: pipe-A-eDP-1 [314.729355] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s) [314.739951] Starting dynamic subtest: pipe-B-eDP-1 [315.856789] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [315.861442] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.925s) [317.027255] [080/131] (703s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [317.122678] Starting subtest: plane-scaler-with-clipping-clamping-rotation [317.125177] Starting dynamic subtest: pipe-A [317.493480] Dynamic subtest pipe-A: SUCCESS (0.371s) [317.502284] Starting dynamic subtest: pipe-B [318.917339] Dynamic subtest pipe-B: SUCCESS (1.423s) [318.926850] Starting dynamic subtest: pipe-C [320.391409] Dynamic subtest pipe-C: SUCCESS (1.474s) [320.400504] Starting dynamic subtest: pipe-D [321.761982] Dynamic subtest pipe-D: SUCCESS (1.370s) [321.764320] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.641s) [322.923363] [081/131] (698s left) kms_flip (dpms-vs-vblank-race) [323.026202] Starting subtest: dpms-vs-vblank-race [323.028546] Starting dynamic subtest: A-eDP1 [327.967164] Dynamic subtest A-eDP1: SUCCESS (4.939s) [327.978598] Starting dynamic subtest: B-eDP1 [332.583583] Dynamic subtest B-eDP1: SUCCESS (4.615s) [332.592652] Starting dynamic subtest: C-eDP1 [337.168287] Dynamic subtest C-eDP1: SUCCESS (4.584s) [337.177272] Starting dynamic subtest: D-eDP1 [341.761076] Dynamic subtest D-eDP1: SUCCESS (4.592s) [341.763401] Subtest dpms-vs-vblank-race: SUCCESS (18.737s) [342.630822] [082/131] (678s left) kms_flip (flip-vs-absolute-wf_vblank) [342.728131] Starting subtest: flip-vs-absolute-wf_vblank [342.730425] Starting dynamic subtest: A-eDP1 [351.679723] Dynamic subtest A-eDP1: SUCCESS (8.951s) [351.688053] Starting dynamic subtest: B-eDP1 [360.601338] Dynamic subtest B-eDP1: SUCCESS (8.921s) [360.610461] Starting dynamic subtest: C-eDP1 [369.513944] Dynamic subtest C-eDP1: SUCCESS (8.910s) [369.522315] Starting dynamic subtest: D-eDP1 [378.441257] Dynamic subtest D-eDP1: SUCCESS (8.926s) [378.443473] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.716s) [379.654566] [083/131] (641s left) kms_psr (fbc-pr-cursor-blt) [379.748393] Starting subtest: fbc-pr-cursor-blt [379.752783] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [379.819019] [084/131] (641s left) kms_cursor_crc (cursor-onscreen-64x64) [379.981770] Starting subtest: cursor-onscreen-64x64 [379.987068] Starting dynamic subtest: pipe-A-eDP-1 [382.237333] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.251s) [382.267730] Starting dynamic subtest: pipe-D-eDP-1 [385.128760] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.867s) [385.130941] Subtest cursor-onscreen-64x64: SUCCESS (5.146s) [386.002110] [085/131] (635s left) gem_exec_fence (syncobj-timeline-signal) [386.556476] Starting subtest: syncobj-timeline-signal [386.563475] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [388.005747] [086/131] (633s left) gem_ctx_persistence (saturated-hostile) [388.075494] Starting subtest: saturated-hostile [388.077773] Starting dynamic subtest: rcs0 [388.951547] Dynamic subtest rcs0: SUCCESS (0.875s) [388.968306] Starting dynamic subtest: bcs0 [389.766028] Dynamic subtest bcs0: SUCCESS (0.812s) [389.777697] Starting dynamic subtest: vcs0 [390.578336] Dynamic subtest vcs0: SUCCESS (0.810s) [390.590851] Starting dynamic subtest: vcs1 [391.404608] Dynamic subtest vcs1: SUCCESS (0.825s) [391.413360] Starting dynamic subtest: vecs0 [392.203434] Dynamic subtest vecs0: SUCCESS (0.794s) [392.214131] Starting dynamic subtest: ccs0 [393.069195] Dynamic subtest ccs0: SUCCESS (0.869s) [393.071726] Subtest saturated-hostile: SUCCESS (4.995s) [393.146313] [087/131] (628s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt) [393.259827] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt [393.264313] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [393.368521] [088/131] (627s left) syncobj_basic (bad-destroy) [393.431789] Starting subtest: bad-destroy [393.433916] Subtest bad-destroy: SUCCESS (0.000s) [393.539595] [089/131] (627s left) kms_dp_aux_dev [393.897085] [090/131] (627s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [393.998119] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [394.002803] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [395.123167] [091/131] (626s left) gem_mmap_offset (partial-mmap) [395.182750] Starting subtest: partial-mmap [395.185262] Starting dynamic subtest: smem0 [395.187720] Dynamic subtest smem0: SUCCESS (0.005s) [395.190080] Subtest partial-mmap: SUCCESS (0.006s) [395.313426] [092/131] (626s left) device_reset (unbind-cold-reset-rebind) [395.362075] Starting subtest: unbind-cold-reset-rebind [395.366429] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [395.436331] [093/131] (625s left) i915_query (test-query-geometry-subslices) [395.490306] Starting subtest: test-query-geometry-subslices [395.492661] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [395.587324] [094/131] (625s left) i915_module_load (reload-with-fault-injection) [395.628497] Starting subtest: reload-with-fault-injection [413.664768] Killing the test because the kernel is tainted. [415.504727] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [415.516169] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [415.516227] [FACT i915_module_load (reload-with-fault-injection)] new: kernel.is_tainted.taint_warn: true [415.516954] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true [415.517087] Closing watchdogs results: parsing output: 0/ for test: gem_exec_schedule results: parsing output: 1/ for test: gem_exec_schedule results: parsing output: 2/ for test: gem_exec_create results: parsing output: 3/ for test: gem_bad_reloc results: parsing output: 4/ for test: gem_userptr_blits results: parsing output: 5/ for test: kms_atomic_interruptible results: parsing output: 6/ for test: gem_exec_capture results: parsing output: 7/ for test: gem_pxp results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_plane_scaling results: parsing output: 14/ for test: kms_prime results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: api_intel_bb results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_exec_whisper results: parsing output: 20/ for test: kms_chamelium_hpd results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: perf_pmu results: parsing output: 24/ for test: kms_flip_scaled_crc results: parsing output: 25/ for test: kms_chamelium_edid results: parsing output: 26/ for test: kms_ccs results: parsing output: 27/ for test: kms_chamelium_audio results: parsing output: 28/ for test: kms_async_flips results: parsing output: 29/ for test: gem_exec_params results: parsing output: 30/ for test: kms_properties results: parsing output: 31/ for test: gem_softpin results: parsing output: 32/ for test: gem_close_race results: parsing output: 33/ for test: gem_userptr_blits results: parsing output: 34/ for test: kms_flip results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: syncobj_basic results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: perf_pmu results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_psr2_sf results: parsing output: 42/ for test: kms_cursor_crc results: parsing output: 43/ for test: kms_cursor_crc results: parsing output: 44/ for test: gem_lmem_swapping results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_pipe_b_c_ivb results: parsing output: 48/ for test: api_intel_allocator results: parsing output: 49/ for test: gem_render_copy_redux results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_ctx_persistence results: parsing output: 52/ for test: sw_sync results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: gem_exec_balancer results: parsing output: 57/ for test: kms_getfb results: parsing output: 58/ for test: gem_exec_schedule results: parsing output: 59/ for test: sysfs_timeslice_duration results: parsing output: 60/ for test: kms_joiner results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: sriov_basic results: parsing output: 64/ for test: gem_ctx_create results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gen3_render_tiledx_blits results: parsing output: 69/ for test: perf results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_plane_alpha_blend results: parsing output: 72/ for test: kms_flip results: parsing output: 73/ for test: kms_rotation_crc results: parsing output: 74/ for test: i915_pm_sseu results: parsing output: 75/ for test: kms_cursor_edge_walk results: parsing output: 76/ for test: kms_lease results: parsing output: 77/ for test: kms_pm_rpm results: parsing output: 78/ for test: kms_psr2_sf results: parsing output: 79/ for test: kms_plane_scaling results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_cursor_crc results: parsing output: 84/ for test: gem_exec_fence results: parsing output: 85/ for test: gem_ctx_persistence results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: syncobj_basic results: parsing output: 88/ for test: kms_dp_aux_dev results: parsing output: 89/ for test: kms_ccs results: parsing output: 90/ for test: gem_mmap_offset results: parsing output: 91/ for test: device_reset results: parsing output: 92/ for test: i915_query results: parsing output: 93/ for test: i915_module_load results: parsing output: 94/ for test: kms_vblank results: no output, setting notrun results: parsing output: 95/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 96/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 97/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 98/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 99/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 100/ for test: gem_exec_balancer results: no output, setting notrun results: parsing output: 101/ for test: kms_flip results: no output, setting notrun results: parsing output: 102/ for test: kms_psr results: no output, setting notrun results: parsing output: 103/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 104/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 105/ for test: gem_pxp results: no output, setting notrun results: parsing output: 106/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 107/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 108/ for test: kms_color results: no output, setting notrun results: parsing output: 109/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 110/ for test: syncobj_timeline 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: gen9_exec_parse results: no output, setting notrun results: parsing output: 113/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 114/ for test: kms_selftest results: no output, setting notrun results: parsing output: 115/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 116/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 117/ for test: gem_cs_tlb results: no output, setting notrun results: parsing output: 118/ for test: kms_rotation_crc results: no output, setting notrun results: parsing output: 119/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 120/ for test: kms_ccs results: no output, setting notrun results: parsing output: 121/ for test: kms_flip results: no output, setting notrun results: parsing output: 122/ for test: kms_flip results: no output, setting notrun results: parsing output: 123/ for test: gem_partial_pwrite_pread results: no output, setting notrun results: parsing output: 124/ for test: gen7_exec_parse results: no output, setting notrun results: parsing output: 125/ for test: kms_vblank results: no output, setting notrun results: parsing output: 126/ for test: gem_sync results: no output, setting notrun results: parsing output: 127/ for test: drm_fdinfo results: no output, setting notrun results: parsing output: 128/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 129/ for test: sw_sync results: no output, setting notrun results: parsing output: 130/ for test: kms_atomic_transition results: no output, setting notrun Done.