[56.978560] Initializing watchdogs
[56.978606]   /dev/watchdog0
[56.992303] [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.996415] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.999093] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.002462] [001/134] (960s left) i915_getparams_basic (basic-eu-total)
[57.074782] Starting subtest: basic-eu-total
[57.079075] Subtest basic-eu-total: SUCCESS (0.000s)
[57.182982] [002/134] (960s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[57.258257] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[57.262460] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[57.448251] [003/134] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[57.557358] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[57.561659] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[57.675776] [004/134] (959s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[57.776204] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[64.903921] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.114s)
[65.039771] [005/134] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[65.137943] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[72.669133] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.527s)
[72.843647] [006/134] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[72.943724] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[79.951058] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.007s)
[80.108374] [007/134] (937s left) kms_content_protection (srm)
[80.259738] Starting subtest: srm
[80.268209] Subtest srm: SKIP (0.003s)
[80.435331] [008/134] (937s left) kms_plane_scaling (planes-downscale-factor-0-5)
[80.535075] Starting subtest: planes-downscale-factor-0-5
[80.537278] Starting dynamic subtest: pipe-A
[80.553692] Dynamic subtest pipe-A: SKIP (0.016s)
[80.560859] Starting dynamic subtest: pipe-B
[80.587481] Dynamic subtest pipe-B: SKIP (0.032s)
[80.594795] Starting dynamic subtest: pipe-C
[80.618826] Dynamic subtest pipe-C: SKIP (0.031s)
[80.625804] Starting dynamic subtest: pipe-D
[80.649586] Dynamic subtest pipe-D: SKIP (0.031s)
[80.653644] Subtest planes-downscale-factor-0-5: SKIP (0.111s)
[80.757369] [009/134] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[80.855620] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[80.860212] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[80.961838] [010/134] (936s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[81.014815] Starting subtest: single-wait-all-for-submit-available-signaled
[81.017083] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[81.121919] [011/134] (936s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[81.210695] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[81.331410] [012/134] (936s left) gem_caching (read-writes)
[81.395228] Subtest read-writes: SKIP (0.000s)
[81.483233] [013/134] (936s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[81.587961] Starting subtest: y-tiled-64bpp-rotate-180
[81.591812] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[81.722657] [014/134] (936s left) kms_prop_blob (invalid-set-prop)
[81.781324] Starting subtest: invalid-set-prop
[81.783493] Subtest invalid-set-prop: SUCCESS (0.000s)
[81.888509] [015/134] (936s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[81.989154] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[82.968614] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.978s)
[83.131768] [016/134] (934s left) gem_ctx_engines (none)
[83.194731] Starting subtest: none
[83.196586] Subtest none: SUCCESS (0.001s)
[83.377845] [017/134] (934s left) gem_exec_reloc (basic-gtt-cpu-active)
[83.440137] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[83.531081] [018/134] (934s left) kms_chamelium_hpd (vga-hpd-fast)
[83.911078] Subtest vga-hpd-fast: SKIP (0.000s)
[84.754715] [019/134] (933s left) syncobj_wait (invalid-signal-zero-handles)
[84.811523] Starting subtest: invalid-signal-zero-handles
[84.814029] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[84.908484] [020/134] (933s left) syncobj_timeline (wait-any-snapshot)
[84.960298] Starting subtest: wait-any-snapshot
[85.039950] Subtest wait-any-snapshot: SUCCESS (0.081s)
[85.125042] [021/134] (933s left) kms_psr (fbc-psr-primary-blt)
[85.214975] Starting subtest: fbc-psr-primary-blt
[85.216887] Starting dynamic subtest: eDP-1
[85.220951] Dynamic subtest eDP-1: SKIP (0.000s)
[85.225057] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[85.293656] [022/134] (932s left) perf_pmu (render-node-busy)
[85.366817] Starting subtest: render-node-busy
[85.369845] Starting dynamic subtest: rcs0
[85.985270] Dynamic subtest rcs0: SUCCESS (0.618s)
[85.995632] Starting dynamic subtest: bcs0
[86.554013] Dynamic subtest bcs0: SUCCESS (0.567s)
[86.562920] Starting dynamic subtest: vcs0
[87.893470] Dynamic subtest vcs0: SUCCESS (1.336s)
[87.904924] Starting dynamic subtest: vcs1
[89.877945] Dynamic subtest vcs1: SUCCESS (1.983s)
[89.888092] Starting dynamic subtest: vecs0
[91.927499] Dynamic subtest vecs0: SUCCESS (2.047s)
[91.938358] Starting dynamic subtest: ccs0
[92.498262] Dynamic subtest ccs0: SUCCESS (0.571s)
[92.500961] Subtest render-node-busy: SUCCESS (7.131s)
[92.594329] [023/134] (925s left) gem_exec_params (invalid-flag)
[92.660048] Starting subtest: invalid-flag
[92.662059] Subtest invalid-flag: SUCCESS (0.000s)
[92.782064] [024/134] (925s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[97.781852] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[97.786651] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[98.636250] [025/134] (919s left) kms_getfb (getfb-repeated-different-handles)
[98.719103] Starting subtest: getfb-repeated-different-handles
[98.721364] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[98.849851] [026/134] (919s left) kms_feature_discovery (psr2)
[98.948973] Starting subtest: psr2
[98.951232] Subtest psr2: SUCCESS (0.000s)
[99.028574] [027/134] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[99.131216] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[99.135598] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[99.257027] [028/134] (919s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[99.350246] Starting subtest: 4-tiled-8bpp-rotate-90
[99.370425] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.019s)
[99.502600] [029/134] (919s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[101.026450] Starting subtest: modeset-non-lpsp-stress-no-wait
[101.081802] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[101.774695] [030/134] (916s left) sysfs_timeslice_duration (timeout)
[101.837072] Starting subtest: timeout
[101.839426] Starting dynamic subtest: vecs0
[111.912941] Dynamic subtest vecs0: SUCCESS (10.072s)
[111.923098] Starting dynamic subtest: ccs0
[113.288684] Dynamic subtest ccs0: SUCCESS (1.375s)
[113.296529] Starting dynamic subtest: vcs0
[122.931490] Dynamic subtest vcs0: SUCCESS (9.640s)
[122.944575] Starting dynamic subtest: bcs0
[123.571944] Dynamic subtest bcs0: SUCCESS (0.640s)
[123.582075] Starting dynamic subtest: rcs0
[124.911599] Dynamic subtest rcs0: SUCCESS (1.339s)
[124.920926] Starting dynamic subtest: vcs1
[134.937299] Dynamic subtest vcs1: SUCCESS (10.024s)
[134.939813] Subtest timeout: SUCCESS (33.098s)
[135.046860] [031/134] (883s left) kms_async_flips (invalid-async-flip-atomic)
[135.149470] Starting subtest: invalid-async-flip-atomic
[135.533150] Starting dynamic subtest: pipe-A-eDP-1
[136.864117] Dynamic subtest pipe-A-eDP-1: FAIL (0.824s)
[136.871497] Starting dynamic subtest: pipe-B-eDP-1
[137.880745] Dynamic subtest pipe-B-eDP-1: FAIL (0.754s)
[137.888429] Starting dynamic subtest: pipe-C-eDP-1
[138.623313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.792s)
[138.977393] Starting dynamic subtest: pipe-D-eDP-1
[139.758898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.790s)
[139.761379] Subtest invalid-async-flip-atomic: FAIL (4.611s)
[140.905259] [032/134] (877s left) kms_psr (fbc-pr-sprite-render)
[140.999184] Starting subtest: fbc-pr-sprite-render
[141.003328] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[141.080147] [033/134] (877s left) gem_wait (busy)
[141.145477] Starting subtest: busy
[141.147764] Starting dynamic subtest: all-engines
[142.934699] Dynamic subtest all-engines: SUCCESS (1.787s)
[142.945481] Starting dynamic subtest: rcs0
[143.474645] Dynamic subtest rcs0: SUCCESS (0.540s)
[143.481954] Starting dynamic subtest: bcs0
[144.014778] Dynamic subtest bcs0: SUCCESS (0.539s)
[144.025168] Starting dynamic subtest: vcs0
[145.942441] Dynamic subtest vcs0: SUCCESS (1.926s)
[145.952590] Starting dynamic subtest: vcs1
[147.925058] Dynamic subtest vcs1: SUCCESS (1.981s)
[147.935806] Starting dynamic subtest: vecs0
[149.909408] Dynamic subtest vecs0: SUCCESS (1.982s)
[149.920171] Starting dynamic subtest: ccs0
[150.450783] Dynamic subtest ccs0: SUCCESS (0.542s)
[150.453461] Subtest busy: SUCCESS (9.305s)
[150.656269] [034/134] (868s left) api_intel_allocator (reloc-allocator)
[150.721382] Starting subtest: reloc-allocator
[150.723702] Starting dynamic subtest: basic
[150.728349] Dynamic subtest basic: SUCCESS (0.007s)
[150.736821] Starting dynamic subtest: parallel-one
[150.739221] Dynamic subtest parallel-one: SUCCESS (0.008s)
[150.747388] Starting dynamic subtest: print
[150.749723] Dynamic subtest print: SUCCESS (0.000s)
[150.757205] Starting dynamic subtest: reuse
[150.759088] Dynamic subtest reuse: SUCCESS (0.000s)
[150.766224] Starting dynamic subtest: fork-reopen-allocator
[150.768118] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[150.770066] Subtest reloc-allocator: SUCCESS (0.027s)
[150.900639] [035/134] (867s left) api_intel_bb (intel-bb-blit-none)
[150.955756] Starting subtest: intel-bb-blit-none
[154.746278] Subtest intel-bb-blit-none: SUCCESS (3.761s)
[154.864838] [036/134] (863s left) kms_cursor_edge_walk (128x128-top-bottom)
[154.967902] Starting subtest: 128x128-top-bottom
[154.970296] Starting dynamic subtest: pipe-A-eDP-1
[158.457074] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s)
[158.464820] Starting dynamic subtest: pipe-D-eDP-1
[161.576446] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[161.578704] Subtest 128x128-top-bottom: SUCCESS (6.608s)
[162.404887] [037/134] (856s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[162.504220] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[162.508680] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[163.638202] [038/134] (855s left) kms_pm_backlight (fade-with-suspend)
[163.730447] Starting subtest: fade-with-suspend
[179.477510] Starting dynamic subtest: eDP-1
[182.158342] Dynamic subtest eDP-1: SUCCESS (2.665s)
[182.160515] Subtest fade-with-suspend: SUCCESS (4.084s)
[182.975723] [039/134] (835s left) gem_softpin (evict-prime)
[183.055401] Starting subtest: evict-prime
[183.057702] Starting dynamic subtest: rcs0
[184.269463] Dynamic subtest rcs0: SUCCESS (1.207s)
[184.280192] Starting dynamic subtest: bcs0
[185.410924] Dynamic subtest bcs0: SUCCESS (1.134s)
[185.423069] Starting dynamic subtest: vcs0
[187.212922] Dynamic subtest vcs0: SUCCESS (1.792s)
[187.225214] Starting dynamic subtest: vcs1
[189.292329] Dynamic subtest vcs1: SUCCESS (2.070s)
[189.305109] Starting dynamic subtest: vecs0
[191.269026] Dynamic subtest vecs0: SUCCESS (1.970s)
[191.282444] Starting dynamic subtest: ccs0
[192.431734] Dynamic subtest ccs0: SUCCESS (1.160s)
[192.444005] Starting dynamic subtest: all
[194.233519] Dynamic subtest all: SUCCESS (1.795s)
[194.236207] Subtest evict-prime: SUCCESS (11.137s)
[194.380734] [040/134] (824s left) gem_userptr_blits (coherency-unsync)
[194.439251] Subtest coherency-unsync: SKIP (0.000s)
[194.572979] [041/134] (824s left) kms_psr (psr2-sprite-mmap-cpu)
[194.662555] Starting subtest: psr2-sprite-mmap-cpu
[194.664843] Starting dynamic subtest: eDP-1
[196.398370] Dynamic subtest eDP-1: SUCCESS (1.732s)
[196.400625] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.733s)
[197.275920] [042/134] (821s left) kms_getfb (getfb-handle-protection)
[197.371669] Starting subtest: getfb-handle-protection
[197.397392] Subtest getfb-handle-protection: SUCCESS (0.026s)
[197.546779] [043/134] (821s left) gem_exec_reloc (basic-cpu)
[197.610657] Subtest basic-cpu: SKIP (0.000s)
[197.675353] [044/134] (821s left) kms_dp_link_training (uhbr-sst)
[197.767772] Starting subtest: uhbr-sst
[197.776293] Subtest uhbr-sst: SKIP (0.000s)
[197.879001] [045/134] (821s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[197.977071] Starting subtest: psr-rgb101010-draw-render
[205.261026] Subtest psr-rgb101010-draw-render: SUCCESS (7.279s)
[205.428523] [046/134] (813s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[205.548649] Starting subtest: cursorB-vs-flipB-legacy
[205.554318] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[205.705804] [047/134] (813s left) syncobj_basic (bad-flags-fd-to-handle)
[205.761928] Starting subtest: bad-flags-fd-to-handle
[205.764250] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[205.871203] [048/134] (813s left) gem_mmap_offset (clear)
[205.929443] Starting subtest: clear
[205.934420] Starting dynamic subtest: smem0
[231.033981] Dynamic subtest smem0: SUCCESS (25.100s)
[231.036319] Subtest clear: SUCCESS (25.102s)
[231.166470] [049/134] (788s left) kms_psr (psr-primary-blt)
[231.318447] Starting subtest: psr-primary-blt
[231.320762] Starting dynamic subtest: eDP-1
[233.017030] Dynamic subtest eDP-1: SUCCESS (1.699s)
[233.019453] Subtest psr-primary-blt: SUCCESS (1.700s)
[233.880685] [050/134] (785s left) gem_busy (close-race)
[233.939339] Starting subtest: close-race
[257.225424] Subtest close-race: SUCCESS (23.277s)
[257.611059] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[257.615308] [051/134] (761s left) gem_exec_flush (basic-wb-rw-default)
[257.720712] Starting subtest: basic-wb-rw-default
[263.179095] Subtest basic-wb-rw-default: SUCCESS (5.456s)
[263.379556] [052/134] (756s left) i915_pm_rpm (gem-pread)
[265.334609] Starting subtest: gem-pread
[267.063837] Subtest gem-pread: SUCCESS (1.730s)
[267.162983] [053/134] (752s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[267.265480] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[267.267747] Starting dynamic subtest: pipe-A-eDP-1
[267.291108] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[267.302503] Starting dynamic subtest: pipe-B-eDP-1
[267.324265] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[267.334193] Starting dynamic subtest: pipe-C-eDP-1
[267.356978] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[267.367291] Starting dynamic subtest: pipe-D-eDP-1
[267.389579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[267.393733] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[269.494712] [054/134] (750s left) gem_exec_params (invalid-batch-start-offset)
[269.556343] Starting subtest: invalid-batch-start-offset
[269.561293] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[269.704819] [055/134] (749s left) gem_exec_schedule (thriceslice)
[269.784842] Starting subtest: thriceslice
[269.787206] Starting dynamic subtest: rcs0
[269.803146] Dynamic subtest rcs0: SUCCESS (0.029s)
[269.815895] Starting dynamic subtest: bcs0
[269.831381] Dynamic subtest bcs0: SUCCESS (0.028s)
[269.843498] Starting dynamic subtest: vcs0
[269.861261] Dynamic subtest vcs0: SUCCESS (0.029s)
[269.871103] Starting dynamic subtest: vcs1
[269.889628] Dynamic subtest vcs1: SUCCESS (0.028s)
[269.898896] Starting dynamic subtest: vecs0
[269.918309] Dynamic subtest vecs0: SUCCESS (0.028s)
[269.927886] Starting dynamic subtest: ccs0
[269.950046] Dynamic subtest ccs0: SUCCESS (0.031s)
[269.952391] Subtest thriceslice: SUCCESS (0.177s)
[270.283278] [056/134] (749s left) gen9_exec_parse (allowed-single)
[270.354517] Subtest allowed-single: SKIP (0.000s)
[270.445124] [057/134] (749s left) gem_exec_params (rsvd2-dirt)
[270.506267] Starting subtest: rsvd2-dirt
[270.510911] Subtest rsvd2-dirt: SKIP (0.000s)
[270.645188] [058/134] (749s left) gem_exec_schedule (pi-shared-iova)
[270.834314] Starting subtest: pi-shared-iova
[270.836298] Starting dynamic subtest: rcs0
[270.909331] Dynamic subtest rcs0: SUCCESS (0.077s)
[270.920527] Starting dynamic subtest: vcs0
[270.968128] Dynamic subtest vcs0: SUCCESS (0.057s)
[270.983283] Starting dynamic subtest: vcs1
[271.021313] Dynamic subtest vcs1: SUCCESS (0.053s)
[271.030898] Starting dynamic subtest: vecs0
[271.076836] Dynamic subtest vecs0: SUCCESS (0.054s)
[271.089221] Starting dynamic subtest: ccs0
[271.133910] Dynamic subtest ccs0: SUCCESS (0.056s)
[271.136259] Subtest pi-shared-iova: SUCCESS (0.303s)
[272.308689] [059/134] (747s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[272.400535] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[272.402795] Starting dynamic subtest: pipe-A-eDP-1
[272.425391] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.436806] Starting dynamic subtest: pipe-B-eDP-1
[272.458426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.468238] Starting dynamic subtest: pipe-C-eDP-1
[272.490555] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.501050] Starting dynamic subtest: pipe-D-eDP-1
[272.523301] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.527364] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[274.581146] [060/134] (745s left) gem_pxp (reject-modify-context-protection-off-1)
[274.710283] Starting subtest: reject-modify-context-protection-off-1
[274.714903] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[274.861954] [061/134] (744s left) kms_psr (pr-primary-blt)
[274.957868] Starting subtest: pr-primary-blt
[274.961878] Subtest pr-primary-blt: SKIP (0.000s)
[275.058066] [062/134] (744s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[275.157455] Starting subtest: fbc-rgb565-draw-mmap-cpu
[279.193199] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.041s)
[280.397918] [063/134] (739s left) kms_plane_cursor (overlay)
[280.491797] Starting subtest: overlay
[280.496032] Starting dynamic subtest: pipe-A-eDP-1-size-64
[283.218134] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.727s)
[283.279680] Starting dynamic subtest: pipe-A-eDP-1-size-128
[286.019002] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.748s)
[286.080620] Starting dynamic subtest: pipe-A-eDP-1-size-256
[288.819830] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.749s)
[289.169472] Starting dynamic subtest: pipe-B-eDP-1-size-64
[292.602051] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.445s)
[292.662946] Starting dynamic subtest: pipe-B-eDP-1-size-128
[295.413859] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.760s)
[295.474104] Starting dynamic subtest: pipe-B-eDP-1-size-256
[298.225306] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.759s)
[298.583981] Starting dynamic subtest: pipe-C-eDP-1-size-64
[301.693286] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.118s)
[301.730293] Starting dynamic subtest: pipe-C-eDP-1-size-128
[304.047126] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.324s)
[304.084386] Starting dynamic subtest: pipe-C-eDP-1-size-256
[306.502718] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.425s)
[306.837387] Starting dynamic subtest: pipe-D-eDP-1-size-64
[309.881668] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.056s)
[309.921307] Starting dynamic subtest: pipe-D-eDP-1-size-128
[312.317434] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.403s)
[312.354809] Starting dynamic subtest: pipe-D-eDP-1-size-256
[314.783237] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.435s)
[315.100729] Subtest overlay: SUCCESS (34.613s)
[316.000152] [064/134] (703s left) gem_exec_whisper (basic-queues-all)
[316.068061] Starting subtest: basic-queues-all
[327.010221] Subtest basic-queues-all: SUCCESS (10.937s)
[327.206485] [065/134] (692s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[327.299021] Starting subtest: random-ccs-data-y-tiled-ccs
[327.301376] Starting dynamic subtest: pipe-A-eDP-1
[327.327445] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.338671] Starting dynamic subtest: pipe-B-eDP-1
[327.363468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.375068] Starting dynamic subtest: pipe-C-eDP-1
[327.398333] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.408778] Starting dynamic subtest: pipe-D-eDP-1
[327.432484] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.436765] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[329.477663] [066/134] (690s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[329.569783] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[329.573790] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[329.702211] [067/134] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[329.805949] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[329.809781] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[329.943665] [068/134] (690s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[330.033688] Starting subtest: 2x-flip-vs-rmfb-interruptible
[330.044903] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[330.181605] [069/134] (689s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[330.274847] Starting subtest: fbc-rgb565-draw-blt
[334.457569] Subtest fbc-rgb565-draw-blt: SUCCESS (4.185s)
[335.670649] [070/134] (684s left) kms_flip (2x-modeset-vs-vblank-race)
[335.771165] Starting subtest: 2x-modeset-vs-vblank-race
[335.778987] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[335.868354] [071/134] (684s left) gem_exec_alignment (pi)
[335.922359] Starting subtest: pi
[384.969193] Subtest pi: SUCCESS (49.030s)
[385.908329] [072/134] (634s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf)
[386.083926] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s)
[386.180241] [073/134] (634s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[386.278821] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[386.283465] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[387.388748] [074/134] (632s left) kms_setmode (invalid-clone-exclusive-crtc)
[387.455265] Starting subtest: invalid-clone-exclusive-crtc
[387.461667] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[387.567073] [075/134] (632s left) gem_media_vme
[387.718573] [076/134] (632s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[387.815805] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[387.819924] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[387.945088] [077/134] (632s left) syncobj_timeline (etime-multi-wait-submitted)
[388.010060] Starting subtest: etime-multi-wait-submitted
[388.117397] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[388.212421] [078/134] (632s left) gem_mmap_gtt (basic-copy)
[388.277276] Subtest basic-copy: SKIP (0.000s)
[388.341166] [079/134] (632s left) gem_exec_flush (basic-wb-set-default)
[388.408468] Starting subtest: basic-wb-set-default
[393.859801] Subtest basic-wb-set-default: SUCCESS (5.450s)
[394.062093] [080/134] (626s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[394.174703] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[394.177067] Starting dynamic subtest: pipe-A-default-mode
[395.332752] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[395.337536] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.155s)
[395.521896] [081/134] (625s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[395.631175] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[395.635340] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[395.748744] [082/134] (624s left) kms_plane (pixel-format-source-clamping)
[395.832156] Starting subtest: pixel-format-source-clamping
[395.860282] Starting dynamic subtest: pipe-A-plane-0
[400.726904] Dynamic subtest pipe-A-plane-0: SUCCESS (4.866s)
[400.737124] Starting dynamic subtest: pipe-A-plane-3
[403.116515] Dynamic subtest pipe-A-plane-3: SUCCESS (2.388s)
[403.125696] Starting dynamic subtest: pipe-A-plane-5
[403.127383] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[404.184535] Starting dynamic subtest: pipe-B-plane-0
[408.917688] Dynamic subtest pipe-B-plane-0: SUCCESS (4.744s)
[408.927658] Starting dynamic subtest: pipe-B-plane-3
[411.228321] Dynamic subtest pipe-B-plane-3: SUCCESS (2.311s)
[411.237830] Starting dynamic subtest: pipe-B-plane-5
[411.239862] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[411.542052] Subtest pixel-format-source-clamping: SUCCESS (15.712s)
[412.379400] [083/134] (608s left) kms_tiled_display (basic-test-pattern)
[412.490664] Subtest basic-test-pattern: SKIP (0.000s)
[412.533961] [084/134] (608s left) gem_ctx_persistence (legacy-engines-hang)
[412.599054] Starting subtest: legacy-engines-hang
[412.601463] Starting dynamic subtest: render
[412.750377] Dynamic subtest render: SUCCESS (0.151s)
[412.763372] Starting dynamic subtest: bsd1
[412.852888] Dynamic subtest bsd1: SUCCESS (0.098s)
[412.865636] Starting dynamic subtest: bsd2
[412.965384] Dynamic subtest bsd2: SUCCESS (0.111s)
[412.976958] Starting dynamic subtest: blt
[413.098093] Dynamic subtest blt: SUCCESS (0.130s)
[413.111661] Starting dynamic subtest: vebox
[413.207531] Dynamic subtest vebox: SUCCESS (0.106s)
[413.210425] Subtest legacy-engines-hang: SUCCESS (0.610s)
[413.309657] [085/134] (607s left) gem_mmap_offset (pf-nonblock)
[413.375600] Starting subtest: pf-nonblock
[413.382000] Subtest pf-nonblock: SUCCESS (0.007s)
[413.541144] [086/134] (607s left) syncobj_wait (invalid-signal-one-illegal-handle)
[413.606298] Starting subtest: invalid-signal-one-illegal-handle
[413.608003] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[413.724847] [087/134] (607s left) gem_ctx_param (invalid-set-ringsize)
[413.769026] Starting subtest: invalid-set-ringsize
[413.771071] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[413.842230] [088/134] (607s left) vgem_basic (mmap)
[413.884705] Starting subtest: mmap
[413.901060] Subtest mmap: SUCCESS (0.018s)
[413.990800] [089/134] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[414.086698] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[414.090267] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[414.218810] [090/134] (606s left) dmabuf_sync_file (import-multiple-read-write)
[414.253224] Starting subtest: import-multiple-read-write
[414.255092] Subtest import-multiple-read-write: SUCCESS (0.003s)
[414.319669] [091/134] (606s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[414.414739] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[415.527089] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.113s)
[415.662740] [092/134] (605s left) vgem_basic (second-client)
[415.702530] Starting subtest: second-client
[415.723063] Subtest second-client: SUCCESS (0.022s)
[415.796387] [093/134] (605s left) kms_colorop (plane-xr30-xr30-pq_125_eotf)
[415.918417] Subtest plane-XR30-XR30-pq_125_eotf: SKIP (0.000s)
[416.013648] [094/134] (605s left) kms_panel_fitting (atomic-fastset)
[416.108122] Starting subtest: atomic-fastset
[416.110106] Starting dynamic subtest: pipe-A-eDP-1
[416.267424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.161s)
[416.279911] Starting dynamic subtest: pipe-B-eDP-1
[417.515696] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.247s)
[417.528311] Starting dynamic subtest: pipe-C-eDP-1
[418.702727] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s)
[418.714135] Starting dynamic subtest: pipe-D-eDP-1
[419.836761] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[419.839186] Subtest atomic-fastset: SUCCESS (3.731s)
[421.000434] [095/134] (600s left) perf_pmu (idle)
[421.038870] Starting subtest: idle
[421.041298] Starting dynamic subtest: rcs0
[421.588698] Dynamic subtest rcs0: SUCCESS (0.550s)
[421.600859] Starting dynamic subtest: bcs0
[422.119038] Dynamic subtest bcs0: SUCCESS (0.527s)
[422.131928] Starting dynamic subtest: vcs0
[422.638809] Dynamic subtest vcs0: SUCCESS (0.517s)
[422.651613] Starting dynamic subtest: vcs1
[423.165981] Dynamic subtest vcs1: SUCCESS (0.525s)
[423.177687] Starting dynamic subtest: vecs0
[423.686077] Dynamic subtest vecs0: SUCCESS (0.517s)
[423.699543] Starting dynamic subtest: ccs0
[424.209778] Dynamic subtest ccs0: SUCCESS (0.521s)
[424.212535] Subtest idle: SUCCESS (3.174s)
[424.340288] [096/134] (596s left) i915_suspend (debugfs-reader)
[424.395967] Starting subtest: debugfs-reader
[442.344043] Subtest debugfs-reader: SUCCESS (3.183s)
[442.407073] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[442.425642] [FACT i915_suspend (debugfs-reader)] new: kernel.is_tainted.taint_warn: true
[442.426530] Closing watchdogs
results: parsing output: 0/ for test: i915_getparams_basic
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_caching
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_ctx_engines
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_feature_discovery
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: sysfs_timeslice_duration
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_wait
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_cursor_edge_walk
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_pm_backlight
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_getfb
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_dp_link_training
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_busy
results: parsing output: 50/ for test: gem_exec_flush
results: parsing output: 51/ for test: i915_pm_rpm
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_plane_cursor
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_exec_alignment
results: parsing output: 71/ for test: kms_colorop
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_setmode
results: parsing output: 74/ for test: gem_media_vme
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: gem_exec_flush
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: kms_tiled_display
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: dmabuf_sync_file
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: kms_colorop
results: parsing output: 93/ for test: kms_panel_fitting
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: i915_suspend
results: parsing output: 96/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 98/ for test: gem_pipe_control_store_loop
results: no output, setting notrun
results: parsing output: 99/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 100/ for test: gem_render_copy_redux
results: no output, setting notrun
results: parsing output: 101/ for test: kms_lease
results: no output, setting notrun
results: parsing output: 102/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 103/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 104/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 105/ for test: prime_vgem
results: no output, setting notrun
results: parsing output: 106/ for test: sw_sync
results: no output, setting notrun
results: parsing output: 107/ for test: gem_bad_reloc
results: no output, setting notrun
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 109/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 110/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 111/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 112/ for test: kms_writeback
results: no output, setting notrun
results: parsing output: 113/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 114/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 115/ for test: perf
results: no output, setting notrun
results: parsing output: 116/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 117/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 118/ for test: kms_psr2_sf
results: no output, setting notrun
results: parsing output: 119/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 120/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 122/ for test: kms_hdmi_inject
results: no output, setting notrun
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 124/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 125/ for test: kms_chamelium_hpd
results: no output, setting notrun
results: parsing output: 126/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 127/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 128/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 130/ for test: kms_color
results: no output, setting notrun
results: parsing output: 131/ for test: kms_lease
results: no output, setting notrun
results: parsing output: 132/ for test: kms_flip_scaled_crc
results: no output, setting notrun
results: parsing output: 133/ for test: syncobj_basic
results: no output, setting notrun
Done.