[57.779616] Initializing watchdogs [57.779683] /dev/watchdog0 [57.787252] [001/130] (960s left) gen9_exec_parse (bb-chained) [57.869941] Subtest bb-chained: SKIP (0.000s) [57.911029] [002/130] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [58.075001] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [58.077082] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [58.211725] [003/130] (960s left) kms_content_protection (content-type-change) [58.507444] Starting subtest: content-type-change [59.051334] Subtest content-type-change: SKIP (0.539s) [59.368706] [004/130] (959s left) kms_chamelium_hpd (hdmi-hpd) [59.639875] Subtest hdmi-hpd: SKIP (0.000s) [59.773417] [005/130] (958s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [59.952975] Starting subtest: cursorA-vs-flipB-atomic-transitions [59.954785] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [60.020051] [006/130] (958s left) kms_fbcon_fbt (fbc-suspend) [60.112438] Starting subtest: fbc-suspend [112.719754] Subtest fbc-suspend: SUCCESS (21.384s) [112.750236] [007/130] (936s left) gem_compute (compute-square) [112.820601] Starting subtest: compute-square [112.830644] Subtest compute-square: SUCCESS (0.010s) [112.980687] [008/130] (936s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [113.148858] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [113.149741] Starting dynamic subtest: pipe-A-DP-4 [113.158464] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [113.166256] Starting dynamic subtest: pipe-B-DP-4 [113.174729] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [113.182357] Starting dynamic subtest: pipe-C-DP-4 [113.190656] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [113.198102] Starting dynamic subtest: pipe-D-DP-4 [113.207973] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [113.209924] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s) [113.510296] [009/130] (936s left) gem_exec_reloc (basic-softpin) [113.619601] Subtest basic-softpin: SKIP (0.000s) [113.659973] [010/130] (936s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [113.837020] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [115.250633] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.413s) [115.447101] [011/130] (934s left) gem_ctx_isolation (preservation-s3) [115.549662] Starting subtest: preservation-S3 [115.550692] Starting dynamic subtest: rcs0 [135.646661] Dynamic subtest rcs0: SUCCESS (4.057s) [135.656336] Starting dynamic subtest: bcs0 [155.596083] Dynamic subtest bcs0: SUCCESS (3.765s) [155.604389] Starting dynamic subtest: vcs0 [175.597522] Dynamic subtest vcs0: SUCCESS (3.776s) [175.606266] Starting dynamic subtest: vcs1 [195.620856] Dynamic subtest vcs1: SUCCESS (3.777s) [195.629104] Starting dynamic subtest: vecs0 [215.620642] Dynamic subtest vecs0: SUCCESS (3.777s) [215.629035] Starting dynamic subtest: vecs1 [235.602349] Dynamic subtest vecs1: SUCCESS (3.768s) [235.610947] Starting dynamic subtest: ccs0 [255.578881] Dynamic subtest ccs0: SUCCESS (3.780s) [255.579785] Subtest preservation-S3: SUCCESS (26.701s) [259.964333] [012/130] (907s left) syncobj_eventfd (timeline-wait-signaled) [260.097495] Starting subtest: timeline-wait-signaled [260.098467] Subtest timeline-wait-signaled: SUCCESS (0.000s) [260.211880] [013/130] (907s left) syncobj_timeline (wait-any-complex) [260.278635] Starting subtest: wait-any-complex [260.341347] Subtest wait-any-complex: SUCCESS (0.063s) [260.431487] [014/130] (906s left) gem_exec_schedule (reorder-wide) [260.630930] Subtest reorder-wide: SKIP (0.000s) [260.829633] [015/130] (906s left) gem_ctx_isolation (dirty-switch) [260.909692] Starting subtest: dirty-switch [260.910665] Starting dynamic subtest: rcs0 [261.513208] Dynamic subtest rcs0: SUCCESS (0.603s) [261.521740] Starting dynamic subtest: bcs0 [262.123739] Dynamic subtest bcs0: SUCCESS (0.610s) [262.132388] Starting dynamic subtest: vcs0 [262.696340] Dynamic subtest vcs0: SUCCESS (0.572s) [262.704892] Starting dynamic subtest: vcs1 [263.268032] Dynamic subtest vcs1: SUCCESS (0.571s) [263.276645] Starting dynamic subtest: vecs0 [263.867669] Dynamic subtest vecs0: SUCCESS (0.590s) [263.876064] Starting dynamic subtest: vecs1 [264.440300] Dynamic subtest vecs1: SUCCESS (0.581s) [264.448846] Starting dynamic subtest: ccs0 [265.009024] Dynamic subtest ccs0: SUCCESS (0.569s) [265.009914] Subtest dirty-switch: SUCCESS (4.099s) [265.279209] [016/130] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [265.449662] Starting subtest: fbc-2p-primscrn-cur-indfb-move [265.451596] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [265.557572] [017/130] (901s left) kms_pm_rpm (pm-tiling) [267.558299] Starting subtest: pm-tiling [267.560722] Subtest pm-tiling: SKIP (0.000s) [267.821208] [018/130] (899s left) kms_plane_scaling (2x-scaler-multi-pipe) [267.988176] Starting subtest: 2x-scaler-multi-pipe [267.991069] Subtest 2x-scaler-multi-pipe: SKIP (0.002s) [268.079236] [019/130] (899s left) kms_flip (flip-vs-panning-interruptible) [268.263079] Starting subtest: flip-vs-panning-interruptible [268.268387] Starting dynamic subtest: A-DP4 [276.157104] Dynamic subtest A-DP4: SUCCESS (7.888s) [276.191257] Starting dynamic subtest: B-DP4 [284.034339] Dynamic subtest B-DP4: SUCCESS (7.875s) [284.065141] Starting dynamic subtest: C-DP4 [291.890105] Dynamic subtest C-DP4: SUCCESS (7.851s) [291.918061] Starting dynamic subtest: D-DP4 [299.742333] Dynamic subtest D-DP4: SUCCESS (7.851s) [299.747580] Subtest flip-vs-panning-interruptible: SUCCESS (31.482s) [300.071383] [020/130] (867s left) gem_softpin (noreloc-s3) [300.159216] Starting subtest: noreloc-S3 [321.003502] Subtest noreloc-S3: SUCCESS (5.469s) [324.176251] [021/130] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [324.341983] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [326.844778] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.503s) [326.984760] [022/130] (858s left) kms_psr (psr-suspend) [327.143550] Subtest psr-suspend: SKIP (0.000s) [327.172549] [023/130] (858s left) syncobj_timeline (single-wait-for-submit-available-signaled) [327.244507] Starting subtest: single-wait-for-submit-available-signaled [327.245402] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [327.368570] [024/130] (858s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [327.565432] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [327.567316] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [327.656746] [025/130] (858s left) perf_pmu (render-node-busy-idle) [327.788835] Starting subtest: render-node-busy-idle [327.789988] Starting dynamic subtest: rcs0 [328.527688] Dynamic subtest rcs0: SUCCESS (0.737s) [328.541987] Starting dynamic subtest: bcs0 [329.191027] Dynamic subtest bcs0: SUCCESS (0.660s) [329.205322] Starting dynamic subtest: vcs0 [329.874147] Dynamic subtest vcs0: FAIL (0.661s) [329.883126] Starting dynamic subtest: vcs1 [330.546419] Dynamic subtest vcs1: FAIL (0.669s) [330.555335] Starting dynamic subtest: vecs0 [331.219456] Dynamic subtest vecs0: FAIL (0.670s) [331.228469] Starting dynamic subtest: vecs1 [331.891286] Dynamic subtest vecs1: FAIL (0.668s) [331.900498] Starting dynamic subtest: ccs0 [332.543469] Dynamic subtest ccs0: FAIL (0.651s) [332.544324] Subtest render-node-busy-idle: FAIL (4.734s) [332.582637] [026/130] (853s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [332.785775] Starting subtest: yf-tiled-16bpp-rotate-0 [332.787714] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [332.907325] [027/130] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [333.098871] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [333.100958] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [333.196783] [028/130] (852s left) perf (enable-disable) [333.584932] Starting subtest: enable-disable [333.585840] Starting dynamic subtest: 0-rcs0 [335.815901] Dynamic subtest 0-rcs0: SUCCESS (2.230s) [335.816986] Subtest enable-disable: SUCCESS (2.231s) [335.844899] [029/130] (850s left) gem_ctx_param (get-priority-new-ctx) [336.001437] Starting subtest: get-priority-new-ctx [336.003583] Subtest get-priority-new-ctx: SUCCESS (0.001s) [336.115634] [030/130] (849s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [336.350154] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [336.351887] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [336.600017] [031/130] (849s left) kms_frontbuffer_tracking (psr-slowdraw) [336.832857] Starting subtest: psr-slowdraw [336.834800] Subtest psr-slowdraw: SKIP (0.000s) [336.992051] [032/130] (849s left) kms_feature_discovery (display-3x) [337.206241] Starting subtest: display-3x [337.208089] Subtest display-3x: SKIP (0.000s) [337.271685] [033/130] (848s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [337.489825] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [338.465619] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.975s) [338.683008] [034/130] (847s left) kms_hdr (static-toggle) [338.910524] Starting subtest: static-toggle [339.052582] Starting dynamic subtest: pipe-A-DP-4 [340.115413] Dynamic subtest pipe-A-DP-4: SUCCESS (1.064s) [340.116567] Subtest static-toggle: SUCCESS (1.206s) [340.300682] [035/130] (845s left) prime_vgem (basic-fence-mmap) [340.584682] Starting subtest: basic-fence-mmap [340.586750] Subtest basic-fence-mmap: SKIP (0.000s) [340.696526] [036/130] (845s left) kms_prop_blob (blob-multiple) [340.827302] Starting subtest: blob-multiple [340.829645] Subtest blob-multiple: SUCCESS (0.003s) [340.955551] [037/130] (845s left) i915_pm_rpm (reg-read-ioctl) [342.975578] Starting subtest: reg-read-ioctl [343.556907] Subtest reg-read-ioctl: SUCCESS (0.581s) [343.857785] [038/130] (842s left) kms_lease (master-vs-lease) [344.081078] Starting subtest: master-vs-lease [344.083938] Subtest master-vs-lease: SUCCESS (0.003s) [344.199059] [039/130] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [344.430152] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [344.432257] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [344.548694] [040/130] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [344.783386] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [344.785115] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [344.880841] [041/130] (841s left) gem_pwrite (basic-exhaustion) [345.022436] Subtest basic-exhaustion: SKIP (0.000s) [345.060856] [042/130] (841s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [345.270845] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [345.271768] Starting dynamic subtest: pipe-A-DP-4 [345.293192] Dynamic subtest pipe-A-DP-4: SKIP (0.002s) [345.302466] Starting dynamic subtest: pipe-B-DP-4 [345.324218] Dynamic subtest pipe-B-DP-4: SKIP (0.002s) [345.333264] Starting dynamic subtest: pipe-C-DP-4 [345.358663] Dynamic subtest pipe-C-DP-4: SKIP (0.002s) [345.368387] Starting dynamic subtest: pipe-D-DP-4 [345.389605] Dynamic subtest pipe-D-DP-4: SKIP (0.002s) [345.391665] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s) [345.647985] [043/130] (840s left) kms_chamelium_edid (dp-edid-change-during-suspend) [345.955554] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [346.066663] [044/130] (840s left) gem_exec_schedule (implicit-write-read) [346.210483] Starting subtest: implicit-write-read [346.211405] Starting dynamic subtest: rcs0 [346.491322] Dynamic subtest rcs0: SUCCESS (0.280s) [346.500570] Starting dynamic subtest: bcs0 [346.682147] Dynamic subtest bcs0: SUCCESS (0.190s) [346.691476] Starting dynamic subtest: vcs0 [346.884596] Dynamic subtest vcs0: SUCCESS (0.202s) [346.894109] Starting dynamic subtest: vcs1 [347.090824] Dynamic subtest vcs1: SUCCESS (0.205s) [347.100145] Starting dynamic subtest: vecs0 [347.292357] Dynamic subtest vecs0: SUCCESS (0.201s) [347.301964] Starting dynamic subtest: vecs1 [347.495219] Dynamic subtest vecs1: SUCCESS (0.202s) [347.504716] Starting dynamic subtest: ccs0 [347.692751] Dynamic subtest ccs0: SUCCESS (0.197s) [347.693890] Subtest implicit-write-read: SUCCESS (1.482s) [348.068109] [045/130] (838s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [348.300058] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [348.301028] Starting dynamic subtest: pipe-A-DP-4 [348.309453] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [348.319130] Starting dynamic subtest: pipe-B-DP-4 [348.327934] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [348.337263] Starting dynamic subtest: pipe-C-DP-4 [348.345749] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [348.355250] Starting dynamic subtest: pipe-D-DP-4 [348.365602] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [348.367667] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.006s) [348.684443] [046/130] (837s left) kms_invalid_mode (bad-vsync-end) [348.888101] Starting subtest: bad-vsync-end [348.889055] Starting dynamic subtest: pipe-A-DP-4 [348.979412] Dynamic subtest pipe-A-DP-4: SUCCESS (0.089s) [348.999434] Starting dynamic subtest: pipe-B-DP-4 [349.000651] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [349.018127] Starting dynamic subtest: pipe-C-DP-4 [349.019211] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [349.031916] Starting dynamic subtest: pipe-D-DP-4 [349.032893] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [349.033871] Subtest bad-vsync-end: SUCCESS (0.104s) [349.192267] [047/130] (837s left) gem_mmap_offset (oob-read) [349.346377] Starting subtest: oob-read [349.347338] Subtest oob-read: SUCCESS (0.000s) [349.473111] [048/130] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [349.705911] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [349.707911] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [349.831794] [049/130] (836s left) kms_flip (flip-vs-rmfb-interruptible) [350.049800] Starting subtest: flip-vs-rmfb-interruptible [350.055317] Starting dynamic subtest: A-DP4 [357.900455] Dynamic subtest A-DP4: SUCCESS (7.844s) [357.940216] Starting dynamic subtest: B-DP4 [365.684876] Dynamic subtest B-DP4: SUCCESS (7.779s) [365.720910] Starting dynamic subtest: C-DP4 [373.469971] Dynamic subtest C-DP4: SUCCESS (7.780s) [373.504623] Starting dynamic subtest: D-DP4 [381.255677] Dynamic subtest D-DP4: SUCCESS (7.781s) [381.268798] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.209s) [381.566200] [050/130] (805s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [381.810572] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [381.811493] Starting dynamic subtest: pipe-A-DP-4 [381.820170] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [381.829615] Starting dynamic subtest: pipe-B-DP-4 [381.838303] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [381.847460] Starting dynamic subtest: pipe-C-DP-4 [381.855883] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [381.865227] Starting dynamic subtest: pipe-D-DP-4 [381.875596] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [381.877522] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [382.223554] [051/130] (804s left) i915_query (hwconfig_table) [382.375391] Starting subtest: hwconfig_table [382.546371] Subtest hwconfig_table: SUCCESS (0.002s) [382.577297] [052/130] (804s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [382.786081] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [382.786982] Starting dynamic subtest: pipe-A-valid-mode [382.898720] Dynamic subtest pipe-A-valid-mode: SKIP (0.109s) [382.901150] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.112s) [383.057309] [053/130] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [383.306222] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [383.308009] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [383.408900] [054/130] (803s left) gem_render_copy_redux (flink-interruptible) [383.579316] Starting subtest: flink-interruptible [385.006276] Subtest flink-interruptible: SUCCESS (1.427s) [385.079229] [055/130] (801s left) kms_addfb_basic (bad-pitch-128) [385.200405] Starting subtest: bad-pitch-128 [385.201357] Subtest bad-pitch-128: SUCCESS (0.000s) [385.390555] [056/130] (801s left) kms_vblank (invalid) [385.637329] Starting subtest: invalid [385.638216] Starting dynamic subtest: pipe-A-DP-4 [385.968763] Dynamic subtest pipe-A-DP-4: SUCCESS (0.328s) [385.970214] Subtest invalid: SUCCESS (0.331s) [386.156732] [057/130] (800s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [386.412255] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [386.438089] [058/130] (800s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [386.653086] Starting subtest: fbc-dirtyfb-ioctl [386.654090] Starting dynamic subtest: A-DP-4 [388.184519] Dynamic subtest A-DP-4: SUCCESS (1.530s) [388.185555] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.532s) [388.399949] [059/130] (798s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [388.647151] Starting subtest: primary-x-tiled-reflect-x-0 [399.196848] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.556s) [399.506668] [060/130] (787s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [399.720214] Starting subtest: cursorA-vs-flipA-atomic [410.692938] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.972s) [410.897900] [061/130] (776s left) gem_userptr_blits (process-exit) [411.034463] Starting subtest: process-exit [411.045652] Subtest process-exit: SUCCESS (0.011s) [411.201059] [062/130] (775s left) kms_big_fb (y-tiled-16bpp-rotate-270) [411.420837] Starting subtest: y-tiled-16bpp-rotate-270 [411.422938] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [411.556033] [063/130] (775s left) api_intel_bb (render) [411.697374] Starting subtest: render [411.698343] Starting dynamic subtest: render-none-512 [411.739119] Dynamic subtest render-none-512: SUCCESS (0.042s) [411.748865] Starting dynamic subtest: render-none-1024 [411.823320] Dynamic subtest render-none-1024: SUCCESS (0.083s) [411.833202] Starting dynamic subtest: render-x-512 [411.840406] Dynamic subtest render-x-512: SUCCESS (0.016s) [411.850379] Starting dynamic subtest: render-x-1024 [411.917939] Dynamic subtest render-x-1024: SUCCESS (0.077s) [411.927724] Starting dynamic subtest: render-y-512 [411.936096] Dynamic subtest render-y-512: SUCCESS (0.017s) [411.946336] Starting dynamic subtest: render-y-1024 [411.996660] Dynamic subtest render-y-1024: SUCCESS (0.060s) [411.997514] Subtest render: SUCCESS (0.300s) [412.127922] [064/130] (775s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [412.334533] Starting subtest: short-flip-before-cursor-toggle [413.391342] Subtest short-flip-before-cursor-toggle: SUCCESS (1.057s) [413.609968] [065/130] (773s left) template (b) [413.731343] Starting subtest: B [413.732338] Subtest B: SUCCESS (0.000s) [413.841407] [066/130] (773s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [414.074106] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [414.075964] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [414.191918] [067/130] (773s left) sw_sync (sync_multi_timeline_wait) [414.315881] Starting subtest: sync_multi_timeline_wait [414.316853] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [414.365280] [068/130] (773s left) kms_vrr (lobf) [414.568832] Starting subtest: lobf [414.570548] Subtest lobf: SKIP (0.000s) [414.633925] [069/130] (772s left) perf (low-oa-exponent-permissions) [414.906730] Starting subtest: low-oa-exponent-permissions [414.956967] Subtest low-oa-exponent-permissions: SUCCESS (0.050s) [414.977941] [070/130] (772s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [415.188980] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [415.190855] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [415.279807] [071/130] (772s left) gem_exec_schedule (timeslicing) [415.428475] Starting subtest: timeslicing [415.429383] Starting dynamic subtest: rcs0 [415.449622] Dynamic subtest rcs0: SUCCESS (0.020s) [415.459556] Starting dynamic subtest: bcs0 [415.470364] Dynamic subtest bcs0: SUCCESS (0.020s) [415.480376] Starting dynamic subtest: vcs0 [415.492700] Dynamic subtest vcs0: SUCCESS (0.021s) [415.502561] Starting dynamic subtest: vcs1 [415.513704] Dynamic subtest vcs1: SUCCESS (0.020s) [415.523685] Starting dynamic subtest: vecs0 [415.534646] Dynamic subtest vecs0: SUCCESS (0.020s) [415.544552] Starting dynamic subtest: vecs1 [415.556321] Dynamic subtest vecs1: SUCCESS (0.021s) [415.566285] Starting dynamic subtest: ccs0 [415.578138] Dynamic subtest ccs0: SUCCESS (0.021s) [415.579118] Subtest timeslicing: SUCCESS (0.150s) [415.918947] [072/130] (771s left) kms_psr (pr-primary-mmap-cpu) [416.150324] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [416.190528] [073/130] (771s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [416.410143] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [416.424301] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.013s) [416.504682] [074/130] (771s left) gem_spin_batch (legacy-resubmit) [416.647165] Starting subtest: legacy-resubmit [416.648105] Starting dynamic subtest: default [416.671823] Dynamic subtest default: SUCCESS (0.024s) [416.682701] Starting dynamic subtest: render [416.683572] Dynamic subtest render: SUCCESS (0.001s) [416.693751] Starting dynamic subtest: bsd [416.694926] Dynamic subtest bsd: SUCCESS (0.002s) [416.704551] Starting dynamic subtest: bsd1 [416.705677] Dynamic subtest bsd1: SUCCESS (0.002s) [416.715164] Starting dynamic subtest: bsd2 [416.716079] Dynamic subtest bsd2: SUCCESS (0.001s) [416.725423] Starting dynamic subtest: blt [416.726424] Dynamic subtest blt: SUCCESS (0.002s) [416.735675] Starting dynamic subtest: vebox [416.736723] Dynamic subtest vebox: SUCCESS (0.002s) [416.737792] Subtest legacy-resubmit: SUCCESS (0.042s) [416.951603] [075/130] (770s left) kms_psr2_su (page_flip-nv12) [417.094257] Subtest page_flip-NV12: SKIP (0.000s) [417.142513] [076/130] (770s left) i915_hangman (gt-error-state-capture) [417.272557] Starting subtest: gt-error-state-capture [417.273416] Starting dynamic subtest: rcs0 [427.047845] Dynamic subtest rcs0: SUCCESS (9.774s) [427.060738] Starting dynamic subtest: bcs0 [436.977602] Dynamic subtest bcs0: SUCCESS (9.927s) [436.999412] Starting dynamic subtest: vcs0 [447.030864] Dynamic subtest vcs0: SUCCESS (10.051s) [447.047139] Starting dynamic subtest: vcs1 [457.000538] Dynamic subtest vcs1: SUCCESS (9.967s) [457.011704] Starting dynamic subtest: vecs0 [466.972476] Dynamic subtest vecs0: SUCCESS (9.971s) [466.982656] Starting dynamic subtest: vecs1 [476.991561] Dynamic subtest vecs1: SUCCESS (10.018s) [477.021664] Starting dynamic subtest: ccs0 [487.052829] Dynamic subtest ccs0: SUCCESS (10.059s) [487.054081] Subtest gt-error-state-capture: SUCCESS (69.778s) [487.214317] [077/130] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [487.444997] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [487.446872] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [487.578393] [078/130] (700s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [487.702770] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [487.805316] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [487.902597] [079/130] (699s left) kms_fbcon_fbt (psr-suspend) [488.031527] Starting subtest: psr-suspend [488.033440] Subtest psr-suspend: SKIP (0.000s) [488.125464] [080/130] (699s left) syncobj_timeline (invalid-transfer-non-existent-point) [488.241688] Starting subtest: invalid-transfer-non-existent-point [488.242745] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [488.339774] [081/130] (699s left) api_intel_allocator (fork-simple-stress-signal) [488.494349] Starting subtest: fork-simple-stress-signal [493.926652] Subtest fork-simple-stress-signal: SUCCESS (5.432s) [494.017181] [082/130] (693s left) perf_pmu (enable-race) [494.203527] Starting subtest: enable-race [494.204455] Starting dynamic subtest: rcs0 [506.989446] Dynamic subtest rcs0: SUCCESS (12.785s) [506.999768] Starting dynamic subtest: bcs0 [519.744337] Dynamic subtest bcs0: SUCCESS (12.754s) [519.755120] Starting dynamic subtest: vcs0 [532.496417] Dynamic subtest vcs0: SUCCESS (12.751s) [532.507348] Starting dynamic subtest: vcs1 [545.249423] Dynamic subtest vcs1: SUCCESS (12.752s) [545.259738] Starting dynamic subtest: vecs0 [558.006445] Dynamic subtest vecs0: SUCCESS (12.756s) [558.017180] Starting dynamic subtest: vecs1 [570.762382] Dynamic subtest vecs1: SUCCESS (12.755s) [570.772915] Starting dynamic subtest: ccs0 [583.518352] Dynamic subtest ccs0: SUCCESS (12.755s) [583.519247] Subtest enable-race: SUCCESS (89.313s) [583.641692] [083/130] (604s left) gem_exec_params (sol-reset-not-gen7) [583.764419] Starting subtest: sol-reset-not-gen7 [583.766908] Subtest sol-reset-not-gen7: SUCCESS (0.002s) [583.895872] [084/130] (603s left) kms_big_fb (4-tiled-32bpp-rotate-90) [584.110203] Starting subtest: 4-tiled-32bpp-rotate-90 [584.163822] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.053s) [584.333848] [085/130] (603s left) gem_render_copy (y-tiled) [584.478214] Starting subtest: y-tiled [584.480284] Subtest y-tiled: SKIP (0.000s) [584.670140] [086/130] (603s left) dmabuf_sync_file (export-before-signal) [584.779973] Starting subtest: export-before-signal [584.780921] Subtest export-before-signal: SUCCESS (0.001s) [584.835939] [087/130] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [585.052054] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [585.053866] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [585.190521] [088/130] (602s left) kms_frontbuffer_tracking (fbc-1p-rte) [585.421204] Starting subtest: fbc-1p-rte [588.898148] Subtest fbc-1p-rte: SUCCESS (3.478s) [589.116325] [089/130] (598s left) gem_exec_params (invalid-bsd1-flag-on-render) [589.255524] Starting subtest: invalid-bsd1-flag-on-render [589.256622] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s) [589.388600] [090/130] (598s left) kms_cursor_crc (cursor-offscreen-512x512) [589.791327] Starting subtest: cursor-offscreen-512x512 [589.793141] Subtest cursor-offscreen-512x512: SKIP (0.001s) [590.048239] [091/130] (598s left) kms_cursor_crc (cursor-sliding-32x10) [590.337301] Starting subtest: cursor-sliding-32x10 [590.384913] Subtest cursor-sliding-32x10: SKIP (0.045s) [590.747836] [092/130] (597s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [590.882759] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [590.989995] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s) [591.071893] [093/130] (597s left) gem_sync (basic-store-all) [591.201919] Starting subtest: basic-store-all [595.658618] Subtest basic-store-all: SUCCESS (4.456s) [595.839650] [094/130] (592s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [595.965329] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [595.967444] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [596.175142] [095/130] (592s left) kms_cursor_edge_walk (128x128-top-edge) [596.392181] Starting subtest: 128x128-top-edge [596.393102] Starting dynamic subtest: pipe-A-DP-4 [599.868828] Dynamic subtest pipe-A-DP-4: SUCCESS (3.475s) [599.889476] Starting dynamic subtest: pipe-D-DP-4 [603.201549] Dynamic subtest pipe-D-DP-4: SUCCESS (3.330s) [603.202605] Subtest 128x128-top-edge: SUCCESS (6.810s) [603.417781] [096/130] (584s left) kms_plane_scaling (planes-upscale-20x20) [603.649776] Starting subtest: planes-upscale-20x20 [603.650615] Starting dynamic subtest: pipe-A [603.761643] Dynamic subtest pipe-A: SUCCESS (0.112s) [603.802124] Starting dynamic subtest: pipe-B [604.001137] Dynamic subtest pipe-B: SUCCESS (0.237s) [604.016265] Starting dynamic subtest: pipe-C [604.191676] Dynamic subtest pipe-C: SUCCESS (0.189s) [604.210998] Starting dynamic subtest: pipe-D [604.398878] Dynamic subtest pipe-D: SUCCESS (0.206s) [604.400000] Subtest planes-upscale-20x20: SUCCESS (0.751s) [604.671293] [097/130] (583s left) gem_exec_fence (invalid-timeline-fence-array) [605.388896] Starting subtest: invalid-timeline-fence-array [605.390081] Subtest invalid-timeline-fence-array: SUCCESS (0.004s) [605.632778] [098/130] (582s left) gem_ctx_shared (q-in-order) [605.760596] Starting subtest: Q-in-order [605.761503] Starting dynamic subtest: rcs0 [606.009202] Dynamic subtest rcs0: SUCCESS (0.248s) [606.020649] Starting dynamic subtest: bcs0 [606.179374] Dynamic subtest bcs0: SUCCESS (0.169s) [606.191103] Starting dynamic subtest: vcs0 [606.361399] Dynamic subtest vcs0: SUCCESS (0.181s) [606.373067] Starting dynamic subtest: vcs1 [606.545763] Dynamic subtest vcs1: SUCCESS (0.183s) [606.556762] Starting dynamic subtest: vecs0 [606.729851] Dynamic subtest vecs0: SUCCESS (0.183s) [606.741199] Starting dynamic subtest: vecs1 [606.911223] Dynamic subtest vecs1: SUCCESS (0.180s) [606.922539] Starting dynamic subtest: ccs0 [607.090023] Dynamic subtest ccs0: SUCCESS (0.178s) [607.091002] Subtest Q-in-order: SUCCESS (1.330s) [607.391499] [099/130] (580s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [607.601028] Starting subtest: fbcpsr-rgb565-draw-render [607.602849] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s) [607.686598] [100/130] (580s left) kms_big_fb (x-tiled-16bpp-rotate-0) [607.923554] Starting subtest: x-tiled-16bpp-rotate-0 [609.507406] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.583s) [609.710779] [101/130] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [609.932128] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [609.934010] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [610.061396] [102/130] (578s left) kms_vblank (ts-continuation-modeset) [610.309792] Starting subtest: ts-continuation-modeset [610.312121] Starting dynamic subtest: pipe-A-DP-4 [610.801073] Dynamic subtest pipe-A-DP-4: SUCCESS (0.489s) [610.822695] Starting dynamic subtest: pipe-D-DP-4 [611.215251] Dynamic subtest pipe-D-DP-4: SUCCESS (0.408s) [611.216256] Subtest ts-continuation-modeset: SUCCESS (0.905s) [611.407660] [103/130] (577s left) gem_pxp (reject-modify-context-protection-off-3) [614.073707] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [614.174820] [104/130] (574s left) kms_pm_rpm (cursor-dpms) [616.004052] Starting subtest: cursor-dpms [618.723723] Subtest cursor-dpms: SUCCESS (2.720s) [619.026561] [105/130] (569s left) gem_unref_active_buffers [619.387988] [106/130] (569s left) kms_psr (psr2-primary-blt) [619.595695] Subtest psr2-primary-blt: SKIP (0.000s) [619.628312] [107/130] (568s left) gem_lmem_swapping (heavy-verify-multi-ccs) [623.069335] Starting subtest: heavy-verify-multi-ccs [623.072944] Starting dynamic subtest: lmem0 [631.401781] Dynamic subtest lmem0: SUCCESS (8.332s) [631.402720] Subtest heavy-verify-multi-ccs: SUCCESS (8.333s) [633.558939] [108/130] (555s left) kms_psr (fbc-psr-dpms) [635.140968] Subtest fbc-psr-dpms: SKIP (0.000s) [635.204731] [109/130] (553s left) gem_lmem_swapping (verify-ccs) [638.384759] Starting subtest: verify-ccs [638.386302] Starting dynamic subtest: lmem0 [674.902172] Dynamic subtest lmem0: SUCCESS (36.516s) [674.903135] Subtest verify-ccs: SUCCESS (36.517s) [677.710536] [110/130] (510s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [681.648954] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [681.649950] Starting dynamic subtest: pipe-A [684.514099] Dynamic subtest pipe-A: SUCCESS (2.865s) [684.523354] Starting dynamic subtest: pipe-B [687.440040] Dynamic subtest pipe-B: SUCCESS (2.925s) [687.449095] Starting dynamic subtest: pipe-C [687.732602] Dynamic subtest pipe-C: SUCCESS (0.291s) [687.760105] Starting dynamic subtest: pipe-D [688.039880] Dynamic subtest pipe-D: SUCCESS (0.304s) [688.041388] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (6.392s) [688.254746] [111/130] (500s left) dumb_buffer (map-valid) [688.327328] Starting subtest: map-valid [688.328259] Subtest map-valid: SUCCESS (0.000s) [688.452997] [112/130] (500s left) prime_self_import (basic-llseek-bad) [688.505705] Starting subtest: basic-llseek-bad [688.516352] Subtest basic-llseek-bad: SUCCESS (0.012s) [688.639074] [113/130] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [688.831025] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [688.833011] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [688.940786] [114/130] (499s left) gem_exec_balancer (bonded-sync) [689.049323] Starting subtest: bonded-sync [689.051445] Subtest bonded-sync: SKIP (0.000s) [689.374210] [115/130] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [689.535349] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [689.537059] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [689.680541] [116/130] (499s left) syncobj_timeline (host-signal-points) [689.771926] Starting subtest: host-signal-points [689.778100] Subtest host-signal-points: SUCCESS (0.006s) [689.840875] [117/130] (499s left) kms_properties (plane-properties-legacy) [690.015357] Starting subtest: plane-properties-legacy [690.016281] Starting dynamic subtest: pipe-A-DP-4 [690.542367] Dynamic subtest pipe-A-DP-4: SUCCESS (0.525s) [690.561193] Starting dynamic subtest: pipe-B-DP-4 [691.097350] Dynamic subtest pipe-B-DP-4: SUCCESS (0.553s) [691.109264] Starting dynamic subtest: pipe-C-DP-4 [691.633769] Dynamic subtest pipe-C-DP-4: SUCCESS (0.535s) [691.646251] Starting dynamic subtest: pipe-D-DP-4 [692.171574] Dynamic subtest pipe-D-DP-4: SUCCESS (0.536s) [692.172514] Subtest plane-properties-legacy: SUCCESS (2.157s) [692.383404] [118/130] (496s left) kms_color (ctm-0-50) [692.549978] Starting subtest: ctm-0-50 [692.550913] Starting dynamic subtest: pipe-A-DP-4 [694.335406] Dynamic subtest pipe-A-DP-4: SUCCESS (1.784s) [694.358002] Starting dynamic subtest: pipe-B-DP-4 [696.000063] Dynamic subtest pipe-B-DP-4: SUCCESS (1.664s) [696.009512] Starting dynamic subtest: pipe-C-DP-4 [697.684325] Dynamic subtest pipe-C-DP-4: SUCCESS (1.682s) [697.699061] Starting dynamic subtest: pipe-D-DP-4 [699.386391] Dynamic subtest pipe-D-DP-4: SUCCESS (1.702s) [699.387302] Subtest ctm-0-50: SUCCESS (6.838s) [699.581302] [119/130] (489s left) kms_plane_lowres (tiling-none) [699.763577] Starting subtest: tiling-none [699.765910] Starting dynamic subtest: pipe-A-DP-4 [724.403299] Dynamic subtest pipe-A-DP-4: SUCCESS (24.637s) [724.517960] Starting dynamic subtest: pipe-B-DP-4 [747.809925] Dynamic subtest pipe-B-DP-4: SUCCESS (23.299s) [747.911458] Starting dynamic subtest: pipe-C-DP-4 [769.768679] Dynamic subtest pipe-C-DP-4: SUCCESS (21.867s) [769.884376] Starting dynamic subtest: pipe-D-DP-4 [792.234315] Dynamic subtest pipe-D-DP-4: SUCCESS (22.358s) [792.340117] Subtest tiling-none: SUCCESS (92.574s) [792.551981] [120/130] (396s left) kms_async_flips (crc-atomic) [792.743346] Starting subtest: crc-atomic [792.967900] Starting dynamic subtest: pipe-A-DP-4 [795.793313] Dynamic subtest pipe-A-DP-4: FAIL (2.569s) [795.804142] Starting dynamic subtest: pipe-B-DP-4 [798.277352] Dynamic subtest pipe-B-DP-4: FAIL (2.293s) [798.288012] Starting dynamic subtest: pipe-C-DP-4 [800.735942] Dynamic subtest pipe-C-DP-4: FAIL (2.291s) [800.746780] Starting dynamic subtest: pipe-D-DP-4 [803.221803] Dynamic subtest pipe-D-DP-4: FAIL (2.299s) [803.222718] Subtest crc-atomic: FAIL (10.205s) [803.341090] [121/130] (385s left) gem_exec_fence (syncobj-timeline-invalid-wait) [804.007600] Starting subtest: syncobj-timeline-invalid-wait [804.010068] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s) [804.270850] [122/130] (384s left) gem_exec_params (rel-constants-invalid-ring) [804.350889] Starting subtest: rel-constants-invalid-ring [804.351813] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [804.499843] [123/130] (384s left) perf_pmu (cpu-hotplug) [804.581103] Starting subtest: cpu-hotplug [804.606954] Subtest cpu-hotplug: SKIP (0.025s) [804.755203] [124/130] (384s left) sw_sync (alloc_fence) [804.813856] Starting subtest: alloc_fence [804.814853] Subtest alloc_fence: SUCCESS (0.000s) [804.860718] [125/130] (384s left) gem_exec_whisper (basic-queues-priority) [804.947306] Starting subtest: basic-queues-priority [827.513000] Subtest basic-queues-priority: SUCCESS (22.564s) [827.732566] [126/130] (361s left) gem_exec_balancer (noheartbeat) [828.114440] Starting subtest: noheartbeat [828.116727] Subtest noheartbeat: SKIP (0.000s) [828.204487] [127/130] (361s left) kms_psr (fbc-psr2-cursor-render) [828.370912] Subtest fbc-psr2-cursor-render: SKIP (0.000s) [828.405703] [128/130] (360s left) gen7_exec_parse (basic-allocation) [828.482009] Subtest basic-allocation: SKIP (0.000s) [828.548362] [129/130] (360s left) kms_flip (flip-vs-absolute-wf_vblank) [828.732958] Starting subtest: flip-vs-absolute-wf_vblank [828.737103] Starting dynamic subtest: A-DP4 [836.900418] Dynamic subtest A-DP4: SUCCESS (8.163s) [836.913200] Starting dynamic subtest: B-DP4 [844.986345] Dynamic subtest B-DP4: SUCCESS (8.084s) [844.998301] Starting dynamic subtest: C-DP4 [853.061380] Dynamic subtest C-DP4: SUCCESS (8.074s) [853.073227] Starting dynamic subtest: D-DP4 [861.139583] Dynamic subtest D-DP4: SUCCESS (8.077s) [861.140521] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.408s) [861.423508] [130/130] (327s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [861.599991] Starting subtest: fbc-rgb565-draw-blt [864.981495] Subtest fbc-rgb565-draw-blt: SUCCESS (3.382s) [865.136864] Closing watchdogs Done.