[60.867197] Initializing watchdogs
[60.867239]   /dev/watchdog0
[60.882023] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.886563] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.888809] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.892170] [001/132] (960s left) gem_exec_schedule (preempt-contexts)
[60.995789] Starting subtest: preempt-contexts
[60.998117] Starting dynamic subtest: rcs0
[61.078636] Dynamic subtest rcs0: SUCCESS (0.087s)
[61.089659] Starting dynamic subtest: bcs0
[61.159049] Dynamic subtest bcs0: SUCCESS (0.080s)
[61.166788] Starting dynamic subtest: vcs0
[61.224423] Dynamic subtest vcs0: SUCCESS (0.065s)
[61.232514] Starting dynamic subtest: vcs1
[61.293763] Dynamic subtest vcs1: SUCCESS (0.069s)
[61.303173] Starting dynamic subtest: vecs0
[61.362781] Dynamic subtest vecs0: SUCCESS (0.069s)
[61.371656] Starting dynamic subtest: ccs0
[61.449216] Dynamic subtest ccs0: SUCCESS (0.086s)
[61.451545] Subtest preempt-contexts: SUCCESS (0.458s)
[63.028694] [002/132] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[63.127316] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[70.546471] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.419s)
[70.670778] [003/132] (950s left) gem_exec_fence (invalid-timeline-fence-array)
[71.221855] Starting subtest: invalid-timeline-fence-array
[71.227636] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[73.021662] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[73.024675] [004/132] (948s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[73.135996] Starting subtest: x-tiled-64bpp-rotate-180
[74.626631] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.490s)
[74.804167] [005/132] (946s left) kms_pm_dc (dc9-dpms)
[75.911743] Starting subtest: dc9-dpms
[77.349063] Subtest dc9-dpms: SUCCESS (1.436s)
[77.407274] [006/132] (944s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[77.471093] Starting subtest: multi-wait-available-submitted-signaled
[77.473654] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[77.568393] [007/132] (944s left) gem_exec_balancer (semaphore)
[77.624980] Starting subtest: semaphore
[78.928657] Subtest semaphore: SUCCESS (1.301s)
[79.236297] [008/132] (942s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[79.288897] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[79.392430] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[79.464699] [009/132] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[79.563441] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[79.567812] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[79.662351] [010/132] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[79.755948] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[79.760195] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[79.855794] [011/132] (941s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[79.949937] Starting subtest: plane-downscale-factor-0-75-with-rotation
[79.952423] Starting dynamic subtest: pipe-A
[80.179103] Dynamic subtest pipe-A: SUCCESS (0.231s)
[80.187274] Starting dynamic subtest: pipe-B
[81.479078] Dynamic subtest pipe-B: SUCCESS (1.299s)
[81.488611] Starting dynamic subtest: pipe-C
[82.820063] Dynamic subtest pipe-C: SUCCESS (1.340s)
[82.827319] Starting dynamic subtest: pipe-D
[84.143582] Dynamic subtest pipe-D: SUCCESS (1.323s)
[84.145966] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.195s)
[85.330216] [012/132] (936s left) kms_feature_discovery (display)
[85.424096] Starting subtest: display
[85.426516] Subtest display: SUCCESS (0.000s)
[85.497530] [013/132] (936s left) gem_close (basic)
[85.574520] Starting subtest: basic
[85.576417] Subtest basic: SUCCESS (0.000s)
[85.701295] [014/132] (936s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[86.016922] Starting subtest: cursor-rapid-movement-max-size
[86.023859] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[86.143484] [015/132] (935s left) gem_mmap_wc (write-gtt-read-wc)
[86.207156] Subtest write-gtt-read-wc: SKIP (0.000s)
[86.266149] [016/132] (935s left) kms_chamelium_hpd (dp-hpd-fast)
[86.648309] Subtest dp-hpd-fast: SKIP (0.000s)
[87.439567] [017/132] (934s left) kms_lease (atomic-implicit-crtc)
[87.551067] Starting subtest: atomic-implicit-crtc
[87.553379] Starting dynamic subtest: pipe-A-eDP-1
[87.564659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[87.576353] Starting dynamic subtest: pipe-B-eDP-1
[87.587523] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[87.597065] Starting dynamic subtest: pipe-C-eDP-1
[87.607517] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[87.614244] Starting dynamic subtest: pipe-D-eDP-1
[87.624409] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[87.626421] Subtest atomic-implicit-crtc: SUCCESS (0.032s)
[87.696842] [018/132] (934s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[87.827743] Starting subtest: cursor-tearing-framebuffer-change
[87.830076] Starting dynamic subtest: pipe-A-eDP-1
[88.392999] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[88.402173] Starting dynamic subtest: pipe-D-eDP-1
[89.604513] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[89.606943] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.775s)
[90.425201] [019/132] (931s left) gem_ctx_persistence (heartbeat-hang)
[90.495534] Starting subtest: heartbeat-hang
[90.500355] Subtest heartbeat-hang: SKIP (0.000s)
[90.590657] [020/132] (931s left) api_intel_bb (crc32)
[90.645033] Starting subtest: crc32
[90.647566] Starting dynamic subtest: rcs0-smem0
[90.936551] Dynamic subtest rcs0-smem0: SUCCESS (0.291s)
[90.945700] Starting dynamic subtest: bcs0-smem0
[91.293690] Dynamic subtest bcs0-smem0: SUCCESS (0.356s)
[91.303205] Starting dynamic subtest: vcs0-smem0
[91.710129] Dynamic subtest vcs0-smem0: SUCCESS (0.415s)
[91.719840] Starting dynamic subtest: vcs1-smem0
[92.041727] Dynamic subtest vcs1-smem0: SUCCESS (0.330s)
[92.051677] Starting dynamic subtest: vecs0-smem0
[92.416196] Dynamic subtest vecs0-smem0: SUCCESS (0.373s)
[92.425657] Starting dynamic subtest: ccs0-smem0
[92.721297] Dynamic subtest ccs0-smem0: SUCCESS (0.303s)
[92.724217] Subtest crc32: SUCCESS (2.077s)
[92.842010] [021/132] (929s left) kms_pm_rpm (pm-caching)
[95.068053] Starting subtest: pm-caching
[95.073471] Subtest pm-caching: SKIP (0.000s)
[95.453329] [022/132] (926s left) gem_vm_create (invalid-create)
[95.512847] Starting subtest: invalid-create
[95.515275] Subtest invalid-create: SUCCESS (0.002s)
[95.611630] [023/132] (926s left) i915_drm_fdinfo (idle)
[95.656995] Starting subtest: idle
[95.659468] Starting dynamic subtest: rcs0
[96.208045] Dynamic subtest rcs0: SUCCESS (0.552s)
[96.218200] Starting dynamic subtest: bcs0
[96.713378] Dynamic subtest bcs0: SUCCESS (0.502s)
[96.745171] Starting dynamic subtest: vcs0
[97.216568] Dynamic subtest vcs0: SUCCESS (0.503s)
[97.227571] Starting dynamic subtest: vcs1
[97.723102] Dynamic subtest vcs1: SUCCESS (0.505s)
[97.733587] Starting dynamic subtest: vecs0
[98.228403] Dynamic subtest vecs0: SUCCESS (0.503s)
[98.240616] Starting dynamic subtest: ccs0
[98.734089] Dynamic subtest ccs0: SUCCESS (0.504s)
[98.737799] Subtest idle: SUCCESS (3.077s)
[98.809614] [024/132] (923s left) kms_properties (plane-properties-legacy)
[98.905435] Starting subtest: plane-properties-legacy
[98.907897] Starting dynamic subtest: pipe-A-eDP-1
[99.457763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[99.467257] Starting dynamic subtest: pipe-B-eDP-1
[100.715506] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[100.724726] Starting dynamic subtest: pipe-C-eDP-1
[101.959643] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s)
[101.968219] Starting dynamic subtest: pipe-D-eDP-1
[103.193930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[103.196164] Subtest plane-properties-legacy: SUCCESS (4.288s)
[103.998129] [025/132] (918s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[104.392243] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[105.202214] [026/132] (917s left) i915_module_load (reload-no-display)
[105.238078] Starting subtest: reload-no-display
[109.435981] Subtest reload-no-display: SUCCESS (4.196s)
[109.462868] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[109.463646] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[109.466846] [027/132] (912s left) gem_softpin (noreloc-s3)
[110.956928] Starting subtest: noreloc-S3
[131.223050] Subtest noreloc-S3: SUCCESS (5.427s)
[131.306118] [FACT gem_softpin (noreloc-s3)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[131.307451] [FACT gem_softpin (noreloc-s3)] new: kernel.kmod_is_loaded.i915: true
[131.311409] [028/132] (891s left) gem_ctx_param (invalid-get-engines)
[131.370365] Starting subtest: invalid-get-engines
[131.372787] Subtest invalid-get-engines: SUCCESS (0.002s)
[131.479298] [029/132] (891s left) gem_ccs (block-multicopy-compressed)
[131.530970] Starting subtest: block-multicopy-compressed
[131.535470] Subtest block-multicopy-compressed: SKIP (0.000s)
[131.629508] [030/132] (890s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[131.731484] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[131.735742] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[131.835148] [031/132] (890s left) kms_addfb_basic (small-bo)
[131.927617] Starting subtest: small-bo
[131.929511] Subtest small-bo: SUCCESS (0.000s)
[132.008114] [032/132] (890s left) api_intel_bb (offset-control)
[132.064426] Starting subtest: offset-control
[132.071261] Subtest offset-control: SUCCESS (0.009s)
[132.203632] [033/132] (890s left) i915_pm_rpm (gem-execbuf-stress)
[133.927537] Starting subtest: gem-execbuf-stress
[133.930317] Starting dynamic subtest: smem0
[146.761147] Dynamic subtest smem0: SUCCESS (12.821s)
[146.772994] Starting dynamic subtest: extra-wait-smem0
[208.628870] Dynamic subtest extra-wait-smem0: SUCCESS (61.837s)
[208.632301] Subtest gem-execbuf-stress: SUCCESS (74.662s)
[209.005347] [034/132] (813s left) gen9_exec_parse (allowed-all)
[209.062550] Subtest allowed-all: SKIP (0.000s)
[209.138373] [035/132] (813s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[209.230932] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[209.235178] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[209.339405] [036/132] (813s left) gem_exec_store (pages)
[209.404329] Starting subtest: pages
[209.406637] Starting dynamic subtest: rcs0
[209.495696] Dynamic subtest rcs0: SUCCESS (0.094s)
[209.505089] Starting dynamic subtest: bcs0
[209.565975] Dynamic subtest bcs0: SUCCESS (0.070s)
[209.575635] Starting dynamic subtest: vcs0
[209.634186] Dynamic subtest vcs0: SUCCESS (0.067s)
[209.644500] Starting dynamic subtest: vcs1
[209.704514] Dynamic subtest vcs1: SUCCESS (0.070s)
[209.715240] Starting dynamic subtest: vecs0
[209.776861] Dynamic subtest vecs0: SUCCESS (0.071s)
[209.786987] Starting dynamic subtest: ccs0
[209.849897] Dynamic subtest ccs0: SUCCESS (0.073s)
[209.852364] Subtest pages: SUCCESS (0.449s)
[210.031135] [037/132] (812s left) gem_exec_balancer (indices)
[210.114337] Starting subtest: indices
[212.640120] Subtest indices: SUCCESS (2.526s)
[212.932967] [038/132] (809s left) kms_fbcon_fbt (psr-suspend)
[212.990164] Starting subtest: psr-suspend
[262.145438] Subtest psr-suspend: SUCCESS (19.651s)
[262.226223] [039/132] (760s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[262.337314] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[262.351984] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.013s)
[262.442917] [040/132] (760s left) kms_addfb_basic (addfb25-modifier-no-flag)
[262.540064] Starting subtest: addfb25-modifier-no-flag
[262.542171] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[262.641591] [041/132] (760s left) vgem_basic (second-client)
[262.700439] Starting subtest: second-client
[262.722107] Subtest second-client: SUCCESS (0.022s)
[262.778104] [042/132] (760s left) i915_selftest (live)
[266.589875] Starting subtest: live
[266.592420] Starting dynamic subtest: sanitycheck
[270.132035] Dynamic subtest sanitycheck: SUCCESS (3.537s)
[270.141947] Starting dynamic subtest: uncore
[273.630284] Dynamic subtest uncore: SUCCESS (3.494s)
[273.639712] Starting dynamic subtest: workarounds
[292.500930] Dynamic subtest workarounds: FAIL (18.499s)
[292.508638] Starting dynamic subtest: gt_engines
[295.997333] Dynamic subtest gt_engines: SUCCESS (3.861s)
[296.006608] Starting dynamic subtest: gt_timelines
[311.209492] Dynamic subtest gt_timelines: SUCCESS (15.213s)
[311.218694] Starting dynamic subtest: gt_contexts
[314.793121] Dynamic subtest gt_contexts: SUCCESS (3.581s)
[314.803820] Starting dynamic subtest: gt_lrc
[321.738042] Dynamic subtest gt_lrc: SUCCESS (6.943s)
[321.770952] Starting dynamic subtest: gt_mocs
[325.488569] Dynamic subtest gt_mocs: SUCCESS (3.748s)
[325.503862] Starting dynamic subtest: gt_pm
[333.175307] Dynamic subtest gt_pm: SUCCESS (7.683s)
[333.185440] Starting dynamic subtest: gt_heartbeat
[336.789688] Dynamic subtest gt_heartbeat: SUCCESS (3.606s)
[336.799640] Starting dynamic subtest: gt_tlb
[347.608219] Dynamic subtest gt_tlb: SUCCESS (10.820s)
[347.618132] Starting dynamic subtest: requests
[360.506577] Dynamic subtest requests: SUCCESS (12.898s)
[360.516222] Starting dynamic subtest: migrate
[367.048742] Dynamic subtest migrate: SUCCESS (6.542s)
[367.058767] Starting dynamic subtest: active
[370.619455] Dynamic subtest active: SUCCESS (3.570s)
[370.629197] Starting dynamic subtest: objects
[374.702845] Dynamic subtest objects: SUCCESS (4.083s)
[374.717841] Starting dynamic subtest: mman
[380.348801] Dynamic subtest mman: SUCCESS (5.644s)
[380.358945] Starting dynamic subtest: dmabuf
[385.500457] Dynamic subtest dmabuf: SUCCESS (5.150s)
[385.510223] Starting dynamic subtest: vma
[389.019237] Dynamic subtest vma: SUCCESS (3.517s)
[389.029012] Starting dynamic subtest: coherency
[395.254016] Dynamic subtest coherency: SUCCESS (6.233s)
[395.268536] Starting dynamic subtest: gtt
[406.093663] Dynamic subtest gtt: SUCCESS (10.837s)
[406.102835] Starting dynamic subtest: gem
[412.874748] Dynamic subtest gem: SUCCESS (6.779s)
[412.884748] Starting dynamic subtest: evict
[417.758919] Dynamic subtest evict: SUCCESS (4.883s)
[417.768749] Starting dynamic subtest: hugepages
[429.824557] Dynamic subtest hugepages: SUCCESS (12.061s)
[429.835539] Starting dynamic subtest: gem_contexts
[456.069614] Dynamic subtest gem_contexts: SUCCESS (26.238s)
[456.078929] Starting dynamic subtest: client
[459.610073] Dynamic subtest client: SUCCESS (3.539s)
[459.619976] Starting dynamic subtest: gem_migrate
[463.135280] Dynamic subtest gem_migrate: SUCCESS (3.522s)
[463.149017] Starting dynamic subtest: reset
[466.765086] Dynamic subtest reset: SUCCESS (3.627s)
[466.775280] Starting dynamic subtest: memory_region
[470.266209] Dynamic subtest memory_region: SUCCESS (3.499s)
[470.275159] Starting dynamic subtest: hangcheck
[486.389606] Dynamic subtest hangcheck: SUCCESS (16.121s)
[486.398861] Starting dynamic subtest: execlists
[489.886734] Dynamic subtest execlists: SUCCESS (3.497s)
[489.897124] Starting dynamic subtest: ring_submission
[493.404357] Dynamic subtest ring_submission: SUCCESS (3.517s)
[493.414072] Starting dynamic subtest: perf
[496.997311] Dynamic subtest perf: SUCCESS (3.591s)
[497.006855] Starting dynamic subtest: slpc
[510.347159] Dynamic subtest slpc: SUCCESS (13.351s)
[510.362479] Starting dynamic subtest: guc
[515.082346] Dynamic subtest guc: SUCCESS (4.734s)
[515.091568] Starting dynamic subtest: guc_multi_lrc
[518.638179] Dynamic subtest guc_multi_lrc: SUCCESS (3.555s)
[518.647470] Starting dynamic subtest: guc_hang
[524.486950] Dynamic subtest guc_hang: SUCCESS (5.846s)
[524.497008] Starting dynamic subtest: late_gt_pm
[528.077586] Dynamic subtest late_gt_pm: SUCCESS (3.589s)
[528.080622] Subtest live: FAIL (261.458s)
[528.111176] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[528.111920] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[528.115611] [043/132] (494s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[530.555056] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[530.557366] Starting dynamic subtest: pipe-A-eDP-1
[530.586065] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.596318] Starting dynamic subtest: pipe-B-eDP-1
[530.625359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.633801] Starting dynamic subtest: pipe-C-eDP-1
[530.659648] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.667821] Starting dynamic subtest: pipe-D-eDP-1
[530.694019] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.698955] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[532.933597] [FACT kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[532.934786] [FACT kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)] new: kernel.kmod_is_loaded.i915: true
[532.939709] [044/132] (490s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[533.069222] Starting subtest: verify-pxp-stale-buf-optout-execution
[534.140318] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.072s)
[534.267669] [045/132] (488s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[534.363316] Starting subtest: fbc-rgb101010-draw-render
[539.217604] Subtest fbc-rgb101010-draw-render: SUCCESS (4.857s)
[540.618374] [046/132] (482s left) gem_ctx_engines (independent)
[540.674032] Starting subtest: independent
[540.676334] Starting dynamic subtest: rcs0
[540.817842] Dynamic subtest rcs0: SUCCESS (0.143s)
[540.828678] Starting dynamic subtest: bcs0
[540.934471] Dynamic subtest bcs0: SUCCESS (0.113s)
[540.946579] Starting dynamic subtest: vcs0
[541.050109] Dynamic subtest vcs0: SUCCESS (0.117s)
[541.063408] Starting dynamic subtest: vcs1
[541.171990] Dynamic subtest vcs1: SUCCESS (0.121s)
[541.184296] Starting dynamic subtest: vecs0
[541.319660] Dynamic subtest vecs0: SUCCESS (0.143s)
[541.332985] Starting dynamic subtest: ccs0
[541.458455] Dynamic subtest ccs0: SUCCESS (0.139s)
[541.467498] Starting dynamic subtest: all-engines
[542.093686] Dynamic subtest all-engines: SUCCESS (0.633s)
[542.096061] Subtest independent: SUCCESS (1.418s)
[542.352986] [047/132] (480s left) kms_dp_aux_dev (basic)
[542.413839] Starting subtest: basic
[542.710815] Subtest basic: SUCCESS (0.297s)
[542.788680] [048/132] (480s left) kms_plane_multiple (tiling-y)
[542.883200] Starting subtest: tiling-y
[542.888334] Subtest tiling-y: SKIP (0.000s)
[542.957010] [049/132] (480s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[543.050296] Starting subtest: plane-upscale-factor-0-25-with-rotation
[543.053079] Starting dynamic subtest: pipe-A
[543.274339] Dynamic subtest pipe-A: SUCCESS (0.227s)
[543.283215] Starting dynamic subtest: pipe-B
[544.828010] Dynamic subtest pipe-B: SUCCESS (1.553s)
[544.839044] Starting dynamic subtest: pipe-C
[546.160112] Dynamic subtest pipe-C: SUCCESS (1.331s)
[546.169142] Starting dynamic subtest: pipe-D
[547.497321] Dynamic subtest pipe-D: SUCCESS (1.335s)
[547.500052] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.451s)
[548.678812] [050/132] (474s left) gem_spin_batch (resubmit-new-all)
[548.748037] Starting subtest: resubmit-new-all
[548.750907] Starting dynamic subtest: rcs0
[548.767167] Dynamic subtest rcs0: SUCCESS (0.019s)
[548.777704] Starting dynamic subtest: bcs0
[548.780336] Dynamic subtest bcs0: SUCCESS (0.011s)
[548.789075] Starting dynamic subtest: vcs0
[548.791785] Dynamic subtest vcs0: SUCCESS (0.009s)
[548.800327] Starting dynamic subtest: vcs1
[548.803042] Dynamic subtest vcs1: SUCCESS (0.009s)
[548.811336] Starting dynamic subtest: vecs0
[548.813670] Dynamic subtest vecs0: SUCCESS (0.008s)
[548.822314] Starting dynamic subtest: ccs0
[548.825122] Dynamic subtest ccs0: SUCCESS (0.008s)
[548.827748] Subtest resubmit-new-all: SUCCESS (0.068s)
[550.285672] [051/132] (473s left) gem_mmap_gtt (hang)
[550.351449] Subtest hang: SKIP (0.000s)
[550.414745] [052/132] (473s left) kms_frontbuffer_tracking (psr-1p-rte)
[550.518458] Starting subtest: psr-1p-rte
[555.904358] Subtest psr-1p-rte: SUCCESS (5.391s)
[556.030121] [053/132] (467s left) i915_query (query-garbage)
[556.086199] Starting subtest: query-garbage
[556.088651] Subtest query-garbage: SUCCESS (0.000s)
[556.176953] [054/132] (467s left) gem_partial_pwrite_pread (writes-after-reads)
[556.232032] Subtest writes-after-reads: SKIP (0.000s)
[556.298152] [055/132] (467s left) tools_test (tools_test)
[556.355074] Starting subtest: tools_test
[556.404213] Subtest tools_test: SUCCESS (0.069s)
[556.480698] [056/132] (467s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[556.584295] Starting subtest: y-tiled-16bpp-rotate-0
[556.589304] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[556.678455] [057/132] (467s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[556.735228] Starting subtest: invalid-single-wait-all-unsubmitted
[556.738136] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[556.819874] [058/132] (466s left) prime_mmap_coherency (read)
[556.877489] Starting subtest: read
[562.255166] Subtest read: SUCCESS (5.376s)
[562.383168] [059/132] (461s left) kms_prop_blob (invalid-get-prop)
[562.438292] Starting subtest: invalid-get-prop
[562.441330] Subtest invalid-get-prop: SUCCESS (0.000s)
[562.564696] [060/132] (461s left) kms_async_flips (test-time-stamp-atomic)
[562.651847] Starting subtest: test-time-stamp-atomic
[563.024143] Starting dynamic subtest: pipe-A-eDP-1
[563.798052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[564.179789] Starting dynamic subtest: pipe-B-eDP-1
[564.937297] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[565.311141] Starting dynamic subtest: pipe-C-eDP-1
[566.068672] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[566.435526] Starting dynamic subtest: pipe-D-eDP-1
[567.199614] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[567.202957] Subtest test-time-stamp-atomic: SUCCESS (4.547s)
[568.355548] [061/132] (455s left) kms_flip (flip-vs-suspend)
[568.450063] Starting subtest: flip-vs-suspend
[568.452213] Starting dynamic subtest: A-eDP1
[714.168287] Dynamic subtest A-eDP1: SUCCESS (11.342s)
[714.170755] Subtest flip-vs-suspend: SUCCESS (11.346s)
[714.311871] [062/132] (309s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[714.432353] Starting subtest: 4-tiled-8bpp-rotate-180
[715.652142] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.215s)
[715.783364] [063/132] (308s left) kms_joiner (invalid-modeset-big-joiner)
[715.875373] Starting subtest: invalid-modeset-big-joiner
[715.880157] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[715.940952] [064/132] (308s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[716.034855] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[720.325743] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.279s)
[721.567804] [065/132] (302s left) gem_pxp (fail-invalid-protected-context)
[721.678746] Starting subtest: fail-invalid-protected-context
[721.681490] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[721.808800] [066/132] (302s left) kms_selftest (drm_plane_helper)
[721.851899] Starting subtest: drm_plane_helper
[721.895481] Starting dynamic subtest: drm_test_check_plane_state
[722.051222] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.156s)
[722.066233] Starting dynamic subtest: drm_test_check_invalid_plane_state
[722.174364] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.119s)
[722.176816] Subtest drm_plane_helper: SUCCESS (0.319s)
[722.390137] [067/132] (301s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[722.486270] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[722.488401] Starting dynamic subtest: pipe-A-eDP-1
[723.712945] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.225s)
[723.722614] Starting dynamic subtest: pipe-B-eDP-1
[726.284995] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.567s)
[726.294222] Starting dynamic subtest: pipe-C-eDP-1
[728.648645] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.359s)
[728.658459] Starting dynamic subtest: pipe-D-eDP-1
[731.212968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[731.215788] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.716s)
[732.321495] [068/132] (291s left) gem_exec_flush (basic-wb-set-default)
[732.406973] Starting subtest: basic-wb-set-default
[737.872112] Subtest basic-wb-set-default: SUCCESS (5.451s)
[738.052734] [069/132] (286s left) kms_plane (pixel-format-4-tiled-modifier)
[738.145205] Starting subtest: pixel-format-4-tiled-modifier
[738.172228] Starting dynamic subtest: pipe-A-plane-0
[738.862060] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[738.873068] Starting dynamic subtest: pipe-A-plane-3
[739.339526] Dynamic subtest pipe-A-plane-3: SUCCESS (0.477s)
[739.348220] Starting dynamic subtest: pipe-A-plane-5
[739.352760] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[740.431220] Starting dynamic subtest: pipe-B-plane-0
[741.212223] Dynamic subtest pipe-B-plane-0: SUCCESS (0.788s)
[741.221769] Starting dynamic subtest: pipe-B-plane-3
[741.667478] Dynamic subtest pipe-B-plane-3: SUCCESS (0.454s)
[741.677275] Starting dynamic subtest: pipe-B-plane-5
[741.681091] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[741.982777] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.835s)
[742.792194] [070/132] (281s left) kms_vblank (ts-continuation-idle)
[742.893243] Starting subtest: ts-continuation-idle
[742.896014] Starting dynamic subtest: pipe-A-eDP-1
[743.305143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[743.320937] Starting dynamic subtest: pipe-D-eDP-1
[744.387146] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.077s)
[744.389756] Subtest ts-continuation-idle: SUCCESS (1.494s)
[745.269657] [071/132] (279s left) kms_vrr (flipline)
[745.380787] Starting subtest: flipline
[745.387278] Subtest flipline: SKIP (0.000s)
[745.507466] [072/132] (278s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[745.621009] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[745.626031] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[745.745575] [073/132] (278s left) prime_vgem (busy)
[745.816914] Starting subtest: busy
[745.819352] Starting dynamic subtest: rcs0
[745.867940] Dynamic subtest rcs0: SUCCESS (0.053s)
[745.878076] Starting dynamic subtest: bcs0
[745.932663] Dynamic subtest bcs0: SUCCESS (0.063s)
[745.942474] Starting dynamic subtest: vcs0
[745.983813] Dynamic subtest vcs0: SUCCESS (0.049s)
[745.993999] Starting dynamic subtest: vcs1
[746.034011] Dynamic subtest vcs1: SUCCESS (0.049s)
[746.043639] Starting dynamic subtest: vecs0
[746.079271] Dynamic subtest vecs0: SUCCESS (0.044s)
[746.089236] Starting dynamic subtest: ccs0
[746.127686] Dynamic subtest ccs0: SUCCESS (0.047s)
[746.130449] Subtest busy: SUCCESS (0.314s)
[746.251750] [074/132] (278s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[746.346227] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[746.350766] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[746.435913] [075/132] (278s left) gem_exec_params (no-blt)
[746.487749] Starting subtest: no-blt
[746.493301] Subtest no-blt: SUCCESS (0.003s)
[746.601800] [076/132] (277s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[746.699501] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[750.779163] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.084s)
[751.981483] [077/132] (272s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[752.079113] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[752.084082] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[752.168292] [078/132] (272s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[752.265118] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[752.270199] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[752.367881] [079/132] (272s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[752.464109] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[752.466511] Starting dynamic subtest: pipe-A-eDP-1
[752.610133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[752.621512] Starting dynamic subtest: pipe-B-eDP-1
[752.643130] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[752.652161] Starting dynamic subtest: pipe-C-eDP-1
[752.672618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[752.681116] Starting dynamic subtest: pipe-D-eDP-1
[752.701090] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[752.703057] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.151s)
[754.951077] [080/132] (269s left) kms_fence_pin_leak
[755.136022] [081/132] (269s left) i915_query (query-topology-kernel-writes)
[755.192057] Starting subtest: query-topology-kernel-writes
[755.195039] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[755.303948] [082/132] (269s left) kms_getfb (getfb-handle-zero)
[755.397757] Starting subtest: getfb-handle-zero
[755.399979] Subtest getfb-handle-zero: SUCCESS (0.000s)
[755.493610] [083/132] (269s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[755.593794] Starting subtest: psr2-cursor-plane-move-continuous-sf
[755.596578] Starting dynamic subtest: pipe-A-eDP-1
[765.952223] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.363s)
[765.964287] Starting dynamic subtest: pipe-B-eDP-1
[777.036767] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.080s)
[777.039704] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.446s)
[777.911216] [084/132] (247s left) kms_psr (pr-sprite-plane-onoff)
[778.011398] Starting subtest: pr-sprite-plane-onoff
[778.016902] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[778.102453] [085/132] (246s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[778.181971] Starting subtest: invalidate-primary-flip-overlay
[788.960472] Subtest invalidate-primary-flip-overlay: SUCCESS (10.777s)
[789.063227] [086/132] (235s left) gem_mmap_offset (bad-object)
[789.113031] Starting subtest: bad-object
[789.115518] Subtest bad-object: SUCCESS (0.001s)
[789.206073] [087/132] (235s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[789.304016] Starting subtest: psr-rgb565-draw-blt
[796.289010] Subtest psr-rgb565-draw-blt: SUCCESS (6.985s)
[796.428619] [088/132] (228s left) kms_psr (fbc-psr-sprite-blt)
[796.528106] Starting subtest: fbc-psr-sprite-blt
[796.531079] Starting dynamic subtest: eDP-1
[796.536212] Dynamic subtest eDP-1: SKIP (0.000s)
[796.541520] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[796.605297] [089/132] (228s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[796.659368] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[796.662118] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[796.764482] [090/132] (228s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[796.871997] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[796.876720] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[796.959337] [091/132] (228s left) gem_mmap_wc (set-cache-level)
[797.010004] Subtest set-cache-level: SKIP (0.000s)
[797.073632] [092/132] (228s left) kms_content_protection (dp-mst-lic-type-0)
[797.216035] Starting subtest: dp-mst-lic-type-0
[797.220709] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[797.347459] [093/132] (227s left) kms_cursor_crc (cursor-offscreen-256x85)
[797.599389] Starting subtest: cursor-offscreen-256x85
[797.650558] Subtest cursor-offscreen-256x85: SKIP (0.046s)
[797.820807] [094/132] (227s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[797.878024] Starting subtest: single-wait-all-for-submit-available-signaled
[797.880778] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[797.971678] [095/132] (227s left) kms_color (ctm-0-25)
[798.054991] Starting subtest: ctm-0-25
[798.057033] Starting dynamic subtest: pipe-A-eDP-1
[801.543382] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s)
[801.555004] Starting dynamic subtest: pipe-B-eDP-1
[805.763730] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.215s)
[805.774233] Starting dynamic subtest: pipe-C-eDP-1
[809.829869] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.064s)
[809.839273] Starting dynamic subtest: pipe-D-eDP-1
[813.831884] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.006s)
[813.834531] Subtest ctm-0-25: SUCCESS (15.776s)
[814.659383] [096/132] (210s left) perf_pmu (render-node-busy)
[814.741797] Starting subtest: render-node-busy
[814.744542] Starting dynamic subtest: rcs0
[815.336817] Dynamic subtest rcs0: SUCCESS (0.595s)
[815.349872] Starting dynamic subtest: bcs0
[815.896218] Dynamic subtest bcs0: SUCCESS (0.557s)
[815.909961] Starting dynamic subtest: vcs0
[817.594213] Dynamic subtest vcs0: SUCCESS (1.695s)
[817.606087] Starting dynamic subtest: vcs1
[819.578245] Dynamic subtest vcs1: SUCCESS (1.981s)
[819.591114] Starting dynamic subtest: vecs0
[821.561510] Dynamic subtest vecs0: SUCCESS (1.981s)
[821.574842] Starting dynamic subtest: ccs0
[822.127050] Dynamic subtest ccs0: SUCCESS (0.564s)
[822.129973] Subtest render-node-busy: SUCCESS (7.389s)
[822.207588] [097/132] (203s left) kms_flip (plain-flip-fb-recreate)
[822.311600] Starting subtest: plain-flip-fb-recreate
[822.314013] Starting dynamic subtest: A-eDP1
[831.146366] Dynamic subtest A-eDP1: SUCCESS (8.835s)
[831.159561] Starting dynamic subtest: B-eDP1
[839.965535] Dynamic subtest B-eDP1: SUCCESS (8.817s)
[839.975441] Starting dynamic subtest: C-eDP1
[848.781564] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[848.793407] Starting dynamic subtest: D-eDP1
[857.611663] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[857.616699] Subtest plain-flip-fb-recreate: SUCCESS (35.305s)
[858.784884] [098/132] (166s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[858.875937] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[858.878454] Starting dynamic subtest: pipe-A-eDP-1
[858.901825] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[858.913570] Starting dynamic subtest: pipe-B-eDP-1
[858.935964] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[858.944688] Starting dynamic subtest: pipe-C-eDP-1
[858.966731] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[858.975323] Starting dynamic subtest: pipe-D-eDP-1
[858.997919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[859.002638] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[861.077291] [099/132] (164s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[861.179165] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[861.181917] Starting dynamic subtest: pipe-A-eDP-1
[861.250909] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[861.263223] Starting dynamic subtest: pipe-B-eDP-1
[861.332949] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[861.344555] Starting dynamic subtest: pipe-C-eDP-1
[861.404383] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[861.413360] Starting dynamic subtest: pipe-D-eDP-1
[861.481835] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[861.486721] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[863.443534] [100/132] (162s left) gem_mmap_gtt (basic-small-copy-odd)
[863.504892] Subtest basic-small-copy-odd: SKIP (0.000s)
[863.564840] [101/132] (162s left) gem_mmap_wc (invalid-flags)
[863.620712] Subtest invalid-flags: SKIP (0.000s)
[863.677654] [102/132] (161s left) sw_sync (alloc_fence)
[863.725379] Starting subtest: alloc_fence
[863.728072] Subtest alloc_fence: SUCCESS (0.000s)
[863.794051] [103/132] (161s left) kms_psr (fbc-pr-no-drrs)
[863.892398] Starting subtest: fbc-pr-no-drrs
[863.897900] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[863.981418] [104/132] (161s left) gem_eio (reset-stress)
[864.193736] Starting subtest: reset-stress
[864.196495] Starting dynamic subtest: render
[868.577237] Dynamic subtest render: SUCCESS (4.381s)
[868.594931] Starting dynamic subtest: bsd1
[887.051207] Dynamic subtest bsd1: SUCCESS (18.469s)
[887.068766] Starting dynamic subtest: bsd2
[905.080587] Dynamic subtest bsd2: SUCCESS (18.024s)
[905.097242] Starting dynamic subtest: blt
[905.101849] Dynamic subtest blt: SKIP (0.000s)
[905.111631] Starting dynamic subtest: vebox
[923.046216] Dynamic subtest vebox: SUCCESS (17.958s)
[923.048999] Subtest reset-stress: SUCCESS (58.836s)
[924.587858] [105/132] (101s left) gem_exec_schedule (smoketest)
[924.770973] Starting subtest: smoketest
[924.773980] Starting dynamic subtest: rcs0
[930.347113] Dynamic subtest rcs0: SUCCESS (5.509s)
[930.358759] Starting dynamic subtest: bcs0
[935.885346] Dynamic subtest bcs0: SUCCESS (5.537s)
[935.897408] Starting dynamic subtest: vcs0
[941.415613] Dynamic subtest vcs0: SUCCESS (5.524s)
[941.428411] Starting dynamic subtest: vcs1
[946.933185] Dynamic subtest vcs1: SUCCESS (5.522s)
[946.944562] Starting dynamic subtest: vecs0
[952.462926] Dynamic subtest vecs0: SUCCESS (5.528s)
[952.474219] Starting dynamic subtest: ccs0
[957.993146] Dynamic subtest ccs0: SUCCESS (5.531s)
[957.996023] Subtest smoketest: SUCCESS (33.160s)
[958.166516] [106/132] ( 67s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[958.273137] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[958.275562] Starting dynamic subtest: pipe-A-default-mode
[960.997064] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s)
[960.999939] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.727s)
[961.845659] [107/132] ( 64s left) perf (invalid-open-flags)
[961.974040] Starting subtest: invalid-open-flags
[961.976917] Subtest invalid-open-flags: SUCCESS (0.000s)
[962.026780] [108/132] ( 63s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[962.140250] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[962.145644] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[962.238472] [109/132] ( 63s left) gem_exec_params (larger-than-life-batch)
[962.299975] Starting subtest: larger-than-life-batch
[964.783203] Subtest larger-than-life-batch: SUCCESS (2.485s)
[965.618946] [110/132] ( 60s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[965.721990] Starting subtest: y-tiled-ccs-to-yf-tiled
[965.727873] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[965.903689] [111/132] ( 60s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[966.013218] Starting subtest: extended-modeset-hang-oldfb-with-reset
[966.016041] Starting dynamic subtest: pipe-A
[978.106864] Dynamic subtest pipe-A: SUCCESS (12.094s)
[978.118245] Starting dynamic subtest: pipe-D
[990.594136] Dynamic subtest pipe-D: SUCCESS (12.485s)
[990.596899] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.583s)
[991.379534] [112/132] ( 34s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[991.477835] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[991.483212] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[991.580552] [113/132] ( 34s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[991.681471] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[995.927055] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.249s)
[997.105441] [114/132] ( 29s left) gem_mmap (bad-object)
[997.169221] Subtest bad-object: SKIP (0.000s)
[997.228499] [115/132] ( 29s left) kms_3d (basic)
[997.281120] Starting subtest: basic
[999.293932] Subtest basic: SUCCESS (2.015s)
[999.786728] [116/132] ( 26s left) kms_getfb (getfb-reject-nv12)
[999.876014] Starting subtest: getfb-reject-nv12
[999.878811] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[999.981845] [117/132] ( 26s left) gem_mmap_gtt (bad-object)
[1000.048464] Subtest bad-object: SKIP (0.000s)
[1000.110599] [118/132] ( 26s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[1000.228051] Starting subtest: yf-tiled-16bpp-rotate-90
[1000.233357] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[1000.329492] [119/132] ( 26s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[1000.427545] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[1000.432321] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[1000.525123] [120/132] ( 25s left) sysfs_timeslice_duration (invalid)
[1000.593581] Starting subtest: invalid
[1000.596381] Starting dynamic subtest: vecs0
[1000.599076] Dynamic subtest vecs0: SUCCESS (0.000s)
[1000.612844] Starting dynamic subtest: ccs0
[1000.615106] Dynamic subtest ccs0: SUCCESS (0.000s)
[1000.625593] Starting dynamic subtest: vcs0
[1000.627627] Dynamic subtest vcs0: SUCCESS (0.000s)
[1000.637750] Starting dynamic subtest: bcs0
[1000.639965] Dynamic subtest bcs0: SUCCESS (0.000s)
[1000.649808] Starting dynamic subtest: rcs0
[1000.652031] Dynamic subtest rcs0: SUCCESS (0.000s)
[1000.661370] Starting dynamic subtest: vcs1
[1000.663229] Dynamic subtest vcs1: SUCCESS (0.000s)
[1000.665219] Subtest invalid: SUCCESS (0.007s)
[1000.703569] [121/132] ( 25s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[1000.796901] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[1000.800871] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[1000.890685] [122/132] ( 25s left) kms_plane_alpha_blend (constant-alpha-mid)
[1000.982853] Starting subtest: constant-alpha-mid
[1001.269243] Starting dynamic subtest: pipe-A-eDP-1
[1002.204199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.933s)
[1002.218928] Starting dynamic subtest: pipe-D-eDP-1
[1003.719548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[1003.722506] Subtest constant-alpha-mid: SUCCESS (2.736s)
[1004.597246] [123/132] ( 21s left) kms_psr (psr-cursor-plane-move)
[1004.700794] Starting subtest: psr-cursor-plane-move
[1004.703631] Starting dynamic subtest: eDP-1
[1006.402116] Dynamic subtest eDP-1: SUCCESS (1.702s)
[1006.405266] Subtest psr-cursor-plane-move: SUCCESS (1.703s)
[1007.265472] [124/132] ( 19s left) kms_frontbuffer_tracking (fbc-tiling-4)
[1007.370050] Starting subtest: fbc-tiling-4
[1011.569925] Subtest fbc-tiling-4: SUCCESS (4.207s)
[1012.779020] [125/132] ( 13s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[1012.845530] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[1012.948653] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[1013.028965] [126/132] ( 13s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[1013.084984] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[1013.142055] [127/132] ( 13s left) gem_userptr_blits (unsync-overlap)
[1013.205159] Subtest unsync-overlap: SKIP (0.000s)
[1013.321477] [128/132] ( 13s left) gem_exec_whisper (basic-queues-priority-all)
[1013.396091] Starting subtest: basic-queues-priority-all
[1036.931233] Subtest basic-queues-priority-all: SUCCESS (23.528s)
[1037.095550] Overall timeout time exceeded, stopping.
[1037.110863] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: kms_feature_discovery
results: parsing output: 12/ for test: gem_close
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: gem_mmap_wc
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: gem_vm_create
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_properties
results: parsing output: 24/ for test: kms_chamelium_edid
results: parsing output: 25/ for test: i915_module_load
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: gem_ccs
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_store
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_fbcon_fbt
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: i915_selftest
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ctx_engines
results: parsing output: 46/ for test: kms_dp_aux_dev
results: parsing output: 47/ for test: kms_plane_multiple
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: gem_spin_batch
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: i915_query
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: tools_test
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: prime_mmap_coherency
results: parsing output: 58/ for test: kms_prop_blob
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_joiner
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_pxp
results: parsing output: 65/ for test: kms_selftest
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_exec_flush
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_vrr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_fence_pin_leak
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: kms_getfb
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_psr_stress_test
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_mmap_wc
results: parsing output: 91/ for test: kms_content_protection
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: gem_mmap_wc
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_busy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_mmap
results: parsing output: 114/ for test: kms_3d
results: parsing output: 115/ for test: kms_getfb
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: sysfs_timeslice_duration
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane_alpha_blend
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_pipe_b_c_ivb
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: sw_sync
results: no output, setting notrun
results: parsing output: 129/ for test: core_setmaster
results: no output, setting notrun
results: parsing output: 130/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 131/ for test: kms_psr
results: no output, setting notrun
Done.