[59.001057] Initializing watchdogs [59.001175] /dev/watchdog0 [59.015892] [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] [59.020237] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.022463] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.025736] [001/129] (960s left) gem_partial_pwrite_pread (reads-uncached) [59.104724] Subtest reads-uncached: SKIP (0.000s) [59.180789] [002/129] (960s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [59.235862] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [59.240338] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [59.436219] [003/129] (960s left) kms_pm_rpm (pm-caching) [61.086934] Starting subtest: pm-caching [61.091983] Subtest pm-caching: SKIP (0.000s) [61.713295] [004/129] (957s left) gem_ctx_param (invalid-param-get) [61.774671] Starting subtest: invalid-param-get [61.777236] Subtest invalid-param-get: SUCCESS (0.001s) [61.897530] [005/129] (957s left) syncobj_timeline (wait-all-snapshot) [61.957160] Starting subtest: wait-all-snapshot [62.037437] Subtest wait-all-snapshot: SUCCESS (0.082s) [62.124840] [006/129] (957s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [62.175793] Starting subtest: multi-wait-for-submit-submitted-signaled [62.178117] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [62.301772] [007/129] (957s left) gem_exec_fence (syncobj-timeline-signal) [62.830797] Starting subtest: syncobj-timeline-signal [62.836073] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [63.975861] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [63.978981] [008/129] (955s left) perf (blocking-parameterized) [64.113256] Starting subtest: blocking-parameterized [84.158066] Subtest blocking-parameterized: SUCCESS (20.039s) [84.199118] [009/129] (935s left) i915_pm_rpm (sysfs-read) [86.121465] Starting subtest: sysfs-read [87.281076] Subtest sysfs-read: SUCCESS (1.157s) [87.672216] [010/129] (932s left) syncobj_timeline (multi-wait-available-signaled) [87.738930] Starting subtest: multi-wait-available-signaled [87.741321] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [87.870850] [011/129] (932s left) gem_mmap_wc (read-write-distinct) [87.927651] Subtest read-write-distinct: SKIP (0.000s) [87.987059] [012/129] (931s left) kms_plane (plane-position-covered) [88.072374] Starting subtest: plane-position-covered [88.627030] Starting dynamic subtest: pipe-A-plane-1 [89.910592] Dynamic subtest pipe-A-plane-1: SUCCESS (1.284s) [89.920619] Starting dynamic subtest: pipe-A-plane-2 [91.143819] Dynamic subtest pipe-A-plane-2: SUCCESS (1.232s) [91.153868] Starting dynamic subtest: pipe-A-plane-3 [92.391072] Dynamic subtest pipe-A-plane-3: SUCCESS (1.248s) [92.399887] Starting dynamic subtest: pipe-A-plane-4 [93.714119] Dynamic subtest pipe-A-plane-4: SUCCESS (1.322s) [93.722816] Starting dynamic subtest: pipe-A-plane-5 [93.739317] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [94.861417] Starting dynamic subtest: pipe-B-plane-1 [96.196042] Dynamic subtest pipe-B-plane-1: SUCCESS (1.339s) [96.205106] Starting dynamic subtest: pipe-B-plane-2 [97.533404] Dynamic subtest pipe-B-plane-2: SUCCESS (1.338s) [97.543096] Starting dynamic subtest: pipe-B-plane-3 [98.862608] Dynamic subtest pipe-B-plane-3: SUCCESS (1.329s) [98.869629] Starting dynamic subtest: pipe-B-plane-4 [100.169804] Dynamic subtest pipe-B-plane-4: SUCCESS (1.304s) [100.181490] Starting dynamic subtest: pipe-B-plane-5 [100.193085] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [100.195290] Subtest plane-position-covered: SUCCESS (12.119s) [100.976132] [013/129] (919s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [101.033953] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [101.035990] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [101.144962] [014/129] (918s left) kms_flip (basic-flip-vs-wf_vblank) [101.245182] Starting subtest: basic-flip-vs-wf_vblank [101.247557] Starting dynamic subtest: A-eDP1 [103.209062] Dynamic subtest A-eDP1: SUCCESS (1.966s) [103.217123] Starting dynamic subtest: B-eDP1 [105.136732] Dynamic subtest B-eDP1: SUCCESS (1.927s) [105.146511] Starting dynamic subtest: C-eDP1 [107.058245] Dynamic subtest C-eDP1: SUCCESS (1.920s) [107.068089] Starting dynamic subtest: D-eDP1 [108.984702] Dynamic subtest D-eDP1: SUCCESS (1.925s) [108.989698] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.748s) [110.246496] [015/129] (909s left) sw_sync (sync_busy_fork) [110.280325] Starting subtest: sync_busy_fork [111.291815] Subtest sync_busy_fork: SUCCESS (1.011s) [111.379248] [016/129] (908s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [111.480341] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [111.484718] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [111.620923] [017/129] (908s left) gem_exec_reloc (basic-wc) [111.675517] Subtest basic-wc: SKIP (0.000s) [111.732782] [018/129] (908s left) kms_plane_scaling (planes-upscale-20x20) [111.825303] Starting subtest: planes-upscale-20x20 [111.827720] Starting dynamic subtest: pipe-A [111.885148] Dynamic subtest pipe-A: SUCCESS (0.062s) [111.893957] Starting dynamic subtest: pipe-B [113.049664] Dynamic subtest pipe-B: SUCCESS (1.164s) [113.059273] Starting dynamic subtest: pipe-C [114.170053] Dynamic subtest pipe-C: SUCCESS (1.119s) [114.180671] Starting dynamic subtest: pipe-D [115.300252] Dynamic subtest pipe-D: SUCCESS (1.129s) [115.302845] Subtest planes-upscale-20x20: SUCCESS (3.478s) [116.461220] [019/129] (903s left) kms_psr (psr-primary-mmap-cpu) [116.567661] Starting subtest: psr-primary-mmap-cpu [116.570097] Starting dynamic subtest: eDP-1 [118.276912] Dynamic subtest eDP-1: SUCCESS (1.711s) [118.279350] Subtest psr-primary-mmap-cpu: SUCCESS (1.712s) [119.137757] [020/129] (901s left) sw_sync (sync_multi_producer_single_consumer) [119.170633] Starting subtest: sync_multi_producer_single_consumer [120.246338] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [120.304008] [021/129] (899s left) gem_softpin (evict-active-interruptible) [120.366867] Starting subtest: evict-active-interruptible [120.373548] Subtest evict-active-interruptible: SUCCESS (0.007s) [120.531713] [022/129] (899s left) kms_psr (fbc-psr2-primary-blt) [120.641095] Starting subtest: fbc-psr2-primary-blt [120.643030] Starting dynamic subtest: eDP-1 [120.647158] Dynamic subtest eDP-1: SKIP (0.000s) [120.651345] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [120.729144] [023/129] (899s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [120.829849] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [120.832173] Starting dynamic subtest: pipe-A-eDP-1 [120.840979] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [120.848639] Starting dynamic subtest: pipe-B-eDP-1 [120.857778] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [120.865214] Starting dynamic subtest: pipe-C-eDP-1 [120.873925] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [120.881166] Starting dynamic subtest: pipe-D-eDP-1 [120.889976] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [120.894426] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [123.043341] [024/129] (897s left) syncobj_wait (wait-any-interrupted) [123.093631] Starting subtest: wait-any-interrupted [123.195557] Subtest wait-any-interrupted: SUCCESS (0.101s) [123.280252] [025/129] (897s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [123.372120] Starting subtest: psr-indfb-scaledprimary [129.088620] Subtest psr-indfb-scaledprimary: SUCCESS (5.719s) [129.232961] [026/129] (891s left) kms_color (legacy-gamma) [129.328367] Starting subtest: legacy-gamma [129.330589] Starting dynamic subtest: pipe-A-eDP-1 [130.041178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [130.049327] Starting dynamic subtest: pipe-B-eDP-1 [131.513363] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s) [131.521265] Starting dynamic subtest: pipe-C-eDP-1 [132.831099] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.319s) [132.840480] Starting dynamic subtest: pipe-D-eDP-1 [134.194129] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.361s) [134.196371] Subtest legacy-gamma: SUCCESS (4.864s) [134.999721] [027/129] (885s left) kms_pm_dc (dc9-dpms) [136.092718] Starting subtest: dc9-dpms [137.525995] Subtest dc9-dpms: SUCCESS (1.433s) [137.600129] [028/129] (882s left) kms_cursor_crc (cursor-tearing-position-change) [137.706642] Starting subtest: cursor-tearing-position-change [137.708938] Starting dynamic subtest: pipe-A-eDP-1 [138.273789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [138.281051] Starting dynamic subtest: pipe-D-eDP-1 [139.492480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s) [139.494762] Subtest cursor-tearing-position-change: SUCCESS (1.785s) [140.342889] [029/129] (880s left) kms_mmap_write_crc (main) [140.446863] Starting subtest: main [140.448860] Starting dynamic subtest: pipe-A-eDP-1 [143.970046] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.524s) [143.972383] Subtest main: SUCCESS (3.525s) [144.789334] [030/129] (875s left) kms_big_fb (y-tiled-64bpp-rotate-0) [144.899546] Starting subtest: y-tiled-64bpp-rotate-0 [144.903622] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [145.033357] [031/129] (875s left) kms_cursor_crc (cursor-onscreen-32x10) [145.198279] Starting subtest: cursor-onscreen-32x10 [145.242513] Subtest cursor-onscreen-32x10: SKIP (0.041s) [145.515247] [032/129] (875s left) kms_plane_multiple (tiling-4) [145.605286] Starting subtest: tiling-4 [145.607575] Starting dynamic subtest: pipe-A-eDP-1 [149.286023] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.676s) [149.297772] Starting dynamic subtest: pipe-B-eDP-1 [153.720755] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.434s) [153.729315] Starting dynamic subtest: pipe-C-eDP-1 [158.043516] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.322s) [158.051289] Starting dynamic subtest: pipe-D-eDP-1 [162.370544] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.324s) [162.372770] Subtest tiling-4: SUCCESS (16.762s) [163.189537] [033/129] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [163.284310] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [163.288312] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [163.399166] [034/129] (857s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [163.511705] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [163.516378] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [163.678265] [035/129] (857s left) kms_big_fb (linear-addfb) [163.777221] Starting subtest: linear-addfb [163.779063] Subtest linear-addfb: SUCCESS (0.000s) [163.906086] [036/129] (856s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [164.003935] Starting subtest: yf-tiled-32bpp-rotate-0 [164.008206] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [164.103717] [037/129] (856s left) gem_eio (in-flight-immediate) [164.332258] Starting subtest: in-flight-immediate [173.006352] Subtest in-flight-immediate: SUCCESS (8.672s) [173.206669] [038/129] (847s left) gem_ctx_param (invalid-get-no-zeromap) [173.264089] Starting subtest: invalid-get-no-zeromap [173.266413] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [173.411437] [039/129] (847s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [173.511159] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [173.513420] Starting dynamic subtest: pipe-A-default-mode [173.813521] Dynamic subtest pipe-A-default-mode: SKIP (0.301s) [173.817800] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.303s) [174.615128] [040/129] (846s left) gem_exec_whisper (basic-normal) [174.682990] Starting subtest: basic-normal [179.667968] Subtest basic-normal: SUCCESS (4.983s) [179.867431] [041/129] (841s left) gen9_exec_parse (bb-start-out) [179.929562] Subtest bb-start-out: SKIP (0.000s) [180.004635] [042/129] (841s left) kms_properties (plane-properties-atomic) [180.098858] Starting subtest: plane-properties-atomic [180.101347] Starting dynamic subtest: pipe-A-eDP-1 [180.646871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s) [180.657654] Starting dynamic subtest: pipe-B-eDP-1 [181.892790] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s) [181.900998] Starting dynamic subtest: pipe-C-eDP-1 [183.137468] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.243s) [183.147208] Starting dynamic subtest: pipe-D-eDP-1 [184.358847] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s) [184.361240] Subtest plane-properties-atomic: SUCCESS (4.261s) [185.184918] [043/129] (835s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [190.339323] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [190.343710] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s) [191.225256] [044/129] (829s left) kms_big_fb (x-tiled-32bpp-rotate-0) [191.326986] Starting subtest: x-tiled-32bpp-rotate-0 [192.805559] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.479s) [192.973799] [045/129] (828s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [193.070980] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [193.072841] Starting dynamic subtest: pipe-A-eDP-1 [193.092412] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [193.106780] Starting dynamic subtest: pipe-B-eDP-1 [193.124528] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [193.132979] Starting dynamic subtest: pipe-C-eDP-1 [193.151136] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [193.161223] Starting dynamic subtest: pipe-D-eDP-1 [193.180603] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [193.184179] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s) [195.289323] [046/129] (825s left) kms_vblank (query-idle) [195.389162] Starting subtest: query-idle [195.391336] Starting dynamic subtest: pipe-A-eDP-1 [197.131632] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s) [197.146877] Starting dynamic subtest: pipe-D-eDP-1 [199.622601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.489s) [199.624536] Subtest query-idle: SUCCESS (4.233s) [200.467557] [047/129] (820s left) gem_pwrite (basic-random) [200.528980] Subtest basic-random: SKIP (0.000s) [200.585781] [048/129] (820s left) gem_exec_balancer (full-pulse) [200.642254] Starting subtest: full-pulse [205.685609] Subtest full-pulse: SUCCESS (5.043s) [206.028817] [049/129] (815s left) gem_ctx_shared (q-smoketest-all) [206.104716] Starting subtest: Q-smoketest-all [238.514922] Subtest Q-smoketest-all: SUCCESS (32.359s) [238.950346] [050/129] (782s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [239.049614] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [239.053700] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [239.187578] [051/129] (782s left) kms_getfb (getfb2-handle-protection) [239.284279] Starting subtest: getfb2-handle-protection [239.301185] Subtest getfb2-handle-protection: SUCCESS (0.018s) [239.449243] [052/129] (782s left) kms_busy (extended-modeset-hang-newfb-with-reset) [239.555530] Starting subtest: extended-modeset-hang-newfb-with-reset [239.557678] Starting dynamic subtest: pipe-A [254.722842] Dynamic subtest pipe-A: SUCCESS (15.168s) [254.732585] Starting dynamic subtest: pipe-D [270.510794] Dynamic subtest pipe-D: SUCCESS (15.783s) [270.512671] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.956s) [271.320795] [053/129] (750s left) gem_lmem_swapping (verify-random) [271.362742] Subtest verify-random: SKIP (0.000s) [271.403487] [054/129] (750s left) prime_mmap_coherency (read) [271.459427] Starting subtest: read [276.831411] Subtest read: SUCCESS (5.374s) [276.991443] [055/129] (744s left) kms_psr (fbc-psr-cursor-plane-onoff) [277.083922] Starting subtest: fbc-psr-cursor-plane-onoff [277.086080] Starting dynamic subtest: eDP-1 [277.090056] Dynamic subtest eDP-1: SKIP (0.000s) [277.094093] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [277.170218] [056/129] (744s left) gem_exec_schedule (preempt-hang) [277.353409] Starting subtest: preempt-hang [277.356538] Starting dynamic subtest: rcs0 [277.589348] Dynamic subtest rcs0: SUCCESS (0.235s) [277.600109] Starting dynamic subtest: bcs0 [277.820963] Dynamic subtest bcs0: SUCCESS (0.230s) [277.831024] Starting dynamic subtest: vcs0 [278.056803] Dynamic subtest vcs0: SUCCESS (0.235s) [278.068740] Starting dynamic subtest: vcs1 [278.292921] Dynamic subtest vcs1: SUCCESS (0.235s) [278.304599] Starting dynamic subtest: vecs0 [278.521157] Dynamic subtest vecs0: SUCCESS (0.226s) [278.531227] Starting dynamic subtest: ccs0 [278.749124] Dynamic subtest ccs0: SUCCESS (0.229s) [278.751318] Subtest preempt-hang: SUCCESS (1.397s) [279.059088] [057/129] (742s left) kms_joiner (basic-force-ultra-joiner) [279.167314] Subtest basic-force-ultra-joiner: SKIP (0.000s) [279.238877] [058/129] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [279.343481] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [279.348103] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [279.468869] [059/129] (742s left) template (a) [279.522279] Starting subtest: A [279.524470] Subtest A: SUCCESS (0.000s) [279.658211] [060/129] (742s left) gem_ppgtt (blt-vs-render-ctx0) [279.713612] Starting subtest: blt-vs-render-ctx0 [312.695421] Subtest blt-vs-render-ctx0: SUCCESS (32.979s) [312.861642] [061/129] (709s left) syncobj_wait (reset-unsignaled) [312.954579] Starting subtest: reset-unsignaled [312.956742] Subtest reset-unsignaled: SUCCESS (0.000s) [313.080646] [062/129] (708s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [313.193120] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [313.197122] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [313.310499] [063/129] (708s left) gem_render_copy (y-tiled-ccs-to-linear) [313.372955] Starting subtest: y-tiled-ccs-to-linear [313.377567] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [313.568281] [064/129] (708s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [313.660745] Starting subtest: psr-2p-primscrn-cur-indfb-move [313.664849] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [313.769879] [065/129] (708s left) gem_mmap_offset (mmap-unmap) [313.822201] Starting subtest: mmap-unmap [313.824501] Starting dynamic subtest: smem0 [335.364778] Dynamic subtest smem0: SUCCESS (21.542s) [335.367682] Subtest mmap-unmap: SUCCESS (21.544s) [335.509796] [066/129] (686s left) kms_vrr (flip-basic) [335.612061] Starting subtest: flip-basic [335.618642] Subtest flip-basic: SKIP (0.000s) [335.692372] [067/129] (686s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [335.788131] Starting subtest: blocking-absolute-wf_vblank-interruptible [335.790488] Starting dynamic subtest: A-eDP1 [344.557007] Dynamic subtest A-eDP1: SUCCESS (8.767s) [344.565460] Starting dynamic subtest: B-eDP1 [353.292430] Dynamic subtest B-eDP1: SUCCESS (8.734s) [353.309439] Starting dynamic subtest: C-eDP1 [362.009750] Dynamic subtest C-eDP1: SUCCESS (8.716s) [362.020177] Starting dynamic subtest: D-eDP1 [370.743272] Dynamic subtest D-eDP1: SUCCESS (8.732s) [370.745694] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.957s) [371.969468] [068/129] (650s left) gem_exec_await (wide-contexts) [372.193740] Starting subtest: wide-contexts [395.616496] Subtest wide-contexts: SUCCESS (23.422s) [395.825514] [069/129] (626s left) kms_atomic_interruptible (universal-setplane-cursor) [395.966804] Starting subtest: universal-setplane-cursor [395.969114] Starting dynamic subtest: pipe-A-eDP-1 [403.379886] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.414s) [403.382160] Subtest universal-setplane-cursor: SUCCESS (7.416s) [404.261299] [070/129] (618s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [404.348154] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [404.350475] Starting dynamic subtest: pipe-A-default-mode [404.650032] Dynamic subtest pipe-A-default-mode: SKIP (0.299s) [404.654515] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.300s) [405.461966] [071/129] (616s left) kms_async_flips (async-flip-suspend-resume) [405.555383] Starting subtest: async-flip-suspend-resume [405.925228] Starting dynamic subtest: pipe-A-eDP-1 [407.201942] Dynamic subtest pipe-A-eDP-1: FAIL (0.826s) [407.212644] Starting dynamic subtest: pipe-B-eDP-1 [408.116493] Dynamic subtest pipe-B-eDP-1: FAIL (0.743s) [408.263822] Starting dynamic subtest: pipe-C-eDP-1 [426.654286] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.008s) [427.032051] Starting dynamic subtest: pipe-D-eDP-1 [444.596000] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.879s) [444.598347] Subtest async-flip-suspend-resume: FAIL (8.954s) [445.821487] [072/129] (576s left) kms_big_fb (yf-tiled-addfb-size-overflow) [445.925471] Starting subtest: yf-tiled-addfb-size-overflow [445.929530] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [446.060897] [073/129] (576s left) gem_exec_big (single) [446.116364] Starting subtest: single [448.282412] Subtest single: SUCCESS (2.183s) [448.481422] [074/129] (573s left) i915_query (query-regions-sanity-check) [448.576608] Starting subtest: query-regions-sanity-check [448.585581] Subtest query-regions-sanity-check: SUCCESS (0.011s) [448.727703] [075/129] (573s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [448.830366] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [455.753474] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.954s) [455.891244] [076/129] (566s left) kms_psr (fbc-pr-basic) [455.991137] Starting subtest: fbc-pr-basic [455.995411] Subtest fbc-pr-basic: SKIP (0.000s) [456.074718] [077/129] (566s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [456.172148] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [456.176612] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [457.346249] [078/129] (565s left) gem_mmap_gtt (basic-read-write-distinct) [457.412140] Subtest basic-read-write-distinct: SKIP (0.000s) [457.483195] [079/129] (565s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [457.595925] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [458.229334] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s) [458.448686] [080/129] (564s left) api_intel_bb (blit-noreloc-keep-cache) [458.500328] Starting subtest: blit-noreloc-keep-cache [458.509981] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s) [458.660017] [081/129] (564s left) core_setmaster (master-drop-set-root) [458.735849] Starting subtest: master-drop-set-root [458.748917] Subtest master-drop-set-root: SUCCESS (0.013s) [458.797297] [082/129] (563s left) gem_exec_params (no-blt) [458.860670] Starting subtest: no-blt [458.862959] Subtest no-blt: SUCCESS (0.002s) [459.025280] [083/129] (563s left) kms_atomic_transition (modeset-transition-fencing) [459.126874] Starting subtest: modeset-transition-fencing [459.128685] Starting dynamic subtest: 1x-outputs [469.981692] Dynamic subtest 1x-outputs: SUCCESS (10.869s) [469.985047] Subtest modeset-transition-fencing: SUCCESS (10.870s) [470.846824] [084/129] (552s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [470.940639] Starting subtest: psr-rgb565-draw-mmap-wc [477.704543] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.767s) [477.829687] [085/129] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [477.936448] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [477.940312] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [478.073292] [086/129] (544s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [478.126002] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [478.235643] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [478.322000] [087/129] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [478.419892] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [478.424352] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [478.533986] [088/129] (544s left) kms_draw_crc (draw-method-render) [478.630471] Starting subtest: draw-method-render [478.632704] Starting dynamic subtest: xrgb8888-untiled [478.908777] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s) [478.919533] Starting dynamic subtest: rgb565-untiled [479.153527] Dynamic subtest rgb565-untiled: SUCCESS (0.243s) [479.164327] Starting dynamic subtest: xrgb2101010-untiled [479.386845] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s) [479.396565] Starting dynamic subtest: xbgr16161616f-untiled [479.608911] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [479.619366] Starting dynamic subtest: xrgb8888-xtiled [479.742454] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [479.752528] Starting dynamic subtest: rgb565-xtiled [479.864762] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [479.875373] Starting dynamic subtest: xrgb2101010-xtiled [479.986992] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [479.997324] Starting dynamic subtest: xbgr16161616f-xtiled [480.120362] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [480.130900] Starting dynamic subtest: xrgb8888-4tiled [480.253407] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [480.263996] Starting dynamic subtest: rgb565-4tiled [480.364838] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s) [480.374506] Starting dynamic subtest: xrgb2101010-4tiled [480.486851] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [480.497429] Starting dynamic subtest: xbgr16161616f-4tiled [480.620343] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s) [480.622202] Subtest draw-method-render: SUCCESS (1.990s) [480.725498] [089/129] (542s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [480.778517] Starting subtest: etime-multi-wait-all-submitted-signaled [480.883221] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s) [480.971218] [090/129] (542s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [486.054887] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [486.059658] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [486.908250] [091/129] (536s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [486.987966] Starting subtest: plane-primary-toggle-with-vblank-wait [486.990265] Starting dynamic subtest: pipe-A-eDP-1 [487.161221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [487.480018] Starting dynamic subtest: pipe-B-eDP-1 [488.396797] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.926s) [488.697964] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.711s) [489.581002] [092/129] (533s left) kms_dirtyfb (psr-dirtyfb-ioctl) [489.680676] Starting subtest: psr-dirtyfb-ioctl [489.683052] Starting dynamic subtest: A-eDP-1 [493.584871] Dynamic subtest A-eDP-1: SUCCESS (3.904s) [493.586779] Subtest psr-dirtyfb-ioctl: SUCCESS (3.905s) [494.398893] [093/129] (528s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [494.494411] Starting subtest: psr-2p-scndscrn-cur-indfb-move [494.498284] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [494.617388] [094/129] (528s left) gem_mmap_gtt (basic-copy) [494.676640] Subtest basic-copy: SKIP (0.000s) [494.750569] [095/129] (528s left) kms_chamelium_color (ctm-negative) [494.835612] Subtest ctm-negative: SKIP (0.000s) [494.882203] [096/129] (528s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [495.269014] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [496.092707] [097/129] (527s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [496.216896] Starting subtest: verify-pxp-execution-after-suspend-resume [503.183130] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.970s) [503.341688] [098/129] (520s left) gem_exec_schedule (u-fairslice) [503.416691] Starting subtest: u-fairslice [503.419157] Starting dynamic subtest: rcs0 [505.434269] Dynamic subtest rcs0: SUCCESS (2.023s) [505.446989] Starting dynamic subtest: bcs0 [507.452543] Dynamic subtest bcs0: SUCCESS (2.018s) [507.463245] Starting dynamic subtest: vcs0 [509.473430] Dynamic subtest vcs0: SUCCESS (2.021s) [509.484955] Starting dynamic subtest: vcs1 [511.493463] Dynamic subtest vcs1: SUCCESS (2.017s) [511.504904] Starting dynamic subtest: vecs0 [513.509854] Dynamic subtest vecs0: SUCCESS (2.015s) [513.521740] Starting dynamic subtest: ccs0 [515.529776] Dynamic subtest ccs0: SUCCESS (2.020s) [515.531687] Subtest u-fairslice: SUCCESS (12.120s) [515.840599] [099/129] (507s left) gem_wait (write-busy) [515.898535] Starting subtest: write-busy [515.900983] Starting dynamic subtest: all-engines [516.527810] Dynamic subtest all-engines: SUCCESS (0.629s) [516.539680] Starting dynamic subtest: rcs0 [517.087381] Dynamic subtest rcs0: SUCCESS (0.557s) [517.104525] Starting dynamic subtest: bcs0 [517.643605] Dynamic subtest bcs0: SUCCESS (0.556s) [517.660072] Starting dynamic subtest: vcs0 [519.059851] Dynamic subtest vcs0: SUCCESS (1.385s) [519.071060] Starting dynamic subtest: vcs1 [521.013557] Dynamic subtest vcs1: SUCCESS (1.981s) [521.031632] Starting dynamic subtest: vecs0 [522.998100] Dynamic subtest vecs0: SUCCESS (1.981s) [523.014786] Starting dynamic subtest: ccs0 [523.548246] Dynamic subtest ccs0: SUCCESS (0.549s) [523.550578] Subtest write-busy: SUCCESS (7.651s) [523.771238] [100/129] (499s left) kms_force_connector_basic (force-load-detect) [523.852011] Starting subtest: force-load-detect [523.856354] Subtest force-load-detect: SKIP (0.000s) [523.979941] [101/129] (499s left) sysfs_preempt_timeout (idempotent) [524.044309] Starting subtest: idempotent [524.046570] Starting dynamic subtest: vecs0 [524.048793] Dynamic subtest vecs0: SUCCESS (0.000s) [524.059943] Starting dynamic subtest: ccs0 [524.062249] Dynamic subtest ccs0: SUCCESS (0.000s) [524.072262] Starting dynamic subtest: vcs0 [524.074450] Dynamic subtest vcs0: SUCCESS (0.000s) [524.084411] Starting dynamic subtest: bcs0 [524.086730] Dynamic subtest bcs0: SUCCESS (0.000s) [524.098093] Starting dynamic subtest: rcs0 [524.100086] Dynamic subtest rcs0: SUCCESS (0.000s) [524.110144] Starting dynamic subtest: vcs1 [524.112511] Dynamic subtest vcs1: SUCCESS (0.000s) [524.114716] Subtest idempotent: SUCCESS (0.006s) [524.166127] [102/129] (499s left) kms_chamelium_edid (hdmi-mode-timings) [524.546763] Subtest hdmi-mode-timings: SKIP (0.000s) [525.340834] [103/129] (498s left) kms_lease (lease-again) [525.437307] Starting subtest: lease-again [525.439585] Starting dynamic subtest: pipe-A-eDP-1 [525.441921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [525.455666] Starting dynamic subtest: pipe-B-eDP-1 [525.457840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [525.467889] Starting dynamic subtest: pipe-C-eDP-1 [525.470017] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [525.479307] Starting dynamic subtest: pipe-D-eDP-1 [525.481387] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [525.483456] Subtest lease-again: SUCCESS (0.012s) [525.572188] [104/129] (498s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [525.670643] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [525.674931] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [525.798397] [105/129] (497s left) gem_barrier_race (remote-request) [525.873661] Starting subtest: remote-request [525.875956] Starting dynamic subtest: rcs0 [531.014335] Dynamic subtest rcs0: SUCCESS (5.142s) [531.016550] Subtest remote-request: SUCCESS (5.144s) [531.160577] [106/129] (492s left) gem_exec_suspend (basic-s4-devices) [531.220410] Starting subtest: basic-S4-devices [531.222503] Starting dynamic subtest: smem [547.000866] Dynamic subtest smem: SUCCESS (15.779s) [547.004515] Subtest basic-S4-devices: SUCCESS (15.784s) [547.242634] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [547.269253] [FACT gem_exec_suspend (basic-s4-devices)] new: kernel.is_tainted.taint_warn: true [547.271481] Closing watchdogs results: parsing output: 0/ for test: gem_partial_pwrite_pread results: parsing output: 1/ for test: gem_render_copy results: parsing output: 2/ for test: kms_pm_rpm results: parsing output: 3/ for test: gem_ctx_param results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: syncobj_wait results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: perf results: parsing output: 8/ for test: i915_pm_rpm results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: gem_mmap_wc results: parsing output: 11/ for test: kms_plane results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: sw_sync results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_exec_reloc results: parsing output: 17/ for test: kms_plane_scaling results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: sw_sync results: parsing output: 20/ for test: gem_softpin results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_color results: parsing output: 26/ for test: kms_pm_dc results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: kms_mmap_write_crc results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: kms_plane_multiple results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: gem_eio results: parsing output: 37/ for test: gem_ctx_param results: parsing output: 38/ for test: kms_flip_scaled_crc results: parsing output: 39/ for test: gem_exec_whisper results: parsing output: 40/ for test: gen9_exec_parse results: parsing output: 41/ for test: kms_properties results: parsing output: 42/ for test: kms_psr2_sf results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: kms_vblank results: parsing output: 46/ for test: gem_pwrite results: parsing output: 47/ for test: gem_exec_balancer results: parsing output: 48/ for test: gem_ctx_shared results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_getfb results: parsing output: 51/ for test: kms_busy results: parsing output: 52/ for test: gem_lmem_swapping results: parsing output: 53/ for test: prime_mmap_coherency results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: gem_exec_schedule results: parsing output: 56/ for test: kms_joiner results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: template results: parsing output: 59/ for test: gem_ppgtt results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_render_copy results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_mmap_offset results: parsing output: 65/ for test: kms_vrr results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: gem_exec_await results: parsing output: 68/ for test: kms_atomic_interruptible results: parsing output: 69/ for test: kms_flip_scaled_crc results: parsing output: 70/ for test: kms_async_flips results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: gem_exec_big results: parsing output: 73/ for test: i915_query results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: gem_mmap_gtt results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: api_intel_bb results: parsing output: 80/ for test: core_setmaster results: parsing output: 81/ for test: gem_exec_params results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_draw_crc results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: kms_atomic_transition results: parsing output: 91/ for test: kms_dirtyfb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_mmap_gtt results: parsing output: 94/ for test: kms_chamelium_color results: parsing output: 95/ for test: kms_chamelium_hpd results: parsing output: 96/ for test: gem_pxp results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: gem_wait results: parsing output: 99/ for test: kms_force_connector_basic results: parsing output: 100/ for test: sysfs_preempt_timeout results: parsing output: 101/ for test: kms_chamelium_edid results: parsing output: 102/ for test: kms_lease results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_barrier_race results: parsing output: 105/ for test: gem_exec_suspend results: parsing output: 106/ for test: gem_ctx_persistence results: no output, setting notrun results: parsing output: 107/ for test: i915_pciid results: no output, setting notrun results: parsing output: 108/ for test: gem_workarounds results: no output, setting notrun results: parsing output: 109/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 110/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 111/ for test: kms_psr results: no output, setting notrun results: parsing output: 112/ for test: kms_fbcon_fbt results: no output, setting notrun results: parsing output: 113/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 114/ for test: prime_vgem results: no output, setting notrun results: parsing output: 115/ for test: kms_ccs results: no output, setting notrun results: parsing output: 116/ for test: gem_close_race results: no output, setting notrun results: parsing output: 117/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 118/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 119/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 120/ for test: perf_pmu results: no output, setting notrun results: parsing output: 121/ for test: prime_self_import results: no output, setting notrun results: parsing output: 122/ for test: gem_softpin results: no output, setting notrun results: parsing output: 123/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 124/ for test: api_intel_bb results: no output, setting notrun results: parsing output: 125/ for test: kms_scaling_modes results: no output, setting notrun results: parsing output: 126/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 127/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 128/ for test: gem_exec_fence results: no output, setting notrun Done.