[60.119969] Initializing watchdogs
[60.120053]   /dev/watchdog0
[60.134466] [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.138963] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.141882] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.145213] [001/133] (960s left) gem_userptr_blits (sync-unmap)
[60.236123] Starting subtest: sync-unmap
[60.255754] Subtest sync-unmap: SUCCESS (0.019s)
[60.375176] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[60.475899] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[60.480329] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[60.561035] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[60.661388] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[60.665768] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[60.755180] [004/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[60.852377] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[61.933156] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.078s)
[62.031107] [005/133] (958s left) vgem_basic (busy-fence)
[62.108206] Starting subtest: busy-fence
[62.110183] Subtest busy-fence: SUCCESS (0.000s)
[62.162479] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[62.165348] [006/133] (958s left) kms_fence_pin_leak
[62.329700] [007/133] (958s left) gem_exec_reloc (basic-cpu-wc)
[62.386152] Subtest basic-cpu-wc: SKIP (0.000s)
[62.449033] [008/133] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[62.540301] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[70.413889] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.862s)
[70.537138] [009/133] (950s left) gem_exec_fence (syncobj-timeline-signal)
[71.077557] Starting subtest: syncobj-timeline-signal
[71.084425] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[72.972091] [010/133] (948s left) gem_exec_basic (basic)
[73.023078] Starting subtest: basic
[73.025575] Starting dynamic subtest: rcs0-smem
[73.030292] Dynamic subtest rcs0-smem: SUCCESS (0.007s)
[73.043061] Starting dynamic subtest: bcs0-smem
[73.045597] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[73.054055] Starting dynamic subtest: vcs0-smem
[73.056184] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[73.063584] Starting dynamic subtest: vcs1-smem
[73.065743] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[73.073150] Starting dynamic subtest: vecs0-smem
[73.075479] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[73.083239] Starting dynamic subtest: ccs0-smem
[73.085182] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[73.087062] Subtest basic: SUCCESS (0.027s)
[74.878971] [011/133] (946s left) kms_flip (dpms-vs-vblank-race-interruptible)
[74.974781] Starting subtest: dpms-vs-vblank-race-interruptible
[74.977105] Starting dynamic subtest: A-eDP1
[79.940412] Dynamic subtest A-eDP1: SUCCESS (4.960s)
[79.949527] Starting dynamic subtest: B-eDP1
[84.570452] Dynamic subtest B-eDP1: SUCCESS (4.625s)
[84.586508] Starting dynamic subtest: C-eDP1
[89.198401] Dynamic subtest C-eDP1: SUCCESS (4.627s)
[89.207798] Starting dynamic subtest: D-eDP1
[93.837558] Dynamic subtest D-eDP1: SUCCESS (4.636s)
[93.839713] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.858s)
[94.709356] [012/133] (926s left) gem_exec_schedule (pi-userfault)
[94.899154] Starting subtest: pi-userfault
[94.901860] Starting dynamic subtest: rcs0
[94.909375] Dynamic subtest rcs0: SUCCESS (0.013s)
[94.918527] Starting dynamic subtest: bcs0
[94.920928] Dynamic subtest bcs0: SUCCESS (0.009s)
[94.928647] Starting dynamic subtest: vcs0
[94.930999] Dynamic subtest vcs0: SUCCESS (0.009s)
[94.941965] Starting dynamic subtest: vcs1
[94.944333] Dynamic subtest vcs1: SUCCESS (0.009s)
[94.952054] Starting dynamic subtest: vecs0
[94.954189] Dynamic subtest vecs0: SUCCESS (0.010s)
[94.961656] Starting dynamic subtest: ccs0
[94.963615] Dynamic subtest ccs0: SUCCESS (0.007s)
[94.965609] Subtest pi-userfault: SUCCESS (0.059s)
[95.142557] [013/133] (925s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[95.244837] Starting subtest: yf-tiled-64bpp-rotate-180
[95.249326] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[95.362192] [014/133] (925s left) core_auth (many-magics)
[95.421343] Starting subtest: many-magics
[96.260932] Subtest many-magics: SUCCESS (0.842s)
[96.413838] [015/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[96.504235] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[96.506513] Starting dynamic subtest: pipe-A-eDP-1
[96.662567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[96.672490] Starting dynamic subtest: pipe-B-eDP-1
[96.688362] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[96.695934] Starting dynamic subtest: pipe-C-eDP-1
[96.713366] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[96.720873] Starting dynamic subtest: pipe-D-eDP-1
[96.737305] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[96.739090] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.186s)
[98.958233] [016/133] (922s left) gem_mmap_wc (write-read)
[99.011044] Subtest write-read: SKIP (0.000s)
[99.074069] [017/133] (922s left) kms_cursor_crc (cursor-onscreen-512x512)
[99.349733] Starting subtest: cursor-onscreen-512x512
[99.354245] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[99.512606] [018/133] (921s left) kms_chamelium_frames (vga-frame-dump)
[99.905882] Subtest vga-frame-dump: SKIP (0.000s)
[100.688922] [019/133] (920s left) kms_plane_scaling (invalid-num-scalers)
[100.776499] Starting subtest: invalid-num-scalers
[100.778947] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[100.798186] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[100.806487] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[100.831753] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[100.839681] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[100.865360] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[100.873841] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[100.897257] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[100.899622] Subtest invalid-num-scalers: SUCCESS (0.120s)
[101.000798] [020/133] (920s left) gem_exec_reloc (basic-write-wc-active)
[101.072279] Subtest basic-write-wc-active: SKIP (0.000s)
[101.154230] [021/133] (920s left) perf_pmu (init-busy)
[101.195199] Starting subtest: init-busy
[101.197451] Starting dynamic subtest: rcs0
[101.199615] Dynamic subtest rcs0: SUCCESS (0.002s)
[101.208260] Starting dynamic subtest: bcs0
[101.210476] Dynamic subtest bcs0: SUCCESS (0.000s)
[101.218145] Starting dynamic subtest: vcs0
[101.220341] Dynamic subtest vcs0: SUCCESS (0.001s)
[101.228023] Starting dynamic subtest: vcs1
[101.229922] Dynamic subtest vcs1: SUCCESS (0.001s)
[101.237262] Starting dynamic subtest: vecs0
[101.239135] Dynamic subtest vecs0: SUCCESS (0.001s)
[101.246301] Starting dynamic subtest: ccs0
[101.248179] Dynamic subtest ccs0: SUCCESS (0.000s)
[101.250428] Subtest init-busy: SUCCESS (0.006s)
[101.311287] [022/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[101.424964] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[101.429122] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[101.525680] [023/133] (920s left) gem_lmem_swapping (heavy-verify-random)
[101.574256] Subtest heavy-verify-random: SKIP (0.000s)
[101.612250] [024/133] (919s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[101.706052] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[101.709924] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[102.844069] [025/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[102.946667] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[102.951059] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[103.043047] [026/133] (918s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[103.107853] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[103.110582] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[103.214884] [027/133] (918s left) kms_content_protection (type1)
[103.361850] Starting subtest: type1
[103.366609] Subtest type1: SKIP (0.000s)
[103.487947] [028/133] (918s left) prime_vgem (fence-wait)
[103.551237] Starting subtest: fence-wait
[103.553086] Starting dynamic subtest: rcs0
[104.592112] Dynamic subtest rcs0: SUCCESS (1.040s)
[104.602044] Starting dynamic subtest: bcs0
[105.649963] Dynamic subtest bcs0: SUCCESS (1.057s)
[105.660670] Starting dynamic subtest: vcs0
[106.696692] Dynamic subtest vcs0: SUCCESS (1.044s)
[106.706844] Starting dynamic subtest: vcs1
[107.741107] Dynamic subtest vcs1: SUCCESS (1.043s)
[107.751837] Starting dynamic subtest: vecs0
[108.784561] Dynamic subtest vecs0: SUCCESS (1.042s)
[108.795537] Starting dynamic subtest: ccs0
[109.900965] Dynamic subtest ccs0: SUCCESS (1.114s)
[109.903797] Subtest fence-wait: SUCCESS (6.349s)
[110.045828] [029/133] (911s left) syncobj_timeline (invalid-signal-zero-handles)
[110.106283] Starting subtest: invalid-signal-zero-handles
[110.108669] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[110.211883] [030/133] (911s left) gem_mmap_wc (coherency)
[110.264992] Subtest coherency: SKIP (0.000s)
[110.320723] [031/133] (911s left) gem_mmap_gtt (basic-short)
[110.378785] Subtest basic-short: SKIP (0.000s)
[110.437049] [032/133] (911s left) perf (per-context-mode-unprivileged)
[110.560301] Starting subtest: per-context-mode-unprivileged
[110.564761] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[110.605618] [033/133] (911s left) kms_chamelium_audio (dp-audio-edid)
[111.003288] Subtest dp-audio-edid: SKIP (0.000s)
[111.849776] [034/133] (910s left) gen9_exec_parse (cmd-crossing-page)
[111.907872] Subtest cmd-crossing-page: SKIP (0.000s)
[111.981929] [035/133] (910s left) gem_spin_batch (user-each)
[112.045474] Starting subtest: user-each
[115.312958] Subtest user-each: SUCCESS (3.260s)
[115.939425] [036/133] (906s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[116.045084] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[116.047432] Starting dynamic subtest: pipe-A-default-mode
[118.788332] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[118.790336] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.744s)
[119.660858] [037/133] (902s left) gem_userptr_blits (create-destroy-unsync)
[119.731428] Subtest create-destroy-unsync: SKIP (0.000s)
[119.870270] [038/133] (902s left) kms_cursor_crc (cursor-sliding-512x512)
[120.135880] Starting subtest: cursor-sliding-512x512
[120.140463] Subtest cursor-sliding-512x512: SKIP (0.001s)
[120.295209] [039/133] (901s left) gem_ctx_persistence (heartbeat-many)
[120.360480] Starting subtest: heartbeat-many
[120.364975] Subtest heartbeat-many: SKIP (0.000s)
[120.456589] [040/133] (901s left) gem_exec_whisper (basic-forked-all)
[120.522993] Starting subtest: basic-forked-all
[133.487683] Subtest basic-forked-all: SUCCESS (12.961s)
[133.673270] [041/133] (888s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[133.769308] Starting subtest: fbcpsr-tiling-4
[140.875091] Subtest fbcpsr-tiling-4: SUCCESS (7.108s)
[141.008433] [042/133] (881s left) kms_psr (fbc-psr2-sprite-plane-move)
[141.096084] Starting subtest: fbc-psr2-sprite-plane-move
[141.098330] Starting dynamic subtest: eDP-1
[141.102615] Dynamic subtest eDP-1: SKIP (0.000s)
[141.106981] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[141.175827] [043/133] (881s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[141.264848] Starting subtest: fb-8bpc-vs-panel-6bpc
[141.267103] Starting dynamic subtest: pipe-A-eDP-1
[142.674691] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.410s)
[142.676876] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.411s)
[143.541650] [044/133] (878s left) kms_vblank (query-idle-hang)
[143.636079] Starting subtest: query-idle-hang
[143.637957] Starting dynamic subtest: pipe-A-eDP-1
[170.655574] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.019s)
[170.669071] Starting dynamic subtest: pipe-D-eDP-1
[185.687255] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.027s)
[185.689262] Subtest query-idle-hang: SUCCESS (42.050s)
[186.496626] [045/133] (835s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[186.589853] Starting subtest: async-flip-with-page-flip-events-linear
[186.974082] Starting dynamic subtest: pipe-A-eDP-1
[189.776214] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[190.149882] Starting dynamic subtest: pipe-B-eDP-1
[192.902480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[193.266722] Starting dynamic subtest: pipe-C-eDP-1
[196.026972] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[196.386270] Starting dynamic subtest: pipe-D-eDP-1
[199.152156] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[199.154744] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.563s)
[200.332686] [046/133] (822s left) sw_sync (alloc_fence_invalid_timeline)
[200.375690] Starting subtest: alloc_fence_invalid_timeline
[200.378069] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[200.428381] [047/133] (822s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[200.530767] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[200.533058] Starting dynamic subtest: pipe-A-default-mode
[203.281534] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[203.283941] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.753s)
[204.132213] [048/133] (818s left) kms_flip (2x-flip-vs-wf_vblank)
[204.222465] Starting subtest: 2x-flip-vs-wf_vblank
[204.234283] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[204.340263] [049/133] (818s left) kms_flip (2x-nonexisting-fb)
[204.446573] Starting subtest: 2x-nonexisting-fb
[204.456464] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[204.572099] [050/133] (818s left) gem_exec_schedule (promotion)
[204.646241] Starting subtest: promotion
[204.648189] Starting dynamic subtest: rcs0
[204.755353] Dynamic subtest rcs0: SUCCESS (0.116s)
[204.767077] Starting dynamic subtest: vcs0
[204.839795] Dynamic subtest vcs0: SUCCESS (0.084s)
[204.851300] Starting dynamic subtest: vcs1
[204.924284] Dynamic subtest vcs1: SUCCESS (0.084s)
[204.933813] Starting dynamic subtest: vecs0
[205.007744] Dynamic subtest vecs0: SUCCESS (0.082s)
[205.019307] Starting dynamic subtest: ccs0
[205.092439] Dynamic subtest ccs0: SUCCESS (0.083s)
[205.095424] Subtest promotion: SUCCESS (0.454s)
[206.019391] [051/133] (816s left) kms_cursor_crc (cursor-random-max-size)
[206.318683] Starting subtest: cursor-random-max-size
[206.325405] Subtest cursor-random-max-size: SKIP (0.000s)
[206.455428] [052/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[206.561545] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[213.938110] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.379s)
[214.097343] [053/133] (808s left) kms_flip (flip-vs-blocking-wf-vblank)
[214.188792] Starting subtest: flip-vs-blocking-wf-vblank
[214.191110] Starting dynamic subtest: A-eDP1
[223.109514] Dynamic subtest A-eDP1: SUCCESS (8.922s)
[223.117519] Starting dynamic subtest: B-eDP1
[232.040982] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[232.053416] Starting dynamic subtest: C-eDP1
[240.969618] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[240.980263] Starting dynamic subtest: D-eDP1
[249.908354] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[249.913186] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.725s)
[251.157385] [054/133] (771s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[251.256143] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[251.258346] Starting dynamic subtest: pipe-A-eDP-1
[267.730690] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.477s)
[267.745921] Starting dynamic subtest: pipe-B-eDP-1
[284.907474] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.174s)
[284.909787] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.655s)
[285.706736] [055/133] (737s left) i915_drm_fdinfo (most-busy-check-all)
[285.758040] Starting subtest: most-busy-check-all
[285.760424] Starting dynamic subtest: rcs0
[285.765121] Dynamic subtest rcs0: SKIP (0.003s)
[285.774586] Starting dynamic subtest: bcs0
[285.778892] Dynamic subtest bcs0: SKIP (0.000s)
[285.787301] Starting dynamic subtest: vcs0
[285.791957] Dynamic subtest vcs0: SKIP (0.000s)
[285.800264] Starting dynamic subtest: vcs1
[285.804698] Dynamic subtest vcs1: SKIP (0.000s)
[285.813090] Starting dynamic subtest: vecs0
[285.817607] Dynamic subtest vecs0: SKIP (0.000s)
[285.825926] Starting dynamic subtest: ccs0
[285.830455] Dynamic subtest ccs0: SKIP (0.000s)
[285.835028] Subtest most-busy-check-all: SKIP (0.009s)
[285.872755] [056/133] (737s left) gem_pxp (verify-pxp-stale-buf-execution)
[286.031864] Starting subtest: verify-pxp-stale-buf-execution
[287.091861] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[287.216677] [057/133] (735s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[287.275243] Starting subtest: y-tiled-ccs-to-yf-tiled
[287.279781] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[287.470849] [058/133] (735s left) i915_pm_rpm (gem-idle)
[289.107628] Starting subtest: gem-idle
[295.324693] Subtest gem-idle: SUCCESS (6.218s)
[295.667538] [059/133] (727s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[296.828881] Starting subtest: y-tiled-ccs-to-y-tiled
[296.833820] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[297.013963] [060/133] (726s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[297.113204] Starting subtest: fbc-psr2-cursor-mmap-gtt
[297.115481] Starting dynamic subtest: eDP-1
[297.119944] Dynamic subtest eDP-1: SKIP (0.000s)
[297.124382] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[297.203907] [061/133] (725s left) kms_color_pipeline (plane-ctm3x4)
[297.297890] Starting subtest: plane-ctm3x4
[297.444155] Starting dynamic subtest: pipe-A-plane-0
[297.587799] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[297.597642] Starting dynamic subtest: pipe-A-plane-1
[297.721116] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[297.730692] Starting dynamic subtest: pipe-A-plane-2
[297.855967] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[299.068780] Starting dynamic subtest: pipe-B-plane-0
[299.206700] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[299.215664] Starting dynamic subtest: pipe-B-plane-1
[299.350595] Dynamic subtest pipe-B-plane-1: SUCCESS (0.143s)
[299.359593] Starting dynamic subtest: pipe-B-plane-2
[299.484086] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[300.696124] Starting dynamic subtest: pipe-C-plane-0
[300.801355] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[300.818615] Starting dynamic subtest: pipe-C-plane-1
[300.910895] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[300.920155] Starting dynamic subtest: pipe-C-plane-2
[301.022043] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[302.233490] Starting dynamic subtest: pipe-D-plane-0
[302.348071] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s)
[302.357077] Starting dynamic subtest: pipe-D-plane-1
[302.481609] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[302.490953] Starting dynamic subtest: pipe-D-plane-2
[302.604056] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[302.890911] Subtest plane-ctm3x4: SUCCESS (5.594s)
[303.703781] [062/133] (719s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[303.795324] Starting subtest: x-tiled-8bpp-rotate-180
[304.997775] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.202s)
[305.135140] [063/133] (718s left) perf_pmu (invalid-init)
[305.174433] Starting subtest: invalid-init
[305.176475] Subtest invalid-init: SUCCESS (0.000s)
[305.285742] [064/133] (718s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[305.374487] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[305.378111] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[305.472268] [065/133] (717s left) gem_reg_read (bad-register)
[305.521545] Starting subtest: bad-register
[305.523248] Subtest bad-register: SUCCESS (0.000s)
[305.613844] [066/133] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[305.709046] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[305.712522] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[305.824811] [067/133] (717s left) gem_ccs (suspend-resume)
[305.884948] Starting subtest: suspend-resume
[305.888896] Subtest suspend-resume: SKIP (0.000s)
[305.982711] [068/133] (717s left) perf (gen12-oa-tlb-invalidate)
[306.084583] Starting subtest: gen12-oa-tlb-invalidate
[306.086804] Starting dynamic subtest: 0-rcs0
[316.126055] Dynamic subtest 0-rcs0: SUCCESS (10.038s)
[316.135318] Starting dynamic subtest: 1-vecs0
[326.173896] Dynamic subtest 1-vecs0: SUCCESS (10.046s)
[326.176935] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.087s)
[326.223671] [069/133] (697s left) prime_vgem (fence-read-hang)
[326.297311] Subtest fence-read-hang: SKIP (0.000s)
[326.396673] [070/133] (697s left) syncobj_basic (bad-create-flags)
[326.457167] Starting subtest: bad-create-flags
[326.459423] Subtest bad-create-flags: SUCCESS (0.000s)
[326.567368] [071/133] (697s left) kms_setmode (basic)
[326.624585] Starting subtest: basic
[326.943350] Starting dynamic subtest: pipe-A-eDP-1
[329.003770] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.056s)
[329.345522] Starting dynamic subtest: pipe-B-eDP-1
[331.431779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[331.738965] Subtest basic: SUCCESS (5.114s)
[332.584116] [072/133] (691s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[332.629915] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[332.739383] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[332.816825] [073/133] (690s left) gem_vm_create (invalid-create)
[332.868673] Starting subtest: invalid-create
[332.873903] Subtest invalid-create: SUCCESS (0.002s)
[332.977264] [074/133] (690s left) kms_prop_blob (invalid-get-prop)
[333.030451] Starting subtest: invalid-get-prop
[333.032619] Subtest invalid-get-prop: SUCCESS (0.000s)
[333.146577] [075/133] (690s left) gem_exec_alignment (pi-isolated)
[333.198770] Starting subtest: pi-isolated
[385.072394] Subtest pi-isolated: SUCCESS (51.867s)
[386.014810] [076/133] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[386.151142] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[386.155184] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[386.247357] [077/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[386.333462] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[386.337852] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[386.415459] [078/133] (637s left) gem_ctx_exec (basic-norecovery)
[386.473717] Starting subtest: basic-norecovery
[386.809719] Subtest basic-norecovery: SUCCESS (0.336s)
[386.921385] [079/133] (637s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[387.008381] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[387.010341] Starting dynamic subtest: pipe-A-eDP-1
[387.029508] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[387.039517] Starting dynamic subtest: pipe-B-eDP-1
[387.063794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[387.072756] Starting dynamic subtest: pipe-C-eDP-1
[387.090276] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[387.099192] Starting dynamic subtest: pipe-D-eDP-1
[387.117425] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[387.120954] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[389.281747] [080/133] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[389.377630] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[389.381693] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[389.486401] [081/133] (634s left) kms_getfb (getfb2-handle-not-fb)
[389.576856] Starting subtest: getfb2-handle-not-fb
[389.579181] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[389.677568] [082/133] (634s left) gem_mmap_offset (partial-remap)
[389.735427] Starting subtest: partial-remap
[389.737686] Starting dynamic subtest: smem0
[389.746596] Dynamic subtest smem0: SUCCESS (0.004s)
[389.748538] Subtest partial-remap: SUCCESS (0.005s)
[389.828214] [083/133] (634s left) kms_psr (pr-suspend)
[389.918620] Starting subtest: pr-suspend
[389.923264] Subtest pr-suspend: SKIP (0.000s)
[389.995778] [084/133] (634s left) kms_plane_alpha_blend (alpha-basic)
[390.086454] Starting subtest: alpha-basic
[390.387458] Starting dynamic subtest: pipe-A-eDP-1
[392.316226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s)
[392.344932] Starting dynamic subtest: pipe-D-eDP-1
[395.040195] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.701s)
[395.042519] Subtest alpha-basic: SUCCESS (4.951s)
[395.839974] [085/133] (628s left) gem_set_tiling_vs_gtt
[395.951475] [086/133] (628s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[396.051975] Starting subtest: yf-tiled-16bpp-rotate-90
[396.056427] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[396.145608] [087/133] (628s left) kms_psr (psr2-suspend)
[396.236695] Starting subtest: psr2-suspend
[396.238864] Starting dynamic subtest: eDP-1
[413.513148] Dynamic subtest eDP-1: SUCCESS (3.730s)
[413.515556] Subtest psr2-suspend: SUCCESS (3.731s)
[414.327599] [088/133] (610s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[414.467557] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[414.471961] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[414.572952] [089/133] (609s left) gem_ctx_create (basic)
[414.643369] Starting subtest: basic
[414.645838] Subtest basic: SUCCESS (0.000s)
[414.845358] [090/133] (609s left) kms_pm_dc (dc5-retention-flops)
[415.951946] Starting subtest: dc5-retention-flops
[415.956446] Subtest dc5-retention-flops: SKIP (0.000s)
[416.029097] [091/133] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[416.133131] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[416.137374] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[416.226766] [092/133] (608s left) kms_sequence (get-forked-busy)
[416.323578] Starting subtest: get-forked-busy
[416.326282] Starting dynamic subtest: pipe-A-eDP-1
[418.312262] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.953s)
[418.322864] Starting dynamic subtest: pipe-B-eDP-1
[420.939586] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.590s)
[420.951153] Starting dynamic subtest: pipe-C-eDP-1
[423.564172] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[423.576038] Starting dynamic subtest: pipe-D-eDP-1
[426.116176] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[426.118343] Subtest get-forked-busy: SUCCESS (9.687s)
[426.910917] [093/133] (597s left) dmabuf_sync_file (import-multiple-read-write)
[426.960983] Starting subtest: import-multiple-read-write
[426.962829] Subtest import-multiple-read-write: SUCCESS (0.004s)
[427.021860] [094/133] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[427.120718] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[427.125048] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[427.220616] [095/133] (597s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[427.317052] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[427.319412] Starting dynamic subtest: pipe-A-eDP-1
[427.341886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[427.354947] Starting dynamic subtest: pipe-B-eDP-1
[427.373906] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[427.384261] Starting dynamic subtest: pipe-C-eDP-1
[427.404391] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[427.414750] Starting dynamic subtest: pipe-D-eDP-1
[427.434541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[427.436696] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[429.596422] [096/133] (595s left) gem_exec_flush (basic-uc-prw-default)
[429.655304] Starting subtest: basic-uc-prw-default
[435.135803] Subtest basic-uc-prw-default: SUCCESS (5.466s)
[435.322794] [097/133] (589s left) gem_exec_reloc (basic-wc)
[435.388835] Subtest basic-wc: SKIP (0.000s)
[435.479201] [098/133] (589s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[435.582810] Starting subtest: y-tiled-64bpp-rotate-90
[435.586827] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[435.696462] [099/133] (589s left) i915_suspend (debugfs-reader)
[435.754649] Starting subtest: debugfs-reader
[454.080645] Subtest debugfs-reader: SUCCESS (3.130s)
[454.245226] [100/133] (570s left) gem_exec_params (invalid-bsd-ring)
[454.319365] Starting subtest: invalid-bsd-ring
[454.321822] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[454.422716] [101/133] (570s left) kms_plane_scaling (planes-upscale-factor-0-25)
[454.512271] Starting subtest: planes-upscale-factor-0-25
[454.514451] Starting dynamic subtest: pipe-A
[454.572591] Dynamic subtest pipe-A: SUCCESS (0.062s)
[454.583326] Starting dynamic subtest: pipe-B
[455.678379] Dynamic subtest pipe-B: SUCCESS (1.103s)
[455.690658] Starting dynamic subtest: pipe-C
[456.793766] Dynamic subtest pipe-C: SUCCESS (1.113s)
[456.803885] Starting dynamic subtest: pipe-D
[457.934794] Dynamic subtest pipe-D: SUCCESS (1.139s)
[457.937057] Subtest planes-upscale-factor-0-25: SUCCESS (3.421s)
[459.096379] [102/133] (565s left) i915_pm_freq_api (freq-reset)
[459.163271] Starting subtest: freq-reset
[459.165784] Starting dynamic subtest: gt0
[459.356192] Dynamic subtest gt0: SUCCESS (0.192s)
[459.367535] Starting dynamic subtest: gt1
[459.530436] Dynamic subtest gt1: SUCCESS (0.171s)
[459.533328] Subtest freq-reset: SUCCESS (0.366s)
[459.623931] [103/133] (565s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[459.731639] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[459.735701] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[459.799619] [104/133] (565s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[459.851824] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[459.959949] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[460.052076] [105/133] (565s left) syncobj_wait (wait-for-submit-snapshot)
[460.101744] Starting subtest: wait-for-submit-snapshot
[460.182509] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[460.261667] [106/133] (564s left) kms_pm_rpm (pm-tiling)
[461.810713] Starting subtest: pm-tiling
[461.819668] Subtest pm-tiling: SKIP (0.000s)
[462.544724] [107/133] (562s left) gem_mmap_gtt (cpuset-basic-small-copy)
[462.618315] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[462.684955] [108/133] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[462.786940] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[466.534967] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.751s)
[467.714383] [109/133] (557s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[467.769277] Starting subtest: single-wait-all-for-submit-available-submitted
[467.771504] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[467.872595] [110/133] (557s left) kms_rotation_crc (primary-rotation-180)
[467.974289] Starting subtest: primary-rotation-180
[475.093928] Subtest primary-rotation-180: SUCCESS (7.117s)
[476.265848] [111/133] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[476.364158] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[476.368613] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[476.474086] [112/133] (549s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[476.566090] Starting subtest: primary-4-tiled-reflect-x-0
[483.717564] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.147s)
[484.961593] [113/133] (540s left) kms_plane_lowres (tiling-x)
[485.053755] Starting subtest: tiling-x
[485.056108] Starting dynamic subtest: pipe-A-eDP-1
[485.060644] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.356066] Starting dynamic subtest: pipe-B-eDP-1
[485.360903] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.371205] Starting dynamic subtest: pipe-C-eDP-1
[485.376039] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.386144] Starting dynamic subtest: pipe-D-eDP-1
[485.390243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.394309] Subtest tiling-x: SKIP (0.295s)
[486.225658] [114/133] (539s left) kms_lease (lease-revoke)
[486.325832] Starting subtest: lease-revoke
[486.328296] Starting dynamic subtest: pipe-A-eDP-1
[486.358701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[486.369561] Starting dynamic subtest: pipe-B-eDP-1
[486.389505] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[486.400339] Starting dynamic subtest: pipe-C-eDP-1
[486.419488] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[486.430225] Starting dynamic subtest: pipe-D-eDP-1
[486.448312] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[486.450566] Subtest lease-revoke: SUCCESS (0.121s)
[486.592952] [115/133] (539s left) kms_hdr (static-toggle-dpms)
[486.690450] Starting subtest: static-toggle-dpms
[486.696930] Subtest static-toggle-dpms: SKIP (0.000s)
[486.780874] [116/133] (538s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[486.872594] Starting subtest: primary-yf-tiled-reflect-x-270
[486.876736] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[486.946696] [117/133] (538s left) gem_ccs (block-copy-uncompressed)
[487.006692] Starting subtest: block-copy-uncompressed
[487.008863] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[487.033382] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.025s)
[487.046118] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[487.051940] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[487.062361] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[487.073083] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[487.083717] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[487.091308] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[487.093571] Subtest block-copy-uncompressed: SUCCESS (0.084s)
[487.204781] [118/133] (538s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[487.289542] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[487.291324] Starting dynamic subtest: pipe-A-eDP-1
[487.309686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.322523] Starting dynamic subtest: pipe-B-eDP-1
[487.340951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.350650] Starting dynamic subtest: pipe-C-eDP-1
[487.368525] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[487.378003] Starting dynamic subtest: pipe-D-eDP-1
[487.396354] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[487.399671] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[489.543770] [119/133] (536s left) vgem_basic (setversion)
[489.594991] Starting subtest: setversion
[489.599508] Subtest setversion: SUCCESS (0.000s)
[489.667671] [120/133] (536s left) api_intel_bb (purge-bb)
[489.734635] Starting subtest: purge-bb
[489.736552] Subtest purge-bb: SUCCESS (0.004s)
[489.866881] [121/133] (536s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[489.984719] Starting subtest: cursorB-vs-flipA-toggle
[489.989076] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[490.146729] [122/133] (535s left) kms_draw_crc (draw-method-pwrite)
[490.246753] Starting subtest: draw-method-pwrite
[490.249088] Starting dynamic subtest: xrgb8888-untiled
[490.866123] Dynamic subtest xrgb8888-untiled: SUCCESS (0.612s)
[490.879064] Starting dynamic subtest: rgb565-untiled
[491.337229] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[491.350093] Starting dynamic subtest: xrgb2101010-untiled
[491.897757] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[491.908559] Starting dynamic subtest: xbgr16161616f-untiled
[492.682179] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[492.693017] Starting dynamic subtest: xrgb8888-xtiled
[494.517618] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.820s)
[494.528551] Starting dynamic subtest: rgb565-xtiled
[495.647773] Dynamic subtest rgb565-xtiled: SUCCESS (1.121s)
[495.659579] Starting dynamic subtest: xrgb2101010-xtiled
[497.489477] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.833s)
[497.500171] Starting dynamic subtest: xbgr16161616f-xtiled
[500.868792] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.364s)
[500.879540] Starting dynamic subtest: xrgb8888-4tiled
[501.994561] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.121s)
[502.005611] Starting dynamic subtest: rgb565-4tiled
[502.574491] Dynamic subtest rgb565-4tiled: SUCCESS (0.576s)
[502.587303] Starting dynamic subtest: xrgb2101010-4tiled
[503.699072] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.122s)
[503.710305] Starting dynamic subtest: xbgr16161616f-4tiled
[506.772194] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.065s)
[506.774559] Subtest draw-method-pwrite: SUCCESS (16.447s)
[506.880978] [123/133] (519s left) kms_flip (dpms-off-confusion-interruptible)
[506.977433] Starting subtest: dpms-off-confusion-interruptible
[506.979757] Starting dynamic subtest: A-eDP1
[515.631902] Dynamic subtest A-eDP1: SUCCESS (8.643s)
[515.643849] Starting dynamic subtest: B-eDP1
[524.271954] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[524.284257] Starting dynamic subtest: C-eDP1
[532.880604] Dynamic subtest C-eDP1: SUCCESS (8.606s)
[532.892564] Starting dynamic subtest: D-eDP1
[541.520527] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[541.526078] Subtest dpms-off-confusion-interruptible: SUCCESS (34.532s)
[542.695112] [124/133] (483s left) kms_atomic (atomic-invalid-params)
[542.785923] Starting subtest: atomic-invalid-params
[542.788518] Starting dynamic subtest: pipe-A-eDP-1
[543.180672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[543.183108] Subtest atomic-invalid-params: SUCCESS (0.396s)
[544.018354] [125/133] (482s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[544.088400] Starting subtest: map-fixed-invalidate-overlap-busy
[544.092851] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[544.241400] [126/133] (481s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[544.336169] Starting subtest: plane-all-modeset-transition-fencing
[544.340359] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[544.414926] [127/133] (481s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[544.504503] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[544.509010] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[544.584049] [128/133] (481s left) gem_exec_balancer (bonded-false-hang)
[544.849953] Starting subtest: bonded-false-hang
[544.855150] Subtest bonded-false-hang: SKIP (0.000s)
[544.951984] [129/133] (481s left) kms_chamelium_edid (hdmi-edid-read)
[545.327327] Subtest hdmi-edid-read: SKIP (0.000s)
[546.142579] [130/133] (480s left) gem_tiled_partial_pwrite_pread (reads)
[546.202137] Subtest reads: SKIP (0.000s)
[546.282599] [131/133] (480s left) kms_big_fb (linear-32bpp-rotate-180)
[546.392542] Starting subtest: linear-32bpp-rotate-180
[548.018788] Subtest linear-32bpp-rotate-180: SUCCESS (1.626s)
[548.157477] [132/133] (478s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[548.729233] Starting subtest: syncobj-timeline-invalid-flags
[548.731715] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[549.736876] [133/133] (476s left) gem_ppgtt (shrink-vs-evict-pinned)
[549.800528] Starting subtest: shrink-vs-evict-pinned
[555.638542] Subtest shrink-vs-evict-pinned: SUCCESS (5.835s)
[555.719315] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_fence_pin_leak
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: gem_exec_basic
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: core_auth
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_dither
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_reg_read
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ccs
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_setmode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_vm_create
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: gem_exec_alignment
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_exec
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_getfb
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: gem_set_tiling_vs_gtt
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_create
results: parsing output: 89/ for test: kms_pm_dc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: dmabuf_sync_file
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: i915_pm_freq_api
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_plane_lowres
results: parsing output: 113/ for test: kms_lease
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: gem_ccs
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_chamelium_edid
results: parsing output: 129/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: gem_ppgtt
Done.