[93.503272] Initializing watchdogs
[93.503481]   /dev/watchdog0
[93.542232] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[93.557954] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[93.564715] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[93.569751] [001/133] (960s left) gem_eio (banned)
[93.729934] Starting subtest: banned
[93.925105] Subtest banned: SUCCESS (0.199s)
[94.160679] [002/133] (959s left) perf (mi-rpc)
[94.386135] Starting subtest: mi-rpc
[94.413921] Subtest mi-rpc: SUCCESS (0.030s)
[94.501771] [003/133] (959s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[94.686101] Starting subtest: compare-crc-sanitycheck-xr24
[94.696114] Starting dynamic subtest: pipe-A-HDMI-A-1
[95.610843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.916s)
[95.636880] Starting dynamic subtest: pipe-B-HDMI-A-2
[96.205523] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.591s)
[96.234290] Starting dynamic subtest: pipe-C-HDMI-A-1
[96.789341] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.577s)
[96.791800] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.106s)
[97.108557] [004/133] (957s left) gem_cs_tlb (engines)
[97.230621] Starting subtest: engines
[97.231714] Starting dynamic subtest: rcs0
[99.394177] Dynamic subtest rcs0: SUCCESS (2.159s)
[99.418482] Starting dynamic subtest: bcs0
[101.549484] Dynamic subtest bcs0: SUCCESS (2.158s)
[101.568955] Starting dynamic subtest: vcs0
[103.710156] Dynamic subtest vcs0: SUCCESS (2.157s)
[103.734351] Starting dynamic subtest: vecs0
[105.868218] Dynamic subtest vecs0: SUCCESS (2.155s)
[105.870364] Subtest engines: SUCCESS (8.634s)
[105.995305] [005/133] (948s left) sw_sync (sync_multi_timeline_wait)
[106.095719] Starting subtest: sync_multi_timeline_wait
[106.097596] Subtest sync_multi_timeline_wait: SUCCESS (0.002s)
[106.211335] [006/133] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[106.428818] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[106.430935] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[106.559425] [007/133] (947s left) gem_fence_thrash (bo-write-verify-threaded-y)
[106.660432] Starting subtest: bo-write-verify-threaded-y
[111.077918] Subtest bo-write-verify-threaded-y: SUCCESS (4.416s)
[111.216443] [008/133] (943s left) kms_psr (pr-suspend)
[111.403249] Subtest pr-suspend: SKIP (0.000s)
[111.497535] [009/133] (943s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[111.611168] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[111.614175] Starting dynamic subtest: smem
[111.973481] Dynamic subtest smem: SUCCESS (0.353s)
[111.974564] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.354s)
[112.243506] [010/133] (942s left) kms_plane_multiple (tiling-y)
[112.419155] Starting subtest: tiling-y
[112.421081] Starting dynamic subtest: pipe-A-HDMI-A-1
[114.448854] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.028s)
[114.491655] Starting dynamic subtest: pipe-A-HDMI-A-2
[116.363734] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.911s)
[116.391295] Starting dynamic subtest: pipe-B-HDMI-A-1
[118.092540] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.727s)
[118.132129] Starting dynamic subtest: pipe-B-HDMI-A-2
[119.941177] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.844s)
[119.988634] Starting dynamic subtest: pipe-C-HDMI-A-1
[121.724766] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.783s)
[121.776412] Starting dynamic subtest: pipe-C-HDMI-A-2
[123.558899] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.826s)
[123.560130] Subtest tiling-y: SUCCESS (11.142s)
[123.855120] [011/133] (931s left) i915_selftest (live)
[125.316654] Starting subtest: live
[125.317664] Starting dynamic subtest: sanitycheck
[128.013841] Dynamic subtest sanitycheck: SUCCESS (2.695s)
[128.031975] Starting dynamic subtest: uncore
[130.369221] Dynamic subtest uncore: SUCCESS (2.353s)
[130.389341] Starting dynamic subtest: workarounds
[133.116601] Dynamic subtest workarounds: SUCCESS (2.746s)
[133.136301] Starting dynamic subtest: gt_engines
[136.120041] Dynamic subtest gt_engines: SUCCESS (3.001s)
[136.140331] Starting dynamic subtest: gt_timelines
[151.973501] Dynamic subtest gt_timelines: SUCCESS (15.850s)
[151.993928] Starting dynamic subtest: gt_contexts
[154.443371] Dynamic subtest gt_contexts: SUCCESS (2.465s)
[154.463385] Starting dynamic subtest: gt_lrc
[159.404875] Dynamic subtest gt_lrc: SUCCESS (4.960s)
[159.425156] Starting dynamic subtest: gt_mocs
[161.905989] Dynamic subtest gt_mocs: SUCCESS (2.498s)
[161.927368] Starting dynamic subtest: gt_pm
[173.068453] Dynamic subtest gt_pm: SUCCESS (11.156s)
[173.087395] Starting dynamic subtest: gt_heartbeat
[175.493797] Dynamic subtest gt_heartbeat: SUCCESS (2.422s)
[175.511781] Starting dynamic subtest: gt_tlb
[179.453796] Dynamic subtest gt_tlb: SUCCESS (3.957s)
[179.473471] Starting dynamic subtest: requests
[188.491298] Dynamic subtest requests: SUCCESS (9.034s)
[188.510074] Starting dynamic subtest: migrate
[193.873063] Dynamic subtest migrate: SUCCESS (5.379s)
[193.896177] Starting dynamic subtest: active
[196.611965] Dynamic subtest active: SUCCESS (2.736s)
[196.633136] Starting dynamic subtest: objects
[201.050545] Dynamic subtest objects: SUCCESS (4.436s)
[201.071425] Starting dynamic subtest: mman
[208.840276] Dynamic subtest mman: SUCCESS (7.786s)
[208.857902] Starting dynamic subtest: dmabuf
[211.252865] Dynamic subtest dmabuf: SUCCESS (2.410s)
[211.274335] Starting dynamic subtest: vma
[213.829713] Dynamic subtest vma: SUCCESS (2.574s)
[213.851309] Starting dynamic subtest: coherency
[218.861122] Dynamic subtest coherency: SUCCESS (5.028s)
[218.881337] Starting dynamic subtest: gtt
[228.962188] Dynamic subtest gtt: SUCCESS (10.099s)
[228.981952] Starting dynamic subtest: gem
[231.960059] Dynamic subtest gem: SUCCESS (2.994s)
[232.003110] Starting dynamic subtest: evict
[237.426772] Dynamic subtest evict: SUCCESS (5.463s)
[237.448068] Starting dynamic subtest: hugepages
[246.242688] Dynamic subtest hugepages: SUCCESS (8.812s)
[246.264336] Starting dynamic subtest: gem_contexts
[266.401058] Dynamic subtest gem_contexts: SUCCESS (20.155s)
[266.422546] Starting dynamic subtest: client
[269.154389] Dynamic subtest client: SUCCESS (2.749s)
[269.174343] Starting dynamic subtest: gem_migrate
[271.759534] Dynamic subtest gem_migrate: SUCCESS (2.604s)
[271.778998] Starting dynamic subtest: reset
[278.029711] Dynamic subtest reset: SUCCESS (6.266s)
[278.050367] Starting dynamic subtest: memory_region
[280.481655] Dynamic subtest memory_region: SUCCESS (2.447s)
[280.501352] Starting dynamic subtest: hangcheck
[306.129934] Dynamic subtest hangcheck: SUCCESS (25.648s)
[306.152160] Starting dynamic subtest: execlists
[318.042835] Dynamic subtest execlists: SUCCESS (11.908s)
[318.062780] Starting dynamic subtest: ring_submission
[320.458917] Dynamic subtest ring_submission: SUCCESS (2.412s)
[320.481399] Starting dynamic subtest: perf
[323.290469] Dynamic subtest perf: SUCCESS (2.826s)
[323.310314] Starting dynamic subtest: slpc
[325.858621] Dynamic subtest slpc: SUCCESS (2.567s)
[325.883313] Starting dynamic subtest: guc
[328.298287] Dynamic subtest guc: SUCCESS (2.437s)
[328.321286] Starting dynamic subtest: guc_multi_lrc
[330.781960] Dynamic subtest guc_multi_lrc: SUCCESS (2.480s)
[330.804064] Starting dynamic subtest: guc_hang
[333.199381] Dynamic subtest guc_hang: SUCCESS (2.414s)
[333.219909] Starting dynamic subtest: late_gt_pm
[335.843636] Dynamic subtest late_gt_pm: SUCCESS (2.640s)
[335.846907] Subtest live: SUCCESS (210.521s)
[335.906572] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[335.910641] [012/133] (719s left) gem_exec_schedule (deep)
[338.897046] Starting subtest: deep
[338.898192] Starting dynamic subtest: rcs0
[352.267555] Dynamic subtest rcs0: SUCCESS (13.358s)
[352.317370] Starting dynamic subtest: bcs0
[367.029036] Dynamic subtest bcs0: SUCCESS (14.736s)
[367.094045] Starting dynamic subtest: vcs0
[381.168079] Dynamic subtest vcs0: SUCCESS (14.119s)
[381.206107] Starting dynamic subtest: vecs0
[395.084759] Dynamic subtest vecs0: SUCCESS (13.899s)
[395.092603] Subtest deep: SUCCESS (56.191s)
[395.944959] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.i915: true
[395.946697] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[395.950889] [013/133] (659s left) gem_exec_flush (basic-wb-rw-before-default)
[396.086143] Starting subtest: basic-wb-rw-before-default
[401.504218] Subtest basic-wb-rw-before-default: SUCCESS (5.418s)
[401.772191] [014/133] (653s left) gem_exec_reloc (basic-gtt)
[401.883345] Starting subtest: basic-gtt
[401.902578] Subtest basic-gtt: SUCCESS (0.020s)
[402.120963] [015/133] (653s left) prime_mmap_coherency (write)
[402.235872] Starting subtest: write
[407.615880] Subtest write: SUCCESS (5.382s)
[407.790265] [016/133] (647s left) gem_ctx_persistence (idempotent)
[407.896990] Starting subtest: idempotent
[407.897973] Subtest idempotent: SUCCESS (0.000s)
[408.082899] [017/133] (647s left) dmabuf_sync_file (export-multiwait)
[408.204212] Starting subtest: export-multiwait
[408.208030] Subtest export-multiwait: SUCCESS (0.004s)
[408.337849] [018/133] (647s left) i915_drm_fdinfo (memory-info-purgeable)
[408.448794] Starting subtest: memory-info-purgeable
[408.450422] Starting dynamic subtest: smem0
[409.531599] Dynamic subtest smem0: SUCCESS (1.088s)
[409.537060] Subtest memory-info-purgeable: SUCCESS (1.090s)
[409.673358] [019/133] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[409.886251] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[409.889711] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[410.038823] [020/133] (645s left) gem_exec_schedule (semaphore-power)
[410.294907] Starting subtest: semaphore-power
[411.176163] Subtest semaphore-power: SUCCESS (0.875s)
[411.442499] [021/133] (644s left) gem_eio (context-create)
[411.583182] Starting subtest: context-create
[411.644984] Subtest context-create: SUCCESS (0.065s)
[411.929259] [022/133] (643s left) kms_universal_plane (universal-plane-pageflip-windowed)
[412.130282] Starting subtest: universal-plane-pageflip-windowed
[412.138112] Starting dynamic subtest: pipe-A-HDMI-A-1
[412.989994] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.854s)
[413.037533] Starting dynamic subtest: pipe-B-HDMI-A-2
[413.534015] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.534s)
[413.563048] Starting dynamic subtest: pipe-C-HDMI-A-1
[414.055869] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.515s)
[414.058130] Subtest universal-plane-pageflip-windowed: SUCCESS (1.927s)
[414.379657] [023/133] (641s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[414.602083] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[416.206310] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.603s)
[416.503046] [024/133] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[416.714597] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[419.272979] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.557s)
[419.567254] [025/133] (636s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[419.752091] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[419.856129] [026/133] (636s left) kms_flip (2x-flip-vs-panning-interruptible)
[420.062152] Starting subtest: 2x-flip-vs-panning-interruptible
[420.068909] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[430.871167] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.800s)
[430.898747] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[441.597498] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.718s)
[441.626741] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[452.320753] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.717s)
[452.330211] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (32.261s)
[452.946923] [027/133] (603s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[453.148719] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[455.805071] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SUCCESS (2.654s)
[456.014385] [028/133] (600s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[456.213064] Starting subtest: flip-vs-cursor-atomic-transitions
[471.244246] Subtest flip-vs-cursor-atomic-transitions: FAIL (14.746s)
[471.333303] [029/133] (585s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[471.532390] Starting subtest: bad-aux-stride-y-tiled-ccs
[471.534468] Starting dynamic subtest: pipe-A-HDMI-A-1
[471.549223] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.003s)
[471.594025] Starting dynamic subtest: pipe-A-HDMI-A-2
[471.618151] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[471.657132] Starting dynamic subtest: pipe-B-HDMI-A-1
[471.680384] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[471.719179] Starting dynamic subtest: pipe-B-HDMI-A-2
[471.740358] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.005s)
[471.762074] Starting dynamic subtest: pipe-C-HDMI-A-1
[471.770201] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[471.791899] Starting dynamic subtest: pipe-C-HDMI-A-2
[471.801852] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[471.802665] Subtest bad-aux-stride-y-tiled-ccs: SUCCESS (0.063s)
[472.615520] [030/133] (583s left) kms_color (invalid-degamma-lut-sizes)
[472.811250] Starting subtest: invalid-degamma-lut-sizes
[472.814481] Starting dynamic subtest: pipe-A
[473.175995] Dynamic subtest pipe-A: SUCCESS (0.372s)
[473.201117] Starting dynamic subtest: pipe-B
[473.206409] Dynamic subtest pipe-B: SUCCESS (0.004s)
[473.232380] Starting dynamic subtest: pipe-C
[473.239186] Dynamic subtest pipe-C: SUCCESS (0.004s)
[473.244363] Subtest invalid-degamma-lut-sizes: SUCCESS (0.395s)
[473.499239] [031/133] (583s left) gem_render_copy (linear-to-vebox-yf-tiled)
[473.624581] Starting subtest: linear-to-vebox-yf-tiled
[473.626524] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[473.913990] [032/133] (582s left) gem_exec_params (invalid-fence-in)
[474.030470] Starting subtest: invalid-fence-in
[474.033136] Subtest invalid-fence-in: SUCCESS (0.001s)
[474.181536] [033/133] (582s left) gem_exec_schedule (preempt-hang)
[474.430920] Starting subtest: preempt-hang
[474.433970] Starting dynamic subtest: rcs0
[474.702977] Dynamic subtest rcs0: SUCCESS (0.266s)
[474.730090] Starting dynamic subtest: bcs0
[474.977531] Dynamic subtest bcs0: SUCCESS (0.277s)
[475.008737] Starting dynamic subtest: vcs0
[475.238591] Dynamic subtest vcs0: SUCCESS (0.255s)
[475.270066] Starting dynamic subtest: vecs0
[475.493162] Dynamic subtest vecs0: SUCCESS (0.253s)
[475.502925] Subtest preempt-hang: SUCCESS (1.068s)
[475.781563] [034/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[475.979083] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[475.983173] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[476.143782] [035/133] (580s left) kms_psr (fbc-pr-cursor-render)
[476.322085] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[476.435972] [036/133] (580s left) gem_mmap_gtt (flink-race)
[476.545227] Starting subtest: flink-race
[496.616749] Subtest flink-race: SUCCESS (20.077s)
[496.783355] [037/133] (560s left) kms_concurrent (multi-plane-atomic-lowres)
[496.969052] Starting subtest: multi-plane-atomic-lowres
[496.971142] Starting dynamic subtest: pipe-A-HDMI-A-1
[497.996640] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.028s)
[498.038097] Starting dynamic subtest: pipe-A-HDMI-A-2
[498.810326] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.806s)
[498.865296] Starting dynamic subtest: pipe-B-HDMI-A-1
[499.580806] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.765s)
[499.641077] Starting dynamic subtest: pipe-B-HDMI-A-2
[500.329069] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.740s)
[500.359537] Starting dynamic subtest: pipe-C-HDMI-A-1
[501.167717] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.831s)
[501.209884] Starting dynamic subtest: pipe-C-HDMI-A-2
[501.934951] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.760s)
[501.936336] Subtest multi-plane-atomic-lowres: SUCCESS (4.971s)
[502.289234] [038/133] (555s left) kms_big_fb (linear-8bpp-rotate-90)
[502.516332] Starting subtest: linear-8bpp-rotate-90
[502.859134] Subtest linear-8bpp-rotate-90: SKIP (0.344s)
[503.093811] [039/133] (554s left) api_intel_bb (render)
[503.208266] Starting subtest: render
[503.212251] Starting dynamic subtest: render-none-512
[503.320573] Dynamic subtest render-none-512: SUCCESS (0.113s)
[503.359922] Starting dynamic subtest: render-none-reloc-512
[503.444243] Dynamic subtest render-none-reloc-512: SUCCESS (0.116s)
[503.471736] Starting dynamic subtest: render-none-1024
[503.824408] Dynamic subtest render-none-1024: SUCCESS (0.374s)
[503.846781] Starting dynamic subtest: render-none-reloc-1024
[504.198389] Dynamic subtest render-none-reloc-1024: SUCCESS (0.369s)
[504.220751] Starting dynamic subtest: render-x-512
[504.288926] Dynamic subtest render-x-512: SUCCESS (0.091s)
[504.316352] Starting dynamic subtest: render-x-reloc-512
[504.379838] Dynamic subtest render-x-reloc-512: SUCCESS (0.087s)
[504.403562] Starting dynamic subtest: render-x-1024
[504.706328] Dynamic subtest render-x-1024: SUCCESS (0.320s)
[504.729071] Starting dynamic subtest: render-x-reloc-1024
[505.031828] Dynamic subtest render-x-reloc-1024: SUCCESS (0.325s)
[505.059189] Starting dynamic subtest: render-y-512
[505.127075] Dynamic subtest render-y-512: SUCCESS (0.091s)
[505.156186] Starting dynamic subtest: render-y-reloc-512
[505.215167] Dynamic subtest render-y-reloc-512: SUCCESS (0.085s)
[505.241834] Starting dynamic subtest: render-y-1024
[505.541226] Dynamic subtest render-y-1024: SUCCESS (0.320s)
[505.564627] Starting dynamic subtest: render-y-reloc-1024
[505.868699] Dynamic subtest render-y-reloc-1024: SUCCESS (0.325s)
[505.871810] Subtest render: SUCCESS (2.662s)
[506.023671] [040/133] (551s left) perf (gen12-group-exclusive-stream-sample-oa)
[506.233854] Starting subtest: gen12-group-exclusive-stream-sample-oa
[506.237093] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[506.346590] [041/133] (551s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[506.558058] Starting subtest: pipe-fbc-rte
[506.566811] Subtest pipe-fbc-rte: SKIP (0.001s)
[506.708900] [042/133] (551s left) kms_plane (plane-position-covered)
[506.901069] Starting subtest: plane-position-covered
[507.694040] Starting dynamic subtest: pipe-A-plane-1
[508.240073] Dynamic subtest pipe-A-plane-1: SUCCESS (0.551s)
[508.290478] Starting dynamic subtest: pipe-A-plane-2
[508.801506] Dynamic subtest pipe-A-plane-2: SUCCESS (0.556s)
[508.851217] Starting dynamic subtest: pipe-A-plane-3
[509.353438] Dynamic subtest pipe-A-plane-3: SUCCESS (0.543s)
[509.378453] Starting dynamic subtest: pipe-A-plane-4
[509.380278] Dynamic subtest pipe-A-plane-4: SUCCESS (0.007s)
[509.879232] Starting dynamic subtest: pipe-B-plane-1
[510.344070] Dynamic subtest pipe-B-plane-1: SUCCESS (0.507s)
[510.391404] Starting dynamic subtest: pipe-B-plane-2
[510.913226] Dynamic subtest pipe-B-plane-2: SUCCESS (0.560s)
[510.958135] Starting dynamic subtest: pipe-B-plane-3
[511.471747] Dynamic subtest pipe-B-plane-3: SUCCESS (0.558s)
[511.530440] Starting dynamic subtest: pipe-B-plane-4
[511.536464] Dynamic subtest pipe-B-plane-4: SUCCESS (0.011s)
[511.539443] Subtest plane-position-covered: SUCCESS (4.589s)
[511.866682] [043/133] (545s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[511.981225] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[511.984142] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[512.135366] [044/133] (545s left) gem_busy (close-race)
[512.261219] Starting subtest: close-race
[535.294843] Subtest close-race: SUCCESS (23.033s)
[535.694351] [045/133] (522s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[535.991412] Starting subtest: addfb25-x-tiled-mismatch-legacy
[535.992648] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[536.151291] [046/133] (521s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[536.361375] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[536.364458] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[536.517794] [047/133] (521s left) kms_cursor_edge_walk (128x128-right-edge)
[536.698077] Starting subtest: 128x128-right-edge
[536.700523] Starting dynamic subtest: pipe-A-HDMI-A-1
[540.592370] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.893s)
[540.638872] Starting dynamic subtest: pipe-C-HDMI-A-1
[544.036954] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.436s)
[544.039472] Subtest 128x128-right-edge: SUCCESS (7.340s)
[544.367487] [048/133] (513s left) gem_exec_reloc (basic-softpin)
[544.499994] Starting subtest: basic-softpin
[544.501717] Subtest basic-softpin: SUCCESS (0.005s)
[544.749646] [049/133] (513s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[544.946310] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[544.949915] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[545.112538] [050/133] (513s left) gem_ctx_isolation (dirty-switch)
[545.232576] Starting subtest: dirty-switch
[545.234423] Starting dynamic subtest: rcs0
[545.827371] Dynamic subtest rcs0: SUCCESS (0.590s)
[545.851945] Starting dynamic subtest: bcs0
[546.775471] Dynamic subtest bcs0: SUCCESS (0.948s)
[546.814875] Starting dynamic subtest: vcs0
[547.362424] Dynamic subtest vcs0: SUCCESS (0.578s)
[547.390926] Starting dynamic subtest: vecs0
[547.953522] Dynamic subtest vecs0: SUCCESS (0.586s)
[547.957804] Subtest dirty-switch: SUCCESS (2.725s)
[548.249496] [051/133] (510s left) gem_exec_balancer (invalid-bonds)
[548.375337] Starting subtest: invalid-bonds
[548.383830] Subtest invalid-bonds: SUCCESS (0.009s)
[548.683437] [052/133] (509s left) gem_exec_reloc (basic-write-wc)
[548.803175] Starting subtest: basic-write-wc
[548.822104] Subtest basic-write-wc: SUCCESS (0.017s)
[549.051181] [053/133] (509s left) i915_pm_rps (basic-api)
[549.173764] Starting subtest: basic-api
[549.183147] Subtest basic-api: SUCCESS (0.011s)
[549.334594] [054/133] (509s left) syncobj_timeline (single-wait-signaled)
[549.448216] Starting subtest: single-wait-signaled
[549.450134] Subtest single-wait-signaled: SUCCESS (0.002s)
[549.602544] [055/133] (509s left) kms_addfb_basic (size-max)
[549.800213] Starting subtest: size-max
[549.802031] Subtest size-max: SUCCESS (0.001s)
[549.952535] [056/133] (509s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[550.174109] Starting subtest: yf-tiled-32bpp-rotate-90
[555.788307] Subtest yf-tiled-32bpp-rotate-90: SUCCESS (5.614s)
[556.183556] [057/133] (502s left) syncobj_wait (invalid-reset-illegal-handle)
[556.290142] Starting subtest: invalid-reset-illegal-handle
[556.291880] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[556.436679] [058/133] (502s left) gem_lmem_swapping (basic)
[556.555220] Subtest basic: SKIP (0.000s)
[556.674296] [059/133] (502s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[556.870361] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[568.210384] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.339s)
[568.592541] [060/133] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[568.817647] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[568.822119] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[568.979222] [061/133] (490s left) kms_display_modes (extended-mode-basic)
[569.179061] Starting subtest: extended-mode-basic
[569.186566] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[570.256062] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.069s)
[570.313108] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[571.662465] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.393s)
[571.708184] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[572.928265] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.256s)
[572.967114] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[574.232110] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.289s)
[574.275884] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[575.506287] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.272s)
[575.566182] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[576.614075] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.093s)
[576.668321] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[578.042201] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.418s)
[578.074249] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[579.317056] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.265s)
[579.372373] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[580.575733] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.245s)
[580.606831] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[582.041355] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.452s)
[582.104550] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[583.446093] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.392s)
[583.493516] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[584.793569] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.342s)
[584.795979] Subtest extended-mode-basic: SUCCESS (15.619s)
[585.174392] [062/133] (474s left) gem_exec_fence (long-history)
[585.814082] Starting subtest: long-history
[591.595899] Subtest long-history: SUCCESS (5.760s)
[592.341407] [063/133] (467s left) vgem_basic (bad-fence)
[592.471090] Starting subtest: bad-fence
[592.474425] Subtest bad-fence: SUCCESS (0.000s)
[592.606272] [064/133] (467s left) kms_chamelium_edid (hdmi-mode-timings)
[593.168064] Subtest hdmi-mode-timings: SKIP (0.000s)
[593.473951] [065/133] (466s left) syncobj_timeline (invalid-wait-illegal-handle)
[593.588318] Starting subtest: invalid-wait-illegal-handle
[593.591234] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[593.740488] [066/133] (466s left) kms_psr (fbc-psr2-cursor-blt)
[593.940281] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[594.048623] [067/133] (466s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[594.274049] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[594.515438] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.245s)
[594.787513] [068/133] (465s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[594.988191] Starting subtest: cursor-rapid-movement-32x32
[595.280109] Subtest cursor-rapid-movement-32x32: SKIP (0.291s)
[595.442316] [069/133] (464s left) api_intel_allocator (reopen)
[595.553097] Starting subtest: reopen
[595.562251] Subtest reopen: SUCCESS (0.008s)
[595.720167] [070/133] (464s left) gem_exec_parallel (fds)
[595.848885] Starting subtest: fds
[595.857293] Starting dynamic subtest: rcs0
[605.455022] Dynamic subtest rcs0: SUCCESS (9.601s)
[605.483443] Starting dynamic subtest: bcs0
[612.335196] Dynamic subtest bcs0: SUCCESS (6.878s)
[612.361506] Starting dynamic subtest: vcs0
[617.547465] Dynamic subtest vcs0: SUCCESS (5.208s)
[617.573661] Starting dynamic subtest: vecs0
[622.642837] Dynamic subtest vecs0: SUCCESS (5.092s)
[622.645569] Subtest fds: SUCCESS (26.796s)
[622.928422] [071/133] (437s left) gem_exec_whisper (basic-fds-all)
[623.057695] Starting subtest: basic-fds-all
[637.095222] Subtest basic-fds-all: SUCCESS (14.037s)
[637.376506] [072/133] (423s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[637.586402] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[637.590108] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.001s)
[637.744124] [073/133] (422s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[637.954221] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[637.957634] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[638.105324] [074/133] (422s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[638.322153] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[638.324392] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[638.475657] [075/133] (422s left) kms_psr (fbc-psr-primary-page-flip)
[638.667321] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[638.783272] [076/133] (422s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[638.964264] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[638.967907] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[639.107393] [077/133] (422s left) kms_chamelium_color (ctm-green-to-red)
[639.296519] Subtest ctm-green-to-red: SKIP (0.000s)
[639.414371] [078/133] (421s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[640.034751] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[640.343353] [079/133] (420s left) perf_pmu (init-busy)
[640.460321] Starting subtest: init-busy
[640.464504] Starting dynamic subtest: rcs0
[640.465676] Dynamic subtest rcs0: SUCCESS (0.002s)
[640.504177] Starting dynamic subtest: bcs0
[640.506655] Dynamic subtest bcs0: SUCCESS (0.002s)
[640.529429] Starting dynamic subtest: vcs0
[640.530587] Dynamic subtest vcs0: SUCCESS (0.002s)
[640.554139] Starting dynamic subtest: vecs0
[640.555231] Dynamic subtest vecs0: SUCCESS (0.002s)
[640.556321] Subtest init-busy: SUCCESS (0.020s)
[640.642919] [080/133] (420s left) sw_sync (sync_merge_invalid)
[640.747044] Starting subtest: sync_merge_invalid
[640.753892] Subtest sync_merge_invalid: SUCCESS (0.006s)
[640.872146] [081/133] (420s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[641.052497] Starting subtest: modeset-transition-nonblocking-fencing
[641.057196] Starting dynamic subtest: 1x-outputs
[644.576296] Dynamic subtest 1x-outputs: SUCCESS (3.519s)
[644.602231] Starting dynamic subtest: 2x-outputs
[651.938650] Dynamic subtest 2x-outputs: SUCCESS (7.356s)
[651.940953] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.884s)
[652.297296] [082/133] (409s left) gem_softpin (evict-prime-sanity-check)
[652.421468] Starting subtest: evict-prime-sanity-check
[652.422776] Starting dynamic subtest: rcs0
[653.518024] Dynamic subtest rcs0: SUCCESS (1.094s)
[653.549222] Starting dynamic subtest: bcs0
[654.626317] Dynamic subtest bcs0: SUCCESS (1.108s)
[654.658143] Starting dynamic subtest: vcs0
[655.732330] Dynamic subtest vcs0: SUCCESS (1.102s)
[655.767557] Starting dynamic subtest: vecs0
[656.837936] Dynamic subtest vecs0: SUCCESS (1.102s)
[656.866613] Starting dynamic subtest: all
[657.939998] Dynamic subtest all: SUCCESS (1.097s)
[657.943554] Subtest evict-prime-sanity-check: SUCCESS (5.522s)
[658.131197] [083/133] (403s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[658.242826] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[658.344652] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[658.513102] [084/133] (403s left) kms_frontbuffer_tracking (fbc-stridechange)
[658.704591] Starting subtest: fbc-stridechange
[660.769486] Subtest fbc-stridechange: SUCCESS (2.064s)
[661.051288] [085/133] (400s left) kms_fbcon_fbt (fbc)
[661.165816] Starting subtest: fbc
[665.421996] Subtest fbc: SUCCESS (4.254s)
[665.536143] [086/133] (396s left) sriov_basic (enable-vfs-bind-unbind-each)
[665.635637] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[665.741515] [087/133] (396s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[665.953447] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[668.937718] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.985s)
[669.285364] [088/133] (392s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[669.506270] Starting subtest: yf-tiled-32bpp-rotate-0
[674.538528] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.037s)
[674.997718] [089/133] (387s left) prime_vgem (fence-flip-hang)
[675.127329] Subtest fence-flip-hang: SKIP (0.000s)
[675.285795] [090/133] (387s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[675.480192] Starting subtest: cursor-vs-flip-varying-size
[721.628662] Subtest cursor-vs-flip-varying-size: SUCCESS (46.147s)
[722.030175] [091/133] (340s left) gem_vm_create (invalid-create)
[722.148254] Starting subtest: invalid-create
[722.150188] Subtest invalid-create: SUCCESS (0.001s)
[722.295448] [092/133] (340s left) gem_ccs (block-multicopy-compressed)
[722.407803] Subtest block-multicopy-compressed: SKIP (0.000s)
[722.519333] [093/133] (340s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[722.706078] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[722.708111] Starting dynamic subtest: pipe-A-valid-mode
[723.859848] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.146s)
[723.861149] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (1.152s)
[724.217580] [094/133] (338s left) gem_partial_pwrite_pread (writes-after-reads)
[724.337047] Starting subtest: writes-after-reads
[745.263372] Subtest writes-after-reads: SUCCESS (20.928s)
[745.444562] [095/133] (317s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[745.551084] Starting subtest: etime-multi-wait-all-for-submit-submitted
[745.657614] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[745.816333] [096/133] (317s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[746.025663] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[748.456032] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.428s)
[748.761932] [097/133] (314s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[748.943186] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[795.525592] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (46.581s)
[795.940177] [098/133] (267s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[796.138182] Starting subtest: addfb25-framebuffer-vs-set-tiling
[796.140587] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[796.293691] [099/133] (266s left) gem_mmap (basic-small-bo)
[796.396266] Starting subtest: basic-small-bo
[796.908468] Subtest basic-small-bo: SUCCESS (0.515s)
[797.079154] [100/133] (266s left) kms_psr (psr-primary-mmap-cpu)
[797.401085] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[797.514197] [101/133] (265s left) kms_prop_blob (blob-prop-core)
[797.615315] Starting subtest: blob-prop-core
[797.618450] Subtest blob-prop-core: SUCCESS (0.000s)
[797.763390] [102/133] (265s left) kms_hdr (bpc-switch)
[797.942395] Starting subtest: bpc-switch
[826.528367] Subtest bpc-switch: SKIP (28.582s)
[827.033409] [103/133] (236s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[827.252064] Starting subtest: crc-primary-basic-y-tiled-ccs
[827.255960] Starting dynamic subtest: pipe-A-HDMI-A-1
[827.821469] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.567s)
[827.847725] Starting dynamic subtest: pipe-A-HDMI-A-2
[828.274144] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.448s)
[828.324178] Starting dynamic subtest: pipe-B-HDMI-A-1
[828.757201] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.478s)
[828.781411] Starting dynamic subtest: pipe-B-HDMI-A-2
[829.184305] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.422s)
[829.212175] Starting dynamic subtest: pipe-C-HDMI-A-1
[829.227412] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[829.278150] Starting dynamic subtest: pipe-C-HDMI-A-2
[829.289669] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[829.290616] Subtest crc-primary-basic-y-tiled-ccs: SUCCESS (1.954s)
[830.084316] [104/133] (233s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[830.281197] Starting subtest: fbc-rgb565-draw-mmap-wc
[833.025689] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.746s)
[833.317520] [105/133] (230s left) gem_mmap_wc (invalid-flags)
[833.423294] Starting subtest: invalid-flags
[833.426231] Subtest invalid-flags: SUCCESS (0.000s)
[833.575225] [106/133] (230s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[833.787135] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[833.789316] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[833.941233] [107/133] (230s left) i915_hangman (error-state-basic)
[834.084081] Starting subtest: error-state-basic
[834.099389] Subtest error-state-basic: SUCCESS (0.011s)
[834.286324] [108/133] (229s left) kms_vblank (ts-continuation-suspend)
[834.464423] Starting subtest: ts-continuation-suspend
[834.474147] Starting dynamic subtest: pipe-A-HDMI-A-1
[852.146618] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.596s)
[852.279366] Starting dynamic subtest: pipe-A-HDMI-A-2