[88.969542] Initializing watchdogs
[88.969736]   /dev/watchdog0
[89.008465] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.023569] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.030755] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.038986] [001/133] (960s left) gem_eio (banned)
[89.203396] Starting subtest: banned
[89.337072] Subtest banned: SUCCESS (0.140s)
[89.579597] [002/133] (960s left) perf (mi-rpc)
[89.797113] Starting subtest: mi-rpc
[89.828652] Subtest mi-rpc: SUCCESS (0.030s)
[89.929037] [003/133] (959s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[90.111070] Starting subtest: compare-crc-sanitycheck-xr24
[90.118273] Starting dynamic subtest: pipe-A-HDMI-A-1
[91.012928] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.895s)
[91.065467] Starting dynamic subtest: pipe-B-HDMI-A-2
[91.578757] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.558s)
[91.606443] Starting dynamic subtest: pipe-C-HDMI-A-1
[92.163521] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.572s)
[92.168463] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.043s)
[92.431036] [004/133] (957s left) gem_cs_tlb (engines)
[92.554071] Starting subtest: engines
[92.559067] Starting dynamic subtest: rcs0
[94.719740] Dynamic subtest rcs0: SUCCESS (2.156s)
[94.742987] Starting dynamic subtest: bcs0
[96.880635] Dynamic subtest bcs0: SUCCESS (2.157s)
[96.903274] Starting dynamic subtest: vcs0
[99.036785] Dynamic subtest vcs0: SUCCESS (2.157s)
[99.061484] Starting dynamic subtest: vecs0
[101.195682] Dynamic subtest vecs0: SUCCESS (2.155s)
[101.200248] Subtest engines: SUCCESS (8.627s)
[101.338848] [005/133] (948s left) sw_sync (sync_multi_timeline_wait)
[101.453888] Starting subtest: sync_multi_timeline_wait
[101.457752] Subtest sync_multi_timeline_wait: SUCCESS (0.003s)
[101.571572] [006/133] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[101.767451] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[101.804154] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[101.908077] [007/133] (948s left) gem_fence_thrash (bo-write-verify-threaded-y)
[102.020128] Starting subtest: bo-write-verify-threaded-y
[106.801654] Subtest bo-write-verify-threaded-y: SUCCESS (4.786s)
[106.940946] [008/133] (943s left) kms_psr (pr-suspend)
[107.130028] Subtest pr-suspend: SKIP (0.000s)
[107.237265] [009/133] (943s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[107.365304] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[107.368522] Starting dynamic subtest: smem
[107.715332] Dynamic subtest smem: SUCCESS (0.349s)
[107.719068] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.350s)
[107.994631] [010/133] (942s left) kms_plane_multiple (tiling-y)
[108.185084] Starting subtest: tiling-y
[108.190098] Starting dynamic subtest: pipe-A-HDMI-A-1
[110.153315] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.967s)
[110.181780] Starting dynamic subtest: pipe-A-HDMI-A-2
[112.089095] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.933s)
[112.119326] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.896170] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.807s)
[113.936269] Starting dynamic subtest: pipe-B-HDMI-A-2
[115.733299] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.829s)
[115.764050] Starting dynamic subtest: pipe-C-HDMI-A-1
[117.566680] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.830s)
[117.592157] Starting dynamic subtest: pipe-C-HDMI-A-2
[119.390123] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.817s)
[119.396090] Subtest tiling-y: SUCCESS (11.204s)
[119.714534] [011/133] (930s left) i915_selftest (live)
[121.586274] Starting subtest: live
[121.591128] Starting dynamic subtest: sanitycheck
[124.015260] Dynamic subtest sanitycheck: SUCCESS (2.428s)
[124.036199] Starting dynamic subtest: uncore
[126.633254] Dynamic subtest uncore: SUCCESS (2.614s)
[126.654392] Starting dynamic subtest: workarounds
[129.502662] Dynamic subtest workarounds: SUCCESS (2.867s)
[129.522647] Starting dynamic subtest: gt_engines
[132.325424] Dynamic subtest gt_engines: SUCCESS (2.825s)
[132.346305] Starting dynamic subtest: gt_timelines
[148.333493] Dynamic subtest gt_timelines: SUCCESS (16.008s)
[148.353361] Starting dynamic subtest: gt_contexts
[150.946121] Dynamic subtest gt_contexts: SUCCESS (2.609s)
[150.968803] Starting dynamic subtest: gt_lrc
[156.247235] Dynamic subtest gt_lrc: SUCCESS (5.299s)
[156.270123] Starting dynamic subtest: gt_mocs
[158.975852] Dynamic subtest gt_mocs: SUCCESS (2.725s)
[159.010892] Starting dynamic subtest: gt_pm
[169.115534] Dynamic subtest gt_pm: SUCCESS (10.292s)
[169.137382] Starting dynamic subtest: gt_heartbeat
[171.771580] Dynamic subtest gt_heartbeat: SUCCESS (2.670s)
[171.791989] Starting dynamic subtest: gt_tlb
[175.797837] Dynamic subtest gt_tlb: SUCCESS (4.042s)
[175.819439] Starting dynamic subtest: requests
[184.895055] Dynamic subtest requests: SUCCESS (9.114s)
[184.916256] Starting dynamic subtest: migrate
[190.231070] Dynamic subtest migrate: SUCCESS (5.339s)
[190.251196] Starting dynamic subtest: active
[192.911290] Dynamic subtest active: SUCCESS (2.656s)
[192.933484] Starting dynamic subtest: objects
[197.424553] Dynamic subtest objects: SUCCESS (4.425s)
[197.445133] Starting dynamic subtest: mman
[205.378730] Dynamic subtest mman: SUCCESS (7.881s)
[205.401386] Starting dynamic subtest: dmabuf
[208.051421] Dynamic subtest dmabuf: SUCCESS (2.657s)
[208.073429] Starting dynamic subtest: vma
[210.529772] Dynamic subtest vma: SUCCESS (2.460s)
[210.549716] Starting dynamic subtest: coherency
[215.434140] Dynamic subtest coherency: SUCCESS (4.897s)
[215.457356] Starting dynamic subtest: gtt
[225.797807] Dynamic subtest gtt: SUCCESS (10.352s)
[225.818254] Starting dynamic subtest: gem
[228.621754] Dynamic subtest gem: SUCCESS (2.821s)
[228.642276] Starting dynamic subtest: evict
[234.039324] Dynamic subtest evict: SUCCESS (5.412s)
[234.063191] Starting dynamic subtest: hugepages
[243.129887] Dynamic subtest hugepages: SUCCESS (9.086s)
[243.153395] Starting dynamic subtest: gem_contexts
[263.585905] Dynamic subtest gem_contexts: SUCCESS (20.447s)
[263.607505] Starting dynamic subtest: client
[266.137078] Dynamic subtest client: SUCCESS (2.547s)
[266.157418] Starting dynamic subtest: gem_migrate
[268.562278] Dynamic subtest gem_migrate: SUCCESS (2.412s)
[268.582578] Starting dynamic subtest: reset
[274.800397] Dynamic subtest reset: SUCCESS (6.242s)
[274.822396] Starting dynamic subtest: memory_region
[277.459433] Dynamic subtest memory_region: SUCCESS (2.655s)
[277.481349] Starting dynamic subtest: hangcheck
[303.098098] Dynamic subtest hangcheck: SUCCESS (25.626s)
[303.137852] Starting dynamic subtest: execlists
[314.943639] Dynamic subtest execlists: SUCCESS (11.854s)
[314.965297] Starting dynamic subtest: ring_submission
[317.508839] Dynamic subtest ring_submission: SUCCESS (2.562s)
[317.530497] Starting dynamic subtest: perf
[320.105193] Dynamic subtest perf: SUCCESS (2.593s)
[320.127462] Starting dynamic subtest: slpc
[322.700114] Dynamic subtest slpc: SUCCESS (2.591s)
[322.721368] Starting dynamic subtest: guc
[325.053831] Dynamic subtest guc: SUCCESS (2.350s)
[325.077162] Starting dynamic subtest: guc_multi_lrc
[327.751474] Dynamic subtest guc_multi_lrc: SUCCESS (2.694s)
[327.773121] Starting dynamic subtest: guc_hang
[330.192984] Dynamic subtest guc_hang: SUCCESS (2.435s)
[330.213847] Starting dynamic subtest: late_gt_pm
[332.704824] Dynamic subtest late_gt_pm: SUCCESS (2.462s)
[332.782619] Subtest live: SUCCESS (211.060s)
[333.209590] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[333.280442] [012/133] (717s left) gem_exec_schedule (deep)
[336.313206] Starting subtest: deep
[336.319443] Starting dynamic subtest: rcs0
[349.731356] Dynamic subtest rcs0: SUCCESS (13.405s)
[349.800627] Starting dynamic subtest: bcs0
[364.312139] Dynamic subtest bcs0: SUCCESS (14.564s)
[364.391191] Starting dynamic subtest: vcs0
[378.316141] Dynamic subtest vcs0: SUCCESS (13.982s)
[378.418129] Starting dynamic subtest: vecs0
[392.214114] Dynamic subtest vecs0: SUCCESS (13.862s)
[392.223843] Subtest deep: SUCCESS (55.882s)
[393.168207] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.i915: true
[393.170279] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[393.177623] [013/133] (657s left) gem_exec_flush (basic-wb-rw-before-default)
[393.317166] Starting subtest: basic-wb-rw-before-default
[398.722742] Subtest basic-wb-rw-before-default: SUCCESS (5.414s)
[398.996769] [014/133] (652s left) gem_exec_reloc (basic-gtt)
[399.111884] Starting subtest: basic-gtt
[399.134715] Subtest basic-gtt: SUCCESS (0.022s)
[399.383351] [015/133] (651s left) prime_mmap_coherency (write)
[399.506301] Starting subtest: write
[404.897350] Subtest write: SUCCESS (5.388s)
[405.084886] [016/133] (646s left) gem_ctx_persistence (idempotent)
[405.210182] Starting subtest: idempotent
[405.213762] Subtest idempotent: SUCCESS (0.000s)
[405.366668] [017/133] (646s left) dmabuf_sync_file (export-multiwait)
[405.497206] Starting subtest: export-multiwait
[405.500902] Subtest export-multiwait: SUCCESS (0.002s)
[405.623473] [018/133] (645s left) i915_drm_fdinfo (memory-info-purgeable)
[405.739897] Starting subtest: memory-info-purgeable
[405.743779] Starting dynamic subtest: smem0
[406.799051] Dynamic subtest smem0: SUCCESS (1.054s)
[406.806104] Subtest memory-info-purgeable: SUCCESS (1.058s)
[406.950228] [019/133] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[407.163195] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[407.171680] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[407.315859] [020/133] (644s left) gem_exec_schedule (semaphore-power)
[407.582373] Starting subtest: semaphore-power
[408.460390] Subtest semaphore-power: SUCCESS (0.869s)
[408.736713] [021/133] (643s left) gem_eio (context-create)
[408.875964] Starting subtest: context-create
[408.925785] Subtest context-create: SUCCESS (0.048s)
[409.185902] [022/133] (642s left) kms_universal_plane (universal-plane-pageflip-windowed)
[409.378035] Starting subtest: universal-plane-pageflip-windowed
[409.382295] Starting dynamic subtest: pipe-A-HDMI-A-1
[410.244174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.857s)
[410.289958] Starting dynamic subtest: pipe-B-HDMI-A-2
[410.780197] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.535s)
[410.809373] Starting dynamic subtest: pipe-C-HDMI-A-1
[411.345083] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.559s)
[411.349418] Subtest universal-plane-pageflip-windowed: SUCCESS (1.972s)
[411.650081] [023/133] (640s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[411.878601] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[413.505847] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.631s)
[413.779155] [024/133] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[413.989242] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[416.524176] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.539s)
[416.906893] [025/133] (635s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[417.095156] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[417.220067] [026/133] (635s left) kms_flip (2x-flip-vs-panning-interruptible)
[417.420098] Starting subtest: 2x-flip-vs-panning-interruptible
[417.430895] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[428.264412] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.840s)
[428.291267] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[439.040076] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.772s)
[439.069326] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[449.760835] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.712s)
[449.764311] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (32.346s)
[450.742793] [027/133] (602s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[451.425111] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[453.706072] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SUCCESS (2.614s)
[453.916050] [028/133] (599s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[454.097204] Starting subtest: flip-vs-cursor-atomic-transitions
[469.116878] Subtest flip-vs-cursor-atomic-transitions: FAIL (14.029s)
[469.220215] [029/133] (583s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[469.420801] Starting subtest: bad-aux-stride-y-tiled-ccs
[469.425237] Starting dynamic subtest: pipe-A-HDMI-A-1
[469.479473] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.004s)
[469.527384] Starting dynamic subtest: pipe-A-HDMI-A-2
[469.573415] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.004s)
[469.616319] Starting dynamic subtest: pipe-B-HDMI-A-1
[469.649439] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.003s)
[469.674328] Starting dynamic subtest: pipe-B-HDMI-A-2
[469.704057] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.004s)
[469.727016] Starting dynamic subtest: pipe-C-HDMI-A-1
[469.759950] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[469.783313] Starting dynamic subtest: pipe-C-HDMI-A-2
[469.818700] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[469.821807] Subtest bad-aux-stride-y-tiled-ccs: SUCCESS (0.049s)
[470.516976] [030/133] (582s left) kms_color (invalid-degamma-lut-sizes)
[470.717226] Starting subtest: invalid-degamma-lut-sizes
[470.724390] Starting dynamic subtest: pipe-A
[471.097365] Dynamic subtest pipe-A: SUCCESS (0.386s)
[471.147567] Starting dynamic subtest: pipe-B
[471.152574] Dynamic subtest pipe-B: SUCCESS (0.002s)
[471.204294] Starting dynamic subtest: pipe-C
[471.209411] Dynamic subtest pipe-C: SUCCESS (0.002s)
[471.215568] Subtest invalid-degamma-lut-sizes: SUCCESS (0.398s)
[471.514688] [031/133] (581s left) gem_render_copy (linear-to-vebox-yf-tiled)
[471.644189] Starting subtest: linear-to-vebox-yf-tiled
[471.652421] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[471.942975] [032/133] (581s left) gem_exec_params (invalid-fence-in)
[472.062468] Starting subtest: invalid-fence-in
[472.066093] Subtest invalid-fence-in: SUCCESS (0.001s)
[472.230949] [033/133] (581s left) gem_exec_schedule (preempt-hang)
[472.475430] Starting subtest: preempt-hang
[472.478617] Starting dynamic subtest: rcs0
[472.753973] Dynamic subtest rcs0: SUCCESS (0.262s)
[472.781941] Starting dynamic subtest: bcs0
[473.031664] Dynamic subtest bcs0: SUCCESS (0.280s)
[473.062886] Starting dynamic subtest: vcs0
[473.292363] Dynamic subtest vcs0: SUCCESS (0.255s)
[473.322780] Starting dynamic subtest: vecs0
[473.541070] Dynamic subtest vecs0: SUCCESS (0.248s)
[473.544569] Subtest preempt-hang: SUCCESS (1.065s)
[473.848794] [034/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[474.061998] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[474.068572] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[474.218310] [035/133] (579s left) kms_psr (fbc-pr-cursor-render)
[474.413553] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[474.543754] [036/133] (579s left) gem_mmap_gtt (flink-race)
[474.657020] Starting subtest: flink-race
[494.715572] Subtest flink-race: SUCCESS (20.062s)
[494.911075] [037/133] (558s left) kms_concurrent (multi-plane-atomic-lowres)
[495.120047] Starting subtest: multi-plane-atomic-lowres
[495.125907] Starting dynamic subtest: pipe-A-HDMI-A-1
[496.155185] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.036s)
[496.199515] Starting dynamic subtest: pipe-A-HDMI-A-2
[496.891050] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.729s)
[496.920867] Starting dynamic subtest: pipe-B-HDMI-A-1
[497.729140] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.829s)
[497.782197] Starting dynamic subtest: pipe-B-HDMI-A-2
[498.553140] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.819s)
[498.602557] Starting dynamic subtest: pipe-C-HDMI-A-1
[499.248112] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.691s)
[499.298062] Starting dynamic subtest: pipe-C-HDMI-A-2
[499.992072] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.735s)
[499.996621] Subtest multi-plane-atomic-lowres: SUCCESS (4.879s)
[500.363737] [038/133] (553s left) kms_big_fb (linear-8bpp-rotate-90)
[500.578079] Starting subtest: linear-8bpp-rotate-90
[500.912583] Subtest linear-8bpp-rotate-90: SKIP (0.328s)
[501.186544] [039/133] (552s left) api_intel_bb (render)
[501.305302] Starting subtest: render
[501.310081] Starting dynamic subtest: render-none-512
[501.418133] Dynamic subtest render-none-512: SUCCESS (0.111s)
[501.442744] Starting dynamic subtest: render-none-reloc-512
[501.528552] Dynamic subtest render-none-reloc-512: SUCCESS (0.108s)
[501.553780] Starting dynamic subtest: render-none-1024
[501.916074] Dynamic subtest render-none-1024: SUCCESS (0.375s)
[501.940281] Starting dynamic subtest: render-none-reloc-1024
[502.286141] Dynamic subtest render-none-reloc-1024: SUCCESS (0.368s)
[502.310552] Starting dynamic subtest: render-x-512
[502.372256] Dynamic subtest render-x-512: SUCCESS (0.091s)
[502.398085] Starting dynamic subtest: render-x-reloc-512
[502.460255] Dynamic subtest render-x-reloc-512: SUCCESS (0.085s)
[502.485210] Starting dynamic subtest: render-x-1024
[502.784282] Dynamic subtest render-x-1024: SUCCESS (0.320s)
[502.808470] Starting dynamic subtest: render-x-reloc-1024
[503.116830] Dynamic subtest render-x-reloc-1024: SUCCESS (0.326s)
[503.140865] Starting dynamic subtest: render-y-512
[503.209073] Dynamic subtest render-y-512: SUCCESS (0.091s)
[503.232655] Starting dynamic subtest: render-y-reloc-512
[503.299133] Dynamic subtest render-y-reloc-512: SUCCESS (0.087s)
[503.323941] Starting dynamic subtest: render-y-1024
[503.625470] Dynamic subtest render-y-1024: SUCCESS (0.321s)
[503.649632] Starting dynamic subtest: render-y-reloc-1024
[503.954265] Dynamic subtest render-y-reloc-1024: SUCCESS (0.325s)
[503.959196] Subtest render: SUCCESS (2.648s)
[504.125901] [040/133] (550s left) perf (gen12-group-exclusive-stream-sample-oa)
[504.349984] Starting subtest: gen12-group-exclusive-stream-sample-oa
[504.358600] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[504.474925] [041/133] (549s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[504.695947] Starting subtest: pipe-fbc-rte
[504.713944] Subtest pipe-fbc-rte: SKIP (0.001s)
[504.850855] [042/133] (549s left) kms_plane (plane-position-covered)
[505.041486] Starting subtest: plane-position-covered
[505.786503] Starting dynamic subtest: pipe-A-plane-1
[506.322149] Dynamic subtest pipe-A-plane-1: SUCCESS (0.542s)
[506.368169] Starting dynamic subtest: pipe-A-plane-2
[506.890285] Dynamic subtest pipe-A-plane-2: SUCCESS (0.554s)
[506.938215] Starting dynamic subtest: pipe-A-plane-3
[507.456839] Dynamic subtest pipe-A-plane-3: SUCCESS (0.561s)
[507.490945] Starting dynamic subtest: pipe-A-plane-4
[507.499128] Dynamic subtest pipe-A-plane-4: SUCCESS (0.007s)
[507.991703] Starting dynamic subtest: pipe-B-plane-1
[508.466707] Dynamic subtest pipe-B-plane-1: SUCCESS (0.516s)
[508.517502] Starting dynamic subtest: pipe-B-plane-2
[509.038651] Dynamic subtest pipe-B-plane-2: SUCCESS (0.571s)
[509.090538] Starting dynamic subtest: pipe-B-plane-3
[509.617220] Dynamic subtest pipe-B-plane-3: SUCCESS (0.568s)
[509.649445] Starting dynamic subtest: pipe-B-plane-4
[509.659127] Dynamic subtest pipe-B-plane-4: SUCCESS (0.007s)
[509.664093] Subtest plane-position-covered: SUCCESS (4.583s)
[509.977113] [043/133] (544s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[510.094202] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[510.097712] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[510.240146] [044/133] (544s left) gem_busy (close-race)
[510.366398] Starting subtest: close-race
[533.176483] Subtest close-race: SUCCESS (22.804s)
[533.613442] [045/133] (521s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[533.952704] Starting subtest: addfb25-x-tiled-mismatch-legacy
[533.956936] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[534.111891] [046/133] (520s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[534.331374] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[534.338143] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[534.509091] [047/133] (520s left) kms_cursor_edge_walk (128x128-right-edge)
[534.693223] Starting subtest: 128x128-right-edge
[534.698878] Starting dynamic subtest: pipe-A-HDMI-A-1
[538.703966] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.010s)
[538.740168] Starting dynamic subtest: pipe-C-HDMI-A-1
[542.213183] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.501s)
[542.216876] Subtest 128x128-right-edge: SUCCESS (7.523s)
[542.523557] [048/133] (512s left) gem_exec_reloc (basic-softpin)
[542.657690] Starting subtest: basic-softpin
[542.662992] Subtest basic-softpin: SUCCESS (0.006s)
[542.906198] [049/133] (512s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[543.138051] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[543.150044] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[543.320421] [050/133] (512s left) gem_ctx_isolation (dirty-switch)
[543.451330] Starting subtest: dirty-switch
[543.456393] Starting dynamic subtest: rcs0
[544.033689] Dynamic subtest rcs0: SUCCESS (0.580s)
[544.069247] Starting dynamic subtest: bcs0
[544.976694] Dynamic subtest bcs0: SUCCESS (0.935s)
[545.005738] Starting dynamic subtest: vcs0
[545.566146] Dynamic subtest vcs0: SUCCESS (0.586s)
[545.595249] Starting dynamic subtest: vecs0
[546.167271] Dynamic subtest vecs0: SUCCESS (0.596s)
[546.171146] Subtest dirty-switch: SUCCESS (2.715s)
[546.440370] [051/133] (509s left) gem_exec_balancer (invalid-bonds)
[546.572355] Starting subtest: invalid-bonds
[546.580404] Subtest invalid-bonds: SUCCESS (0.008s)
[546.871795] [052/133] (508s left) gem_exec_reloc (basic-write-wc)
[546.993827] Starting subtest: basic-write-wc
[547.011089] Subtest basic-write-wc: SUCCESS (0.020s)
[547.255547] [053/133] (508s left) i915_pm_rps (basic-api)
[547.381440] Starting subtest: basic-api
[547.393489] Subtest basic-api: SUCCESS (0.012s)
[547.555389] [054/133] (508s left) syncobj_timeline (single-wait-signaled)
[547.680300] Starting subtest: single-wait-signaled
[547.683799] Subtest single-wait-signaled: SUCCESS (0.001s)
[547.836552] [055/133] (508s left) kms_addfb_basic (size-max)
[548.037855] Starting subtest: size-max
[548.041718] Subtest size-max: SUCCESS (0.001s)
[548.204691] [056/133] (507s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[548.427059] Starting subtest: yf-tiled-32bpp-rotate-90
[552.953129] Subtest yf-tiled-32bpp-rotate-90: SUCCESS (4.523s)
[553.357371] [057/133] (502s left) syncobj_wait (invalid-reset-illegal-handle)
[553.471209] Starting subtest: invalid-reset-illegal-handle
[553.475332] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[553.650745] [058/133] (502s left) gem_lmem_swapping (basic)
[553.778812] Subtest basic: SKIP (0.000s)
[553.885701] [059/133] (502s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[554.085238] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[565.524495] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.322s)
[566.347500] [060/133] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[566.954109] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[566.960451] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[567.067046] [061/133] (490s left) kms_display_modes (extended-mode-basic)
[567.272052] Starting subtest: extended-mode-basic
[567.278606] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[568.376077] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.101s)
[568.438361] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[569.545108] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.152s)
[569.593353] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[570.919930] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.368s)
[570.968356] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[572.392725] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.463s)
[572.444521] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[573.675608] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.272s)
[573.724406] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[575.199161] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.520s)
[575.254279] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[576.718265] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.513s)
[576.775278] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[578.135136] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.408s)
[578.172022] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[579.480435] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.336s)
[579.532411] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[580.944654] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.456s)
[580.999439] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[582.366328] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.415s)
[582.419427] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[583.655140] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.279s)
[583.662614] Subtest extended-mode-basic: SUCCESS (16.382s)
[583.965149] [062/133] (473s left) gem_exec_fence (long-history)
[584.586635] Starting subtest: long-history
[590.354094] Subtest long-history: SUCCESS (5.766s)
[590.978960] [063/133] (466s left) vgem_basic (bad-fence)
[591.104421] Starting subtest: bad-fence
[591.107988] Subtest bad-fence: SUCCESS (0.000s)
[591.231255] [064/133] (466s left) kms_chamelium_edid (hdmi-mode-timings)
[591.817057] Subtest hdmi-mode-timings: SKIP (0.000s)
[592.170159] [065/133] (465s left) syncobj_timeline (invalid-wait-illegal-handle)
[592.293851] Starting subtest: invalid-wait-illegal-handle
[592.298517] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[592.455839] [066/133] (465s left) kms_psr (fbc-psr2-cursor-blt)
[592.652099] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[592.772936] [067/133] (465s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[592.986344] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[593.235433] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.235s)
[593.488930] [068/133] (464s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[593.697287] Starting subtest: cursor-rapid-movement-32x32
[593.953825] Subtest cursor-rapid-movement-32x32: SKIP (0.252s)
[594.123204] [069/133] (463s left) api_intel_allocator (reopen)
[594.243663] Starting subtest: reopen
[594.249140] Subtest reopen: SUCCESS (0.008s)
[594.407703] [070/133] (463s left) gem_exec_parallel (fds)
[594.544475] Starting subtest: fds
[594.547869] Starting dynamic subtest: rcs0
[600.066912] Dynamic subtest rcs0: SUCCESS (5.520s)
[600.093858] Starting dynamic subtest: bcs0
[605.675853] Dynamic subtest bcs0: SUCCESS (5.603s)
[605.705764] Starting dynamic subtest: vcs0
[621.374023] Dynamic subtest vcs0: SUCCESS (15.691s)
[621.400720] Starting dynamic subtest: vecs0
[626.275325] Dynamic subtest vecs0: SUCCESS (4.896s)
[626.279575] Subtest fds: SUCCESS (31.726s)
[626.565732] [071/133] (431s left) gem_exec_whisper (basic-fds-all)
[626.707100] Starting subtest: basic-fds-all
[641.924374] Subtest basic-fds-all: SUCCESS (15.212s)
[642.179363] [072/133] (416s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[642.384981] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[642.392121] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[642.552835] [073/133] (415s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[642.772213] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[642.780403] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[642.962685] [074/133] (415s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[643.170163] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[643.178118] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[643.334711] [075/133] (415s left) kms_psr (fbc-psr-primary-page-flip)
[643.525421] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[643.645925] [076/133] (415s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[643.846734] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[643.853067] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[644.000713] [077/133] (414s left) kms_chamelium_color (ctm-green-to-red)
[644.204107] Subtest ctm-green-to-red: SKIP (0.000s)
[644.314682] [078/133] (414s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[644.999389] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[645.621182] [079/133] (413s left) perf_pmu (init-busy)
[646.255607] Starting subtest: init-busy
[646.261993] Starting dynamic subtest: rcs0
[646.266571] Dynamic subtest rcs0: SUCCESS (0.002s)
[646.293267] Starting dynamic subtest: bcs0
[646.297509] Dynamic subtest bcs0: SUCCESS (0.001s)
[646.323912] Starting dynamic subtest: vcs0
[646.327955] Dynamic subtest vcs0: SUCCESS (0.001s)
[646.354584] Starting dynamic subtest: vecs0
[646.358574] Dynamic subtest vecs0: SUCCESS (0.001s)
[646.362819] Subtest init-busy: SUCCESS (0.017s)
[646.466273] [080/133] (413s left) sw_sync (sync_merge_invalid)
[646.571524] Starting subtest: sync_merge_invalid
[646.578817] Subtest sync_merge_invalid: SUCCESS (0.006s)
[646.698082] [081/133] (413s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[646.882172] Starting subtest: modeset-transition-nonblocking-fencing
[646.887069] Starting dynamic subtest: 1x-outputs
[650.409751] Dynamic subtest 1x-outputs: SUCCESS (3.529s)
[650.444191] Starting dynamic subtest: 2x-outputs
[657.770386] Dynamic subtest 2x-outputs: SUCCESS (7.353s)
[657.775604] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.890s)
[658.075221] [082/133] (401s left) gem_softpin (evict-prime-sanity-check)
[658.204584] Starting subtest: evict-prime-sanity-check
[658.207731] Starting dynamic subtest: rcs0
[659.316223] Dynamic subtest rcs0: SUCCESS (1.109s)
[659.354788] Starting dynamic subtest: bcs0
[660.415220] Dynamic subtest bcs0: SUCCESS (1.088s)
[660.442193] Starting dynamic subtest: vcs0
[661.515042] Dynamic subtest vcs0: SUCCESS (1.102s)
[661.542945] Starting dynamic subtest: vecs0
[662.618935] Dynamic subtest vecs0: SUCCESS (1.100s)
[662.646487] Starting dynamic subtest: all
[663.733192] Dynamic subtest all: SUCCESS (1.110s)
[663.736691] Subtest evict-prime-sanity-check: SUCCESS (5.530s)
[663.891665] [083/133] (396s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[664.005382] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[664.102504] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[664.259257] [084/133] (395s left) kms_frontbuffer_tracking (fbc-stridechange)
[664.460757] Starting subtest: fbc-stridechange
[666.517994] Subtest fbc-stridechange: SUCCESS (2.062s)
[666.807977] [085/133] (393s left) kms_fbcon_fbt (fbc)
[666.929504] Starting subtest: fbc
[671.077247] Subtest fbc: SUCCESS (4.149s)
[671.201890] [086/133] (389s left) sriov_basic (enable-vfs-bind-unbind-each)
[671.315284] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[671.426055] [087/133] (389s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[671.627046] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[674.628312] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.010s)
[674.969649] [088/133] (385s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[675.171265] Starting subtest: yf-tiled-32bpp-rotate-0
[679.605884] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (4.440s)
[680.016862] [089/133] (380s left) prime_vgem (fence-flip-hang)
[680.150539] Subtest fence-flip-hang: SKIP (0.000s)
[680.294877] [090/133] (380s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[680.479887] Starting subtest: cursor-vs-flip-varying-size
[726.898507] Subtest cursor-vs-flip-varying-size: SUCCESS (46.444s)
[727.243568] [091/133] (333s left) gem_vm_create (invalid-create)
[727.361516] Starting subtest: invalid-create
[727.365542] Subtest invalid-create: SUCCESS (0.001s)
[727.524494] [092/133] (333s left) gem_ccs (block-multicopy-compressed)
[727.650052] Subtest block-multicopy-compressed: SKIP (0.000s)
[727.767052] [093/133] (333s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[727.957972] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[727.977333] Starting dynamic subtest: pipe-A-valid-mode
[728.950179] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.985s)
[728.954141] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (0.994s)
[729.320397] [094/133] (331s left) gem_partial_pwrite_pread (writes-after-reads)
[729.448791] Starting subtest: writes-after-reads
[750.496478] Subtest writes-after-reads: SUCCESS (21.049s)
[750.660653] [095/133] (310s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[750.776454] Starting subtest: etime-multi-wait-all-for-submit-submitted
[750.878351] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[751.028972] [096/133] (310s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[751.251086] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[753.688201] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.448s)
[753.995068] [097/133] (307s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[754.194937] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[800.887200] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (46.696s)
[801.266809] [098/133] (260s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[801.457688] Starting subtest: addfb25-framebuffer-vs-set-tiling
[801.461603] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[801.637210] [099/133] (260s left) gem_mmap (basic-small-bo)
[801.753446] Starting subtest: basic-small-bo
[802.217456] Subtest basic-small-bo: SUCCESS (0.472s)
[802.400273] [100/133] (259s left) kms_psr (psr-primary-mmap-cpu)
[802.769061] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[802.895847] [101/133] (259s left) kms_prop_blob (blob-prop-core)
[803.016826] Starting subtest: blob-prop-core
[803.020791] Subtest blob-prop-core: SUCCESS (0.000s)
[803.169108] [102/133] (258s left) kms_hdr (bpc-switch)
[803.373437] Starting subtest: bpc-switch
[831.532879] Subtest bpc-switch: SKIP (28.164s)
[832.023364] [103/133] (230s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[832.247405] Starting subtest: crc-primary-basic-y-tiled-ccs
[832.252049] Starting dynamic subtest: pipe-A-HDMI-A-1
[832.860151] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.597s)
[832.890069] Starting dynamic subtest: pipe-A-HDMI-A-2
[833.317070] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.447s)
[833.371859] Starting dynamic subtest: pipe-B-HDMI-A-1
[833.796064] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.472s)
[833.822967] Starting dynamic subtest: pipe-B-HDMI-A-2
[834.208474] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.412s)
[834.258956] Starting dynamic subtest: pipe-C-HDMI-A-1
[834.293561] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[834.324626] Starting dynamic subtest: pipe-C-HDMI-A-2
[834.356490] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[834.359585] Subtest crc-primary-basic-y-tiled-ccs: SUCCESS (1.966s)
[835.006547] [104/133] (227s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[835.218072] Starting subtest: fbc-rgb565-draw-mmap-wc
[837.981037] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.772s)
[838.299390] [105/133] (224s left) gem_mmap_wc (invalid-flags)
[838.417124] Starting subtest: invalid-flags
[838.421292] Subtest invalid-flags: SUCCESS (0.000s)
[838.599286] [106/133] (223s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[838.811124] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[838.817479] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[839.002602] [107/133] (223s left) i915_hangman (error-state-basic)
[839.148197] Starting subtest: error-state-basic
[839.163810] Subtest error-state-basic: SUCCESS (0.016s)
[839.336971] [108/133] (223s left) kms_vblank (ts-continuation-suspend)
[839.528205] Starting subtest: ts-continuation-suspend
[839.531586] Starting dynamic subtest: pipe-A-HDMI-A-1
[855.880308] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.825s)
[855.930927] Starting dynamic subtest: pipe-A-HDMI-A-2