[58.848238] Initializing watchdogs
[58.848286]   /dev/watchdog0
[58.863505] [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]
[58.868344] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.870723] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.873750] [001/156] (960s left) gen7_exec_parse (basic-allowed)
[58.936155] Subtest basic-allowed: SKIP (0.000s)
[58.973624] [002/156] (960s left) perf_pmu (enable-race)
[59.006678] Starting subtest: enable-race
[59.007946] Starting dynamic subtest: rcs0
[71.782307] Dynamic subtest rcs0: SUCCESS (12.692s)
[71.789648] Starting dynamic subtest: bcs0
[84.528675] Dynamic subtest bcs0: SUCCESS (12.731s)
[84.535766] Starting dynamic subtest: vcs0
[100.328903] Dynamic subtest vcs0: SUCCESS (15.795s)
[100.338160] Starting dynamic subtest: vcs1
[116.329656] Dynamic subtest vcs1: SUCCESS (15.996s)
[116.339061] Starting dynamic subtest: vecs0
[132.329816] Dynamic subtest vecs0: SUCCESS (15.997s)
[132.339158] Starting dynamic subtest: ccs0
[145.075553] Dynamic subtest ccs0: SUCCESS (12.741s)
[145.076676] Subtest enable-race: SUCCESS (85.958s)
[145.174667] [003/156] (874s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[145.280501] Starting subtest: fbchdr-2p-rte
[145.282307] Subtest fbchdr-2p-rte: SKIP (0.000s)
[145.374242] [004/156] (874s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[145.474047] Starting subtest: 4-tiled-32bpp-rotate-0
[146.997302] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.524s)
[147.123726] [005/156] (872s left) syncobj_wait (wait-all-interrupted)
[147.166520] Starting subtest: wait-all-interrupted
[147.269064] Subtest wait-all-interrupted: SUCCESS (0.101s)
[147.350458] [006/156] (872s left) gem_exec_balancer (nohangcheck)
[147.637929] Starting subtest: nohangcheck
[148.641306] Subtest nohangcheck: SUCCESS (1.001s)
[148.732114] [007/156] (870s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[148.814522] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[148.816404] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[148.914091] [008/156] (870s left) kms_plane (plane-panning-bottom-right-suspend)
[149.012486] Starting subtest: plane-panning-bottom-right-suspend
[149.013539] Starting dynamic subtest: pipe-A
[167.508733] Dynamic subtest pipe-A: SUCCESS (3.685s)
[167.518539] Starting dynamic subtest: pipe-B
[186.529960] Dynamic subtest pipe-B: SUCCESS (4.214s)
[186.530821] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.901s)
[194.466644] [009/156] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[194.562631] Starting subtest: compare-crc-sanitycheck-nv12
[194.563720] Starting dynamic subtest: pipe-A-eDP-1
[195.295283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[195.303718] Starting dynamic subtest: pipe-B-eDP-1
[196.636477] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s)
[196.645971] Starting dynamic subtest: pipe-C-eDP-1
[197.981092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.309s)
[197.989849] Starting dynamic subtest: pipe-D-eDP-1
[199.220359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[199.221351] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.552s)
[200.057561] [010/156] (826s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[200.155843] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[200.157327] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[200.261843] [011/156] (826s left) kms_vblank (query-idle)
[200.343816] Starting subtest: query-idle
[200.344825] Starting dynamic subtest: pipe-A-eDP-1
[202.120976] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s)
[202.131800] Starting dynamic subtest: pipe-D-eDP-1
[204.552240] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.401s)
[204.553336] Subtest query-idle: SUCCESS (4.153s)
[205.380408] [012/156] (821s left) gem_exec_schedule (implicit-read-write)
[205.437513] Starting subtest: implicit-read-write
[205.438829] Starting dynamic subtest: rcs0
[205.553986] Dynamic subtest rcs0: SUCCESS (0.116s)
[205.565816] Starting dynamic subtest: vcs0
[205.635430] Dynamic subtest vcs0: SUCCESS (0.080s)
[205.647270] Starting dynamic subtest: vcs1
[205.722571] Dynamic subtest vcs1: SUCCESS (0.086s)
[205.733656] Starting dynamic subtest: vecs0
[205.801260] Dynamic subtest vecs0: SUCCESS (0.078s)
[205.809991] Starting dynamic subtest: ccs0
[205.890040] Dynamic subtest ccs0: SUCCESS (0.088s)
[205.891379] Subtest implicit-read-write: SUCCESS (0.449s)
[207.013046] [013/156] (819s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[207.059702] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[207.165093] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[207.235457] [014/156] (819s left) kms_cursor_crc (cursor-sliding-max-size)
[207.536115] Starting subtest: cursor-sliding-max-size
[207.538862] Subtest cursor-sliding-max-size: SKIP (0.000s)
[207.651481] [015/156] (819s left) gem_exec_reloc (basic-write-read)
[207.708214] Subtest basic-write-read: SKIP (0.000s)
[207.768376] [016/156] (819s left) kms_content_protection (type1)
[207.901899] Starting subtest: type1
[207.903970] Subtest type1: SKIP (0.000s)
[208.014424] [017/156] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[208.095020] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[208.096601] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[208.223340] [018/156] (818s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[208.306739] Starting subtest: stress-xrgb8888-ytiled
[208.308565] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[208.378935] [019/156] (818s left) gem_exec_params (dr1-dirt)
[208.428058] Starting subtest: DR1-dirt
[208.429128] Subtest DR1-dirt: SUCCESS (0.000s)
[208.536013] [020/156] (818s left) kms_pm_rpm (i2c)
[210.061893] Starting subtest: i2c
[215.780229] Subtest i2c: SUCCESS (5.699s)
[215.863791] [021/156] (811s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[215.956195] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[215.958233] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.043323] [022/156] (811s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[216.418496] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[217.257769] [023/156] (809s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[217.347122] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[217.348755] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[217.438801] [024/156] (809s left) kms_getfb (getfb-handle-valid)
[217.529185] Starting subtest: getfb-handle-valid
[217.530139] Subtest getfb-handle-valid: SUCCESS (0.000s)
[217.632775] [025/156] (809s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[217.691184] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[217.692321] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[217.787788] [026/156] (809s left) syncobj_timeline (etime-multi-wait-submitted)
[217.830006] Starting subtest: etime-multi-wait-submitted
[217.932460] Subtest etime-multi-wait-submitted: SUCCESS (0.101s)
[218.019896] [027/156] (809s left) perf (invalid-open-flags)
[218.148434] Starting subtest: invalid-open-flags
[218.149316] Subtest invalid-open-flags: SUCCESS (0.000s)
[218.189361] [028/156] (809s left) kms_force_connector_basic (force-connector-state)
[218.273886] Starting subtest: force-connector-state
[218.897551] Subtest force-connector-state: SUCCESS (0.624s)
[219.853214] [029/156] (807s left) kms_big_fb (y-tiled-addfb)
[219.944680] Starting subtest: y-tiled-addfb
[219.946557] Subtest y-tiled-addfb: SKIP (0.000s)
[220.044218] [030/156] (807s left) kms_pipe_crc_basic (bad-source)
[220.124993] Starting subtest: bad-source
[220.126063] Subtest bad-source: SUCCESS (0.000s)
[220.192432] [031/156] (807s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[220.273677] Starting subtest: fbcpsrhdr-modesetfrombusy
[220.275393] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[220.348022] [032/156] (807s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[220.443578] Starting subtest: extended-modeset-hang-newfb-with-reset
[220.444678] Starting dynamic subtest: pipe-A
[236.378169] Dynamic subtest pipe-A: SUCCESS (15.932s)
[236.389380] Starting dynamic subtest: pipe-D
[251.976976] Dynamic subtest pipe-D: SUCCESS (15.593s)
[251.977913] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.528s)
[252.824266] [033/156] (774s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[252.938059] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[252.940085] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[253.076363] [034/156] (774s left) gem_exec_whisper (basic-contexts-forked-all)
[253.125937] Starting subtest: basic-contexts-forked-all
[273.940580] Subtest basic-contexts-forked-all: SUCCESS (20.795s)
[274.115231] [035/156] (753s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[274.215812] Starting subtest: fbc-rgb565-draw-mmap-gtt
[274.217422] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[274.303004] [036/156] (753s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[274.399214] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[274.400950] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[274.490262] [037/156] (753s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[274.584927] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[274.586427] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[274.676342] [038/156] (752s left) syncobj_wait (wait-any-interrupted)
[274.718969] Starting subtest: wait-any-interrupted
[274.820142] Subtest wait-any-interrupted: SUCCESS (0.101s)
[274.890112] [039/156] (752s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[274.987304] Starting subtest: fbc-psr2-sprite-mmap-gtt
[274.988506] Starting dynamic subtest: eDP-1
[274.990759] Dynamic subtest eDP-1: SKIP (0.000s)
[274.992814] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[275.061489] [040/156] (752s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[275.146515] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[275.174791] Starting dynamic subtest: pipe-A-plane-0
[275.563554] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s)
[275.573708] Starting dynamic subtest: pipe-A-plane-3
[275.863832] Dynamic subtest pipe-A-plane-3: SUCCESS (0.300s)
[277.003595] Starting dynamic subtest: pipe-B-plane-0
[277.404737] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[277.414167] Starting dynamic subtest: pipe-B-plane-3
[277.704865] Dynamic subtest pipe-B-plane-3: SUCCESS (0.299s)
[278.015300] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.866s)
[278.833964] [041/156] (748s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[278.927934] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[278.929479] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[279.021408] [042/156] (748s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[279.077313] Starting subtest: legacy-engines-hostile-preempt
[279.078404] Starting dynamic subtest: render
[279.151926] Dynamic subtest render: SUCCESS (0.074s)
[279.165126] Starting dynamic subtest: bsd1
[280.896485] Dynamic subtest bsd1: SUCCESS (1.731s)
[280.906458] Starting dynamic subtest: bsd2
[282.973099] Dynamic subtest bsd2: SUCCESS (2.073s)
[282.985083] Starting dynamic subtest: blt
[282.988324] Dynamic subtest blt: SUCCESS (0.022s)
[282.999326] Starting dynamic subtest: vebox
[284.953120] Dynamic subtest vebox: SUCCESS (1.954s)
[284.954299] Subtest legacy-engines-hostile-preempt: SUCCESS (5.864s)
[285.030333] [043/156] (742s left) gem_exec_params (sol-reset-not-gen7)
[285.072282] Starting subtest: sol-reset-not-gen7
[285.075080] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[285.193692] [044/156] (742s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[285.290822] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[285.292448] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[285.393717] [045/156] (742s left) gem_exec_async (forked-writes)
[285.454962] Starting subtest: forked-writes
[285.455979] Starting dynamic subtest: rcs0
[285.481454] Dynamic subtest rcs0: SUCCESS (0.026s)
[285.491549] Starting dynamic subtest: bcs0
[285.509942] Dynamic subtest bcs0: SUCCESS (0.028s)
[285.519808] Starting dynamic subtest: vcs0
[285.533593] Dynamic subtest vcs0: SUCCESS (0.023s)
[285.545338] Starting dynamic subtest: vcs1
[285.558291] Dynamic subtest vcs1: SUCCESS (0.023s)
[285.568782] Starting dynamic subtest: vecs0
[285.585912] Dynamic subtest vecs0: SUCCESS (0.026s)
[285.597654] Starting dynamic subtest: ccs0
[285.607313] Dynamic subtest ccs0: SUCCESS (0.021s)
[285.608112] Subtest forked-writes: SUCCESS (0.153s)
[285.816675] [046/156] (742s left) gem_render_copy (linear-to-vebox-y-tiled)
[285.874012] Starting subtest: linear-to-vebox-y-tiled
[285.876671] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[286.051595] [047/156] (741s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[286.135456] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[286.137355] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[286.230659] [048/156] (741s left) kms_cursor_crc (cursor-onscreen-512x512)
[286.482312] Starting subtest: cursor-onscreen-512x512
[286.485919] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[286.632460] [049/156] (741s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[286.722190] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[293.896697] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.184s)
[294.016273] [050/156] (734s left) gem_exec_params (no-blt)
[294.067874] Starting subtest: no-blt
[294.070339] Subtest no-blt: SUCCESS (0.003s)
[294.194541] [051/156] (733s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[294.302646] Starting subtest: cursorB-vs-flipB-legacy
[294.304667] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[294.444324] [052/156] (733s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[294.497108] Starting subtest: single-wait-all-for-submit-available-submitted
[294.498241] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[294.606794] [053/156] (733s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[294.706526] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[294.708423] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[294.798383] [054/156] (733s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[294.900191] Starting subtest: yf-tiled-8bpp-rotate-0
[294.902020] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[294.987008] [055/156] (733s left) gem_exec_schedule (preempt-contexts)
[295.049786] Starting subtest: preempt-contexts
[295.050755] Starting dynamic subtest: rcs0
[295.100428] Dynamic subtest rcs0: SUCCESS (0.050s)
[295.110711] Starting dynamic subtest: bcs0
[295.152800] Dynamic subtest bcs0: SUCCESS (0.052s)
[295.161748] Starting dynamic subtest: vcs0
[295.196893] Dynamic subtest vcs0: SUCCESS (0.043s)
[295.205949] Starting dynamic subtest: vcs1
[295.238461] Dynamic subtest vcs1: SUCCESS (0.041s)
[295.248005] Starting dynamic subtest: vecs0
[295.281444] Dynamic subtest vecs0: SUCCESS (0.042s)
[295.290417] Starting dynamic subtest: ccs0
[295.324940] Dynamic subtest ccs0: SUCCESS (0.043s)
[295.325832] Subtest preempt-contexts: SUCCESS (0.276s)
[297.069307] [056/156] (731s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[297.160354] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[297.172642] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[297.254813] [057/156] (731s left) sysfs_heartbeat_interval (idempotent)
[297.314057] Starting subtest: idempotent
[297.315077] Starting dynamic subtest: vecs0
[297.316080] Dynamic subtest vecs0: SUCCESS (0.001s)
[297.328239] Starting dynamic subtest: ccs0
[297.329163] Dynamic subtest ccs0: SUCCESS (0.001s)
[297.337976] Starting dynamic subtest: vcs0
[297.338899] Dynamic subtest vcs0: SUCCESS (0.000s)
[297.347506] Starting dynamic subtest: bcs0
[297.348405] Dynamic subtest bcs0: SUCCESS (0.001s)
[297.356838] Starting dynamic subtest: rcs0
[297.357683] Dynamic subtest rcs0: SUCCESS (0.000s)
[297.366078] Starting dynamic subtest: vcs1
[297.366977] Dynamic subtest vcs1: SUCCESS (0.000s)
[297.367853] Subtest idempotent: SUCCESS (0.007s)
[297.396100] [058/156] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[297.489843] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[304.894466] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.409s)
[305.013527] [059/156] (723s left) kms_psr (pr-primary-blt)
[305.108219] Starting subtest: pr-primary-blt
[305.109901] Subtest pr-primary-blt: SKIP (0.000s)
[305.174142] [060/156] (723s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[305.265429] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[309.377496] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.116s)
[310.546654] [061/156] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[310.641822] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[310.643635] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[310.745139] [062/156] (717s left) i915_pm_rpm (system-suspend)
[312.267933] Starting subtest: system-suspend
[330.911839] Subtest system-suspend: SUCCESS (3.248s)
[337.368085] [063/156] (697s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[337.473519] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[337.475322] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[337.563727] [064/156] (697s left) gem_ctx_param (invalid-get-ringsize)
[337.608093] Starting subtest: invalid-get-ringsize
[337.609006] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[337.703426] [065/156] (696s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[337.801456] Starting subtest: x-tiled-32bpp-rotate-0
[339.219674] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.379s)
[339.338035] [066/156] (695s left) gem_exec_flush (basic-wb-rw-default)
[339.392043] Starting subtest: basic-wb-rw-default
[344.944580] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[345.129357] [067/156] (689s left) kms_joiner (invalid-modeset-ultra-joiner)
[345.226281] Starting subtest: invalid-modeset-ultra-joiner
[345.228156] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[345.298063] [068/156] (689s left) perf (non-zero-reason)
[345.392827] Starting subtest: non-zero-reason
[345.393888] Starting dynamic subtest: 0-rcs0
[351.210644] Dynamic subtest 0-rcs0: SUCCESS (5.726s)
[351.223122] Starting dynamic subtest: 1-vcs1
[355.296757] Dynamic subtest 1-vcs1: SUCCESS (4.067s)
[355.298157] Subtest non-zero-reason: SUCCESS (9.795s)
[355.329476] [069/156] (679s left) kms_color (ctm-red-to-blue)
[355.415430] Starting subtest: ctm-red-to-blue
[355.416393] Starting dynamic subtest: pipe-A-eDP-1
[356.127406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[356.136799] Starting dynamic subtest: pipe-B-eDP-1
[357.621925] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[357.631044] Starting dynamic subtest: pipe-C-eDP-1
[359.027289] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[359.036860] Starting dynamic subtest: pipe-D-eDP-1
[360.440915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[360.441706] Subtest ctm-red-to-blue: SUCCESS (5.013s)
[361.297738] [070/156] (673s left) gem_exec_schedule (u-semaphore-user)
[361.365873] Starting subtest: u-semaphore-user
[361.423973] Subtest u-semaphore-user: SUCCESS (0.058s)
[363.350021] [071/156] (671s left) syncobj_wait (single-wait-for-submit-submitted)
[363.405383] Starting subtest: single-wait-for-submit-submitted
[363.514700] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[363.585228] [072/156] (671s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[363.633111] Subtest tiled-to-tiled: SKIP (0.000s)
[363.695962] [073/156] (671s left) i915_hangman (hangcheck-unterminated)
[363.750346] Starting subtest: hangcheck-unterminated
[373.341098] Subtest hangcheck-unterminated: SUCCESS (9.574s)
[373.451075] [074/156] (661s left) kms_plane_scaling (planes-upscale-factor-0-25)
[373.541187] Starting subtest: planes-upscale-factor-0-25
[373.542247] Starting dynamic subtest: pipe-A
[373.602260] Dynamic subtest pipe-A: SUCCESS (0.062s)
[373.613510] Starting dynamic subtest: pipe-B
[374.719802] Dynamic subtest pipe-B: SUCCESS (1.116s)
[374.732885] Starting dynamic subtest: pipe-C
[375.888644] Dynamic subtest pipe-C: SUCCESS (1.167s)
[375.898201] Starting dynamic subtest: pipe-D
[376.994874] Dynamic subtest pipe-D: SUCCESS (1.105s)
[376.995908] Subtest planes-upscale-factor-0-25: SUCCESS (3.455s)
[378.229012] [075/156] (656s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[378.315976] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[378.318286] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[378.407967] [076/156] (656s left) gem_spin_batch (resubmit-new-all)
[378.457840] Starting subtest: resubmit-new-all
[378.458785] Starting dynamic subtest: rcs0
[378.471269] Dynamic subtest rcs0: SUCCESS (0.013s)
[378.482994] Starting dynamic subtest: bcs0
[378.485043] Dynamic subtest bcs0: SUCCESS (0.013s)
[378.495186] Starting dynamic subtest: vcs0
[378.496332] Dynamic subtest vcs0: SUCCESS (0.010s)
[378.505769] Starting dynamic subtest: vcs1
[378.508241] Dynamic subtest vcs1: SUCCESS (0.012s)
[378.517685] Starting dynamic subtest: vecs0
[378.518607] Dynamic subtest vecs0: SUCCESS (0.009s)
[378.528021] Starting dynamic subtest: ccs0
[378.528796] Dynamic subtest ccs0: SUCCESS (0.009s)
[378.529550] Subtest resubmit-new-all: SUCCESS (0.070s)
[380.375610] [077/156] (654s left) kms_flip (bo-too-big-interruptible)
[380.465980] Starting subtest: bo-too-big-interruptible
[380.466981] Starting dynamic subtest: A-eDP1
[381.740238] Dynamic subtest A-eDP1: SUCCESS (1.275s)
[381.752980] Starting dynamic subtest: B-eDP1
[383.045175] Dynamic subtest B-eDP1: SUCCESS (1.302s)
[383.059280] Starting dynamic subtest: C-eDP1
[384.349906] Dynamic subtest C-eDP1: SUCCESS (1.302s)
[384.361703] Starting dynamic subtest: D-eDP1
[385.638369] Dynamic subtest D-eDP1: SUCCESS (1.288s)
[385.639481] Subtest bo-too-big-interruptible: SUCCESS (5.176s)
[386.818815] [078/156] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[386.909247] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[386.911047] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[386.994462] [079/156] (648s left) vgem_basic (create)
[387.103745] Starting subtest: create
[387.104964] Subtest create: SUCCESS (0.000s)
[387.167593] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[387.169552] [080/156] (647s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[387.265958] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[387.267689] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[387.355032] [081/156] (647s left) i915_drm_fdinfo (basics)
[387.389661] Starting subtest: basics
[387.390415] Subtest basics: SUCCESS (0.000s)
[387.457461] [082/156] (647s left) gem_exec_whisper (basic-queues-priority)
[387.519172] Starting subtest: basic-queues-priority
[410.475040] Subtest basic-queues-priority: SUCCESS (22.936s)
[410.648587] [083/156] (624s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[410.744612] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[410.745475] Starting dynamic subtest: pipe-A-eDP-1
[410.754023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.763800] Starting dynamic subtest: pipe-B-eDP-1
[410.772081] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.781293] Starting dynamic subtest: pipe-C-eDP-1
[410.789088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.801846] Starting dynamic subtest: pipe-D-eDP-1
[410.810475] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.812042] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[413.020591] [084/156] (622s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[413.138680] Starting subtest: cursorB-vs-flipA-atomic
[413.141291] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[413.278470] [085/156] (622s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[413.371829] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[413.372699] Starting dynamic subtest: pipe-A-eDP-1
[413.394333] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[413.403946] Starting dynamic subtest: pipe-B-eDP-1
[413.425393] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[413.434739] Starting dynamic subtest: pipe-C-eDP-1
[413.455776] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[413.464417] Starting dynamic subtest: pipe-D-eDP-1
[413.485484] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[413.487266] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[415.617021] [086/156] (619s left) gem_ppgtt (blt-vs-render-ctx0)
[415.668852] Starting subtest: blt-vs-render-ctx0
[448.616679] Subtest blt-vs-render-ctx0: SUCCESS (32.935s)
[448.764193] [087/156] (586s left) kms_setmode (basic-clone-single-crtc)
[448.978092] Starting subtest: basic-clone-single-crtc
[448.980945] Subtest basic-clone-single-crtc: SKIP (0.000s)
[449.053026] [088/156] (586s left) kms_cursor_crc (cursor-random-512x170)
[449.367852] Starting subtest: cursor-random-512x170
[449.370053] Subtest cursor-random-512x170: SKIP (0.001s)
[449.505621] [089/156] (585s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[449.559553] Starting subtest: yf-tiled-to-vebox-y-tiled
[449.561312] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[449.739748] [090/156] (585s left) gem_exec_balancer (waits)
[449.811251] Starting subtest: waits
[456.456006] Subtest waits: SUCCESS (6.599s)
[456.766984] [091/156] (578s left) api_intel_bb (full-batch)
[456.809046] Starting subtest: full-batch
[456.814013] Subtest full-batch: SUCCESS (0.005s)
[456.942217] [092/156] (578s left) kms_flip (basic-flip-vs-wf_vblank)
[457.036018] Starting subtest: basic-flip-vs-wf_vblank
[457.038722] Starting dynamic subtest: A-eDP1
[459.045225] Dynamic subtest A-eDP1: SUCCESS (2.005s)
[459.055607] Starting dynamic subtest: B-eDP1
[460.933217] Dynamic subtest B-eDP1: SUCCESS (1.887s)
[460.943889] Starting dynamic subtest: C-eDP1
[462.835192] Dynamic subtest C-eDP1: SUCCESS (1.899s)
[462.848021] Starting dynamic subtest: D-eDP1
[464.728842] Dynamic subtest D-eDP1: SUCCESS (1.893s)
[464.732907] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.697s)
[465.939696] [093/156] (569s left) gem_mmap_gtt (isolation)
[465.991623] Subtest isolation: SKIP (0.000s)
[466.054609] [094/156] (569s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[466.114637] Starting subtest: multi-wait-all-for-submit-available-signaled
[466.115724] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[466.221174] [095/156] (569s left) gem_close_race (basic-threads)
[466.291117] Starting subtest: basic-threads
[467.705111] Subtest basic-threads: SUCCESS (1.414s)
[467.886847] [096/156] (567s left) kms_frontbuffer_tracking (psr-2p-rte)
[467.974795] Starting subtest: psr-2p-rte
[467.976795] Subtest psr-2p-rte: SKIP (0.000s)
[468.067418] [097/156] (567s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[468.161197] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[468.162936] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[468.268669] [098/156] (567s left) gem_eio (in-flight-internal-1us)
[468.503182] Starting subtest: in-flight-internal-1us
[470.397736] Subtest in-flight-internal-1us: SUCCESS (1.895s)
[470.539016] [099/156] (565s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[470.620089] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[470.621979] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[470.690739] [100/156] (565s left) gem_pxp (create-protected-buffer)
[470.804730] Starting subtest: create-protected-buffer
[470.806002] Subtest create-protected-buffer: SUCCESS (0.000s)
[470.906098] [101/156] (565s left) gem_userptr_blits (access-control)
[470.974810] Starting subtest: access-control
[470.976701] Subtest access-control: SKIP (0.000s)
[471.083159] [102/156] (564s left) kms_big_fb (linear-8bpp-rotate-180)
[471.176208] Starting subtest: linear-8bpp-rotate-180
[472.445535] Subtest linear-8bpp-rotate-180: SUCCESS (1.269s)
[472.566579] [103/156] (563s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[472.662958] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[479.751861] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.088s)
[479.873693] [104/156] (556s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[479.983492] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[486.828699] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.846s)
[488.261644] [105/156] (547s left) kms_flip (bo-too-big)
[488.344161] Starting subtest: bo-too-big
[488.346851] Starting dynamic subtest: A-eDP1
[489.638896] Dynamic subtest A-eDP1: SUCCESS (1.291s)
[489.652048] Starting dynamic subtest: B-eDP1
[490.943996] Dynamic subtest B-eDP1: SUCCESS (1.304s)
[490.955915] Starting dynamic subtest: C-eDP1
[492.250146] Dynamic subtest C-eDP1: SUCCESS (1.303s)
[492.266063] Starting dynamic subtest: D-eDP1
[493.552503] Dynamic subtest D-eDP1: SUCCESS (1.301s)
[493.554043] Subtest bo-too-big: SUCCESS (5.207s)
[494.712387] [106/156] (541s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[494.824698] Starting subtest: pr-overlay-plane-move-continuous-sf
[494.826407] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[494.897200] [107/156] (541s left) kms_universal_plane (universal-plane-functional)
[494.983965] Starting subtest: universal-plane-functional
[494.984917] Starting dynamic subtest: pipe-A-eDP-1
[498.885160] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.899s)
[498.896278] Starting dynamic subtest: pipe-B-eDP-1
[503.371755] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.483s)
[503.381760] Starting dynamic subtest: pipe-C-eDP-1
[507.536920] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.163s)
[507.548125] Starting dynamic subtest: pipe-D-eDP-1
[511.835454] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.295s)
[511.836521] Subtest universal-plane-functional: SUCCESS (16.847s)
[512.718120] [108/156] (523s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[512.809861] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[512.811569] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[513.937079] [109/156] (522s left) perf (create-destroy-userspace-config)
[514.054387] Starting subtest: create-destroy-userspace-config
[514.070031] Subtest create-destroy-userspace-config: SUCCESS (0.015s)
[514.111281] [110/156] (522s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[514.205292] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[514.207131] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[514.307303] [111/156] (521s left) gem_mmap_gtt (fault-concurrent-x)
[514.364596] Subtest fault-concurrent-X: SKIP (0.000s)
[514.427783] [112/156] (521s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[514.509806] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[519.097739] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.587s)
[520.230968] [113/156] (516s left) kms_psr (psr2-primary-blt)
[520.317643] Starting subtest: psr2-primary-blt
[520.318503] Starting dynamic subtest: eDP-1
[522.084598] Dynamic subtest eDP-1: SUCCESS (1.765s)
[522.085583] Subtest psr2-primary-blt: SUCCESS (1.766s)
[522.938819] [114/156] (513s left) prime_busy (before)
[522.994646] Starting subtest: before
[522.996872] Starting dynamic subtest: rcs0
[523.030491] Dynamic subtest rcs0: SUCCESS (0.034s)
[523.041682] Starting dynamic subtest: bcs0
[523.079702] Dynamic subtest bcs0: SUCCESS (0.048s)
[523.093378] Starting dynamic subtest: vcs0
[523.121295] Dynamic subtest vcs0: SUCCESS (0.040s)
[523.131279] Starting dynamic subtest: vcs1
[523.162219] Dynamic subtest vcs1: SUCCESS (0.040s)
[523.171999] Starting dynamic subtest: vecs0
[523.203572] Dynamic subtest vecs0: SUCCESS (0.040s)
[523.213665] Starting dynamic subtest: ccs0
[523.244161] Dynamic subtest ccs0: SUCCESS (0.040s)
[523.351719] Subtest before: SUCCESS (0.357s)
[523.431431] [115/156] (513s left) kms_panel_fitting (legacy)
[523.518560] Starting subtest: legacy
[523.519490] Starting dynamic subtest: pipe-A-eDP-1
[524.039394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[524.068966] Starting dynamic subtest: pipe-B-eDP-1
[525.622285] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.563s)
[525.653003] Starting dynamic subtest: pipe-C-eDP-1
[527.139070] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.497s)
[527.167184] Starting dynamic subtest: pipe-D-eDP-1
[528.695248] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.536s)
[528.696462] Subtest legacy: SUCCESS (5.177s)
[529.926643] [116/156] (506s left) dumb_buffer (create-valid-dumb)
[529.973638] Starting subtest: create-valid-dumb
[529.974645] Subtest create-valid-dumb: SUCCESS (0.000s)
[530.067027] [117/156] (506s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[530.168970] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[530.170620] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[530.239793] [118/156] (506s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[530.327801] Starting subtest: bad-rotation-90-y-tiled-ccs
[530.328762] Starting dynamic subtest: pipe-A-eDP-1
[530.337241] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.347444] Starting dynamic subtest: pipe-B-eDP-1
[530.357295] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.367367] Starting dynamic subtest: pipe-C-eDP-1
[530.376149] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.386001] Starting dynamic subtest: pipe-D-eDP-1
[530.394157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.395742] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[532.622746] [119/156] (503s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[532.704983] Starting subtest: fbc-pr-cursor-mmap-gtt
[532.706811] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[532.787958] [120/156] (503s left) gem_userptr_blits (map-fixed-invalidate-busy)
[532.853718] Starting subtest: map-fixed-invalidate-busy
[532.855582] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[532.964565] [121/156] (503s left) api_intel_allocator (gem-pool)
[533.005984] Starting subtest: gem-pool
[533.014110] Subtest gem-pool: SUCCESS (0.009s)
[533.100678] [122/156] (503s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[533.155714] Subtest writes-after-reads-uncached: SKIP (0.000s)
[533.224307] [123/156] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[533.318230] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[533.320372] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[533.411244] [124/156] (503s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[533.502007] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[533.503648] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[533.624558] [125/156] (503s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[533.731054] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[534.412493] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[534.571501] [126/156] (502s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[534.952072] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[535.808948] [127/156] (501s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[535.899117] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[535.910874] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[535.990797] [128/156] (500s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[536.084881] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[536.111980] Starting dynamic subtest: pipe-A-plane-0
[536.389497] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s)
[536.399516] Starting dynamic subtest: pipe-A-plane-3
[536.600464] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[536.611222] Starting dynamic subtest: pipe-A-plane-5
[536.612992] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[537.694000] Starting dynamic subtest: pipe-B-plane-0
[537.962128] Dynamic subtest pipe-B-plane-0: SUCCESS (0.277s)
[537.972358] Starting dynamic subtest: pipe-B-plane-3
[538.173429] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[538.185600] Starting dynamic subtest: pipe-B-plane-5
[538.187391] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[538.492393] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.407s)
[539.320679] [129/156] (497s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[539.413158] Starting subtest: primary-4-tiled-reflect-x-180
[546.458124] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.044s)
[547.626375] [130/156] (489s left) gem_exec_reloc (basic-wc-read)
[547.680753] Subtest basic-wc-read: SKIP (0.000s)
[547.756268] [131/156] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[547.843750] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[554.766456] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.922s)
[554.912321] [132/156] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[555.015983] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[562.179455] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.163s)
[562.288446] [133/156] (474s left) prime_self_import (basic-llseek-size)
[562.325639] Starting subtest: basic-llseek-size
[562.353326] Subtest basic-llseek-size: SUCCESS (0.031s)
[562.455294] [134/156] (474s left) gem_exec_flush (basic-batch-kernel-default-wb)
[562.511019] Starting subtest: basic-batch-kernel-default-wb
[569.333402] Subtest basic-batch-kernel-default-wb: SUCCESS (6.824s)
[569.523400] [135/156] (467s left) kms_hdr (invalid-metadata-sizes)
[569.623159] Starting subtest: invalid-metadata-sizes
[569.624128] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[569.625965] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[569.636368] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[569.638483] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[569.640551] Subtest invalid-metadata-sizes: SKIP (0.003s)
[569.696639] [136/156] (467s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[569.788800] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[569.790556] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[569.878488] [137/156] (467s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[569.993444] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[577.475246] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.486s)
[577.609433] [138/156] (459s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[577.694743] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[577.706828] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[577.780131] [139/156] (459s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[577.868206] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[577.870086] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[577.939848] [140/156] (459s left) kms_feature_discovery (chamelium)
[578.024059] Starting subtest: chamelium
[578.025858] Subtest chamelium: SKIP (0.000s)
[578.110780] [141/156] (459s left) gem_busy (parallel)
[578.283962] Starting subtest: parallel
[578.285264] Starting dynamic subtest: rcs0
[580.351030] Dynamic subtest rcs0: SUCCESS (2.065s)
[580.363708] Starting dynamic subtest: bcs0
[582.334743] Dynamic subtest bcs0: SUCCESS (1.981s)
[582.346860] Starting dynamic subtest: vcs0
[584.383888] Dynamic subtest vcs0: SUCCESS (2.047s)
[584.396480] Starting dynamic subtest: vcs1
[586.367384] Dynamic subtest vcs1: SUCCESS (1.981s)
[586.380205] Starting dynamic subtest: vecs0
[588.350762] Dynamic subtest vecs0: SUCCESS (1.981s)
[588.361992] Starting dynamic subtest: ccs0
[590.335436] Dynamic subtest ccs0: SUCCESS (1.982s)
[590.336854] Subtest parallel: SUCCESS (12.052s)
[590.564760] [142/156] (446s left) kms_chamelium_color (ctm-0-75)
[590.660908] Subtest ctm-0-75: SKIP (0.000s)
[590.704495] [143/156] (446s left) kms_async_flips (test-time-stamp-atomic)
[590.784030] Starting subtest: test-time-stamp-atomic
[591.155274] Starting dynamic subtest: pipe-A-eDP-1
[591.998385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.842s)
[592.394294] Starting dynamic subtest: pipe-B-eDP-1
[593.204553] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.818s)
[593.571429] Starting dynamic subtest: pipe-C-eDP-1
[594.400657] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.837s)
[594.766634] Starting dynamic subtest: pipe-D-eDP-1
[595.596605] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.838s)
[595.597636] Subtest test-time-stamp-atomic: SUCCESS (4.814s)
[596.831110] [144/156] (440s left) kms_pm_rpm (modeset-non-lpsp-stress)
[598.462161] Starting subtest: modeset-non-lpsp-stress
[599.614374] Subtest modeset-non-lpsp-stress: SKIP (1.154s)
[600.002573] [145/156] (437s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[600.101073] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[600.102706] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[600.196609] [146/156] (437s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[600.288809] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[600.663062] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[603.472195] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[603.482290] Starting dynamic subtest: pipe-A-eDP-1-4
[605.657599] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[605.671257] Starting dynamic subtest: pipe-A-eDP-1-4
[607.667337] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[607.677611] Starting dynamic subtest: pipe-A-eDP-1-x
[609.868943] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[610.235399] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[612.978866] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.745s)
[612.992877] Starting dynamic subtest: pipe-B-eDP-1-4
[615.163726] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s)
[615.174286] Starting dynamic subtest: pipe-B-eDP-1-4
[617.174170] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[617.186434] Starting dynamic subtest: pipe-B-eDP-1-x
[619.363664] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[619.735083] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[622.474805] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.741s)
[622.487876] Starting dynamic subtest: pipe-C-eDP-1-4
[624.659428] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.183s)
[624.670038] Starting dynamic subtest: pipe-C-eDP-1-4
[626.669372] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[626.679777] Starting dynamic subtest: pipe-C-eDP-1-x
[628.858990] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.187s)
[629.220152] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[631.970441] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.749s)
[631.984817] Starting dynamic subtest: pipe-D-eDP-1-4
[634.144824] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[634.157905] Starting dynamic subtest: pipe-D-eDP-1-4
[636.155335] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[636.167509] Starting dynamic subtest: pipe-D-eDP-1-x
[638.333975] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.175s)
[638.335440] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.036s)
[639.521714] [147/156] (398s left) kms_rotation_crc (cursor-rotation-180)
[639.609780] Starting subtest: cursor-rotation-180
[641.156446] Subtest cursor-rotation-180: SUCCESS (1.547s)
[642.331939] [148/156] (395s left) kms_psr (fbc-psr-primary-mmap-gtt)
[642.414661] Starting subtest: fbc-psr-primary-mmap-gtt
[642.415506] Starting dynamic subtest: eDP-1
[642.417516] Dynamic subtest eDP-1: SKIP (0.000s)
[642.419705] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[642.487942] [149/156] (395s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt)
[642.596753] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt
[642.598365] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[642.690832] [150/156] (395s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[642.784969] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[642.786598] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[642.887182] [151/156] (394s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[642.998735] Starting subtest: basic-flip-before-cursor-legacy
[643.909089] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.911s)
[644.722699] [152/156] (393s left) gem_create (create-size-update)
[644.772628] Starting subtest: create-size-update
[644.773689] Subtest create-size-update: SUCCESS (0.000s)
[644.978939] [153/156] (392s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[645.558609] Starting subtest: syncobj-timeline-multiple-ext-nodes
[645.560051] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[647.438822] [154/156] (390s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[647.537444] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[647.538992] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[647.639855] [155/156] (390s left) i915_query (test-query-geometry-subslices)
[647.691605] Starting subtest: test-query-geometry-subslices
[647.692517] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[647.788089] [156/156] (390s left) gen9_exec_parse (batch-without-end)
[647.849362] Subtest batch-without-end: SKIP (0.000s)
[647.917898] Closing watchdogs
results: parsing output: 0/ for test: gen7_exec_parse
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_pipe_crc_basic
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_pipe_stress
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_chamelium_edid
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_getfb
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_force_connector_basic
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_pipe_crc_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_busy
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_async
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: sysfs_heartbeat_interval
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: kms_joiner
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_color
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: gem_set_tiling_vs_blt
results: parsing output: 72/ for test: i915_hangman
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_spin_batch
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: vgem_basic
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: i915_drm_fdinfo
results: parsing output: 81/ for test: gem_exec_whisper
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_ppgtt
results: parsing output: 86/ for test: kms_setmode
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_close_race
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_pxp
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_universal_plane
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: prime_busy
results: parsing output: 114/ for test: kms_panel_fitting
results: parsing output: 115/ for test: dumb_buffer
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: gem_partial_pwrite_pread
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: prime_self_import
results: parsing output: 133/ for test: gem_exec_flush
results: parsing output: 134/ for test: kms_hdr
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: kms_flip_scaled_crc
results: parsing output: 139/ for test: kms_feature_discovery
results: parsing output: 140/ for test: gem_busy
results: parsing output: 141/ for test: kms_chamelium_color
results: parsing output: 142/ for test: kms_async_flips
results: parsing output: 143/ for test: kms_pm_rpm
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_async_flips
results: parsing output: 146/ for test: kms_rotation_crc
results: parsing output: 147/ for test: kms_psr
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_cursor_legacy
results: parsing output: 151/ for test: gem_create
results: parsing output: 152/ for test: gem_exec_fence
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: i915_query
results: parsing output: 155/ for test: gen9_exec_parse
Done.