[68.690826] Initializing watchdogs
[68.690910]   /dev/watchdog0
[68.722518] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.737498] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.742657] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.748154] [001/156] (960s left) syncobj_timeline (wait-zero-handles)
[68.828295] Starting subtest: wait-zero-handles
[68.830302] Subtest wait-zero-handles: SUCCESS (0.000s)
[68.954406] [002/156] (960s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[70.448860] Starting subtest: cursorB-vs-flipB-legacy
[70.452110] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[70.562139] [003/156] (958s left) gem_shrink (reclaim)
[70.633988] Starting subtest: reclaim
[72.954391] Subtest reclaim: SUCCESS (2.318s)
[73.253795] [004/156] (956s left) gem_mmap_offset (perf)
[73.320950] Starting subtest: perf
[73.322823] Starting dynamic subtest: lmem0
[73.466957] Dynamic subtest lmem0: SUCCESS (0.144s)
[73.477320] Starting dynamic subtest: smem0
[73.495206] Dynamic subtest smem0: SUCCESS (0.003s)
[73.496757] Subtest perf: SUCCESS (0.148s)
[73.632057] [005/156] (955s left) gem_ctx_persistence (heartbeat-hang)
[73.685214] Starting subtest: heartbeat-hang
[73.688515] Subtest heartbeat-hang: SKIP (0.000s)
[73.789332] [006/156] (955s left) gem_exec_whisper (basic-queues)
[73.884129] Starting subtest: basic-queues
[77.037188] Subtest basic-queues: SUCCESS (3.148s)
[77.302723] [007/156] (952s left) gem_ctx_shared (q-promotion)
[77.362462] Starting subtest: Q-promotion
[77.364125] Starting dynamic subtest: rcs0
[77.594742] Dynamic subtest rcs0: SUCCESS (0.229s)
[77.604570] Starting dynamic subtest: bcs0
[77.719570] Dynamic subtest bcs0: SUCCESS (0.125s)
[77.729649] Starting dynamic subtest: vcs0
[77.847189] Dynamic subtest vcs0: SUCCESS (0.127s)
[77.857831] Starting dynamic subtest: vcs1
[77.987176] Dynamic subtest vcs1: SUCCESS (0.140s)
[77.997109] Starting dynamic subtest: vecs0
[78.128303] Dynamic subtest vecs0: SUCCESS (0.141s)
[78.130187] Subtest Q-promotion: SUCCESS (0.763s)
[78.425436] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[78.428950] [008/156] (951s left) syncobj_wait (multi-wait-signaled)
[78.478620] Starting subtest: multi-wait-signaled
[78.480506] Subtest multi-wait-signaled: SUCCESS (0.001s)
[78.598839] [009/156] (951s left) gem_exec_balancer (bonded-pair)
[78.678044] Starting subtest: bonded-pair
[78.681198] Subtest bonded-pair: SKIP (0.000s)
[79.106681] [010/156] (950s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[80.596554] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[80.599832] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[80.832072] [011/156] (949s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-blt)
[82.333733] Starting subtest: psrhdr-rgb101010-draw-blt
[82.337133] Subtest psrhdr-rgb101010-draw-blt: SKIP (0.000s)
[82.509683] [012/156] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[84.009477] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[84.012555] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[84.152778] [013/156] (946s left) gem_exec_reloc (basic-write-gtt-active)
[84.214835] Subtest basic-write-gtt-active: SKIP (0.000s)
[84.304307] [014/156] (946s left) gem_userptr_blits (coherency-unsync)
[84.364908] Subtest coherency-unsync: SKIP (0.000s)
[84.592856] [015/156] (945s left) gem_exec_schedule (out-order)
[84.660690] Starting subtest: out-order
[84.662110] Starting dynamic subtest: rcs0
[84.852473] Dynamic subtest rcs0: SUCCESS (0.190s)
[84.862514] Starting dynamic subtest: bcs0
[84.985674] Dynamic subtest bcs0: SUCCESS (0.136s)
[84.995787] Starting dynamic subtest: vcs0
[85.120223] Dynamic subtest vcs0: SUCCESS (0.134s)
[85.130281] Starting dynamic subtest: vcs1
[85.257259] Dynamic subtest vcs1: SUCCESS (0.137s)
[85.267417] Starting dynamic subtest: vecs0
[85.404789] Dynamic subtest vecs0: SUCCESS (0.147s)
[85.406231] Subtest out-order: SUCCESS (0.746s)
[85.899752] [016/156] (944s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[87.436052] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[87.564322] [017/156] (943s left) kms_async_flips (test-time-stamp)
[89.055940] Starting subtest: test-time-stamp
[89.278128] Starting dynamic subtest: pipe-A-HDMI-A-4
[89.633765] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.354s)
[89.839619] Starting dynamic subtest: pipe-B-HDMI-A-4
[89.947916] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.115s)
[90.134044] Starting dynamic subtest: pipe-C-HDMI-A-4
[90.246194] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.119s)
[90.442892] Starting dynamic subtest: pipe-D-HDMI-A-4
[90.554637] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.118s)
[90.556298] Subtest test-time-stamp: SUCCESS (1.499s)
[90.954725] [018/156] (939s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[92.455252] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[92.459093] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[92.626759] [019/156] (938s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[94.165099] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[95.447213] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.282s)
[95.658320] [020/156] (935s left) gem_exec_params (secure-non-master)
[95.711916] Starting subtest: secure-non-master
[95.715187] Subtest secure-non-master: SKIP (0.000s)
[95.850135] [021/156] (935s left) kms_dsc (dsc-fractional-bpp)
[97.341490] Starting subtest: dsc-fractional-bpp
[97.344407] Subtest dsc-fractional-bpp: SKIP (0.000s)
[97.450404] [022/156] (933s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[98.949213] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[98.968350] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.018s)
[99.090105] [023/156] (932s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[100.600548] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[100.604407] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.781101] [024/156] (930s left) prime_mmap_coherency (ioctl-errors)
[100.844819] Starting subtest: ioctl-errors
[104.265279] Subtest ioctl-errors: SUCCESS (3.429s)
[104.502609] [025/156] (926s left) kms_psr (fbc-psr-dpms)
[106.067905] Subtest fbc-psr-dpms: SKIP (0.000s)
[106.140497] [026/156] (925s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[107.648145] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[107.651228] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[107.831614] [027/156] (923s left) kms_atomic_interruptible (universal-setplane-primary)
[109.333466] Starting subtest: universal-setplane-primary
[109.337175] Starting dynamic subtest: pipe-A-HDMI-A-4
[115.558381] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.222s)
[115.560195] Subtest universal-setplane-primary: SUCCESS (6.224s)
[115.750188] [028/156] (915s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[117.251046] Starting subtest: fbcpsrhdr-suspend
[117.254499] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[117.403253] [029/156] (914s left) kms_cursor_crc (cursor-random-64x64)
[119.037986] Starting subtest: cursor-random-64x64
[119.044993] Starting dynamic subtest: pipe-A-HDMI-A-4
[123.683635] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.631s)
[123.707114] Starting dynamic subtest: pipe-D-HDMI-A-4
[128.016308] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.317s)
[128.017922] Subtest cursor-random-64x64: SUCCESS (8.976s)
[128.536238] [030/156] (903s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[130.037385] Starting subtest: fbc-shrfb-scaledprimary
[131.416773] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.384s)
[131.616379] [031/156] (900s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[133.158103] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[133.290976] [032/156] (898s left) kms_properties (invalid-properties-atomic)
[134.781960] Starting subtest: invalid-properties-atomic
[135.662880] Subtest invalid-properties-atomic: SUCCESS (0.879s)
[135.779102] [033/156] (896s left) gem_wait (write-wait)
[135.845225] Starting subtest: write-wait
[135.846744] Starting dynamic subtest: all-engines
[136.957715] Dynamic subtest all-engines: SUCCESS (1.112s)
[136.971852] Starting dynamic subtest: rcs0
[138.024342] Dynamic subtest rcs0: SUCCESS (1.065s)
[138.037647] Starting dynamic subtest: bcs0
[139.087251] Dynamic subtest bcs0: SUCCESS (1.061s)
[139.103656] Starting dynamic subtest: vcs0
[140.151348] Dynamic subtest vcs0: SUCCESS (1.062s)
[140.164848] Starting dynamic subtest: vcs1
[141.211390] Dynamic subtest vcs1: SUCCESS (1.058s)
[141.224859] Starting dynamic subtest: vecs0
[142.272423] Dynamic subtest vecs0: SUCCESS (1.059s)
[142.275378] Subtest write-wait: SUCCESS (6.427s)
[142.637431] [034/156] (889s left) gem_exec_balancer (persistence)
[143.066207] Starting subtest: persistence
[145.133228] Subtest persistence: SUCCESS (2.063s)
[145.296562] [035/156] (886s left) kms_getfb (getfb-handle-zero)
[146.788747] Starting subtest: getfb-handle-zero
[146.790306] Subtest getfb-handle-zero: SUCCESS (0.000s)
[146.977550] [036/156] (885s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt)
[148.476315] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt
[148.479146] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[148.667569] [037/156] (883s left) kms_psr (fbc-psr2-suspend)
[150.176433] Subtest fbc-psr2-suspend: SKIP (0.000s)
[150.255366] [038/156] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[151.756752] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[151.760585] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[151.900447] [039/156] (880s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[153.391588] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[153.393257] Starting dynamic subtest: pipe-A-valid-mode
[154.556570] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.162s)
[154.558224] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.163s)
[154.756773] [040/156] (877s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[156.248046] Starting subtest: plane-lut1d-pre-ctm3x4
[156.440649] Starting dynamic subtest: pipe-A-plane-0
[156.690704] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[156.730141] Starting dynamic subtest: pipe-A-plane-1
[156.888884] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[156.901470] Starting dynamic subtest: pipe-A-plane-2
[157.074066] Dynamic subtest pipe-A-plane-2: SUCCESS (0.183s)
[157.386040] Starting dynamic subtest: pipe-B-plane-0
[157.566826] Dynamic subtest pipe-B-plane-0: SUCCESS (0.216s)
[157.592992] Starting dynamic subtest: pipe-B-plane-1
[157.750279] Dynamic subtest pipe-B-plane-1: SUCCESS (0.179s)
[157.783413] Starting dynamic subtest: pipe-B-plane-2
[157.958545] Dynamic subtest pipe-B-plane-2: SUCCESS (0.196s)
[158.249951] Starting dynamic subtest: pipe-C-plane-0
[158.415220] Dynamic subtest pipe-C-plane-0: SUCCESS (0.199s)
[158.445235] Starting dynamic subtest: pipe-C-plane-1
[158.630286] Dynamic subtest pipe-C-plane-1: SUCCESS (0.212s)
[158.643782] Starting dynamic subtest: pipe-C-plane-2
[158.813769] Dynamic subtest pipe-C-plane-2: SUCCESS (0.181s)
[159.149123] Starting dynamic subtest: pipe-D-plane-0
[159.321271] Dynamic subtest pipe-D-plane-0: SUCCESS (0.199s)
[159.340856] Starting dynamic subtest: pipe-D-plane-1
[159.520474] Dynamic subtest pipe-D-plane-1: SUCCESS (0.199s)
[159.554804] Starting dynamic subtest: pipe-D-plane-2
[159.737106] Dynamic subtest pipe-D-plane-2: SUCCESS (0.213s)
[159.775424] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.526s)
[159.963060] [041/156] (872s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[161.479724] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[162.084624] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.605s)
[162.318440] [042/156] (870s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[162.370169] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[162.371738] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[162.509474] [043/156] (870s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[164.006175] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[164.025286] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.017s)
[164.142609] [044/156] (868s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[164.199189] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[164.200890] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[164.345261] [045/156] (868s left) kms_hdr (invalid-metadata-sizes)
[165.837121] Starting subtest: invalid-metadata-sizes
[165.838971] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB2101010
[165.842721] Dynamic subtest pipe-A-HDMI-A-4-XRGB2101010: SKIP (0.000s)
[165.854786] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB16161616F
[165.859147] Dynamic subtest pipe-A-HDMI-A-4-XRGB16161616F: SKIP (0.000s)
[165.863288] Subtest invalid-metadata-sizes: SKIP (0.004s)
[165.959606] [046/156] (867s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[166.497028] Starting subtest: syncobj-backward-timeline-chain-engines
[166.629842] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.134s)
[166.961364] [047/156] (866s left) gem_mmap_wc (read)
[167.012179] Subtest read: SKIP (0.000s)
[167.097247] [048/156] (866s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[168.596829] Starting subtest: nonblocking-crc-frame-sequence
[168.598277] Starting dynamic subtest: pipe-A-HDMI-A-4
[169.357652] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.769s)
[169.369291] Starting dynamic subtest: pipe-B-HDMI-A-4
[169.900162] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.541s)
[169.912208] Starting dynamic subtest: pipe-C-HDMI-A-4
[170.466115] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.564s)
[170.477707] Starting dynamic subtest: pipe-D-HDMI-A-4
[171.047808] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.580s)
[171.049422] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.461s)
[171.254739] [049/156] (862s left) gem_madvise (dontneed-before-exec)
[171.304727] Starting subtest: dontneed-before-exec
[171.310254] Subtest dontneed-before-exec: SKIP (0.003s)
[171.403434] [050/156] (862s left) kms_psr (psr2-sprite-plane-move)
[172.894027] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[172.968964] [051/156] (860s left) kms_scaling_modes (scaling-mode-full-aspect)
[174.462769] Starting subtest: scaling-mode-full-aspect
[174.472241] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[174.581462] [052/156] (859s left) gem_ctx_persistence (engines-hostile)
[174.643626] Starting subtest: engines-hostile
[174.645243] Starting dynamic subtest: rcs0
[174.755497] Dynamic subtest rcs0: SUCCESS (0.110s)
[174.803122] Starting dynamic subtest: bcs0
[174.808122] Dynamic subtest bcs0: SUCCESS (0.050s)
[174.823988] Starting dynamic subtest: vcs0
[174.907338] Dynamic subtest vcs0: SUCCESS (0.097s)
[174.953133] Starting dynamic subtest: vcs1
[174.960210] Dynamic subtest vcs1: SUCCESS (0.050s)
[174.976928] Starting dynamic subtest: vecs0
[175.053120] Dynamic subtest vecs0: SUCCESS (0.091s)
[175.056305] Subtest engines-hostile: SUCCESS (0.410s)
[175.304416] [053/156] (858s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[176.805886] Starting subtest: fbchdr-modesetfrombusy
[176.809215] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[176.955645] [054/156] (856s left) fbdev (unaligned-read)
[177.026883] Starting subtest: unaligned-read
[177.041026] Subtest unaligned-read: SUCCESS (0.016s)
[177.141434] [055/156] (856s left) gem_exec_params (sol-reset-not-gen7)
[177.195483] Starting subtest: sol-reset-not-gen7
[177.201336] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[177.390774] [056/156] (856s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[178.889223] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[178.892304] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[179.034148] [057/156] (855s left) api_intel_bb (render)
[179.092812] Starting subtest: render
[179.094484] Starting dynamic subtest: render-none-512
[179.133374] Dynamic subtest render-none-512: SUCCESS (0.041s)
[179.145277] Starting dynamic subtest: render-none-1024
[179.210255] Dynamic subtest render-none-1024: SUCCESS (0.076s)
[179.221910] Starting dynamic subtest: render-x-512
[179.231840] Dynamic subtest render-x-512: SUCCESS (0.021s)
[179.243617] Starting dynamic subtest: render-x-1024
[179.301114] Dynamic subtest render-x-1024: SUCCESS (0.069s)
[179.312966] Starting dynamic subtest: render-y-512
[179.322392] Dynamic subtest render-y-512: SUCCESS (0.021s)
[179.334110] Starting dynamic subtest: render-y-1024
[179.380921] Dynamic subtest render-y-1024: SUCCESS (0.058s)
[179.382685] Subtest render: SUCCESS (0.289s)
[179.548367] [058/156] (854s left) perf_pmu (init-wait)
[179.613501] Starting subtest: init-wait
[179.614948] Starting dynamic subtest: rcs0
[179.616469] Dynamic subtest rcs0: SUCCESS (0.002s)
[179.628260] Starting dynamic subtest: bcs0
[179.629948] Dynamic subtest bcs0: SUCCESS (0.001s)
[179.641211] Starting dynamic subtest: vcs0
[179.642874] Dynamic subtest vcs0: SUCCESS (0.001s)
[179.653868] Starting dynamic subtest: vcs1
[179.655461] Dynamic subtest vcs1: SUCCESS (0.001s)
[179.666966] Starting dynamic subtest: vecs0
[179.668752] Dynamic subtest vecs0: SUCCESS (0.001s)
[179.670371] Subtest init-wait: SUCCESS (0.008s)
[179.766961] [059/156] (854s left) perf_pmu (busy)
[179.818187] Starting subtest: busy
[179.819820] Starting dynamic subtest: rcs0
[180.417588] Dynamic subtest rcs0: SUCCESS (0.599s)
[180.432321] Starting dynamic subtest: bcs0
[180.973602] Dynamic subtest bcs0: SUCCESS (0.555s)
[180.988148] Starting dynamic subtest: vcs0
[181.533261] Dynamic subtest vcs0: SUCCESS (0.558s)
[181.549315] Starting dynamic subtest: vcs1
[182.096754] Dynamic subtest vcs1: SUCCESS (0.561s)
[182.111626] Starting dynamic subtest: vecs0
[182.653634] Dynamic subtest vecs0: SUCCESS (0.556s)
[182.655428] Subtest busy: SUCCESS (2.836s)
[182.789382] [060/156] (851s left) gem_exec_schedule (timeslicing)
[182.851792] Starting subtest: timeslicing
[182.853418] Starting dynamic subtest: rcs0
[182.870930] Dynamic subtest rcs0: SUCCESS (0.020s)
[182.883797] Starting dynamic subtest: bcs0
[182.891837] Dynamic subtest bcs0: SUCCESS (0.020s)
[182.904576] Starting dynamic subtest: vcs0
[182.911699] Dynamic subtest vcs0: SUCCESS (0.019s)
[182.924495] Starting dynamic subtest: vcs1
[182.933363] Dynamic subtest vcs1: SUCCESS (0.021s)
[182.946235] Starting dynamic subtest: vecs0
[182.956145] Dynamic subtest vecs0: SUCCESS (0.022s)
[182.957959] Subtest timeslicing: SUCCESS (0.105s)
[183.396796] [061/156] (851s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[183.447801] Starting subtest: single-wait-all-for-submit-signaled
[183.449231] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[183.562231] [062/156] (850s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[185.073242] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[186.178300] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.102s)
[186.468374] [063/156] (848s left) gem_create (busy-create)
[186.521780] Starting subtest: busy-create
[186.523335] Starting dynamic subtest: lmem0
[218.778820] Dynamic subtest lmem0: SUCCESS (32.257s)
[218.791397] Starting dynamic subtest: smem0
[251.049827] Dynamic subtest smem0: SUCCESS (32.270s)
[251.051785] Subtest busy-create: SUCCESS (64.529s)
[251.294395] [064/156] (783s left) i915_hangman (gt-engine-hang)
[251.368505] Starting subtest: gt-engine-hang
[251.370468] Starting dynamic subtest: rcs0
[252.060184] Dynamic subtest rcs0: SUCCESS (0.692s)
[252.073060] Starting dynamic subtest: bcs0
[252.730094] Dynamic subtest bcs0: SUCCESS (0.669s)
[252.743356] Starting dynamic subtest: vcs0
[253.397711] Dynamic subtest vcs0: SUCCESS (0.667s)
[253.410839] Starting dynamic subtest: vcs1
[254.046483] Dynamic subtest vcs1: SUCCESS (0.648s)
[254.058950] Starting dynamic subtest: vecs0
[254.714786] Dynamic subtest vecs0: SUCCESS (0.668s)
[254.716267] Subtest gt-engine-hang: SUCCESS (3.348s)
[254.860321] [065/156] (779s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[256.349840] Starting subtest: plane-downscale-factor-0-5-with-rotation
[256.351481] Starting dynamic subtest: pipe-A
[256.859515] Dynamic subtest pipe-A: SKIP (0.506s)
[256.872150] Starting dynamic subtest: pipe-B
[257.283672] Dynamic subtest pipe-B: SKIP (0.423s)
[257.296076] Starting dynamic subtest: pipe-C
[257.707473] Dynamic subtest pipe-C: SKIP (0.422s)
[257.720212] Starting dynamic subtest: pipe-D
[258.129652] Dynamic subtest pipe-D: SKIP (0.422s)
[258.133217] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (1.777s)
[258.346957] [066/156] (776s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[259.865137] Starting subtest: x-tiled-8bpp-rotate-90
[259.961601] Subtest x-tiled-8bpp-rotate-90: SKIP (0.094s)
[260.114083] [067/156] (774s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[261.608229] Starting subtest: cursorB-vs-flipB-varying-size
[261.611268] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[261.736468] [068/156] (773s left) gem_softpin (allocator-basic)
[261.798206] Starting subtest: allocator-basic
[262.074805] Subtest allocator-basic: SUCCESS (0.273s)
[262.260022] [069/156] (772s left) kms_chamelium_color (ctm-max)
[263.752136] Subtest ctm-max: SKIP (0.000s)
[263.840700] [070/156] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[265.341154] Starting subtest: psr-1p-primscrn-cur-indfb-move
[265.343825] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[265.531251] [071/156] (769s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[267.033465] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[267.037245] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[267.268230] [072/156] (768s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[271.092546] Starting subtest: gem-execbuf-stress-pc8
[271.171698] Subtest gem-execbuf-stress-pc8: SKIP (0.078s)
[272.075493] [073/156] (763s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[273.585747] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[273.588724] Starting dynamic subtest: pipe-A-HDMI-A-4
[273.603799] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[273.616806] Starting dynamic subtest: pipe-B-HDMI-A-4
[273.632684] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[273.644991] Starting dynamic subtest: pipe-C-HDMI-A-4
[273.660791] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[273.673647] Starting dynamic subtest: pipe-D-HDMI-A-4
[273.694795] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[273.698271] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.012s)
[273.877185] [074/156] (761s left) syncobj_wait (wait-all-delayed-signal)
[273.927227] Starting subtest: wait-all-delayed-signal
[274.034132] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[274.201613] [075/156] (761s left) kms_addfb_basic (invalid-get-prop)
[274.250616] Starting subtest: invalid-get-prop
[274.252188] Subtest invalid-get-prop: SUCCESS (0.000s)
[275.897445] [076/156] (759s left) kms_vblank (wait-idle-hang)
[277.388513] Starting subtest: wait-idle-hang
[277.390314] Starting dynamic subtest: pipe-A-HDMI-A-4
[303.468927] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.070s)
[303.484216] Starting dynamic subtest: pipe-D-HDMI-A-4
[328.463282] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.000s)
[328.464861] Subtest wait-idle-hang: SUCCESS (51.078s)
[328.660674] [077/156] (707s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[330.162385] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[330.165277] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[330.338349] [078/156] (705s left) kms_vblank (query-idle)
[331.829702] Starting subtest: query-idle
[331.831206] Starting dynamic subtest: pipe-A-HDMI-A-4
[334.144772] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.313s)
[334.160495] Starting dynamic subtest: pipe-D-HDMI-A-4
[336.335923] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.187s)
[336.337623] Subtest query-idle: SUCCESS (4.507s)
[336.535803] [079/156] (699s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[338.035819] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[338.039026] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[338.225515] [080/156] (697s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[339.741885] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[339.745281] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[339.918555] [081/156] (696s left) dmabuf_sync_file (import-basic)
[339.973750] Starting subtest: import-basic
[339.975424] Subtest import-basic: SUCCESS (0.003s)
[340.072106] [082/156] (696s left) gem_mmap_wc (bad-object)
[340.126169] Subtest bad-object: SKIP (0.000s)
[340.201986] [083/156] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[341.700128] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[341.703271] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[341.884305] [084/156] (694s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[343.384936] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[343.388116] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[343.594618] [085/156] (693s left) perf_pmu (frequency)
[343.648317] Starting subtest: frequency
[343.652595] Starting dynamic subtest: gt0
[345.793202] Dynamic subtest gt0: SUCCESS (2.136s)
[345.806228] Starting dynamic subtest: idle-gt0
[346.311566] Dynamic subtest idle-gt0: SUCCESS (0.515s)
[346.312916] Subtest frequency: SUCCESS (2.664s)
[346.451878] [086/156] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[347.950173] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[347.953364] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[348.137939] [087/156] (688s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[349.632552] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[349.719801] [088/156] (687s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[351.214884] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[351.236896] Starting dynamic subtest: pipe-A-plane-0
[351.770743] Dynamic subtest pipe-A-plane-0: SUCCESS (0.533s)
[351.814903] Starting dynamic subtest: pipe-A-plane-3
[352.103182] Dynamic subtest pipe-A-plane-3: SUCCESS (0.328s)
[352.139968] Starting dynamic subtest: pipe-A-plane-5
[352.436401] Dynamic subtest pipe-A-plane-5: SUCCESS (0.329s)
[352.480897] Starting dynamic subtest: pipe-A-plane-7
[352.484594] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[352.599922] Starting dynamic subtest: pipe-B-plane-0
[352.990072] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[353.007680] Starting dynamic subtest: pipe-B-plane-3
[353.355649] Dynamic subtest pipe-B-plane-3: SUCCESS (0.361s)
[353.395644] Starting dynamic subtest: pipe-B-plane-5
[353.688121] Dynamic subtest pipe-B-plane-5: SUCCESS (0.329s)
[353.702390] Starting dynamic subtest: pipe-B-plane-7
[353.705335] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[353.727599] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SUCCESS (2.514s)
[354.006679] [089/156] (683s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[355.499886] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[355.587690] [090/156] (681s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[357.079582] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[357.081151] Starting dynamic subtest: pipe-A-HDMI-A-4
[357.094868] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[357.107945] Starting dynamic subtest: pipe-B-HDMI-A-4
[357.124042] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[357.136479] Starting dynamic subtest: pipe-C-HDMI-A-4
[357.150779] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[357.163582] Starting dynamic subtest: pipe-D-HDMI-A-4
[357.179541] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[357.181369] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.017s)
[357.370843] [091/156] (679s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[357.419222] Starting subtest: etime-multi-wait-all-submitted-signaled
[357.526870] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[357.741770] [092/156] (679s left) prime_self_import (basic-with_fd_dup)
[357.789659] Starting subtest: basic-with_fd_dup
[357.792995] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[357.947396] [093/156] (679s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[359.457982] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[361.633885] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.179s)
[361.837103] [094/156] (675s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[363.326551] Starting subtest: plane-upscale-20x20-with-pixel-format
[363.327913] Starting dynamic subtest: pipe-A
[365.549165] Dynamic subtest pipe-A: SUCCESS (2.222s)
[365.566860] Starting dynamic subtest: pipe-B
[367.789389] Dynamic subtest pipe-B: SUCCESS (2.239s)
[367.812406] Starting dynamic subtest: pipe-C
[368.097319] Dynamic subtest pipe-C: SUCCESS (0.306s)
[368.118481] Starting dynamic subtest: pipe-D
[368.404806] Dynamic subtest pipe-D: SUCCESS (0.305s)
[368.406748] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.079s)
[368.635324] [095/156] (668s left) gen9_exec_parse (unaligned-access)
[368.695038] Subtest unaligned-access: SKIP (0.000s)
[368.776930] [096/156] (668s left) syncobj_wait (multi-wait-submitted-signaled)
[368.827118] Starting subtest: multi-wait-submitted-signaled
[368.828728] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[368.955634] [097/156] (668s left) kms_feature_discovery (display-2x)
[370.448868] Starting subtest: display-2x
[370.452603] Subtest display-2x: SKIP (0.000s)
[370.576387] [098/156] (667s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[372.085122] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[372.090502] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.325977] [099/156] (665s left) kms_addfb_basic (invalid-set-prop-any)
[372.375672] Starting subtest: invalid-set-prop-any
[372.377310] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[373.980356] [100/156] (664s left) kms_lease (lease-invalid-crtc)
[375.492710] Starting subtest: lease-invalid-crtc
[375.494161] Starting dynamic subtest: pipe-A-HDMI-A-4
[375.495652] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.000s)
[375.508826] Starting dynamic subtest: pipe-B-HDMI-A-4
[375.510420] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.000s)
[375.523231] Starting dynamic subtest: pipe-C-HDMI-A-4
[375.524928] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.000s)
[375.537926] Starting dynamic subtest: pipe-D-HDMI-A-4
[375.539778] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.000s)
[375.541555] Subtest lease-invalid-crtc: SUCCESS (0.009s)
[375.614213] [101/156] (662s left) kms_plane_multiple (2x-tiling-none)
[377.108442] Starting subtest: 2x-tiling-none
[377.111209] Subtest 2x-tiling-none: SKIP (0.000s)
[377.241213] [102/156] (660s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[378.739103] Starting subtest: addfb25-y-tiled-legacy
[378.741121] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[378.931492] [103/156] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[380.448055] Starting subtest: psr-1p-primscrn-spr-indfb-move
[380.451582] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[380.629976] [104/156] (657s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[382.149215] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[384.995117] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.850s)
[385.209761] [105/156] (653s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[385.275477] Starting subtest: yf-tiled-ccs-to-y-tiled
[385.277113] Starting dynamic subtest: smem
[385.371501] Dynamic subtest smem: SUCCESS (0.095s)
[385.384454] Starting dynamic subtest: lmem0
[386.312496] Dynamic subtest lmem0: SUCCESS (0.936s)
[386.314230] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (1.035s)
[386.592344] [106/156] (652s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[388.085408] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[388.086892] Starting dynamic subtest: pipe-A-HDMI-A-4
[388.102096] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[388.115167] Starting dynamic subtest: pipe-B-HDMI-A-4
[388.130176] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[388.142787] Starting dynamic subtest: pipe-C-HDMI-A-4
[388.158349] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[388.170975] Starting dynamic subtest: pipe-D-HDMI-A-4
[388.187859] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[388.191188] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.013s)
[388.359578] [107/156] (650s left) kms_flip (flip-vs-rmfb)
[389.853898] Starting subtest: flip-vs-rmfb
[389.860350] Starting dynamic subtest: A-HDMI-A4
[397.620248] Dynamic subtest A-HDMI-A4: SUCCESS (7.759s)
[397.669312] Starting dynamic subtest: B-HDMI-A4
[405.330152] Dynamic subtest B-HDMI-A4: SUCCESS (7.700s)
[405.373595] Starting dynamic subtest: C-HDMI-A4
[413.041956] Dynamic subtest C-HDMI-A4: SUCCESS (7.706s)
[413.080568] Starting dynamic subtest: D-HDMI-A4
[420.753871] Dynamic subtest D-HDMI-A4: SUCCESS (7.706s)
[420.756024] Subtest flip-vs-rmfb: SUCCESS (30.904s)
[421.032241] [108/156] (617s left) syncobj_wait (multi-wait-all-submitted)
[421.081129] Starting subtest: multi-wait-all-submitted
[421.193180] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[421.348544] [109/156] (617s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[422.845967] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[422.848984] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[423.024286] [110/156] (615s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[424.518410] Starting subtest: plane-all-modeset-transition-internal-panels
[424.521341] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[424.632052] [111/156] (614s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[426.133602] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[426.136385] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[426.293151] [112/156] (612s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[427.811846] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[427.815214] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[427.984095] [113/156] (611s left) gem_bad_reloc (negative-reloc-bltcopy)
[428.051828] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[428.164709] [114/156] (611s left) syncobj_wait (multi-wait-for-submit-submitted)
[428.213247] Starting subtest: multi-wait-for-submit-submitted
[428.320117] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[428.485239] [115/156] (611s left) kms_pm_lpsp (kms-lpsp)
[430.981763] Starting subtest: kms-lpsp
[430.985205] Subtest kms-lpsp: SKIP (0.000s)
[431.105777] [116/156] (608s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[432.644980] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[432.648425] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[432.823317] [117/156] (606s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[434.324169] Starting subtest: psr-rgb101010-draw-blt
[434.327289] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[434.548463] [118/156] (605s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[436.047587] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[436.050620] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[436.227619] [119/156] (603s left) gem_flink_basic (bad-flink)
[436.277725] Starting subtest: bad-flink
[436.279540] Subtest bad-flink: SUCCESS (0.000s)
[436.404693] [120/156] (603s left) prime_vgem (busy)
[436.514130] Starting subtest: busy
[436.516066] Starting dynamic subtest: rcs0
[436.609244] Dynamic subtest rcs0: SUCCESS (0.097s)
[436.622178] Starting dynamic subtest: bcs0
[436.658777] Dynamic subtest bcs0: SUCCESS (0.048s)
[436.674380] Starting dynamic subtest: vcs0
[436.702181] Dynamic subtest vcs0: SUCCESS (0.041s)
[436.723711] Starting dynamic subtest: vcs1
[436.745160] Dynamic subtest vcs1: SUCCESS (0.041s)
[436.771363] Starting dynamic subtest: vecs0
[436.787258] Dynamic subtest vecs0: SUCCESS (0.038s)
[436.789188] Subtest busy: SUCCESS (0.277s)
[437.013835] [121/156] (603s left) syncobj_wait (wait-all-for-submit-snapshot)
[437.064912] Starting subtest: wait-all-for-submit-snapshot
[437.148687] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[437.318858] [122/156] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[438.815359] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[438.818367] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[439.001049] [123/156] (601s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt)
[440.500410] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt
[440.503997] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[440.675220] [124/156] (599s left) gen9_exec_parse (basic-rejected-ctx-param)
[440.738558] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[440.808736] [125/156] (599s left) gem_exec_params (readonly)
[440.861482] Starting subtest: readonly
[440.865154] Subtest readonly: SUCCESS (0.003s)
[441.060992] [126/156] (599s left) kms_psr (fbc-pr-primary-render)
[442.552244] Subtest fbc-pr-primary-render: SKIP (0.000s)
[442.641880] [127/156] (598s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[444.140981] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[444.157908] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.017s)
[444.304245] [128/156] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[445.805735] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[445.809027] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[446.007548] [129/156] (595s left) kms_cursor_legacy (single-bo)
[447.516238] Starting subtest: single-bo
[447.518105] Starting dynamic subtest: pipe-A
[452.903794] Dynamic subtest pipe-A: SUCCESS (5.383s)
[452.916813] Starting dynamic subtest: pipe-B
[458.287335] Dynamic subtest pipe-B: SUCCESS (5.382s)
[458.300237] Starting dynamic subtest: pipe-C
[463.670454] Dynamic subtest pipe-C: SUCCESS (5.382s)
[463.683429] Starting dynamic subtest: pipe-D
[469.053650] Dynamic subtest pipe-D: SUCCESS (5.382s)
[469.066749] Starting dynamic subtest: all-pipes
[474.437429] Dynamic subtest all-pipes: SUCCESS (5.382s)
[474.439238] Subtest single-bo: SUCCESS (26.918s)
[474.548769] [130/156] (566s left) kms_cursor_crc (cursor-sliding-64x21)
[476.195889] Starting subtest: cursor-sliding-64x21
[476.204544] Starting dynamic subtest: pipe-A-HDMI-A-4
[480.630450] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.427s)
[480.665991] Starting dynamic subtest: pipe-D-HDMI-A-4
[484.882917] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.217s)
[484.884463] Subtest cursor-sliding-64x21: SUCCESS (8.676s)
[485.341976] [131/156] (555s left) gem_huc_copy (huc-copy)
[485.413598] Starting subtest: huc-copy
[485.418858] Subtest huc-copy: SUCCESS (0.005s)
[485.642557] [132/156] (555s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[487.135651] Starting subtest: primary-y-tiled-reflect-x-0
[497.708040] Subtest primary-y-tiled-reflect-x-0: SUCCESS (10.574s)
[497.987554] [133/156] (543s left) kms_properties (colorop-properties-atomic)
[499.480102] Starting subtest: colorop-properties-atomic
[499.481781] Starting dynamic subtest: pipe-A-HDMI-A-4
[499.597067] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.114s)
[499.610601] Starting dynamic subtest: pipe-B-HDMI-A-4
[499.724180] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.122s)
[499.738011] Starting dynamic subtest: pipe-C-HDMI-A-4
[499.854637] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.131s)
[499.867539] Starting dynamic subtest: pipe-D-HDMI-A-4
[499.979135] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.122s)
[499.980870] Subtest colorop-properties-atomic: SUCCESS (0.498s)
[500.199761] [134/156] (541s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[501.692272] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[501.695739] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[501.804380] [135/156] (539s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[503.308281] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[503.311203] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[503.464266] [136/156] (538s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[503.518688] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[503.595719] [137/156] (538s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[505.087907] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[505.091709] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[505.206086] [138/156] (536s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[506.709862] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[506.712860] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[506.899704] [139/156] (535s left) i915_pm_rps (thresholds-park)
[506.956886] Starting subtest: thresholds-park
[506.960133] Subtest thresholds-park: SKIP (0.000s)
[507.073967] [140/156] (534s left) kms_setmode (basic)
[507.125904] Starting subtest: basic
[507.218976] Starting dynamic subtest: pipe-A-HDMI-A-4
[509.351156] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.126s)
[509.438656] Starting dynamic subtest: pipe-C-HDMI-A-4
[511.555289] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.123s)
[511.591577] Subtest basic: SUCCESS (4.466s)
[511.802665] [141/156] (530s left) gem_partial_pwrite_pread (write)
[511.858155] Subtest write: SKIP (0.000s)
[511.972728] [142/156] (530s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[513.481780] Starting subtest: yf-tiled-addfb-size-offset-overflow
[513.484808] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[513.666411] [143/156] (528s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[515.163829] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[515.166746] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[515.362147] [144/156] (527s left) gem_softpin (overlap)
[515.417158] Starting subtest: overlap
[519.151224] Subtest overlap: SUCCESS (3.731s)
[519.354838] [145/156] (523s left) gem_softpin (softpin)
[519.410879] Starting subtest: softpin
[551.633965] Subtest softpin: SUCCESS (32.218s)
[551.798318] [146/156] (490s left) gem_spin_batch (resubmit-new-all)
[551.861401] Starting subtest: resubmit-new-all
[551.863107] Starting dynamic subtest: rcs0
[551.889307] Dynamic subtest rcs0: SUCCESS (0.027s)
[551.902602] Starting dynamic subtest: bcs0
[551.904222] Dynamic subtest bcs0: SUCCESS (0.007s)
[551.917306] Starting dynamic subtest: vcs0
[551.918986] Dynamic subtest vcs0: SUCCESS (0.008s)
[551.932211] Starting dynamic subtest: vcs1
[551.933982] Dynamic subtest vcs1: SUCCESS (0.007s)
[551.946995] Starting dynamic subtest: vecs0
[551.949127] Dynamic subtest vecs0: SUCCESS (0.008s)
[551.950986] Subtest resubmit-new-all: SUCCESS (0.065s)
[552.278843] [147/156] (490s left) kms_content_protection (dp-mst-lic-type-1)
[553.827878] Starting subtest: dp-mst-lic-type-1
[553.833706] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[554.017926] [148/156] (488s left) kms_cursor_crc (cursor-onscreen-512x512)
[555.778202] Starting subtest: cursor-onscreen-512x512
[555.780845] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[556.034937] [149/156] (486s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[557.539379] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[557.543049] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[557.680222] [150/156] (485s left) kms_big_fb (linear-addfb)
[559.194792] Starting subtest: linear-addfb
[559.196430] Subtest linear-addfb: SUCCESS (0.000s)
[559.388034] [151/156] (483s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[560.887858] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[560.891050] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[561.031839] [152/156] (482s left) kms_psr (psr2-cursor-mmap-cpu)
[562.527512] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[562.618184] [153/156] (480s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[564.131318] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[564.134256] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[564.324321] [154/156] (479s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[565.822814] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[565.826641] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[566.003221] [155/156] (477s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[566.051954] Starting subtest: invalid-single-wait-unsubmitted
[566.053728] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[566.181635] [156/156] (477s left) api_intel_allocator (standalone)
[566.241721] Starting subtest: standalone
[566.279374] Subtest standalone: SUCCESS (0.038s)
[566.466631] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: gem_shrink
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: gem_ctx_shared
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: kms_async_flips
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: kms_dsc
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: prime_mmap_coherency
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_atomic_interruptible
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_edid
results: parsing output: 31/ for test: kms_properties
results: parsing output: 32/ for test: gem_wait
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: kms_color_pipeline
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_hdr
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: kms_pipe_crc_basic
results: parsing output: 48/ for test: gem_madvise
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_scaling_modes
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: fbdev
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_create
results: parsing output: 63/ for test: i915_hangman
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_chamelium_color
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: i915_pm_rpm
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: dmabuf_sync_file
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: gen9_exec_parse
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_feature_discovery
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_atomic_transition
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_bad_reloc
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_pm_lpsp
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_flink_basic
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: gem_huc_copy
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: kms_properties
results: parsing output: 133/ for test: kms_plane
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_mmap_gtt
results: parsing output: 136/ for test: kms_flip_scaled_crc
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: i915_pm_rps
results: parsing output: 139/ for test: kms_setmode
results: parsing output: 140/ for test: gem_partial_pwrite_pread
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_softpin
results: parsing output: 144/ for test: gem_softpin
results: parsing output: 145/ for test: gem_spin_batch
results: parsing output: 146/ for test: kms_content_protection
results: parsing output: 147/ for test: kms_cursor_crc
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: syncobj_timeline
results: parsing output: 155/ for test: api_intel_allocator
Done.