[63.614499] Initializing watchdogs
[63.614582]   /dev/watchdog0
[63.645514] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[63.660551] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.665280] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.667943] [001/155] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[65.169040] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[65.171057] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[65.311523] [002/155] (958s left) core_getversion (basic)
[65.370178] Starting subtest: basic
[65.372398] Subtest basic: SUCCESS (0.000s)
[65.470196] [003/155] (958s left) kms_psr (fbc-pr-dpms)
[66.961151] Subtest fbc-pr-dpms: SKIP (0.000s)
[67.042687] [004/155] (957s left) kms_psr (fbc-psr2-basic)
[68.803506] Subtest fbc-psr2-basic: SKIP (0.000s)
[68.980056] [005/155] (955s left) gem_exec_schedule (u-submit-golden-slice)
[69.049224] Starting subtest: u-submit-golden-slice
[69.050149] Starting dynamic subtest: rcs0
[69.117659] Dynamic subtest rcs0: SUCCESS (0.068s)
[69.127474] Starting dynamic subtest: bcs0
[69.163249] Dynamic subtest bcs0: SUCCESS (0.045s)
[69.171936] Starting dynamic subtest: vcs0
[69.207268] Dynamic subtest vcs0: SUCCESS (0.044s)
[69.216035] Starting dynamic subtest: vcs1
[69.252030] Dynamic subtest vcs1: SUCCESS (0.045s)
[69.260896] Starting dynamic subtest: vecs0
[69.296159] Dynamic subtest vecs0: SUCCESS (0.044s)
[69.297044] Subtest u-submit-golden-slice: SUCCESS (0.247s)
[69.766054] [006/155] (954s left) kms_cursor_crc (cursor-onscreen-max-size)
[71.586887] Starting subtest: cursor-onscreen-max-size
[71.589413] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[71.784662] [007/155] (952s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[73.279926] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[73.282107] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[73.446911] [008/155] (951s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[73.501883] Starting subtest: invalid-bsd1-flag-on-blt
[73.503104] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[73.712096] [009/155] (951s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[75.262461] Starting subtest: dp-mst-type-0-suspend-resume
[75.264125] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[75.447297] [010/155] (949s left) syncobj_wait (multi-wait-all-submitted-signaled)
[75.493950] Starting subtest: multi-wait-all-submitted-signaled
[75.607585] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.109s)
[75.767232] [011/155] (949s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[77.252910] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[77.253869] Starting dynamic subtest: pipe-A-HDMI-A-3
[77.263086] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[77.272022] Starting dynamic subtest: pipe-B-HDMI-A-3
[77.281849] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[77.291734] Starting dynamic subtest: pipe-C-HDMI-A-3
[77.301409] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[77.310122] Starting dynamic subtest: pipe-D-HDMI-A-3
[77.320170] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[77.322196] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[77.518424] [012/155] (947s left) gem_exec_params (invalid-bsd-ring)
[77.570927] Starting subtest: invalid-bsd-ring
[77.571874] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[77.742037] [013/155] (947s left) gem_ctx_isolation (dirty-switch)
[77.798027] Starting subtest: dirty-switch
[77.798868] Starting dynamic subtest: rcs0
[78.603279] Dynamic subtest rcs0: SUCCESS (0.805s)
[78.612234] Starting dynamic subtest: bcs0
[79.452404] Dynamic subtest bcs0: SUCCESS (0.849s)
[79.461208] Starting dynamic subtest: vcs0
[80.308660] Dynamic subtest vcs0: SUCCESS (0.856s)
[80.317723] Starting dynamic subtest: vcs1
[81.135072] Dynamic subtest vcs1: SUCCESS (0.826s)
[81.144044] Starting dynamic subtest: vecs0
[81.995449] Dynamic subtest vecs0: SUCCESS (0.860s)
[81.996421] Subtest dirty-switch: SUCCESS (4.198s)
[82.298771] [014/155] (943s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[83.786229] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[83.787109] Starting dynamic subtest: pipe-A-HDMI-A-3
[83.795358] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[83.804387] Starting dynamic subtest: pipe-B-HDMI-A-3
[83.812921] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[83.821881] Starting dynamic subtest: pipe-C-HDMI-A-3
[83.830537] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[83.839138] Starting dynamic subtest: pipe-D-HDMI-A-3
[83.848416] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[83.850164] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[84.063232] [015/155] (941s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[85.552131] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[85.553035] Starting dynamic subtest: pipe-A-valid-mode
[86.877401] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.325s)
[86.878259] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.326s)
[87.062911] [016/155] (938s left) gem_exec_whisper (basic-fds-priority)
[87.133329] Starting subtest: basic-fds-priority
[100.358459] Subtest basic-fds-priority: SUCCESS (13.221s)
[100.588028] [017/155] (924s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[102.075382] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[102.076287] Starting dynamic subtest: pipe-A-valid-mode
[102.927057] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.851s)
[102.927962] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SUCCESS (0.852s)
[103.120710] [018/155] (922s left) gem_vm_create (create-ext)
[103.171870] Starting subtest: create-ext
[103.177276] Subtest create-ext: SUCCESS (0.005s)
[103.334254] [019/155] (922s left) gem_exec_create (forked)
[103.391399] Starting subtest: forked
[103.392336] Starting dynamic subtest: smem
[123.525086] Dynamic subtest smem: SUCCESS (20.133s)
[123.537584] Starting dynamic subtest: lmem0
[143.690916] Dynamic subtest lmem0: SUCCESS (20.165s)
[143.691974] Subtest forked: SUCCESS (40.300s)
[143.985249] [020/155] (881s left) gem_exec_schedule (pi-shared-iova)
[144.169230] Starting subtest: pi-shared-iova
[144.170516] Starting dynamic subtest: rcs0
[144.352713] Dynamic subtest rcs0: SUCCESS (0.181s)
[144.362285] Starting dynamic subtest: bcs0
[144.454578] Dynamic subtest bcs0: SUCCESS (0.105s)
[144.464107] Starting dynamic subtest: vcs0
[144.561288] Dynamic subtest vcs0: SUCCESS (0.106s)
[144.570800] Starting dynamic subtest: vcs1
[144.685177] Dynamic subtest vcs1: SUCCESS (0.121s)
[144.694972] Starting dynamic subtest: vecs0
[144.806223] Dynamic subtest vecs0: SUCCESS (0.120s)
[144.807548] Subtest pi-shared-iova: SUCCESS (0.635s)
[145.136283] [021/155] (880s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[146.625974] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[146.878581] Starting dynamic subtest: pipe-A-HDMI-A-3
[149.190144] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.307s)
[149.390163] Starting dynamic subtest: pipe-B-HDMI-A-3
[151.451567] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.067s)
[151.634829] Starting dynamic subtest: pipe-C-HDMI-A-3
[153.709558] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.080s)
[153.901138] Starting dynamic subtest: pipe-D-HDMI-A-3
[155.971571] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.075s)
[155.972568] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.343s)
[156.346919] [022/155] (869s left) gem_ctx_persistence (legacy-engines-mixed)
[156.398019] Starting subtest: legacy-engines-mixed
[156.398880] Starting dynamic subtest: render
[156.456143] Dynamic subtest render: SUCCESS (0.058s)
[156.465357] Starting dynamic subtest: bsd1
[156.504196] Dynamic subtest bsd1: SUCCESS (0.047s)
[156.517664] Starting dynamic subtest: bsd2
[156.547387] Dynamic subtest bsd2: SUCCESS (0.042s)
[156.566906] Starting dynamic subtest: blt
[156.600694] Dynamic subtest blt: SUCCESS (0.052s)
[156.633840] Starting dynamic subtest: vebox
[156.668389] Dynamic subtest vebox: SUCCESS (0.066s)
[156.669572] Subtest legacy-engines-mixed: SUCCESS (0.271s)
[156.862512] [023/155] (869s left) gem_caching (reads)
[156.913237] Starting subtest: reads
[160.638500] Subtest reads: SUCCESS (3.725s)
[160.775652] [024/155] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[162.267978] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[162.269670] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[162.422528] [025/155] (863s left) kms_cursor_crc (cursor-random-512x512)
[164.173136] Starting subtest: cursor-random-512x512
[164.174927] Subtest cursor-random-512x512: SKIP (0.001s)
[164.406989] [026/155] (861s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[164.454445] Starting subtest: multi-wait-all-for-submit-submitted
[164.558490] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[164.718251] [027/155] (861s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[166.211336] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[166.213140] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[166.388898] [028/155] (860s left) i915_drm_fdinfo (memory-info-purgeable)
[166.439963] Starting subtest: memory-info-purgeable
[166.440933] Starting dynamic subtest: lmem0
[170.721786] Dynamic subtest lmem0: SUCCESS (4.282s)
[170.735230] Starting dynamic subtest: smem0
[174.901746] Dynamic subtest smem0: SUCCESS (4.176s)
[174.902856] Subtest memory-info-purgeable: SUCCESS (8.460s)
[175.003132] [029/155] (851s left) kms_chamelium_hpd (dp-hpd-fast)
[176.535179] Subtest dp-hpd-fast: SKIP (0.000s)
[176.660437] [030/155] (849s left) gen9_exec_parse (batch-invalid-length)
[176.712969] Subtest batch-invalid-length: SKIP (0.000s)
[176.811825] [031/155] (849s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[176.861612] Subtest writes-after-reads: SKIP (0.000s)
[176.942882] [032/155] (849s left) api_intel_bb (add-remove-objects)
[176.986425] Starting subtest: add-remove-objects
[177.010572] Subtest add-remove-objects: SUCCESS (0.024s)
[177.226989] [033/155] (849s left) kms_async_flips (test-time-stamp)
[178.714180] Starting subtest: test-time-stamp
[178.946729] Starting dynamic subtest: pipe-A-HDMI-A-3
[179.346472] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.399s)
[179.553926] Starting dynamic subtest: pipe-B-HDMI-A-3
[179.658547] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.113s)
[179.846707] Starting dynamic subtest: pipe-C-HDMI-A-3
[179.962346] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.124s)
[180.143139] Starting dynamic subtest: pipe-D-HDMI-A-3
[180.252840] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.118s)
[180.253819] Subtest test-time-stamp: SUCCESS (1.539s)
[180.638943] [034/155] (846s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[182.132546] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[182.134217] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[182.310755] [035/155] (844s left) kms_dsc (dsc-with-output-formats-with-bpc)
[183.798742] Starting subtest: dsc-with-output-formats-with-bpc
[183.825156] Subtest dsc-with-output-formats-with-bpc: SKIP (0.003s)
[183.929179] [036/155] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[185.437406] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[185.439130] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[185.596989] [037/155] (841s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[187.115213] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[187.748025] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.633s)
[187.953504] [038/155] (839s left) kms_frontbuffer_tracking (fbchdr-suspend)
[189.458644] Starting subtest: fbchdr-suspend
[189.460302] Subtest fbchdr-suspend: SKIP (0.000s)
[189.610571] [039/155] (837s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[189.679448] Starting subtest: stress-mm-invalidate-close-overlap
[191.829093] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[192.011910] [040/155] (835s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[192.064904] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[192.065936] Starting dynamic subtest: smem
[192.162969] Dynamic subtest smem: SUCCESS (0.098s)
[192.173039] Starting dynamic subtest: lmem0
[193.279312] Dynamic subtest lmem0: SUCCESS (1.113s)
[193.280422] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (1.212s)
[193.546832] [041/155] (834s left) kms_selftest (drm_plane_helper)
[193.592898] Starting subtest: drm_plane_helper
[193.665888] Starting dynamic subtest: drm_test_check_plane_state
[193.736887] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.097s)
[193.764344] Starting dynamic subtest: drm_test_check_invalid_plane_state
[193.803712] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.066s)
[193.804963] Subtest drm_plane_helper: SUCCESS (0.211s)
[194.033777] [042/155] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[195.527347] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[195.528980] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[195.720949] [043/155] (832s left) kms_big_fb (linear-8bpp-rotate-180)
[197.229353] Starting subtest: linear-8bpp-rotate-180
[198.934307] Subtest linear-8bpp-rotate-180: SUCCESS (1.702s)
[199.141866] [044/155] (828s left) syncobj_wait (invalid-reset-bad-pad)
[199.188487] Starting subtest: invalid-reset-bad-pad
[199.189402] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[199.318583] [045/155] (828s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[200.812555] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[200.814381] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[201.003800] [046/155] (827s left) gem_exec_balancer (parallel-contexts)
[201.428376] Starting subtest: parallel-contexts
[206.059282] Subtest parallel-contexts: SUCCESS (4.631s)
[206.177700] [047/155] (822s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[207.666203] Starting subtest: primary-x-tiled-reflect-x-0
[218.310507] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.644s)
[218.566817] [048/155] (809s left) vgem_basic (second-client)
[218.694433] Starting subtest: second-client
[218.728861] Subtest second-client: SUCCESS (0.033s)
[218.827295] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[218.829782] [049/155] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[220.322892] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[220.324693] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[220.476854] [050/155] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[221.975536] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[221.977251] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[222.162435] [051/155] (806s left) kms_chamelium_frames (vga-frame-dump)
[223.703475] Subtest vga-frame-dump: SKIP (0.000s)
[223.839086] [052/155] (804s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[225.347398] Starting subtest: y-tiled-16bpp-rotate-90
[227.194948] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.844s)
[227.417216] [053/155] (801s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[228.909091] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[228.911060] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[229.087802] [054/155] (799s left) kms_cursor_legacy (single-bo)
[230.592912] Starting subtest: single-bo
[230.593789] Starting dynamic subtest: pipe-A
[235.980535] Dynamic subtest pipe-A: SUCCESS (5.383s)
[235.990881] Starting dynamic subtest: pipe-B
[241.363031] Dynamic subtest pipe-B: SUCCESS (5.382s)
[241.373349] Starting dynamic subtest: pipe-C
[246.745956] Dynamic subtest pipe-C: SUCCESS (5.382s)
[246.756238] Starting dynamic subtest: pipe-D
[252.128769] Dynamic subtest pipe-D: SUCCESS (5.382s)
[252.139096] Starting dynamic subtest: all-pipes
[257.512050] Dynamic subtest all-pipes: SUCCESS (5.382s)
[257.513046] Subtest single-bo: SUCCESS (26.914s)
[257.624876] [055/155] (771s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[259.113809] Starting subtest: invalid-modeset-force-ultra-joiner
[259.115800] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[259.241109] [056/155] (769s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[260.741936] Starting subtest: 2x-long-cursor-vs-flip-legacy
[260.744859] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[260.882373] [057/155] (768s left) syncobj_timeline (device-submit-unordered)
[260.943048] Starting subtest: device-submit-unordered
[260.943913] Subtest device-submit-unordered: SUCCESS (0.001s)
[261.061333] [058/155] (768s left) kms_psr (psr-cursor-mmap-gtt)
[262.548546] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[262.620562] [059/155] (766s left) gem_exec_params (larger-than-life-batch)
[262.671925] Starting subtest: larger-than-life-batch
[273.749215] Subtest larger-than-life-batch: SUCCESS (11.073s)
[274.385730] [060/155] (754s left) gem_exec_capture (pi)
[274.480359] Starting subtest: pi
[274.481230] Starting dynamic subtest: rcs0
[281.276349] Dynamic subtest rcs0: SUCCESS (6.792s)
[281.287621] Starting dynamic subtest: bcs0
[287.671330] Dynamic subtest bcs0: SUCCESS (6.392s)
[287.682412] Starting dynamic subtest: vcs0
[294.171691] Dynamic subtest vcs0: SUCCESS (6.502s)
[294.184224] Starting dynamic subtest: vcs1
[300.574674] Dynamic subtest vcs1: SUCCESS (6.399s)
[300.585484] Starting dynamic subtest: vecs0
[307.110418] Dynamic subtest vecs0: SUCCESS (6.534s)
[307.111680] Subtest pi: SUCCESS (32.625s)
[307.267920] [061/155] (722s left) perf_pmu (busy-idle)
[307.384775] Starting subtest: busy-idle
[307.385668] Starting dynamic subtest: rcs0
[308.095712] Dynamic subtest rcs0: SUCCESS (0.709s)
[308.145520] Starting dynamic subtest: bcs0
[308.783960] Dynamic subtest bcs0: SUCCESS (0.686s)
[308.797922] Starting dynamic subtest: vcs0
[309.448058] Dynamic subtest vcs0: SUCCESS (0.663s)
[309.471296] Starting dynamic subtest: vcs1
[310.119618] Dynamic subtest vcs1: SUCCESS (0.669s)
[310.139386] Starting dynamic subtest: vecs0
[310.783624] Dynamic subtest vecs0: SUCCESS (0.660s)
[310.785891] Subtest busy-idle: SUCCESS (3.400s)
[310.960342] [062/155] (718s left) kms_prime (basic-crc-vgem)
[312.482146] Subtest basic-crc-vgem: SKIP (0.000s)
[312.709034] [063/155] (716s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[314.202740] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[314.204459] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[314.365772] [064/155] (715s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[315.857090] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[315.857968] Starting dynamic subtest: pipe-A-HDMI-A-3
[315.866165] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[315.877905] Starting dynamic subtest: pipe-B-HDMI-A-3
[315.885860] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[315.897529] Starting dynamic subtest: pipe-C-HDMI-A-3
[315.905747] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[315.917262] Starting dynamic subtest: pipe-D-HDMI-A-3
[315.925906] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[315.927558] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[316.127880] [065/155] (713s left) gem_pread (exhaustion)
[316.174153] Subtest exhaustion: SKIP (0.000s)
[316.270273] [066/155] (713s left) kms_flip (flip-vs-rmfb)
[317.758158] Starting subtest: flip-vs-rmfb
[317.765188] Starting dynamic subtest: A-HDMI-A3
[325.554317] Dynamic subtest A-HDMI-A3: SUCCESS (7.788s)
[325.603850] Starting dynamic subtest: B-HDMI-A3
[333.264706] Dynamic subtest B-HDMI-A3: SUCCESS (7.704s)
[333.298243] Starting dynamic subtest: C-HDMI-A3
[340.977161] Dynamic subtest C-HDMI-A3: SUCCESS (7.708s)
[341.008945] Starting dynamic subtest: D-HDMI-A3
[348.671156] Dynamic subtest D-HDMI-A3: SUCCESS (7.688s)
[348.677617] Subtest flip-vs-rmfb: SUCCESS (30.917s)
[348.941260] [067/155] (680s left) syncobj_timeline (wait-for-submit-snapshot)
[348.989373] Starting subtest: wait-for-submit-snapshot
[349.073111] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[349.203442] [068/155] (680s left) drm_read (short-buffer-nonblock)
[350.759910] Starting subtest: short-buffer-nonblock
[350.760939] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[351.004291] [069/155] (679s left) kms_psr (pr-cursor-blt)
[352.494338] Subtest pr-cursor-blt: SKIP (0.000s)
[352.571938] [070/155] (677s left) kms_pm_backlight (bad-brightness)
[354.061244] Subtest bad-brightness: SKIP (0.000s)
[354.140942] [071/155] (676s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[355.630452] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[355.631439] Starting dynamic subtest: pipe-A-HDMI-A-3
[355.640898] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[355.653180] Starting dynamic subtest: pipe-B-HDMI-A-3
[355.661997] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[355.673823] Starting dynamic subtest: pipe-C-HDMI-A-3
[355.683471] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[355.695047] Starting dynamic subtest: pipe-D-HDMI-A-3
[355.705040] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[355.706956] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[355.907231] [072/155] (674s left) kms_flip (basic-plain-flip)
[357.395948] Starting subtest: basic-plain-flip
[357.401854] Starting dynamic subtest: A-HDMI-A3
[358.147442] Dynamic subtest A-HDMI-A3: SUCCESS (0.745s)
[358.161913] Starting dynamic subtest: B-HDMI-A3
[358.842350] Dynamic subtest B-HDMI-A3: SUCCESS (0.692s)
[358.856764] Starting dynamic subtest: C-HDMI-A3
[359.537645] Dynamic subtest C-HDMI-A3: SUCCESS (0.692s)
[359.579380] Starting dynamic subtest: D-HDMI-A3
[360.263624] Dynamic subtest D-HDMI-A3: SUCCESS (0.717s)
[360.266354] Subtest basic-plain-flip: SUCCESS (2.871s)
[360.506883] [073/155] (669s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[361.996514] Starting subtest: basic-flip-before-cursor-atomic
[362.958302] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.961s)
[363.168228] [074/155] (667s left) kms_prop_blob (invalid-set-prop-any)
[363.214827] Starting subtest: invalid-set-prop-any
[363.215737] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[363.327927] [075/155] (667s left) tools_test (tools_test)
[363.376991] Starting subtest: tools_test
[363.485668] Subtest tools_test: SUCCESS (0.115s)
[363.591745] [076/155] (667s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[365.085149] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[365.086997] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[365.260260] [077/155] (665s left) gem_ctx_shared (q-out-order)
[365.322574] Starting subtest: Q-out-order
[365.323472] Starting dynamic subtest: rcs0
[365.520984] Dynamic subtest rcs0: SUCCESS (0.196s)
[365.535403] Starting dynamic subtest: bcs0
[365.652916] Dynamic subtest bcs0: SUCCESS (0.130s)
[365.665195] Starting dynamic subtest: vcs0
[365.778622] Dynamic subtest vcs0: SUCCESS (0.124s)
[365.790965] Starting dynamic subtest: vcs1
[365.914907] Dynamic subtest vcs1: SUCCESS (0.135s)
[365.927222] Starting dynamic subtest: vecs0
[366.049981] Dynamic subtest vecs0: SUCCESS (0.133s)
[366.051271] Subtest Q-out-order: SUCCESS (0.726s)
[366.366077] [078/155] (664s left) gem_media_fill (media-fill)
[366.419955] Starting subtest: media-fill
[366.420967] Starting dynamic subtest: smem
[366.439899] Dynamic subtest smem: SUCCESS (0.019s)
[366.454605] Starting dynamic subtest: lmem0
[366.455772] Dynamic subtest lmem0: SUCCESS (0.009s)
[366.456794] Subtest media-fill: SUCCESS (0.032s)
[366.738373] [079/155] (664s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[368.227445] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[368.252204] Starting dynamic subtest: pipe-A-plane-0
[368.769583] Dynamic subtest pipe-A-plane-0: SUCCESS (0.516s)
[368.819498] Starting dynamic subtest: pipe-A-plane-3
[369.101889] Dynamic subtest pipe-A-plane-3: SUCCESS (0.326s)
[369.133285] Starting dynamic subtest: pipe-A-plane-5
[369.435659] Dynamic subtest pipe-A-plane-5: SUCCESS (0.330s)
[369.631104] Starting dynamic subtest: pipe-B-plane-0
[370.020028] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[370.061512] Starting dynamic subtest: pipe-B-plane-3
[370.352675] Dynamic subtest pipe-B-plane-3: SUCCESS (0.328s)
[370.369117] Starting dynamic subtest: pipe-B-plane-5
[370.703051] Dynamic subtest pipe-B-plane-5: SUCCESS (0.346s)
[370.773678] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.547s)
[370.959581] [080/155] (660s left) gem_ctx_param (basic-default)
[371.006727] Starting subtest: basic-default
[371.007578] Subtest basic-default: SUCCESS (0.000s)
[371.148350] [081/155] (659s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[371.195694] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[371.196632] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[371.312221] [082/155] (659s left) kms_vblank (wait-busy-hang)
[372.802653] Starting subtest: wait-busy-hang
[372.803725] Starting dynamic subtest: pipe-A-HDMI-A-3
[399.463046] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.658s)
[399.478558] Starting dynamic subtest: pipe-D-HDMI-A-3
[424.468938] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.001s)
[424.469899] Subtest wait-busy-hang: SUCCESS (51.666s)
[424.674925] [083/155] (606s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[426.164335] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[426.166025] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[426.314428] [084/155] (604s left) gem_render_copy (x-tiled)
[426.372760] Starting subtest: x-tiled
[426.373814] Starting dynamic subtest: smem
[426.460136] Dynamic subtest smem: SUCCESS (0.086s)
[426.474421] Starting dynamic subtest: lmem0
[427.220035] Dynamic subtest lmem0: SUCCESS (0.755s)
[427.221176] Subtest x-tiled: SUCCESS (0.845s)
[427.483131] [085/155] (603s left) syncobj_timeline (multi-wait-available-signaled)
[427.530450] Starting subtest: multi-wait-available-signaled
[427.531303] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[427.660383] [086/155] (603s left) kms_lease (lease-unleased-connector)
[429.150703] Starting subtest: lease-unleased-connector
[429.151627] Starting dynamic subtest: pipe-A-HDMI-A-3
[429.206571] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.055s)
[429.221357] Starting dynamic subtest: pipe-B-HDMI-A-3
[429.263772] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.055s)
[429.278504] Starting dynamic subtest: pipe-C-HDMI-A-3
[429.322307] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.055s)
[429.334983] Starting dynamic subtest: pipe-D-HDMI-A-3
[429.378608] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.055s)
[429.379525] Subtest lease-unleased-connector: SUCCESS (0.230s)
[429.497415] [087/155] (602s left) gem_exec_params (invalid-flag)
[429.549711] Starting subtest: invalid-flag
[429.550648] Subtest invalid-flag: SUCCESS (0.000s)
[429.715116] [088/155] (601s left) gem_exec_fence (submit-chain)
[429.931886] Starting subtest: submit-chain
[429.977812] Subtest submit-chain: SUCCESS (0.046s)
[430.649667] [089/155] (601s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[432.142360] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[432.144190] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[432.336544] [090/155] (599s left) i915_hangman (detector)
[432.397845] Starting subtest: detector
[432.398809] Starting dynamic subtest: rcs0
[442.166421] Dynamic subtest rcs0: SUCCESS (9.768s)
[442.181964] Starting dynamic subtest: bcs0
[452.108507] Dynamic subtest bcs0: SUCCESS (9.940s)
[452.133148] Starting dynamic subtest: vcs0
[462.098445] Dynamic subtest vcs0: SUCCESS (9.988s)
[462.113591] Starting dynamic subtest: vcs1
[472.102281] Dynamic subtest vcs1: SUCCESS (10.002s)
[472.118760] Starting dynamic subtest: vecs0
[481.113712] Dynamic subtest vecs0: SUCCESS (9.009s)
[481.117503] Subtest detector: SUCCESS (48.717s)
[481.372365] [091/155] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[482.866792] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[482.868601] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[483.060793] [092/155] (548s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[484.575924] Starting subtest: 4-tiled-8bpp-rotate-180
[484.578253] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[484.763306] [093/155] (547s left) syncobj_wait (wait-any-complex)
[484.809198] Starting subtest: wait-any-complex
[484.871834] Subtest wait-any-complex: SUCCESS (0.062s)
[485.039619] [094/155] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[486.532643] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[486.534442] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[486.700378] [095/155] (545s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[488.194870] Starting subtest: fbchdr-1p-rte
[488.196529] Subtest fbchdr-1p-rte: SKIP (0.000s)
[488.337128] [096/155] (544s left) syncobj_eventfd (invalid-bad-pad)
[488.391432] Starting subtest: invalid-bad-pad
[488.392477] Subtest invalid-bad-pad: SUCCESS (0.000s)
[488.498172] [097/155] (544s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[489.992690] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[489.994830] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[490.182047] [098/155] (542s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[491.675827] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[491.677502] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[491.821957] [099/155] (540s left) gem_busy (busy)
[491.885837] Starting subtest: busy
[491.886821] Starting dynamic subtest: all-engines
[491.948459] Dynamic subtest all-engines: SUCCESS (0.062s)
[491.964514] Starting dynamic subtest: rcs0
[492.020727] Dynamic subtest rcs0: SUCCESS (0.071s)
[492.037581] Starting dynamic subtest: bcs0
[492.062063] Dynamic subtest bcs0: SUCCESS (0.039s)
[492.079776] Starting dynamic subtest: vcs0
[492.102177] Dynamic subtest vcs0: SUCCESS (0.039s)
[492.122397] Starting dynamic subtest: vcs1
[492.142224] Dynamic subtest vcs1: SUCCESS (0.038s)
[492.159893] Starting dynamic subtest: vecs0
[492.182194] Dynamic subtest vecs0: SUCCESS (0.038s)
[492.183504] Subtest busy: SUCCESS (0.297s)
[492.580701] [100/155] (540s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[494.075258] Starting subtest: psr-rgb101010-draw-mmap-wc
[494.077149] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[494.273974] [101/155] (538s left) gem_spin_batch (engines)
[494.331968] Starting subtest: engines
[494.332910] Starting dynamic subtest: rcs0
[497.584333] Dynamic subtest rcs0: SUCCESS (3.245s)
[497.600210] Starting dynamic subtest: bcs0
[500.822934] Dynamic subtest bcs0: SUCCESS (3.231s)
[500.837562] Starting dynamic subtest: vcs0
[504.061121] Dynamic subtest vcs0: SUCCESS (3.231s)
[504.076463] Starting dynamic subtest: vcs1
[507.300109] Dynamic subtest vcs1: SUCCESS (3.231s)
[507.317230] Starting dynamic subtest: vecs0
[510.539576] Dynamic subtest vecs0: SUCCESS (3.232s)
[510.541845] Subtest engines: SUCCESS (16.205s)
[510.823066] [102/155] (522s left) gem_create (create-ext-cpu-access-big)
[511.002107] Starting subtest: create-ext-cpu-access-big
[512.030761] Subtest create-ext-cpu-access-big: SUCCESS (1.030s)
[512.331277] [103/155] (520s left) kms_chamelium_color (ctm-0-25)
[513.823403] Subtest ctm-0-25: SKIP (0.000s)
[513.910909] [104/155] (519s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[515.405131] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[515.407028] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[515.559674] [105/155] (517s left) kms_plane_multiple (2x-tiling-4)
[517.052292] Starting subtest: 2x-tiling-4
[517.053990] Subtest 2x-tiling-4: SKIP (0.000s)
[517.184175] [106/155] (516s left) kms_concurrent (multi-plane-atomic-lowres)
[518.681978] Starting subtest: multi-plane-atomic-lowres
[518.684465] Starting dynamic subtest: pipe-A-HDMI-A-3
[519.096928] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.412s)
[519.112901] Starting dynamic subtest: pipe-B-HDMI-A-3
[519.427285] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.327s)
[519.440673] Starting dynamic subtest: pipe-C-HDMI-A-3
[519.793762] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.364s)
[519.808407] Starting dynamic subtest: pipe-D-HDMI-A-3
[520.161938] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.366s)
[520.162840] Subtest multi-plane-atomic-lowres: SUCCESS (1.480s)
[520.410144] [107/155] (513s left) gem_userptr_blits (map-fixed-invalidate)
[520.473498] Starting subtest: map-fixed-invalidate
[520.475459] Subtest map-fixed-invalidate: SKIP (0.000s)
[520.665348] [108/155] (512s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[522.174956] Starting subtest: x-tiled-64bpp-rotate-180
[524.610559] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.434s)
[524.821349] [109/155] (508s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[527.393312] Starting subtest: verify-pxp-stale-buf-optout-execution
[527.395662] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[527.511376] [110/155] (506s left) gem_mmap_offset (oob-read)
[527.555853] Starting subtest: oob-read
[527.556786] Subtest oob-read: SUCCESS (0.000s)
[527.720451] [111/155] (506s left) prime_mmap_coherency (write)
[527.773253] Starting subtest: write
[533.178597] Subtest write: SUCCESS (5.402s)
[533.328729] [112/155] (500s left) vgem_basic (bad-handle)
[533.391488] Starting subtest: bad-handle
[533.392435] Subtest bad-handle: SUCCESS (0.000s)
[533.491680] [113/155] (500s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[534.980352] Starting subtest: 2x-long-flip-vs-cursor-atomic
[534.983041] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[535.101977] [114/155] (499s left) kms_psr (pr-primary-page-flip)
[536.598216] Subtest pr-primary-page-flip: SKIP (0.000s)
[536.687618] [115/155] (497s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[538.180843] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[538.182504] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[538.354566] [116/155] (495s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[539.846913] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[539.921184] [117/155] (494s left) kms_getfb (getfb2-handle-protection)
[541.412336] Starting subtest: getfb2-handle-protection
[541.430526] Subtest getfb2-handle-protection: SUCCESS (0.019s)
[541.660726] [118/155] (492s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[543.153965] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[545.692325] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.538s)
[545.894275] [119/155] (488s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[547.395111] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[547.397424] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.580799] [120/155] (487s left) i915_pm_rps (thresholds-idle)
[547.636391] Starting subtest: thresholds-idle
[547.637972] Subtest thresholds-idle: SKIP (0.000s)
[547.778690] [121/155] (487s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[549.271970] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[549.273841] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[549.469281] [122/155] (485s left) gem_wait (invalid-buf)
[549.522456] Starting subtest: invalid-buf
[549.523408] Subtest invalid-buf: SUCCESS (0.000s)
[549.838896] [123/155] (485s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[551.332323] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[551.334157] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[551.504188] [124/155] (483s left) kms_cursor_crc (cursor-sliding-64x21)
[553.151986] Starting subtest: cursor-sliding-64x21
[553.159419] Starting dynamic subtest: pipe-A-HDMI-A-3
[557.513561] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.353s)
[557.548360] Starting dynamic subtest: pipe-D-HDMI-A-3
[561.803471] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.267s)
[561.804301] Subtest cursor-sliding-64x21: SUCCESS (8.651s)
[562.285332] [125/155] (472s left) kms_addfb_basic (no-handle)
[562.332896] Starting subtest: no-handle
[562.333890] Subtest no-handle: SUCCESS (0.000s)
[563.941601] [126/155] (471s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[565.437156] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[568.455423] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.018s)
[568.659846] [127/155] (466s left) kms_pwrite_crc (basic)
[570.147425] Starting subtest: basic
[570.743394] Subtest basic: SUCCESS (0.595s)
[570.975469] [128/155] (464s left) api_intel_bb (reset-flags)
[571.022897] Starting subtest: reset-flags
[571.050418] Subtest reset-flags: SUCCESS (0.028s)
[571.222463] [129/155] (464s left) kms_plane_scaling (2x-scaler-multi-pipe)
[572.713974] Starting subtest: 2x-scaler-multi-pipe
[572.717546] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[572.973812] [130/155] (462s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[573.035043] Starting subtest: multi-wait-for-submit-available-signaled
[573.038435] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[573.150249] [131/155] (462s left) gem_exec_reloc (basic-wc-noreloc)
[573.202098] Subtest basic-wc-noreloc: SKIP (0.000s)
[573.311382] [132/155] (462s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[574.804717] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[574.806703] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[575.066777] [133/155] (460s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[576.555766] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[576.556955] Starting dynamic subtest: pipe-A
[577.363374] Dynamic subtest pipe-A: SUCCESS (0.808s)
[577.379321] Starting dynamic subtest: pipe-B
[578.136855] Dynamic subtest pipe-B: SUCCESS (0.772s)
[578.160108] Starting dynamic subtest: pipe-C
[578.927948] Dynamic subtest pipe-C: SUCCESS (0.789s)
[578.943900] Starting dynamic subtest: pipe-D
[579.702369] Dynamic subtest pipe-D: SUCCESS (0.772s)
[579.703591] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.149s)
[579.916669] [134/155] (456s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[581.411762] Starting subtest: psr-1p-primscrn-cur-indfb-move
[581.413838] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[581.584637] [135/155] (454s left) kms_flip (2x-flip-vs-panning)
[583.074905] Starting subtest: 2x-flip-vs-panning
[583.093409] Subtest 2x-flip-vs-panning: SKIP (0.019s)
[583.220023] [136/155] (453s left) kms_pm_rpm (dpms-non-lpsp)
[587.041093] Starting subtest: dpms-non-lpsp
[587.192512] Subtest dpms-non-lpsp: SUCCESS (0.153s)
[588.063464] [137/155] (448s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[589.566794] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[589.568502] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[589.772417] [138/155] (446s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt)
[591.273633] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt
[591.275273] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[591.466084] [139/155] (445s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[592.976449] Starting subtest: stress-xrgb8888-yftiled
[592.978235] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[593.150447] [140/155] (443s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[594.644297] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[594.645963] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[594.830386] [141/155] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[596.323412] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[596.325154] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[596.504304] [142/155] (440s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[597.997987] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[597.999609] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[598.161495] [143/155] (438s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[599.672051] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[600.273645] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[600.551309] [144/155] (436s left) kms_big_fb (yf-tiled-addfb)
[602.057531] Starting subtest: yf-tiled-addfb
[602.059229] Subtest yf-tiled-addfb: SKIP (0.000s)
[602.243333] [145/155] (435s left) i915_pm_rps (min-max-config-loaded)
[602.316274] Starting subtest: min-max-config-loaded
[602.317934] Subtest min-max-config-loaded: SKIP (0.000s)
[602.425580] [146/155] (435s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[603.918786] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[603.920649] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[604.077998] [147/155] (433s left) syncobj_timeline (host-signal-ordered)
[604.128041] Starting subtest: host-signal-ordered
[604.129094] Subtest host-signal-ordered: SUCCESS (0.001s)
[604.249761] [148/155] (433s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[605.744041] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[605.751645] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[605.930790] [149/155] (431s left) gem_exercise_blt (fast-copy-emit)
[605.983390] Starting subtest: fast-copy-emit
[605.984207] Starting dynamic subtest: linear-smem-smem-emit
[606.016150] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.033s)
[606.032692] Starting dynamic subtest: linear-smem-lmem0-emit
[606.035158] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[606.048610] Starting dynamic subtest: linear-lmem0-smem-emit
[606.095491] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.060s)
[606.110277] Starting dynamic subtest: linear-lmem0-lmem0-emit
[606.155904] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.059s)
[606.170460] Starting dynamic subtest: ymajor-smem-smem-emit
[606.172878] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s)
[606.187824] Starting dynamic subtest: ymajor-smem-lmem0-emit
[606.188824] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.015s)
[606.203659] Starting dynamic subtest: ymajor-lmem0-smem-emit
[606.250393] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.060s)
[606.265159] Starting dynamic subtest: ymajor-lmem0-lmem0-emit
[606.311194] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.059s)
[606.325843] Starting dynamic subtest: tile4-smem-smem-emit
[606.328545] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[606.343719] Starting dynamic subtest: tile4-smem-lmem0-emit
[606.344707] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.015s)
[606.359845] Starting dynamic subtest: tile4-lmem0-smem-emit
[606.406588] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.060s)
[606.421492] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[606.467124] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.059s)
[606.481852] Starting dynamic subtest: tile64-smem-smem-emit
[606.483749] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[606.498909] Starting dynamic subtest: tile64-smem-lmem0-emit
[606.499827] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[606.514988] Starting dynamic subtest: tile64-lmem0-smem-emit
[606.561691] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.061s)
[606.576238] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[606.621084] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.058s)
[606.621953] Subtest fast-copy-emit: SUCCESS (0.640s)
[606.770280] [150/155] (431s left) perf (polling-small-buf)
[606.909482] Starting subtest: polling-small-buf
[607.014256] Subtest polling-small-buf: SUCCESS (0.104s)
[607.093107] [151/155] (430s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[608.587185] Starting subtest: fbc-rgb101010-draw-mmap-wc
[608.589151] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[608.734771] [152/155] (429s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[610.231475] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[610.233134] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[610.394665] [153/155] (427s left) syncobj_basic (bad-fd-to-handle)
[610.442307] Starting subtest: bad-fd-to-handle
[610.443170] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[610.564187] [154/155] (427s left) kms_flip (plain-flip-ts-check)
[612.054030] Starting subtest: plain-flip-ts-check
[612.059887] Starting dynamic subtest: A-HDMI-A3
[620.102357] Dynamic subtest A-HDMI-A3: SUCCESS (8.041s)
[620.120107] Starting dynamic subtest: B-HDMI-A3
[628.083287] Dynamic subtest B-HDMI-A3: SUCCESS (7.975s)
[628.109457] Starting dynamic subtest: C-HDMI-A3
[636.061909] Dynamic subtest C-HDMI-A3: SUCCESS (7.968s)
[636.080155] Starting dynamic subtest: D-HDMI-A3
[644.053488] Dynamic subtest D-HDMI-A3: SUCCESS (7.986s)
[644.056078] Subtest plain-flip-ts-check: SUCCESS (32.003s)
[644.283106] [155/155] (393s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[645.776348] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[645.778266] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[645.959613] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_ctx_isolation
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: gem_exec_whisper
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_vm_create
results: parsing output: 18/ for test: gem_exec_create
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_async_flips
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: gem_caching
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: gen9_exec_parse
results: parsing output: 30/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_async_flips
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_dsc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_selftest
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_exec_capture
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_pread
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: drm_read
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_pm_backlight
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: tools_test
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: gem_media_fill
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_lease
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_eventfd
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_busy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: gem_create
results: parsing output: 102/ for test: kms_chamelium_color
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane_multiple
results: parsing output: 105/ for test: kms_concurrent
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_pxp
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: prime_mmap_coherency
results: parsing output: 111/ for test: vgem_basic
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_pm_rps
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_pwrite_crc
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_flip
results: parsing output: 135/ for test: kms_pm_rpm
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_pipe_stress
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: i915_pm_rps
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: syncobj_timeline
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exercise_blt
results: parsing output: 149/ for test: perf
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: syncobj_basic
results: parsing output: 153/ for test: kms_flip
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.