[60.963951] Initializing watchdogs
[60.964132]   /dev/watchdog0
[60.978976] [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]
[60.983163] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.985310] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.988636] [001/133] (960s left) kms_psr (fbc-psr2-primary-blt)
[61.093108] Starting subtest: fbc-psr2-primary-blt
[61.095400] Starting dynamic subtest: eDP-1
[61.099868] Dynamic subtest eDP-1: SKIP (0.000s)
[61.104461] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[61.171441] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[61.270281] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[61.274692] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[61.409199] [003/133] (960s left) gem_exec_big (single)
[61.470834] Starting subtest: single
[63.789058] Subtest single: SUCCESS (2.315s)
[64.016224] [004/133] (957s left) syncobj_wait (wait-all-for-submit-complex)
[64.127255] Starting subtest: wait-all-for-submit-complex
[64.342344] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[64.431702] [005/133] (957s left) kms_hdr (invalid-metadata-sizes)
[64.538808] Starting subtest: invalid-metadata-sizes
[64.545417] Subtest invalid-metadata-sizes: SKIP (0.000s)
[64.622262] [006/133] (957s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[64.712050] Starting subtest: addfb25-y-tiled-small-legacy
[64.716178] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[64.821088] [007/133] (956s left) kms_flip (flip-vs-fences-interruptible)
[64.931164] Starting subtest: flip-vs-fences-interruptible
[64.936220] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[65.058865] [008/133] (956s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[65.115408] Starting subtest: single-wait-for-submit-unsubmitted
[65.218346] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[65.300993] [009/133] (956s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[65.403975] Starting subtest: fbc-psr2-primary-mmap-cpu
[65.406883] Starting dynamic subtest: eDP-1
[65.411270] Dynamic subtest eDP-1: SKIP (0.000s)
[65.416112] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[65.486153] [010/133] (956s left) gem_caching (reads)
[65.551998] Subtest reads: SKIP (0.000s)
[65.605224] [011/133] (956s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[65.690047] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[65.701136] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[65.834592] [012/133] (956s left) kms_flip (2x-flip-vs-fences)
[65.921200] Starting subtest: 2x-flip-vs-fences
[65.925536] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[66.024181] [013/133] (955s left) gen9_exec_parse (batch-zero-length)
[66.082094] Subtest batch-zero-length: SKIP (0.000s)
[66.144487] [014/133] (955s left) kms_colorop (plane-xr30-xr30-pq_125_eotf-pq_125_inv_eotf)
[66.273477] Subtest plane-XR30-XR30-pq_125_eotf-pq_125_inv_eotf: SKIP (0.000s)
[66.350191] [015/133] (955s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[66.440860] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[66.444780] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.001s)
[66.544658] [016/133] (955s left) gem_tiled_wb
[66.662776] [017/133] (955s left) syncobj_timeline (multi-wait-for-submit-signaled)
[66.707215] Starting subtest: multi-wait-for-submit-signaled
[66.708832] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[66.829960] [018/133] (955s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[66.928348] Starting subtest: psr-1p-pri-indfb-multidraw
[89.565352] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.640s)
[89.743686] [019/133] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[89.854466] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[93.833438] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.982s)
[94.976709] [020/133] (927s left) kms_joiner (invalid-modeset-ultra-joiner)
[95.081242] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[95.161948] [021/133] (927s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[95.259587] Starting subtest: psr-2p-pri-indfb-multidraw
[95.263624] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[95.357788] [022/133] (926s left) kms_big_fb (linear-16bpp-rotate-270)
[95.459805] Starting subtest: linear-16bpp-rotate-270
[95.478788] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[95.599704] [023/133] (926s left) gem_exec_schedule (preempt)
[95.671841] Starting subtest: preempt
[95.674086] Starting dynamic subtest: rcs0
[95.690043] Dynamic subtest rcs0: SUCCESS (0.023s)
[95.696988] Starting dynamic subtest: bcs0
[95.708485] Dynamic subtest bcs0: SUCCESS (0.018s)
[95.717263] Starting dynamic subtest: vcs0
[95.727895] Dynamic subtest vcs0: SUCCESS (0.019s)
[95.737266] Starting dynamic subtest: vcs1
[95.747072] Dynamic subtest vcs1: SUCCESS (0.019s)
[95.754586] Starting dynamic subtest: vecs0
[95.767233] Dynamic subtest vecs0: SUCCESS (0.020s)
[95.774416] Starting dynamic subtest: ccs0
[95.786342] Dynamic subtest ccs0: SUCCESS (0.018s)
[95.788627] Subtest preempt: SUCCESS (0.120s)
[97.025493] [024/133] (925s left) kms_vblank (wait-busy-hang)
[97.126104] Starting subtest: wait-busy-hang
[97.128239] Starting dynamic subtest: pipe-A-eDP-1
[103.335744] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.209s)
[103.350149] Starting dynamic subtest: pipe-D-eDP-1
[109.350869] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.012s)
[109.352897] Subtest wait-busy-hang: SUCCESS (12.225s)
[110.223683] [025/133] (912s left) gem_exec_params (invalid-batch-start-offset)
[110.279080] Starting subtest: invalid-batch-start-offset
[110.285459] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[110.430613] [026/133] (911s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[110.522046] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[110.524332] Starting dynamic subtest: pipe-A-eDP-1
[110.581746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[110.877189] Starting dynamic subtest: pipe-B-eDP-1
[111.713234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.845s)
[112.003616] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.482s)
[112.885195] [027/133] (909s left) gem_ringfill (legacy-basic)
[118.938768] Starting subtest: legacy-basic
[118.942567] Starting dynamic subtest: default
[119.008371] Dynamic subtest default: SUCCESS (0.069s)
[119.019028] Starting dynamic subtest: render
[119.050972] Dynamic subtest render: SUCCESS (0.041s)
[119.060658] Starting dynamic subtest: bsd
[119.093773] Dynamic subtest bsd: SUCCESS (0.040s)
[119.103714] Starting dynamic subtest: bsd1
[119.134899] Dynamic subtest bsd1: SUCCESS (0.039s)
[119.144738] Starting dynamic subtest: bsd2
[119.177365] Dynamic subtest bsd2: SUCCESS (0.040s)
[119.186473] Starting dynamic subtest: blt
[119.222497] Dynamic subtest blt: SUCCESS (0.043s)
[119.231771] Starting dynamic subtest: vebox
[119.264273] Dynamic subtest vebox: SUCCESS (0.040s)
[119.266649] Subtest legacy-basic: SUCCESS (0.328s)
[119.348999] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[119.351987] [028/133] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[119.442327] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[119.446275] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[119.573710] [029/133] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[119.658728] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[119.663257] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[119.790262] [030/133] (902s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[119.907391] Starting subtest: cursorB-vs-flipA-legacy
[119.911526] Subtest cursorB-vs-flipA-legacy: SKIP (0.003s)
[120.074798] [031/133] (902s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[120.186051] Starting subtest: cursor-vs-flip-atomic-transitions
[150.091917] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.902s)
[150.918341] [032/133] (871s left) perf_pmu (busy-accuracy-2)
[150.961760] Starting subtest: busy-accuracy-2
[150.964097] Starting dynamic subtest: rcs0
[154.007637] Dynamic subtest rcs0: SUCCESS (3.044s)
[154.018369] Starting dynamic subtest: bcs0
[157.064262] Dynamic subtest bcs0: SUCCESS (3.055s)
[157.074920] Starting dynamic subtest: vcs0
[160.109511] Dynamic subtest vcs0: SUCCESS (3.042s)
[160.119888] Starting dynamic subtest: vcs1
[163.156171] Dynamic subtest vcs1: SUCCESS (3.045s)
[163.166581] Starting dynamic subtest: vecs0
[166.200609] Dynamic subtest vecs0: SUCCESS (3.043s)
[166.211079] Starting dynamic subtest: ccs0
[169.256469] Dynamic subtest ccs0: SUCCESS (3.054s)
[169.258833] Subtest busy-accuracy-2: SUCCESS (18.294s)
[169.392704] [033/133] (853s left) kms_color (gamma)
[169.494975] Starting subtest: gamma
[169.496911] Starting dynamic subtest: pipe-A-eDP-1
[170.215924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[170.225079] Starting dynamic subtest: pipe-B-eDP-1
[171.605879] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[171.614953] Starting dynamic subtest: pipe-C-eDP-1
[172.957070] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s)
[172.965026] Starting dynamic subtest: pipe-D-eDP-1
[174.310508] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[174.312772] Subtest gamma: SUCCESS (4.818s)
[175.131514] [034/133] (847s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[175.225952] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[179.492954] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.273s)
[180.670433] [035/133] (842s left) kms_properties (get_properties-sanity-non-atomic)
[180.768988] Starting subtest: get_properties-sanity-non-atomic
[180.771310] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[180.865908] [036/133] (841s left) syncobj_wait (wait-all-complex)
[180.917835] Starting subtest: wait-all-complex
[181.131044] Subtest wait-all-complex: SUCCESS (0.213s)
[181.218884] [037/133] (841s left) kms_psr (psr2-suspend)
[181.307921] Starting subtest: psr2-suspend
[181.310236] Starting dynamic subtest: eDP-1
[199.756089] Dynamic subtest eDP-1: SUCCESS (3.223s)
[199.758403] Subtest psr2-suspend: SUCCESS (3.224s)
[200.573692] [038/133] (822s left) perf_pmu (rc6-all-gts)
[200.626849] Starting subtest: rc6-all-gts
[207.009300] Subtest rc6-all-gts: SUCCESS (6.380s)
[207.907386] [039/133] (814s left) sysfs_heartbeat_interval (mixed)
[207.966927] Starting subtest: mixed
[207.969302] Starting dynamic subtest: vecs0
[213.254833] Dynamic subtest vecs0: SUCCESS (5.286s)
[213.267762] Starting dynamic subtest: ccs0
[218.473946] Dynamic subtest ccs0: SUCCESS (5.215s)
[218.486381] Starting dynamic subtest: vcs0
[223.703232] Dynamic subtest vcs0: SUCCESS (5.227s)
[223.712831] Starting dynamic subtest: bcs0
[228.931305] Dynamic subtest bcs0: SUCCESS (5.227s)
[228.942959] Starting dynamic subtest: rcs0
[234.106358] Dynamic subtest rcs0: SUCCESS (5.174s)
[234.116210] Starting dynamic subtest: vcs1
[239.328111] Dynamic subtest vcs1: SUCCESS (5.219s)
[239.330532] Subtest mixed: SUCCESS (31.358s)
[239.418385] [040/133] (783s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[239.523836] Starting subtest: fbcpsr-tiling-4
[246.572663] Subtest fbcpsr-tiling-4: SUCCESS (7.050s)
[246.770999] [041/133] (776s left) kms_atomic_transition (plane-all-modeset-transition)
[246.867128] Starting subtest: plane-all-modeset-transition
[246.871059] Subtest plane-all-modeset-transition: SKIP (0.000s)
[246.949156] [042/133] (776s left) i915_module_load (resize-bar)
[246.979177] Starting subtest: resize-bar
[246.985505] Subtest resize-bar: SKIP (0.005s)
[247.036315] [043/133] (776s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[247.139316] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[248.252494] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.114s)
[248.378650] [044/133] (774s left) kms_cursor_crc (cursor-onscreen-max-size)
[248.664775] Starting subtest: cursor-onscreen-max-size
[248.670407] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[248.839663] [045/133] (774s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[249.212314] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[249.995558] [046/133] (773s left) gem_ctx_persistence (engines-cleanup)
[250.054313] Starting subtest: engines-cleanup
[250.056675] Starting dynamic subtest: rcs0
[250.141887] Dynamic subtest rcs0: SUCCESS (0.087s)
[250.153954] Starting dynamic subtest: bcs0
[250.196890] Dynamic subtest bcs0: SUCCESS (0.053s)
[250.207321] Starting dynamic subtest: vcs0
[250.212611] Dynamic subtest vcs0: SUCCESS (0.014s)
[250.221161] Starting dynamic subtest: vcs1
[250.301318] Dynamic subtest vcs1: SUCCESS (0.087s)
[250.312845] Starting dynamic subtest: vecs0
[250.343644] Dynamic subtest vecs0: SUCCESS (0.041s)
[250.353362] Starting dynamic subtest: ccs0
[250.370530] Dynamic subtest ccs0: SUCCESS (0.025s)
[250.372772] Subtest engines-cleanup: SUCCESS (0.317s)
[250.515065] [047/133] (772s left) api_intel_bb (blit-noreloc-purge-cache)
[250.578787] Starting subtest: blit-noreloc-purge-cache
[250.587156] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[250.744612] [048/133] (772s left) gem_partial_pwrite_pread (write-snoop)
[250.809736] Subtest write-snoop: SKIP (0.000s)
[250.900068] [049/133] (772s left) kms_async_flips (invalid-async-flip-atomic)
[250.999305] Starting subtest: invalid-async-flip-atomic
[251.377502] Starting dynamic subtest: pipe-A-eDP-1
[252.832722] Dynamic subtest pipe-A-eDP-1: FAIL (0.846s)
[252.843109] Starting dynamic subtest: pipe-B-eDP-1
[253.741106] Dynamic subtest pipe-B-eDP-1: FAIL (0.747s)
[253.752976] Starting dynamic subtest: pipe-C-eDP-1
[254.512729] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.797s)
[254.871904] Starting dynamic subtest: pipe-D-eDP-1
[255.644538] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[255.646855] Subtest invalid-async-flip-atomic: FAIL (4.647s)
[256.802115] [050/133] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[256.903650] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[261.338121] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.438s)
[262.516680] [051/133] (760s left) gem_tiled_partial_pwrite_pread (reads)
[262.589966] Subtest reads: SKIP (0.000s)
[262.680601] [052/133] (760s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[262.735599] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[262.842095] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[262.929457] [053/133] (760s left) kms_psr (fbc-psr-suspend)
[263.026408] Starting subtest: fbc-psr-suspend
[263.028658] Starting dynamic subtest: eDP-1
[263.032767] Dynamic subtest eDP-1: SKIP (0.000s)
[263.036871] Subtest fbc-psr-suspend: SKIP (0.001s)
[263.113667] [054/133] (760s left) gem_exec_balancer (invalid-balancer)
[263.179615] Starting subtest: invalid-balancer
[264.045631] Subtest invalid-balancer: SUCCESS (0.862s)
[264.368605] [055/133] (759s left) gem_userptr_blits (access-control)
[264.432224] Starting subtest: access-control
[264.436823] Subtest access-control: SKIP (0.000s)
[264.605795] [056/133] (758s left) i915_drm_fdinfo (virtual-busy-hang)
[264.652902] Starting subtest: virtual-busy-hang
[264.657540] Subtest virtual-busy-hang: SKIP (0.000s)
[264.726288] [057/133] (758s left) kms_selftest (drm_cmdline_parser)
[264.763894] Starting subtest: drm_cmdline_parser
[264.814129] Starting dynamic subtest: drm_test_cmdline_force_d_only
[264.932133] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.115s)
[264.940893] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[265.081376] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.148s)
[265.091543] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[265.238714] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.157s)
[265.246883] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[265.371835] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.131s)
[265.387461] Starting dynamic subtest: drm_test_cmdline_force_e_only
[265.480514] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.109s)
[265.491006] Starting dynamic subtest: drm_test_cmdline_res
[265.580486] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.099s)
[265.591049] Starting dynamic subtest: drm_test_cmdline_res_vesa
[265.705210] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.123s)
[265.715647] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[265.817881] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.113s)
[265.826338] Starting dynamic subtest: drm_test_cmdline_res_rblank
[265.933627] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.114s)
[265.944359] Starting dynamic subtest: drm_test_cmdline_res_bpp
[266.052223] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.118s)
[266.060638] Starting dynamic subtest: drm_test_cmdline_res_refresh
[266.179348] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.127s)
[266.187398] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[266.307222] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.127s)
[266.317823] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[266.429333] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.121s)
[266.439496] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[266.555300] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.125s)
[266.565870] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[266.674661] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.119s)
[266.683135] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[266.798596] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.123s)
[266.806770] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[266.915670] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.116s)
[266.925541] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[267.037328] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.120s)
[267.047704] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[267.149369] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.111s)
[267.157780] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[267.289515] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.138s)
[267.299355] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[267.395343] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.106s)
[267.404410] Starting dynamic subtest: drm_test_cmdline_name
[267.511350] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.115s)
[267.520397] Starting dynamic subtest: drm_test_cmdline_name_bpp
[267.628761] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.116s)
[267.637286] Starting dynamic subtest: drm_test_cmdline_name_option
[267.762502] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.131s)
[267.773175] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[267.903123] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.141s)
[267.911348] Starting dynamic subtest: drm_test_cmdline_rotate_0
[267.990368] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.086s)
[267.998556] Starting dynamic subtest: drm_test_cmdline_rotate_90
[268.143394] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.152s)
[268.152525] Starting dynamic subtest: drm_test_cmdline_rotate_180
[268.239989] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.095s)
[268.248647] Starting dynamic subtest: drm_test_cmdline_rotate_270
[268.373015] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.132s)
[268.381406] Starting dynamic subtest: drm_test_cmdline_hmirror
[268.512688] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.136s)
[268.522922] Starting dynamic subtest: drm_test_cmdline_vmirror
[268.662510] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.149s)
[268.673092] Starting dynamic subtest: drm_test_cmdline_margin_options
[268.795739] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.133s)
[268.805922] Starting dynamic subtest: drm_test_cmdline_multiple_options
[268.932318] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.134s)
[268.943161] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[269.015705] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.083s)
[269.026169] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[269.170674] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.154s)
[269.181241] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[269.325626] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.153s)
[269.336252] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[269.491145] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.154s)
[269.502298] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[269.618738] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.138s)
[269.633806] Starting dynamic subtest: drm_test_cmdline_invalid
[269.764005] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.148s)
[269.773825] Starting dynamic subtest: drm_test_cmdline_tv_options
[269.912597] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.147s)
[269.914880] Subtest drm_cmdline_parser: SUCCESS (5.151s)
[270.145717] [058/133] (753s left) gem_exec_schedule (preempt-user)
[270.222995] Starting subtest: preempt-user
[270.225480] Starting dynamic subtest: rcs0
[270.259652] Dynamic subtest rcs0: SUCCESS (0.039s)
[270.272390] Starting dynamic subtest: bcs0
[270.292437] Dynamic subtest bcs0: SUCCESS (0.032s)
[270.302551] Starting dynamic subtest: vcs0
[270.319065] Dynamic subtest vcs0: SUCCESS (0.026s)
[270.328192] Starting dynamic subtest: vcs1
[270.345439] Dynamic subtest vcs1: SUCCESS (0.026s)
[270.354507] Starting dynamic subtest: vecs0
[270.373610] Dynamic subtest vecs0: SUCCESS (0.027s)
[270.382419] Starting dynamic subtest: ccs0
[270.404364] Dynamic subtest ccs0: SUCCESS (0.030s)
[270.406692] Subtest preempt-user: SUCCESS (0.185s)
[272.260639] [059/133] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[272.365651] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[279.674005] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.310s)
[279.833565] [060/133] (743s left) gem_exec_fence (keep-in-fence)
[280.023286] Starting subtest: keep-in-fence
[280.025628] Starting dynamic subtest: rcs0
[280.087353] Dynamic subtest rcs0: SUCCESS (0.067s)
[280.098220] Starting dynamic subtest: bcs0
[280.140510] Dynamic subtest bcs0: SUCCESS (0.051s)
[280.151718] Starting dynamic subtest: vcs0
[282.126487] Dynamic subtest vcs0: SUCCESS (1.982s)
[282.138864] Starting dynamic subtest: vcs1
[284.110734] Dynamic subtest vcs1: SUCCESS (1.982s)
[284.122355] Starting dynamic subtest: vecs0
[286.159475] Dynamic subtest vecs0: SUCCESS (2.046s)
[286.172061] Starting dynamic subtest: ccs0
[286.398220] Dynamic subtest ccs0: SUCCESS (0.238s)
[286.401192] Subtest keep-in-fence: SUCCESS (6.379s)
[288.260073] [061/133] (735s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[288.360691] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[288.364641] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[288.469843] [062/133] (735s left) gem_exec_params (sol-reset-not-gen7)
[288.529088] Starting subtest: sol-reset-not-gen7
[288.531462] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[288.686754] [063/133] (735s left) device_reset (cold-reset-bound)
[288.727927] Starting subtest: cold-reset-bound
[288.732800] Subtest cold-reset-bound: SKIP (0.000s)
[288.801685] [064/133] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[288.893437] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[288.897433] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[289.013797] [065/133] (734s left) prime_mmap (test_forked)
[289.068932] Starting subtest: test_forked
[289.071128] Starting dynamic subtest: test_forked-smem
[289.106422] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[289.108974] Subtest test_forked: SUCCESS (0.040s)
[289.232468] [066/133] (734s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[289.330370] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[289.334058] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[289.471799] [067/133] (734s left) gem_mmap_offset (clear-via-pagefault)
[289.531899] Starting subtest: clear-via-pagefault
[289.533903] Starting dynamic subtest: smem0
[323.929932] Dynamic subtest smem0: SUCCESS (34.394s)
[323.932221] Subtest clear-via-pagefault: SUCCESS (34.396s)
[324.082377] [068/133] (699s left) kms_chamelium_frames (hdmi-crc-multiple)
[324.481121] Subtest hdmi-crc-multiple: SKIP (0.000s)
[325.326744] [069/133] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[325.431834] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[325.435875] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[325.549470] [070/133] (698s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[325.649376] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[325.651621] Starting dynamic subtest: pipe-A
[325.986782] Dynamic subtest pipe-A: SUCCESS (0.339s)
[325.996561] Starting dynamic subtest: pipe-B
[327.361263] Dynamic subtest pipe-B: SUCCESS (1.374s)
[327.372790] Starting dynamic subtest: pipe-C
[328.779343] Dynamic subtest pipe-C: SUCCESS (1.417s)
[328.788582] Starting dynamic subtest: pipe-D
[330.244658] Dynamic subtest pipe-D: SUCCESS (1.464s)
[330.247116] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.598s)
[331.409398] [071/133] (692s left) kms_writeback (writeback-check-output-xrgb2101010)
[331.507625] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s)
[331.552011] [072/133] (692s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[331.648456] Starting subtest: random-ccs-data-y-tiled-ccs
[331.650729] Starting dynamic subtest: pipe-A-eDP-1
[331.675898] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[331.686096] Starting dynamic subtest: pipe-B-eDP-1
[331.710051] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[331.719493] Starting dynamic subtest: pipe-C-eDP-1
[331.744345] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[331.754826] Starting dynamic subtest: pipe-D-eDP-1
[331.778895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[331.783044] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[333.895012] [073/133] (690s left) gem_mmap_offset (pf-nonblock)
[333.954412] Starting subtest: pf-nonblock
[333.961213] Subtest pf-nonblock: SUCCESS (0.008s)
[334.124833] [074/133] (690s left) gem_ccs (ctrl-surf-copy-new-ctx)
[334.168281] Starting subtest: ctrl-surf-copy-new-ctx
[334.172463] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[334.280762] [075/133] (690s left) kms_pipe_stress (stress-xrgb8888-untiled)
[334.374336] Starting subtest: stress-xrgb8888-untiled
[340.260767] Subtest stress-xrgb8888-untiled: SUCCESS (5.887s)
[340.319252] [076/133] (684s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[340.442787] Starting subtest: 2x-long-flip-vs-cursor-legacy
[340.446683] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[340.601579] [077/133] (683s left) gem_exercise_blt (fast-copy)
[340.658249] Starting subtest: fast-copy
[340.660326] Starting dynamic subtest: linear-smem-smem
[340.681456] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[340.691990] Starting dynamic subtest: xmajor-smem-smem
[340.698174] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[340.706965] Starting dynamic subtest: tile4-smem-smem
[340.715150] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[340.723701] Starting dynamic subtest: tile64-smem-smem
[340.732713] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[340.734728] Subtest fast-copy: SUCCESS (0.075s)
[340.882699] [078/133] (683s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[340.987309] Starting subtest: psr-rgb101010-draw-mmap-wc
[348.009613] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.034s)
[348.157140] [079/133] (676s left) syncobj_timeline (multi-wait-available-signaled)
[348.228123] Starting subtest: multi-wait-available-signaled
[348.230073] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[348.351643] [080/133] (676s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[348.444335] Starting subtest: yf-tiled-16bpp-rotate-0
[348.448955] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[348.567285] [081/133] (676s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[353.540732] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[353.543136] Starting dynamic subtest: pipe-A-eDP-1
[354.352913] Dynamic subtest pipe-A-eDP-1: SKIP (0.810s)
[354.364345] Starting dynamic subtest: pipe-B-eDP-1
[355.492532] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[355.497028] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.951s)
[356.694824] [082/133] (667s left) kms_addfb_basic (invalid-set-prop)
[356.759119] Starting subtest: invalid-set-prop
[356.761469] Subtest invalid-set-prop: SUCCESS (0.000s)
[356.934869] [083/133] (667s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[357.025293] Starting subtest: crc-primary-basic-y-tiled-ccs
[357.027625] Starting dynamic subtest: pipe-A-eDP-1
[357.050637] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.060028] Starting dynamic subtest: pipe-B-eDP-1
[357.081425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.090374] Starting dynamic subtest: pipe-C-eDP-1
[357.112491] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.121448] Starting dynamic subtest: pipe-D-eDP-1
[357.143971] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.148499] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[359.257383] [084/133] (665s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[359.358460] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[359.360694] Starting dynamic subtest: pipe-A-default-mode
[359.662610] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[359.667034] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.305s)
[360.492163] [085/133] (664s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[360.583779] Starting subtest: fbcpsr-rgb565-draw-render
[367.643091] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.062s)
[367.795165] [086/133] (657s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[367.867840] Starting subtest: etime-multi-wait-all-available-unsubmitted
[367.970049] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.100s)
[368.058785] [087/133] (656s left) gen3_render_tiledy_blits
[368.180610] [088/133] (656s left) gem_busy (extended)
[368.374123] Starting subtest: extended
[368.375955] Starting dynamic subtest: rcs0
[368.460541] Dynamic subtest rcs0: SUCCESS (0.088s)
[368.472444] Starting dynamic subtest: bcs0
[368.502975] Dynamic subtest bcs0: SUCCESS (0.039s)
[368.512337] Starting dynamic subtest: vcs0
[370.126733] Dynamic subtest vcs0: SUCCESS (1.620s)
[370.139435] Starting dynamic subtest: vcs1
[372.109860] Dynamic subtest vcs1: SUCCESS (1.980s)
[372.122112] Starting dynamic subtest: vecs0
[374.157356] Dynamic subtest vecs0: SUCCESS (2.045s)
[374.168144] Starting dynamic subtest: ccs0
[374.201911] Dynamic subtest ccs0: SUCCESS (0.044s)
[374.204191] Subtest extended: SUCCESS (5.831s)
[374.444320] [089/133] (650s left) kms_psr (psr-cursor-blt)
[374.536242] Starting subtest: psr-cursor-blt
[374.538625] Starting dynamic subtest: eDP-1
[376.296148] Dynamic subtest eDP-1: SUCCESS (1.759s)
[376.298931] Subtest psr-cursor-blt: SUCCESS (1.760s)
[377.175626] [090/133] (647s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[377.271363] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[377.275865] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[378.410725] [091/133] (646s left) kms_rmfb (rmfb-ioctl)
[378.505820] Starting subtest: rmfb-ioctl
[378.508106] Starting dynamic subtest: pipe-A-eDP-1
[378.607944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[378.618174] Starting dynamic subtest: pipe-B-eDP-1
[379.763737] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[379.775464] Starting dynamic subtest: pipe-C-eDP-1
[380.887316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[380.897484] Starting dynamic subtest: pipe-D-eDP-1
[382.015724] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[382.018057] Subtest rmfb-ioctl: SUCCESS (3.513s)
[383.159627] [092/133] (641s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[383.262716] Starting subtest: 4-tiled-32bpp-rotate-270
[383.281553] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[383.417846] [093/133] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[383.521854] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[391.079909] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.559s)
[391.283370] [094/133] (633s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[391.399152] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[396.284319] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.888s)
[397.489628] [095/133] (627s left) gem_exec_params (rel-constants-invalid)
[397.546907] Starting subtest: rel-constants-invalid
[397.549344] Subtest rel-constants-invalid: SUCCESS (0.000s)
[397.687408] [096/133] (627s left) kms_pm_rpm (fences-dpms)
[399.329302] Starting subtest: fences-dpms
[399.334625] Subtest fences-dpms: SKIP (0.000s)
[399.945316] [097/133] (625s left) prime_self_import (basic-with_one_bo_two_files)
[399.983726] Starting subtest: basic-with_one_bo_two_files
[400.014950] Subtest basic-with_one_bo_two_files: SUCCESS (0.031s)
[400.118014] [098/133] (625s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[400.205539] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[400.207909] Starting dynamic subtest: pipe-A-default-mode
[400.493050] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[400.497788] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[401.350563] [099/133] (623s left) gem_exec_params (cliprects-invalid)
[401.413473] Starting subtest: cliprects-invalid
[401.415626] Subtest cliprects-invalid: SUCCESS (0.000s)
[401.517446] [100/133] (623s left) gem_mmap_gtt (basic-read)
[401.568544] Subtest basic-read: SKIP (0.000s)
[401.621085] [101/133] (623s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[406.626121] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[406.628497] Starting dynamic subtest: pipe-A-eDP-1
[418.333449] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.704s)
[418.343322] Starting dynamic subtest: pipe-B-eDP-1
[430.076312] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.743s)
[430.078726] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.451s)
[430.946102] [102/133] (594s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[436.021111] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[436.025574] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[436.870729] [103/133] (588s left) gem_exec_whisper (basic-normal-all)
[436.938791] Starting subtest: basic-normal-all
[439.240067] Subtest basic-normal-all: SUCCESS (2.301s)
[439.444694] [104/133] (586s left) i915_pm_rpm (gem-mmap-type)
[441.272475] Starting subtest: gem-mmap-type
[441.275056] Starting dynamic subtest: wb-smem0
[444.806946] Dynamic subtest wb-smem0: SUCCESS (3.537s)
[444.819551] Starting dynamic subtest: wc-smem0
[447.695180] Dynamic subtest wc-smem0: SUCCESS (2.886s)
[447.704409] Starting dynamic subtest: uc-smem0
[451.172005] Dynamic subtest uc-smem0: SUCCESS (3.476s)
[451.174346] Subtest gem-mmap-type: SUCCESS (9.903s)
[451.274597] [105/133] (574s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[451.375526] Starting subtest: fbc-rgb565-draw-pwrite
[455.925695] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.553s)
[457.140518] [106/133] (568s left) gem_userptr_blits (unsync-unmap-after-close)
[457.205118] Subtest unsync-unmap-after-close: SKIP (0.000s)
[457.363865] [107/133] (568s left) i915_pm_rps (waitboost)
[457.421856] Starting subtest: waitboost
[463.522818] Subtest waitboost: SUCCESS (6.100s)
[463.687853] [108/133] (562s left) syncobj_timeline (etime-multi-wait-all-submitted)
[463.733786] Starting subtest: etime-multi-wait-all-submitted
[463.842133] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[463.932048] [109/133] (561s left) api_intel_bb (reset-flags)
[463.981849] Starting subtest: reset-flags
[463.990004] Subtest reset-flags: SUCCESS (0.011s)
[464.132389] [110/133] (561s left) gem_spin_batch (resubmit-new)
[464.197233] Starting subtest: resubmit-new
[464.199671] Starting dynamic subtest: rcs0
[464.211727] Dynamic subtest rcs0: SUCCESS (0.014s)
[464.223691] Starting dynamic subtest: bcs0
[464.226358] Dynamic subtest bcs0: SUCCESS (0.006s)
[464.238462] Starting dynamic subtest: vcs0
[464.240701] Dynamic subtest vcs0: SUCCESS (0.007s)
[464.250252] Starting dynamic subtest: vcs1
[464.252557] Dynamic subtest vcs1: SUCCESS (0.009s)
[464.260647] Starting dynamic subtest: vecs0
[464.262519] Dynamic subtest vecs0: SUCCESS (0.006s)
[464.270570] Starting dynamic subtest: ccs0
[464.272718] Dynamic subtest ccs0: SUCCESS (0.007s)
[464.274664] Subtest resubmit-new: SUCCESS (0.053s)
[466.191233] [111/133] (559s left) gem_ctx_persistence (many-contexts)
[466.257533] Starting subtest: many-contexts
[503.983178] Subtest many-contexts: SUCCESS (37.723s)
[504.076559] [112/133] (521s left) vgem_basic (sysfs)
[504.116635] Starting subtest: sysfs
[504.118986] Subtest sysfs: SUCCESS (0.001s)
[504.196426] [113/133] (521s left) kms_cursor_crc (cursor-suspend)
[504.324897] Starting subtest: cursor-suspend
[504.327230] Starting dynamic subtest: pipe-A-eDP-1
[537.527175] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.112s)
[537.542423] Starting dynamic subtest: pipe-D-eDP-1
[571.525509] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.695s)
[571.527949] Subtest cursor-suspend: SUCCESS (6.809s)
[572.410522] [114/133] (453s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[572.522245] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[572.526774] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[572.617699] [115/133] (453s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[572.702686] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[572.705032] Starting dynamic subtest: pipe-A
[573.039081] Dynamic subtest pipe-A: SUCCESS (0.338s)
[573.048275] Starting dynamic subtest: pipe-B
[574.391272] Dynamic subtest pipe-B: SUCCESS (1.350s)
[574.401394] Starting dynamic subtest: pipe-C
[575.823248] Dynamic subtest pipe-C: SUCCESS (1.429s)
[575.834773] Starting dynamic subtest: pipe-D
[577.251566] Dynamic subtest pipe-D: SUCCESS (1.426s)
[577.253819] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.547s)
[578.438824] [116/133] (447s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[578.537245] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[578.539507] Starting dynamic subtest: pipe-A-eDP-1
[578.596839] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[578.607084] Starting dynamic subtest: pipe-B-eDP-1
[578.665152] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[578.677600] Starting dynamic subtest: pipe-C-eDP-1
[578.736654] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[578.747118] Starting dynamic subtest: pipe-D-eDP-1
[578.802927] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[578.807122] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[580.716522] [117/133] (445s left) kms_lease (setcrtc-implicit-plane)
[580.814882] Starting subtest: setcrtc-implicit-plane
[580.817177] Starting dynamic subtest: pipe-A-eDP-1
[581.292110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[581.305704] Starting dynamic subtest: pipe-B-eDP-1
[582.438846] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[582.448346] Starting dynamic subtest: pipe-C-eDP-1
[583.538418] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[583.550307] Starting dynamic subtest: pipe-D-eDP-1
[584.677097] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[584.679467] Subtest setcrtc-implicit-plane: SUCCESS (3.861s)
[585.529919] [118/133] (440s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[585.624114] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[585.626344] Starting dynamic subtest: pipe-A-eDP-1
[602.324304] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.470s)
[602.333982] Starting dynamic subtest: pipe-B-eDP-1
[619.267461] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.363s)
[619.278796] Starting dynamic subtest: pipe-C-eDP-1
[636.190628] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.273s)
[636.208084] Starting dynamic subtest: pipe-D-eDP-1
[653.183332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.236s)
[653.185589] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.347s)
[654.392149] [119/133] (371s left) gem_mmap_gtt (cpuset-basic-small-copy)
[654.473098] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[654.542341] [120/133] (371s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[654.604836] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[654.768316] [121/133] (371s left) kms_plane_multiple (tiling-y)
[654.854081] Starting subtest: tiling-y
[654.858452] Subtest tiling-y: SKIP (0.000s)
[654.936917] [122/133] (371s left) gem_eio (context-create)
[655.141913] Starting subtest: context-create
[655.439310] Subtest context-create: SUCCESS (0.298s)
[655.615345] [123/133] (370s left) vgem_basic (create)
[655.651483] Starting subtest: create
[655.653193] Subtest create: SUCCESS (0.000s)
[655.724402] [124/133] (370s left) gem_pxp (protected-raw-src-copy-not-readible)
[655.846768] Starting subtest: protected-raw-src-copy-not-readible
[655.918519] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.073s)
[656.081095] [125/133] (370s left) syncobj_wait (invalid-signal-illegal-handle)
[656.141388] Starting subtest: invalid-signal-illegal-handle
[656.143286] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[656.261090] [126/133] (370s left) kms_flip (2x-flip-vs-dpms-on-nop)
[656.357945] Starting subtest: 2x-flip-vs-dpms-on-nop
[656.366095] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[656.513440] [127/133] (369s left) kms_colorop (plane-xr30-xr30-3dlut_17_12_rgb)
[656.644448] Subtest plane-XR30-XR30-3dlut_17_12_rgb: SKIP (0.000s)
[656.738163] [128/133] (369s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[656.847844] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[656.851245] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[656.977537] [129/133] (369s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[657.069131] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[657.072567] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[657.175909] [130/133] (369s left) prime_udl
[657.256080] [131/133] (369s left) kms_content_protection (legacy)
[657.393665] Starting subtest: legacy
[657.397624] Subtest legacy: SKIP (0.000s)
[657.545117] [132/133] (369s left) kms_draw_crc (draw-method-mmap-wc)
[657.634661] Starting subtest: draw-method-mmap-wc
[657.636523] Starting dynamic subtest: xrgb8888-untiled
[657.877225] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[657.886777] Starting dynamic subtest: rgb565-untiled
[658.076835] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[658.086681] Starting dynamic subtest: xrgb2101010-untiled
[658.288406] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[658.300053] Starting dynamic subtest: xbgr16161616f-untiled
[658.499918] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[658.509622] Starting dynamic subtest: xrgb8888-xtiled
[658.633479] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[658.643973] Starting dynamic subtest: rgb565-xtiled
[658.767678] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[658.777573] Starting dynamic subtest: xrgb2101010-xtiled
[658.889068] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[658.898931] Starting dynamic subtest: xbgr16161616f-xtiled
[659.022574] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[659.033674] Starting dynamic subtest: xrgb8888-4tiled
[659.178064] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[659.187345] Starting dynamic subtest: rgb565-4tiled
[659.323287] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[659.335288] Starting dynamic subtest: xrgb2101010-4tiled
[659.467012] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[659.477497] Starting dynamic subtest: xbgr16161616f-4tiled
[659.634570] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[659.636532] Subtest draw-method-mmap-wc: SUCCESS (2.001s)
[659.779169] [133/133] (366s left) kms_cursor_crc (cursor-sliding-256x85)
[660.029321] Starting subtest: cursor-sliding-256x85
[660.074134] Subtest cursor-sliding-256x85: SKIP (0.041s)
[660.254461] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_big
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_hdr
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_caching
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_colorop
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_tiled_wb
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_vblank
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_atomic_transition
results: parsing output: 26/ for test: gem_ringfill
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_color
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_properties
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: sysfs_heartbeat_interval
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_atomic_transition
results: parsing output: 41/ for test: i915_module_load
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: api_intel_bb
results: parsing output: 47/ for test: gem_partial_pwrite_pread
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: kms_selftest
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: device_reset
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: prime_mmap
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_mmap_offset
results: parsing output: 67/ for test: kms_chamelium_frames
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_writeback
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_mmap_offset
results: parsing output: 73/ for test: gem_ccs
results: parsing output: 74/ for test: kms_pipe_stress
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_exercise_blt
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gen3_render_tiledy_blits
results: parsing output: 87/ for test: gem_busy
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_rmfb
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: prime_self_import
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_exec_params
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: gem_exec_whisper
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: i915_pm_rps
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: gem_spin_batch
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: vgem_basic
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: vgem_basic
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_colorop
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: prime_udl
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: kms_draw_crc
results: parsing output: 132/ for test: kms_cursor_crc
Done.