[59.083102] Initializing watchdogs
[59.083146]   /dev/watchdog0
[59.096645] [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.100489] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.102718] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.105908] [001/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[59.267989] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[60.276941] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.018s)
[60.409182] [002/133] (959s left) kms_prop_blob (invalid-set-prop)
[60.474535] Starting subtest: invalid-set-prop
[60.476862] Subtest invalid-set-prop: SUCCESS (0.000s)
[60.571020] [003/133] (959s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[60.667497] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[60.669460] Starting dynamic subtest: pipe-A-eDP-1
[60.677395] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.684736] Starting dynamic subtest: pipe-B-eDP-1
[60.692395] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.699485] Starting dynamic subtest: pipe-C-eDP-1
[60.706539] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.712456] Starting dynamic subtest: pipe-D-eDP-1
[60.719477] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.722973] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s)
[62.819354] [004/133] (956s left) kms_rotation_crc (bad-pixel-format)
[62.915962] Starting subtest: bad-pixel-format
[62.920326] Subtest bad-pixel-format: SKIP (0.001s)
[62.980579] [005/133] (956s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[63.083751] Starting subtest: pipe-fbc-rte
[63.090543] Starting dynamic subtest: pipe-B-eDP-1
[67.441148] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.382s)
[67.448542] Subtest pipe-fbc-rte: SUCCESS (4.383s)
[68.632167] [006/133] (951s left) vgem_basic (unload)
[68.667449] Starting subtest: unload
[97.866880] Subtest unload: SUCCESS (29.216s)
[97.951879] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[97.954882] [007/133] (921s left) kms_vrr (lobf)
[98.052944] Starting subtest: lobf
[98.057438] Subtest lobf: SKIP (0.000s)
[98.118162] [008/133] (921s left) gem_userptr_blits (create-destroy-sync)
[98.184665] Starting subtest: create-destroy-sync
[103.205377] Subtest create-destroy-sync: SUCCESS (5.020s)
[103.351190] [009/133] (916s left) gen7_exec_parse (chained-batch)
[103.421246] Subtest chained-batch: SKIP (0.000s)
[103.502285] [010/133] (916s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[103.616253] Starting subtest: yf-tiled-16bpp-rotate-0
[103.620506] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[103.702698] [011/133] (916s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[103.831307] Starting subtest: cursorB-vs-flipB-varying-size
[103.835704] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[103.960629] [012/133] (915s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[104.085984] Starting subtest: 2x-cursor-vs-flip-atomic
[104.089979] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[104.212467] [013/133] (915s left) gem_exec_endless (dispatch)
[104.279303] Starting subtest: dispatch
[104.281352] Starting dynamic subtest: rcs0
[104.286805] Dynamic subtest rcs0: SUCCESS (0.005s)
[104.295515] Starting dynamic subtest: bcs0
[104.299022] Dynamic subtest bcs0: SUCCESS (0.004s)
[104.306051] Starting dynamic subtest: vcs0
[104.309991] Dynamic subtest vcs0: SUCCESS (0.004s)
[104.315991] Starting dynamic subtest: vcs1
[104.319295] Dynamic subtest vcs1: SUCCESS (0.004s)
[104.325230] Starting dynamic subtest: vecs0
[104.328622] Dynamic subtest vecs0: SUCCESS (0.005s)
[104.334734] Starting dynamic subtest: ccs0
[104.338204] Dynamic subtest ccs0: SUCCESS (0.005s)
[104.339754] Subtest dispatch: SUCCESS (0.028s)
[106.002640] [014/133] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[106.102622] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[106.107161] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[106.203020] [015/133] (913s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[106.306910] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[106.309261] Starting dynamic subtest: pipe-A-eDP-1
[106.332179] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.339557] Starting dynamic subtest: pipe-B-eDP-1
[106.360688] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.367528] Starting dynamic subtest: pipe-C-eDP-1
[106.388879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.396808] Starting dynamic subtest: pipe-D-eDP-1
[106.418664] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.422816] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[108.470969] [016/133] (911s left) kms_psr (psr2-primary-mmap-cpu)
[108.579605] Starting subtest: psr2-primary-mmap-cpu
[108.581768] Starting dynamic subtest: eDP-1
[110.252965] Dynamic subtest eDP-1: SUCCESS (1.672s)
[110.255212] Subtest psr2-primary-mmap-cpu: SUCCESS (1.673s)
[111.115938] [017/133] (908s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[111.180385] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[111.260096] [018/133] (908s left) gem_lmem_swapping (basic)
[111.317615] Subtest basic: SKIP (0.000s)
[111.354748] [019/133] (908s left) gem_exec_reloc (basic-wc-read)
[111.420346] Subtest basic-wc-read: SKIP (0.000s)
[111.496951] [020/133] (908s left) kms_frontbuffer_tracking (psr-1p-rte)
[111.595212] Starting subtest: psr-1p-rte
[114.803624] Subtest psr-1p-rte: SUCCESS (3.212s)
[114.920720] [021/133] (905s left) kms_lease (possible-crtcs-filtering)
[115.036893] Starting subtest: possible-crtcs-filtering
[115.041534] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[115.143902] [022/133] (905s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[115.249623] Starting subtest: psr-rgb101010-draw-mmap-gtt
[115.254086] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[115.352308] [023/133] (904s left) gem_spin_batch (spin-all)
[115.416160] Starting subtest: spin-all
[115.430529] Subtest spin-all: SUCCESS (0.012s)
[116.945617] [024/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[117.044447] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[117.049022] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[117.124122] [025/133] (903s left) kms_pm_rpm (modeset-lpsp-stress)
[119.066170] Starting subtest: modeset-lpsp-stress
[135.376397] Subtest modeset-lpsp-stress: SUCCESS (16.308s)
[135.456276] [026/133] (884s left) drm_fdinfo (all-busy-check-all)
[135.495500] Starting subtest: all-busy-check-all
[135.500340] Subtest all-busy-check-all: SKIP (0.004s)
[135.556389] [027/133] (884s left) kms_atomic_transition (modeset-transition-fencing)
[135.705042] Starting subtest: modeset-transition-fencing
[135.706977] Starting dynamic subtest: 1x-outputs
[146.234798] Dynamic subtest 1x-outputs: SUCCESS (10.529s)
[146.510966] Subtest modeset-transition-fencing: SUCCESS (10.805s)
[147.357664] [028/133] (873s left) kms_content_protection (type1)
[147.532935] Starting subtest: type1
[150.900130] Subtest type1: SKIP (3.364s)
[152.075779] [029/133] (868s left) gem_exec_parallel (fds)
[152.145853] Starting subtest: fds
[152.148326] Starting dynamic subtest: rcs0
[154.582186] Dynamic subtest rcs0: SUCCESS (2.436s)
[154.592072] Starting dynamic subtest: bcs0
[157.816052] Dynamic subtest bcs0: SUCCESS (3.231s)
[157.826539] Starting dynamic subtest: vcs0
[162.100074] Dynamic subtest vcs0: SUCCESS (4.283s)
[162.107241] Starting dynamic subtest: vcs1
[166.152900] Dynamic subtest vcs1: SUCCESS (4.052s)
[166.162907] Starting dynamic subtest: vecs0
[170.198944] Dynamic subtest vecs0: SUCCESS (4.045s)
[170.206131] Starting dynamic subtest: ccs0
[173.073258] Dynamic subtest ccs0: SUCCESS (2.873s)
[173.075831] Subtest fds: SUCCESS (20.924s)
[173.256943] [030/133] (847s left) gem_workarounds (basic-read)
[173.330316] Starting subtest: basic-read
[173.348991] Subtest basic-read: SUCCESS (0.018s)
[173.478854] [031/133] (847s left) kms_universal_plane (universal-plane-sanity)
[173.575094] Starting subtest: universal-plane-sanity
[173.577489] Starting dynamic subtest: pipe-A-eDP-1
[174.230365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.651s)
[174.237730] Starting dynamic subtest: pipe-B-eDP-1
[175.486745] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[175.495103] Starting dynamic subtest: pipe-C-eDP-1
[176.709511] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[176.717692] Starting dynamic subtest: pipe-D-eDP-1
[177.931743] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[177.934206] Subtest universal-plane-sanity: SUCCESS (4.355s)
[178.783651] [032/133] (841s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[178.891266] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[178.893661] Starting dynamic subtest: pipe-A-eDP-1
[178.963401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.071s)
[179.255171] Starting dynamic subtest: pipe-B-eDP-1
[180.089751] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.843s)
[180.365773] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.474s)
[181.237163] [033/133] (839s left) vgem_basic (setversion)
[181.285435] Starting subtest: setversion
[181.289549] Subtest setversion: SUCCESS (0.000s)
[181.340504] [034/133] (839s left) gem_exec_balancer (full)
[181.413999] Starting subtest: full
[185.691645] Subtest full: SUCCESS (4.277s)
[185.991594] [035/133] (834s left) gem_ctx_bad_destroy (invalid-default-ctx)
[186.051774] Starting subtest: invalid-default-ctx
[186.054207] Subtest invalid-default-ctx: SUCCESS (0.000s)
[186.121288] [036/133] (834s left) kms_chamelium_color (ctm-limited-range)
[186.223436] Subtest ctm-limited-range: SKIP (0.000s)
[186.261647] [037/133] (834s left) kms_psr (psr2-sprite-plane-onoff)
[186.363363] Starting subtest: psr2-sprite-plane-onoff
[186.365715] Starting dynamic subtest: eDP-1
[188.130638] Dynamic subtest eDP-1: SUCCESS (1.763s)
[188.132767] Subtest psr2-sprite-plane-onoff: SUCCESS (1.764s)
[188.985297] [038/133] (831s left) vkms/vkms_configfs (plane-valid-values)
[189.091588] Subtest plane-valid-values: SKIP (0.000s)
[189.146535] [039/133] (831s left) fbdev (read)
[189.191532] Starting subtest: read
[189.725154] Subtest read: SUCCESS (0.531s)
[189.781288] [040/133] (831s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[189.881272] Starting subtest: fbc-psr-sprite-mmap-gtt
[189.883619] Starting dynamic subtest: eDP-1
[189.887869] Dynamic subtest eDP-1: SKIP (0.000s)
[189.892294] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[189.972359] [041/133] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[190.069871] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[190.074064] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[190.179938] [042/133] (830s left) gem_exec_fence (basic-wait-all)
[190.241073] Starting subtest: basic-wait-all
[190.352989] Subtest basic-wait-all: SUCCESS (0.112s)
[191.983370] [043/133] (829s left) kms_plane (plane-panning-bottom-right-suspend)
[192.079084] Starting subtest: plane-panning-bottom-right-suspend
[192.081403] Starting dynamic subtest: pipe-A
[209.800132] Dynamic subtest pipe-A: SUCCESS (2.856s)
[209.813504] Starting dynamic subtest: pipe-B
[227.748022] Dynamic subtest pipe-B: SUCCESS (3.321s)
[227.750394] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.179s)
[228.587172] [044/133] (821s left) gem_exec_whisper (basic-forked)
[228.655369] Starting subtest: basic-forked
[235.268604] Subtest basic-forked: SUCCESS (6.707s)
[235.450338] [045/133] (814s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[235.545052] Starting subtest: random-ccs-data-y-tiled-ccs
[235.547459] Starting dynamic subtest: pipe-A-eDP-1
[235.572625] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.582700] Starting dynamic subtest: pipe-B-eDP-1
[235.606519] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.615146] Starting dynamic subtest: pipe-C-eDP-1
[235.638433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.646559] Starting dynamic subtest: pipe-D-eDP-1
[235.670661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.674768] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[237.740104] [046/133] (812s left) syncobj_timeline (32bits-limit)
[237.803205] Starting subtest: 32bits-limit
[237.805653] Subtest 32bits-limit: SUCCESS (0.001s)
[237.916404] [047/133] (812s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[242.873127] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[242.875574] Starting dynamic subtest: pipe-A-eDP-1
[260.041164] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.191s)
[260.050503] Starting dynamic subtest: pipe-B-eDP-1
[277.161122] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.111s)
[277.163506] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.306s)
[277.962841] [048/133] (772s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[278.018672] Starting subtest: yf-tiled-to-vebox-x-tiled
[278.023227] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[278.197368] [049/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[278.288803] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[278.293271] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[278.397293] [050/133] (772s left) gem_mmap_offset (bad-flags)
[278.460244] Starting subtest: bad-flags
[278.462102] Subtest bad-flags: SUCCESS (0.000s)
[278.552925] [051/133] (772s left) kms_addfb_basic (size-max)
[278.663527] Starting subtest: size-max
[278.665833] Subtest size-max: SUCCESS (0.000s)
[278.778184] [052/133] (771s left) gem_exec_schedule (preempt-contexts)
[278.850888] Starting subtest: preempt-contexts
[278.852800] Starting dynamic subtest: rcs0
[278.895915] Dynamic subtest rcs0: SUCCESS (0.048s)
[278.904829] Starting dynamic subtest: bcs0
[278.947068] Dynamic subtest bcs0: SUCCESS (0.048s)
[278.958501] Starting dynamic subtest: vcs0
[278.986785] Dynamic subtest vcs0: SUCCESS (0.041s)
[278.995362] Starting dynamic subtest: vcs1
[279.022600] Dynamic subtest vcs1: SUCCESS (0.035s)
[279.031105] Starting dynamic subtest: vecs0
[279.059860] Dynamic subtest vecs0: SUCCESS (0.035s)
[279.071287] Starting dynamic subtest: ccs0
[279.101104] Dynamic subtest ccs0: SUCCESS (0.040s)
[279.103004] Subtest preempt-contexts: SUCCESS (0.251s)
[280.596646] [053/133] (770s left) gen3_render_linear_blits
[280.715355] [054/133] (770s left) api_intel_bb (add-remove-objects)
[280.777058] Starting subtest: add-remove-objects
[280.782583] Subtest add-remove-objects: SUCCESS (0.007s)
[280.903993] [055/133] (769s left) gem_mmap_gtt (bad-object)
[280.951461] Subtest bad-object: SKIP (0.000s)
[281.006276] [056/133] (769s left) gem_softpin (softpin)
[281.076072] Starting subtest: softpin
[313.345260] Subtest softpin: SUCCESS (32.271s)
[313.482138] [057/133] (737s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[313.577549] Starting subtest: nonblocking-crc-frame-sequence
[313.579833] Starting dynamic subtest: pipe-A-eDP-1
[314.326346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[314.334898] Starting dynamic subtest: pipe-B-eDP-1
[315.751216] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[315.759906] Starting dynamic subtest: pipe-C-eDP-1
[317.136045] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[317.145345] Starting dynamic subtest: pipe-D-eDP-1
[318.441174] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[318.443809] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.864s)
[319.248972] [058/133] (731s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[319.362695] Starting subtest: short-busy-flip-before-cursor-toggle
[319.367022] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[319.490248] [059/133] (731s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[319.587467] Starting subtest: psr-dirtyfb-ioctl
[319.589354] Starting dynamic subtest: A-eDP-1
[321.418651] Dynamic subtest A-eDP-1: SUCCESS (1.832s)
[321.421027] Subtest psr-dirtyfb-ioctl: SUCCESS (1.834s)
[322.276096] [060/133] (728s left) syncobj_wait (multi-wait-for-submit-submitted)
[322.338828] Starting subtest: multi-wait-for-submit-submitted
[322.437738] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[322.514791] [061/133] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[322.623890] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[327.799024] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.175s)
[327.956689] [062/133] (723s left) i915_pm_rps (thresholds-idle-park)
[328.026990] Starting subtest: thresholds-idle-park
[328.031394] Subtest thresholds-idle-park: SKIP (0.000s)
[328.099649] [063/133] (722s left) sysfs_preempt_timeout (timeout)
[328.155112] Starting subtest: timeout
[328.157449] Starting dynamic subtest: vecs0
[337.505907] Dynamic subtest vecs0: SUCCESS (9.342s)
[337.517044] Starting dynamic subtest: ccs0
[338.810216] Dynamic subtest ccs0: SUCCESS (1.305s)
[338.819772] Starting dynamic subtest: vcs0
[348.533987] Dynamic subtest vcs0: SUCCESS (9.721s)
[348.545352] Starting dynamic subtest: bcs0
[349.829646] Dynamic subtest bcs0: SUCCESS (1.295s)
[349.840006] Starting dynamic subtest: rcs0
[351.100410] Dynamic subtest rcs0: SUCCESS (1.269s)
[351.109970] Starting dynamic subtest: vcs1
[360.500705] Dynamic subtest vcs1: SUCCESS (9.396s)
[360.503057] Subtest timeout: SUCCESS (32.337s)
[360.571589] [064/133] (690s left) kms_chamelium_hpd (vga-hpd)
[360.944404] Subtest vga-hpd: SKIP (0.000s)
[361.722301] [065/133] (689s left) kms_psr (fbc-pr-suspend)
[361.828500] Starting subtest: fbc-pr-suspend
[361.832865] Subtest fbc-pr-suspend: SKIP (0.000s)
[361.899933] [066/133] (689s left) gem_pxp (create-regular-context-2)
[362.028249] Starting subtest: create-regular-context-2
[362.030829] Subtest create-regular-context-2: SUCCESS (0.001s)
[362.130121] [067/133] (689s left) gem_mmap_gtt (big-bo-tiledx)
[362.176827] Subtest big-bo-tiledX: SKIP (0.000s)
[362.237406] [068/133] (689s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[362.347568] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[362.351926] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[362.454600] [069/133] (688s left) kms_rotation_crc (primary-rotation-180)
[362.550646] Starting subtest: primary-rotation-180
[369.420964] Subtest primary-rotation-180: SUCCESS (6.870s)
[370.592933] [070/133] (680s left) syncobj_timeline (reset-multiple-signaled)
[370.652750] Starting subtest: reset-multiple-signaled
[370.654728] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[370.756150] [071/133] (680s left) syncobj_wait (multi-wait-signaled)
[370.805245] Starting subtest: multi-wait-signaled
[370.807426] Subtest multi-wait-signaled: SUCCESS (0.000s)
[370.911225] [072/133] (680s left) i915_selftest (mock)
[374.380701] Starting subtest: mock
[374.382782] Starting dynamic subtest: sanitycheck
[375.002795] Dynamic subtest sanitycheck: SUCCESS (0.622s)
[375.012025] Starting dynamic subtest: shmem
[375.640137] Dynamic subtest shmem: SUCCESS (0.635s)
[375.648845] Starting dynamic subtest: fence
[383.670462] Dynamic subtest fence: SUCCESS (8.030s)
[383.678204] Starting dynamic subtest: scatterlist
[385.286738] Dynamic subtest scatterlist: SUCCESS (1.614s)
[385.295774] Starting dynamic subtest: syncmap
[388.678335] Dynamic subtest syncmap: SUCCESS (3.390s)
[388.687503] Starting dynamic subtest: uncore
[389.300065] Dynamic subtest uncore: SUCCESS (0.620s)
[389.309829] Starting dynamic subtest: ring
[389.933657] Dynamic subtest ring: SUCCESS (0.632s)
[389.948896] Starting dynamic subtest: engine
[390.566356] Dynamic subtest engine: SUCCESS (0.630s)
[390.575822] Starting dynamic subtest: timelines
[394.090121] Dynamic subtest timelines: SUCCESS (3.523s)
[394.099014] Starting dynamic subtest: requests
[397.625370] Dynamic subtest requests: SUCCESS (3.534s)
[397.634361] Starting dynamic subtest: objects
[398.360576] Dynamic subtest objects: SUCCESS (0.734s)
[398.370277] Starting dynamic subtest: phys
[399.126343] Dynamic subtest phys: SUCCESS (0.764s)
[399.135757] Starting dynamic subtest: dmabuf
[399.839373] Dynamic subtest dmabuf: SUCCESS (0.711s)
[399.849057] Starting dynamic subtest: vma
[404.916544] Dynamic subtest vma: SUCCESS (5.076s)
[404.925031] Starting dynamic subtest: evict
[406.210471] Dynamic subtest evict: SUCCESS (1.293s)
[406.217664] Starting dynamic subtest: gtt
[409.305547] Dynamic subtest gtt: SUCCESS (3.093s)
[409.315333] Starting dynamic subtest: hugepages
[410.139712] Dynamic subtest hugepages: SUCCESS (0.833s)
[410.149630] Starting dynamic subtest: memory_region
[413.847052] Dynamic subtest memory_region: SUCCESS (3.707s)
[413.849547] Subtest mock: SUCCESS (39.474s)
[413.895021] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[413.895806] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[413.899210] [073/133] (637s left) i915_pm_freq_mult (media-freq)
[415.166603] Starting subtest: media-freq
[415.169401] Starting dynamic subtest: gt0
[415.174044] Dynamic subtest gt0: SKIP (0.000s)
[415.185943] Starting dynamic subtest: gt1
[415.192360] Dynamic subtest gt1: SKIP (0.000s)
[415.197946] Subtest media-freq: SKIP (0.001s)
[415.231329] [FACT i915_pm_freq_mult (media-freq)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[415.234213] [FACT i915_pm_freq_mult (media-freq)] new: kernel.kmod_is_loaded.i915: true
[415.237990] [074/133] (636s left) kms_joiner (invalid-modeset-force-big-joiner)
[415.350619] Starting subtest: invalid-modeset-force-big-joiner
[415.352799] Starting dynamic subtest: big_joiner_on_last_pipe
[415.693283] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.349s)
[415.696203] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.349s)
[416.422509] [075/133] (635s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[416.525854] Starting subtest: fbc-rgb101010-draw-render
[420.156369] Subtest fbc-rgb101010-draw-render: SUCCESS (3.635s)
[420.302558] [076/133] (631s left) gem_ctx_persistence (idempotent)
[420.366418] Starting subtest: idempotent
[420.368726] Subtest idempotent: SUCCESS (0.000s)
[420.463775] [077/133] (631s left) prime_vgem (basic-fence-flip)
[420.536143] Starting subtest: basic-fence-flip
[420.829299] Subtest basic-fence-flip: SUCCESS (0.294s)
[420.943143] [078/133] (630s left) gem_ctx_isolation (clean)
[421.008136] Starting subtest: clean
[421.010642] Starting dynamic subtest: rcs0
[421.087143] Dynamic subtest rcs0: SUCCESS (0.079s)
[421.095200] Starting dynamic subtest: bcs0
[421.200683] Dynamic subtest bcs0: SUCCESS (0.113s)
[421.211252] Starting dynamic subtest: vcs0
[421.290789] Dynamic subtest vcs0: SUCCESS (0.090s)
[421.301952] Starting dynamic subtest: vcs1
[422.529794] Dynamic subtest vcs1: SUCCESS (1.238s)
[422.540413] Starting dynamic subtest: vecs0
[424.558391] Dynamic subtest vecs0: SUCCESS (2.028s)
[424.568907] Starting dynamic subtest: ccs0
[426.498265] Dynamic subtest ccs0: SUCCESS (1.940s)
[426.501069] Subtest clean: SUCCESS (5.491s)
[426.680671] [079/133] (624s left) perf_pmu (busy-idle-check-all)
[426.723526] Starting subtest: busy-idle-check-all
[426.726031] Starting dynamic subtest: rcs0
[427.387038] Dynamic subtest rcs0: SUCCESS (0.665s)
[427.397363] Starting dynamic subtest: bcs0
[428.043195] Dynamic subtest bcs0: SUCCESS (0.654s)
[428.052851] Starting dynamic subtest: vcs0
[429.475414] Dynamic subtest vcs0: SUCCESS (1.429s)
[429.486547] Starting dynamic subtest: vcs1
[431.524886] Dynamic subtest vcs1: SUCCESS (2.047s)
[431.536523] Starting dynamic subtest: vecs0
[433.508053] Dynamic subtest vecs0: SUCCESS (1.981s)
[433.518577] Starting dynamic subtest: ccs0
[434.163810] Dynamic subtest ccs0: SUCCESS (0.656s)
[434.166283] Subtest busy-idle-check-all: SUCCESS (7.444s)
[434.282386] [080/133] (617s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[434.401480] Starting subtest: fbcpsr-slowdraw
[457.380376] Subtest fbcpsr-slowdraw: SUCCESS (22.984s)
[457.515297] [081/133] (594s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[457.582722] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[457.666643] [082/133] (594s left) kms_properties (plane-properties-legacy)
[457.776378] Starting subtest: plane-properties-legacy
[457.778624] Starting dynamic subtest: pipe-A-eDP-1
[458.358740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[458.367102] Starting dynamic subtest: pipe-B-eDP-1
[459.658885] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.297s)
[459.668349] Starting dynamic subtest: pipe-C-eDP-1
[460.868943] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[460.877716] Starting dynamic subtest: pipe-D-eDP-1
[462.103392] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[462.105985] Subtest plane-properties-legacy: SUCCESS (4.325s)
[462.894471] [083/133] (588s left) kms_plane_scaling (planes-downscale-factor-0-25)
[462.990471] Starting subtest: planes-downscale-factor-0-25
[462.992728] Starting dynamic subtest: pipe-A
[463.007907] Dynamic subtest pipe-A: SKIP (0.012s)
[463.017231] Starting dynamic subtest: pipe-B
[463.029254] Dynamic subtest pipe-B: SKIP (0.022s)
[463.037849] Starting dynamic subtest: pipe-C
[463.052536] Dynamic subtest pipe-C: SKIP (0.022s)
[463.060711] Starting dynamic subtest: pipe-D
[463.075458] Dynamic subtest pipe-D: SKIP (0.022s)
[463.079609] Subtest planes-downscale-factor-0-25: SKIP (0.080s)
[463.167410] [084/133] (588s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[463.267387] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[463.271361] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[463.360447] [085/133] (588s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[463.448376] Starting subtest: plane-upscale-factor-0-25-with-rotation
[463.450617] Starting dynamic subtest: pipe-A
[463.676101] Dynamic subtest pipe-A: SUCCESS (0.227s)
[463.684913] Starting dynamic subtest: pipe-B
[464.975498] Dynamic subtest pipe-B: SUCCESS (1.298s)
[464.983800] Starting dynamic subtest: pipe-C
[466.296707] Dynamic subtest pipe-C: SUCCESS (1.320s)
[466.305936] Starting dynamic subtest: pipe-D
[467.619629] Dynamic subtest pipe-D: SUCCESS (1.322s)
[467.621991] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.170s)
[468.798446] [086/133] (583s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[468.860385] Starting subtest: etime-single-wait-for-submit-submitted
[468.967888] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[469.042888] [087/133] (582s left) syncobj_wait (invalid-wait-illegal-handle)
[469.105875] Starting subtest: invalid-wait-illegal-handle
[469.108105] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[469.198515] [088/133] (582s left) gem_flink_basic (basic)
[469.254934] Starting subtest: basic
[469.256930] Subtest basic: SUCCESS (0.000s)
[469.363355] [089/133] (582s left) gem_exec_schedule (implicit-boths)
[469.429311] Starting subtest: implicit-boths
[469.431513] Starting dynamic subtest: rcs0
[469.532299] Dynamic subtest rcs0: SUCCESS (0.113s)
[469.541249] Starting dynamic subtest: vcs0
[469.616783] Dynamic subtest vcs0: SUCCESS (0.083s)
[469.626063] Starting dynamic subtest: vcs1
[469.690671] Dynamic subtest vcs1: SUCCESS (0.074s)
[469.700971] Starting dynamic subtest: vecs0
[469.762366] Dynamic subtest vecs0: SUCCESS (0.071s)
[469.773508] Starting dynamic subtest: ccs0
[469.838871] Dynamic subtest ccs0: SUCCESS (0.076s)
[469.841346] Subtest implicit-boths: SUCCESS (0.420s)
[471.561060] [090/133] (580s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[471.662594] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[471.664788] Starting dynamic subtest: pipe-A-eDP-1
[473.826894] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.162s)
[473.835369] Starting dynamic subtest: pipe-B-eDP-1
[475.835074] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.006s)
[475.843808] Starting dynamic subtest: pipe-C-eDP-1
[477.900132] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.064s)
[477.909055] Starting dynamic subtest: pipe-D-eDP-1
[479.871370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.969s)
[479.873671] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.206s)
[481.119139] [091/133] (570s left) kms_rotation_crc (cursor-rotation-180)
[481.228667] Starting subtest: cursor-rotation-180
[482.662004] Subtest cursor-rotation-180: SUCCESS (1.430s)
[483.870394] [092/133] (568s left) gem_exec_schedule (u-submit-late-slice)
[483.950502] Starting subtest: u-submit-late-slice
[483.952509] Starting dynamic subtest: rcs0
[483.977238] Dynamic subtest rcs0: SUCCESS (0.034s)
[483.989005] Starting dynamic subtest: bcs0
[484.006041] Dynamic subtest bcs0: SUCCESS (0.028s)
[484.015215] Starting dynamic subtest: vcs0
[484.032610] Dynamic subtest vcs0: SUCCESS (0.026s)
[484.041735] Starting dynamic subtest: vcs1
[484.059926] Dynamic subtest vcs1: SUCCESS (0.027s)
[484.068888] Starting dynamic subtest: vecs0
[484.085635] Dynamic subtest vecs0: SUCCESS (0.025s)
[484.094413] Starting dynamic subtest: ccs0
[484.113384] Dynamic subtest ccs0: SUCCESS (0.027s)
[484.115703] Subtest u-submit-late-slice: SUCCESS (0.170s)
[485.588972] [093/133] (566s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[485.718037] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[485.722136] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[485.848534] [094/133] (566s left) gem_ctx_sseu (invalid-args)
[485.911678] Subtest invalid-args: SKIP (0.000s)
[485.998504] [095/133] (566s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[486.105271] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[486.109413] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[486.211824] [096/133] (566s left) gem_softpin (evict-prime-sanity-check)
[486.277065] Starting subtest: evict-prime-sanity-check
[486.279498] Starting dynamic subtest: rcs0
[487.468192] Dynamic subtest rcs0: SUCCESS (1.191s)
[487.480047] Starting dynamic subtest: bcs0
[488.588262] Dynamic subtest bcs0: SUCCESS (1.118s)
[488.599440] Starting dynamic subtest: vcs0
[490.489976] Dynamic subtest vcs0: SUCCESS (1.899s)
[490.501155] Starting dynamic subtest: vcs1
[492.477380] Dynamic subtest vcs1: SUCCESS (1.986s)
[492.486459] Starting dynamic subtest: vecs0
[494.520866] Dynamic subtest vecs0: SUCCESS (2.042s)
[494.530173] Starting dynamic subtest: ccs0
[495.665417] Dynamic subtest ccs0: SUCCESS (1.144s)
[495.677102] Starting dynamic subtest: all
[496.795327] Dynamic subtest all: SUCCESS (1.128s)
[496.797945] Subtest evict-prime-sanity-check: SUCCESS (10.518s)
[496.873810] [097/133] (555s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[497.037342] Starting subtest: cursor-rapid-movement-64x64
[497.039669] Starting dynamic subtest: pipe-A-eDP-1
[497.590183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[497.613555] Starting dynamic subtest: pipe-D-eDP-1
[498.771098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.164s)
[498.773493] Subtest cursor-rapid-movement-64x64: SUCCESS (1.736s)
[499.614675] [098/133] (552s left) api_intel_bb (offset-control)
[499.681953] Starting subtest: offset-control
[499.688374] Subtest offset-control: SUCCESS (0.008s)
[499.836704] [099/133] (552s left) vkms/vkms_configfs (enable-too-many-connectors)
[499.883389] Subtest enable-too-many-connectors: SKIP (0.000s)
[499.936970] [100/133] (552s left) kms_selftest (drm_dp_mst_helper)
[499.973794] Starting subtest: drm_dp_mst_helper
[500.008684] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[500.162618] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.152s)
[500.171777] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[500.316984] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.155s)
[500.326641] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[500.475944] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.159s)
[500.478235] Subtest drm_dp_mst_helper: SUCCESS (0.504s)
[500.659487] [101/133] (551s left) kms_flip (flip-vs-rmfb)
[500.759580] Starting subtest: flip-vs-rmfb
[500.761999] Starting dynamic subtest: A-eDP1
[509.410988] Dynamic subtest A-eDP1: SUCCESS (8.651s)
[509.421146] Starting dynamic subtest: B-eDP1
[518.141275] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[518.151564] Starting dynamic subtest: C-eDP1
[526.850432] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[526.859584] Starting dynamic subtest: D-eDP1
[535.603762] Dynamic subtest D-eDP1: SUCCESS (8.752s)
[535.608861] Subtest flip-vs-rmfb: SUCCESS (34.849s)
[536.751635] [102/133] (515s left) gem_exec_fence (syncobj-invalid-wait)
[537.164002] Starting subtest: syncobj-invalid-wait
[537.166425] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[538.569957] [103/133] (513s left) kms_async_flips (crc-atomic)
[538.673228] Starting subtest: crc-atomic
[539.043725] Starting dynamic subtest: pipe-A-eDP-1
[541.939904] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.897s)
[542.307244] Starting dynamic subtest: pipe-B-eDP-1
[545.165055] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.867s)
[545.537595] Starting dynamic subtest: pipe-C-eDP-1
[548.366137] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.838s)
[548.729905] Starting dynamic subtest: pipe-D-eDP-1
[551.604944] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.884s)
[551.607397] Subtest crc-atomic: SUCCESS (12.933s)
[552.778859] [104/133] (499s left) syncobj_timeline (invalid-transfer-bad-pad)
[552.842454] Starting subtest: invalid-transfer-bad-pad
[552.844770] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[552.950482] [105/133] (499s left) gem_pread (snoop)
[552.998919] Subtest snoop: SKIP (0.000s)
[553.051412] [106/133] (499s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[558.012193] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[558.016766] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[558.878499] [107/133] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[558.990032] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[558.994035] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[559.079133] [108/133] (493s left) i915_hangman (engine-engine-error)
[559.149362] Starting subtest: engine-engine-error
[559.152295] Starting dynamic subtest: rcs0
[560.451370] Dynamic subtest rcs0: SUCCESS (1.301s)
[560.462345] Starting dynamic subtest: bcs0
[562.434156] Dynamic subtest bcs0: SUCCESS (1.980s)
[562.445594] Starting dynamic subtest: vcs0
[564.481731] Dynamic subtest vcs0: SUCCESS (2.045s)
[564.493857] Starting dynamic subtest: vcs1
[566.464538] Dynamic subtest vcs1: SUCCESS (1.981s)
[566.476478] Starting dynamic subtest: vecs0
[568.450036] Dynamic subtest vecs0: SUCCESS (1.983s)
[568.462596] Starting dynamic subtest: ccs0
[570.434254] Dynamic subtest ccs0: SUCCESS (1.982s)
[570.437373] Subtest engine-engine-error: SUCCESS (11.286s)
[570.512743] [109/133] (482s left) perf_pmu (init-sema)
[570.555917] Starting subtest: init-sema
[570.558633] Starting dynamic subtest: rcs0
[570.561222] Dynamic subtest rcs0: SUCCESS (0.002s)
[570.576831] Starting dynamic subtest: bcs0
[570.579215] Dynamic subtest bcs0: SUCCESS (0.000s)
[570.590488] Starting dynamic subtest: vcs0
[570.592844] Dynamic subtest vcs0: SUCCESS (0.001s)
[570.602375] Starting dynamic subtest: vcs1
[570.604635] Dynamic subtest vcs1: SUCCESS (0.001s)
[570.612964] Starting dynamic subtest: vecs0
[570.615260] Dynamic subtest vecs0: SUCCESS (0.001s)
[570.623656] Starting dynamic subtest: ccs0
[570.625985] Dynamic subtest ccs0: SUCCESS (0.001s)
[570.628334] Subtest init-sema: SUCCESS (0.009s)
[570.710734] [110/133] (482s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[570.772760] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[570.775125] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[570.887750] [111/133] (481s left) gem_create (create-clear)
[570.949425] Starting subtest: create-clear
[570.951685] Starting dynamic subtest: smem0
[604.596150] Dynamic subtest smem0: SUCCESS (33.647s)
[604.598669] Subtest create-clear: SUCCESS (33.649s)
[604.783927] [112/133] (448s left) gem_userptr_blits (sync-unmap-cycles)
[604.854290] Starting subtest: sync-unmap-cycles
[610.234214] Subtest sync-unmap-cycles: SUCCESS (5.380s)
[610.381436] [113/133] (442s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[610.487238] Starting subtest: y-tiled-16bpp-rotate-180
[610.490929] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[610.586609] [114/133] (442s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[610.683588] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[615.249016] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.567s)
[615.383388] [115/133] (437s left) gem_ctx_isolation (preservation)
[615.445351] Starting subtest: preservation
[615.447515] Starting dynamic subtest: rcs0
[615.720317] Dynamic subtest rcs0: SUCCESS (0.273s)
[615.732051] Starting dynamic subtest: bcs0
[616.015766] Dynamic subtest bcs0: SUCCESS (0.295s)
[616.028381] Starting dynamic subtest: vcs0
[616.331286] Dynamic subtest vcs0: SUCCESS (0.314s)
[616.344275] Starting dynamic subtest: vcs1
[617.730883] Dynamic subtest vcs1: SUCCESS (1.400s)
[617.742257] Starting dynamic subtest: vecs0
[619.776651] Dynamic subtest vecs0: SUCCESS (2.045s)
[619.787887] Starting dynamic subtest: ccs0
[621.746736] Dynamic subtest ccs0: SUCCESS (1.970s)
[621.749196] Subtest preservation: SUCCESS (6.301s)
[622.004178] [116/133] (431s left) gem_close_race (basic-process)
[622.076612] Starting subtest: basic-process
[622.137897] Subtest basic-process: SUCCESS (0.061s)
[622.319429] [117/133] (430s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[622.427534] Starting subtest: yf-tiled-8bpp-rotate-180
[622.432197] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[622.535246] [118/133] (430s left) kms_cursor_crc (cursor-onscreen-256x256)
[622.761434] Starting subtest: cursor-onscreen-256x256
[622.766532] Starting dynamic subtest: pipe-A-eDP-1
[625.042374] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.274s)
[625.065051] Starting dynamic subtest: pipe-D-eDP-1
[627.944708] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.886s)
[627.946684] Subtest cursor-onscreen-256x256: SUCCESS (5.183s)
[628.754132] [119/133] (424s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[628.851673] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[628.854014] Starting dynamic subtest: pipe-A-default-mode
[630.015559] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[630.020381] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.159s)
[630.154168] [120/133] (423s left) core_getstats
[630.314410] [121/133] (422s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[630.409412] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[630.411744] Starting dynamic subtest: pipe-A-eDP-1
[630.434351] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[630.444716] Starting dynamic subtest: pipe-B-eDP-1
[630.466383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[630.474472] Starting dynamic subtest: pipe-C-eDP-1
[630.496124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[630.504339] Starting dynamic subtest: pipe-D-eDP-1
[630.526588] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[630.531009] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[632.544272] [122/133] (420s left) kms_flip (flip-vs-suspend)
[632.651318] Starting subtest: flip-vs-suspend
[632.653604] Starting dynamic subtest: A-eDP1
[682.391692] Dynamic subtest A-eDP1: SUCCESS (4.437s)
[682.404151] Starting dynamic subtest: B-eDP1
[731.390924] Dynamic subtest B-eDP1: SUCCESS (4.343s)
[731.400813] Starting dynamic subtest: C-eDP1
[780.381745] Dynamic subtest C-eDP1: SUCCESS (4.306s)
[780.401670] Starting dynamic subtest: D-eDP1
[829.395814] Dynamic subtest D-eDP1: SUCCESS (4.380s)
[829.398772] Subtest flip-vs-suspend: SUCCESS (17.474s)
[830.586952] [123/133] (401s left) kms_chamelium_hpd (dp-hpd-storm)
[830.980871] Subtest dp-hpd-storm: SKIP (0.000s)
[831.773175] [124/133] (400s left) gem_mmap_gtt (big-copy-odd)
[831.824594] Subtest big-copy-odd: SKIP (0.000s)
[831.889019] [125/133] (400s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[831.995320] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[831.999996] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[832.094914] [126/133] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[832.211034] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[835.252494] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.087s)
[835.397395] [127/133] (397s left) syncobj_eventfd (binary-wait-before-signal)
[835.463433] Starting subtest: binary-wait-before-signal
[835.495431] Subtest binary-wait-before-signal: SUCCESS (0.032s)
[835.568864] [128/133] (397s left) gem_wait (invalid-flags)
[835.635995] Starting subtest: invalid-flags
[835.638456] Subtest invalid-flags: SUCCESS (0.000s)
[835.849484] [129/133] (396s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[835.950445] Starting subtest: fbc-psr-cursor-mmap-cpu
[835.952574] Starting dynamic subtest: eDP-1
[835.957503] Dynamic subtest eDP-1: SKIP (0.000s)
[835.961774] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[836.020055] [130/133] (396s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[836.085024] Starting subtest: single-wait-for-submit-available-submitted
[836.087735] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[836.188130] [131/133] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[836.301203] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[836.306412] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[836.412124] [132/133] (396s left) kms_flip (blocking-wf_vblank)
[836.518609] Starting subtest: blocking-wf_vblank
[836.521458] Starting dynamic subtest: A-eDP1
[848.491591] Dynamic subtest A-eDP1: FAIL (11.538s)
[848.501290] Starting dynamic subtest: B-eDP1
[856.952982] Dynamic subtest B-eDP1: SUCCESS (8.967s)
[856.963589] Starting dynamic subtest: C-eDP1
[865.870776] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[865.883019] Starting dynamic subtest: D-eDP1
[874.799462] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[874.805152] Subtest blocking-wf_vblank: FAIL (38.355s)
[876.018595] [133/133] (356s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[876.116543] Starting subtest: x-tiled-16bpp-rotate-90
[876.136687] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[876.262565] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_prop_blob
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_rotation_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: vgem_basic
results: parsing output: 6/ for test: kms_vrr
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: gen7_exec_parse
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: gem_exec_endless
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_pipe_b_c_ivb
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: drm_fdinfo
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: gem_exec_parallel
results: parsing output: 29/ for test: gem_workarounds
results: parsing output: 30/ for test: kms_universal_plane
results: parsing output: 31/ for test: kms_atomic_transition
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: gem_ctx_bad_destroy
results: parsing output: 35/ for test: kms_chamelium_color
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: vkms/vkms_configfs
results: parsing output: 38/ for test: fbdev
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gen3_render_linear_blits
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: kms_pipe_crc_basic
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_dirtyfb
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: i915_pm_rps
results: parsing output: 62/ for test: sysfs_preempt_timeout
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: i915_selftest
results: parsing output: 72/ for test: i915_pm_freq_mult
results: parsing output: 73/ for test: kms_joiner
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_properties
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_flink_basic
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_ctx_sseu
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: vkms/vkms_configfs
results: parsing output: 99/ for test: kms_selftest
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_pread
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_hangman
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: gem_create
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_isolation
results: parsing output: 115/ for test: gem_close_race
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: core_getstats
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_eventfd
results: parsing output: 127/ for test: gem_wait
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_big_fb
Done.