[59.379592] Initializing watchdogs
[59.379640]   /dev/watchdog0
[59.394386] [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.399318] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.401720] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.404945] [001/133] (960s left) gem_exec_schedule (u-submit-late-slice)
[59.504907] Starting subtest: u-submit-late-slice
[59.506938] Starting dynamic subtest: rcs0
[59.560455] Dynamic subtest rcs0: SUCCESS (0.057s)
[59.568640] Starting dynamic subtest: bcs0
[59.601807] Dynamic subtest bcs0: SUCCESS (0.042s)
[59.609480] Starting dynamic subtest: vcs0
[59.650197] Dynamic subtest vcs0: SUCCESS (0.048s)
[59.658616] Starting dynamic subtest: vcs1
[59.696288] Dynamic subtest vcs1: SUCCESS (0.046s)
[59.703549] Starting dynamic subtest: vecs0
[59.742892] Dynamic subtest vecs0: SUCCESS (0.046s)
[59.750440] Starting dynamic subtest: ccs0
[59.791413] Dynamic subtest ccs0: SUCCESS (0.048s)
[59.793819] Subtest u-submit-late-slice: SUCCESS (0.289s)
[60.950898] [002/133] (958s left) gem_exec_flush (basic-wb-rw-default)
[61.021757] Starting subtest: basic-wb-rw-default
[66.516256] Subtest basic-wb-rw-default: SUCCESS (5.473s)
[66.679493] [003/133] (953s left) sysfs_timeslice_duration (duration)
[66.766802] Starting subtest: duration
[66.769080] Starting dynamic subtest: vecs0
[80.884469] Dynamic subtest vecs0: SUCCESS (14.120s)
[80.894806] Starting dynamic subtest: ccs0
[94.043456] Dynamic subtest ccs0: SUCCESS (13.150s)
[94.051876] Starting dynamic subtest: vcs0
[107.891631] Dynamic subtest vcs0: SUCCESS (13.858s)
[107.901665] Starting dynamic subtest: bcs0
[121.045834] Dynamic subtest bcs0: SUCCESS (13.130s)
[121.052927] Starting dynamic subtest: rcs0
[134.168391] Dynamic subtest rcs0: SUCCESS (13.144s)
[134.178688] Starting dynamic subtest: vcs1
[147.892848] Dynamic subtest vcs1: SUCCESS (13.721s)
[147.895932] Subtest duration: SUCCESS (81.131s)
[147.973173] [004/133] (872s left) gem_userptr_blits (readonly-unsync)
[148.036087] Subtest readonly-unsync: SKIP (0.000s)
[148.154682] [005/133] (871s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[148.255427] Starting subtest: plane-lut1d-pre-ctm3x4
[148.425892] Starting dynamic subtest: pipe-A-plane-0
[148.602493] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[148.610135] Starting dynamic subtest: pipe-A-plane-1
[148.769758] Dynamic subtest pipe-A-plane-1: SUCCESS (0.167s)
[148.779149] Starting dynamic subtest: pipe-A-plane-2
[148.924950] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[150.169236] Starting dynamic subtest: pipe-B-plane-0
[150.330288] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[150.337744] Starting dynamic subtest: pipe-B-plane-1
[150.519439] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s)
[150.528498] Starting dynamic subtest: pipe-B-plane-2
[150.688550] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[151.872383] Starting dynamic subtest: pipe-C-plane-0
[152.022368] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[152.029918] Starting dynamic subtest: pipe-C-plane-1
[152.167299] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[152.174830] Starting dynamic subtest: pipe-C-plane-2
[152.333425] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[153.527913] Starting dynamic subtest: pipe-D-plane-0
[153.671820] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s)
[153.680877] Starting dynamic subtest: pipe-D-plane-1
[153.850141] Dynamic subtest pipe-D-plane-1: SUCCESS (0.177s)
[153.863662] Starting dynamic subtest: pipe-D-plane-2
[153.994334] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[154.279678] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.022s)
[155.077198] [006/133] (865s left) kms_sequence (queue-busy)
[155.171205] Starting subtest: queue-busy
[155.173625] Starting dynamic subtest: pipe-A-eDP-1
[157.100063] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[157.109133] Starting dynamic subtest: pipe-B-eDP-1
[159.706319] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.607s)
[159.715078] Starting dynamic subtest: pipe-C-eDP-1
[162.274406] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.567s)
[162.283834] Starting dynamic subtest: pipe-D-eDP-1
[164.824526] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[164.826709] Subtest queue-busy: SUCCESS (9.654s)
[165.621930] [007/133] (854s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[165.737339] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[165.739499] Starting dynamic subtest: pipe-A-eDP-1
[166.642096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.898s)
[166.650797] Starting dynamic subtest: pipe-B-eDP-1
[168.268657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.623s)
[168.278231] Starting dynamic subtest: pipe-C-eDP-1
[169.737534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.469s)
[169.749504] Starting dynamic subtest: pipe-D-eDP-1
[171.183660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s)
[171.185619] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.439s)
[172.364434] [008/133] (847s left) gem_pxp (reject-modify-context-protection-on)
[172.491786] Starting subtest: reject-modify-context-protection-on
[172.494554] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[172.611727] [009/133] (847s left) gen9_exec_parse (bb-secure)
[172.677815] Subtest bb-secure: SKIP (0.000s)
[172.746382] [010/133] (847s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[172.963668] Starting subtest: cursor-rapid-movement-128x42
[173.010440] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[173.222675] [011/133] (847s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[173.283996] Starting subtest: invalid-single-wait-all-unsubmitted
[173.285982] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[173.384374] [012/133] (846s left) gem_mmap_gtt (coherency)
[173.444987] Subtest coherency: SKIP (0.000s)
[173.495670] [013/133] (846s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[173.602445] Starting subtest: psr-rgb101010-draw-mmap-wc
[180.650186] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.051s)
[180.761889] [014/133] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[180.864162] Starting subtest: psr-1p-primscrn-spr-indfb-move
[188.531929] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.668s)
[188.668693] [015/133] (831s left) kms_plane (planar-pixel-format-settings)
[188.779982] Starting subtest: planar-pixel-format-settings
[188.847593] Subtest planar-pixel-format-settings: SUCCESS (0.068s)
[188.963114] [016/133] (831s left) kms_psr (pr-cursor-plane-onoff)
[189.055624] Starting subtest: pr-cursor-plane-onoff
[189.059912] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[189.129510] [017/133] (831s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[189.226878] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[189.229040] Starting dynamic subtest: pipe-A-eDP-1
[189.250936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[189.263761] Starting dynamic subtest: pipe-B-eDP-1
[189.284747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[189.293161] Starting dynamic subtest: pipe-C-eDP-1
[189.314393] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[189.322388] Starting dynamic subtest: pipe-D-eDP-1
[189.344642] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[189.348794] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[191.439292] [018/133] (829s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[191.532481] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[198.872424] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.343s)
[198.982078] [019/133] (821s left) kms_cursor_crc (cursor-offscreen-32x32)
[199.146653] Starting subtest: cursor-offscreen-32x32
[199.196328] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[199.466032] [020/133] (821s left) gem_exec_balancer (parallel-contexts)
[199.719014] Starting subtest: parallel-contexts
[202.401471] Subtest parallel-contexts: SUCCESS (2.685s)
[203.060746] [021/133] (817s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[203.141281] Starting subtest: saturated-hostile-nopreempt
[203.143589] Starting dynamic subtest: rcs0
[203.214710] Dynamic subtest rcs0: SKIP (0.070s)
[203.225257] Starting dynamic subtest: bcs0
[203.232053] Dynamic subtest bcs0: SKIP (0.016s)
[203.239997] Starting dynamic subtest: vcs0
[203.246714] Dynamic subtest vcs0: SKIP (0.013s)
[203.254632] Starting dynamic subtest: vcs1
[203.261464] Dynamic subtest vcs1: SKIP (0.011s)
[203.269357] Starting dynamic subtest: vecs0
[203.278593] Dynamic subtest vecs0: SKIP (0.017s)
[203.286540] Starting dynamic subtest: ccs0
[203.290988] Dynamic subtest ccs0: SKIP (0.010s)
[203.295206] Subtest saturated-hostile-nopreempt: SKIP (0.149s)
[203.374746] [022/133] (817s left) kms_getfb (getfb-handle-zero)
[203.482430] Starting subtest: getfb-handle-zero
[203.484723] Subtest getfb-handle-zero: SUCCESS (0.000s)
[203.580388] [023/133] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[203.683271] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[208.317550] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.635s)
[209.467936] [024/133] (811s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[209.530520] Starting subtest: etime-single-wait-for-submit-submitted
[209.635285] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[209.708319] [025/133] (811s left) syncobj_timeline (multi-wait-submitted-signaled)
[209.766635] Starting subtest: multi-wait-submitted-signaled
[209.769042] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[209.860336] [026/133] (811s left) gem_exec_schedule (preempt-queue-chain)
[209.934331] Subtest preempt-queue-chain: SKIP (0.000s)
[210.264073] [027/133] (810s left) gem_exec_schedule (fairslice)
[210.340383] Starting subtest: fairslice
[210.342794] Starting dynamic subtest: rcs0
[212.353294] Dynamic subtest rcs0: SUCCESS (2.021s)
[212.363156] Starting dynamic subtest: bcs0
[214.429663] Dynamic subtest bcs0: SUCCESS (2.023s)
[214.439428] Starting dynamic subtest: vcs0
[216.396372] Dynamic subtest vcs0: SUCCESS (2.018s)
[216.404752] Starting dynamic subtest: vcs1
[218.465059] Dynamic subtest vcs1: SUCCESS (2.017s)
[218.475070] Starting dynamic subtest: vecs0
[220.435029] Dynamic subtest vecs0: SUCCESS (2.018s)
[220.443766] Starting dynamic subtest: ccs0
[222.507051] Dynamic subtest ccs0: SUCCESS (2.021s)
[222.509861] Subtest fairslice: SUCCESS (12.123s)
[222.752419] [028/133] (798s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[222.861894] Starting subtest: x-tiled-16bpp-rotate-180
[224.207303] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.345s)
[224.312779] [029/133] (796s left) kms_psr (psr2-no-drrs)
[224.404492] Starting subtest: psr2-no-drrs
[224.406314] Starting dynamic subtest: eDP-1
[226.030039] Dynamic subtest eDP-1: SUCCESS (1.626s)
[226.032363] Subtest psr2-no-drrs: SUCCESS (1.627s)
[226.829883] [030/133] (794s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[226.926051] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[226.930057] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[227.013739] [031/133] (794s left) gem_unref_active_buffers
[227.194656] [032/133] (793s left) kms_vblank (query-forked)
[227.280151] Starting subtest: query-forked
[227.282326] Starting dynamic subtest: pipe-A-eDP-1
[229.090130] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[229.103993] Starting dynamic subtest: pipe-D-eDP-1
[231.631175] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[231.633667] Subtest query-forked: SUCCESS (4.353s)
[232.498480] [033/133] (788s left) syncobj_timeline (wait-all-snapshot)
[232.564029] Starting subtest: wait-all-snapshot
[232.644722] Subtest wait-all-snapshot: SUCCESS (0.082s)
[232.722219] [034/133] (788s left) gem_create (create-ext-set-pat)
[232.890040] Starting subtest: create-ext-set-pat
[232.892312] Subtest create-ext-set-pat: SUCCESS (0.001s)
[232.996383] [035/133] (788s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[233.103974] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[233.106323] Starting dynamic subtest: pipe-A-eDP-1
[233.186374] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[233.195098] Starting dynamic subtest: pipe-B-eDP-1
[234.367764] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[234.372473] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.271s)
[235.556055] [036/133] (785s left) syncobj_basic (bad-destroy-pad)
[235.616925] Starting subtest: bad-destroy-pad
[235.619123] Subtest bad-destroy-pad: SUCCESS (0.000s)
[235.699850] [037/133] (785s left) gem_gpgpu_fill (offset-16x16)
[235.757116] Starting subtest: offset-16x16
[235.762486] Subtest offset-16x16: SUCCESS (0.007s)
[235.906611] [038/133] (785s left) gem_exec_params (batch-first)
[235.960858] Starting subtest: batch-first
[235.966354] Subtest batch-first: SUCCESS (0.005s)
[236.076644] [039/133] (785s left) kms_plane_lowres (tiling-4)
[236.167268] Starting subtest: tiling-4
[236.169564] Starting dynamic subtest: pipe-A-eDP-1
[236.174033] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.459934] Starting dynamic subtest: pipe-B-eDP-1
[236.464373] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.472748] Starting dynamic subtest: pipe-C-eDP-1
[236.477168] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.485168] Starting dynamic subtest: pipe-D-eDP-1
[236.489638] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.493876] Subtest tiling-4: SKIP (0.292s)
[237.276327] [040/133] (784s left) kms_dirtyfb (default-dirtyfb-ioctl)
[237.388091] Starting subtest: default-dirtyfb-ioctl
[237.390342] Starting dynamic subtest: A-eDP-1
[238.975907] Dynamic subtest A-eDP-1: SUCCESS (1.587s)
[238.978206] Subtest default-dirtyfb-ioctl: SUCCESS (1.588s)
[239.809336] [041/133] (781s left) syncobj_wait (multi-wait-for-submit-signaled)
[239.864217] Starting subtest: multi-wait-for-submit-signaled
[239.866220] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[239.947403] [042/133] (781s left) gem_exec_balancer (bonded-dual)
[240.017227] Starting subtest: bonded-dual
[240.021548] Subtest bonded-dual: SKIP (0.000s)
[240.317917] [043/133] (781s left) i915_selftest (live)
[243.581298] Starting subtest: live
[243.583443] Starting dynamic subtest: sanitycheck
[247.881814] Dynamic subtest sanitycheck: SUCCESS (4.300s)
[247.890017] Starting dynamic subtest: uncore
[252.223548] Dynamic subtest uncore: SUCCESS (4.340s)
[252.232178] Starting dynamic subtest: workarounds
[255.327716] Dynamic subtest workarounds: SUCCESS (3.103s)
[255.337588] Starting dynamic subtest: gt_engines
[258.453219] Dynamic subtest gt_engines: SUCCESS (3.124s)
[258.462644] Starting dynamic subtest: gt_timelines
[274.426404] Dynamic subtest gt_timelines: SUCCESS (15.969s)
[274.435753] Starting dynamic subtest: gt_contexts
[278.766432] Dynamic subtest gt_contexts: SUCCESS (4.339s)
[278.775025] Starting dynamic subtest: gt_lrc
[284.881066] Dynamic subtest gt_lrc: SUCCESS (6.112s)
[284.890156] Starting dynamic subtest: gt_mocs
[287.836348] Dynamic subtest gt_mocs: SUCCESS (2.954s)
[287.844643] Starting dynamic subtest: gt_pm
[292.559290] Dynamic subtest gt_pm: SUCCESS (4.721s)
[292.568359] Starting dynamic subtest: gt_heartbeat
[296.890622] Dynamic subtest gt_heartbeat: SUCCESS (4.330s)
[296.899311] Starting dynamic subtest: gt_tlb
[306.162652] Dynamic subtest gt_tlb: SUCCESS (9.270s)
[306.171817] Starting dynamic subtest: requests
[319.806393] Dynamic subtest requests: SUCCESS (13.641s)
[319.815216] Starting dynamic subtest: migrate
[327.472681] Dynamic subtest migrate: SUCCESS (7.664s)
[327.480685] Starting dynamic subtest: active
[331.809352] Dynamic subtest active: SUCCESS (4.335s)
[331.817236] Starting dynamic subtest: objects
[336.540054] Dynamic subtest objects: SUCCESS (4.728s)
[336.549207] Starting dynamic subtest: mman
[341.300889] Dynamic subtest mman: SUCCESS (4.758s)
[341.310168] Starting dynamic subtest: dmabuf
[344.019239] Dynamic subtest dmabuf: SUCCESS (2.715s)
[344.027512] Starting dynamic subtest: vma
[348.318356] Dynamic subtest vma: SUCCESS (4.298s)
[348.327416] Starting dynamic subtest: coherency
[353.846904] Dynamic subtest coherency: SUCCESS (5.526s)
[353.853618] Starting dynamic subtest: gtt
[363.689792] Dynamic subtest gtt: SUCCESS (9.842s)
[363.699433] Starting dynamic subtest: gem
[371.566028] Dynamic subtest gem: SUCCESS (7.874s)
[371.574872] Starting dynamic subtest: evict
[377.078871] Dynamic subtest evict: SUCCESS (5.511s)
[377.087653] Starting dynamic subtest: hugepages
[387.867834] Dynamic subtest hugepages: SUCCESS (10.787s)
[387.877013] Starting dynamic subtest: gem_contexts
[414.643255] Dynamic subtest gem_contexts: SUCCESS (26.773s)
[414.652083] Starting dynamic subtest: client
[419.003305] Dynamic subtest client: SUCCESS (4.359s)
[419.012769] Starting dynamic subtest: gem_migrate
[423.362997] Dynamic subtest gem_migrate: SUCCESS (4.358s)
[423.374570] Starting dynamic subtest: reset
[426.109412] Dynamic subtest reset: SUCCESS (2.744s)
[426.119281] Starting dynamic subtest: memory_region
[430.415738] Dynamic subtest memory_region: SUCCESS (4.305s)
[430.425358] Starting dynamic subtest: hangcheck
[443.347399] Dynamic subtest hangcheck: SUCCESS (12.928s)
[443.356923] Starting dynamic subtest: execlists
[447.712348] Dynamic subtest execlists: SUCCESS (4.362s)
[447.721871] Starting dynamic subtest: ring_submission
[452.010825] Dynamic subtest ring_submission: SUCCESS (4.296s)
[452.020775] Starting dynamic subtest: perf
[456.290070] Dynamic subtest perf: SUCCESS (4.278s)
[456.299046] Starting dynamic subtest: slpc
[470.265676] Dynamic subtest slpc: SUCCESS (13.974s)
[470.274565] Starting dynamic subtest: guc
[474.166578] Dynamic subtest guc: SUCCESS (3.900s)
[474.175030] Starting dynamic subtest: guc_multi_lrc
[478.442049] Dynamic subtest guc_multi_lrc: SUCCESS (4.273s)
[478.451320] Starting dynamic subtest: guc_hang
[483.303112] Dynamic subtest guc_hang: SUCCESS (4.859s)
[483.312362] Starting dynamic subtest: late_gt_pm
[486.035293] Dynamic subtest late_gt_pm: SUCCESS (2.732s)
[486.037798] Subtest live: SUCCESS (242.446s)
[486.066295] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[486.069399] [044/133] (535s left) kms_tv_load_detect (load-detect)
[487.625246] Subtest load-detect: SKIP (0.000s)
[487.681818] [FACT kms_tv_load_detect (load-detect)] new: kernel.kmod_is_loaded.i915: true
[487.685752] [045/133] (533s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[487.796656] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[487.800764] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[487.898870] [046/133] (533s left) kms_async_flips (async-flip-hang)
[487.998989] Starting subtest: async-flip-hang
[488.372586] Starting dynamic subtest: pipe-A-eDP-1
[503.357481] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.973s)
[503.716819] Starting dynamic subtest: pipe-B-eDP-1
[519.347246] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.630s)
[519.738301] Starting dynamic subtest: pipe-C-eDP-1
[535.353366] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.608s)
[535.720928] Starting dynamic subtest: pipe-D-eDP-1
[551.408654] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.691s)
[551.411159] Subtest async-flip-hang: SUCCESS (63.407s)
[552.606858] [047/133] (469s left) kms_pm_rpm (cursor)
[554.136056] Starting subtest: cursor
[554.140719] Subtest cursor: SKIP (0.000s)
[554.857904] [048/133] (466s left) gem_userptr_blits (relocations)
[554.924321] Starting subtest: relocations
[554.928451] Subtest relocations: SKIP (0.001s)
[555.040152] [049/133] (466s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[557.013856] Starting subtest: modeset-non-lpsp-stress-no-wait
[557.063367] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.049s)
[557.420142] [050/133] (464s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[557.513617] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[557.515855] Starting dynamic subtest: pipe-A
[557.575772] Dynamic subtest pipe-A: SUCCESS (0.066s)
[557.585788] Starting dynamic subtest: pipe-B
[558.751057] Dynamic subtest pipe-B: SUCCESS (1.173s)
[558.761284] Starting dynamic subtest: pipe-C
[559.848697] Dynamic subtest pipe-C: SUCCESS (1.096s)
[559.856514] Starting dynamic subtest: pipe-D
[560.978622] Dynamic subtest pipe-D: SUCCESS (1.129s)
[560.980911] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.470s)
[562.132415] [051/133] (459s left) kms_async_flips (invalid-async-flip)
[562.219677] Starting subtest: invalid-async-flip
[562.594214] Starting dynamic subtest: pipe-A-eDP-1
[563.465951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[563.824482] Starting dynamic subtest: pipe-B-eDP-1
[564.612778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.794s)
[564.972750] Starting dynamic subtest: pipe-C-eDP-1
[565.820313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.855s)
[566.185435] Starting dynamic subtest: pipe-D-eDP-1
[566.958368] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[566.960668] Subtest invalid-async-flip: SUCCESS (4.741s)
[568.112800] [052/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[568.230645] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[574.898761] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.671s)
[575.007737] [053/133] (446s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[575.131218] Starting subtest: 2x-cursor-vs-flip-atomic
[575.135538] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[575.273486] [054/133] (446s left) kms_lease (setcrtc-implicit-plane)
[575.360940] Starting subtest: setcrtc-implicit-plane
[575.363220] Starting dynamic subtest: pipe-A-eDP-1
[575.833721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.471s)
[575.842081] Starting dynamic subtest: pipe-B-eDP-1
[576.973866] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[576.981785] Starting dynamic subtest: pipe-C-eDP-1
[578.078546] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[578.087599] Starting dynamic subtest: pipe-D-eDP-1
[579.219763] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[579.222062] Subtest setcrtc-implicit-plane: SUCCESS (3.861s)
[580.062276] [055/133] (441s left) kms_flip (flip-vs-panning-interruptible)
[580.166389] Starting subtest: flip-vs-panning-interruptible
[580.168626] Starting dynamic subtest: A-eDP1
[588.879333] Dynamic subtest A-eDP1: SUCCESS (8.711s)
[588.890640] Starting dynamic subtest: B-eDP1
[597.607685] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[597.616418] Starting dynamic subtest: C-eDP1
[606.336514] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[606.345614] Starting dynamic subtest: D-eDP1
[615.059232] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[615.063679] Subtest flip-vs-panning-interruptible: SUCCESS (34.898s)
[616.226228] [056/133] (405s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[616.336427] Starting subtest: x-tiled-addfb-size-offset-overflow
[616.338605] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[616.453429] [057/133] (405s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[616.553033] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[616.555227] Starting dynamic subtest: pipe-A-eDP-1
[616.613339] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[616.621774] Starting dynamic subtest: pipe-B-eDP-1
[616.678501] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[616.687892] Starting dynamic subtest: pipe-C-eDP-1
[616.746071] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[616.755788] Starting dynamic subtest: pipe-D-eDP-1
[616.811777] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[616.816054] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[618.804604] [058/133] (403s left) kms_prop_blob (invalid-get-prop-any)
[618.858449] Starting subtest: invalid-get-prop-any
[618.860623] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[618.951339] [059/133] (403s left) core_getclient (basic)
[619.004794] Starting subtest: basic
[619.007085] Subtest basic: SUCCESS (0.000s)
[619.100222] [060/133] (403s left) gem_mmap_offset (partial-unmap)
[619.158042] Starting subtest: partial-unmap
[619.160213] Starting dynamic subtest: smem0
[619.667398] Dynamic subtest smem0: SUCCESS (0.509s)
[619.670262] Subtest partial-unmap: SUCCESS (0.510s)
[619.806223] [061/133] (402s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[619.878393] Starting subtest: invalid-bsd1-flag-on-blt
[619.880730] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[619.996240] [062/133] (402s left) gem_workarounds (reset)
[620.065996] Starting subtest: reset
[620.208309] Subtest reset: SUCCESS (0.142s)
[620.334511] [063/133] (402s left) syncobj_eventfd (invalid-illegal-handle)
[620.397607] Starting subtest: invalid-illegal-handle
[620.399583] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[620.489243] [064/133] (401s left) gem_exec_schedule (semaphore-codependency)
[620.555082] Starting subtest: semaphore-codependency
[620.561926] Subtest semaphore-codependency: SUCCESS (0.016s)
[620.889920] [065/133] (401s left) gem_tiled_partial_pwrite_pread (reads)
[620.950762] Subtest reads: SKIP (0.000s)
[621.019567] [066/133] (401s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[621.119625] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[628.404022] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.287s)
[628.527031] [067/133] (393s left) gem_spin_batch (resubmit-new)
[628.596767] Starting subtest: resubmit-new
[628.599170] Starting dynamic subtest: rcs0
[628.605761] Dynamic subtest rcs0: SUCCESS (0.009s)
[628.615895] Starting dynamic subtest: bcs0
[628.618308] Dynamic subtest bcs0: SUCCESS (0.004s)
[628.626327] Starting dynamic subtest: vcs0
[628.628680] Dynamic subtest vcs0: SUCCESS (0.006s)
[628.636954] Starting dynamic subtest: vcs1
[628.638813] Dynamic subtest vcs1: SUCCESS (0.004s)
[628.646531] Starting dynamic subtest: vecs0
[628.648439] Dynamic subtest vecs0: SUCCESS (0.004s)
[628.656136] Starting dynamic subtest: ccs0
[628.657978] Dynamic subtest ccs0: SUCCESS (0.004s)
[628.659836] Subtest resubmit-new: SUCCESS (0.035s)
[629.959142] [068/133] (392s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[630.068535] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[630.072639] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[630.171049] [069/133] (392s left) gem_mmap_gtt (cpuset-big-copy-xy)
[630.227503] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[630.284162] [070/133] (392s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[630.365693] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[630.369936] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[630.438321] [071/133] (392s left) syncobj_wait (single-wait-all-for-submit-signaled)
[630.495510] Starting subtest: single-wait-all-for-submit-signaled
[630.497490] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[630.608696] [072/133] (392s left) kms_cursor_edge_walk (64x64-left-edge)
[630.707405] Starting subtest: 64x64-left-edge
[630.709739] Starting dynamic subtest: pipe-A-eDP-1
[634.177301] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[634.186685] Starting dynamic subtest: pipe-D-eDP-1
[637.329259] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.149s)
[637.331454] Subtest 64x64-left-edge: SUCCESS (6.623s)
[638.129668] [073/133] (384s left) api_intel_allocator (open-vm)
[638.182563] Starting subtest: open-vm
[638.185081] Subtest open-vm: SUCCESS (0.003s)
[638.303282] [074/133] (384s left) kms_joiner (basic-force-ultra-joiner)
[638.392523] Starting subtest: basic-force-ultra-joiner
[638.396639] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[638.456252] [075/133] (384s left) sw_sync (timeline_closed)
[638.501804] Starting subtest: timeline_closed
[638.504074] Subtest timeline_closed: SUCCESS (0.000s)
[638.560308] [076/133] (384s left) kms_hdmi_inject (inject-4k)
[638.892213] Starting subtest: inject-4k
[639.208022] Subtest inject-4k: SUCCESS (0.316s)
[639.803719] [077/133] (383s left) i915_drm_fdinfo (virtual-busy-idle)
[639.842399] Starting subtest: virtual-busy-idle
[639.846822] Subtest virtual-busy-idle: SKIP (0.000s)
[639.904544] [078/133] (383s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[640.005817] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[643.974592] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.972s)
[645.102938] [079/133] (377s left) kms_chamelium_color (ctm-0-75)
[645.194193] Subtest ctm-0-75: SKIP (0.000s)
[645.242600] [080/133] (377s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[645.336775] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[645.339075] Starting dynamic subtest: pipe-A-eDP-1
[645.360571] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[645.370681] Starting dynamic subtest: pipe-B-eDP-1
[645.391356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[645.399609] Starting dynamic subtest: pipe-C-eDP-1
[645.420289] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[645.429676] Starting dynamic subtest: pipe-D-eDP-1
[645.450343] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[645.454510] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[647.640314] [081/133] (375s left) gem_userptr_blits (dmabuf-unsync)
[647.709332] Subtest dmabuf-unsync: SKIP (0.000s)
[647.818080] [082/133] (375s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[647.919593] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[647.923971] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[648.021129] [083/133] (375s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[648.126467] Starting subtest: extended-modeset-hang-newfb-with-reset
[648.128673] Starting dynamic subtest: pipe-A
[661.686777] Dynamic subtest pipe-A: SUCCESS (13.557s)
[661.698206] Starting dynamic subtest: pipe-D
[678.057581] Dynamic subtest pipe-D: SUCCESS (16.363s)
[678.059702] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.929s)
[678.857913] [084/133] (344s left) prime_busy (after)
[678.932111] Starting subtest: after
[678.938499] Starting dynamic subtest: rcs0
[678.965199] Dynamic subtest rcs0: SUCCESS (0.027s)
[678.977617] Starting dynamic subtest: bcs0
[679.017927] Dynamic subtest bcs0: SUCCESS (0.050s)
[679.035075] Starting dynamic subtest: vcs0
[679.058220] Dynamic subtest vcs0: SUCCESS (0.038s)
[679.067294] Starting dynamic subtest: vcs1
[679.098051] Dynamic subtest vcs1: SUCCESS (0.038s)
[679.106739] Starting dynamic subtest: vecs0
[679.137602] Dynamic subtest vecs0: SUCCESS (0.039s)
[679.146570] Starting dynamic subtest: ccs0
[679.178067] Dynamic subtest ccs0: SUCCESS (0.039s)
[679.286282] Subtest after: SUCCESS (0.355s)
[679.363317] [085/133] (343s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[679.461294] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[679.465388] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[679.537218] [086/133] (343s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[679.600377] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[679.604694] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[679.779101] [087/133] (343s left) gem_ctx_shared (exec-shared-gtt)
[679.841306] Starting subtest: exec-shared-gtt
[679.843694] Starting dynamic subtest: rcs0
[679.849256] Dynamic subtest rcs0: SUCCESS (0.008s)
[679.858340] Starting dynamic subtest: bcs0
[679.860264] Dynamic subtest bcs0: SUCCESS (0.005s)
[679.869020] Starting dynamic subtest: vcs0
[679.871186] Dynamic subtest vcs0: SUCCESS (0.007s)
[679.879823] Starting dynamic subtest: vcs1
[679.882041] Dynamic subtest vcs1: SUCCESS (0.006s)
[679.890358] Starting dynamic subtest: vecs0
[679.892223] Dynamic subtest vecs0: SUCCESS (0.006s)
[679.900145] Starting dynamic subtest: ccs0
[679.902075] Dynamic subtest ccs0: SUCCESS (0.006s)
[679.903949] Subtest exec-shared-gtt: SUCCESS (0.042s)
[680.081053] [088/133] (343s left) kms_getfb (getfb-handle-valid)
[680.177495] Starting subtest: getfb-handle-valid
[680.179842] Subtest getfb-handle-valid: SUCCESS (0.000s)
[680.270802] [089/133] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[680.385192] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[680.389347] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[680.502350] [090/133] (342s left) kms_content_protection (atomic-dpms-hdcp14)
[680.651771] Starting subtest: atomic-dpms-hdcp14
[680.656302] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[680.758331] [091/133] (342s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[680.854748] Starting subtest: plane-primary-toggle-with-vblank-wait
[680.856746] Starting dynamic subtest: pipe-A-eDP-1
[681.027861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[681.330999] Starting dynamic subtest: pipe-B-eDP-1
[682.254548] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.932s)
[682.561909] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.707s)
[683.419240] [092/133] (340s left) gem_mmap_gtt (basic-read-write-distinct)
[683.479309] Subtest basic-read-write-distinct: SKIP (0.000s)
[683.537247] [093/133] (340s left) gem_exec_params (cliprects_ptr-dirt)
[683.604663] Starting subtest: cliprects_ptr-dirt
[683.606530] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[683.716542] [094/133] (339s left) sw_sync (sync_merge_invalid)
[683.759121] Starting subtest: sync_merge_invalid
[683.773454] Subtest sync_merge_invalid: SUCCESS (0.014s)
[683.828280] [095/133] (339s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[683.946133] Starting subtest: flip-vs-cursor-atomic
[691.425726] Subtest flip-vs-cursor-atomic: SUCCESS (7.480s)
[692.264092] [096/133] (331s left) kms_psr (fbc-psr-primary-render)
[692.369824] Starting subtest: fbc-psr-primary-render
[692.372107] Starting dynamic subtest: eDP-1
[692.376212] Dynamic subtest eDP-1: SKIP (0.000s)
[692.380248] Subtest fbc-psr-primary-render: SKIP (0.001s)
[692.453728] [097/133] (331s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[692.515308] Subtest no-spare-fences-busy: SKIP (0.000s)
[692.588988] [098/133] (331s left) kms_chamelium_hpd (hdmi-hpd-storm)
[692.957395] Subtest hdmi-hpd-storm: SKIP (0.000s)
[693.803934] [099/133] (330s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[694.015501] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[698.051994] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.039s)
[699.270785] [100/133] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[699.380186] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[699.384495] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[699.472783] [101/133] (324s left) fbdev (eof)
[699.522193] Starting subtest: eof
[699.524337] Subtest eof: SUCCESS (0.000s)
[699.590376] [102/133] (324s left) perf (gen12-unprivileged-single-ctx-counters)
[699.713936] Starting subtest: gen12-unprivileged-single-ctx-counters
[699.716043] Starting dynamic subtest: rcs0
[699.862274] Dynamic subtest rcs0: SUCCESS (0.149s)
[699.864610] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.151s)
[699.910269] [103/133] (324s left) kms_feature_discovery (display-1x)
[700.000037] Starting subtest: display-1x
[700.002243] Subtest display-1x: SUCCESS (0.000s)
[700.072182] [104/133] (324s left) kms_chamelium_edid (dp-mode-timings)
[700.446178] Subtest dp-mode-timings: SKIP (0.000s)
[701.275099] [105/133] (322s left) gem_mmap_gtt (basic-wc)
[701.326547] Subtest basic-wc: SKIP (0.000s)
[701.393386] [106/133] (322s left) kms_fbcon_fbt (fbc-suspend)
[701.442580] Starting subtest: fbc-suspend
[750.772727] Subtest fbc-suspend: SUCCESS (20.728s)
[752.102113] [107/133] (272s left) perf_pmu (busy-idle)
[752.150452] Starting subtest: busy-idle
[752.152653] Starting dynamic subtest: rcs0
[752.826731] Dynamic subtest rcs0: SUCCESS (0.679s)
[752.844669] Starting dynamic subtest: bcs0
[753.487414] Dynamic subtest bcs0: SUCCESS (0.660s)
[753.499899] Starting dynamic subtest: vcs0
[755.537077] Dynamic subtest vcs0: SUCCESS (2.049s)
[755.549904] Starting dynamic subtest: vcs1
[757.519558] Dynamic subtest vcs1: SUCCESS (1.982s)
[757.531021] Starting dynamic subtest: vecs0
[759.503892] Dynamic subtest vecs0: SUCCESS (1.984s)
[759.517293] Starting dynamic subtest: ccs0
[760.168714] Dynamic subtest ccs0: SUCCESS (0.664s)
[760.171763] Subtest busy-idle: SUCCESS (8.034s)
[760.260065] [108/133] (263s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[760.363620] Starting subtest: basic-max-pipe-crc-check
[760.368002] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[760.411633] [109/133] (263s left) dumb_buffer (create-clear)
[760.473128] Starting subtest: create-clear
[794.984614] Subtest create-clear: SUCCESS (34.469s)
[795.048320] [110/133] (229s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[795.158049] Starting subtest: 4-tiled-32bpp-rotate-0
[796.539958] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.384s)
[796.672669] [111/133] (227s left) kms_big_fb (linear-16bpp-rotate-180)
[796.784402] Starting subtest: linear-16bpp-rotate-180
[798.175925] Subtest linear-16bpp-rotate-180: SUCCESS (1.391s)
[798.298962] [112/133] (226s left) gem_pread (self)
[798.352891] Subtest self: SKIP (0.000s)
[798.424602] [113/133] (226s left) kms_psr2_su (frontbuffer-xrgb8888)
[798.481301] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[798.556295] [114/133] (225s left) gem_exec_parallel (basic)
[798.620549] Starting subtest: basic
[798.622438] Starting dynamic subtest: rcs0
[800.029295] Dynamic subtest rcs0: SUCCESS (1.411s)
[800.039657] Starting dynamic subtest: bcs0
[801.531350] Dynamic subtest bcs0: SUCCESS (1.501s)
[801.544729] Starting dynamic subtest: vcs0
[803.534894] Dynamic subtest vcs0: SUCCESS (2.000s)
[803.546157] Starting dynamic subtest: vcs1
[805.519486] Dynamic subtest vcs1: SUCCESS (1.982s)
[805.531879] Starting dynamic subtest: vecs0
[807.504091] Dynamic subtest vecs0: SUCCESS (1.983s)
[807.515414] Starting dynamic subtest: ccs0
[809.044892] Dynamic subtest ccs0: SUCCESS (1.539s)
[809.047712] Subtest basic: SUCCESS (10.430s)
[809.241092] [115/133] (215s left) gem_mmap_wc (read-write-distinct)
[809.293070] Subtest read-write-distinct: SKIP (0.000s)
[809.358998] [116/133] (215s left) gem_ctx_param (invalid-get-engines)
[809.404667] Starting subtest: invalid-get-engines
[809.406888] Subtest invalid-get-engines: SUCCESS (0.001s)
[809.523320] [117/133] (215s left) kms_getfb (getfb-reject-nv12)
[809.624605] Starting subtest: getfb-reject-nv12
[809.626810] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[809.727233] [118/133] (214s left) kms_plane (pixel-format-yf-tiled-modifier)
[809.830989] Starting subtest: pixel-format-yf-tiled-modifier
[809.834968] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[809.906358] [119/133] (214s left) gem_exec_flush (basic-wb-set-default)
[809.972244] Starting subtest: basic-wb-set-default
[815.458285] Subtest basic-wb-set-default: SUCCESS (5.459s)
[815.615923] [120/133] (209s left) vgem_slow (nohang)
[815.725163] Starting subtest: nohang
[825.951499] Subtest nohang: SUCCESS (10.178s)
[825.987675] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[825.991047] [121/133] (198s left) gem_softpin (invalid)
[826.046625] Starting subtest: invalid
[826.056641] Subtest invalid: SUCCESS (0.010s)
[826.167773] [122/133] (198s left) i915_pm_rpm (gem-pread)
[827.698323] Starting subtest: gem-pread
[830.096125] Subtest gem-pread: SUCCESS (2.403s)
[830.194722] [123/133] (194s left) gem_vm_create (invalid-destroy)
[830.243669] Starting subtest: invalid-destroy
[830.245941] Subtest invalid-destroy: SUCCESS (0.002s)
[830.355599] [124/133] (194s left) syncobj_wait (wait-any-snapshot)
[830.412915] Starting subtest: wait-any-snapshot
[830.494219] Subtest wait-any-snapshot: SUCCESS (0.082s)
[830.570235] [125/133] (194s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[830.659826] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[830.664498] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[830.758076] [126/133] (194s left) kms_psr (fbc-psr2-cursor-plane-move)
[830.848135] Starting subtest: fbc-psr2-cursor-plane-move
[830.850424] Starting dynamic subtest: eDP-1
[830.854608] Dynamic subtest eDP-1: SKIP (0.000s)
[830.858925] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[830.924964] [127/133] (194s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[831.015170] Starting subtest: fbcpsr-rgb101010-draw-blt
[837.832092] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.822s)
[837.946765] [128/133] (187s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[838.488057] Starting subtest: syncobj-timeline-multiple-ext-nodes
[838.490386] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[839.575270] [129/133] (185s left) gem_render_tiled_blits (basic)
[839.653325] Subtest basic: SKIP (0.000s)
[839.729640] [130/133] (185s left) i915_drm_fdinfo (memory-info-purgeable)
[839.772712] Starting subtest: memory-info-purgeable
[839.775003] Starting dynamic subtest: smem0
[842.775251] Dynamic subtest smem0: SUCCESS (3.004s)
[842.777679] Subtest memory-info-purgeable: SUCCESS (3.005s)
[842.852655] [131/133] (182s left) kms_scaling_modes (scaling-mode-full-aspect)
[842.949130] Starting subtest: scaling-mode-full-aspect
[842.950977] Starting dynamic subtest: pipe-A-eDP-1
[843.041338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[843.053844] Starting dynamic subtest: pipe-B-eDP-1
[844.218520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s)
[844.231924] Starting dynamic subtest: pipe-C-eDP-1
[845.335908] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[845.348388] Starting dynamic subtest: pipe-D-eDP-1
[846.469481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[846.471657] Subtest scaling-mode-full-aspect: SUCCESS (3.522s)
[847.638195] [132/133] (177s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[847.738054] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[847.741974] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[847.835294] [133/133] (177s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[847.933501] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[854.660599] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.725s)
[854.797325] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_color_pipeline
results: parsing output: 5/ for test: kms_sequence
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_unref_active_buffers
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_create
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: gem_gpgpu_fill
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_plane_lowres
results: parsing output: 39/ for test: kms_dirtyfb
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: i915_selftest
results: parsing output: 43/ for test: kms_tv_load_detect
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: core_getclient
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: gem_workarounds
results: parsing output: 62/ for test: syncobj_eventfd
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_cursor_edge_walk
results: parsing output: 72/ for test: api_intel_allocator
results: parsing output: 73/ for test: kms_joiner
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_hdmi_inject
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: prime_busy
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_ctx_shared
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_content_protection
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_fenced_exec_thrash
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: fbdev
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_fbcon_fbt
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_multipipe_modeset
results: parsing output: 108/ for test: dumb_buffer
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_pread
results: parsing output: 112/ for test: kms_psr2_su
results: parsing output: 113/ for test: gem_exec_parallel
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: vgem_slow
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: gem_vm_create
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_render_tiled_blits
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: kms_scaling_modes
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.