[56.543364] Initializing watchdogs
[56.543419]   /dev/watchdog0
[56.556617] [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.560704] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.562876] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.567123] [001/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[56.747765] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[56.752364] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.843331] [002/130] (960s left) gem_pxp (create-protected-buffer)
[56.967304] Starting subtest: create-protected-buffer
[56.970280] Subtest create-protected-buffer: SUCCESS (0.000s)
[57.066630] [003/130] (960s left) gem_exec_balancer (nohangcheck)
[57.326076] Starting subtest: nohangcheck
[58.074332] Subtest nohangcheck: SUCCESS (0.747s)
[58.186341] [004/130] (958s left) gem_exec_whisper (basic-forked-all)
[58.257610] Starting subtest: basic-forked-all
[71.915864] Subtest basic-forked-all: SUCCESS (13.656s)
[72.090506] [005/130] (945s left) gem_exec_fence (syncobj-channel)
[72.552169] Starting subtest: syncobj-channel
[73.575585] Subtest syncobj-channel: SUCCESS (1.021s)
[74.070403] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[74.073521] [006/130] (943s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[74.127986] Starting subtest: invalid-smem-bo-on-discrete
[74.132268] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[74.280140] [007/130] (942s left) fbdev (write)
[74.328068] Starting subtest: write
[74.689781] Subtest write: SUCCESS (0.360s)
[74.745947] [008/130] (942s left) syncobj_eventfd (invalid-illegal-eventfd)
[74.813941] Starting subtest: invalid-illegal-eventfd
[74.816425] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[74.905466] [009/130] (942s left) perf (enable-disable)
[75.013930] Starting subtest: enable-disable
[75.016225] Starting dynamic subtest: 0-rcs0
[77.338633] Dynamic subtest 0-rcs0: SUCCESS (2.324s)
[77.346107] Starting dynamic subtest: 1-vcs1
[81.860911] Dynamic subtest 1-vcs1: SUCCESS (4.522s)
[81.863785] Subtest enable-disable: SUCCESS (6.846s)
[81.892204] [010/130] (935s left) gem_mmap_offset (mmap-unmap)
[81.956658] Starting subtest: mmap-unmap
[81.958886] Starting dynamic subtest: smem0
[107.187935] Dynamic subtest smem0: SUCCESS (25.233s)
[107.190177] Subtest mmap-unmap: SUCCESS (25.233s)
[107.316706] [011/130] (910s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[107.428643] Starting subtest: 2x-flip-vs-rmfb-interruptible
[107.441112] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[107.543394] [012/130] (909s left) gem_exec_reloc (basic-gtt-cpu)
[107.608461] Subtest basic-gtt-cpu: SKIP (0.000s)
[107.684673] [013/130] (909s left) kms_rotation_crc (exhaust-fences)
[107.773079] Starting subtest: exhaust-fences
[107.777594] Subtest exhaust-fences: SKIP (0.000s)
[107.839381] [014/130] (909s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[112.880354] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[112.882749] Starting dynamic subtest: pipe-A-eDP-1
[113.684367] Dynamic subtest pipe-A-eDP-1: SKIP (0.799s)
[113.691062] Starting dynamic subtest: pipe-B-eDP-1
[114.911973] Dynamic subtest pipe-B-eDP-1: SKIP (1.226s)
[114.916821] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.030s)
[116.085455] [015/130] (901s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[116.485057] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[117.295532] [016/130] (900s left) gem_ctx_exec (basic-nohangcheck)
[117.355260] Starting subtest: basic-nohangcheck
[117.616277] Subtest basic-nohangcheck: SUCCESS (0.262s)
[117.733678] [017/130] (899s left) syncobj_wait (wait-all-for-submit-snapshot)
[117.794072] Starting subtest: wait-all-for-submit-snapshot
[117.874511] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[117.941048] [018/130] (899s left) gem_exec_flush (basic-uc-set-default)
[117.993782] Starting subtest: basic-uc-set-default
[123.472489] Subtest basic-uc-set-default: SUCCESS (5.478s)
[123.653181] [019/130] (894s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[123.762230] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[123.767121] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[123.867901] [020/130] (893s left) kms_prop_blob (blob-prop-core)
[123.930974] Starting subtest: blob-prop-core
[123.933449] Subtest blob-prop-core: SUCCESS (0.000s)
[124.043985] [021/130] (893s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[124.140173] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[124.142596] Starting dynamic subtest: pipe-A
[124.478761] Dynamic subtest pipe-A: SUCCESS (0.339s)
[124.489650] Starting dynamic subtest: pipe-B
[125.905062] Dynamic subtest pipe-B: SUCCESS (1.426s)
[125.913899] Starting dynamic subtest: pipe-C
[127.327456] Dynamic subtest pipe-C: SUCCESS (1.422s)
[127.335992] Starting dynamic subtest: pipe-D
[128.750396] Dynamic subtest pipe-D: SUCCESS (1.423s)
[128.752742] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.611s)
[129.910080] [022/130] (887s left) gem_exec_flush (basic-uc-rw-default)
[129.983686] Starting subtest: basic-uc-rw-default
[135.461154] Subtest basic-uc-rw-default: SUCCESS (5.477s)
[135.641533] [023/130] (882s left) gem_lmem_swapping (parallel-random-verify)
[135.685148] Subtest parallel-random-verify: SKIP (0.000s)
[135.725323] [024/130] (882s left) perf (invalid-oa-format-id)
[135.810529] Starting subtest: invalid-oa-format-id
[135.827276] Subtest invalid-oa-format-id: SUCCESS (0.015s)
[135.861387] [025/130] (882s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[135.972597] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[135.976541] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[136.088242] [026/130] (881s left) api_intel_bb (blit-reloc-keep-cache)
[136.143199] Starting subtest: blit-reloc-keep-cache
[136.147904] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[136.275435] [027/130] (881s left) kms_pm_dc (dc9-dpms)
[137.387953] Starting subtest: dc9-dpms
[138.800207] Subtest dc9-dpms: SUCCESS (1.414s)
[138.855824] [028/130] (879s left) gem_softpin (evict-snoop)
[138.924135] Starting subtest: evict-snoop
[138.928718] Subtest evict-snoop: SKIP (0.000s)
[139.039997] [029/130] (878s left) kms_cursor_crc (cursor-random-32x32)
[139.170959] Starting subtest: cursor-random-32x32
[139.217125] Subtest cursor-random-32x32: SKIP (0.040s)
[139.493424] [030/130] (878s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[139.888013] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[140.647471] [031/130] (877s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[140.745598] Starting subtest: fbc-psr2-sprite-mmap-cpu
[140.748311] Starting dynamic subtest: eDP-1
[140.752570] Dynamic subtest eDP-1: SKIP (0.000s)
[140.756861] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[140.810606] [032/130] (877s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[140.908467] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[144.389684] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.485s)
[144.532125] [033/130] (873s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[144.594367] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[144.596066] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[144.707429] [034/130] (873s left) gem_exec_fence (long-history)
[145.164778] Starting subtest: long-history
[152.656820] Subtest long-history: SUCCESS (7.493s)
[153.130227] [035/130] (865s left) kms_dp_aux_dev
[153.491084] [036/130] (864s left) kms_psr (fbc-pr-primary-blt)
[153.582201] Starting subtest: fbc-pr-primary-blt
[153.587259] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[153.647844] [037/130] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[153.759786] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[158.687248] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.931s)
[158.824632] [038/130] (859s left) gem_exec_reloc (basic-write-wc-active)
[158.893748] Subtest basic-write-wc-active: SKIP (0.000s)
[158.973899] [039/130] (859s left) gem_create (create-valid-nonaligned)
[159.029703] Starting subtest: create-valid-nonaligned
[159.032042] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[159.209607] [040/130] (859s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)
[159.513698] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s)
[159.560606] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)] new: kernel.kmod_is_loaded.xe: true
[159.563606] [041/130] (858s left) gem_ctx_persistence (legacy-engines-mixed-process)
[159.618575] Starting subtest: legacy-engines-mixed-process
[159.621141] Starting dynamic subtest: render
[160.922318] Dynamic subtest render: SUCCESS (1.303s)
[160.931651] Starting dynamic subtest: bsd1
[162.946934] Dynamic subtest bsd1: SUCCESS (2.024s)
[162.956904] Starting dynamic subtest: bsd2
[164.923668] Dynamic subtest bsd2: SUCCESS (1.975s)
[164.933792] Starting dynamic subtest: blt
[166.958073] Dynamic subtest blt: SUCCESS (2.033s)
[166.967647] Starting dynamic subtest: vebox
[168.935680] Dynamic subtest vebox: SUCCESS (1.977s)
[168.938255] Subtest legacy-engines-mixed-process: SUCCESS (9.317s)
[169.076375] [042/130] (849s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[169.192798] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[169.197616] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[169.294626] [043/130] (849s left) i915_pm_rps (thresholds-idle-park)
[169.360173] Starting subtest: thresholds-idle-park
[169.364969] Subtest thresholds-idle-park: SKIP (0.001s)
[169.481381] [044/130] (849s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[169.869075] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[170.645525] [045/130] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[170.752497] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[170.756581] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[170.844275] [046/130] (847s left) gen9_exec_parse (basic-rejected)
[170.906503] Subtest basic-rejected: SKIP (0.000s)
[170.982209] [047/130] (847s left) kms_psr (psr-primary-blt)
[171.092550] Starting subtest: psr-primary-blt
[171.094943] Starting dynamic subtest: eDP-1
[172.862459] Dynamic subtest eDP-1: SUCCESS (1.768s)
[172.864488] Subtest psr-primary-blt: SUCCESS (1.768s)
[173.723607] [048/130] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[173.831473] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[173.835749] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[173.920176] [049/130] (844s left) prime_mmap (test_errors)
[173.973878] Starting subtest: test_errors
[173.975889] Starting dynamic subtest: test_errors-smem
[174.083100] Dynamic subtest test_errors-smem: SUCCESS (0.109s)
[174.086068] Subtest test_errors: SUCCESS (0.110s)
[174.188417] [050/130] (844s left) kms_flip (plain-flip-fb-recreate-interruptible)
[174.281062] Starting subtest: plain-flip-fb-recreate-interruptible
[174.283459] Starting dynamic subtest: A-eDP1
[183.217845] Dynamic subtest A-eDP1: SUCCESS (8.936s)
[183.226527] Starting dynamic subtest: B-eDP1
[192.041924] Dynamic subtest B-eDP1: SUCCESS (8.823s)
[192.049754] Starting dynamic subtest: C-eDP1
[200.856384] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[200.865932] Starting dynamic subtest: D-eDP1
[209.686713] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[209.688869] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.407s)
[210.849623] [051/130] (807s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[210.974684] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[210.978921] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[211.101453] [052/130] (807s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[211.199072] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[211.201473] Starting dynamic subtest: pipe-A-default-mode
[211.488173] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[211.492799] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.284s)
[212.276310] [053/130] (806s left) drm_fdinfo (idle)
[212.320739] Starting subtest: idle
[212.323292] Starting dynamic subtest: rcs0
[212.923366] Dynamic subtest rcs0: SUCCESS (0.604s)
[212.933739] Starting dynamic subtest: bcs0
[213.429246] Dynamic subtest bcs0: SUCCESS (0.503s)
[213.439798] Starting dynamic subtest: vcs0
[213.933430] Dynamic subtest vcs0: SUCCESS (0.503s)
[213.943704] Starting dynamic subtest: vcs1
[214.438434] Dynamic subtest vcs1: SUCCESS (0.504s)
[214.448840] Starting dynamic subtest: vecs0
[214.943268] Dynamic subtest vecs0: SUCCESS (0.503s)
[214.953685] Starting dynamic subtest: ccs0
[215.447856] Dynamic subtest ccs0: SUCCESS (0.504s)
[215.450796] Subtest idle: SUCCESS (3.128s)
[215.521133] [054/130] (803s left) syncobj_wait (single-wait-all-submitted)
[215.577530] Starting subtest: single-wait-all-submitted
[215.679161] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[215.751773] [055/130] (803s left) kms_sequence (get-forked)
[215.849990] Starting subtest: get-forked
[215.852352] Starting dynamic subtest: pipe-A-eDP-1
[217.753764] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.900s)
[217.765184] Starting dynamic subtest: pipe-B-eDP-1
[220.335684] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[220.345201] Starting dynamic subtest: pipe-C-eDP-1
[222.874403] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.536s)
[222.881881] Starting dynamic subtest: pipe-D-eDP-1
[225.385935] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.510s)
[225.388610] Subtest get-forked: SUCCESS (9.533s)
[226.184238] [056/130] (792s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[226.235581] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[226.240274] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[226.413607] [057/130] (792s left) gem_unref_active_buffers
[226.633262] [058/130] (792s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[226.762034] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[226.803721] [059/130] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[226.909893] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[226.914178] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[227.002689] [060/130] (792s left) vgem_basic (debugfs)
[227.049605] Starting subtest: debugfs
[227.051515] Subtest debugfs: SUCCESS (0.000s)
[227.098435] [061/130] (792s left) kms_flip (2x-flip-vs-dpms)
[227.200405] Starting subtest: 2x-flip-vs-dpms
[227.211691] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[227.294262] [062/130] (791s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[227.354678] Starting subtest: y-tiled-ccs-to-x-tiled
[227.359678] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[227.533745] [063/130] (791s left) gem_spin_batch (resubmit-new-all)
[227.604928] Starting subtest: resubmit-new-all
[227.607364] Starting dynamic subtest: rcs0
[227.618451] Dynamic subtest rcs0: SUCCESS (0.013s)
[227.627202] Starting dynamic subtest: bcs0
[227.629944] Dynamic subtest bcs0: SUCCESS (0.009s)
[227.637349] Starting dynamic subtest: vcs0
[227.639708] Dynamic subtest vcs0: SUCCESS (0.008s)
[227.648410] Starting dynamic subtest: vcs1
[227.650727] Dynamic subtest vcs1: SUCCESS (0.008s)
[227.658241] Starting dynamic subtest: vecs0
[227.660164] Dynamic subtest vecs0: SUCCESS (0.008s)
[227.667770] Starting dynamic subtest: ccs0
[227.670100] Dynamic subtest ccs0: SUCCESS (0.009s)
[227.672352] Subtest resubmit-new-all: SUCCESS (0.058s)
[228.940225] [064/130] (790s left) gem_ctx_shared (single-timeline)
[229.002788] Starting subtest: single-timeline
[229.024303] Subtest single-timeline: SUCCESS (0.015s)
[229.257163] [065/130] (790s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[229.352090] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[229.354432] Starting dynamic subtest: pipe-A-eDP-1
[229.378103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[229.385933] Starting dynamic subtest: pipe-B-eDP-1
[229.407720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.415209] Starting dynamic subtest: pipe-C-eDP-1
[229.437227] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.444660] Starting dynamic subtest: pipe-D-eDP-1
[229.467064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.471211] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[231.544148] [066/130] (787s left) kms_hdr (invalid-metadata-sizes)
[231.638175] Starting subtest: invalid-metadata-sizes
[231.645046] Subtest invalid-metadata-sizes: SKIP (0.000s)
[231.707362] [067/130] (787s left) kms_joiner (invalid-modeset-big-joiner)
[231.819931] Starting subtest: invalid-modeset-big-joiner
[231.824282] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[231.879069] [068/130] (787s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[231.941937] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[231.947087] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[232.118154] [069/130] (787s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[232.218409] Starting subtest: psr-rgb101010-draw-render
[237.292925] Subtest psr-rgb101010-draw-render: SUCCESS (5.078s)
[237.417777] [070/130] (782s left) kms_plane_scaling (invalid-num-scalers)
[237.511103] Starting subtest: invalid-num-scalers
[237.513387] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[237.530105] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.016s)
[237.538630] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[237.559770] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.027s)
[237.567253] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[237.586070] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.026s)
[237.593438] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[237.612655] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.026s)
[237.614986] Subtest invalid-num-scalers: SUCCESS (0.102s)
[237.712398] [071/130] (781s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[237.831522] Starting subtest: 4-tiled-16bpp-rotate-180
[239.221650] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.390s)
[239.381049] [072/130] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[239.486142] Starting subtest: fbcpsr-rgb565-draw-pwrite
[244.458457] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.974s)
[244.615553] [073/130] (774s left) api_intel_allocator (execbuf-with-allocator)
[244.674825] Starting subtest: execbuf-with-allocator
[244.677884] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[244.809161] [074/130] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[244.917213] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[244.921733] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[245.002991] [075/130] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[245.115516] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[245.119787] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[245.216460] [076/130] (774s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[245.306068] Starting subtest: plane-scaler-unity-scaling-with-rotation
[245.308244] Starting dynamic subtest: pipe-A
[245.642766] Dynamic subtest pipe-A: SUCCESS (0.337s)
[245.650108] Starting dynamic subtest: pipe-B
[247.025413] Dynamic subtest pipe-B: SUCCESS (1.382s)
[247.033064] Starting dynamic subtest: pipe-C
[248.447105] Dynamic subtest pipe-C: SUCCESS (1.421s)
[248.456215] Starting dynamic subtest: pipe-D
[249.869639] Dynamic subtest pipe-D: SUCCESS (1.422s)
[249.871800] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.564s)
[251.037261] [077/130] (768s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[251.142159] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[251.144662] Starting dynamic subtest: pipe-A-eDP-1
[251.353605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.198s)
[251.363611] Starting dynamic subtest: pipe-B-eDP-1
[251.383191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[251.391794] Starting dynamic subtest: pipe-C-eDP-1
[251.411466] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[251.419062] Starting dynamic subtest: pipe-D-eDP-1
[251.438566] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[251.440838] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.233s)
[253.584892] [078/130] (766s left) syncobj_timeline (wait-all-snapshot)
[253.645828] Starting subtest: wait-all-snapshot
[253.725493] Subtest wait-all-snapshot: SUCCESS (0.081s)
[253.797914] [079/130] (766s left) gem_set_tiling_vs_pwrite
[253.927157] [080/130] (765s left) gem_exec_params (invalid-bsd2-flag-on-render)
[253.994374] Starting subtest: invalid-bsd2-flag-on-render
[253.996604] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[254.106064] [081/130] (765s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[254.219151] Starting subtest: yf-tiled-addfb-size-overflow
[254.223531] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[254.336381] [082/130] (765s left) gem_exec_schedule (semaphore-user)
[254.409826] Starting subtest: semaphore-user
[254.461731] Subtest semaphore-user: SUCCESS (0.057s)
[255.948507] [083/130] (764s left) kms_big_fb (y-tiled-addfb)
[256.052851] Starting subtest: y-tiled-addfb
[256.057180] Subtest y-tiled-addfb: SKIP (0.000s)
[256.155188] [084/130] (763s left) kms_psr (pr-basic)
[256.247066] Starting subtest: pr-basic
[256.251071] Subtest pr-basic: SKIP (0.000s)
[256.313109] [085/130] (763s left) perf_pmu (init-busy)
[256.351999] Starting subtest: init-busy
[256.354580] Starting dynamic subtest: rcs0
[256.356851] Dynamic subtest rcs0: SUCCESS (0.001s)
[256.364383] Starting dynamic subtest: bcs0
[256.366634] Dynamic subtest bcs0: SUCCESS (0.000s)
[256.373910] Starting dynamic subtest: vcs0
[256.376147] Dynamic subtest vcs0: SUCCESS (0.001s)
[256.383320] Starting dynamic subtest: vcs1
[256.385605] Dynamic subtest vcs1: SUCCESS (0.001s)
[256.393051] Starting dynamic subtest: vecs0
[256.394938] Dynamic subtest vecs0: SUCCESS (0.001s)
[256.401838] Starting dynamic subtest: ccs0
[256.404194] Dynamic subtest ccs0: SUCCESS (0.000s)
[256.406434] Subtest init-busy: SUCCESS (0.007s)
[256.444322] [086/130] (763s left) gem_mmap_gtt (hang)
[256.501316] Subtest hang: SKIP (0.000s)
[256.558720] [087/130] (763s left) perf_pmu (busy-no-semaphores)
[256.602633] Starting subtest: busy-no-semaphores
[256.604951] Starting dynamic subtest: rcs0
[257.148985] Dynamic subtest rcs0: SUCCESS (0.544s)
[257.159679] Starting dynamic subtest: bcs0
[257.699807] Dynamic subtest bcs0: SUCCESS (0.548s)
[257.710430] Starting dynamic subtest: vcs0
[258.249507] Dynamic subtest vcs0: SUCCESS (0.547s)
[258.260985] Starting dynamic subtest: vcs1
[259.440447] Dynamic subtest vcs1: SUCCESS (1.186s)
[259.450045] Starting dynamic subtest: vecs0
[261.422859] Dynamic subtest vecs0: SUCCESS (1.981s)
[261.433077] Starting dynamic subtest: ccs0
[263.471630] Dynamic subtest ccs0: SUCCESS (2.046s)
[263.474729] Subtest busy-no-semaphores: SUCCESS (6.868s)
[263.583667] [088/130] (756s left) gem_exec_params (larger-than-life-batch)
[263.645355] Starting subtest: larger-than-life-batch
[267.368883] Subtest larger-than-life-batch: SUCCESS (3.722s)
[267.994081] [089/130] (752s left) kms_flip (2x-absolute-wf_vblank)
[268.140285] Starting subtest: 2x-absolute-wf_vblank
[268.152200] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[268.227558] [090/130] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[268.330040] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[268.334389] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[268.435143] [091/130] (751s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[268.502296] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[268.566523] [092/130] (751s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[268.671957] Starting subtest: fbc-shrfb-scaledprimary
[272.765026] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.097s)
[272.907875] [093/130] (747s left) kms_vrr (flip-suspend)
[273.011297] Starting subtest: flip-suspend
[273.017962] Subtest flip-suspend: SKIP (0.000s)
[273.079383] [094/130] (747s left) kms_big_fb (linear-16bpp-rotate-90)
[273.189873] Starting subtest: linear-16bpp-rotate-90
[273.209638] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[273.341172] [095/130] (747s left) kms_psr (psr2-cursor-mmap-cpu)
[273.432261] Starting subtest: psr2-cursor-mmap-cpu
[273.434493] Starting dynamic subtest: eDP-1
[275.179802] Dynamic subtest eDP-1: SUCCESS (1.747s)
[275.182194] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.747s)
[275.965455] [096/130] (744s left) gem_pipe_control_store_loop (reused-buffer)
[276.039311] Starting subtest: reused-buffer
[278.193556] Subtest reused-buffer: SUCCESS (2.153s)
[278.319122] [097/130] (742s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[278.426123] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[278.428355] Starting dynamic subtest: pipe-A-eDP-1
[278.485257] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[278.493407] Starting dynamic subtest: pipe-B-eDP-1
[278.549380] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[278.559096] Starting dynamic subtest: pipe-C-eDP-1
[278.616553] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[278.626081] Starting dynamic subtest: pipe-D-eDP-1
[278.683211] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[278.687404] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[280.619895] [098/130] (739s left) kms_addfb_basic (addfb25-4-tiled)
[280.727463] Starting subtest: addfb25-4-tiled
[280.729827] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[280.847049] [099/130] (739s left) drm_read (short-buffer-wakeup)
[281.048028] Starting subtest: short-buffer-wakeup
[313.266124] Subtest short-buffer-wakeup: SUCCESS (32.218s)
[313.427513] [100/130] (707s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[313.486594] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[313.489089] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[313.580246] [101/130] (707s left) sysfs_heartbeat_interval (nopreempt)
[313.637191] Starting subtest: nopreempt
[313.639518] Starting dynamic subtest: vecs0
[322.952966] Dynamic subtest vecs0: SUCCESS (9.312s)
[322.965841] Starting dynamic subtest: ccs0
[326.993168] Dynamic subtest ccs0: SUCCESS (4.041s)
[327.004574] Starting dynamic subtest: vcs0
[336.957999] Dynamic subtest vcs0: SUCCESS (9.960s)
[336.972185] Starting dynamic subtest: bcs0
[340.835978] Dynamic subtest bcs0: SUCCESS (3.877s)
[340.851096] Starting dynamic subtest: rcs0
[344.975969] Dynamic subtest rcs0: SUCCESS (4.140s)
[344.986650] Starting dynamic subtest: vcs1
[354.950871] Dynamic subtest vcs1: SUCCESS (9.970s)
[354.953485] Subtest nopreempt: SUCCESS (41.310s)
[355.024563] [102/130] (665s left) vgem_basic (dmabuf-mmap)
[355.069149] Starting subtest: dmabuf-mmap
[355.101448] Subtest dmabuf-mmap: SUCCESS (0.035s)
[355.152954] [103/130] (665s left) gem_shrink (reclaim)
[355.220949] Starting subtest: reclaim
[357.850954] Subtest reclaim: SUCCESS (2.629s)
[357.994239] [104/130] (662s left) gem_userptr_blits (sync-unmap-after-close)
[358.063487] Starting subtest: sync-unmap-after-close
[358.081504] Subtest sync-unmap-after-close: SUCCESS (0.018s)
[358.238019] [105/130] (662s left) core_auth (getclient-master-drop)
[358.276721] Starting subtest: getclient-master-drop
[358.300910] Subtest getclient-master-drop: SUCCESS (0.025s)
[358.415297] [106/130] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[358.513580] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[358.517967] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[358.604186] [107/130] (662s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[363.659533] Starting subtest: psr2-cursor-plane-move-continuous-sf
[363.661935] Starting dynamic subtest: pipe-A-eDP-1
[374.746453] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.084s)
[374.755793] Starting dynamic subtest: pipe-B-eDP-1
[385.771513] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.024s)
[385.774071] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.112s)
[386.565747] [108/130] (634s left) sw_sync (sync_expired_merge)
[386.604833] Starting subtest: sync_expired_merge
[387.678729] Subtest sync_expired_merge: SUCCESS (1.074s)
[387.735170] [109/130] (633s left) gem_pread (snoop)
[387.799838] Subtest snoop: SKIP (0.000s)
[387.863361] [110/130] (633s left) kms_big_fb (linear-8bpp-rotate-270)
[387.974580] Starting subtest: linear-8bpp-rotate-270
[387.994911] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[388.125655] [111/130] (632s left) gem_exec_schedule (pi-shared-iova)
[388.314657] Starting subtest: pi-shared-iova
[388.317089] Starting dynamic subtest: rcs0
[388.387015] Dynamic subtest rcs0: SUCCESS (0.074s)
[388.399472] Starting dynamic subtest: vcs0
[388.435373] Dynamic subtest vcs0: SUCCESS (0.048s)
[388.445555] Starting dynamic subtest: vcs1
[388.486703] Dynamic subtest vcs1: SUCCESS (0.051s)
[388.499024] Starting dynamic subtest: vecs0
[388.538146] Dynamic subtest vecs0: SUCCESS (0.051s)
[388.549604] Starting dynamic subtest: ccs0
[388.601039] Dynamic subtest ccs0: SUCCESS (0.062s)
[388.603941] Subtest pi-shared-iova: SUCCESS (0.290s)
[390.051407] [112/130] (630s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[390.111086] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[390.113389] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[390.228791] [113/130] (630s left) kms_setmode (invalid-clone-exclusive-crtc)
[390.290810] Starting subtest: invalid-clone-exclusive-crtc
[390.297380] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[390.390703] [114/130] (630s left) gem_ctx_persistence (engines-hostile)
[390.444253] Starting subtest: engines-hostile
[390.446574] Starting dynamic subtest: rcs0
[390.602531] Dynamic subtest rcs0: SUCCESS (0.155s)
[390.612957] Starting dynamic subtest: bcs0
[390.681639] Dynamic subtest bcs0: SUCCESS (0.080s)
[390.691172] Starting dynamic subtest: vcs0
[390.854771] Dynamic subtest vcs0: SUCCESS (0.171s)
[390.866668] Starting dynamic subtest: vcs1
[390.977045] Dynamic subtest vcs1: SUCCESS (0.121s)
[390.988057] Starting dynamic subtest: vecs0
[391.101854] Dynamic subtest vecs0: SUCCESS (0.123s)
[391.112916] Starting dynamic subtest: ccs0
[391.207977] Dynamic subtest ccs0: SUCCESS (0.104s)
[391.210617] Subtest engines-hostile: SUCCESS (0.764s)
[391.283501] [115/130] (629s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[391.409407] Starting subtest: cursorA-vs-flipA-atomic
[402.558376] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.148s)
[403.380724] [116/130] (617s left) gem_watchdog (default-physical)
[403.449238] Starting subtest: default-physical
[405.203297] Subtest default-physical: SUCCESS (1.766s)
[405.302709] [117/130] (615s left) kms_busy (extended-pageflip-hang-oldfb)
[405.401428] Starting subtest: extended-pageflip-hang-oldfb
[405.403755] Starting dynamic subtest: pipe-A
[405.842450] Dynamic subtest pipe-A: SUCCESS (0.437s)
[405.856728] Starting dynamic subtest: pipe-D
[407.019708] Dynamic subtest pipe-D: SUCCESS (1.175s)
[407.022140] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.617s)
[407.840585] [118/130] (613s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[408.071720] Starting subtest: cursor-rapid-movement-256x85
[408.111055] Subtest cursor-rapid-movement-256x85: SKIP (0.034s)
[408.298581] [119/130] (612s left) gem_fence_thrash (bo-write-verify-x)
[408.335473] Starting subtest: bo-write-verify-x
[408.360428] Subtest bo-write-verify-x: SKIP (0.020s)
[408.414807] [120/130] (612s left) kms_addfb_basic (invalid-set-prop)
[408.474515] Starting subtest: invalid-set-prop
[408.476870] Subtest invalid-set-prop: SUCCESS (0.000s)
[408.621617] [121/130] (612s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[408.692655] Subtest tiled-to-untiled: SKIP (0.000s)
[408.747071] [122/130] (612s left) kms_lease (lessee-list)
[408.833729] Starting subtest: lessee-list
[408.835725] Starting dynamic subtest: pipe-A-eDP-1
[408.837726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[408.846034] Starting dynamic subtest: pipe-B-eDP-1
[408.847912] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[408.855847] Starting dynamic subtest: pipe-C-eDP-1
[408.857614] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[408.865300] Starting dynamic subtest: pipe-D-eDP-1
[408.867044] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[408.868849] Subtest lessee-list: SUCCESS (0.009s)
[408.955041] [123/130] (612s left) kms_plane_cursor (primary)
[409.050726] Starting subtest: primary
[409.054855] Starting dynamic subtest: pipe-A-eDP-1-size-64
[411.831072] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.778s)
[411.854618] Starting dynamic subtest: pipe-A-eDP-1-size-128
[414.598095] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.750s)
[414.622538] Starting dynamic subtest: pipe-A-eDP-1-size-256
[417.399464] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.784s)
[417.714598] Starting dynamic subtest: pipe-B-eDP-1-size-64
[421.283332] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.580s)
[421.307386] Starting dynamic subtest: pipe-B-eDP-1-size-128
[424.104884] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.804s)
[424.131062] Starting dynamic subtest: pipe-B-eDP-1-size-256
[426.885241] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.760s)
[427.199484] Starting dynamic subtest: pipe-C-eDP-1-size-64
[430.298514] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.108s)
[430.325887] Starting dynamic subtest: pipe-C-eDP-1-size-128
[432.730476] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.412s)
[432.763086] Starting dynamic subtest: pipe-C-eDP-1-size-256
[435.186301] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.434s)
[435.502578] Starting dynamic subtest: pipe-D-eDP-1-size-64
[438.586158] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.093s)
[438.612011] Starting dynamic subtest: pipe-D-eDP-1-size-128
[440.986253] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.380s)
[441.011925] Starting dynamic subtest: pipe-D-eDP-1-size-256
[443.386175] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.380s)
[443.690805] Subtest primary: SUCCESS (34.637s)
[444.543648] [124/130] (576s left) perf (non-sampling-read-error)
[444.643763] Starting subtest: non-sampling-read-error
[444.658748] Subtest non-sampling-read-error: SUCCESS (0.013s)
[444.691900] [125/130] (576s left) i915_module_load (reload-with-fault-injection)
[444.726765] Starting subtest: reload-with-fault-injection
[482.828507] Killing the test because the kernel is tainted.
[485.246447] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[485.257508] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[485.257570] [FACT i915_module_load (reload-with-fault-injection)] new: kernel.is_tainted.taint_warn: true
[485.258326] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[485.258457] Closing watchdogs
Done.