[56.516197] Initializing watchdogs
[56.516338]   /dev/watchdog0
[56.533345] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.537870] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.540343] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.543829] [001/156] (960s left) gem_mmap_wc (close)
[56.624086] Subtest close: SKIP (0.000s)
[56.688701] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[56.806189] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[56.810729] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.912542] [003/156] (960s left) kms_content_protection (type1)
[57.057134] Starting subtest: type1
[57.061817] Subtest type1: SKIP (0.000s)
[57.173357] [004/156] (959s left) gem_exec_schedule (thriceslice)
[57.240852] Starting subtest: thriceslice
[57.243239] Starting dynamic subtest: rcs0
[57.263731] Dynamic subtest rcs0: SUCCESS (0.030s)
[57.274454] Starting dynamic subtest: bcs0
[57.293795] Dynamic subtest bcs0: SUCCESS (0.029s)
[57.303091] Starting dynamic subtest: vcs0
[57.347917] Dynamic subtest vcs0: SUCCESS (0.052s)
[57.358695] Starting dynamic subtest: vcs1
[57.404069] Dynamic subtest vcs1: SUCCESS (0.053s)
[57.416491] Starting dynamic subtest: vecs0
[57.436501] Dynamic subtest vecs0: SUCCESS (0.032s)
[57.445171] Starting dynamic subtest: ccs0
[57.491852] Dynamic subtest ccs0: SUCCESS (0.053s)
[57.495123] Subtest thriceslice: SUCCESS (0.252s)
[59.339314] [005/156] (957s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[59.458394] Starting subtest: 2x-long-cursor-vs-flip-legacy
[59.463184] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[59.602690] [006/156] (957s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[59.700425] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[59.704574] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[59.797182] [007/156] (957s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[59.888583] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[59.891067] Starting dynamic subtest: pipe-A-default-mode
[62.690816] Dynamic subtest pipe-A-default-mode: SUCCESS (2.756s)
[62.693219] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.757s)
[63.532976] [008/156] (953s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[63.643355] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[63.648071] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[63.744778] [009/156] (953s left) prime_mmap (test_correct_cpu_write)
[63.807087] Starting subtest: test_correct_cpu_write
[63.809301] Starting dynamic subtest: test_correct_cpu_write-smem
[63.811179] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[63.813060] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[63.911267] [010/156] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[64.003854] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[64.008374] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[65.205638] [011/156] (952s left) prime_busy (hang-wait)
[65.270043] Starting subtest: hang-wait
[65.272451] Starting dynamic subtest: rcs0
[91.853351] Dynamic subtest rcs0: SUCCESS (26.502s)
[91.865230] Starting dynamic subtest: bcs0
[99.002763] Dynamic subtest bcs0: SUCCESS (7.141s)
[99.011808] Starting dynamic subtest: vcs0
[105.904338] Dynamic subtest vcs0: SUCCESS (6.899s)
[105.912103] Starting dynamic subtest: vcs1
[113.013328] Dynamic subtest vcs1: SUCCESS (7.096s)
[113.022504] Starting dynamic subtest: vecs0
[119.913572] Dynamic subtest vecs0: SUCCESS (6.905s)
[119.921695] Starting dynamic subtest: ccs0
[133.819250] Dynamic subtest ccs0: SUCCESS (13.897s)
[133.821529] Subtest hang-wait: SUCCESS (68.446s)
[133.941983] [012/156] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[134.049200] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[141.273079] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.228s)
[141.397760] [013/156] (876s left) kms_addfb_basic (invalid-get-prop-any)
[141.458354] Starting subtest: invalid-get-prop-any
[141.460284] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[141.591834] [014/156] (875s left) kms_plane_scaling (intel-max-src-size)
[141.687747] Starting subtest: intel-max-src-size
[141.694551] Subtest intel-max-src-size: SKIP (0.000s)
[141.787888] [015/156] (875s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[141.847378] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[141.955385] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[142.037832] [016/156] (875s left) kms_big_fb (linear-8bpp-rotate-180)
[142.143134] Starting subtest: linear-8bpp-rotate-180
[143.402577] Subtest linear-8bpp-rotate-180: SUCCESS (1.260s)
[143.536320] [017/156] (874s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[143.634528] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[143.636541] Starting dynamic subtest: pipe-A
[144.693597] Dynamic subtest pipe-A: SUCCESS (1.061s)
[144.704433] Starting dynamic subtest: pipe-B
[146.841419] Dynamic subtest pipe-B: SUCCESS (2.146s)
[146.851454] Starting dynamic subtest: pipe-C
[148.032547] Dynamic subtest pipe-C: SUCCESS (1.190s)
[148.042663] Starting dynamic subtest: pipe-D
[149.259906] Dynamic subtest pipe-D: SUCCESS (1.226s)
[149.262886] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.626s)
[150.474889] [018/156] (867s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[150.546813] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[150.619871] [019/156] (867s left) syncobj_wait (wait-for-submit-complex)
[150.671716] Starting subtest: wait-for-submit-complex
[150.732200] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[150.805796] [020/156] (866s left) gem_fence_thrash (bo-write-verify-threaded-none)
[150.839487] Starting subtest: bo-write-verify-threaded-none
[150.857181] Subtest bo-write-verify-threaded-none: SKIP (0.018s)
[150.912299] [021/156] (866s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[151.000706] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[151.004812] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[151.105336] [022/156] (866s left) kms_pm_rpm (legacy-planes)
[152.626915] Starting subtest: legacy-planes
[152.629078] Starting dynamic subtest: plane-65
[161.054287] Dynamic subtest plane-65: SUCCESS (8.426s)
[161.064649] Starting dynamic subtest: plane-95
[169.376774] Dynamic subtest plane-95: SUCCESS (8.317s)
[169.387680] Starting dynamic subtest: plane-125
[177.679067] Dynamic subtest plane-125: SUCCESS (8.297s)
[177.690199] Starting dynamic subtest: plane-135
[186.073700] Dynamic subtest plane-135: SUCCESS (8.391s)
[186.076290] Subtest legacy-planes: SUCCESS (33.437s)
[186.470743] [023/156] (831s left) kms_cursor_crc (cursor-alpha-transparent)
[186.563293] Starting subtest: cursor-alpha-transparent
[186.565240] Starting dynamic subtest: pipe-A-eDP-1
[187.197017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[187.205934] Starting dynamic subtest: pipe-D-eDP-1
[188.527942] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[188.530312] Subtest cursor-alpha-transparent: SUCCESS (1.963s)
[189.421280] [024/156] (828s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[189.521566] Starting subtest: fbchdr-rgb101010-draw-pwrite
[189.525950] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[189.638127] [025/156] (828s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[189.733730] Starting subtest: yf-tiled-addfb-size-offset-overflow
[189.738235] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[189.827354] [026/156] (828s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[189.883469] Starting subtest: invalid-multi-wait-unsubmitted
[189.885765] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[189.994588] [027/156] (828s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[190.093286] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[196.970459] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.879s)
[197.139445] [028/156] (820s left) kms_psr (fbc-psr-primary-page-flip)
[197.231503] Starting subtest: fbc-psr-primary-page-flip
[197.233804] Starting dynamic subtest: eDP-1
[197.238361] Dynamic subtest eDP-1: SKIP (0.000s)
[197.242879] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[197.305069] [029/156] (820s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[197.426806] Starting subtest: fbc-pr-cursor-plane-update-sf
[197.431034] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[197.502613] [030/156] (820s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[197.606749] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[197.611188] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[197.703764] [031/156] (820s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[197.792850] Starting subtest: async-flip-with-page-flip-events-linear
[198.173880] Starting dynamic subtest: pipe-A-eDP-1
[200.978625] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.749s)
[201.301587] Starting dynamic subtest: pipe-B-eDP-1
[204.107262] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[204.429219] Starting dynamic subtest: pipe-C-eDP-1
[207.244950] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[207.558619] Starting dynamic subtest: pipe-D-eDP-1
[210.366995] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[210.369054] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.519s)
[211.504010] [032/156] (806s left) gen9_exec_parse (batch-zero-length)
[211.558697] Subtest batch-zero-length: SKIP (0.000s)
[211.624377] [033/156] (806s left) sysfs_heartbeat_interval (nopreempt)
[211.680186] Starting subtest: nopreempt
[211.682429] Starting dynamic subtest: vecs0
[220.321234] Dynamic subtest vecs0: SUCCESS (8.638s)
[220.334273] Starting dynamic subtest: ccs0
[224.316408] Dynamic subtest ccs0: SUCCESS (3.991s)
[224.325872] Starting dynamic subtest: vcs0
[233.307145] Dynamic subtest vcs0: SUCCESS (8.985s)
[233.317960] Starting dynamic subtest: bcs0
[237.236086] Dynamic subtest bcs0: SUCCESS (3.928s)
[237.245847] Starting dynamic subtest: rcs0
[241.310042] Dynamic subtest rcs0: SUCCESS (4.071s)
[241.320040] Starting dynamic subtest: vcs1
[251.293776] Dynamic subtest vcs1: SUCCESS (9.977s)
[251.296641] Subtest nopreempt: SUCCESS (39.601s)
[251.368357] [034/156] (766s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[251.490319] Starting subtest: 2x-long-flip-vs-cursor-legacy
[251.494710] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[251.647245] [035/156] (766s left) gem_exec_capture (userptr)
[251.706507] Starting subtest: userptr
[252.534547] Subtest userptr: SUCCESS (0.828s)
[252.659320] [036/156] (765s left) gem_exec_schedule (independent)
[252.729098] Starting subtest: independent
[252.731040] Starting dynamic subtest: rcs0
[254.308345] Dynamic subtest rcs0: SUCCESS (1.586s)
[254.320773] Starting dynamic subtest: vcs0
[256.364404] Dynamic subtest vcs0: SUCCESS (2.054s)
[256.376748] Starting dynamic subtest: vcs1
[258.344627] Dynamic subtest vcs1: SUCCESS (1.978s)
[258.356199] Starting dynamic subtest: vecs0
[260.329447] Dynamic subtest vecs0: SUCCESS (1.982s)
[260.343242] Starting dynamic subtest: ccs0
[262.303865] Dynamic subtest ccs0: SUCCESS (1.971s)
[262.306869] Subtest independent: SUCCESS (9.581s)
[262.604334] [037/156] (755s left) perf_pmu (busy-idle-no-semaphores)
[262.645519] Starting subtest: busy-idle-no-semaphores
[262.647774] Starting dynamic subtest: rcs0
[263.301493] Dynamic subtest rcs0: SUCCESS (0.653s)
[263.312664] Starting dynamic subtest: bcs0
[263.955604] Dynamic subtest bcs0: SUCCESS (0.652s)
[263.966799] Starting dynamic subtest: vcs0
[264.611287] Dynamic subtest vcs0: SUCCESS (0.652s)
[264.621489] Starting dynamic subtest: vcs1
[265.925272] Dynamic subtest vcs1: SUCCESS (1.313s)
[265.937298] Starting dynamic subtest: vecs0
[267.909913] Dynamic subtest vecs0: SUCCESS (1.982s)
[267.921720] Starting dynamic subtest: ccs0
[269.961700] Dynamic subtest ccs0: SUCCESS (2.050s)
[269.964798] Subtest busy-idle-no-semaphores: SUCCESS (7.314s)
[270.094208] [038/156] (748s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[270.197702] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[270.201857] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[270.286477] [039/156] (748s left) kms_cursor_crc (cursor-tearing-position-change)
[270.400552] Starting subtest: cursor-tearing-position-change
[270.402839] Starting dynamic subtest: pipe-A-eDP-1
[270.958879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[270.968079] Starting dynamic subtest: pipe-D-eDP-1
[272.239360] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s)
[272.241297] Subtest cursor-tearing-position-change: SUCCESS (1.836s)
[273.068345] [040/156] (745s left) gem_exec_reloc (basic-gtt-cpu-active)
[273.124658] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[273.198332] [041/156] (745s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[273.260664] Starting subtest: wait-all-for-submit-delayed-submit
[273.364920] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[273.453278] [042/156] (745s left) perf (gen8-unprivileged-single-ctx-counters)
[273.574059] Starting subtest: gen8-unprivileged-single-ctx-counters
[273.577935] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[273.617679] [043/156] (745s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[273.730616] Starting subtest: basic-flip-after-cursor-legacy
[274.654715] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.924s)
[275.503368] [044/156] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[275.602477] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[275.606501] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[275.695306] [045/156] (743s left) gem_ctx_persistence (userptr)
[275.750533] Starting subtest: userptr
[275.939678] Subtest userptr: SUCCESS (0.189s)
[276.022021] [046/156] (742s left) gem_pxp (hw-rejects-pxp-context)
[276.138095] Starting subtest: hw-rejects-pxp-context
[276.142741] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[276.242024] [047/156] (742s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[276.327197] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[276.329517] Starting dynamic subtest: pipe-A-eDP-1
[276.350208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[276.360920] Starting dynamic subtest: pipe-B-eDP-1
[276.380369] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[276.389641] Starting dynamic subtest: pipe-C-eDP-1
[276.409088] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[276.417496] Starting dynamic subtest: pipe-D-eDP-1
[276.433537] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[276.435198] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[278.653955] [048/156] (740s left) gem_pwrite (basic-random)
[278.705807] Subtest basic-random: SKIP (0.000s)
[278.776598] [049/156] (740s left) gem_exec_reloc (basic-write-wc-active)
[278.838477] Subtest basic-write-wc-active: SKIP (0.000s)
[278.893142] [050/156] (740s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[278.989253] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[278.998785] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.012s)
[279.078633] [051/156] (739s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[279.179896] Starting subtest: fbchdr-farfromfence-mmap-gtt
[279.184139] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[279.282983] [052/156] (739s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[279.343492] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[279.406846] [053/156] (739s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[279.494738] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[279.496973] Starting dynamic subtest: pipe-A-eDP-1
[279.524743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.534554] Starting dynamic subtest: pipe-B-eDP-1
[279.555106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.563937] Starting dynamic subtest: pipe-C-eDP-1
[279.581358] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.589670] Starting dynamic subtest: pipe-D-eDP-1
[279.607939] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.611496] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[281.817815] [054/156] (737s left) kms_scaling_modes (scaling-mode-full)
[281.916067] Starting subtest: scaling-mode-full
[281.918250] Starting dynamic subtest: pipe-A-eDP-1
[282.023396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[282.033240] Starting dynamic subtest: pipe-B-eDP-1
[283.256708] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[283.267845] Starting dynamic subtest: pipe-C-eDP-1
[284.474724] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[284.484733] Starting dynamic subtest: pipe-D-eDP-1
[285.613563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[285.615865] Subtest scaling-mode-full: SUCCESS (3.699s)
[286.764658] [055/156] (732s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[286.867065] Starting subtest: y-tiled-16bpp-rotate-0
[286.871228] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[286.983248] [056/156] (732s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[287.078741] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[287.082815] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[287.184298] [057/156] (732s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[287.270895] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[287.272883] Starting dynamic subtest: pipe-A-eDP-1
[287.292736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[287.302183] Starting dynamic subtest: pipe-B-eDP-1
[287.321586] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[287.331073] Starting dynamic subtest: pipe-C-eDP-1
[287.349993] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[287.359528] Starting dynamic subtest: pipe-D-eDP-1
[287.380860] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[287.383283] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[289.649353] [058/156] (729s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[289.756261] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[289.760446] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[289.873417] [059/156] (729s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[289.970174] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[289.974179] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[290.065314] [060/156] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[290.162793] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[290.167200] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[290.251570] [061/156] (729s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[290.347817] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[290.351999] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[290.431903] [062/156] (729s left) syncobj_wait (wait-for-submit-snapshot)
[290.487314] Starting subtest: wait-for-submit-snapshot
[290.567184] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[290.642159] [063/156] (728s left) kms_color (ctm-0-75)
[290.730837] Starting subtest: ctm-0-75
[290.732487] Starting dynamic subtest: pipe-A-eDP-1
[295.672028] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.940s)
[295.683906] Starting dynamic subtest: pipe-B-eDP-1
[301.390766] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.715s)
[301.400276] Starting dynamic subtest: pipe-C-eDP-1
[306.777303] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.385s)
[306.787606] Starting dynamic subtest: pipe-D-eDP-1
[312.142424] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.362s)
[312.144812] Subtest ctm-0-75: SUCCESS (21.406s)
[312.968380] [064/156] (706s left) kms_vblank (wait-idle)
[313.053334] Starting subtest: wait-idle
[313.055702] Starting dynamic subtest: pipe-A-eDP-1
[314.808041] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[314.823161] Starting dynamic subtest: pipe-D-eDP-1
[317.305707] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[317.308169] Subtest wait-idle: SUCCESS (4.251s)
[318.141267] [065/156] (701s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[318.529743] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[319.353500] [066/156] (700s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[319.468573] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[319.472630] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[319.546816] [067/156] (700s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[319.645447] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[319.649621] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[319.761469] [068/156] (699s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[319.829425] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[319.833734] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[320.024412] [069/156] (699s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw)
[320.114187] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw
[320.118307] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[320.211425] [070/156] (699s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[320.308069] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[320.312342] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.413494] [071/156] (699s left) kms_universal_plane (universal-plane-sanity)
[320.503183] Starting subtest: universal-plane-sanity
[320.505491] Starting dynamic subtest: pipe-A-eDP-1
[321.087617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[321.097207] Starting dynamic subtest: pipe-B-eDP-1
[322.288808] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[322.299820] Starting dynamic subtest: pipe-C-eDP-1
[323.511319] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.220s)
[323.523858] Starting dynamic subtest: pipe-D-eDP-1
[324.757655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[324.760042] Subtest universal-plane-sanity: SUCCESS (4.255s)
[325.622542] [072/156] (694s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[325.728266] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[325.732438] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[325.813763] [073/156] (694s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[325.907744] Starting subtest: x-tiled-8bpp-rotate-90
[325.929811] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[326.077622] [074/156] (693s left) gem_flink_basic (bad-open)
[326.126569] Starting subtest: bad-open
[326.128869] Subtest bad-open: SUCCESS (0.000s)
[326.217766] [075/156] (693s left) gem_softpin (allocator-nopin-reserve)
[326.271593] Starting subtest: allocator-nopin-reserve
[326.364203] Subtest allocator-nopin-reserve: SUCCESS (0.092s)
[326.466876] [076/156] (693s left) api_intel_bb (add-remove-objects)
[326.531061] Starting subtest: add-remove-objects
[326.537466] Subtest add-remove-objects: SUCCESS (0.008s)
[326.655453] [077/156] (693s left) gem_readwrite (new-obj)
[326.700751] Subtest new-obj: SKIP (0.000s)
[326.763713] [078/156] (693s left) gem_exec_reloc (basic-concurrent0)
[326.822870] Subtest basic-concurrent0: SKIP (0.000s)
[326.907642] [079/156] (693s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[327.007866] Starting subtest: psr-shrfb-scaledprimary
[332.777692] Subtest psr-shrfb-scaledprimary: SUCCESS (5.773s)
[332.901039] [080/156] (687s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[332.963811] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[333.067225] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[333.141731] [081/156] (687s left) api_intel_bb (simple-bb)
[333.188496] Starting subtest: simple-bb
[333.194074] Subtest simple-bb: SUCCESS (0.004s)
[333.302665] [082/156] (686s left) kms_flip (flip-vs-panning)
[333.408359] Starting subtest: flip-vs-panning
[333.411664] Starting dynamic subtest: A-eDP1
[342.177925] Dynamic subtest A-eDP1: SUCCESS (8.770s)
[342.189106] Starting dynamic subtest: B-eDP1
[350.901442] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[350.911351] Starting dynamic subtest: C-eDP1
[359.621460] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[359.633066] Starting dynamic subtest: D-eDP1
[368.346232] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[368.351311] Subtest flip-vs-panning: SUCCESS (34.937s)
[369.614732] [083/156] (650s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[369.713190] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[369.800506] [084/156] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[369.888554] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[369.892814] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[370.010613] [085/156] (650s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[370.062378] Starting subtest: invalid-signal-one-illegal-handle
[370.064566] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[370.156940] [086/156] (650s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[370.240205] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[370.244645] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[370.311885] [087/156] (650s left) dmabuf_sync_file (import-multiple-read-only)
[370.408917] Starting subtest: import-multiple-read-only
[370.411118] Subtest import-multiple-read-only: SUCCESS (0.002s)
[370.479637] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[370.483653] [088/156] (650s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render)
[370.586891] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render
[370.590619] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[370.677130] [089/156] (649s left) gem_userptr_blits (probe)
[370.746521] Starting subtest: probe
[370.829715] Subtest probe: SUCCESS (0.082s)
[370.945470] [090/156] (649s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[371.046261] Starting subtest: hdr-farfromfence-mmap-gtt
[371.049790] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[371.164057] [091/156] (649s left) kms_lease (lease-revoke)
[371.264907] Starting subtest: lease-revoke
[371.266822] Starting dynamic subtest: pipe-A-eDP-1
[371.296589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[371.308736] Starting dynamic subtest: pipe-B-eDP-1
[371.325088] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[371.339662] Starting dynamic subtest: pipe-C-eDP-1
[371.353738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[371.365495] Starting dynamic subtest: pipe-D-eDP-1
[371.384756] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[371.386867] Subtest lease-revoke: SUCCESS (0.123s)
[371.496638] [092/156] (649s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[371.550486] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[371.660047] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[371.738701] [093/156] (649s left) gem_exec_whisper (basic-contexts-forked-all)
[371.798799] Starting subtest: basic-contexts-forked-all
[394.374207] Subtest basic-contexts-forked-all: SUCCESS (22.515s)
[394.507038] [094/156] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[394.605849] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[402.479074] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.877s)
[402.596462] [095/156] (618s left) prime_self_import (basic-with_fd_dup)
[402.630273] Starting subtest: basic-with_fd_dup
[402.646676] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[402.763356] [096/156] (618s left) gem_exec_params (sol-reset-invalid)
[402.812441] Starting subtest: sol-reset-invalid
[402.817320] Subtest sol-reset-invalid: SUCCESS (0.004s)
[404.365231] [097/156] (616s left) kms_joiner (basic-max-non-joiner)
[404.465236] Starting subtest: basic-max-non-joiner
[404.469562] Subtest basic-max-non-joiner: SKIP (0.000s)
[404.534399] [098/156] (616s left) kms_cdclk (mode-transition)
[404.621831] Starting subtest: mode-transition
[404.624071] Starting dynamic subtest: pipe-A-eDP-1
[404.911802] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[404.922026] Starting dynamic subtest: pipe-B-eDP-1
[404.926562] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[404.939669] Starting dynamic subtest: pipe-C-eDP-1
[404.944314] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[404.953381] Starting dynamic subtest: pipe-D-eDP-1
[404.957490] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[404.961677] Subtest mode-transition: SKIP (0.296s)
[405.735703] [099/156] (615s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[405.830280] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[405.834441] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[405.921221] [100/156] (615s left) kms_prop_blob (basic)
[405.978223] Starting subtest: basic
[405.980378] Subtest basic: SUCCESS (0.000s)
[406.087360] [101/156] (615s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[406.182719] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[406.187199] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[406.285033] [102/156] (614s left) kms_psr (fbc-psr2-no-drrs)
[406.387350] Starting subtest: fbc-psr2-no-drrs
[406.389624] Starting dynamic subtest: eDP-1
[406.393726] Dynamic subtest eDP-1: SKIP (0.000s)
[406.397869] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[406.465118] [103/156] (614s left) gem_lmem_swapping (heavy-verify-random-ccs)
[406.510249] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[406.561901] [104/156] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[406.661304] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[406.664800] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[406.759563] [105/156] (614s left) i915_pm_rpm (gem-execbuf)
[408.483370] Starting subtest: gem-execbuf
[408.486571] Starting dynamic subtest: smem0
[410.044102] Dynamic subtest smem0: SUCCESS (1.560s)
[410.046510] Subtest gem-execbuf: SUCCESS (1.563s)
[410.141429] [106/156] (611s left) kms_fb_coherency (memset-crc)
[410.237058] Starting subtest: memset-crc
[410.238992] Starting dynamic subtest: mmap-offset-wc
[410.626904] Dynamic subtest mmap-offset-wc: SUCCESS (0.389s)
[410.925574] Starting dynamic subtest: mmap-offset-uc
[416.938317] Dynamic subtest mmap-offset-uc: SUCCESS (6.018s)
[417.227851] Subtest memset-crc: SUCCESS (6.990s)
[418.061302] [107/156] (603s left) kms_getfb (getfb-reject-nv12)
[418.155096] Starting subtest: getfb-reject-nv12
[418.157264] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[418.267302] [108/156] (603s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[418.375781] Starting subtest: fbcpsr-modesetfrombusy
[424.630234] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.258s)
[424.770592] [109/156] (596s left) gem_exec_endless (dispatch)
[424.834630] Starting subtest: dispatch
[424.836319] Starting dynamic subtest: rcs0
[424.840299] Dynamic subtest rcs0: SUCCESS (0.005s)
[424.852623] Starting dynamic subtest: bcs0
[424.856168] Dynamic subtest bcs0: SUCCESS (0.004s)
[424.867025] Starting dynamic subtest: vcs0
[424.870785] Dynamic subtest vcs0: SUCCESS (0.004s)
[424.879760] Starting dynamic subtest: vcs1
[424.883128] Dynamic subtest vcs1: SUCCESS (0.005s)
[424.891908] Starting dynamic subtest: vecs0
[424.895375] Dynamic subtest vecs0: SUCCESS (0.004s)
[424.904189] Starting dynamic subtest: ccs0
[424.907460] Dynamic subtest ccs0: SUCCESS (0.004s)
[424.909046] Subtest dispatch: SUCCESS (0.032s)
[426.376582] [110/156] (595s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[426.475682] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[426.479896] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[426.582197] [111/156] (594s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[426.681083] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[426.685114] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[426.771707] [112/156] (594s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[426.820334] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[426.822500] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[426.915809] [113/156] (594s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[427.017844] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[427.022223] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[427.111586] [114/156] (594s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[427.200101] Starting subtest: plane-all-modeset-transition-internal-panels
[427.201976] Starting dynamic subtest: pipe-A-eDP-1
[428.560218] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.359s)
[428.849069] Starting dynamic subtest: pipe-B-eDP-1
[429.892560] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[430.163685] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.964s)
[431.007865] [115/156] (590s left) gem_busy (semaphore)
[431.190577] Subtest semaphore: SKIP (0.000s)
[431.415140] [116/156] (590s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[431.713145] Starting subtest: cursor-rapid-movement-512x170
[431.717614] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[431.856163] [117/156] (589s left) gem_ctx_param (invalid-set-no-zeromap)
[431.911907] Starting subtest: invalid-set-no-zeromap
[431.914390] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[431.987523] [118/156] (589s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[432.090855] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[432.095276] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[432.201698] [119/156] (589s left) kms_psr (psr-primary-blt)
[432.297278] Starting subtest: psr-primary-blt
[432.299428] Starting dynamic subtest: eDP-1
[434.014036] Dynamic subtest eDP-1: SUCCESS (1.716s)
[434.016486] Subtest psr-primary-blt: SUCCESS (1.717s)
[434.874843] [120/156] (587s left) gem_partial_pwrite_pread (write-uncached)
[434.928829] Subtest write-uncached: SKIP (0.000s)
[435.000367] [121/156] (586s left) kms_flip (2x-flip-vs-panning)
[435.102372] Starting subtest: 2x-flip-vs-panning
[435.112263] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[435.192297] [122/156] (586s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[435.235385] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[435.305453] [123/156] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[435.401333] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[435.405661] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[435.501246] [124/156] (586s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[435.601949] Starting subtest: psr-rgb101010-draw-pwrite
[443.316405] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.718s)
[443.444425] [125/156] (578s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[443.539608] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[443.543607] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[443.621705] [126/156] (578s left) gem_exec_balancer (parallel)
[443.885407] Starting subtest: parallel
[444.877105] Subtest parallel: SUCCESS (0.991s)
[445.331620] [127/156] (576s left) kms_plane_alpha_blend (coverage-7efc)
[445.419066] Starting subtest: coverage-7efc
[445.719721] Starting dynamic subtest: pipe-A-eDP-1
[446.308723] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[446.336870] Starting dynamic subtest: pipe-D-eDP-1
[447.678405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[447.680884] Subtest coverage-7efc: SUCCESS (2.261s)
[448.515125] [128/156] (573s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[448.610108] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[448.614554] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[448.693181] [129/156] (573s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[448.804465] Starting subtest: cursorA-vs-flipA-atomic
[459.928208] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.118s)
[460.765430] [130/156] (561s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[460.867284] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[460.877337] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.012s)
[460.962337] [131/156] (561s left) kms_addfb_basic (unused-offsets)
[461.023204] Starting subtest: unused-offsets
[461.025410] Subtest unused-offsets: SUCCESS (0.000s)
[461.167439] [132/156] (561s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[461.264319] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[461.268445] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[461.333543] [133/156] (561s left) gem_exec_create (basic)
[461.398788] Starting subtest: basic
[461.401253] Starting dynamic subtest: smem
[465.313071] Dynamic subtest smem: SUCCESS (3.908s)
[465.315606] Subtest basic: SUCCESS (3.910s)
[465.494694] [134/156] (556s left) kms_chamelium_frames (dp-crc-single)
[465.894175] Subtest dp-crc-single: SKIP (0.000s)
[466.760776] [135/156] (555s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[466.864881] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[467.899180] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.035s)
[468.001268] [136/156] (554s left) kms_async_flips (test-time-stamp-atomic)
[468.100700] Starting subtest: test-time-stamp-atomic
[468.474516] Starting dynamic subtest: pipe-A-eDP-1
[469.291661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[469.670121] Starting dynamic subtest: pipe-B-eDP-1
[470.517553] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.853s)
[470.885775] Starting dynamic subtest: pipe-C-eDP-1
[471.646627] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[472.016071] Starting dynamic subtest: pipe-D-eDP-1
[472.768059] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.760s)
[472.770477] Subtest test-time-stamp-atomic: SUCCESS (4.667s)
[473.947149] [137/156] (548s left) gem_exec_params (invalid-ring)
[474.009728] Starting subtest: invalid-ring
[474.012084] Subtest invalid-ring: SUCCESS (0.000s)
[474.110198] [138/156] (548s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[474.228579] Starting subtest: short-busy-flip-before-cursor-toggle
[474.233087] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[474.390069] [139/156] (548s left) kms_psr (psr2-cursor-mmap-cpu)
[474.488339] Starting subtest: psr2-cursor-mmap-cpu
[474.490678] Starting dynamic subtest: eDP-1
[476.208872] Dynamic subtest eDP-1: SUCCESS (1.717s)
[476.210754] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.718s)
[477.103878] [140/156] (545s left) i915_drm_fdinfo (virtual-busy-idle-all)
[477.144735] Starting subtest: virtual-busy-idle-all
[477.148751] Subtest virtual-busy-idle-all: SKIP (0.000s)
[477.219400] [141/156] (545s left) kms_fence_pin_leak
[477.388914] [142/156] (545s left) perf_pmu (event-wait)
[477.427426] Starting subtest: event-wait
[477.429844] Starting dynamic subtest: rcs0
[477.434368] Dynamic subtest rcs0: SKIP (0.000s)
[477.438879] Subtest event-wait: SKIP (0.001s)
[477.543442] [143/156] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[477.637869] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[484.665274] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.031s)
[484.779694] [144/156] (538s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[484.882234] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[484.884589] Starting dynamic subtest: pipe-A-eDP-1
[490.822740] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.940s)
[490.833221] Starting dynamic subtest: pipe-B-eDP-1
[497.467405] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[497.469829] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.585s)
[498.349320] [145/156] (524s left) gem_mmap_offset (partial-remap)
[498.409752] Starting subtest: partial-remap
[498.412135] Starting dynamic subtest: smem0
[498.421113] Dynamic subtest smem0: SUCCESS (0.004s)
[498.423340] Subtest partial-remap: SUCCESS (0.004s)
[498.531931] [146/156] (524s left) i915_pm_sseu (full-enable)
[498.597485] Subtest full-enable: SKIP (0.000s)
[498.714113] [147/156] (524s left) gem_userptr_blits (readonly-unsync)
[498.769663] Subtest readonly-unsync: SKIP (0.000s)
[498.897057] [148/156] (524s left) gem_ctx_shared (q-smoketest-all)
[498.960444] Starting subtest: Q-smoketest-all
[531.354272] Subtest Q-smoketest-all: SUCCESS (32.336s)
[532.412931] [149/156] (490s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[532.522781] Starting subtest: pr-cursor-plane-move-continuous-sf
[532.527135] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[532.597343] [150/156] (490s left) i915_drm_fdinfo (isolation)
[532.639514] Starting subtest: isolation
[532.641652] Starting dynamic subtest: rcs0
[532.670944] Dynamic subtest rcs0: SKIP (0.032s)
[532.683755] Starting dynamic subtest: bcs0
[532.687859] Dynamic subtest bcs0: SKIP (0.000s)
[532.697959] Starting dynamic subtest: vcs0
[532.702500] Dynamic subtest vcs0: SKIP (0.000s)
[532.711891] Starting dynamic subtest: vcs1
[532.715995] Dynamic subtest vcs1: SKIP (0.000s)
[532.725510] Starting dynamic subtest: vecs0
[532.729626] Dynamic subtest vecs0: SKIP (0.000s)
[532.739450] Starting dynamic subtest: ccs0
[532.743588] Dynamic subtest ccs0: SKIP (0.000s)
[532.747642] Subtest isolation: SKIP (0.037s)
[532.786190] [151/156] (490s left) gem_exec_fence (parallel)
[532.961637] Starting subtest: parallel
[532.963846] Starting dynamic subtest: rcs0
[535.117198] Dynamic subtest rcs0: SUCCESS (2.155s)
[535.129247] Starting dynamic subtest: bcs0
[537.270915] Dynamic subtest bcs0: SUCCESS (2.152s)
[537.282126] Starting dynamic subtest: vcs0
[539.425885] Dynamic subtest vcs0: SUCCESS (2.154s)
[539.437789] Starting dynamic subtest: vcs1
[541.580976] Dynamic subtest vcs1: SUCCESS (2.154s)
[541.591547] Starting dynamic subtest: vecs0
[543.732916] Dynamic subtest vecs0: SUCCESS (2.151s)
[543.745915] Starting dynamic subtest: ccs0
[545.885929] Dynamic subtest ccs0: SUCCESS (2.152s)
[545.887975] Subtest parallel: SUCCESS (12.922s)
[546.509705] [152/156] (476s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[546.557854] Starting subtest: single-wait-all-for-submit-available-submitted
[546.560070] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[546.647225] [153/156] (476s left) gem_ctx_exec (basic-invalid-context)
[546.700490] Starting subtest: basic-invalid-context
[546.710982] Subtest basic-invalid-context: SUCCESS (0.012s)
[546.834772] [154/156] (476s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[546.941177] Starting subtest: yf-tiled-16bpp-rotate-0
[546.945345] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[547.043031] [155/156] (476s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[547.133652] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[547.137791] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[547.235374] [156/156] (476s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[547.345912] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[547.350557] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[547.455170] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_wc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_mmap
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: prime_busy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: gem_fence_thrash
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: sysfs_heartbeat_interval
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_exec_capture
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_pwrite
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_fenced_exec_thrash
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_scaling_modes
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_chamelium_hpd
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_universal_plane
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_flink_basic
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: gem_readwrite
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: dmabuf_sync_file
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_whisper
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: prime_self_import
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_joiner
results: parsing output: 97/ for test: kms_cdclk
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: i915_pm_rpm
results: parsing output: 105/ for test: kms_fb_coherency
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_endless
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: gem_busy
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: gem_ctx_param
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_partial_pwrite_pread
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_plane_alpha_blend
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: gem_exec_create
results: parsing output: 133/ for test: kms_chamelium_frames
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_async_flips
results: parsing output: 136/ for test: gem_exec_params
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: i915_drm_fdinfo
results: parsing output: 140/ for test: kms_fence_pin_leak
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_psr2_sf
results: parsing output: 144/ for test: gem_mmap_offset
results: parsing output: 145/ for test: i915_pm_sseu
results: parsing output: 146/ for test: gem_userptr_blits
results: parsing output: 147/ for test: gem_ctx_shared
results: parsing output: 148/ for test: kms_psr2_sf
results: parsing output: 149/ for test: i915_drm_fdinfo
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: gem_ctx_exec
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_big_fb
Done.