[59.230801] Initializing watchdogs
[59.230856]   /dev/watchdog0
[59.244934] [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]
[59.249512] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.251786] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.255113] [001/132] (960s left) gem_fence_thrash (bo-write-verify-threaded-none)
[59.311675] Starting subtest: bo-write-verify-threaded-none
[59.334340] Subtest bo-write-verify-threaded-none: SKIP (0.018s)
[59.387078] [002/132] (960s left) gem_close_race (basic-process)
[59.459825] Starting subtest: basic-process
[59.511447] Subtest basic-process: SUCCESS (0.052s)
[59.699623] [003/132] (960s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[59.798492] Starting subtest: 4-tiled-32bpp-rotate-180
[61.260943] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.467s)
[61.391174] [004/132] (958s left) gem_exec_reloc (basic-gtt-wc)
[61.463551] Subtest basic-gtt-wc: SKIP (0.000s)
[61.556138] [005/132] (958s left) core_getclient (basic)
[61.606644] Starting subtest: basic
[61.608441] Subtest basic: SUCCESS (0.000s)
[61.681573] [006/132] (958s left) gen9_exec_parse (bb-oversize)
[61.732848] Subtest bb-oversize: SKIP (0.000s)
[61.809342] [007/132] (958s left) syncobj_timeline (host-signal-points)
[61.859044] Starting subtest: host-signal-points
[61.865827] Subtest host-signal-points: SUCCESS (0.007s)
[61.955028] [008/132] (958s left) syncobj_timeline (wait-any-complex)
[62.008757] Starting subtest: wait-any-complex
[62.071742] Subtest wait-any-complex: SUCCESS (0.063s)
[62.142479] [009/132] (957s left) kms_psr (pr-sprite-blt)
[62.235058] Starting subtest: pr-sprite-blt
[62.238618] Subtest pr-sprite-blt: SKIP (0.000s)
[62.302986] [010/132] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[62.412531] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[62.415840] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[62.507734] [011/132] (957s left) gem_exec_params (larger-than-life-batch)
[62.565215] Starting subtest: larger-than-life-batch
[64.859036] Subtest larger-than-life-batch: SUCCESS (2.297s)
[65.988873] [012/132] (954s left) kms_psr (fbc-psr-sprite-plane-onoff)
[66.123051] Starting subtest: fbc-psr-sprite-plane-onoff
[66.125345] Starting dynamic subtest: eDP-1
[66.129868] Dynamic subtest eDP-1: SKIP (0.000s)
[66.134495] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[66.191540] [013/132] (954s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[66.311131] Starting subtest: flip-vs-cursor-legacy
[74.398089] Subtest flip-vs-cursor-legacy: SUCCESS (8.091s)
[74.767718] [014/132] (945s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[74.871939] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[74.874347] Starting dynamic subtest: pipe-A
[74.895483] Dynamic subtest pipe-A: SKIP (0.020s)
[74.904408] Starting dynamic subtest: pipe-B
[74.926929] Dynamic subtest pipe-B: SKIP (0.033s)
[74.934683] Starting dynamic subtest: pipe-C
[74.962062] Dynamic subtest pipe-C: SKIP (0.033s)
[74.970259] Starting dynamic subtest: pipe-D
[74.994919] Dynamic subtest pipe-D: SKIP (0.033s)
[74.999263] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.120s)
[75.081213] [015/132] (945s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[75.176092] Starting subtest: yf-tiled-8bpp-rotate-90
[75.180676] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[75.285203] [016/132] (945s left) gem_softpin (noreloc-s3)
[75.339616] Starting subtest: noreloc-S3
[95.431817] Subtest noreloc-S3: SUCCESS (5.415s)
[95.556085] [017/132] (924s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[95.631518] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[95.636036] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[95.811613] [018/132] (924s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[95.914571] Starting subtest: fbcpsr-rgb565-draw-blt
[102.945610] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.102s)
[103.054722] [019/132] (917s left) gem_mmap_gtt (basic-copy)
[103.113141] Subtest basic-copy: SKIP (0.000s)
[103.165305] [020/132] (917s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[103.276810] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[103.279114] Starting dynamic subtest: pipe-A-eDP-1
[103.303384] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.311976] Starting dynamic subtest: pipe-B-eDP-1
[103.334591] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.342337] Starting dynamic subtest: pipe-C-eDP-1
[103.364862] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.373239] Starting dynamic subtest: pipe-D-eDP-1
[103.396151] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.399958] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[105.584941] [021/132] (914s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[105.685467] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[105.689824] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[105.786297] [022/132] (914s left) kms_getfb (getfb2-handle-zero)
[105.881329] Starting subtest: getfb2-handle-zero
[105.883524] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[105.983938] [023/132] (914s left) gem_exec_async (forked-writes)
[106.042295] Starting subtest: forked-writes
[106.044596] Starting dynamic subtest: rcs0
[106.069470] Dynamic subtest rcs0: SUCCESS (0.027s)
[106.081865] Starting dynamic subtest: bcs0
[106.093292] Dynamic subtest bcs0: SUCCESS (0.023s)
[106.102093] Starting dynamic subtest: vcs0
[106.115130] Dynamic subtest vcs0: SUCCESS (0.022s)
[106.124024] Starting dynamic subtest: vcs1
[106.138246] Dynamic subtest vcs1: SUCCESS (0.023s)
[106.147299] Starting dynamic subtest: vecs0
[106.158996] Dynamic subtest vecs0: SUCCESS (0.020s)
[106.167759] Starting dynamic subtest: ccs0
[106.181223] Dynamic subtest ccs0: SUCCESS (0.022s)
[106.183481] Subtest forked-writes: SUCCESS (0.140s)
[106.403099] [024/132] (914s left) kms_chamelium_color (ctm-limited-range)
[106.492228] Subtest ctm-limited-range: SKIP (0.000s)
[106.538104] [025/132] (914s left) gem_mmap_offset (partial-mmap)
[106.585031] Starting subtest: partial-mmap
[106.587229] Starting dynamic subtest: smem0
[106.589520] Dynamic subtest smem0: SUCCESS (0.003s)
[106.591655] Subtest partial-mmap: SUCCESS (0.004s)
[106.698791] [026/132] (914s left) i915_drm_fdinfo (memory-info-idle)
[106.738561] Starting subtest: memory-info-idle
[106.740395] Starting dynamic subtest: smem0
[106.800522] Dynamic subtest smem0: SUCCESS (0.064s)
[106.802998] Subtest memory-info-idle: SUCCESS (0.064s)
[106.871211] [027/132] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[106.981710] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[106.985929] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[107.074686] [028/132] (913s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[107.167497] Starting subtest: primary-4-tiled-reflect-x-180
[114.058572] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.908s)
[115.227215] [029/132] (905s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[115.296794] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[115.299100] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[115.419513] [030/132] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[115.530793] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[122.768898] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.248s)
[122.882579] [031/132] (898s left) kms_chamelium_frames (dp-frame-dump)
[123.271641] Subtest dp-frame-dump: SKIP (0.000s)
[124.067676] [032/132] (896s left) perf_pmu (semaphore-wait)
[124.108678] Starting subtest: semaphore-wait
[124.110740] Starting dynamic subtest: rcs0
[124.621416] Dynamic subtest rcs0: SUCCESS (0.512s)
[124.633611] Starting dynamic subtest: bcs0
[125.134028] Dynamic subtest bcs0: SUCCESS (0.511s)
[125.144596] Starting dynamic subtest: vcs0
[125.646591] Dynamic subtest vcs0: SUCCESS (0.511s)
[125.656620] Starting dynamic subtest: vcs1
[126.158865] Dynamic subtest vcs1: SUCCESS (0.510s)
[126.170385] Starting dynamic subtest: vecs0
[126.673251] Dynamic subtest vecs0: SUCCESS (0.512s)
[126.688368] Starting dynamic subtest: ccs0
[127.190218] Dynamic subtest ccs0: SUCCESS (0.514s)
[127.192876] Subtest semaphore-wait: SUCCESS (3.081s)
[128.737873] [033/132] (892s left) kms_flip (flip-vs-panning-interruptible)
[128.849283] Starting subtest: flip-vs-panning-interruptible
[128.851593] Starting dynamic subtest: A-eDP1
[137.599667] Dynamic subtest A-eDP1: SUCCESS (8.750s)
[137.610353] Starting dynamic subtest: B-eDP1
[146.322752] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[146.335135] Starting dynamic subtest: C-eDP1
[155.039406] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[155.048033] Starting dynamic subtest: D-eDP1
[163.688589] Dynamic subtest D-eDP1: SUCCESS (8.651s)
[163.692699] Subtest flip-vs-panning-interruptible: SUCCESS (34.852s)
[164.852976] [034/132] (856s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[164.972344] Starting subtest: 2x-flip-vs-cursor-legacy
[164.977053] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[165.118138] [035/132] (856s left) kms_cursor_legacy (single-bo)
[165.237014] Starting subtest: single-bo
[165.238935] Starting dynamic subtest: pipe-A
[170.616050] Dynamic subtest pipe-A: SUCCESS (5.378s)
[170.627992] Starting dynamic subtest: pipe-B
[175.995029] Dynamic subtest pipe-B: SUCCESS (5.379s)
[176.006399] Starting dynamic subtest: pipe-C
[181.375044] Dynamic subtest pipe-C: SUCCESS (5.379s)
[181.386355] Starting dynamic subtest: pipe-D
[186.754062] Dynamic subtest pipe-D: SUCCESS (5.379s)
[186.765363] Starting dynamic subtest: all-pipes
[192.145252] Dynamic subtest all-pipes: SUCCESS (5.386s)
[192.147797] Subtest single-bo: SUCCESS (26.913s)
[192.290527] [036/132] (828s left) device_reset (unbind-reset-rebind)
[192.340195] Starting subtest: unbind-reset-rebind
[196.920933] Subtest unbind-reset-rebind: SUCCESS (4.581s)
[196.968282] [037/132] (824s left) kms_plane_cursor (viewport)
[197.070169] Starting subtest: viewport
[197.076873] Starting dynamic subtest: pipe-A-eDP-1-size-64
[199.618314] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.552s)
[199.678766] Starting dynamic subtest: pipe-A-eDP-1-size-128
[202.130748] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.460s)
[202.189853] Starting dynamic subtest: pipe-A-eDP-1-size-256
[204.621219] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.437s)
[204.978252] Starting dynamic subtest: pipe-B-eDP-1-size-64
[208.105527] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.138s)
[208.166702] Starting dynamic subtest: pipe-B-eDP-1-size-128
[210.584896] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.427s)
[210.644642] Starting dynamic subtest: pipe-B-eDP-1-size-256
[213.120959] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[213.470244] Starting dynamic subtest: pipe-C-eDP-1-size-64
[216.278860] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.821s)
[216.317292] Starting dynamic subtest: pipe-C-eDP-1-size-128
[218.391059] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[218.429463] Starting dynamic subtest: pipe-C-eDP-1-size-256
[220.680970] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.260s)
[221.018575] Starting dynamic subtest: pipe-D-eDP-1-size-64
[223.895949] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.887s)
[223.936111] Starting dynamic subtest: pipe-D-eDP-1-size-128
[225.995677] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.069s)
[226.034583] Starting dynamic subtest: pipe-D-eDP-1-size-256
[228.062113] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.036s)
[228.387398] Subtest viewport: SUCCESS (31.316s)
[229.229255] [038/132] (792s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[229.355120] Starting subtest: cursor-vs-flip-toggle
[260.104373] Subtest cursor-vs-flip-toggle: SUCCESS (30.753s)
[260.936158] [039/132] (760s left) syncobj_wait (multi-wait-submitted-signaled)
[261.003279] Starting subtest: multi-wait-submitted-signaled
[261.005667] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[261.104198] [040/132] (760s left) gem_barrier_race (remote-request)
[261.174913] Starting subtest: remote-request
[261.177641] Starting dynamic subtest: rcs0
[266.339764] Dynamic subtest rcs0: SUCCESS (5.169s)
[266.342070] Subtest remote-request: SUCCESS (5.170s)
[266.471974] [041/132] (754s left) gem_userptr_blits (sync-unmap)
[266.535435] Starting subtest: sync-unmap
[266.552402] Subtest sync-unmap: SUCCESS (0.017s)
[266.682878] [042/132] (754s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[266.774846] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[266.776791] Starting dynamic subtest: pipe-A-eDP-1
[266.793061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[266.803461] Starting dynamic subtest: pipe-B-eDP-1
[266.820851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[266.832068] Starting dynamic subtest: pipe-C-eDP-1
[266.848019] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[266.856735] Starting dynamic subtest: pipe-D-eDP-1
[266.872716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[266.874683] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.018s)
[269.012207] [043/132] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[269.122843] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[273.596767] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.478s)
[274.731624] [044/132] (746s left) gem_exec_fence (syncobj-repeat)
[275.165716] Starting subtest: syncobj-repeat
[275.348990] Subtest syncobj-repeat: SUCCESS (0.181s)
[276.702441] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[276.706204] [045/132] (744s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[276.828189] Starting subtest: x-tiled-8bpp-rotate-270
[276.849827] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[276.979451] [046/132] (744s left) syncobj_eventfd (invalid-illegal-eventfd)
[277.032121] Starting subtest: invalid-illegal-eventfd
[277.034361] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[277.129187] [047/132] (744s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[277.215931] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[277.218181] Starting dynamic subtest: A-eDP1
[286.168266] Dynamic subtest A-eDP1: SUCCESS (8.954s)
[286.181376] Starting dynamic subtest: B-eDP1
[295.096345] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[295.106327] Starting dynamic subtest: C-eDP1
[304.014837] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[304.025483] Starting dynamic subtest: D-eDP1
[312.938977] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[312.941181] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.736s)
[314.170146] [048/132] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[314.281494] Starting subtest: psr-1p-primscrn-spr-indfb-move
[321.750663] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.469s)
[321.887216] [049/132] (699s left) kms_content_protection (uevent)
[322.035228] Starting subtest: uevent
[322.039879] Subtest uevent: SKIP (0.000s)
[322.168472] [050/132] (699s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[322.259695] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[322.262041] Starting dynamic subtest: pipe-A-eDP-1
[322.284267] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.295459] Starting dynamic subtest: pipe-B-eDP-1
[322.317602] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.327060] Starting dynamic subtest: pipe-C-eDP-1
[322.351739] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.363089] Starting dynamic subtest: pipe-D-eDP-1
[322.384918] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.389249] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[324.547980] [051/132] (697s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[324.617178] Starting subtest: stress-mm-invalidate-close-overlap
[326.766365] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[326.881737] [052/132] (694s left) syncobj_timeline (invalid-signal-illegal-point)
[326.939562] Starting subtest: invalid-signal-illegal-point
[326.942073] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[327.028280] [053/132] (694s left) gem_exec_endless (dispatch)
[327.099303] Starting subtest: dispatch
[327.101746] Starting dynamic subtest: rcs0
[327.109673] Dynamic subtest rcs0: SUCCESS (0.005s)
[327.122183] Starting dynamic subtest: bcs0
[327.126969] Dynamic subtest bcs0: SUCCESS (0.007s)
[327.139606] Starting dynamic subtest: vcs0
[327.143842] Dynamic subtest vcs0: SUCCESS (0.006s)
[327.152769] Starting dynamic subtest: vcs1
[327.157108] Dynamic subtest vcs1: SUCCESS (0.005s)
[327.166100] Starting dynamic subtest: vecs0
[327.170181] Dynamic subtest vecs0: SUCCESS (0.004s)
[327.178969] Starting dynamic subtest: ccs0
[327.182998] Dynamic subtest ccs0: SUCCESS (0.004s)
[327.184860] Subtest dispatch: SUCCESS (0.039s)
[328.664196] [054/132] (693s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[328.776540] Starting subtest: 4-tiled-16bpp-rotate-0
[330.057833] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.279s)
[330.199478] [055/132] (691s left) sysfs_heartbeat_interval (precise)
[330.262814] Starting subtest: precise
[330.265006] Starting dynamic subtest: vecs0
[337.646910] Dynamic subtest vecs0: SUCCESS (7.381s)
[337.660189] Starting dynamic subtest: ccs0
[338.793387] Dynamic subtest ccs0: SUCCESS (1.144s)
[338.807901] Starting dynamic subtest: vcs0
[346.666190] Dynamic subtest vcs0: SUCCESS (7.869s)
[346.680647] Starting dynamic subtest: bcs0
[347.822613] Dynamic subtest bcs0: SUCCESS (1.153s)
[347.845598] Starting dynamic subtest: rcs0
[348.904945] Dynamic subtest rcs0: SUCCESS (1.080s)
[348.916629] Starting dynamic subtest: vcs1
[356.646069] Dynamic subtest vcs1: SUCCESS (7.741s)
[356.648467] Subtest precise: SUCCESS (26.378s)
[356.730819] [056/132] (665s left) api_intel_allocator (alloc-simple)
[356.794625] Starting subtest: alloc-simple
[356.796809] Subtest alloc-simple: SUCCESS (0.005s)
[356.929493] [057/132] (665s left) kms_lease (lease-invalid-connector)
[357.024794] Starting subtest: lease-invalid-connector
[357.027123] Starting dynamic subtest: pipe-A-eDP-1
[357.029416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[357.038974] Starting dynamic subtest: pipe-B-eDP-1
[357.041273] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[357.050758] Starting dynamic subtest: pipe-C-eDP-1
[357.053080] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[357.061953] Starting dynamic subtest: pipe-D-eDP-1
[357.063829] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[357.065688] Subtest lease-invalid-connector: SUCCESS (0.004s)
[357.108025] [058/132] (664s left) gem_reg_read (timestamp-moving)
[357.167750] Starting subtest: timestamp-moving
[358.167303] Subtest timestamp-moving: SUCCESS (1.001s)
[358.243382] [059/132] (663s left) gem_ctx_persistence (engines-hostile-preempt)
[358.306586] Starting subtest: engines-hostile-preempt
[358.309011] Starting dynamic subtest: rcs0
[358.403819] Dynamic subtest rcs0: SUCCESS (0.097s)
[358.425629] Starting dynamic subtest: bcs0
[358.460576] Dynamic subtest bcs0: SUCCESS (0.054s)
[358.477043] Starting dynamic subtest: vcs0
[359.590321] Dynamic subtest vcs0: SUCCESS (1.127s)
[359.602605] Starting dynamic subtest: vcs1
[361.649601] Dynamic subtest vcs1: SUCCESS (2.055s)
[361.662877] Starting dynamic subtest: vecs0
[363.618337] Dynamic subtest vecs0: SUCCESS (1.966s)
[363.630151] Starting dynamic subtest: ccs0
[363.644161] Dynamic subtest ccs0: SUCCESS (0.025s)
[363.647680] Subtest engines-hostile-preempt: SUCCESS (5.337s)
[363.769821] [060/132] (658s left) syncobj_wait (wait-for-submit-complex)
[363.820963] Starting subtest: wait-for-submit-complex
[363.881098] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[363.976715] [061/132] (658s left) kms_joiner (invalid-modeset-force-big-joiner)
[364.090615] Starting subtest: invalid-modeset-force-big-joiner
[364.094998] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[364.160970] [062/132] (658s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[364.273146] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[364.276999] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[364.379263] [063/132] (657s left) gem_wait (busy)
[364.440001] Starting subtest: busy
[364.441862] Starting dynamic subtest: all-engines
[365.675480] Dynamic subtest all-engines: SUCCESS (1.236s)
[365.688279] Starting dynamic subtest: rcs0
[366.216739] Dynamic subtest rcs0: SUCCESS (0.539s)
[366.228543] Starting dynamic subtest: bcs0
[366.754542] Dynamic subtest bcs0: SUCCESS (0.537s)
[366.764658] Starting dynamic subtest: vcs0
[368.618837] Dynamic subtest vcs0: SUCCESS (1.863s)
[368.636286] Starting dynamic subtest: vcs1
[370.667417] Dynamic subtest vcs1: SUCCESS (2.046s)
[370.680223] Starting dynamic subtest: vecs0
[372.651311] Dynamic subtest vecs0: SUCCESS (1.981s)
[372.665062] Starting dynamic subtest: ccs0
[373.193338] Dynamic subtest ccs0: SUCCESS (0.541s)
[373.195903] Subtest busy: SUCCESS (8.756s)
[373.392046] [064/132] (648s left) gem_userptr_blits (dmabuf-sync)
[373.456359] Starting subtest: dmabuf-sync
[373.461082] Subtest dmabuf-sync: SKIP (0.002s)
[373.600323] [065/132] (648s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[373.710636] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[373.715072] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[373.793800] [066/132] (648s left) kms_pm_rpm (drm-resources-equal)
[375.825541] Starting subtest: drm-resources-equal
[380.822823] Subtest drm-resources-equal: SUCCESS (5.000s)
[380.915134] [067/132] (641s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[381.012896] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[381.015304] Starting dynamic subtest: pipe-A-eDP-1
[381.099061] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[381.114348] Starting dynamic subtest: pipe-B-eDP-1
[382.240266] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[382.244635] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.228s)
[383.426385] [068/132] (639s left) gem_exec_schedule (u-semaphore-codependency)
[383.502558] Starting subtest: u-semaphore-codependency
[383.511905] Subtest u-semaphore-codependency: SUCCESS (0.014s)
[383.860646] [069/132] (638s left) kms_prop_blob (invalid-get-prop-any)
[383.923306] Starting subtest: invalid-get-prop-any
[383.925582] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[384.020939] [070/132] (638s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[384.074539] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[384.076405] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[384.168120] [071/132] (638s left) i915_pm_rps (reset)
[384.221375] Starting subtest: reset
[391.825981] Subtest reset: FAIL (7.191s)
[392.599726] [072/132] (630s left) perf_pmu (event-wait)
[392.643553] Starting subtest: event-wait
[392.645564] Starting dynamic subtest: rcs0
[392.649221] Dynamic subtest rcs0: SKIP (0.000s)
[392.652805] Subtest event-wait: SKIP (0.001s)
[392.747545] [073/132] (629s left) gem_spin_batch (resubmit)
[392.811089] Starting subtest: resubmit
[392.813643] Starting dynamic subtest: rcs0
[392.820459] Dynamic subtest rcs0: SUCCESS (0.008s)
[392.831643] Starting dynamic subtest: bcs0
[392.833275] Dynamic subtest bcs0: SUCCESS (0.005s)
[392.842924] Starting dynamic subtest: vcs0
[392.844682] Dynamic subtest vcs0: SUCCESS (0.004s)
[392.855749] Starting dynamic subtest: vcs1
[392.857518] Dynamic subtest vcs1: SUCCESS (0.003s)
[392.866691] Starting dynamic subtest: vecs0
[392.868477] Dynamic subtest vecs0: SUCCESS (0.003s)
[392.877671] Starting dynamic subtest: ccs0
[392.879462] Dynamic subtest ccs0: SUCCESS (0.004s)
[392.881204] Subtest resubmit: SUCCESS (0.031s)
[393.088630] [074/132] (629s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[393.195937] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[393.197739] Starting dynamic subtest: pipe-A-default-mode
[395.946956] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[395.949403] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.751s)
[396.819546] [075/132] (625s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[396.915984] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[396.920024] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[396.990672] [076/132] (625s left) gem_create (busy-create)
[397.051471] Starting subtest: busy-create
[397.053607] Starting dynamic subtest: smem0
[430.639148] Dynamic subtest smem0: SUCCESS (33.588s)
[430.641741] Subtest busy-create: SUCCESS (33.590s)
[430.831511] [077/132] (592s left) kms_chamelium_hpd (vga-hpd)
[431.241115] Subtest vga-hpd: SKIP (0.000s)
[432.030228] [078/132] (590s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[432.086133] Starting subtest: x-tiled-to-vebox-yf-tiled
[432.090866] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[432.271464] [079/132] (590s left) gem_mmap_gtt (bad-object)
[432.331163] Subtest bad-object: SKIP (0.000s)
[432.394581] [080/132] (590s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[432.509975] Starting subtest: basic-flip-after-cursor-varying-size
[433.432984] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s)
[434.292865] [081/132] (588s left) i915_drm_fdinfo (virtual-busy-idle-all)
[434.339995] Starting subtest: virtual-busy-idle-all
[434.344519] Subtest virtual-busy-idle-all: SKIP (0.000s)
[434.428200] [082/132] (588s left) gem_render_copy (x-tiled)
[434.489932] Starting subtest: x-tiled
[434.492229] Starting dynamic subtest: smem
[434.529305] Dynamic subtest smem: SUCCESS (0.040s)
[434.531826] Subtest x-tiled: SUCCESS (0.040s)
[434.751552] [083/132] (588s left) kms_async_flips (alternate-sync-async-flip-atomic)
[434.845887] Starting subtest: alternate-sync-async-flip-atomic
[435.217600] Starting dynamic subtest: pipe-A-eDP-1
[437.964962] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.748s)
[438.334699] Starting dynamic subtest: pipe-B-eDP-1
[441.101402] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s)
[441.480398] Starting dynamic subtest: pipe-C-eDP-1
[444.227180] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[444.593988] Starting dynamic subtest: pipe-D-eDP-1
[447.359026] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[447.361244] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.517s)
[448.541355] [084/132] (574s left) gem_exec_whisper (basic-forked-all)
[448.613571] Starting subtest: basic-forked-all
[462.639378] Subtest basic-forked-all: SUCCESS (14.023s)
[462.821969] [085/132] (560s left) gem_ctx_persistence (legacy-engines-cleanup)
[462.891223] Starting subtest: legacy-engines-cleanup
[462.893587] Starting dynamic subtest: render
[462.954997] Dynamic subtest render: SUCCESS (0.064s)
[462.970916] Starting dynamic subtest: bsd1
[463.039804] Dynamic subtest bsd1: SUCCESS (0.081s)
[463.052655] Starting dynamic subtest: bsd2
[463.080402] Dynamic subtest bsd2: SUCCESS (0.038s)
[463.093536] Starting dynamic subtest: blt
[463.115647] Dynamic subtest blt: SUCCESS (0.032s)
[463.125343] Starting dynamic subtest: vebox
[463.198422] Dynamic subtest vebox: SUCCESS (0.082s)
[463.201051] Subtest legacy-engines-cleanup: SUCCESS (0.309s)
[463.281347] [086/132] (559s left) prime_vgem (basic-gtt)
[463.360215] Starting subtest: basic-gtt
[463.365624] Subtest basic-gtt: SKIP (0.000s)
[463.463197] [087/132] (559s left) drm_read (short-buffer-nonblock)
[463.612531] Starting subtest: short-buffer-nonblock
[463.614483] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[463.738885] [088/132] (559s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[463.833215] Starting subtest: bad-pixel-format-y-tiled-ccs
[463.834981] Starting dynamic subtest: pipe-A-eDP-1
[463.853235] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.864670] Starting dynamic subtest: pipe-B-eDP-1
[463.881973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.891911] Starting dynamic subtest: pipe-C-eDP-1
[463.909397] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.921266] Starting dynamic subtest: pipe-D-eDP-1
[463.938530] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.941740] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[466.008359] [089/132] (557s left) gem_lmem_swapping (heavy-random)
[466.046084] Subtest heavy-random: SKIP (0.000s)
[466.089465] [090/132] (557s left) kms_psr (fbc-pr-cursor-plane-onoff)
[466.183833] Starting subtest: fbc-pr-cursor-plane-onoff
[466.188007] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[466.260177] [091/132] (557s left) kms_cursor_crc (cursor-size-hints)
[466.386895] Starting subtest: cursor-size-hints
[466.389086] Starting dynamic subtest: pipe-A-eDP-1
[467.002222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[467.015290] Starting dynamic subtest: pipe-D-eDP-1
[468.275528] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s)
[468.277909] Subtest cursor-size-hints: SUCCESS (1.891s)
[469.095841] [092/132] (554s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[469.189863] Starting subtest: compare-crc-sanitycheck-nv12
[469.193068] Starting dynamic subtest: pipe-A-eDP-1
[469.867996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s)
[469.879899] Starting dynamic subtest: pipe-B-eDP-1
[471.156281] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.287s)
[471.169823] Starting dynamic subtest: pipe-C-eDP-1
[472.347569] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.189s)
[472.358250] Starting dynamic subtest: pipe-D-eDP-1
[473.581478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[473.583975] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.394s)
[474.431797] [093/132] (549s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[474.535113] Starting subtest: y-tiled-32bpp-rotate-180
[474.539486] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[474.638505] [094/132] (548s left) syncobj_wait (wait-all-delayed-signal)
[474.687357] Starting subtest: wait-all-delayed-signal
[474.791394] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[474.876701] [095/132] (548s left) perf_pmu (busy)
[474.918167] Starting subtest: busy
[474.920521] Starting dynamic subtest: rcs0
[475.502027] Dynamic subtest rcs0: SUCCESS (0.585s)
[475.515406] Starting dynamic subtest: bcs0
[476.077507] Dynamic subtest bcs0: SUCCESS (0.574s)
[476.090644] Starting dynamic subtest: vcs0
[477.675104] Dynamic subtest vcs0: SUCCESS (1.594s)
[477.688835] Starting dynamic subtest: vcs1
[479.660156] Dynamic subtest vcs1: SUCCESS (1.982s)
[479.671844] Starting dynamic subtest: vecs0
[481.643259] Dynamic subtest vecs0: SUCCESS (1.980s)
[481.656322] Starting dynamic subtest: ccs0
[482.219360] Dynamic subtest ccs0: SUCCESS (0.573s)
[482.221706] Subtest busy: SUCCESS (7.303s)
[482.321324] [096/132] (541s left) gem_mmap (short-mmap)
[482.388084] Subtest short-mmap: SKIP (0.000s)
[482.456944] [097/132] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[482.553239] Starting subtest: psr-2p-primscrn-spr-indfb-move
[482.557351] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[482.639567] [098/132] (541s left) kms_psr (fbc-psr2-primary-blt)
[482.737702] Starting subtest: fbc-psr2-primary-blt
[482.739903] Starting dynamic subtest: eDP-1
[482.743839] Dynamic subtest eDP-1: SKIP (0.000s)
[482.747723] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[482.824257] [099/132] (540s left) kms_vblank (query-forked)
[482.920841] Starting subtest: query-forked
[482.922923] Starting dynamic subtest: pipe-A-eDP-1
[484.745085] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.826s)
[484.759548] Starting dynamic subtest: pipe-D-eDP-1
[487.247882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.501s)
[487.250321] Subtest query-forked: SUCCESS (4.331s)
[488.112449] [100/132] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[488.204036] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[510.847838] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.652s)
[510.977015] [101/132] (512s left) kms_psr (psr-cursor-render)
[511.078373] Starting subtest: psr-cursor-render
[511.080255] Starting dynamic subtest: eDP-1
[512.834607] Dynamic subtest eDP-1: SUCCESS (1.755s)
[512.836986] Subtest psr-cursor-render: SUCCESS (1.756s)
[513.690876] [102/132] (510s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[513.791987] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[513.794419] Starting dynamic subtest: A-eDP1
[517.435837] Dynamic subtest A-eDP1: SUCCESS (3.640s)
[517.446699] Starting dynamic subtest: B-eDP1
[520.628451] Dynamic subtest B-eDP1: SUCCESS (3.192s)
[520.649543] Starting dynamic subtest: C-eDP1
[523.726279] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[523.737677] Starting dynamic subtest: D-eDP1
[526.822672] Dynamic subtest D-eDP1: SUCCESS (3.097s)
[526.825402] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.035s)
[527.618889] [103/132] (496s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[527.688556] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[527.753441] [104/132] (496s left) kms_cursor_crc (cursor-offscreen-128x42)
[527.981531] Starting subtest: cursor-offscreen-128x42
[528.050796] Subtest cursor-offscreen-128x42: SKIP (0.064s)
[528.274375] [105/132] (495s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[528.383464] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[535.424513] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.046s)
[535.567039] [106/132] (488s left) kms_flip (bo-too-big)
[535.651541] Starting subtest: bo-too-big
[535.653963] Starting dynamic subtest: A-eDP1
[537.005611] Dynamic subtest A-eDP1: SUCCESS (1.354s)
[537.021918] Starting dynamic subtest: B-eDP1
[538.336736] Dynamic subtest B-eDP1: SUCCESS (1.330s)
[538.349655] Starting dynamic subtest: C-eDP1
[539.658859] Dynamic subtest C-eDP1: SUCCESS (1.322s)
[539.671540] Starting dynamic subtest: D-eDP1
[540.982254] Dynamic subtest D-eDP1: SUCCESS (1.321s)
[540.987296] Subtest bo-too-big: SUCCESS (5.337s)
[542.196047] [107/132] (481s left) i915_selftest (perf)
[543.946998] Starting subtest: perf
[543.949462] Starting dynamic subtest: engine_cs
[548.317833] Dynamic subtest engine_cs: SUCCESS (4.370s)
[548.333551] Starting dynamic subtest: request
[555.548770] Dynamic subtest request: SUCCESS (7.231s)
[555.558387] Starting dynamic subtest: migrate
[559.878506] Dynamic subtest migrate: SUCCESS (4.329s)
[559.887695] Starting dynamic subtest: region
[565.467768] Dynamic subtest region: SUCCESS (5.588s)
[565.470506] Subtest perf: SUCCESS (21.525s)
[565.499052] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[565.499771] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[565.502868] [108/132] (458s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[567.068473] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[574.430602] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.361s)
[574.573601] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[574.575217] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)] new: kernel.kmod_is_loaded.i915: true
[574.579239] [109/132] (449s left) kms_draw_crc (draw-method-mmap-cpu)
[574.684023] Starting subtest: draw-method-mmap-cpu
[574.685885] Starting dynamic subtest: xrgb8888-untiled
[574.936754] Dynamic subtest xrgb8888-untiled: SUCCESS (0.254s)
[574.946822] Starting dynamic subtest: rgb565-untiled
[575.137002] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[575.146565] Starting dynamic subtest: xrgb2101010-untiled
[575.337134] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[575.346797] Starting dynamic subtest: xbgr16161616f-untiled
[575.548014] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[575.559802] Starting dynamic subtest: xrgb8888-xtiled
[575.670259] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[575.679303] Starting dynamic subtest: rgb565-xtiled
[575.814494] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s)
[575.823840] Starting dynamic subtest: xrgb2101010-xtiled
[575.937081] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[575.947299] Starting dynamic subtest: xbgr16161616f-xtiled
[576.072001] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[576.081096] Starting dynamic subtest: xrgb8888-4tiled
[576.204268] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.131s)
[576.215262] Starting dynamic subtest: rgb565-4tiled
[576.359739] Dynamic subtest rgb565-4tiled: SUCCESS (0.153s)
[576.369290] Starting dynamic subtest: xrgb2101010-4tiled
[576.493480] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[576.503069] Starting dynamic subtest: xbgr16161616f-4tiled
[576.626990] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[576.628953] Subtest draw-method-mmap-cpu: SUCCESS (1.945s)
[576.744874] [110/132] (447s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[576.860067] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[576.863838] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[577.008711] [111/132] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[577.104756] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[577.108088] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[577.192458] [112/132] (447s left) kms_vblank (query-idle-hang)
[577.276842] Starting subtest: query-idle-hang
[577.278613] Starting dynamic subtest: pipe-A-eDP-1
[603.436306] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.139s)
[603.451313] Starting dynamic subtest: pipe-D-eDP-1
[628.406959] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s)
[628.409293] Subtest query-idle-hang: SUCCESS (51.102s)
[629.292112] [113/132] (395s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[629.401641] Starting subtest: x-tiled-addfb-size-offset-overflow
[629.403895] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[629.504077] [114/132] (394s left) kms_big_fb (linear-8bpp-rotate-270)
[629.611048] Starting subtest: linear-8bpp-rotate-270
[629.632103] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[629.732097] [115/132] (394s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[629.826902] Starting subtest: plane-downscale-factor-0-5-with-rotation
[629.829173] Starting dynamic subtest: pipe-A
[629.847085] Dynamic subtest pipe-A: SKIP (0.016s)
[629.856942] Starting dynamic subtest: pipe-B
[629.881745] Dynamic subtest pipe-B: SKIP (0.035s)
[629.891234] Starting dynamic subtest: pipe-C
[629.919766] Dynamic subtest pipe-C: SKIP (0.037s)
[629.928463] Starting dynamic subtest: pipe-D
[629.950834] Dynamic subtest pipe-D: SKIP (0.030s)
[629.954531] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.121s)
[630.053738] [116/132] (394s left) gem_mmap (pf-nonblock)
[630.105845] Subtest pf-nonblock: SKIP (0.000s)
[630.182088] [117/132] (394s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[630.278453] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[634.399824] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.122s)
[635.616581] [118/132] (388s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[635.721988] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[635.725950] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[635.821166] [119/132] (388s left) gem_create (create-valid-nonaligned)
[635.874806] Starting subtest: create-valid-nonaligned
[635.877039] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[636.075060] [120/132] (388s left) gem_exec_schedule (pi-ringfull)
[636.265142] Starting subtest: pi-ringfull
[636.271362] Starting dynamic subtest: rcs0
[636.287683] Dynamic subtest rcs0: SUCCESS (0.026s)
[636.302973] Starting dynamic subtest: bcs0
[636.314257] Dynamic subtest bcs0: SUCCESS (0.026s)
[636.327638] Starting dynamic subtest: vcs0
[636.342376] Dynamic subtest vcs0: SUCCESS (0.027s)
[636.356068] Starting dynamic subtest: vcs1
[636.368277] Dynamic subtest vcs1: SUCCESS (0.025s)
[636.379903] Starting dynamic subtest: vecs0
[636.397046] Dynamic subtest vecs0: SUCCESS (0.028s)
[636.409032] Starting dynamic subtest: ccs0
[636.425674] Dynamic subtest ccs0: SUCCESS (0.028s)
[636.427971] Subtest pi-ringfull: SUCCESS (0.165s)
[636.649752] [121/132] (388s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[636.760475] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[641.182717] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.425s)
[642.315390] [122/132] (382s left) syncobj_basic (bad-fd-to-handle)
[642.362962] Starting subtest: bad-fd-to-handle
[642.364841] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[642.465876] [123/132] (382s left) gem_exec_balancer (busy)
[642.527193] Starting subtest: busy
[644.647998] Subtest busy: SUCCESS (2.118s)
[644.969283] [124/132] (379s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[645.036288] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[645.106340] [125/132] (379s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[645.209533] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[645.213837] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[645.298530] [126/132] (379s left) gem_exec_flush (basic-wb-set-default)
[645.357366] Starting subtest: basic-wb-set-default
[650.827897] Subtest basic-wb-set-default: SUCCESS (5.470s)
[651.018542] [127/132] (373s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[651.125735] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[651.130047] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[651.200106] [128/132] (373s left) kms_color (invalid-ctm-matrix-sizes)
[651.284941] Starting subtest: invalid-ctm-matrix-sizes
[651.287076] Starting dynamic subtest: pipe-A
[651.289341] Dynamic subtest pipe-A: SUCCESS (0.002s)
[651.299848] Starting dynamic subtest: pipe-B
[651.301747] Dynamic subtest pipe-B: SUCCESS (0.003s)
[651.311525] Starting dynamic subtest: pipe-C
[651.313731] Dynamic subtest pipe-C: SUCCESS (0.003s)
[651.323276] Starting dynamic subtest: pipe-D
[651.325158] Dynamic subtest pipe-D: SUCCESS (0.004s)
[651.327023] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[651.370194] [129/132] (373s left) prime_self_import (basic-llseek-bad)
[651.402975] Starting subtest: basic-llseek-bad
[651.424663] Subtest basic-llseek-bad: SUCCESS (0.021s)
[651.529701] [130/132] (373s left) kms_cursor_edge_walk (256x256-top-bottom)
[651.621546] Starting subtest: 256x256-top-bottom
[651.623762] Starting dynamic subtest: pipe-A-eDP-1
[655.049687] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[655.060997] Starting dynamic subtest: pipe-D-eDP-1
[658.165043] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[658.167417] Subtest 256x256-top-bottom: SUCCESS (6.542s)
[658.969077] [131/132] (366s left) gem_mmap (basic)
[659.029967] Subtest basic: SKIP (0.000s)
[659.097133] [132/132] (366s left) kms_addfb_basic (unused-handle)
[659.146113] Starting subtest: unused-handle
[659.148333] Subtest unused-handle: SUCCESS (0.000s)
[659.296636] Closing watchdogs
results: parsing output: 0/ for test: gem_fence_thrash
results: parsing output: 1/ for test: gem_close_race
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: core_getclient
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: gem_exec_async
results: parsing output: 23/ for test: kms_chamelium_color
results: parsing output: 24/ for test: gem_mmap_offset
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: device_reset
results: parsing output: 36/ for test: kms_plane_cursor
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_barrier_race
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_eventfd
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_content_protection
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_exec_endless
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: sysfs_heartbeat_interval
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: gem_reg_read
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_joiner
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_wait
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_pm_rpm
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_prop_blob
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: i915_pm_rps
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_spin_batch
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: gem_create
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: i915_drm_fdinfo
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: gem_exec_whisper
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: prime_vgem
results: parsing output: 86/ for test: drm_read
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_lmem_swapping
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: gem_mmap
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_pipe_b_c_ivb
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: i915_selftest
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_draw_crc
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: gem_mmap
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_basic
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_color
results: parsing output: 128/ for test: prime_self_import
results: parsing output: 129/ for test: kms_cursor_edge_walk
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: kms_addfb_basic
Done.