[57.577306] Initializing watchdogs
[57.577352]   /dev/watchdog0
[57.590863] [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]
[57.595190] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.597440] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.600866] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[57.740043] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[65.070183] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.312s)
[65.227252] [002/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[65.328628] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[65.333197] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[65.429391] [003/133] (952s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[65.523260] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[65.525515] Starting dynamic subtest: pipe-A-eDP-1
[65.534431] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.541337] Starting dynamic subtest: pipe-B-eDP-1
[65.550427] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.557628] Starting dynamic subtest: pipe-C-eDP-1
[65.566180] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.572804] Starting dynamic subtest: pipe-D-eDP-1
[65.581619] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.586060] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[67.738617] [004/133] (950s left) gem_flink_race (flink_close)
[67.791092] Starting subtest: flink_close
[72.903625] Subtest flink_close: SUCCESS (5.109s)
[72.984822] [005/133] (945s left) gem_render_copy_redux (normal)
[73.070666] Starting subtest: normal
[73.466967] Subtest normal: SUCCESS (0.398s)
[73.646257] [006/133] (944s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[73.728433] Starting subtest: single-wait-all-for-submit-unsubmitted
[73.832419] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[73.920765] [007/133] (944s left) kms_flip (2x-flip-vs-panning-vs-hang)
[74.045705] Starting subtest: 2x-flip-vs-panning-vs-hang
[74.062878] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.018s)
[74.178977] [008/133] (944s left) gem_render_copy_redux (flink-interruptible)
[74.275306] Starting subtest: flink-interruptible
[75.004196] Subtest flink-interruptible: SUCCESS (0.730s)
[75.151861] [009/133] (943s left) gem_exec_flush (basic-uc-ro-default)
[75.211670] Starting subtest: basic-uc-ro-default
[80.662805] Subtest basic-uc-ro-default: SUCCESS (5.449s)
[80.865791] [010/133] (937s left) kms_psr (psr2-cursor-mmap-cpu)
[80.963399] Starting subtest: psr2-cursor-mmap-cpu
[80.965797] Starting dynamic subtest: eDP-1
[82.691774] Dynamic subtest eDP-1: SUCCESS (1.726s)
[82.694151] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.727s)
[83.490216] [011/133] (935s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[83.552899] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[83.657082] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[83.746300] [012/133] (934s left) core_getversion (basic)
[83.784915] Starting subtest: basic
[83.789275] Subtest basic: SUCCESS (0.000s)
[83.850611] [013/133] (934s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[83.954868] Starting subtest: 4-tiled-16bpp-rotate-180
[85.156913] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.203s)
[85.295470] [014/133] (933s left) perf (missing-sample-flags)
[85.428907] Starting subtest: missing-sample-flags
[85.430505] Subtest missing-sample-flags: SUCCESS (0.000s)
[85.470101] [015/133] (933s left) gem_exec_balancer (bonded-pair)
[85.555762] Starting subtest: bonded-pair
[85.559661] Subtest bonded-pair: SKIP (0.000s)
[85.853257] [016/133] (932s left) kms_pm_rpm (modeset-non-lpsp)
[88.074353] Starting subtest: modeset-non-lpsp
[89.228226] Subtest modeset-non-lpsp: SKIP (1.153s)
[89.630115] [017/133] (929s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[89.732996] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[89.735394] Starting dynamic subtest: pipe-A-eDP-1
[89.756664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[89.765860] Starting dynamic subtest: pipe-B-eDP-1
[89.785292] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[89.793056] Starting dynamic subtest: pipe-C-eDP-1
[89.811501] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[89.818733] Starting dynamic subtest: pipe-D-eDP-1
[89.838954] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[89.840858] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[91.966865] [018/133] (926s left) gem_userptr_blits (sync-unmap)
[92.041096] Starting subtest: sync-unmap
[92.050514] Subtest sync-unmap: SUCCESS (0.013s)
[92.193556] [019/133] (926s left) syncobj_timeline (wait-for-submit-complex)
[92.245800] Starting subtest: wait-for-submit-complex
[92.306998] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[92.391985] [020/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[92.491296] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[92.495261] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[92.611229] [021/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[92.715955] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[92.719958] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[92.830413] [022/133] (926s left) sw_sync (alloc_timeline)
[92.865656] Starting subtest: alloc_timeline
[92.867872] Subtest alloc_timeline: SUCCESS (0.000s)
[92.928746] [023/133] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[93.027066] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[100.001251] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.973s)
[100.195227] [024/133] (918s left) kms_cdclk (mode-transition-all-outputs)
[100.303030] Starting subtest: mode-transition-all-outputs
[100.591748] Subtest mode-transition-all-outputs: SKIP (0.287s)
[101.408160] [025/133] (917s left) kms_flip (2x-flip-vs-dpms-on-nop)
[101.516942] Starting subtest: 2x-flip-vs-dpms-on-nop
[101.527680] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[101.667430] [026/133] (917s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[101.709085] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[101.752205] [027/133] (917s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[101.818663] Starting subtest: invalid-signal-one-illegal-handle
[101.820967] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[101.927594] [028/133] (917s left) gem_pxp (reject-modify-context-protection-off-2)
[102.056226] Starting subtest: reject-modify-context-protection-off-2
[102.058517] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[102.190639] [029/133] (917s left) i915_drm_fdinfo (all-busy-idle-check-all)
[102.227176] Starting subtest: all-busy-idle-check-all
[102.233914] Subtest all-busy-idle-check-all: SKIP (0.003s)
[102.308217] [030/133] (916s left) gem_ctx_param (basic)
[102.369232] Starting subtest: basic
[102.371063] Subtest basic: SUCCESS (0.001s)
[102.511526] [031/133] (916s left) gem_exec_schedule (preempt-queue)
[102.588753] Subtest preempt-queue: SKIP (0.000s)
[102.887607] [032/133] (916s left) gem_mmap_offset (oob-read)
[102.948977] Starting subtest: oob-read
[102.951393] Subtest oob-read: SUCCESS (0.000s)
[103.073264] [033/133] (916s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[103.174018] Starting subtest: y-tiled-32bpp-rotate-90
[103.178127] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[103.322087] [034/133] (916s left) kms_color (ctm-0-25)
[103.415089] Starting subtest: ctm-0-25
[103.417032] Starting dynamic subtest: pipe-A-eDP-1
[106.819553] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.405s)
[106.828670] Starting dynamic subtest: pipe-B-eDP-1
[110.949538] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.130s)
[110.957744] Starting dynamic subtest: pipe-C-eDP-1
[114.988590] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.037s)
[114.996904] Starting dynamic subtest: pipe-D-eDP-1
[118.944747] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.956s)
[118.947057] Subtest ctm-0-25: SUCCESS (15.529s)
[119.782251] [035/133] (899s left) gem_ctx_persistence (hang)
[119.848634] Starting subtest: hang
[119.853398] Subtest hang: SKIP (0.000s)
[119.984465] [036/133] (899s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[120.099346] Starting subtest: 2x-cursor-vs-flip-legacy
[120.103911] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[120.264847] [037/133] (899s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[120.324948] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[120.458780] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.133s)
[120.618157] [038/133] (898s left) kms_psr (fbc-psr2-dpms)
[120.711416] Starting subtest: fbc-psr2-dpms
[120.713545] Starting dynamic subtest: eDP-1
[120.717210] Dynamic subtest eDP-1: SKIP (0.000s)
[120.720838] Subtest fbc-psr2-dpms: SKIP (0.001s)
[120.791724] [039/133] (898s left) kms_cursor_crc (cursor-random-256x256)
[121.027263] Starting subtest: cursor-random-256x256
[121.031216] Starting dynamic subtest: pipe-A-eDP-1
[124.344482] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.311s)
[124.369628] Starting dynamic subtest: pipe-D-eDP-1
[128.371772] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.006s)
[128.373654] Subtest cursor-random-256x256: SUCCESS (7.341s)
[129.255897] [040/133] (890s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[129.321041] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[129.323349] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[129.419586] [041/133] (890s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[129.477040] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[129.585433] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[129.667859] [042/133] (890s left) perf_pmu (idle)
[129.708720] Starting subtest: idle
[129.711032] Starting dynamic subtest: rcs0
[130.281896] Dynamic subtest rcs0: SUCCESS (0.571s)
[130.292643] Starting dynamic subtest: bcs0
[130.812519] Dynamic subtest bcs0: SUCCESS (0.528s)
[130.823636] Starting dynamic subtest: vcs0
[131.341798] Dynamic subtest vcs0: SUCCESS (0.526s)
[131.350394] Starting dynamic subtest: vcs1
[131.872369] Dynamic subtest vcs1: SUCCESS (0.528s)
[131.883090] Starting dynamic subtest: vecs0
[132.399776] Dynamic subtest vecs0: SUCCESS (0.525s)
[132.410595] Starting dynamic subtest: ccs0
[132.927574] Dynamic subtest ccs0: SUCCESS (0.521s)
[132.930139] Subtest idle: SUCCESS (3.214s)
[133.033303] [043/133] (886s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[133.427524] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[134.254321] [044/133] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[134.358940] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[138.827868] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.472s)
[139.983727] [045/133] (879s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[140.102942] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[140.107240] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[140.214904] [046/133] (879s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[140.314622] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[141.093924] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[141.274490] [047/133] (878s left) gen7_exec_parse (bitmasks)
[141.343591] Subtest bitmasks: SKIP (0.000s)
[141.406991] [048/133] (878s left) kms_invalid_mode (overflow-vrefresh)
[141.497327] Starting subtest: overflow-vrefresh
[141.499587] Starting dynamic subtest: pipe-A-eDP-1
[141.786860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[141.795850] Starting dynamic subtest: pipe-B-eDP-1
[141.797825] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[141.805093] Starting dynamic subtest: pipe-C-eDP-1
[141.806974] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[141.815048] Starting dynamic subtest: pipe-D-eDP-1
[141.817737] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[141.820294] Subtest overflow-vrefresh: SUCCESS (0.299s)
[142.598694] [049/133] (877s left) gem_lmem_swapping (verify-random)
[142.640491] Subtest verify-random: SKIP (0.000s)
[142.675727] [050/133] (877s left) kms_draw_crc (draw-method-pwrite)
[142.766858] Starting subtest: draw-method-pwrite
[142.768712] Starting dynamic subtest: xrgb8888-untiled
[143.386269] Dynamic subtest xrgb8888-untiled: SUCCESS (0.621s)
[143.394745] Starting dynamic subtest: rgb565-untiled
[143.909676] Dynamic subtest rgb565-untiled: SUCCESS (0.522s)
[143.917796] Starting dynamic subtest: xrgb2101010-untiled
[144.542083] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.633s)
[144.551471] Starting dynamic subtest: xbgr16161616f-untiled
[145.375188] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.831s)
[145.383347] Starting dynamic subtest: xrgb8888-xtiled
[147.463955] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.088s)
[147.472423] Starting dynamic subtest: rgb565-xtiled
[148.807894] Dynamic subtest rgb565-xtiled: SUCCESS (1.344s)
[148.816586] Starting dynamic subtest: xrgb2101010-xtiled
[150.887319] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.077s)
[150.895149] Starting dynamic subtest: xbgr16161616f-xtiled
[154.508586] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.622s)
[154.522665] Starting dynamic subtest: xrgb8888-4tiled
[155.785479] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.275s)
[155.794064] Starting dynamic subtest: rgb565-4tiled
[156.462995] Dynamic subtest rgb565-4tiled: SUCCESS (0.677s)
[156.471940] Starting dynamic subtest: xrgb2101010-4tiled
[157.741801] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.277s)
[157.762122] Starting dynamic subtest: xbgr16161616f-4tiled
[161.040868] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.298s)
[161.043219] Subtest draw-method-pwrite: SUCCESS (18.277s)
[161.168096] [051/133] (858s left) sw_sync (sync_merge_invalid)
[161.210042] Starting subtest: sync_merge_invalid
[161.234590] Subtest sync_merge_invalid: SUCCESS (0.025s)
[161.323627] [052/133] (858s left) kms_flip (basic-plain-flip)
[161.422356] Starting subtest: basic-plain-flip
[161.424640] Starting dynamic subtest: A-eDP1
[163.105299] Dynamic subtest A-eDP1: SUCCESS (1.682s)
[163.115903] Starting dynamic subtest: B-eDP1
[164.731711] Dynamic subtest B-eDP1: SUCCESS (1.624s)
[164.742059] Starting dynamic subtest: C-eDP1
[166.346626] Dynamic subtest C-eDP1: SUCCESS (1.614s)
[166.356211] Starting dynamic subtest: D-eDP1
[167.973590] Dynamic subtest D-eDP1: SUCCESS (1.626s)
[167.975914] Subtest basic-plain-flip: SUCCESS (6.555s)
[169.155996] [053/133] (850s left) gem_watchdog (default-virtual)
[169.222930] Starting subtest: default-virtual
[175.501473] Subtest default-virtual: SUCCESS (6.287s)
[175.614466] [054/133] (844s left) gem_render_copy (x-tiled)
[175.670909] Starting subtest: x-tiled
[175.673371] Starting dynamic subtest: smem
[175.716352] Dynamic subtest smem: SUCCESS (0.045s)
[175.718603] Subtest x-tiled: SUCCESS (0.046s)
[175.976895] [055/133] (844s left) kms_psr (fbc-pr-cursor-plane-onoff)
[176.092853] Starting subtest: fbc-pr-cursor-plane-onoff
[176.096828] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[176.175172] [056/133] (844s left) i915_pm_rpm (gem-mmap-type)
[178.002090] Starting subtest: gem-mmap-type
[178.004596] Starting dynamic subtest: wb-smem0
[181.579373] Dynamic subtest wb-smem0: SUCCESS (3.580s)
[181.591182] Starting dynamic subtest: wc-smem0
[184.745196] Dynamic subtest wc-smem0: SUCCESS (3.163s)
[184.752874] Starting dynamic subtest: uc-smem0
[187.619675] Dynamic subtest uc-smem0: SUCCESS (2.875s)
[187.621968] Subtest gem-mmap-type: SUCCESS (9.620s)
[187.713214] [057/133] (832s left) kms_lease (empty-lease)
[187.812321] Starting subtest: empty-lease
[187.815034] Starting dynamic subtest: pipe-A-eDP-1
[187.817755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[187.831500] Starting dynamic subtest: pipe-B-eDP-1
[187.833790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[187.842131] Starting dynamic subtest: pipe-C-eDP-1
[187.844256] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[187.852295] Starting dynamic subtest: pipe-D-eDP-1
[187.854451] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[187.856602] Subtest empty-lease: SUCCESS (0.008s)
[187.940530] [058/133] (832s left) kms_psr (fbc-psr-cursor-blt)
[188.038688] Starting subtest: fbc-psr-cursor-blt
[188.041092] Starting dynamic subtest: eDP-1
[188.045184] Dynamic subtest eDP-1: SKIP (0.000s)
[188.049264] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[188.118063] [059/133] (832s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[188.214484] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[188.218427] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[188.335309] [060/133] (832s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[188.439141] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[188.443272] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[188.569294] [061/133] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[188.661313] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[188.664754] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[188.776464] [062/133] (831s left) perf_pmu (frequency)
[188.812184] Starting subtest: frequency
[188.817223] Starting dynamic subtest: gt0
[190.988927] Dynamic subtest gt0: SUCCESS (2.168s)
[190.998705] Starting dynamic subtest: idle-gt0
[191.494361] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[191.505056] Starting dynamic subtest: gt1
[195.913061] Dynamic subtest gt1: SUCCESS (4.414s)
[195.923399] Starting dynamic subtest: idle-gt1
[196.456094] Dynamic subtest idle-gt1: SUCCESS (0.542s)
[196.458249] Subtest frequency: SUCCESS (7.646s)
[196.560681] [063/133] (823s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[196.650779] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[196.653050] Starting dynamic subtest: pipe-A-eDP-1
[196.675206] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.685102] Starting dynamic subtest: pipe-B-eDP-1
[196.706032] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.713339] Starting dynamic subtest: pipe-C-eDP-1
[196.734411] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.741590] Starting dynamic subtest: pipe-D-eDP-1
[196.763254] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.767568] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[198.869034] [064/133] (821s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[198.971855] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[198.976095] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[199.115449] [065/133] (821s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[199.220304] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[199.224476] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[199.308933] [066/133] (821s left) syncobj_basic (bad-flags-handle-to-fd)
[199.372667] Starting subtest: bad-flags-handle-to-fd
[199.374993] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[199.490933] [067/133] (821s left) gem_exec_schedule (smoketest-all)
[199.582628] Starting subtest: smoketest-all
[231.984806] Subtest smoketest-all: SUCCESS (32.322s)
[232.984505] [068/133] (787s left) gen3_mixed_blits
[233.099656] [069/133] (787s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[233.206923] Starting subtest: multiplane-rotation-cropping-top
[250.564605] Subtest multiplane-rotation-cropping-top: SUCCESS (17.360s)
[250.711024] [070/133] (770s left) kms_chamelium_frames (hdmi-frame-dump)
[251.111614] Subtest hdmi-frame-dump: SKIP (0.000s)
[251.960356] [071/133] (768s left) core_setmaster_vs_auth
[252.168769] [072/133] (768s left) gem_create (create-valid-nonaligned)
[252.241732] Starting subtest: create-valid-nonaligned
[252.243698] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[252.436889] [073/133] (768s left) gem_exec_params (readonly)
[252.489325] Starting subtest: readonly
[252.494816] Subtest readonly: SUCCESS (0.003s)
[252.639755] [074/133] (768s left) gem_caching (reads)
[252.702168] Subtest reads: SKIP (0.000s)
[252.781746] [075/133] (768s left) kms_flip (2x-flip-vs-expired-vblank)
[252.871288] Starting subtest: 2x-flip-vs-expired-vblank
[252.882081] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[252.980208] [076/133] (767s left) syncobj_wait (wait-for-submit-complex)
[253.041451] Starting subtest: wait-for-submit-complex
[253.103212] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[253.201472] [077/133] (767s left) api_intel_bb (blit-reloc-keep-cache)
[253.259958] Starting subtest: blit-reloc-keep-cache
[253.264338] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[253.400835] [078/133] (767s left) gem_render_tiled_blits (basic)
[253.461336] Subtest basic: SKIP (0.000s)
[253.517671] [079/133] (767s left) i915_getparams_basic (basic-subslice-total)
[253.578222] Starting subtest: basic-subslice-total
[253.581768] Subtest basic-subslice-total: SUCCESS (0.000s)
[253.693405] [080/133] (767s left) kms_big_fb (linear-32bpp-rotate-270)
[253.807056] Starting subtest: linear-32bpp-rotate-270
[253.826568] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[253.998773] [081/133] (767s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[254.124890] Starting subtest: short-flip-before-cursor-atomic-transitions
[255.084349] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s)
[255.907279] [082/133] (765s left) kms_pm_dc (dc6-dpms)
[257.001985] Starting subtest: dc6-dpms
[259.081230] Subtest dc6-dpms: SUCCESS (2.078s)
[259.181875] [083/133] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[259.283677] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[259.288048] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[259.416694] [084/133] (761s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[259.536336] Starting subtest: cursor-vs-flip-atomic
[288.729813] Subtest cursor-vs-flip-atomic: SUCCESS (29.190s)
[289.582405] [085/133] (731s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[289.839855] Starting subtest: parallel-dmabuf-import-out-fence
[290.991281] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.151s)
[291.125054] [086/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[291.217673] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[291.222074] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[291.334114] [087/133] (730s left) kms_properties (colorop-properties-atomic)
[291.428038] Starting subtest: colorop-properties-atomic
[291.430311] Starting dynamic subtest: pipe-A-eDP-1
[291.816626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[291.825088] Starting dynamic subtest: pipe-B-eDP-1
[292.848585] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.030s)
[292.857015] Starting dynamic subtest: pipe-C-eDP-1
[293.880181] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.033s)
[293.889297] Starting dynamic subtest: pipe-D-eDP-1
[294.914077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.030s)
[294.916395] Subtest colorop-properties-atomic: SUCCESS (3.484s)
[295.721780] [088/133] (725s left) gem_exec_alignment (single)
[295.795642] Starting subtest: single
[295.797985] Subtest single: SUCCESS (0.002s)
[295.944481] [089/133] (725s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[296.042153] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[296.044323] Starting dynamic subtest: pipe-A
[296.378814] Dynamic subtest pipe-A: SUCCESS (0.339s)
[296.387583] Starting dynamic subtest: pipe-B
[297.815582] Dynamic subtest pipe-B: SUCCESS (1.436s)
[297.823525] Starting dynamic subtest: pipe-C
[299.239836] Dynamic subtest pipe-C: SUCCESS (1.423s)
[299.248886] Starting dynamic subtest: pipe-D
[300.674215] Dynamic subtest pipe-D: SUCCESS (1.433s)
[300.676641] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.635s)
[301.851322] [090/133] (719s left) gem_exec_fence (submit67)
[302.036101] Starting subtest: submit67
[302.040742] Subtest submit67: SKIP (0.000s)
[303.893989] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[303.897281] [091/133] (717s left) kms_psr (psr2-dpms)
[303.983265] Starting subtest: psr2-dpms
[303.985545] Starting dynamic subtest: eDP-1
[306.866991] Dynamic subtest eDP-1: SUCCESS (2.883s)
[306.868918] Subtest psr2-dpms: SUCCESS (2.884s)
[307.747636] [092/133] (713s left) gem_sync (basic-store-each)
[307.820209] Starting subtest: basic-store-each
[310.147625] Subtest basic-store-each: SUCCESS (2.338s)
[310.345221] [093/133] (711s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[310.463534] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[311.420784] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.958s)
[311.584342] [094/133] (710s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[311.683138] Starting subtest: primary-y-tiled-reflect-x-90
[311.686868] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[311.766154] [095/133] (709s left) perf_pmu (busy-accuracy-98)
[311.807558] Starting subtest: busy-accuracy-98
[311.809199] Starting dynamic subtest: rcs0
[314.845367] Dynamic subtest rcs0: SUCCESS (3.035s)
[314.855906] Starting dynamic subtest: bcs0
[317.891295] Dynamic subtest bcs0: SUCCESS (3.045s)
[317.901716] Starting dynamic subtest: vcs0
[320.935914] Dynamic subtest vcs0: SUCCESS (3.042s)
[320.946442] Starting dynamic subtest: vcs1
[323.979250] Dynamic subtest vcs1: SUCCESS (3.040s)
[323.993544] Starting dynamic subtest: vecs0
[327.021151] Dynamic subtest vecs0: SUCCESS (3.039s)
[327.031678] Starting dynamic subtest: ccs0
[330.071046] Dynamic subtest ccs0: SUCCESS (3.047s)
[330.073468] Subtest busy-accuracy-98: SUCCESS (18.262s)
[330.221547] [096/133] (691s left) kms_cursor_crc (cursor-offscreen-32x10)
[330.388925] Starting subtest: cursor-offscreen-32x10
[330.432876] Subtest cursor-offscreen-32x10: SKIP (0.041s)
[330.740425] [097/133] (691s left) api_intel_bb (intel-bb-blit-y)
[330.803776] Starting subtest: intel-bb-blit-y
[334.617370] Subtest intel-bb-blit-y: SUCCESS (3.814s)
[334.768074] [098/133] (687s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[334.876259] Starting subtest: psr-rgb101010-draw-blt
[342.124747] Subtest psr-rgb101010-draw-blt: SUCCESS (7.250s)
[342.304219] [099/133] (679s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[342.403142] Starting subtest: disable-crc-after-crtc
[342.405337] Starting dynamic subtest: pipe-A-eDP-1
[343.993077] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.590s)
[344.002622] Starting dynamic subtest: pipe-B-eDP-1
[346.411806] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.416s)
[346.420669] Starting dynamic subtest: pipe-C-eDP-1
[348.709455] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.297s)
[348.717748] Starting dynamic subtest: pipe-D-eDP-1
[350.992322] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.280s)
[350.994580] Subtest disable-crc-after-crtc: SUCCESS (8.588s)
[351.829240] [100/133] (670s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[351.930108] Starting subtest: psr-dirtyfb-ioctl
[351.932550] Starting dynamic subtest: A-eDP-1
[355.814410] Dynamic subtest A-eDP-1: SUCCESS (3.883s)
[355.816265] Subtest psr-dirtyfb-ioctl: SUCCESS (3.884s)
[356.625962] [101/133] (665s left) prime_vgem (fence-wait)
[356.726869] Starting subtest: fence-wait
[356.729063] Starting dynamic subtest: rcs0
[357.785913] Dynamic subtest rcs0: SUCCESS (1.058s)
[357.796050] Starting dynamic subtest: bcs0
[358.869205] Dynamic subtest bcs0: SUCCESS (1.083s)
[358.879314] Starting dynamic subtest: vcs0
[359.911932] Dynamic subtest vcs0: SUCCESS (1.041s)
[359.922682] Starting dynamic subtest: vcs1
[360.954652] Dynamic subtest vcs1: SUCCESS (1.041s)
[360.965715] Starting dynamic subtest: vecs0
[361.997923] Dynamic subtest vecs0: SUCCESS (1.040s)
[362.008775] Starting dynamic subtest: ccs0
[363.041530] Dynamic subtest ccs0: SUCCESS (1.041s)
[363.044216] Subtest fence-wait: SUCCESS (6.315s)
[363.197346] [102/133] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[363.299927] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[363.303816] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[363.438831] [103/133] (658s left) kms_hdr (invalid-metadata-sizes)
[363.534871] Starting subtest: invalid-metadata-sizes
[363.541093] Subtest invalid-metadata-sizes: SKIP (0.000s)
[363.616456] [104/133] (658s left) gem_workarounds (reset)
[363.694192] Starting subtest: reset
[363.852322] Subtest reset: SUCCESS (0.156s)
[364.030589] [105/133] (658s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[364.125866] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[364.127733] Starting dynamic subtest: pipe-A-eDP-1
[364.135191] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[364.148081] Starting dynamic subtest: pipe-B-eDP-1
[364.155606] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[364.165988] Starting dynamic subtest: pipe-C-eDP-1
[364.172896] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[364.180183] Starting dynamic subtest: pipe-D-eDP-1
[364.186986] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[364.190371] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[366.380906] [106/133] (655s left) gem_exec_whisper (basic-forked-all)
[366.444488] Starting subtest: basic-forked-all
[379.927712] Subtest basic-forked-all: SUCCESS (13.478s)
[380.117326] [107/133] (642s left) syncobj_timeline (wait-all-interrupted)
[380.178569] Starting subtest: wait-all-interrupted
[380.280191] Subtest wait-all-interrupted: SUCCESS (0.102s)
[380.371528] [108/133] (641s left) kms_async_flips (alternate-sync-async-flip-atomic)
[380.469616] Starting subtest: alternate-sync-async-flip-atomic
[380.854204] Starting dynamic subtest: pipe-A-eDP-1
[383.668107] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.816s)
[384.037977] Starting dynamic subtest: pipe-B-eDP-1
[386.795957] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s)
[387.162076] Starting dynamic subtest: pipe-C-eDP-1
[389.930646] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[390.295941] Starting dynamic subtest: pipe-D-eDP-1
[393.056390] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[393.058459] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.589s)
[394.238949] [109/133] (628s left) gem_ctx_isolation (dirty-switch)
[394.308597] Starting subtest: dirty-switch
[394.311084] Starting dynamic subtest: rcs0
[394.535640] Dynamic subtest rcs0: SUCCESS (0.227s)
[394.544774] Starting dynamic subtest: bcs0
[394.767079] Dynamic subtest bcs0: SUCCESS (0.229s)
[394.778198] Starting dynamic subtest: vcs0
[394.996592] Dynamic subtest vcs0: SUCCESS (0.229s)
[395.005079] Starting dynamic subtest: vcs1
[396.130864] Dynamic subtest vcs1: SUCCESS (1.133s)
[396.140467] Starting dynamic subtest: vecs0
[398.124814] Dynamic subtest vecs0: SUCCESS (1.993s)
[398.133348] Starting dynamic subtest: ccs0
[400.109910] Dynamic subtest ccs0: SUCCESS (1.984s)
[400.112431] Subtest dirty-switch: SUCCESS (5.802s)
[400.372171] [110/133] (621s left) kms_content_protection (mei-interface)
[400.503851] Starting subtest: mei-interface
[400.508464] Subtest mei-interface: SKIP (0.001s)
[400.634475] [111/133] (621s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[400.732910] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[400.735269] Starting dynamic subtest: pipe-A-default-mode
[403.478719] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[403.481155] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.748s)
[404.324504] [112/133] (618s left) gem_ctx_shared (exec-shared-gtt)
[404.384711] Starting subtest: exec-shared-gtt
[404.387197] Starting dynamic subtest: rcs0
[404.392778] Dynamic subtest rcs0: SUCCESS (0.007s)
[404.403081] Starting dynamic subtest: bcs0
[404.405021] Dynamic subtest bcs0: SUCCESS (0.006s)
[404.413869] Starting dynamic subtest: vcs0
[404.416176] Dynamic subtest vcs0: SUCCESS (0.006s)
[404.424669] Starting dynamic subtest: vcs1
[404.426664] Dynamic subtest vcs1: SUCCESS (0.007s)
[404.435287] Starting dynamic subtest: vecs0
[404.437498] Dynamic subtest vecs0: SUCCESS (0.007s)
[404.445988] Starting dynamic subtest: ccs0
[404.448293] Dynamic subtest ccs0: SUCCESS (0.007s)
[404.450535] Subtest exec-shared-gtt: SUCCESS (0.045s)
[404.629553] [113/133] (617s left) gem_softpin (noreloc-interruptible)
[404.687733] Starting subtest: noreloc-interruptible
[410.108886] Subtest noreloc-interruptible: SUCCESS (5.420s)
[410.254207] [114/133] (612s left) gem_create (create-massive)
[410.306566] Starting subtest: create-massive
[410.308751] Subtest create-massive: SUCCESS (0.000s)
[410.515317] [115/133] (612s left) kms_addfb_basic (unused-handle)
[410.570596] Starting subtest: unused-handle
[410.573304] Subtest unused-handle: SUCCESS (0.000s)
[410.735749] [116/133] (611s left) gem_mmap_gtt (basic-small-bo-tiledx)
[410.787185] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[410.842047] [117/133] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[410.941543] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[410.945965] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[411.053468] [118/133] (611s left) kms_selftest (drm_format_helper)
[411.087084] Starting subtest: drm_format_helper
[411.127749] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[411.301457] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.173s)
[411.309531] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[411.452476] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.151s)
[411.460775] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[411.601974] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.147s)
[411.611290] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[411.756742] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.152s)
[411.764858] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[411.896431] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.139s)
[411.926144] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[412.064692] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.167s)
[412.073108] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[412.216366] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.151s)
[412.224612] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[412.369109] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.153s)
[412.377297] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[412.515400] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.145s)
[412.529078] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[412.657031] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.140s)
[412.667380] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[412.805171] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.148s)
[412.818128] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[412.954172] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.144s)
[412.964265] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[413.106054] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.149s)
[413.116030] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[413.260090] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.154s)
[413.270446] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[413.416074] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.154s)
[413.425634] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[413.547084] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.130s)
[413.555725] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[413.703478] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.155s)
[413.705439] Subtest drm_format_helper: SUCCESS (2.616s)
[413.912050] [119/133] (608s left) kms_vblank (wait-forked-busy)
[414.013799] Starting subtest: wait-forked-busy
[414.015663] Starting dynamic subtest: pipe-A-eDP-1
[415.888057] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[415.901904] Starting dynamic subtest: pipe-D-eDP-1
[418.480264] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.588s)
[418.482467] Subtest wait-forked-busy: SUCCESS (4.465s)
[419.281302] [120/133] (603s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[419.390584] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[419.395167] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[419.538296] [121/133] (603s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[419.594065] Starting subtest: yf-tiled-ccs-to-y-tiled
[419.598681] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[419.789367] [122/133] (603s left) gem_softpin (safe-alignment)
[419.853131] Starting subtest: safe-alignment
[419.890529] Subtest safe-alignment: SUCCESS (0.037s)
[421.895522] [123/133] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[422.017008] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[431.242492] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.228s)
[431.380149] [124/133] (591s left) gem_exec_schedule (u-semaphore-noskip)
[431.454741] Starting subtest: u-semaphore-noskip
[431.861075] Subtest u-semaphore-noskip: SUCCESS (0.412s)
[432.231298] [125/133] (590s left) kms_plane_multiple (2x-tiling-x)
[432.324176] Starting subtest: 2x-tiling-x
[432.328462] Subtest 2x-tiling-x: SKIP (0.000s)
[432.423568] [126/133] (590s left) gem_busy (semaphore)
[432.632932] Subtest semaphore: SKIP (0.000s)
[432.888489] [127/133] (590s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[432.983154] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[433.008755] Starting dynamic subtest: pipe-A-plane-0
[433.013294] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[433.023871] Starting dynamic subtest: pipe-A-plane-3
[433.028316] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[433.037240] Starting dynamic subtest: pipe-A-plane-5
[433.041709] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[434.081668] Starting dynamic subtest: pipe-B-plane-0
[434.085904] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[434.094773] Starting dynamic subtest: pipe-B-plane-3
[434.099649] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[434.110235] Starting dynamic subtest: pipe-B-plane-5
[434.114096] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[434.385574] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (1.400s)
[435.269469] [128/133] (587s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[435.363166] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[435.365456] Starting dynamic subtest: pipe-A
[435.383742] Dynamic subtest pipe-A: SKIP (0.017s)
[435.397798] Starting dynamic subtest: pipe-B
[435.413679] Dynamic subtest pipe-B: SKIP (0.029s)
[435.427227] Starting dynamic subtest: pipe-C
[435.443587] Dynamic subtest pipe-C: SKIP (0.029s)
[435.452117] Starting dynamic subtest: pipe-D
[435.471917] Dynamic subtest pipe-D: SKIP (0.030s)
[435.475518] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.107s)
[435.608947] [129/133] (587s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[435.713111] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[435.717065] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[435.825431] [130/133] (587s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[435.945570] Starting subtest: cursor-tearing-framebuffer-change
[435.947724] Starting dynamic subtest: pipe-A-eDP-1
[436.500582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[436.510375] Starting dynamic subtest: pipe-D-eDP-1
[437.705270] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.200s)
[437.707504] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.757s)
[438.547287] [131/133] (584s left) kms_addfb_basic (bad-pitch-0)
[438.614961] Starting subtest: bad-pitch-0
[438.616977] Subtest bad-pitch-0: SUCCESS (0.000s)
[438.797297] [132/133] (584s left) syncobj_timeline (etime-single-wait-submitted)
[438.863641] Starting subtest: etime-single-wait-submitted
[438.969066] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[439.057672] [133/133] (584s left) i915_query (engine-info-invalid)
[439.122617] Starting subtest: engine-info-invalid
[439.124865] Subtest engine-info-invalid: SUCCESS (0.000s)
[439.238186] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_flink_race
results: parsing output: 4/ for test: gem_render_copy_redux
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_render_copy_redux
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: core_getversion
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cdclk
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_lmem_swapping
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: gem_ctx_param
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_pxp
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_chamelium_hpd
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gen7_exec_parse
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_lmem_swapping
results: parsing output: 49/ for test: kms_draw_crc
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_watchdog
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: syncobj_basic
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gen3_mixed_blits
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_chamelium_frames
results: parsing output: 70/ for test: core_setmaster_vs_auth
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: gem_caching
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: gem_render_tiled_blits
results: parsing output: 78/ for test: i915_getparams_basic
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_pm_dc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_properties
results: parsing output: 87/ for test: gem_exec_alignment
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pipe_crc_basic
results: parsing output: 99/ for test: kms_dirtyfb
results: parsing output: 100/ for test: prime_vgem
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: gem_ctx_isolation
results: parsing output: 109/ for test: kms_content_protection
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_ctx_shared
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_selftest
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_plane_multiple
results: parsing output: 125/ for test: gem_busy
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: i915_query
Done.