[56.176486] Initializing watchdogs
[56.176531]   /dev/watchdog0
[56.190933] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.195713] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.197901] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.201537] [001/156] (960s left) gem_partial_pwrite_pread (reads-uncached)
[56.284682] Subtest reads-uncached: SKIP (0.000s)
[56.343632] [002/156] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[56.398973] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[56.508597] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[56.591773] [003/156] (960s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[56.707883] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[56.712023] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[56.814469] [004/156] (959s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[56.897823] Starting subtest: primary-4-tiled-reflect-x-180
[63.945261] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.017s)
[65.215109] [005/156] (951s left) i915_query (query-regions-sanity-check)
[65.277874] Starting subtest: query-regions-sanity-check
[65.286823] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[65.408640] [006/156] (951s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[65.465961] Starting subtest: invalid-bsd2-flag-on-vebox
[65.468260] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[65.591836] [007/156] (951s left) gem_userptr_blits (sync-unmap-after-close)
[65.664215] Starting subtest: sync-unmap-after-close
[65.675768] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[65.798244] [008/156] (951s left) gem_mmap_offset (bad-object)
[65.854890] Starting subtest: bad-object
[65.857543] Subtest bad-object: SUCCESS (0.001s)
[65.965144] [009/156] (951s left) gem_exec_store (cachelines)
[66.023743] Starting subtest: cachelines
[66.025957] Starting dynamic subtest: rcs0
[66.094479] Dynamic subtest rcs0: SUCCESS (0.073s)
[66.103895] Starting dynamic subtest: bcs0
[66.151912] Dynamic subtest bcs0: SUCCESS (0.057s)
[66.162253] Starting dynamic subtest: vcs0
[67.267241] Dynamic subtest vcs0: SUCCESS (1.109s)
[67.277607] Starting dynamic subtest: vcs1
[67.324763] Dynamic subtest vcs1: SUCCESS (0.058s)
[67.333200] Starting dynamic subtest: vecs0
[67.384294] Dynamic subtest vecs0: SUCCESS (0.059s)
[67.397627] Starting dynamic subtest: ccs0
[67.447930] Dynamic subtest ccs0: SUCCESS (0.063s)
[67.450535] Subtest cachelines: SUCCESS (1.424s)
[67.626078] [010/156] (949s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[67.729767] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[67.734325] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[67.833641] [011/156] (949s left) kms_vblank (accuracy-idle)
[67.914735] Starting subtest: accuracy-idle
[67.916688] Starting dynamic subtest: pipe-A-eDP-1
[69.669791] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[69.683982] Starting dynamic subtest: pipe-D-eDP-1
[72.139222] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.465s)
[72.141617] Subtest accuracy-idle: SUCCESS (4.220s)
[72.984834] [012/156] (944s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[73.148360] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[73.152956] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[73.273753] [013/156] (943s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[73.359357] Starting subtest: multi-wait-all-available-submitted-signaled
[73.361936] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[73.531212] [014/156] (943s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[73.694893] Starting subtest: basic-max-pipe-crc-check
[73.699473] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[73.740215] [015/156] (943s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-pwrite)
[73.836239] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-pwrite
[73.840587] Subtest fbchdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[73.941082] [016/156] (943s left) kms_flip (dpms-vs-vblank-race)
[74.038977] Starting subtest: dpms-vs-vblank-race
[74.041033] Starting dynamic subtest: A-eDP1
[78.011887] Dynamic subtest A-eDP1: SUCCESS (3.969s)
[78.021080] Starting dynamic subtest: B-eDP1
[81.621791] Dynamic subtest B-eDP1: SUCCESS (3.608s)
[81.631203] Starting dynamic subtest: C-eDP1
[85.141843] Dynamic subtest C-eDP1: SUCCESS (3.520s)
[85.151354] Starting dynamic subtest: D-eDP1
[89.783282] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[89.785602] Subtest dpms-vs-vblank-race: SUCCESS (15.742s)
[90.673203] [017/156] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[90.773967] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[90.778274] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[90.851499] [018/156] (926s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[90.956699] Starting subtest: psrhdr-1p-rte
[90.960821] Subtest psrhdr-1p-rte: SKIP (0.000s)
[91.083237] [019/156] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[91.179292] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[98.111412] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.936s)
[98.256158] [020/156] (919s left) gem_ctx_shared (exec-single-timeline)
[98.326108] Starting subtest: exec-single-timeline
[98.328604] Starting dynamic subtest: rcs0
[99.357274] Dynamic subtest rcs0: SUCCESS (1.029s)
[99.369163] Starting dynamic subtest: bcs0
[100.446772] Dynamic subtest bcs0: SUCCESS (1.087s)
[100.458021] Starting dynamic subtest: vcs0
[101.533883] Dynamic subtest vcs0: SUCCESS (1.087s)
[101.542855] Starting dynamic subtest: vcs1
[102.622301] Dynamic subtest vcs1: SUCCESS (1.086s)
[102.632482] Starting dynamic subtest: vecs0
[103.709482] Dynamic subtest vecs0: SUCCESS (1.085s)
[103.722697] Starting dynamic subtest: ccs0
[104.797389] Dynamic subtest ccs0: SUCCESS (1.087s)
[104.800099] Subtest exec-single-timeline: SUCCESS (6.470s)
[104.982555] [021/156] (912s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[105.089162] Starting subtest: psr2-cursor-plane-move-continuous-sf
[105.091467] Starting dynamic subtest: pipe-A-eDP-1
[115.431539] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.342s)
[115.439666] Starting dynamic subtest: pipe-B-eDP-1
[126.535467] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.104s)
[126.537996] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.448s)
[127.430787] [022/156] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[127.537631] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[132.074804] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.544s)
[133.228598] [023/156] (884s left) gem_exec_schedule (implicit-read-write)
[133.293534] Starting subtest: implicit-read-write
[133.295382] Starting dynamic subtest: rcs0
[133.393481] Dynamic subtest rcs0: SUCCESS (0.108s)
[133.404764] Starting dynamic subtest: vcs0
[133.474567] Dynamic subtest vcs0: SUCCESS (0.081s)
[133.485449] Starting dynamic subtest: vcs1
[133.553249] Dynamic subtest vcs1: SUCCESS (0.078s)
[133.565402] Starting dynamic subtest: vecs0
[133.631890] Dynamic subtest vecs0: SUCCESS (0.079s)
[133.643853] Starting dynamic subtest: ccs0
[133.710856] Dynamic subtest ccs0: SUCCESS (0.078s)
[133.713184] Subtest implicit-read-write: SUCCESS (0.427s)
[135.380855] [024/156] (882s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[135.483688] Starting subtest: y-tiled-64bpp-rotate-90
[135.488134] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[135.571500] [025/156] (882s left) perf (short-reads)
[135.694797] Starting subtest: short-reads
[135.712313] Subtest short-reads: SUCCESS (0.018s)
[135.748230] [026/156] (881s left) syncobj_wait (wait-all-interrupted)
[135.801573] Starting subtest: wait-all-interrupted
[135.909081] Subtest wait-all-interrupted: SUCCESS (0.106s)
[135.980578] [027/156] (881s left) kms_pm_backlight (fade)
[136.077892] Starting subtest: fade
[136.127931] Starting dynamic subtest: eDP-1
[139.134305] Dynamic subtest eDP-1: SUCCESS (3.004s)
[139.136983] Subtest fade: SUCCESS (3.055s)
[139.959550] [028/156] (877s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[140.057251] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[140.061464] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[140.159394] [029/156] (877s left) gem_exec_schedule (pi-userfault)
[140.333799] Starting subtest: pi-userfault
[140.336266] Starting dynamic subtest: rcs0
[140.341168] Dynamic subtest rcs0: SUCCESS (0.009s)
[140.352179] Starting dynamic subtest: bcs0
[140.354318] Dynamic subtest bcs0: SUCCESS (0.011s)
[140.363454] Starting dynamic subtest: vcs0
[140.365463] Dynamic subtest vcs0: SUCCESS (0.007s)
[140.374222] Starting dynamic subtest: vcs1
[140.376476] Dynamic subtest vcs1: SUCCESS (0.012s)
[140.384420] Starting dynamic subtest: vecs0
[140.386209] Dynamic subtest vecs0: SUCCESS (0.010s)
[140.393571] Starting dynamic subtest: ccs0
[140.395806] Dynamic subtest ccs0: SUCCESS (0.013s)
[140.398047] Subtest pi-userfault: SUCCESS (0.064s)
[140.573249] [030/156] (877s left) perf_pmu (init-wait)
[140.617194] Starting subtest: init-wait
[140.619542] Starting dynamic subtest: rcs0
[140.621964] Dynamic subtest rcs0: SUCCESS (0.002s)
[140.631500] Starting dynamic subtest: bcs0
[140.633373] Dynamic subtest bcs0: SUCCESS (0.001s)
[140.641233] Starting dynamic subtest: vcs0
[140.643413] Dynamic subtest vcs0: SUCCESS (0.001s)
[140.651109] Starting dynamic subtest: vcs1
[140.653254] Dynamic subtest vcs1: SUCCESS (0.000s)
[140.660989] Starting dynamic subtest: vecs0
[140.663213] Dynamic subtest vecs0: SUCCESS (0.000s)
[140.670620] Starting dynamic subtest: ccs0
[140.672860] Dynamic subtest ccs0: SUCCESS (0.000s)
[140.675150] Subtest init-wait: SUCCESS (0.006s)
[140.742045] [031/156] (877s left) i915_pm_rpm (gem-mmap-type)
[142.473991] Starting subtest: gem-mmap-type
[142.476751] Starting dynamic subtest: wb-smem0
[146.145048] Dynamic subtest wb-smem0: SUCCESS (3.672s)
[146.154927] Starting dynamic subtest: wc-smem0
[149.326492] Dynamic subtest wc-smem0: SUCCESS (3.181s)
[149.339048] Starting dynamic subtest: uc-smem0
[152.527387] Dynamic subtest uc-smem0: SUCCESS (3.201s)
[152.529630] Subtest gem-mmap-type: SUCCESS (10.057s)
[152.609531] [032/156] (865s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[152.715169] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[152.719602] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[152.808606] [033/156] (865s left) kms_psr (fbc-psr-primary-page-flip)
[152.906300] Starting subtest: fbc-psr-primary-page-flip
[152.908471] Starting dynamic subtest: eDP-1
[152.912727] Dynamic subtest eDP-1: SKIP (0.000s)
[152.917313] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[152.984896] [034/156] (865s left) kms_color (ctm-green-to-red)
[153.088099] Starting subtest: ctm-green-to-red
[153.089945] Starting dynamic subtest: pipe-A-eDP-1
[153.778242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s)
[153.786635] Starting dynamic subtest: pipe-B-eDP-1
[155.166985] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[155.174878] Starting dynamic subtest: pipe-C-eDP-1
[156.517663] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s)
[156.527100] Starting dynamic subtest: pipe-D-eDP-1
[157.871698] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[157.873834] Subtest ctm-green-to-red: SUCCESS (4.784s)
[158.703490] [035/156] (859s left) kms_psr (psr2-primary-mmap-gtt)
[158.802106] Starting subtest: psr2-primary-mmap-gtt
[158.804403] Starting dynamic subtest: eDP-1
[160.201893] Dynamic subtest eDP-1: SKIP (1.397s)
[160.206925] Subtest psr2-primary-mmap-gtt: SKIP (1.398s)
[160.342465] [036/156] (857s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[160.443193] Starting subtest: psr-rgb565-draw-blt
[167.463577] Subtest psr-rgb565-draw-blt: SUCCESS (7.026s)
[167.584057] [037/156] (850s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[167.690111] Starting subtest: fbc-pr-cursor-plane-update-sf
[167.694221] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[167.753502] [038/156] (850s left) gem_eio (in-flight-contexts-10ms)
[167.971205] Starting subtest: in-flight-contexts-10ms
[179.300435] Subtest in-flight-contexts-10ms: SUCCESS (11.328s)
[179.459633] [039/156] (838s left) gem_ctx_exec (basic-close-race)
[179.527506] Starting subtest: basic-close-race
[185.111896] Subtest basic-close-race: SUCCESS (5.584s)
[185.237374] [040/156] (833s left) sriov_basic (enable-vfs-autoprobe-off)
[185.294850] Starting subtest: enable-vfs-autoprobe-off
[185.297132] Starting dynamic subtest: numvfs-1
[185.369640] Dynamic subtest numvfs-1: FAIL (0.015s)
[185.379065] Starting dynamic subtest: numvfs-2
[185.452082] Dynamic subtest numvfs-2: FAIL (0.004s)
[185.462251] Starting dynamic subtest: numvfs-3
[185.534736] Dynamic subtest numvfs-3: FAIL (0.004s)
[185.544067] Starting dynamic subtest: numvfs-4
[185.616693] Dynamic subtest numvfs-4: FAIL (0.004s)
[185.627212] Starting dynamic subtest: numvfs-5
[185.699807] Dynamic subtest numvfs-5: FAIL (0.004s)
[185.709877] Starting dynamic subtest: numvfs-6
[185.783296] Dynamic subtest numvfs-6: FAIL (0.003s)
[185.792626] Starting dynamic subtest: numvfs-7
[185.863940] Dynamic subtest numvfs-7: FAIL (0.004s)
[185.872737] Starting dynamic subtest: numvfs-random
[185.941674] Dynamic subtest numvfs-random: FAIL (0.003s)
[185.950049] Starting dynamic subtest: numvfs-all
[186.019204] Dynamic subtest numvfs-all: FAIL (0.507s)
[186.021416] Subtest enable-vfs-autoprobe-off: FAIL (0.555s)
[186.056318] [041/156] (832s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[186.152820] Starting subtest: fbcpsr-suspend
[226.614759] Subtest fbcpsr-suspend: SUCCESS (10.180s)
[226.740726] [042/156] (791s left) gem_ctx_persistence (engines-hostile)
[226.806054] Starting subtest: engines-hostile
[226.808568] Starting dynamic subtest: rcs0
[226.921155] Dynamic subtest rcs0: SUCCESS (0.114s)
[226.933059] Starting dynamic subtest: bcs0
[226.961397] Dynamic subtest bcs0: SUCCESS (0.038s)
[226.971302] Starting dynamic subtest: vcs0
[227.061182] Dynamic subtest vcs0: SUCCESS (0.097s)
[227.072223] Starting dynamic subtest: vcs1
[227.153953] Dynamic subtest vcs1: SUCCESS (0.090s)
[227.165835] Starting dynamic subtest: vecs0
[227.246137] Dynamic subtest vecs0: SUCCESS (0.089s)
[227.259193] Starting dynamic subtest: ccs0
[227.316429] Dynamic subtest ccs0: SUCCESS (0.068s)
[227.318841] Subtest engines-hostile: SUCCESS (0.507s)
[227.450125] [043/156] (790s left) kms_pm_rpm (basic-rte)
[227.491879] Starting subtest: basic-rte
[231.156937] Subtest basic-rte: SUCCESS (3.644s)
[232.668385] [044/156] (785s left) gem_ctx_persistence (legacy-engines-hostile)
[232.732575] Starting subtest: legacy-engines-hostile
[232.734785] Starting dynamic subtest: render
[232.877279] Dynamic subtest render: SUCCESS (0.146s)
[232.889643] Starting dynamic subtest: bsd1
[232.986664] Dynamic subtest bsd1: SUCCESS (0.106s)
[233.005564] Starting dynamic subtest: bsd2
[233.075940] Dynamic subtest bsd2: SUCCESS (0.087s)
[233.090655] Starting dynamic subtest: blt
[233.165212] Dynamic subtest blt: SUCCESS (0.086s)
[233.178090] Starting dynamic subtest: vebox
[233.257966] Dynamic subtest vebox: SUCCESS (0.090s)
[233.260592] Subtest legacy-engines-hostile: SUCCESS (0.527s)
[233.336188] [045/156] (785s left) kms_getfb (getfb2-into-addfb2)
[233.424587] Starting subtest: getfb2-into-addfb2
[233.426947] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[233.523070] [046/156] (784s left) gem_exec_fence (concurrent)
[233.704370] Starting subtest: concurrent
[233.709176] Subtest concurrent: SKIP (0.000s)
[235.638290] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[235.642171] [047/156] (782s left) syncobj_timeline (transfer-timeline-point)
[235.692390] Starting subtest: transfer-timeline-point
[235.694732] Subtest transfer-timeline-point: SUCCESS (0.001s)
[235.802840] [048/156] (782s left) syncobj_eventfd (timeline-wait-before-signal)
[235.855789] Starting subtest: timeline-wait-before-signal
[235.885466] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[235.959886] [049/156] (782s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[236.053136] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[236.057599] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[236.142202] [050/156] (782s left) kms_flip (flip-vs-blocking-wf-vblank)
[236.232035] Starting subtest: flip-vs-blocking-wf-vblank
[236.234031] Starting dynamic subtest: A-eDP1
[245.232445] Dynamic subtest A-eDP1: SUCCESS (8.986s)
[245.243992] Starting dynamic subtest: B-eDP1
[254.178109] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[254.189799] Starting dynamic subtest: C-eDP1
[263.096821] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[263.109877] Starting dynamic subtest: D-eDP1
[272.033945] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[272.035893] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.789s)
[273.279262] [051/156] (745s left) kms_plane_multiple (tiling-y)
[273.363632] Starting subtest: tiling-y
[273.368033] Subtest tiling-y: SKIP (0.000s)
[273.436392] [052/156] (745s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[273.527854] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[273.532093] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[273.635980] [053/156] (745s left) kms_atomic_interruptible (universal-setplane-primary)
[273.737551] Starting subtest: universal-setplane-primary
[273.739941] Starting dynamic subtest: pipe-A-eDP-1
[281.200757] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.462s)
[281.203136] Subtest universal-setplane-primary: SUCCESS (7.463s)
[282.026959] [054/156] (736s left) i915_hangman (engine-engine-error)
[282.090745] Starting subtest: engine-engine-error
[282.092690] Starting dynamic subtest: rcs0
[283.524602] Dynamic subtest rcs0: SUCCESS (1.434s)
[283.534161] Starting dynamic subtest: bcs0
[285.507403] Dynamic subtest bcs0: SUCCESS (1.980s)
[285.521568] Starting dynamic subtest: vcs0
[287.491926] Dynamic subtest vcs0: SUCCESS (1.981s)
[287.506533] Starting dynamic subtest: vcs1
[289.477713] Dynamic subtest vcs1: SUCCESS (1.983s)
[289.490710] Starting dynamic subtest: vecs0
[291.525523] Dynamic subtest vecs0: SUCCESS (2.044s)
[291.537967] Starting dynamic subtest: ccs0
[293.506684] Dynamic subtest ccs0: SUCCESS (1.978s)
[293.509651] Subtest engine-engine-error: SUCCESS (11.416s)
[293.587770] [055/156] (725s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[293.681050] Starting subtest: plane-downscale-factor-0-75-with-rotation
[293.683366] Starting dynamic subtest: pipe-A
[293.921227] Dynamic subtest pipe-A: SUCCESS (0.241s)
[293.932705] Starting dynamic subtest: pipe-B
[295.205496] Dynamic subtest pipe-B: SUCCESS (1.283s)
[295.215565] Starting dynamic subtest: pipe-C
[296.533038] Dynamic subtest pipe-C: SUCCESS (1.326s)
[296.544642] Starting dynamic subtest: pipe-D
[297.873960] Dynamic subtest pipe-D: SUCCESS (1.340s)
[297.876383] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.194s)
[299.065667] [056/156] (719s left) perf (invalid-oa-exponent)
[299.146927] Starting subtest: invalid-oa-exponent
[299.161277] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[299.202544] [057/156] (719s left) gem_exec_schedule (semaphore-power)
[299.381992] Subtest semaphore-power: SKIP (0.000s)
[299.559746] [058/156] (719s left) kms_atomic (plane-cursor-legacy)
[299.659511] Starting subtest: plane-cursor-legacy
[299.661785] Starting dynamic subtest: pipe-A-eDP-1
[300.041416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s)
[300.043650] Subtest plane-cursor-legacy: SUCCESS (0.382s)
[300.895670] [059/156] (718s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[300.983404] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[300.985628] Starting dynamic subtest: pipe-A-eDP-1
[300.994980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[301.007172] Starting dynamic subtest: pipe-B-eDP-1
[301.015948] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[301.025487] Starting dynamic subtest: pipe-C-eDP-1
[301.034018] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[301.043488] Starting dynamic subtest: pipe-D-eDP-1
[301.051957] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[301.056067] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[303.265275] [060/156] (715s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[303.382390] Starting subtest: verify-pxp-key-change-after-suspend-resume
[310.548410] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.166s)
[310.698323] [061/156] (708s left) perf_pmu (busy-accuracy-2)
[310.744519] Starting subtest: busy-accuracy-2
[310.746733] Starting dynamic subtest: rcs0
[313.785432] Dynamic subtest rcs0: SUCCESS (3.041s)
[313.795601] Starting dynamic subtest: bcs0
[316.845597] Dynamic subtest bcs0: SUCCESS (3.056s)
[316.856176] Starting dynamic subtest: vcs0
[319.893762] Dynamic subtest vcs0: SUCCESS (3.044s)
[319.910739] Starting dynamic subtest: vcs1
[322.938862] Dynamic subtest vcs1: SUCCESS (3.043s)
[322.950130] Starting dynamic subtest: vecs0
[325.984587] Dynamic subtest vecs0: SUCCESS (3.044s)
[325.995743] Starting dynamic subtest: ccs0
[329.045567] Dynamic subtest ccs0: SUCCESS (3.057s)
[329.047933] Subtest busy-accuracy-2: SUCCESS (18.301s)
[329.186092] [062/156] (689s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[329.299522] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[329.303959] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[329.388650] [063/156] (689s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[329.470804] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[329.481936] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[329.564109] [064/156] (689s left) kms_flip (nonexisting-fb)
[329.661971] Starting subtest: nonexisting-fb
[329.664324] Starting dynamic subtest: A-eDP1
[330.828698] Dynamic subtest A-eDP1: SUCCESS (1.168s)
[330.841063] Starting dynamic subtest: B-eDP1
[331.962192] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[331.973545] Starting dynamic subtest: C-eDP1
[333.089573] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[333.103769] Starting dynamic subtest: D-eDP1
[334.234736] Dynamic subtest D-eDP1: SUCCESS (1.144s)
[334.239734] Subtest nonexisting-fb: SUCCESS (4.581s)
[335.410823] [065/156] (683s left) prime_self_import (basic-llseek-size)
[335.450728] Starting subtest: basic-llseek-size
[335.476779] Subtest basic-llseek-size: SUCCESS (0.027s)
[335.591114] [066/156] (683s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[335.688838] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[335.692955] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[335.776196] [067/156] (683s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[335.863463] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[335.865691] Starting dynamic subtest: pipe-A-eDP-1
[335.888561] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[335.911113] Starting dynamic subtest: pipe-B-eDP-1
[335.934994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[335.956846] Starting dynamic subtest: pipe-C-eDP-1
[335.979441] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.000484] Starting dynamic subtest: pipe-D-eDP-1
[336.024175] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.028388] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[338.190263] [068/156] (681s left) kms_big_fb (linear-32bpp-rotate-270)
[338.301282] Starting subtest: linear-32bpp-rotate-270
[338.321166] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[338.450069] [069/156] (680s left) kms_flip (basic-flip-vs-modeset)
[338.538590] Starting subtest: basic-flip-vs-modeset
[338.540747] Starting dynamic subtest: A-eDP1
[341.107211] Dynamic subtest A-eDP1: SUCCESS (2.566s)
[341.118118] Starting dynamic subtest: B-eDP1
[343.281042] Dynamic subtest B-eDP1: SUCCESS (2.173s)
[343.291953] Starting dynamic subtest: C-eDP1
[345.447824] Dynamic subtest C-eDP1: SUCCESS (2.168s)
[345.459015] Starting dynamic subtest: D-eDP1
[347.616119] Dynamic subtest D-eDP1: SUCCESS (2.163s)
[347.618543] Subtest basic-flip-vs-modeset: SUCCESS (9.079s)
[348.441312] [070/156] (671s left) api_intel_allocator (fork-simple-stress-signal)
[348.494443] Starting subtest: fork-simple-stress-signal
[353.899183] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[354.009274] [071/156] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[354.127257] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[354.131670] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[354.239437] [072/156] (665s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[354.351788] Starting subtest: x-tiled-16bpp-rotate-0
[355.685982] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.335s)
[355.827566] [073/156] (663s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[355.934489] Starting subtest: primary-yf-tiled-reflect-x-180
[355.994172] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[356.106262] [074/156] (663s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[356.208425] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[356.211826] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[356.320122] [075/156] (663s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[356.424894] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[356.428574] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[356.524777] [076/156] (663s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[356.615055] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[356.618479] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[356.689667] [077/156] (663s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[356.748965] Subtest tiled-to-untiled: SKIP (0.000s)
[356.866873] [078/156] (663s left) gem_eio (in-flight-internal-1us)
[357.088511] Starting subtest: in-flight-internal-1us
[358.568755] Subtest in-flight-internal-1us: SUCCESS (1.479s)
[358.695519] [079/156] (661s left) gem_pipe_control_store_loop (reused-buffer)
[358.749656] Starting subtest: reused-buffer
[360.903858] Subtest reused-buffer: SUCCESS (2.152s)
[361.013548] [080/156] (658s left) kms_draw_crc (draw-method-mmap-wc)
[361.099415] Starting subtest: draw-method-mmap-wc
[361.101558] Starting dynamic subtest: xrgb8888-untiled
[361.353132] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[361.363198] Starting dynamic subtest: rgb565-untiled
[361.575269] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[361.585518] Starting dynamic subtest: xrgb2101010-untiled
[361.797995] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[361.811145] Starting dynamic subtest: xbgr16161616f-untiled
[362.030405] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[362.040155] Starting dynamic subtest: xrgb8888-xtiled
[362.153015] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[362.164568] Starting dynamic subtest: rgb565-xtiled
[362.275155] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[362.285857] Starting dynamic subtest: xrgb2101010-xtiled
[362.397484] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[362.410099] Starting dynamic subtest: xbgr16161616f-xtiled
[362.519631] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[362.529547] Starting dynamic subtest: xrgb8888-4tiled
[362.675261] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[362.687123] Starting dynamic subtest: rgb565-4tiled
[362.808724] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[362.821267] Starting dynamic subtest: xrgb2101010-4tiled
[362.953367] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[362.963067] Starting dynamic subtest: xbgr16161616f-4tiled
[363.130970] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[363.132973] Subtest draw-method-mmap-wc: SUCCESS (2.034s)
[363.237040] [081/156] (656s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[363.324735] Starting subtest: fbc-psr2-cursor-mmap-cpu
[363.326500] Starting dynamic subtest: eDP-1
[363.330416] Dynamic subtest eDP-1: SKIP (0.000s)
[363.333904] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[363.411927] [082/156] (656s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[363.504847] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[363.506807] Starting dynamic subtest: pipe-A-eDP-1
[363.525409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.535850] Starting dynamic subtest: pipe-B-eDP-1
[363.553844] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.563400] Starting dynamic subtest: pipe-C-eDP-1
[363.581267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.591014] Starting dynamic subtest: pipe-D-eDP-1
[363.610191] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.613625] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[365.799383] [083/156] (654s left) gem_softpin (allocator-fork)
[365.856053] Starting subtest: allocator-fork
[368.072609] Subtest allocator-fork: SUCCESS (2.215s)
[368.220232] [084/156] (651s left) gen9_exec_parse (bb-chained)
[368.279098] Subtest bb-chained: SKIP (0.000s)
[368.354449] [085/156] (651s left) gem_ccs (ctrl-surf-copy-new-ctx)
[368.422290] Starting subtest: ctrl-surf-copy-new-ctx
[368.426456] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[368.533147] [086/156] (651s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[368.636983] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[368.641406] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[368.727797] [087/156] (651s left) syncobj_wait (signal)
[368.782230] Starting subtest: signal
[368.784126] Subtest signal: SUCCESS (0.000s)
[368.891022] [088/156] (651s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[368.988963] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[368.991216] Starting dynamic subtest: pipe-A-eDP-1
[369.014045] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[369.026910] Starting dynamic subtest: pipe-B-eDP-1
[369.048412] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[369.058241] Starting dynamic subtest: pipe-C-eDP-1
[369.079930] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[369.089154] Starting dynamic subtest: pipe-D-eDP-1
[369.107546] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[369.111474] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[371.246303] [089/156] (649s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[371.296440] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[371.401415] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[371.480202] [090/156] (648s left) syncobj_wait (invalid-signal-one-illegal-handle)
[371.528471] Starting subtest: invalid-signal-one-illegal-handle
[371.530264] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[371.622409] [091/156] (648s left) i915_drm_fdinfo (memory-info-idle)
[371.658749] Starting subtest: memory-info-idle
[371.661180] Starting dynamic subtest: smem0
[371.724556] Dynamic subtest smem0: SUCCESS (0.068s)
[371.727141] Subtest memory-info-idle: SUCCESS (0.068s)
[371.798731] [092/156] (648s left) dmabuf_sync_file (import-basic)
[371.840177] Starting subtest: import-basic
[371.842189] Subtest import-basic: SUCCESS (0.002s)
[371.902099] [093/156] (648s left) kms_dp_link_training (non-uhbr-mst)
[371.990262] Starting subtest: non-uhbr-mst
[371.998774] Subtest non-uhbr-mst: SKIP (0.000s)
[372.062237] [094/156] (648s left) gem_lmem_swapping (massive-random)
[372.102637] Subtest massive-random: SKIP (0.000s)
[372.142193] [095/156] (648s left) gem_exec_fence (syncobj-repeat)
[372.583484] Starting subtest: syncobj-repeat
[372.778134] Subtest syncobj-repeat: SUCCESS (0.193s)
[374.680591] [096/156] (645s left) gem_sync (basic-each)
[374.751305] Starting subtest: basic-each
[377.279033] Subtest basic-each: SUCCESS (2.537s)
[377.469653] [097/156] (643s left) syncobj_timeline (reset-signaled)
[377.537262] Starting subtest: reset-signaled
[377.539638] Subtest reset-signaled: SUCCESS (0.000s)
[377.641665] [098/156] (643s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[377.898017] Starting subtest: cursor-rapid-movement-256x85
[377.957125] Subtest cursor-rapid-movement-256x85: SKIP (0.052s)
[378.143773] [099/156] (642s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[378.238066] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[378.242267] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[378.358845] [100/156] (642s left) gem_linear_blits (basic)
[378.767725] Starting subtest: basic
[378.776924] Subtest basic: SUCCESS (0.010s)
[378.882210] [101/156] (641s left) gem_create (create-invalid-size)
[378.987841] Starting subtest: create-invalid-size
[378.990224] Subtest create-invalid-size: SUCCESS (0.000s)
[379.191694] [102/156] (641s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[379.293664] Starting subtest: hdr-modesetfrombusy
[379.297869] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[379.396182] [103/156] (641s left) kms_cursor_crc (cursor-onscreen-512x512)
[379.683322] Starting subtest: cursor-onscreen-512x512
[379.687931] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[379.882059] [104/156] (641s left) kms_busy (extended-pageflip-hang-oldfb)
[379.984253] Starting subtest: extended-pageflip-hang-oldfb
[379.986526] Starting dynamic subtest: pipe-A
[380.436446] Dynamic subtest pipe-A: SUCCESS (0.450s)
[380.447878] Starting dynamic subtest: pipe-D
[381.561115] Dynamic subtest pipe-D: SUCCESS (1.120s)
[381.563408] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.577s)
[382.406031] [105/156] (638s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[382.512715] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[382.516884] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[382.599736] [106/156] (638s left) kms_plane (plane-panning-bottom-right)
[382.692474] Starting subtest: plane-panning-bottom-right
[382.694727] Starting dynamic subtest: pipe-A
[384.373208] Dynamic subtest pipe-A: SUCCESS (1.681s)
[384.385687] Starting dynamic subtest: pipe-B
[386.733942] Dynamic subtest pipe-B: SUCCESS (2.360s)
[386.736257] Subtest plane-panning-bottom-right: SUCCESS (4.043s)
[387.558326] [107/156] (633s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[387.656089] Starting subtest: psr-2p-primscrn-spr-indfb-move
[387.660509] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[387.750874] [108/156] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[387.860435] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[387.864996] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[387.964249] [109/156] (633s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[388.071621] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[388.076039] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[388.184974] [110/156] (633s left) kms_psr (fbc-pr-cursor-render)
[388.280672] Starting subtest: fbc-pr-cursor-render
[388.284908] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[388.365501] [111/156] (632s left) gem_pread (bench)
[388.422811] Subtest bench: SKIP (0.000s)
[388.484774] [112/156] (632s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[388.572667] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[388.576100] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[388.668343] [113/156] (632s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[388.766249] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[388.769605] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[388.884343] [114/156] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[388.973264] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[396.336927] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.366s)
[396.489024] [115/156] (624s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[396.585016] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[403.269809] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.687s)
[403.384259] [116/156] (618s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[403.480583] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[404.149143] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[404.328676] [117/156] (617s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[404.434722] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[408.008749] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.580s)
[409.147305] [118/156] (612s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[409.258710] Starting subtest: hdr-1p-pri-indfb-multidraw
[409.262619] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[409.362893] [119/156] (612s left) prime_vgem (basic-fence-read)
[409.440495] Starting subtest: basic-fence-read
[409.449558] Subtest basic-fence-read: SKIP (0.010s)
[409.555297] [120/156] (612s left) kms_addfb_basic (addfb25-4-tiled)
[409.647936] Starting subtest: addfb25-4-tiled
[409.649870] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[409.747706] [121/156] (611s left) gem_exec_balancer (bonded-semaphore)
[409.813224] Starting subtest: bonded-semaphore
[409.817273] Subtest bonded-semaphore: SKIP (0.000s)
[410.108519] [122/156] (611s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[410.194143] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[410.198384] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[410.299889] [123/156] (611s left) kms_cursor_crc (cursor-alpha-opaque)
[410.386758] Starting subtest: cursor-alpha-opaque
[410.388618] Starting dynamic subtest: pipe-A-eDP-1
[411.022839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[411.035662] Starting dynamic subtest: pipe-D-eDP-1
[412.327642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[412.329867] Subtest cursor-alpha-opaque: SUCCESS (1.941s)
[413.224972] [124/156] (608s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[413.324520] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[414.182117] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s)
[414.342947] [125/156] (607s left) api_intel_bb (purge-bb)
[414.405396] Starting subtest: purge-bb
[414.410868] Subtest purge-bb: SUCCESS (0.006s)
[414.529789] [126/156] (607s left) sysfs_timeslice_duration (duration)
[414.580181] Starting subtest: duration
[414.582554] Starting dynamic subtest: vecs0
[428.482900] Dynamic subtest vecs0: SUCCESS (13.897s)
[428.497275] Starting dynamic subtest: ccs0
[441.630566] Dynamic subtest ccs0: SUCCESS (13.144s)
[441.644110] Starting dynamic subtest: vcs0
[456.450706] Dynamic subtest vcs0: SUCCESS (14.813s)
[456.466172] Starting dynamic subtest: bcs0
[469.591262] Dynamic subtest bcs0: SUCCESS (13.136s)
[469.604384] Starting dynamic subtest: rcs0
[482.740310] Dynamic subtest rcs0: SUCCESS (13.143s)
[482.753685] Starting dynamic subtest: vcs1
[496.451080] Dynamic subtest vcs1: SUCCESS (13.702s)
[496.454191] Subtest duration: SUCCESS (81.851s)
[496.530488] [127/156] (525s left) gen7_exec_parse (basic-allowed)
[496.600044] Subtest basic-allowed: SKIP (0.000s)
[496.668811] [128/156] (525s left) kms_prime (basic-crc-vgem)
[496.768562] Starting subtest: basic-crc-vgem
[496.770853] Starting dynamic subtest: second-to-first
[497.732783] Dynamic subtest second-to-first: SUCCESS (0.968s)
[497.734775] Subtest basic-crc-vgem: SUCCESS (0.969s)
[497.853721] [129/156] (524s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[497.974889] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[497.978226] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[498.058611] [130/156] (524s left) syncobj_wait (invalid-reset-zero-handles)
[498.115814] Starting subtest: invalid-reset-zero-handles
[498.117410] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[498.203358] [131/156] (523s left) gem_ringfill (engines-basic)
[503.528867] Starting subtest: engines-basic
[503.531501] Starting dynamic subtest: rcs0
[503.590031] Dynamic subtest rcs0: SUCCESS (0.061s)
[503.603160] Starting dynamic subtest: bcs0
[503.633838] Dynamic subtest bcs0: SUCCESS (0.042s)
[503.645286] Starting dynamic subtest: vcs0
[503.675382] Dynamic subtest vcs0: SUCCESS (0.041s)
[503.686318] Starting dynamic subtest: vcs1
[503.718186] Dynamic subtest vcs1: SUCCESS (0.041s)
[503.729895] Starting dynamic subtest: vecs0
[503.761588] Dynamic subtest vecs0: SUCCESS (0.041s)
[503.772969] Starting dynamic subtest: ccs0
[503.807228] Dynamic subtest ccs0: SUCCESS (0.044s)
[503.809677] Subtest engines-basic: SUCCESS (0.281s)
[503.886178] [132/156] (518s left) vgem_basic (debugfs)
[503.927242] Starting subtest: debugfs
[503.929398] Subtest debugfs: SUCCESS (0.000s)
[504.003318] [133/156] (518s left) kms_cursor_edge_walk (256x256-right-edge)
[504.108856] Starting subtest: 256x256-right-edge
[504.111204] Starting dynamic subtest: pipe-A-eDP-1
[507.573645] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[507.589138] Starting dynamic subtest: pipe-D-eDP-1
[510.698516] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[510.700777] Subtest 256x256-right-edge: SUCCESS (6.591s)
[511.512463] [134/156] (510s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[511.621180] Starting subtest: fbcpsr-shrfb-scaledprimary
[517.403509] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.786s)
[517.552885] [135/156] (504s left) kms_chamelium_color (ctm-red-to-blue)
[517.655416] Subtest ctm-red-to-blue: SKIP (0.000s)
[517.705856] [136/156] (504s left) kms_plane_alpha_blend (alpha-basic)
[517.791500] Starting subtest: alpha-basic
[518.083026] Starting dynamic subtest: pipe-A-eDP-1
[520.008869] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[520.042575] Starting dynamic subtest: pipe-D-eDP-1
[522.735834] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.702s)
[522.738527] Subtest alpha-basic: SUCCESS (4.943s)
[523.617749] [137/156] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[523.721114] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[523.725542] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[523.822805] [138/156] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[523.923805] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[523.928407] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[524.015874] [139/156] (498s left) gem_ctx_param (invalid-ctx-set)
[524.070002] Starting subtest: invalid-ctx-set
[524.072369] Subtest invalid-ctx-set: SUCCESS (0.001s)
[524.188010] [140/156] (498s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-pwrite)
[524.286787] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-pwrite
[524.290872] Subtest hdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[524.434163] [141/156] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[524.527275] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[531.349636] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.826s)
[531.500747] [142/156] (491s left) kms_invalid_mode (bad-htotal)
[531.592919] Starting subtest: bad-htotal
[531.595127] Starting dynamic subtest: pipe-A-eDP-1
[531.880584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[531.891510] Starting dynamic subtest: pipe-B-eDP-1
[531.893456] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[531.905894] Starting dynamic subtest: pipe-C-eDP-1
[531.908222] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[531.919089] Starting dynamic subtest: pipe-D-eDP-1
[531.921392] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[531.923690] Subtest bad-htotal: SUCCESS (0.294s)
[532.704714] [143/156] (489s left) kms_psr (psr2-cursor-mmap-gtt)
[532.797676] Starting subtest: psr2-cursor-mmap-gtt
[532.799975] Starting dynamic subtest: eDP-1
[534.499646] Dynamic subtest eDP-1: SUCCESS (1.702s)
[534.501954] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.703s)
[535.383278] [144/156] (487s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[535.445631] Starting subtest: invalid-bsd1-flag-on-vebox
[535.448053] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[535.571710] [145/156] (487s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[535.669295] Starting subtest: fbc-indfb-scaledprimary
[538.575920] Subtest fbc-indfb-scaledprimary: SUCCESS (2.911s)
[539.712892] [146/156] (483s left) kms_vblank (ts-continuation-modeset-hang)
[539.800887] Starting subtest: ts-continuation-modeset-hang
[539.803107] Starting dynamic subtest: pipe-A-eDP-1
[566.383416] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.573s)
[566.402255] Starting dynamic subtest: pipe-D-eDP-1
[581.307351] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.919s)
[581.309732] Subtest ts-continuation-modeset-hang: SUCCESS (41.497s)
[582.162276] [147/156] (440s left) gem_lmem_swapping (random-engines)
[582.208378] Subtest random-engines: SKIP (0.000s)
[582.254621] [148/156] (440s left) kms_flip (2x-dpms-vs-vblank-race)
[582.343892] Starting subtest: 2x-dpms-vs-vblank-race
[582.351933] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[582.433563] [149/156] (440s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[582.553873] Starting subtest: flip-vs-cursor-varying-size
[591.508298] Subtest flip-vs-cursor-varying-size: SUCCESS (8.951s)
[592.382000] [150/156] (430s left) kms_chamelium_frames (hdmi-aspect-ratio)
[592.791049] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[593.608712] [151/156] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[593.707147] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[593.711413] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[593.811231] [152/156] (429s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[593.931985] Starting subtest: cursor-vs-flip-toggle
[625.160400] Subtest cursor-vs-flip-toggle: SUCCESS (31.217s)
[625.982105] [153/156] (397s left) kms_chamelium_hpd (vga-hpd-fast)
[626.378421] Subtest vga-hpd-fast: SKIP (0.000s)
[627.172749] [154/156] (395s left) gem_pread (display)
[627.234986] Subtest display: SKIP (0.000s)
[627.299290] [155/156] (395s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[627.398121] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[627.402314] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[627.489227] [156/156] (395s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[627.589141] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[627.593510] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[627.685611] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_rotation_crc
results: parsing output: 4/ for test: i915_query
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: gem_mmap_offset
results: parsing output: 8/ for test: gem_exec_store
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_multipipe_modeset
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_pm_backlight
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: gem_ctx_exec
results: parsing output: 39/ for test: sriov_basic
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_eventfd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_plane_multiple
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: i915_hangman
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: prime_self_import
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_set_tiling_vs_blt
results: parsing output: 77/ for test: gem_eio
results: parsing output: 78/ for test: gem_pipe_control_store_loop
results: parsing output: 79/ for test: kms_draw_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: gem_ccs
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: dmabuf_sync_file
results: parsing output: 92/ for test: kms_dp_link_training
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: gem_sync
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_linear_blits
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_pread
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: sysfs_timeslice_duration
results: parsing output: 126/ for test: gen7_exec_parse
results: parsing output: 127/ for test: kms_prime
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: gem_ringfill
results: parsing output: 131/ for test: vgem_basic
results: parsing output: 132/ for test: kms_cursor_edge_walk
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_chamelium_color
results: parsing output: 135/ for test: kms_plane_alpha_blend
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_ctx_param
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_invalid_mode
results: parsing output: 142/ for test: kms_psr
results: parsing output: 143/ for test: gem_exec_params
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_vblank
results: parsing output: 146/ for test: gem_lmem_swapping
results: parsing output: 147/ for test: kms_flip
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: kms_chamelium_frames
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: kms_chamelium_hpd
results: parsing output: 153/ for test: gem_pread
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.