[54.941324] Initializing watchdogs
[54.941368]   /dev/watchdog0
[54.955856] [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]
[54.960297] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.962384] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.965713] [001/131] (960s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[55.093422] Starting subtest: basic-busy-flip-before-cursor-varying-size
[55.097808] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[55.234536] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[55.351522] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[55.355972] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[55.468994] [003/131] (960s left) i915_pm_rpm (sysfs-read)
[57.116403] Starting subtest: sysfs-read
[58.276234] Subtest sysfs-read: SUCCESS (1.158s)
[58.633992] [004/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[58.743679] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[58.747848] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[58.851774] [005/131] (956s left) sw_sync (sync_busy_fork)
[58.884525] Starting subtest: sync_busy_fork
[59.894908] Subtest sync_busy_fork: SUCCESS (1.011s)
[59.949146] [006/131] (955s left) kms_flip (blocking-absolute-wf_vblank)
[60.040364] Starting subtest: blocking-absolute-wf_vblank
[60.042887] Starting dynamic subtest: A-eDP1
[68.790541] Dynamic subtest A-eDP1: SUCCESS (8.750s)
[68.799415] Starting dynamic subtest: B-eDP1
[77.531420] Dynamic subtest B-eDP1: SUCCESS (8.740s)
[77.538431] Starting dynamic subtest: C-eDP1
[86.257875] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[86.268369] Starting dynamic subtest: D-eDP1
[94.989858] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[94.992861] Subtest blocking-absolute-wf_vblank: SUCCESS (34.952s)
[96.200870] [007/131] (919s left) gem_exec_schedule (preempt-queue-contexts)
[96.275529] Subtest preempt-queue-contexts: SKIP (0.000s)
[96.561092] [008/131] (919s left) kms_color (ctm-green-to-red)
[96.661894] Starting subtest: ctm-green-to-red
[96.663816] Starting dynamic subtest: pipe-A-eDP-1
[97.348712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[97.357859] Starting dynamic subtest: pipe-B-eDP-1
[98.687701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[98.694561] Starting dynamic subtest: pipe-C-eDP-1
[99.978336] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.291s)
[99.987017] Starting dynamic subtest: pipe-D-eDP-1
[101.277975] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[101.280017] Subtest ctm-green-to-red: SUCCESS (4.616s)
[102.141262] [009/131] (913s left) gem_exec_fence (nb-await)
[102.316742] Starting subtest: nb-await
[102.319117] Starting dynamic subtest: rcs0
[102.384954] Dynamic subtest rcs0: SUCCESS (0.068s)
[102.395082] Starting dynamic subtest: bcs0
[102.445979] Dynamic subtest bcs0: SUCCESS (0.060s)
[102.454862] Starting dynamic subtest: vcs0
[102.506222] Dynamic subtest vcs0: SUCCESS (0.060s)
[102.515033] Starting dynamic subtest: vcs1
[102.566076] Dynamic subtest vcs1: SUCCESS (0.059s)
[102.576050] Starting dynamic subtest: vecs0
[102.625773] Dynamic subtest vecs0: SUCCESS (0.059s)
[102.634632] Starting dynamic subtest: ccs0
[102.682480] Dynamic subtest ccs0: SUCCESS (0.057s)
[102.685053] Subtest nb-await: SUCCESS (0.366s)
[104.987319] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[104.990619] [010/131] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[105.099517] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[105.103720] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[105.201063] [011/131] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[105.302232] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[105.306355] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[105.403969] [012/131] (910s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[110.414790] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[110.419575] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[111.278947] [013/131] (904s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[111.375328] Starting subtest: psr-2p-primscrn-spr-indfb-move
[111.379576] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[111.464311] [014/131] (904s left) fbdev (unaligned-read)
[111.494903] Starting subtest: unaligned-read
[111.509433] Subtest unaligned-read: SUCCESS (0.014s)
[111.565715] [015/131] (904s left) gem_tiled_pread_basic
[111.696534] [016/131] (904s left) syncobj_timeline (etime-single-wait-submitted)
[111.755927] Starting subtest: etime-single-wait-submitted
[111.864517] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[111.936509] [017/131] (904s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[111.995598] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[111.999690] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[112.176338] [018/131] (903s left) gem_mmap_wc (read-write)
[112.226778] Subtest read-write: SKIP (0.000s)
[112.285179] [019/131] (903s left) kms_flip (flip-vs-suspend)
[112.382127] Starting subtest: flip-vs-suspend
[112.384581] Starting dynamic subtest: A-eDP1
[161.947487] Dynamic subtest A-eDP1: SUCCESS (4.563s)
[161.956304] Starting dynamic subtest: B-eDP1
[210.947617] Dynamic subtest B-eDP1: SUCCESS (4.337s)
[210.956486] Starting dynamic subtest: C-eDP1
[259.942469] Dynamic subtest C-eDP1: SUCCESS (4.394s)
[259.951780] Starting dynamic subtest: D-eDP1
[308.912278] Dynamic subtest D-eDP1: SUCCESS (4.293s)
[308.914730] Subtest flip-vs-suspend: SUCCESS (17.592s)
[310.056607] [020/131] (706s left) gem_userptr_blits (sync-unmap-cycles)
[310.124068] Starting subtest: sync-unmap-cycles
[315.500823] Subtest sync-unmap-cycles: SUCCESS (5.374s)
[315.635172] [021/131] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[315.742459] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[315.746350] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.854353] [022/131] (700s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[315.947794] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[315.949755] Starting dynamic subtest: pipe-A-eDP-1
[315.957970] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.966853] Starting dynamic subtest: pipe-B-eDP-1
[315.974732] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.983087] Starting dynamic subtest: pipe-C-eDP-1
[315.990566] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.998029] Starting dynamic subtest: pipe-D-eDP-1
[316.006125] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.009741] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[318.155867] [023/131] (698s left) gem_exec_schedule (timeslicing)
[318.236059] Starting subtest: timeslicing
[318.238155] Starting dynamic subtest: rcs0
[318.245898] Dynamic subtest rcs0: SUCCESS (0.022s)
[318.254932] Starting dynamic subtest: bcs0
[318.266633] Dynamic subtest bcs0: SUCCESS (0.020s)
[318.274589] Starting dynamic subtest: vcs0
[318.287750] Dynamic subtest vcs0: SUCCESS (0.020s)
[318.296134] Starting dynamic subtest: vcs1
[318.307494] Dynamic subtest vcs1: SUCCESS (0.020s)
[318.315935] Starting dynamic subtest: vecs0
[318.328763] Dynamic subtest vecs0: SUCCESS (0.021s)
[318.339861] Starting dynamic subtest: ccs0
[318.348826] Dynamic subtest ccs0: SUCCESS (0.020s)
[318.351329] Subtest timeslicing: SUCCESS (0.125s)
[319.859305] [024/131] (696s left) kms_rmfb (close-fd)
[319.943447] Starting subtest: close-fd
[319.945750] Starting dynamic subtest: pipe-A-eDP-1
[320.054714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[320.063767] Starting dynamic subtest: pipe-B-eDP-1
[321.224602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.169s)
[321.234601] Starting dynamic subtest: pipe-C-eDP-1
[322.353603] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[322.363504] Starting dynamic subtest: pipe-D-eDP-1
[323.483799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[323.485852] Subtest close-fd: SUCCESS (3.536s)
[324.694672] [025/131] (691s left) kms_pm_rpm (modeset-lpsp)
[327.036810] Starting subtest: modeset-lpsp
[328.515090] Subtest modeset-lpsp: SUCCESS (1.475s)
[328.604786] [026/131] (687s left) gem_pxp (reject-modify-context-protection-off-3)
[328.719464] Starting subtest: reject-modify-context-protection-off-3
[328.722122] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[328.842605] [027/131] (687s left) prime_mmap (test_forked_cpu_write)
[328.900604] Starting subtest: test_forked_cpu_write
[328.902768] Starting dynamic subtest: test_forked_cpu_write-smem
[328.905660] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[328.908245] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[329.016381] [028/131] (687s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[329.111110] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[329.113627] Starting dynamic subtest: A-eDP1
[332.695655] Dynamic subtest A-eDP1: SUCCESS (3.580s)
[332.706075] Starting dynamic subtest: B-eDP1
[335.801118] Dynamic subtest B-eDP1: SUCCESS (3.105s)
[335.814267] Starting dynamic subtest: C-eDP1
[338.935492] Dynamic subtest C-eDP1: SUCCESS (3.133s)
[338.944368] Starting dynamic subtest: D-eDP1
[342.053540] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[342.055733] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.939s)
[342.839542] [029/131] (673s left) gem_watchdog (default-physical)
[342.913597] Starting subtest: default-physical
[344.669977] Subtest default-physical: SUCCESS (1.767s)
[344.782471] [030/131] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[344.881687] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[344.887494] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[344.997341] [031/131] (671s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[345.099617] Starting subtest: yf-tiled-64bpp-rotate-90
[345.104714] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[345.212766] [032/131] (671s left) gem_ctx_shared (detached-shared-gtt)
[345.280980] Starting subtest: detached-shared-gtt
[347.435866] Subtest detached-shared-gtt: SUCCESS (2.153s)
[347.786326] [033/131] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[347.888774] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[354.773252] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.885s)
[354.932219] [034/131] (661s left) gem_mmap_wc (invalid-flags)
[354.985690] Subtest invalid-flags: SKIP (0.000s)
[355.052837] [035/131] (661s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[355.159077] Starting subtest: fbc-psr-cursor-mmap-gtt
[355.161388] Starting dynamic subtest: eDP-1
[355.165714] Dynamic subtest eDP-1: SKIP (0.000s)
[355.170115] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[355.229929] [036/131] (661s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[355.333875] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[361.751998] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.421s)
[361.879869] [037/131] (655s left) api_intel_allocator (simple-allocator)
[361.940081] Starting subtest: simple-allocator
[361.942224] Starting dynamic subtest: basic
[361.944972] Dynamic subtest basic: SUCCESS (0.005s)
[361.953122] Starting dynamic subtest: parallel-one
[362.120500] Dynamic subtest parallel-one: SUCCESS (0.176s)
[362.128526] Starting dynamic subtest: print
[362.130883] Dynamic subtest print: SUCCESS (0.000s)
[362.139893] Starting dynamic subtest: reuse
[362.142102] Dynamic subtest reuse: SUCCESS (0.000s)
[362.150011] Starting dynamic subtest: reserve
[362.152306] Dynamic subtest reserve: SUCCESS (0.000s)
[362.160254] Starting dynamic subtest: fork-reopen-allocator
[362.162128] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[362.164108] Subtest simple-allocator: SUCCESS (0.196s)
[362.240724] [038/131] (654s left) gem_create (create-size-update)
[362.289873] Starting subtest: create-size-update
[362.292405] Subtest create-size-update: SUCCESS (0.000s)
[362.489964] [039/131] (654s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[362.878752] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[363.658461] [040/131] (653s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[363.755222] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[364.753194] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s)
[364.863133] [041/131] (652s left) gem_lmem_swapping (massive-random)
[364.906097] Subtest massive-random: SKIP (0.000s)
[364.953487] [042/131] (652s left) kms_tiled_display (basic-test-pattern)
[365.065719] Subtest basic-test-pattern: SKIP (0.000s)
[365.113452] [043/131] (652s left) kms_plane_multiple (2x-tiling-yf)
[365.198785] Starting subtest: 2x-tiling-yf
[365.203367] Subtest 2x-tiling-yf: SKIP (0.000s)
[365.273469] [044/131] (651s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[365.380218] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[365.384300] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[365.474599] [045/131] (651s left) gem_spin_batch (engines)
[365.526839] Starting subtest: engines
[365.529420] Starting dynamic subtest: rcs0
[368.770789] Dynamic subtest rcs0: SUCCESS (3.238s)
[368.781945] Starting dynamic subtest: bcs0
[372.008402] Dynamic subtest bcs0: SUCCESS (3.234s)
[372.018785] Starting dynamic subtest: vcs0
[375.244827] Dynamic subtest vcs0: SUCCESS (3.234s)
[375.254131] Starting dynamic subtest: vcs1
[378.485670] Dynamic subtest vcs1: SUCCESS (3.236s)
[378.495688] Starting dynamic subtest: vecs0
[381.724289] Dynamic subtest vecs0: SUCCESS (3.234s)
[381.734423] Starting dynamic subtest: ccs0
[384.962848] Dynamic subtest ccs0: SUCCESS (3.236s)
[384.965110] Subtest engines: SUCCESS (19.427s)
[385.196278] [046/131] (632s left) kms_psr (pr-primary-blt)
[385.290903] Starting subtest: pr-primary-blt
[385.294896] Subtest pr-primary-blt: SKIP (0.000s)
[385.359146] [047/131] (631s left) kms_flip (2x-flip-vs-fences)
[385.442395] Starting subtest: 2x-flip-vs-fences
[385.446546] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[385.543213] [048/131] (631s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[385.639864] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[385.650121] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[385.723552] [049/131] (631s left) gem_softpin (evict-snoop-interruptible)
[385.780968] Starting subtest: evict-snoop-interruptible
[385.785964] Subtest evict-snoop-interruptible: SKIP (0.000s)
[385.905630] [050/131] (631s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[386.000549] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[386.002789] Starting dynamic subtest: pipe-A-eDP-1
[386.027173] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.037834] Starting dynamic subtest: pipe-B-eDP-1
[386.061965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.069955] Starting dynamic subtest: pipe-C-eDP-1
[386.093603] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.101207] Starting dynamic subtest: pipe-D-eDP-1
[386.121528] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.124893] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[388.157477] [051/131] (629s left) kms_debugfs (display-on-read-all)
[388.244203] Starting subtest: display-on-read-all
[388.379757] Subtest display-on-read-all: SUCCESS (0.133s)
[388.522096] [052/131] (628s left) gem_exec_suspend (basic)
[388.575786] Starting subtest: basic
[388.578094] Starting dynamic subtest: smem
[389.835026] Dynamic subtest smem: SUCCESS (1.257s)
[389.837960] Subtest basic: SUCCESS (1.259s)
[390.035208] [053/131] (627s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[390.139928] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[394.118089] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.981s)
[395.258822] [054/131] (622s left) i915_drm_fdinfo (virtual-busy)
[395.305136] Starting subtest: virtual-busy
[395.309748] Subtest virtual-busy: SKIP (0.000s)
[395.375724] [055/131] (622s left) gem_exec_balancer (waits)
[395.434731] Starting subtest: waits
[401.889986] Subtest waits: SUCCESS (6.452s)
[402.185468] [056/131] (615s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[402.304240] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[402.309810] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[402.398897] [057/131] (615s left) gem_exec_reloc (basic-gtt)
[402.450695] Subtest basic-gtt: SKIP (0.000s)
[402.526925] [058/131] (615s left) kms_getfb (getfb-handle-not-fb)
[402.611718] Starting subtest: getfb-handle-not-fb
[402.614158] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[402.715182] [059/131] (615s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[402.817264] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[402.822320] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[402.929631] [060/131] (614s left) kms_plane (plane-position-hole-dpms)
[403.014575] Starting subtest: plane-position-hole-dpms
[403.514636] Starting dynamic subtest: pipe-A-plane-1
[405.934094] Dynamic subtest pipe-A-plane-1: SUCCESS (2.419s)
[405.943023] Starting dynamic subtest: pipe-A-plane-2
[408.232082] Dynamic subtest pipe-A-plane-2: SUCCESS (2.300s)
[408.243090] Starting dynamic subtest: pipe-A-plane-3
[410.490578] Dynamic subtest pipe-A-plane-3: SUCCESS (2.256s)
[410.500860] Starting dynamic subtest: pipe-A-plane-4
[412.857895] Dynamic subtest pipe-A-plane-4: SUCCESS (2.369s)
[412.867841] Starting dynamic subtest: pipe-A-plane-5
[412.882841] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[414.024917] Starting dynamic subtest: pipe-B-plane-1
[416.392221] Dynamic subtest pipe-B-plane-1: SUCCESS (2.376s)
[416.400681] Starting dynamic subtest: pipe-B-plane-2
[418.761320] Dynamic subtest pipe-B-plane-2: SUCCESS (2.369s)
[418.771029] Starting dynamic subtest: pipe-B-plane-3
[421.107659] Dynamic subtest pipe-B-plane-3: SUCCESS (2.346s)
[421.116887] Starting dynamic subtest: pipe-B-plane-4
[423.469241] Dynamic subtest pipe-B-plane-4: SUCCESS (2.363s)
[423.479189] Starting dynamic subtest: pipe-B-plane-5
[423.494812] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[423.497699] Subtest plane-position-hole-dpms: SUCCESS (20.485s)
[424.287985] [061/131] (593s left) kms_vrr (lobf)
[424.394413] Starting subtest: lobf
[424.399000] Subtest lobf: SKIP (0.000s)
[424.465358] [062/131] (593s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[424.552631] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[429.296483] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.749s)
[430.483804] [063/131] (587s left) syncobj_timeline (etime-multi-wait-all-submitted)
[430.531938] Starting subtest: etime-multi-wait-all-submitted
[430.638802] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[430.714101] [064/131] (587s left) gem_exec_reloc (basic-scanout)
[430.764855] Subtest basic-scanout: SKIP (0.000s)
[430.855894] [065/131] (587s left) kms_hdr (invalid-hdr)
[430.939867] Starting subtest: invalid-hdr
[432.042713] Starting dynamic subtest: pipe-A-eDP-1
[434.893071] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.850s)
[434.895729] Subtest invalid-hdr: SUCCESS (3.954s)
[435.019940] [066/131] (583s left) kms_fbcon_fbt (fbc)
[435.068224] Starting subtest: fbc
[441.354278] Subtest fbc: SUCCESS (6.282s)
[442.459405] [067/131] (575s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[442.568868] Starting subtest: fbc-rgb101010-draw-mmap-wc
[447.179758] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.615s)
[448.315896] [068/131] (569s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[448.401720] Starting subtest: plane-all-transition-nonblocking-fencing
[448.404301] Starting dynamic subtest: pipe-A-eDP-1
[450.901602] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[451.215717] Starting dynamic subtest: pipe-B-eDP-1
[454.426929] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s)
[454.736061] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.337s)
[455.554248] [069/131] (562s left) gem_exec_reloc (basic-write-read-active)
[455.617512] Subtest basic-write-read-active: SKIP (0.000s)
[455.704970] [070/131] (562s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[455.765393] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[455.769865] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[455.948494] [071/131] (562s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[456.043239] Starting subtest: primary-y-tiled-reflect-x-90
[456.048690] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[456.112127] [072/131] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[456.207752] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[462.605015] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.399s)
[462.731130] [073/131] (555s left) kms_legacy_colorkey (basic)
[462.816813] Starting subtest: basic
[462.819138] Starting dynamic subtest: pipe-A
[462.862615] Dynamic subtest pipe-A: SUCCESS (0.045s)
[462.873987] Starting dynamic subtest: pipe-B
[462.876602] Dynamic subtest pipe-B: SUCCESS (0.000s)
[462.885836] Starting dynamic subtest: pipe-C
[462.888327] Dynamic subtest pipe-C: SUCCESS (0.000s)
[462.898799] Starting dynamic subtest: pipe-D
[462.901066] Dynamic subtest pipe-D: SUCCESS (0.000s)
[462.903417] Subtest basic: SUCCESS (0.050s)
[462.940654] [074/131] (555s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[463.038770] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[463.042741] Starting dynamic subtest: pipe-A
[463.107699] Dynamic subtest pipe-A: SUCCESS (0.069s)
[463.117850] Starting dynamic subtest: pipe-B
[464.303862] Dynamic subtest pipe-B: SUCCESS (1.194s)
[464.314697] Starting dynamic subtest: pipe-C
[465.409599] Dynamic subtest pipe-C: SUCCESS (1.105s)
[465.420940] Starting dynamic subtest: pipe-D
[466.552469] Dynamic subtest pipe-D: SUCCESS (1.141s)
[466.554959] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.514s)
[467.689920] [075/131] (550s left) gem_exec_reloc (basic-gtt-read-noreloc)
[467.755838] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[467.816472] [076/131] (550s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[467.927936] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[467.933465] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[468.031718] [077/131] (550s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[468.126771] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[468.129346] Starting dynamic subtest: pipe-A-eDP-1
[468.149790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[468.159843] Starting dynamic subtest: pipe-B-eDP-1
[468.179350] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[468.187772] Starting dynamic subtest: pipe-C-eDP-1
[468.208107] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[468.218102] Starting dynamic subtest: pipe-D-eDP-1
[468.239871] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[468.242183] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[470.265407] [078/131] (548s left) gem_create (create-ext-cpu-access-sanity-check)
[470.432903] Starting subtest: create-ext-cpu-access-sanity-check
[470.438409] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[470.508836] [079/131] (548s left) gem_fenced_exec_thrash (too-many-fences)
[470.565428] Subtest too-many-fences: SKIP (0.000s)
[470.648586] [080/131] (547s left) gem_mmap_gtt (basic-write-read)
[470.713495] Subtest basic-write-read: SKIP (0.000s)
[470.778577] [081/131] (547s left) perf_pmu (interrupts)
[470.820992] Starting subtest: interrupts
[471.932983] Subtest interrupts: SUCCESS (1.112s)
[472.057888] [082/131] (546s left) gem_mmap_offset (bad-flags)
[472.109890] Starting subtest: bad-flags
[472.112473] Subtest bad-flags: SUCCESS (0.000s)
[472.223524] [083/131] (546s left) kms_cursor_crc (cursor-sliding-512x170)
[472.485863] Starting subtest: cursor-sliding-512x170
[472.491631] Subtest cursor-sliding-512x170: SKIP (0.001s)
[472.622696] [084/131] (546s left) gem_eio (create)
[472.847019] Starting subtest: create
[473.154018] Subtest create: SUCCESS (0.309s)
[473.315402] [085/131] (545s left) kms_psr (fbc-pr-sprite-plane-onoff)
[473.409450] Starting subtest: fbc-pr-sprite-plane-onoff
[473.413507] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[473.481064] [086/131] (545s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[473.529889] Starting subtest: multi-wait-all-for-submit-unsubmitted
[473.639406] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[473.720644] [087/131] (545s left) kms_content_protection (srm)
[473.866489] Starting subtest: srm
[477.231967] Subtest srm: SKIP (3.362s)
[478.406250] [088/131] (540s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[478.472282] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[478.561802] [089/131] (540s left) kms_async_flips (test-cursor)
[478.659964] Starting subtest: test-cursor
[478.664931] Subtest test-cursor: SKIP (0.000s)
[479.829155] [090/131] (539s left) kms_prop_blob (basic)
[479.882070] Starting subtest: basic
[479.884493] Subtest basic: SUCCESS (0.000s)
[479.991122] [091/131] (539s left) gem_mmap (short-mmap)
[480.053884] Subtest short-mmap: SKIP (0.000s)
[480.122709] [092/131] (539s left) kms_cursor_crc (cursor-offscreen-64x64)
[480.306901] Starting subtest: cursor-offscreen-64x64
[480.311419] Starting dynamic subtest: pipe-A-eDP-1
[482.246227] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[482.270108] Starting dynamic subtest: pipe-D-eDP-1
[484.824575] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[484.827124] Subtest cursor-offscreen-64x64: SUCCESS (4.516s)
[485.684770] [093/131] (533s left) syncobj_timeline (wait-for-submit-snapshot)
[485.749836] Starting subtest: wait-for-submit-snapshot
[485.831452] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[485.909301] [094/131] (533s left) syncobj_timeline (wait-all-interrupted)
[485.957992] Starting subtest: wait-all-interrupted
[486.063307] Subtest wait-all-interrupted: SUCCESS (0.105s)
[486.141631] [095/131] (533s left) syncobj_wait (single-wait-all-signaled)
[486.195348] Starting subtest: single-wait-all-signaled
[486.197685] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[486.292353] [096/131] (532s left) gem_tiled_swapping (non-threaded)
[486.349490] Subtest non-threaded: SKIP (0.000s)
[486.422584] [097/131] (532s left) prime_busy (after)
[486.474977] Starting subtest: after
[486.481504] Starting dynamic subtest: rcs0
[486.513120] Dynamic subtest rcs0: SUCCESS (0.035s)
[486.524118] Starting dynamic subtest: bcs0
[486.577004] Dynamic subtest bcs0: SUCCESS (0.063s)
[486.588002] Starting dynamic subtest: vcs0
[486.617649] Dynamic subtest vcs0: SUCCESS (0.040s)
[486.627408] Starting dynamic subtest: vcs1
[486.657915] Dynamic subtest vcs1: SUCCESS (0.040s)
[486.667975] Starting dynamic subtest: vecs0
[486.699769] Dynamic subtest vecs0: SUCCESS (0.042s)
[486.709572] Starting dynamic subtest: ccs0
[486.742994] Dynamic subtest ccs0: SUCCESS (0.042s)
[486.851673] Subtest after: SUCCESS (0.375s)
[486.927516] [098/131] (532s left) syncobj_timeline (invalid-signal-bad-pad)
[486.987674] Starting subtest: invalid-signal-bad-pad
[486.990088] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[487.091629] [099/131] (532s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[487.189988] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[487.194579] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[487.299183] [100/131] (532s left) gem_ctx_persistence (idempotent)
[487.356928] Starting subtest: idempotent
[487.359878] Subtest idempotent: SUCCESS (0.000s)
[487.483496] [101/131] (532s left) kms_psr (pr-cursor-plane-onoff)
[487.578923] Starting subtest: pr-cursor-plane-onoff
[487.583651] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[487.648785] [102/131] (531s left) gem_exec_flush (basic-uc-ro-default)
[487.703851] Starting subtest: basic-uc-ro-default
[493.156436] Subtest basic-uc-ro-default: SUCCESS (5.451s)
[493.342132] [103/131] (526s left) gem_exercise_blt (fast-copy-emit)
[493.392668] Starting subtest: fast-copy-emit
[493.395526] Starting dynamic subtest: linear-smem-smem-emit
[493.421531] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.029s)
[493.432803] Starting dynamic subtest: xmajor-smem-smem-emit
[493.443420] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.021s)
[493.452463] Starting dynamic subtest: tile4-smem-smem-emit
[493.462080] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[493.471001] Starting dynamic subtest: tile64-smem-smem-emit
[493.478741] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[493.481495] Subtest fast-copy-emit: SUCCESS (0.086s)
[493.616289] [104/131] (526s left) perf (low-oa-exponent-permissions)
[493.727561] Starting subtest: low-oa-exponent-permissions
[493.763340] Subtest low-oa-exponent-permissions: SUCCESS (0.035s)
[493.813277] [105/131] (525s left) gem_ppgtt (shrink-vs-evict-pinned)
[493.872591] Starting subtest: shrink-vs-evict-pinned
[500.834750] Subtest shrink-vs-evict-pinned: SUCCESS (6.960s)
[500.945549] [106/131] (518s left) kms_chamelium_color (ctm-0-25)
[501.050075] Subtest ctm-0-25: SKIP (0.000s)
[501.099312] [107/131] (518s left) kms_lease (lease-again)
[501.199657] Starting subtest: lease-again
[501.202100] Starting dynamic subtest: pipe-A-eDP-1
[501.204674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[501.214141] Starting dynamic subtest: pipe-B-eDP-1
[501.216743] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[501.226177] Starting dynamic subtest: pipe-C-eDP-1
[501.228569] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[501.237752] Starting dynamic subtest: pipe-D-eDP-1
[501.239997] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[501.242618] Subtest lease-again: SUCCESS (0.012s)
[501.327616] [108/131] (518s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[501.422237] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[501.424861] Starting dynamic subtest: pipe-A-eDP-1
[501.446762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[501.458048] Starting dynamic subtest: pipe-B-eDP-1
[501.477927] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[501.487589] Starting dynamic subtest: pipe-C-eDP-1
[501.508678] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[501.518248] Starting dynamic subtest: pipe-D-eDP-1
[501.539924] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[501.542211] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[503.650236] [109/131] (516s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[503.704639] Starting subtest: multi-wait-for-submit-submitted-signaled
[503.708021] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[503.811033] [110/131] (516s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[503.911732] Starting subtest: 4-tiled-64bpp-rotate-0
[505.322748] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.411s)
[505.512910] [111/131] (514s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[505.616965] Starting subtest: x-tiled-addfb-size-offset-overflow
[505.619463] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[505.727494] [112/131] (514s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[505.821291] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[512.730369] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (6.910s)
[512.844892] [113/131] (507s left) i915_selftest (live)
[514.832707] Starting subtest: live
[514.835701] Starting dynamic subtest: sanitycheck
[517.856936] Dynamic subtest sanitycheck: SUCCESS (3.023s)
[517.871576] Starting dynamic subtest: uncore
[520.872009] Dynamic subtest uncore: SUCCESS (3.012s)
[520.881820] Starting dynamic subtest: workarounds
[524.283364] Dynamic subtest workarounds: SUCCESS (3.409s)
[524.293850] Starting dynamic subtest: gt_engines
[527.624906] Dynamic subtest gt_engines: SUCCESS (3.340s)
[527.635342] Starting dynamic subtest: gt_timelines
[543.345543] Dynamic subtest gt_timelines: SUCCESS (15.720s)
[543.355697] Starting dynamic subtest: gt_contexts
[547.945107] Dynamic subtest gt_contexts: SUCCESS (4.599s)
[547.955280] Starting dynamic subtest: gt_lrc
[552.507566] Dynamic subtest gt_lrc: SUCCESS (4.561s)
[552.515096] Starting dynamic subtest: gt_mocs
[555.815792] Dynamic subtest gt_mocs: SUCCESS (3.306s)
[555.826130] Starting dynamic subtest: gt_pm
[562.856114] Dynamic subtest gt_pm: SUCCESS (7.040s)
[562.866982] Starting dynamic subtest: gt_heartbeat
[565.851679] Dynamic subtest gt_heartbeat: SUCCESS (2.994s)
[565.861555] Starting dynamic subtest: gt_tlb
[575.483257] Dynamic subtest gt_tlb: SUCCESS (9.631s)
[575.493402] Starting dynamic subtest: requests
[589.194536] Dynamic subtest requests: SUCCESS (13.710s)
[589.204962] Starting dynamic subtest: migrate
[595.470330] Dynamic subtest migrate: SUCCESS (6.274s)
[595.480505] Starting dynamic subtest: active
[600.036449] Dynamic subtest active: SUCCESS (4.564s)
[600.046287] Starting dynamic subtest: objects
[603.538481] Dynamic subtest objects: SUCCESS (3.500s)
[603.548586] Starting dynamic subtest: mman
[608.722704] Dynamic subtest mman: SUCCESS (5.182s)
[608.732971] Starting dynamic subtest: dmabuf
[611.791250] Dynamic subtest dmabuf: SUCCESS (3.067s)
[611.801207] Starting dynamic subtest: vma
[616.462379] Dynamic subtest vma: SUCCESS (4.669s)
[616.477397] Starting dynamic subtest: coherency
[622.135525] Dynamic subtest coherency: SUCCESS (5.671s)
[622.145787] Starting dynamic subtest: gtt
[634.236628] Dynamic subtest gtt: SUCCESS (12.099s)
[634.246965] Starting dynamic subtest: gem
[640.600547] Dynamic subtest gem: SUCCESS (6.362s)
[640.610831] Starting dynamic subtest: evict
[644.947399] Dynamic subtest evict: SUCCESS (4.345s)
[644.958186] Starting dynamic subtest: hugepages
[654.192086] Dynamic subtest hugepages: SUCCESS (9.242s)
[654.202615] Starting dynamic subtest: gem_contexts
[680.834141] Dynamic subtest gem_contexts: SUCCESS (26.637s)
[680.847723] Starting dynamic subtest: client
[685.505559] Dynamic subtest client: SUCCESS (4.669s)
[685.515803] Starting dynamic subtest: gem_migrate
[688.503524] Dynamic subtest gem_migrate: SUCCESS (2.996s)
[688.513777] Starting dynamic subtest: reset
[693.102082] Dynamic subtest reset: SUCCESS (4.597s)
[693.111501] Starting dynamic subtest: memory_region
[697.671949] Dynamic subtest memory_region: SUCCESS (4.568s)
[697.686600] Starting dynamic subtest: hangcheck
[711.393396] Dynamic subtest hangcheck: SUCCESS (13.718s)
[711.404022] Starting dynamic subtest: execlists
[714.392266] Dynamic subtest execlists: SUCCESS (2.997s)
[714.402541] Starting dynamic subtest: ring_submission
[719.004257] Dynamic subtest ring_submission: SUCCESS (4.610s)
[719.013102] Starting dynamic subtest: perf
[722.120376] Dynamic subtest perf: SUCCESS (3.114s)
[722.130387] Starting dynamic subtest: slpc
[734.631803] Dynamic subtest slpc: SUCCESS (12.507s)
[734.642012] Starting dynamic subtest: guc
[738.698678] Dynamic subtest guc: SUCCESS (4.064s)
[738.709204] Starting dynamic subtest: guc_multi_lrc
[741.710958] Dynamic subtest guc_multi_lrc: SUCCESS (3.011s)
[741.720325] Starting dynamic subtest: guc_hang
[746.895375] Dynamic subtest guc_hang: SUCCESS (5.182s)
[746.905774] Starting dynamic subtest: late_gt_pm
[749.949674] Dynamic subtest late_gt_pm: SUCCESS (3.052s)
[749.952600] Subtest live: SUCCESS (235.101s)
[749.984889] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[749.985666] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[749.989408] [114/131] (270s left) gen9_exec_parse (cmd-crossing-page)
[751.677749] Subtest cmd-crossing-page: SKIP (0.000s)
[751.764605] [FACT gen9_exec_parse (cmd-crossing-page)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[751.766657] [FACT gen9_exec_parse (cmd-crossing-page)] new: kernel.kmod_is_loaded.i915: true
[751.770503] [115/131] (268s left) kms_psr (psr-primary-page-flip)
[751.869802] Starting subtest: psr-primary-page-flip
[751.872356] Starting dynamic subtest: eDP-1
[753.645885] Dynamic subtest eDP-1: SUCCESS (1.775s)
[753.648118] Subtest psr-primary-page-flip: SUCCESS (1.776s)
[754.496784] [116/131] (265s left) gem_userptr_blits (unsync-unmap-after-close)
[754.562837] Subtest unsync-unmap-after-close: SKIP (0.000s)
[754.699660] [117/131] (265s left) perf (gen12-group-concurrent-oa-buffer-read)
[754.803433] Starting subtest: gen12-group-concurrent-oa-buffer-read
[764.834662] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.031s)
[764.884888] [118/131] (255s left) perf_pmu (idle)
[764.927254] Starting subtest: idle
[764.930267] Starting dynamic subtest: rcs0
[765.471845] Dynamic subtest rcs0: SUCCESS (0.547s)
[765.482283] Starting dynamic subtest: bcs0
[765.991260] Dynamic subtest bcs0: SUCCESS (0.517s)
[766.003405] Starting dynamic subtest: vcs0
[766.514410] Dynamic subtest vcs0: SUCCESS (0.521s)
[766.525687] Starting dynamic subtest: vcs1
[767.034638] Dynamic subtest vcs1: SUCCESS (0.514s)
[767.044934] Starting dynamic subtest: vecs0
[767.555084] Dynamic subtest vecs0: SUCCESS (0.523s)
[767.567011] Starting dynamic subtest: ccs0
[768.072460] Dynamic subtest ccs0: SUCCESS (0.514s)
[768.075385] Subtest idle: SUCCESS (3.148s)
[768.170377] [119/131] (252s left) kms_scaling_modes (scaling-mode-full-aspect)
[768.271877] Starting subtest: scaling-mode-full-aspect
[768.274567] Starting dynamic subtest: pipe-A-eDP-1
[768.375927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.103s)
[768.386081] Starting dynamic subtest: pipe-B-eDP-1
[769.525920] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[769.534538] Starting dynamic subtest: pipe-C-eDP-1
[770.645994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[770.655086] Starting dynamic subtest: pipe-D-eDP-1
[771.771684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[771.774114] Subtest scaling-mode-full-aspect: SUCCESS (3.500s)
[772.922526] [120/131] (247s left) prime_self_import (reimport-vs-gem_close-race)
[772.959886] Starting subtest: reimport-vs-gem_close-race
[778.054387] Subtest reimport-vs-gem_close-race: SUCCESS (5.093s)
[778.125912] [121/131] (242s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[778.238509] Starting subtest: psr-rgb101010-draw-pwrite
[785.741342] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.506s)
[785.853445] [122/131] (234s left) api_intel_bb (reset-flags)
[785.916450] Starting subtest: reset-flags
[785.923602] Subtest reset-flags: SUCCESS (0.009s)
[786.068572] [123/131] (234s left) perf (disabled-read-error)
[786.143979] Starting subtest: disabled-read-error
[786.157790] Subtest disabled-read-error: SUCCESS (0.014s)
[786.201225] [124/131] (234s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[786.580527] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[787.360877] [125/131] (233s left) kms_setmode (basic)
[787.417761] Starting subtest: basic
[787.749954] Starting dynamic subtest: pipe-A-eDP-1
[789.791399] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.038s)
[790.134031] Starting dynamic subtest: pipe-B-eDP-1
[792.224961] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.095s)
[792.532956] Subtest basic: SUCCESS (5.113s)
[793.378129] [126/131] (227s left) gem_ctx_param (set-priority-range)
[793.429092] Starting subtest: set-priority-range
[793.443925] Subtest set-priority-range: SUCCESS (0.015s)
[793.560633] [127/131] (227s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[793.660535] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[793.662844] Starting dynamic subtest: pipe-A-default-mode
[793.956669] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[793.961833] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.292s)
[794.806879] [128/131] (225s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[794.912723] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[795.824821] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.913s)
[795.955813] [129/131] (224s left) i915_pm_freq_api (freq-reset)
[796.022225] Starting subtest: freq-reset
[796.024381] Starting dynamic subtest: gt0
[796.200844] Dynamic subtest gt0: SUCCESS (0.178s)
[796.216709] Starting dynamic subtest: gt1
[796.342011] Dynamic subtest gt1: SUCCESS (0.136s)
[796.344350] Subtest freq-reset: SUCCESS (0.315s)
[796.413976] [130/131] (224s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[801.379840] Starting subtest: pr-plane-move-sf-dmg-area
[801.384919] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[802.224480] [131/131] (218s left) gem_exec_fence (syncobj-timeline-chain-engines)
[802.761852] Starting subtest: syncobj-timeline-chain-engines
[802.853380] Subtest syncobj-timeline-chain-engines: SUCCESS (0.093s)
[803.912484] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: i915_pm_rpm
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: sw_sync
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_color
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: fbdev
results: parsing output: 14/ for test: gem_tiled_pread_basic
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_mmap_wc
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_rmfb
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: prime_mmap
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_watchdog
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: gem_create
results: parsing output: 38/ for test: kms_chamelium_edid
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_lmem_swapping
results: parsing output: 41/ for test: kms_tiled_display
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_debugfs
results: parsing output: 51/ for test: gem_exec_suspend
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_getfb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_vrr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: kms_fbcon_fbt
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_legacy_colorkey
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_create
results: parsing output: 78/ for test: gem_fenced_exec_thrash
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_prop_blob
results: parsing output: 90/ for test: gem_mmap
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_tiled_swapping
results: parsing output: 96/ for test: prime_busy
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: gem_exercise_blt
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: gem_ppgtt
results: parsing output: 105/ for test: kms_chamelium_color
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_selftest
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_scaling_modes
results: parsing output: 119/ for test: prime_self_import
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: api_intel_bb
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_chamelium_hpd
results: parsing output: 124/ for test: kms_setmode
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: i915_pm_freq_api
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: gem_exec_fence
Done.