[58.099610] Initializing watchdogs
[58.099743]   /dev/watchdog0
[58.118544] [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]
[58.123345] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.125743] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.129179] [001/132] (960s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[58.257309] Starting subtest: fbc-rgb101010-draw-pwrite
[64.255970] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.952s)
[65.462198] [002/132] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[65.565505] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[65.569960] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[65.655914] [003/132] (953s left) gem_pxp (display-protected-crc)
[65.791968] Starting subtest: display-protected-crc
[67.466900] Subtest display-protected-crc: SUCCESS (1.671s)
[67.571858] [004/132] (951s left) gem_ctx_param (invalid-ctx-get)
[67.624662] Starting subtest: invalid-ctx-get
[67.627051] Subtest invalid-ctx-get: SUCCESS (0.000s)
[67.697029] [005/132] (951s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[67.789534] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[67.793843] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[67.890620] [006/132] (950s left) kms_psr (pr-primary-blt)
[67.995248] Starting subtest: pr-primary-blt
[67.999954] Subtest pr-primary-blt: SKIP (0.000s)
[68.064647] [007/132] (950s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[68.180428] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[68.185168] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[68.324106] [008/132] (950s left) gem_softpin (zero)
[68.387522] Starting subtest: zero
[68.393718] Subtest zero: SUCCESS (0.004s)
[68.526081] [009/132] (950s left) kms_cursor_crc (cursor-onscreen-32x32)
[68.671327] Starting subtest: cursor-onscreen-32x32
[68.723089] Subtest cursor-onscreen-32x32: SKIP (0.049s)
[69.037071] [010/132] (949s left) gem_exec_reloc (basic-wc-gtt)
[69.096869] Subtest basic-wc-gtt: SKIP (0.000s)
[69.152154] [011/132] (949s left) gem_exec_balancer (parallel-ordering)
[69.406195] Starting subtest: parallel-ordering
[70.397078] Subtest parallel-ordering: SUCCESS (0.989s)
[70.555188] [012/132] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[70.652086] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[77.613157] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.955s)
[77.734319] [013/132] (941s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[79.496069] Starting subtest: dpms-mode-unset-lpsp
[83.553803] Subtest dpms-mode-unset-lpsp: SUCCESS (4.059s)
[83.922417] [014/132] (935s left) kms_psr (psr2-primary-mmap-gtt)
[84.018626] Starting subtest: psr2-primary-mmap-gtt
[84.021084] Starting dynamic subtest: eDP-1
[85.416362] Dynamic subtest eDP-1: SKIP (1.395s)
[85.421052] Subtest psr2-primary-mmap-gtt: SKIP (1.396s)
[85.544461] [015/132] (933s left) vgem_basic (dmabuf-mmap)
[85.621234] Starting subtest: dmabuf-mmap
[85.628298] Subtest dmabuf-mmap: SUCCESS (0.009s)
[85.701813] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[85.705341] [016/132] (933s left) gem_exec_params (invalid-ring)
[85.756147] Starting subtest: invalid-ring
[85.758597] Subtest invalid-ring: SUCCESS (0.000s)
[85.848487] [017/132] (933s left) perf_pmu (gt-awake)
[85.894027] Starting subtest: gt-awake
[94.304775] Subtest gt-awake: SUCCESS (8.406s)
[94.426547] [018/132] (924s left) gem_exec_schedule (deep)
[94.609335] Starting subtest: deep
[94.611930] Starting dynamic subtest: rcs0
[100.920774] Dynamic subtest rcs0: SKIP (6.306s)
[100.933019] Starting dynamic subtest: vcs0
[111.115841] Dynamic subtest vcs0: SUCCESS (10.196s)
[111.130544] Starting dynamic subtest: vcs1
[122.026347] Dynamic subtest vcs1: SUCCESS (10.909s)
[122.041832] Starting dynamic subtest: vecs0
[132.877136] Dynamic subtest vecs0: SUCCESS (10.849s)
[132.891078] Starting dynamic subtest: ccs0
[144.970234] Dynamic subtest ccs0: SUCCESS (12.092s)
[144.972817] Subtest deep: SUCCESS (50.354s)
[146.019362] [019/132] (873s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[146.115783] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[146.118233] Starting dynamic subtest: pipe-A-eDP-1
[180.107366] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.834s)
[180.118702] Starting dynamic subtest: pipe-B-eDP-1
[215.022305] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.450s)
[215.034792] Starting dynamic subtest: pipe-C-eDP-1
[250.008625] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.562s)
[250.020190] Starting dynamic subtest: pipe-D-eDP-1
[285.002594] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.421s)
[285.005057] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.271s)
[295.242843] [020/132] (733s left) gem_ctx_bad_destroy (double-destroy)
[295.306251] Starting subtest: double-destroy
[295.308663] Subtest double-destroy: SUCCESS (0.000s)
[295.384969] [021/132] (733s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[295.445923] Starting subtest: single-wait-all-for-submit-available-submitted
[295.448722] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[295.543569] [022/132] (732s left) perf (unprivileged-single-ctx-counters)
[295.694802] Starting subtest: unprivileged-single-ctx-counters
[295.699356] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[295.770883] [023/132] (732s left) kms_flip (bo-too-big)
[295.872607] Starting subtest: bo-too-big
[295.875310] Starting dynamic subtest: A-eDP1
[297.213183] Dynamic subtest A-eDP1: SUCCESS (1.304s)
[297.227273] Starting dynamic subtest: B-eDP1
[298.575092] Dynamic subtest B-eDP1: SUCCESS (1.325s)
[298.589516] Starting dynamic subtest: C-eDP1
[299.942087] Dynamic subtest C-eDP1: SUCCESS (1.335s)
[299.956354] Starting dynamic subtest: D-eDP1
[301.304482] Dynamic subtest D-eDP1: SUCCESS (1.335s)
[301.310606] Subtest bo-too-big: SUCCESS (5.314s)
[302.529639] [024/132] (726s left) gem_mmap_gtt (basic-small-copy)
[302.584171] Subtest basic-small-copy: SKIP (0.000s)
[302.642785] [025/132] (726s left) gem_exec_params (sol-reset-not-gen7)
[302.700303] Starting subtest: sol-reset-not-gen7
[302.705576] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[302.817299] [026/132] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[302.914795] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[302.918854] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[303.021585] [027/132] (725s left) kms_atomic (atomic-plane-damage)
[303.110833] Starting subtest: atomic-plane-damage
[303.157378] Starting dynamic subtest: pipe-A-eDP-1
[303.697369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[303.699843] Subtest atomic-plane-damage: SUCCESS (0.579s)
[304.594285] [028/132] (724s left) kms_plane_scaling (invalid-parameters)
[304.687369] Starting subtest: invalid-parameters
[304.689940] Starting dynamic subtest: less-than-1-height-src
[304.700421] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[304.714731] Starting dynamic subtest: less-than-1-width-src
[304.717208] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s)
[304.719295] Subtest invalid-parameters: SUCCESS (0.029s)
[304.813520] [029/132] (724s left) sysfs_timeslice_duration (duration)
[304.863514] Starting subtest: duration
[304.865821] Starting dynamic subtest: vecs0
[319.889007] Dynamic subtest vecs0: SUCCESS (14.950s)
[319.902330] Starting dynamic subtest: ccs0
[333.057707] Dynamic subtest ccs0: SUCCESS (13.161s)
[333.071559] Starting dynamic subtest: vcs0
[346.893909] Dynamic subtest vcs0: SUCCESS (13.829s)
[346.906518] Starting dynamic subtest: bcs0
[360.046769] Dynamic subtest bcs0: SUCCESS (13.147s)
[360.059756] Starting dynamic subtest: rcs0
[373.190154] Dynamic subtest rcs0: SUCCESS (13.136s)
[373.202495] Starting dynamic subtest: vcs1
[387.917895] Dynamic subtest vcs1: SUCCESS (14.718s)
[387.920892] Subtest duration: SUCCESS (82.954s)
[388.009455] [030/132] (640s left) gem_exec_schedule (reorder-wide)
[388.194592] Subtest reorder-wide: SKIP (0.000s)
[388.381331] [031/132] (640s left) i915_selftest (live)
[390.191008] Starting subtest: live
[390.193170] Starting dynamic subtest: sanitycheck
[394.619538] Dynamic subtest sanitycheck: SUCCESS (4.429s)
[394.630251] Starting dynamic subtest: uncore
[399.057214] Dynamic subtest uncore: SUCCESS (4.438s)
[399.068093] Starting dynamic subtest: workarounds
[417.113035] Dynamic subtest workarounds: FAIL (17.584s)
[417.121685] Starting dynamic subtest: gt_engines
[421.323249] Dynamic subtest gt_engines: SUCCESS (4.682s)
[421.333961] Starting dynamic subtest: gt_timelines
[437.136225] Dynamic subtest gt_timelines: SUCCESS (15.810s)
[437.147156] Starting dynamic subtest: gt_contexts
[441.597869] Dynamic subtest gt_contexts: SUCCESS (4.460s)
[441.608452] Starting dynamic subtest: gt_lrc
[446.050401] Dynamic subtest gt_lrc: SUCCESS (4.451s)
[446.066636] Starting dynamic subtest: gt_mocs
[449.112461] Dynamic subtest gt_mocs: SUCCESS (3.058s)
[449.122953] Starting dynamic subtest: gt_pm
[456.045106] Dynamic subtest gt_pm: SUCCESS (6.931s)
[456.053990] Starting dynamic subtest: gt_heartbeat
[460.522967] Dynamic subtest gt_heartbeat: SUCCESS (4.474s)
[460.532164] Starting dynamic subtest: gt_tlb
[469.924240] Dynamic subtest gt_tlb: SUCCESS (9.397s)
[469.935133] Starting dynamic subtest: requests
[483.522577] Dynamic subtest requests: SUCCESS (13.593s)
[483.533452] Starting dynamic subtest: migrate
[491.424065] Dynamic subtest migrate: SUCCESS (7.896s)
[491.436975] Starting dynamic subtest: active
[495.887966] Dynamic subtest active: SUCCESS (4.461s)
[495.898710] Starting dynamic subtest: objects
[500.828766] Dynamic subtest objects: SUCCESS (4.937s)
[500.838356] Starting dynamic subtest: mman
[505.745959] Dynamic subtest mman: SUCCESS (4.913s)
[505.756053] Starting dynamic subtest: dmabuf
[510.211719] Dynamic subtest dmabuf: SUCCESS (4.462s)
[510.222526] Starting dynamic subtest: vma
[514.649770] Dynamic subtest vma: SUCCESS (4.435s)
[514.661081] Starting dynamic subtest: coherency
[520.284507] Dynamic subtest coherency: SUCCESS (5.632s)
[520.294145] Starting dynamic subtest: gtt
[532.299811] Dynamic subtest gtt: SUCCESS (12.017s)
[532.312586] Starting dynamic subtest: gem
[540.757139] Dynamic subtest gem: SUCCESS (8.457s)
[540.768598] Starting dynamic subtest: evict
[544.986845] Dynamic subtest evict: SUCCESS (4.229s)
[544.997821] Starting dynamic subtest: hugepages
[555.939344] Dynamic subtest hugepages: SUCCESS (10.952s)
[555.956894] Starting dynamic subtest: gem_contexts
[582.890550] Dynamic subtest gem_contexts: SUCCESS (26.949s)
[582.900984] Starting dynamic subtest: client
[587.336998] Dynamic subtest client: SUCCESS (4.444s)
[587.349618] Starting dynamic subtest: gem_migrate
[591.838335] Dynamic subtest gem_migrate: SUCCESS (4.499s)
[591.849376] Starting dynamic subtest: reset
[596.264075] Dynamic subtest reset: SUCCESS (4.423s)
[596.275321] Starting dynamic subtest: memory_region
[600.706346] Dynamic subtest memory_region: SUCCESS (4.440s)
[600.715202] Starting dynamic subtest: hangcheck
[614.020879] Dynamic subtest hangcheck: SUCCESS (13.312s)
[614.029377] Starting dynamic subtest: execlists
[618.475838] Dynamic subtest execlists: SUCCESS (4.451s)
[618.486854] Starting dynamic subtest: ring_submission
[622.926996] Dynamic subtest ring_submission: SUCCESS (4.449s)
[622.937353] Starting dynamic subtest: perf
[627.384221] Dynamic subtest perf: SUCCESS (4.455s)
[627.395535] Starting dynamic subtest: slpc
[639.582083] Dynamic subtest slpc: SUCCESS (12.195s)
[639.597823] Starting dynamic subtest: guc
[643.604397] Dynamic subtest guc: SUCCESS (4.021s)
[643.613670] Starting dynamic subtest: guc_multi_lrc
[646.425076] Dynamic subtest guc_multi_lrc: SUCCESS (2.817s)
[646.435919] Starting dynamic subtest: guc_hang
[651.457536] Dynamic subtest guc_hang: SUCCESS (5.030s)
[651.469279] Starting dynamic subtest: late_gt_pm
[655.897524] Dynamic subtest late_gt_pm: SUCCESS (4.437s)
[655.900154] Subtest live: FAIL (265.686s)
[655.931691] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[655.932519] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[655.935737] [032/132] (373s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[657.480772] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[657.580864] [FACT kms_addfb_basic (addfb25-x-tiled-legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[657.582531] [FACT kms_addfb_basic (addfb25-x-tiled-legacy)] new: kernel.kmod_is_loaded.i915: true
[657.586000] [033/132] (371s left) kms_psr (fbc-pr-no-drrs)
[657.680761] Starting subtest: fbc-pr-no-drrs
[657.685107] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[657.769280] [034/132] (371s left) kms_color (legacy-gamma)
[657.871822] Starting subtest: legacy-gamma
[657.874254] Starting dynamic subtest: pipe-A-eDP-1
[658.620034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[658.630189] Starting dynamic subtest: pipe-B-eDP-1
[660.073045] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.453s)
[660.082999] Starting dynamic subtest: pipe-C-eDP-1
[661.421081] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[661.431259] Starting dynamic subtest: pipe-D-eDP-1
[662.775609] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[662.778051] Subtest legacy-gamma: SUCCESS (4.904s)
[663.585193] [035/132] (365s left) gem_exec_reloc (basic-wc-cpu-active)
[663.642384] Subtest basic-wc-cpu-active: SKIP (0.000s)
[663.710461] [036/132] (365s left) gem_exec_fence (submit67)
[663.874520] Starting subtest: submit67
[663.879801] Subtest submit67: SKIP (0.000s)
[666.040308] [037/132] (363s left) perf_pmu (busy-accuracy-50)
[666.081755] Starting subtest: busy-accuracy-50
[666.084069] Starting dynamic subtest: rcs0
[667.630458] Dynamic subtest rcs0: SUCCESS (1.545s)
[667.642451] Starting dynamic subtest: bcs0
[669.183219] Dynamic subtest bcs0: SUCCESS (1.550s)
[669.194910] Starting dynamic subtest: vcs0
[670.726378] Dynamic subtest vcs0: SUCCESS (1.540s)
[670.738334] Starting dynamic subtest: vcs1
[672.268304] Dynamic subtest vcs1: SUCCESS (1.540s)
[672.281034] Starting dynamic subtest: vecs0
[673.811391] Dynamic subtest vecs0: SUCCESS (1.540s)
[673.822162] Starting dynamic subtest: ccs0
[675.357370] Dynamic subtest ccs0: SUCCESS (1.543s)
[675.359589] Subtest busy-accuracy-50: SUCCESS (9.272s)
[675.491004] [038/132] (353s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[675.591442] Starting subtest: blocking-absolute-wf_vblank-interruptible
[675.593728] Starting dynamic subtest: A-eDP1
[684.342209] Dynamic subtest A-eDP1: SUCCESS (8.746s)
[684.353410] Starting dynamic subtest: B-eDP1
[693.078268] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[693.090004] Starting dynamic subtest: C-eDP1
[701.809142] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[701.820710] Starting dynamic subtest: D-eDP1
[710.537814] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[710.543295] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.944s)
[711.765393] [039/132] (317s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[711.821789] Starting subtest: mixed-tiled-to-y-tiled-ccs
[711.826224] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[712.016458] [040/132] (317s left) api_intel_allocator (standalone)
[712.068809] Starting subtest: standalone
[712.084975] Subtest standalone: SUCCESS (0.018s)
[712.224101] [041/132] (317s left) gen7_exec_parse (chained-batch)
[712.278899] Subtest chained-batch: SKIP (0.000s)
[712.350833] [042/132] (317s left) perf (i915-ref-count)
[712.422117] Starting subtest: i915-ref-count
[712.479827] Subtest i915-ref-count: SUCCESS (0.059s)
[712.538938] [043/132] (316s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[712.659977] Starting subtest: cursorA-vs-flipB-toggle
[712.664596] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[712.805372] [044/132] (316s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[712.917861] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[712.922162] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[713.013839] [045/132] (316s left) kms_chamelium_color (ctm-max)
[713.114739] Subtest ctm-max: SKIP (0.000s)
[713.161277] [046/132] (316s left) syncobj_timeline (multi-wait-available-submitted)
[713.207444] Starting subtest: multi-wait-available-submitted
[713.209249] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[713.294656] [047/132] (316s left) gem_softpin (overlap)
[713.350694] Starting subtest: overlap
[714.277769] Subtest overlap: SUCCESS (0.925s)
[714.418660] [048/132] (315s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[714.798365] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[715.580620] [049/132] (314s left) kms_cursor_crc (cursor-random-128x42)
[715.802430] Starting subtest: cursor-random-128x42
[715.853810] Subtest cursor-random-128x42: SKIP (0.044s)
[716.056097] [050/132] (313s left) gem_exec_reloc (basic-gtt-noreloc)
[716.114558] Subtest basic-gtt-noreloc: SKIP (0.000s)
[716.183905] [051/132] (313s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[716.297209] Starting subtest: basic-flip-before-cursor-legacy
[717.217924] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.920s)
[718.032083] [052/132] (311s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[718.085533] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[718.188759] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[718.279186] [053/132] (311s left) sw_sync (sync_busy_fork_unixsocket)
[718.316346] Starting subtest: sync_busy_fork_unixsocket
[718.319454] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[718.375409] [054/132] (311s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[718.486245] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[722.616018] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.132s)
[723.751695] [055/132] (306s left) gem_ctx_shared (q-smoketest-all)
[723.816228] Starting subtest: Q-smoketest-all
[756.206976] Subtest Q-smoketest-all: SUCCESS (32.334s)
[757.983915] [056/132] (272s left) gem_ctx_persistence (process)
[758.041354] Starting subtest: process
[758.204353] Subtest process: SUCCESS (0.165s)
[758.288061] [057/132] (271s left) kms_rotation_crc (exhaust-fences)
[758.381228] Starting subtest: exhaust-fences
[758.385354] Subtest exhaust-fences: SKIP (0.000s)
[758.465971] [058/132] (271s left) kms_lease (lease-revoke)
[758.564472] Starting subtest: lease-revoke
[758.567348] Starting dynamic subtest: pipe-A-eDP-1
[758.595834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[758.608886] Starting dynamic subtest: pipe-B-eDP-1
[758.624918] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[758.639938] Starting dynamic subtest: pipe-C-eDP-1
[758.656534] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[758.667749] Starting dynamic subtest: pipe-D-eDP-1
[758.683369] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[758.685666] Subtest lease-revoke: SUCCESS (0.121s)
[758.820771] [059/132] (271s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[758.921327] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[758.924702] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[759.028771] [060/132] (271s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[759.128337] Starting subtest: bad-pixel-format-yf-tiled-ccs
[759.130325] Starting dynamic subtest: pipe-A-eDP-1
[759.149960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[759.163337] Starting dynamic subtest: pipe-B-eDP-1
[759.181712] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[759.192019] Starting dynamic subtest: pipe-C-eDP-1
[759.209797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[759.220002] Starting dynamic subtest: pipe-D-eDP-1
[759.238824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[759.242518] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[761.397514] [061/132] (268s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[761.485988] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[761.490066] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[761.595059] [062/132] (268s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[761.699254] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[761.703281] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[761.817991] [063/132] (268s left) i915_drm_fdinfo (memory-info-shared)
[761.855208] Starting subtest: memory-info-shared
[761.857310] Starting dynamic subtest: smem0
[761.898807] Dynamic subtest smem0: SUCCESS (0.044s)
[761.901223] Subtest memory-info-shared: SUCCESS (0.045s)
[761.975926] [064/132] (268s left) gem_exec_balancer (bonded-dual)
[762.036827] Starting subtest: bonded-dual
[762.041480] Subtest bonded-dual: SKIP (0.000s)
[762.336530] [065/132] (268s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[762.425774] Starting subtest: fbcpsr-modesetfrombusy
[768.600461] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.177s)
[768.743409] [066/132] (261s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[768.844359] Starting subtest: y-tiled-64bpp-rotate-0
[768.847978] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[768.948259] [067/132] (261s left) tools_test (tools_test)
[768.992119] Starting subtest: tools_test
[769.048569] Subtest tools_test: SUCCESS (0.069s)
[769.112907] [068/132] (261s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[769.203764] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[769.974951] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.772s)
[770.147884] [069/132] (260s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[770.209707] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[770.212058] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[770.317954] [070/132] (260s left) perf_pmu (semaphore-wait)
[770.356022] Starting subtest: semaphore-wait
[770.358380] Starting dynamic subtest: rcs0
[770.873236] Dynamic subtest rcs0: SUCCESS (0.516s)
[770.891015] Starting dynamic subtest: bcs0
[771.386111] Dynamic subtest bcs0: SUCCESS (0.510s)
[771.400963] Starting dynamic subtest: vcs0
[771.899098] Dynamic subtest vcs0: SUCCESS (0.510s)
[771.912877] Starting dynamic subtest: vcs1
[772.412769] Dynamic subtest vcs1: SUCCESS (0.510s)
[772.425581] Starting dynamic subtest: vecs0
[772.925546] Dynamic subtest vecs0: SUCCESS (0.510s)
[772.939196] Starting dynamic subtest: ccs0
[773.440929] Dynamic subtest ccs0: SUCCESS (0.512s)
[773.443769] Subtest semaphore-wait: SUCCESS (3.084s)
[773.594688] [071/132] (257s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[773.704103] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[774.339439] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[774.516259] [072/132] (256s left) kms_rotation_crc (primary-rotation-270)
[774.602892] Starting subtest: primary-rotation-270
[774.607324] Subtest primary-rotation-270: SKIP (0.001s)
[774.677115] [073/132] (256s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[774.768593] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[774.772812] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[774.859796] [074/132] (255s left) kms_psr (psr-sprite-mmap-gtt)
[774.950189] Starting subtest: psr-sprite-mmap-gtt
[774.952330] Starting dynamic subtest: eDP-1
[776.382664] Dynamic subtest eDP-1: SKIP (1.428s)
[776.387982] Subtest psr-sprite-mmap-gtt: SKIP (1.430s)
[776.575224] [075/132] (254s left) i915_hangman (hangcheck-unterminated)
[776.634779] Starting subtest: hangcheck-unterminated
[787.918535] Subtest hangcheck-unterminated: SUCCESS (11.279s)
[788.069066] [076/132] (242s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[788.173393] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[788.175621] Starting dynamic subtest: pipe-A-eDP-1
[788.194804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[788.206274] Starting dynamic subtest: pipe-B-eDP-1
[788.225067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[788.236060] Starting dynamic subtest: pipe-C-eDP-1
[788.254642] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[788.265061] Starting dynamic subtest: pipe-D-eDP-1
[788.284428] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[788.286668] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[790.494612] [077/132] (240s left) kms_panel_fitting (atomic-fastset)
[790.587540] Starting subtest: atomic-fastset
[790.589428] Starting dynamic subtest: pipe-A-eDP-1
[790.726970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[790.739230] Starting dynamic subtest: pipe-B-eDP-1
[791.955749] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s)
[791.971745] Starting dynamic subtest: pipe-C-eDP-1
[793.144347] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[793.156385] Starting dynamic subtest: pipe-D-eDP-1
[794.295632] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[794.298001] Subtest atomic-fastset: SUCCESS (3.709s)
[795.552704] [078/132] (235s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[795.645734] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[795.649978] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[795.756020] [079/132] (235s left) kms_draw_crc (draw-method-pwrite)
[795.853996] Starting subtest: draw-method-pwrite
[795.855915] Starting dynamic subtest: xrgb8888-untiled
[796.476311] Dynamic subtest xrgb8888-untiled: SUCCESS (0.623s)
[796.487634] Starting dynamic subtest: rgb565-untiled
[796.941623] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[796.952950] Starting dynamic subtest: xrgb2101010-untiled
[797.520452] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.578s)
[797.534379] Starting dynamic subtest: xbgr16161616f-untiled
[798.343198] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.819s)
[798.354816] Starting dynamic subtest: xrgb8888-xtiled
[800.242625] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.899s)
[800.254653] Starting dynamic subtest: rgb565-xtiled
[801.398465] Dynamic subtest rgb565-xtiled: SUCCESS (1.155s)
[801.410922] Starting dynamic subtest: xrgb2101010-xtiled
[803.298930] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.899s)
[803.310995] Starting dynamic subtest: xbgr16161616f-xtiled
[806.799782] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.499s)
[806.811575] Starting dynamic subtest: xrgb8888-4tiled
[807.966834] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.166s)
[807.978188] Starting dynamic subtest: rgb565-4tiled
[808.557254] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[808.568141] Starting dynamic subtest: xrgb2101010-4tiled
[809.711704] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.155s)
[809.723450] Starting dynamic subtest: xbgr16161616f-4tiled
[812.845834] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.132s)
[812.848182] Subtest draw-method-pwrite: SUCCESS (16.990s)
[812.945449] [080/132] (218s left) kms_vblank (wait-idle-hang)
[813.032149] Starting subtest: wait-idle-hang
[813.034113] Starting dynamic subtest: pipe-A-eDP-1
[839.726477] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.689s)
[839.745636] Starting dynamic subtest: pipe-D-eDP-1
[854.724246] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.989s)
[854.726130] Subtest wait-idle-hang: SUCCESS (41.683s)
[855.524981] [081/132] (175s left) gem_partial_pwrite_pread (write-uncached)
[855.583038] Subtest write-uncached: SKIP (0.000s)
[855.662617] [082/132] (175s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[855.783870] Starting subtest: cursorA-vs-flipA-legacy
[866.932568] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.143s)
[867.766420] [083/132] (163s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[867.857656] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[871.406148] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.551s)
[872.575316] [084/132] (158s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[872.676795] Starting subtest: 4-tiled-8bpp-rotate-0
[873.925717] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.250s)
[874.051620] [085/132] (157s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[874.145893] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[874.149549] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[874.265611] [086/132] (157s left) syncobj_timeline (multi-wait-all-available-signaled)
[874.321669] Starting subtest: multi-wait-all-available-signaled
[874.323812] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[874.434527] [087/132] (156s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[874.552556] Starting subtest: cursorA-vs-flipA-atomic
[885.692174] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.138s)
[886.501725] [088/132] (144s left) kms_invalid_mode (zero-vdisplay)
[886.587398] Starting subtest: zero-vdisplay
[886.589539] Starting dynamic subtest: pipe-A-eDP-1
[886.869398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[886.881511] Starting dynamic subtest: pipe-B-eDP-1
[886.883626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[886.894357] Starting dynamic subtest: pipe-C-eDP-1
[886.896616] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[886.908246] Starting dynamic subtest: pipe-D-eDP-1
[886.910690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[886.913190] Subtest zero-vdisplay: SUCCESS (0.290s)
[887.744951] [089/132] (143s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[887.845085] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[887.849293] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[887.941310] [090/132] (143s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[888.031441] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[888.033751] Starting dynamic subtest: pipe-A-eDP-1
[888.331120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.266s)
[888.343997] Starting dynamic subtest: pipe-B-eDP-1
[889.619666] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[889.633511] Starting dynamic subtest: pipe-C-eDP-1
[890.924632] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.306s)
[890.936217] Starting dynamic subtest: pipe-D-eDP-1
[892.139656] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[892.141713] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.078s)
[893.273186] [091/132] (138s left) kms_plane_scaling (planes-upscale-factor-0-25)
[893.365415] Starting subtest: planes-upscale-factor-0-25
[893.367736] Starting dynamic subtest: pipe-A
[893.426708] Dynamic subtest pipe-A: SUCCESS (0.063s)
[893.440452] Starting dynamic subtest: pipe-B
[894.595566] Dynamic subtest pipe-B: SUCCESS (1.167s)
[894.609869] Starting dynamic subtest: pipe-C
[895.719829] Dynamic subtest pipe-C: SUCCESS (1.123s)
[895.732282] Starting dynamic subtest: pipe-D
[896.856632] Dynamic subtest pipe-D: SUCCESS (1.136s)
[896.859178] Subtest planes-upscale-factor-0-25: SUCCESS (3.493s)
[898.015926] [092/132] (133s left) kms_prop_blob (blob-multiple)
[898.081217] Starting subtest: blob-multiple
[898.083646] Subtest blob-multiple: SUCCESS (0.003s)
[898.184945] [093/132] (133s left) kms_cursor_edge_walk (128x128-top-bottom)
[898.288569] Starting subtest: 128x128-top-bottom
[898.290712] Starting dynamic subtest: pipe-A-eDP-1
[901.765426] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[901.776698] Starting dynamic subtest: pipe-D-eDP-1
[904.888354] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[904.890265] Subtest 128x128-top-bottom: SUCCESS (6.597s)
[905.696558] [094/132] (125s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[905.793081] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[905.797213] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[905.867119] [095/132] (125s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[905.965172] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[905.969581] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[906.066536] [096/132] (125s left) gem_exec_reloc (basic-gtt-active)
[906.116966] Subtest basic-gtt-active: SKIP (0.000s)
[906.198049] [097/132] (125s left) gem_vm_create (execbuf)
[906.248213] Starting subtest: execbuf
[906.255701] Subtest execbuf: SUCCESS (0.007s)
[906.378884] [098/132] (125s left) gem_exec_store (pages)
[906.433466] Starting subtest: pages
[906.435829] Starting dynamic subtest: rcs0
[906.511385] Dynamic subtest rcs0: SUCCESS (0.079s)
[906.523986] Starting dynamic subtest: bcs0
[906.581020] Dynamic subtest bcs0: SUCCESS (0.069s)
[906.594314] Starting dynamic subtest: vcs0
[906.653301] Dynamic subtest vcs0: SUCCESS (0.072s)
[906.664128] Starting dynamic subtest: vcs1
[906.731048] Dynamic subtest vcs1: SUCCESS (0.076s)
[906.741820] Starting dynamic subtest: vecs0
[906.804116] Dynamic subtest vecs0: SUCCESS (0.072s)
[906.814332] Starting dynamic subtest: ccs0
[906.870475] Dynamic subtest ccs0: SUCCESS (0.064s)
[906.873120] Subtest pages: SUCCESS (0.440s)
[907.057272] [099/132] (124s left) gem_pipe_control_store_loop (reused-buffer)
[907.107966] Starting subtest: reused-buffer
[909.264962] Subtest reused-buffer: SUCCESS (2.154s)
[909.370605] [100/132] (122s left) kms_sequence (get-busy)
[909.467473] Starting subtest: get-busy
[909.469833] Starting dynamic subtest: pipe-A-eDP-1
[911.403145] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[911.415793] Starting dynamic subtest: pipe-B-eDP-1
[913.998260] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.593s)
[914.009718] Starting dynamic subtest: pipe-C-eDP-1
[916.610412] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[916.621637] Starting dynamic subtest: pipe-D-eDP-1
[919.141506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[919.143877] Subtest get-busy: SUCCESS (9.673s)
[919.955125] [101/132] (112s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[920.059550] Starting subtest: x-tiled-16bpp-rotate-90
[920.079422] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[920.194640] [102/132] (111s left) kms_psr (fbc-pr-primary-render)
[920.295703] Starting subtest: fbc-pr-primary-render
[920.300285] Subtest fbc-pr-primary-render: SKIP (0.000s)
[920.370982] [103/132] (111s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[920.471813] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[929.956547] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.486s)
[930.085814] [104/132] (102s left) kms_plane_alpha_blend (constant-alpha-mid)
[930.177260] Starting subtest: constant-alpha-mid
[930.462314] Starting dynamic subtest: pipe-A-eDP-1
[931.427357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.964s)
[931.439623] Starting dynamic subtest: pipe-D-eDP-1
[933.015086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.586s)
[933.017267] Subtest constant-alpha-mid: SUCCESS (2.840s)
[933.824606] [105/132] ( 98s left) gem_exec_schedule (noreorder)
[934.013973] Starting subtest: noreorder
[934.016255] Starting dynamic subtest: rcs0
[934.063210] Dynamic subtest rcs0: SUCCESS (0.052s)
[934.078172] Starting dynamic subtest: vcs0
[935.895176] Dynamic subtest vcs0: SUCCESS (1.829s)
[935.909301] Starting dynamic subtest: vcs1
[937.969702] Dynamic subtest vcs1: SUCCESS (2.071s)
[937.983816] Starting dynamic subtest: vecs0
[939.953079] Dynamic subtest vecs0: SUCCESS (1.980s)
[939.967392] Starting dynamic subtest: ccs0
[940.016322] Dynamic subtest ccs0: SUCCESS (0.063s)
[940.019030] Subtest noreorder: SUCCESS (6.004s)
[940.224504] [106/132] ( 92s left) gem_ctx_engines (invalid-engines)
[940.292078] Starting subtest: invalid-engines
[940.305161] Subtest invalid-engines: SUCCESS (0.013s)
[940.548108] [107/132] ( 91s left) i915_pm_rpm (reg-read-ioctl)
[942.087553] Starting subtest: reg-read-ioctl
[944.374843] Subtest reg-read-ioctl: SUCCESS (2.287s)
[944.758523] [108/132] ( 87s left) gem_ctx_param (invalid-get-no-zeromap)
[944.816424] Starting subtest: invalid-get-no-zeromap
[944.818880] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[944.937396] [109/132] ( 87s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[945.035918] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[952.489996] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.455s)
[952.618961] [110/132] ( 79s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[952.716261] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[952.718733] Starting dynamic subtest: pipe-A-default-mode
[955.490231] Dynamic subtest pipe-A-default-mode: SUCCESS (2.774s)
[955.493208] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.776s)
[956.335856] [111/132] ( 76s left) kms_flip_event_leak (basic)
[956.440826] Starting subtest: basic
[956.443112] Starting dynamic subtest: pipe-A-eDP-1
[956.860069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[956.873809] Starting dynamic subtest: pipe-B-eDP-1
[957.941267] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s)
[957.952520] Starting dynamic subtest: pipe-C-eDP-1
[959.072864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[959.084595] Starting dynamic subtest: pipe-D-eDP-1
[960.217159] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[960.219262] Subtest basic: SUCCESS (3.776s)
[961.079894] [112/132] ( 71s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[961.179381] Starting subtest: extended-pageflip-modeset-hang-oldfb
[961.181687] Starting dynamic subtest: pipe-A
[969.080526] Dynamic subtest pipe-A: SUCCESS (7.899s)
[969.092926] Starting dynamic subtest: pipe-D
[977.696307] Dynamic subtest pipe-D: SUCCESS (8.610s)
[977.698560] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.513s)
[978.561371] [113/132] ( 53s left) gem_lmem_swapping (parallel-random)
[978.601225] Subtest parallel-random: SKIP (0.000s)
[978.647137] [114/132] ( 53s left) kms_content_protection (atomic)
[978.787628] Starting subtest: atomic
[978.791870] Subtest atomic: SKIP (0.000s)
[978.914353] [115/132] ( 53s left) kms_flip (2x-blocking-absolute-wf_vblank)
[979.012020] Starting subtest: 2x-blocking-absolute-wf_vblank
[979.023866] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[979.119787] [116/132] ( 53s left) gem_mmap_offset (blt-coherency)
[979.172201] Starting subtest: blt-coherency
[979.179296] Subtest blt-coherency: SUCCESS (0.009s)
[979.313566] [117/132] ( 53s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[979.375553] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[979.435847] [118/132] ( 53s left) syncobj_wait (invalid-signal-bad-pad)
[979.480427] Starting subtest: invalid-signal-bad-pad
[979.482077] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[979.602033] [119/132] ( 53s left) syncobj_eventfd (invalid-bad-pad)
[979.664583] Starting subtest: invalid-bad-pad
[979.666459] Subtest invalid-bad-pad: SUCCESS (0.000s)
[979.771613] [120/132] ( 53s left) device_reset (unbind-cold-reset-rebind)
[979.821030] Starting subtest: unbind-cold-reset-rebind
[979.824538] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[979.907482] [121/132] ( 52s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[980.000804] Starting subtest: fbc-psr-cursor-mmap-gtt
[980.002749] Starting dynamic subtest: eDP-1
[980.006309] Dynamic subtest eDP-1: SKIP (0.000s)
[980.009912] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[980.074816] [122/132] ( 52s left) kms_chamelium_frames (dp-crc-multiple)
[980.449401] Subtest dp-crc-multiple: SKIP (0.000s)
[981.264347] [123/132] ( 51s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[981.365557] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[981.369607] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[981.425381] [124/132] ( 51s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[981.517141] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[981.521382] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[981.611470] [125/132] ( 51s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[981.701227] Starting subtest: yf-tiled-64bpp-rotate-0
[981.706003] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[981.823771] [126/132] ( 51s left) gem_exec_params (no-vebox)
[981.881590] Starting subtest: no-vebox
[981.886466] Subtest no-vebox: SUCCESS (0.003s)
[983.972700] [127/132] ( 49s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[984.071107] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[984.075584] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[984.148560] [128/132] ( 49s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[984.204148] Starting subtest: y-tiled-to-vebox-y-tiled
[984.208098] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[984.389972] [129/132] ( 48s left) gem_media_vme
[984.516751] [130/132] ( 48s left) gem_busy (extended)
[984.698122] Starting subtest: extended
[984.700747] Starting dynamic subtest: rcs0
[984.790217] Dynamic subtest rcs0: SUCCESS (0.092s)
[984.803401] Starting dynamic subtest: bcs0
[984.834245] Dynamic subtest bcs0: SUCCESS (0.042s)
[984.849185] Starting dynamic subtest: vcs0
[985.968679] Dynamic subtest vcs0: SUCCESS (1.129s)
[985.982376] Starting dynamic subtest: vcs1
[987.952130] Dynamic subtest vcs1: SUCCESS (1.981s)
[987.966673] Starting dynamic subtest: vecs0
[989.935826] Dynamic subtest vecs0: SUCCESS (1.981s)
[989.949815] Starting dynamic subtest: ccs0
[989.982386] Dynamic subtest ccs0: SUCCESS (0.045s)
[989.984809] Subtest extended: SUCCESS (5.284s)
[990.214416] [131/132] ( 43s left) perf (buffer-fill)
[990.306172] Starting subtest: buffer-fill
[990.308580] Starting dynamic subtest: 0-rcs0
[992.608559] Dynamic subtest 0-rcs0: SUCCESS (2.300s)
[992.622404] Starting dynamic subtest: 1-vcs1
[997.061149] Dynamic subtest 1-vcs1: SUCCESS (4.449s)
[997.063452] Subtest buffer-fill: SUCCESS (6.752s)
[997.114795] [132/132] ( 36s left) api_intel_bb (object-noreloc-keep-cache-simple)
[997.168547] Starting subtest: object-noreloc-keep-cache-simple
[997.175220] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[997.270039] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_ctx_bad_destroy
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_atomic
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: sysfs_timeslice_duration
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: i915_selftest
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: api_intel_allocator
results: parsing output: 40/ for test: gen7_exec_parse
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: kms_chamelium_color
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ctx_shared
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: tools_test
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: i915_hangman
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_panel_fitting
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_draw_crc
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_invalid_mode
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_prop_blob
results: parsing output: 92/ for test: kms_cursor_edge_walk
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gem_vm_create
results: parsing output: 97/ for test: gem_exec_store
results: parsing output: 98/ for test: gem_pipe_control_store_loop
results: parsing output: 99/ for test: kms_sequence
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_alpha_blend
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_ctx_engines
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: gem_ctx_param
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: kms_flip_event_leak
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: syncobj_eventfd
results: parsing output: 119/ for test: device_reset
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_chamelium_frames
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: gem_media_vme
results: parsing output: 129/ for test: gem_busy
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: api_intel_bb
Done.