[58.342858] Initializing watchdogs
[58.342904]   /dev/watchdog0
[58.357971] [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.362628] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.365225] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.368506] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[58.507691] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[65.920561] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.419s)
[66.054349] [002/156] (952s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[66.164077] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[66.843486] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[67.005162] [003/156] (951s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[67.089797] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[67.092082] Starting dynamic subtest: pipe-A-eDP-1
[67.115368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.125672] Starting dynamic subtest: pipe-B-eDP-1
[67.147305] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.154820] Starting dynamic subtest: pipe-C-eDP-1
[67.176628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.183867] Starting dynamic subtest: pipe-D-eDP-1
[67.206821] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.211401] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[69.405768] [004/156] (949s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[69.499662] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[69.504025] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[69.587470] [005/156] (949s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[69.694635] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[69.698362] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[69.794979] [006/156] (949s left) perf (global-sseu-config)
[69.925587] Starting subtest: global-sseu-config
[69.929850] Subtest global-sseu-config: SKIP (0.000s)
[69.969308] [007/156] (949s left) core_debugfs (read-all-entries)
[70.033040] Starting subtest: read-all-entries
[70.127765] Subtest read-all-entries: SUCCESS (0.095s)
[70.192753] [008/156] (948s left) kms_flip (flip-vs-absolute-wf_vblank)
[70.287653] Starting subtest: flip-vs-absolute-wf_vblank
[70.289596] Starting dynamic subtest: A-eDP1
[79.254417] Dynamic subtest A-eDP1: SUCCESS (8.968s)
[79.262368] Starting dynamic subtest: B-eDP1
[88.184797] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[88.195546] Starting dynamic subtest: C-eDP1
[97.108814] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[97.117742] Starting dynamic subtest: D-eDP1
[106.040521] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[106.042819] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.758s)
[107.263938] [009/156] (911s left) syncobj_timeline (reset-unsignaled)
[107.328080] Starting subtest: reset-unsignaled
[107.330405] Subtest reset-unsignaled: SUCCESS (0.000s)
[107.413491] [010/156] (911s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt)
[107.517692] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt
[107.522126] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[107.615180] [011/156] (911s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt)
[107.723999] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt
[107.728587] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[107.827390] [012/156] (911s left) i915_query (query-regions-garbage-items)
[107.885520] Starting subtest: query-regions-garbage-items
[107.887387] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[107.989893] [013/156] (911s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[108.095982] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[108.100185] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[108.205353] [014/156] (911s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[108.306463] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[108.309803] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.394880] [015/156] (911s left) gem_eio (kms)
[108.632355] Starting subtest: kms
[125.260678] Subtest kms: SUCCESS (16.627s)
[126.441470] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[126.444705] [016/156] (893s left) i915_pm_rpm (debugfs-read)
[128.478564] Starting subtest: debugfs-read
[129.636925] Subtest debugfs-read: SUCCESS (1.158s)
[130.026234] [017/156] (889s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render)
[130.126230] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render
[130.130564] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[130.222250] [018/156] (889s left) perf_pmu (idle-no-semaphores)
[130.260880] Starting subtest: idle-no-semaphores
[130.263507] Starting dynamic subtest: rcs0
[130.802570] Dynamic subtest rcs0: SUCCESS (0.540s)
[130.814383] Starting dynamic subtest: bcs0
[131.321293] Dynamic subtest bcs0: SUCCESS (0.517s)
[131.333576] Starting dynamic subtest: vcs0
[131.849775] Dynamic subtest vcs0: SUCCESS (0.527s)
[131.861904] Starting dynamic subtest: vcs1
[132.368385] Dynamic subtest vcs1: SUCCESS (0.517s)
[132.379263] Starting dynamic subtest: vecs0
[132.888625] Dynamic subtest vecs0: SUCCESS (0.518s)
[132.903169] Starting dynamic subtest: ccs0
[133.420476] Dynamic subtest ccs0: SUCCESS (0.530s)
[133.423598] Subtest idle-no-semaphores: SUCCESS (3.159s)
[133.535562] [019/156] (886s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[133.632258] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[133.636253] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[133.729453] [020/156] (885s left) tools_test (sysfs_l3_parity)
[133.780776] Starting subtest: sysfs_l3_parity
[133.836373] Subtest sysfs_l3_parity: SKIP (0.066s)
[133.902397] [021/156] (885s left) sysfs_timeslice_duration (invalid)
[133.964521] Starting subtest: invalid
[133.967135] Starting dynamic subtest: vecs0
[133.969802] Dynamic subtest vecs0: SUCCESS (0.000s)
[133.980107] Starting dynamic subtest: ccs0
[133.981996] Dynamic subtest ccs0: SUCCESS (0.000s)
[133.990389] Starting dynamic subtest: vcs0
[133.992297] Dynamic subtest vcs0: SUCCESS (0.000s)
[134.000569] Starting dynamic subtest: bcs0
[134.002468] Dynamic subtest bcs0: SUCCESS (0.001s)
[134.010495] Starting dynamic subtest: rcs0
[134.012395] Dynamic subtest rcs0: SUCCESS (0.000s)
[134.020961] Starting dynamic subtest: vcs1
[134.023301] Dynamic subtest vcs1: SUCCESS (0.000s)
[134.025515] Subtest invalid: SUCCESS (0.004s)
[134.095092] [022/156] (885s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[134.201103] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[134.205212] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[134.286533] [023/156] (885s left) syncobj_timeline (wait-any-interrupted)
[134.341781] Starting subtest: wait-any-interrupted
[134.452056] Subtest wait-any-interrupted: SUCCESS (0.109s)
[134.529276] [024/156] (885s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[134.663911] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[134.668679] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[134.807834] [025/156] (885s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[134.912185] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[135.602765] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[135.775778] [026/156] (884s left) kms_content_protection (atomic-dpms-hdcp14)
[135.918849] Starting subtest: atomic-dpms-hdcp14
[135.923317] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[136.046464] [027/156] (883s left) kms_addfb_basic (basic-y-tiled-legacy)
[136.099198] Starting subtest: basic-y-tiled-legacy
[136.103751] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[136.248583] [028/156] (883s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[136.363189] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[136.367349] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[136.473151] [029/156] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[136.570205] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[143.223872] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.657s)
[143.347723] [030/156] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[143.442716] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[150.009581] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.572s)
[150.124452] [031/156] (869s left) kms_atomic_interruptible (legacy-dpms)
[150.218763] Starting subtest: legacy-dpms
[150.221079] Starting dynamic subtest: pipe-A-eDP-1
[157.700841] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.482s)
[157.703130] Subtest legacy-dpms: SUCCESS (7.483s)
[158.521764] [032/156] (861s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[158.639758] Starting subtest: cursor-tearing-framebuffer-change
[158.642153] Starting dynamic subtest: pipe-A-eDP-1
[159.222809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.582s)
[159.232284] Starting dynamic subtest: pipe-D-eDP-1
[160.468574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[160.470803] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.826s)
[161.296853] [033/156] (858s left) syncobj_timeline (device-submit-unordered)
[161.345680] Starting subtest: device-submit-unordered
[161.347894] Subtest device-submit-unordered: SUCCESS (0.000s)
[161.449475] [034/156] (858s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[161.548280] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[161.573823] Starting dynamic subtest: pipe-A-plane-0
[161.840295] Dynamic subtest pipe-A-plane-0: SUCCESS (0.267s)
[161.852490] Starting dynamic subtest: pipe-A-plane-3
[162.062541] Dynamic subtest pipe-A-plane-3: SUCCESS (0.222s)
[163.179721] Starting dynamic subtest: pipe-B-plane-0
[163.460610] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[163.471594] Starting dynamic subtest: pipe-B-plane-3
[163.672122] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[163.988298] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.441s)
[164.851705] [035/156] (855s left) gem_mmap_offset (bad-extensions)
[164.908037] Starting subtest: bad-extensions
[164.910282] Subtest bad-extensions: SUCCESS (0.000s)
[165.001330] [036/156] (855s left) gem_ctx_engines (invalid-engines)
[165.068900] Starting subtest: invalid-engines
[165.073662] Subtest invalid-engines: SUCCESS (0.008s)
[165.304572] [037/156] (855s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[165.364831] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[165.369414] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[165.548071] [038/156] (854s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[165.657051] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[170.102048] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.450s)
[171.283445] [039/156] (849s left) gem_pxp (create-regular-buffer)
[171.397887] Starting subtest: create-regular-buffer
[171.400499] Subtest create-regular-buffer: SUCCESS (0.000s)
[171.516730] [040/156] (848s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[171.575894] Starting subtest: etime-single-wait-available-unsubmitted
[171.682958] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[171.757960] [041/156] (848s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[171.864922] Starting subtest: primary-x-tiled-reflect-x-0
[178.959067] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.096s)
[180.249180] [042/156] (840s left) i915_drm_fdinfo (busy-check-all)
[180.288051] Starting subtest: busy-check-all
[180.290485] Starting dynamic subtest: rcs0
[180.295220] Dynamic subtest rcs0: SKIP (0.004s)
[180.306298] Starting dynamic subtest: bcs0
[180.310782] Dynamic subtest bcs0: SKIP (0.000s)
[180.320409] Starting dynamic subtest: vcs0
[180.324485] Dynamic subtest vcs0: SKIP (0.000s)
[180.333163] Starting dynamic subtest: vcs1
[180.337244] Dynamic subtest vcs1: SKIP (0.000s)
[180.345802] Starting dynamic subtest: vecs0
[180.350031] Dynamic subtest vecs0: SKIP (0.000s)
[180.358786] Starting dynamic subtest: ccs0
[180.362983] Dynamic subtest ccs0: SKIP (0.000s)
[180.367133] Subtest busy-check-all: SKIP (0.008s)
[180.407701] [043/156] (840s left) kms_chamelium_hpd (common-hpd-after-suspend)
[180.835308] Subtest common-hpd-after-suspend: SKIP (0.000s)
[181.639620] [044/156] (838s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[181.745850] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[188.405875] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.663s)
[188.521950] [045/156] (832s left) kms_cursor_crc (cursor-offscreen-64x21)
[188.711627] Starting subtest: cursor-offscreen-64x21
[188.761165] Subtest cursor-offscreen-64x21: SKIP (0.045s)
[189.020622] [046/156] (831s left) kms_plane (pixel-format-4-tiled-modifier)
[189.103924] Starting subtest: pixel-format-4-tiled-modifier
[189.131769] Starting dynamic subtest: pipe-A-plane-0
[189.541381] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[189.550503] Starting dynamic subtest: pipe-A-plane-3
[189.874543] Dynamic subtest pipe-A-plane-3: SUCCESS (0.332s)
[189.884328] Starting dynamic subtest: pipe-A-plane-5
[189.887893] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[190.976033] Starting dynamic subtest: pipe-B-plane-0
[191.376897] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[191.387111] Starting dynamic subtest: pipe-B-plane-3
[191.710603] Dynamic subtest pipe-B-plane-3: SUCCESS (0.331s)
[191.720657] Starting dynamic subtest: pipe-B-plane-5
[191.725200] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[192.040230] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.936s)
[192.867942] [047/156] (827s left) gem_gpgpu_fill (offset-16x16)
[192.931244] Starting subtest: offset-16x16
[192.938246] Subtest offset-16x16: SUCCESS (0.008s)
[193.076582] [048/156] (827s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[193.171070] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[193.173328] Starting dynamic subtest: pipe-A-eDP-1
[193.196685] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.206367] Starting dynamic subtest: pipe-B-eDP-1
[193.227636] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.236679] Starting dynamic subtest: pipe-C-eDP-1
[193.257655] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.266136] Starting dynamic subtest: pipe-D-eDP-1
[193.289345] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.293683] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[195.425667] [049/156] (825s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[195.477287] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[195.549155] [050/156] (825s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[195.642726] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[195.646754] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[195.741332] [051/156] (825s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[195.796173] Subtest writes-after-reads-uncached: SKIP (0.000s)
[195.877727] [052/156] (825s left) gem_ctx_param (invalid-set-ringsize)
[195.921969] Starting subtest: invalid-set-ringsize
[195.924268] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[195.990360] [053/156] (824s left) gem_exec_whisper (basic-fds-forked-all)
[196.057875] Starting subtest: basic-fds-forked-all
[218.424723] Subtest basic-fds-forked-all: SUCCESS (22.365s)
[218.611456] [054/156] (802s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[218.714715] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[218.719600] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[218.793375] [055/156] (802s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[218.892966] Starting subtest: psr-rgb101010-draw-pwrite
[226.727130] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.840s)
[226.818325] [056/156] (794s left) gem_mmap_gtt (cpuset-basic-small-copy)
[226.874868] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[226.947336] [057/156] (794s left) gem_exec_balancer (parallel-keep-submit-fence)
[227.210745] Starting subtest: parallel-keep-submit-fence
[228.494370] Subtest parallel-keep-submit-fence: SUCCESS (1.287s)
[228.604606] [058/156] (792s left) gem_eio (in-flight-10ms)
[228.834038] Starting subtest: in-flight-10ms
[237.292523] Subtest in-flight-10ms: SUCCESS (8.459s)
[237.477643] [059/156] (783s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[237.573474] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[237.577704] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[237.687373] [060/156] (783s left) core_setmaster (master-drop-set-shared-fd)
[237.772067] Starting subtest: master-drop-set-shared-fd
[237.790294] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[237.830174] [061/156] (783s left) gem_userptr_blits (set-cache-level)
[237.887639] Starting subtest: set-cache-level
[237.891848] Subtest set-cache-level: SKIP (0.000s)
[238.008968] [062/156] (783s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[238.056026] Starting subtest: wait-all-for-submit-delayed-submit
[238.159315] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[238.239165] [063/156] (783s left) fbdev (pan)
[238.278649] Starting subtest: pan
[238.306930] Subtest pan: SUCCESS (0.030s)
[238.381411] [064/156] (783s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[238.471310] Starting subtest: fbcpsr-rgb565-draw-blt
[245.655476] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.187s)
[245.812607] [065/156] (775s left) kms_pm_rpm (cursor)
[247.444809] Starting subtest: cursor
[247.450269] Subtest cursor: SKIP (0.000s)
[248.087798] [066/156] (773s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[248.187084] Starting subtest: hdr-rgb101010-draw-pwrite
[248.191429] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[248.298082] [067/156] (773s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[248.397850] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[248.402216] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[248.502163] [068/156] (773s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[248.602188] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[248.606237] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[248.711039] [069/156] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[248.805417] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[248.809642] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[248.914100] [070/156] (772s left) gem_ctx_create (basic-files)
[248.970999] Starting subtest: basic-files
[250.981200] Subtest basic-files: SUCCESS (2.010s)
[252.346679] [071/156] (769s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[252.448069] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[252.452390] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.550275] [072/156] (769s left) syncobj_basic (illegal-fd-to-handle)
[252.602691] Starting subtest: illegal-fd-to-handle
[252.604990] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[252.713669] [073/156] (769s left) gem_exec_balancer (hang)
[252.975539] Starting subtest: hang
[254.691764] Subtest hang: SUCCESS (1.721s)
[254.819199] [074/156] (767s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[254.920575] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[254.924784] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[255.021205] [075/156] (766s left) syncobj_wait (single-wait-for-submit-signaled)
[255.078797] Starting subtest: single-wait-for-submit-signaled
[255.081077] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[255.177693] [076/156] (766s left) kms_prime (basic-modeset-hybrid)
[255.256689] Subtest basic-modeset-hybrid: SKIP (0.000s)
[255.360014] [077/156] (766s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[255.450959] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[255.455438] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[255.522848] [078/156] (766s left) kms_atomic (plane-primary-legacy)
[255.617440] Starting subtest: plane-primary-legacy
[255.619819] Starting dynamic subtest: pipe-A-eDP-1
[256.052196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[256.054450] Subtest plane-primary-legacy: SUCCESS (0.436s)
[256.902453] [079/156] (765s left) kms_vblank (query-forked)
[256.991150] Starting subtest: query-forked
[256.993314] Starting dynamic subtest: pipe-A-eDP-1
[258.837309] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.846s)
[258.853446] Starting dynamic subtest: pipe-D-eDP-1
[261.323453] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.485s)
[261.325798] Subtest query-forked: SUCCESS (4.334s)
[262.167172] [080/156] (759s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen)
[262.269386] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen
[262.273613] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[262.363563] [081/156] (759s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[262.468510] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[262.470873] Starting dynamic subtest: pipe-A-eDP-1
[273.156545] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.693s)
[273.167740] Starting dynamic subtest: pipe-B-eDP-1
[284.582948] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.424s)
[284.585783] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.120s)
[285.452247] [082/156] (736s left) sriov_basic (enable-vfs-autoprobe-off)
[285.511493] Starting subtest: enable-vfs-autoprobe-off
[285.514310] Starting dynamic subtest: numvfs-1
[285.589771] Dynamic subtest numvfs-1: FAIL (0.017s)
[285.599981] Starting dynamic subtest: numvfs-2
[285.672676] Dynamic subtest numvfs-2: FAIL (0.004s)
[285.685102] Starting dynamic subtest: numvfs-3
[285.756903] Dynamic subtest numvfs-3: FAIL (0.004s)
[285.767524] Starting dynamic subtest: numvfs-4
[285.840231] Dynamic subtest numvfs-4: FAIL (0.004s)
[285.850791] Starting dynamic subtest: numvfs-5
[285.923474] Dynamic subtest numvfs-5: FAIL (0.004s)
[285.935421] Starting dynamic subtest: numvfs-6
[286.008552] Dynamic subtest numvfs-6: FAIL (0.004s)
[286.019123] Starting dynamic subtest: numvfs-7
[286.092597] Dynamic subtest numvfs-7: FAIL (0.004s)
[286.102223] Starting dynamic subtest: numvfs-random
[286.175482] Dynamic subtest numvfs-random: FAIL (0.004s)
[286.189621] Starting dynamic subtest: numvfs-all
[286.262183] Dynamic subtest numvfs-all: FAIL (0.516s)
[286.264077] Subtest enable-vfs-autoprobe-off: FAIL (0.568s)
[286.304854] [083/156] (735s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[286.393472] Starting subtest: sprite-rotation-90-pos-100-0
[286.397306] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[286.458254] [084/156] (735s left) kms_psr (fbc-psr-primary-mmap-cpu)
[286.546478] Starting subtest: fbc-psr-primary-mmap-cpu
[286.548392] Starting dynamic subtest: eDP-1
[286.551778] Dynamic subtest eDP-1: SKIP (0.000s)
[286.555198] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[286.619944] [085/156] (735s left) kms_psr (psr-primary-render)
[286.714649] Starting subtest: psr-primary-render
[286.716494] Starting dynamic subtest: eDP-1
[288.452270] Dynamic subtest eDP-1: SUCCESS (1.737s)
[288.454472] Subtest psr-primary-render: SUCCESS (1.738s)
[289.314800] [086/156] (733s left) gem_ctx_param (basic-default)
[289.370035] Starting subtest: basic-default
[289.372424] Subtest basic-default: SUCCESS (0.000s)
[289.444739] [087/156] (732s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[289.549337] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[289.551684] Starting dynamic subtest: pipe-A-eDP-1
[289.572114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[289.583145] Starting dynamic subtest: pipe-B-eDP-1
[289.602516] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[289.611802] Starting dynamic subtest: pipe-C-eDP-1
[289.631176] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[289.640439] Starting dynamic subtest: pipe-D-eDP-1
[289.660060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[289.661924] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[291.886626] [088/156] (730s left) kms_big_fb (linear-8bpp-rotate-90)
[291.992456] Starting subtest: linear-8bpp-rotate-90
[292.013718] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[292.141755] [089/156] (730s left) api_intel_allocator (alloc-simple)
[292.199747] Starting subtest: alloc-simple
[292.202080] Subtest alloc-simple: SUCCESS (0.003s)
[292.317754] [090/156] (730s left) kms_hdr (bpc-switch-suspend)
[292.411841] Starting subtest: bpc-switch-suspend
[292.414229] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[312.905733] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.755s)
[312.918848] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[333.890355] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.750s)
[333.892746] Subtest bpc-switch-suspend: SUCCESS (11.508s)
[334.008021] [091/156] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[334.108748] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[339.526940] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.421s)
[340.665854] [092/156] (681s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[340.719312] Starting subtest: y-tiled-ccs-to-x-tiled
[340.723843] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[340.917581] [093/156] (681s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[341.003724] Starting subtest: plane-downscale-factor-0-75-with-rotation
[341.005973] Starting dynamic subtest: pipe-A
[341.243361] Dynamic subtest pipe-A: SUCCESS (0.242s)
[341.254131] Starting dynamic subtest: pipe-B
[342.567547] Dynamic subtest pipe-B: SUCCESS (1.323s)
[342.579431] Starting dynamic subtest: pipe-C
[343.871749] Dynamic subtest pipe-C: SUCCESS (1.303s)
[343.883078] Starting dynamic subtest: pipe-D
[345.201117] Dynamic subtest pipe-D: SUCCESS (1.328s)
[345.203382] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.199s)
[346.397794] [094/156] (676s left) gem_exec_schedule (manyslice)
[346.477319] Starting subtest: manyslice
[346.479511] Starting dynamic subtest: rcs0
[351.614330] Dynamic subtest rcs0: SUCCESS (5.142s)
[351.634669] Starting dynamic subtest: bcs0
[358.250146] Dynamic subtest bcs0: SUCCESS (6.632s)
[358.272759] Starting dynamic subtest: vcs0
[364.343107] Dynamic subtest vcs0: SUCCESS (6.091s)
[364.359216] Starting dynamic subtest: vcs1
[370.425001] Dynamic subtest vcs1: SUCCESS (6.081s)
[370.436868] Starting dynamic subtest: vecs0
[376.006760] Dynamic subtest vecs0: SUCCESS (5.582s)
[376.019400] Starting dynamic subtest: ccs0
[382.204741] Dynamic subtest ccs0: SUCCESS (6.196s)
[382.207163] Subtest manyslice: SUCCESS (35.736s)
[382.518099] [095/156] (640s left) kms_cursor_crc (cursor-random-32x32)
[382.671498] Starting subtest: cursor-random-32x32
[382.720194] Subtest cursor-random-32x32: SKIP (0.045s)
[383.012927] [096/156] (639s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-plflip-blt)
[383.107200] Starting subtest: hdr-1p-primscrn-indfb-plflip-blt
[383.111280] Subtest hdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[383.214547] [097/156] (639s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[383.297631] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[383.299879] Starting dynamic subtest: pipe-A-eDP-1
[383.324566] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[383.337808] Starting dynamic subtest: pipe-B-eDP-1
[383.360827] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[383.372363] Starting dynamic subtest: pipe-C-eDP-1
[383.396167] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[383.407148] Starting dynamic subtest: pipe-D-eDP-1
[383.431395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[383.435500] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[385.560240] [098/156] (637s left) syncobj_timeline (invalid-transfer-illegal-handle)
[385.613341] Starting subtest: invalid-transfer-illegal-handle
[385.615443] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[385.718340] [099/156] (637s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[385.822943] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[385.827435] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[385.941986] [100/156] (637s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[385.993102] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[386.099811] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[386.191911] [101/156] (636s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[386.283130] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[386.287158] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[386.379138] [102/156] (636s left) gem_eio (in-flight-1us)
[386.613866] Starting subtest: in-flight-1us
[395.139628] Subtest in-flight-1us: SUCCESS (8.524s)
[395.316149] [103/156] (627s left) gem_exec_schedule (fifo)
[395.388289] Starting subtest: fifo
[395.390119] Starting dynamic subtest: rcs0
[395.485514] Dynamic subtest rcs0: SUCCESS (0.104s)
[395.500382] Starting dynamic subtest: vcs0
[395.565359] Dynamic subtest vcs0: SUCCESS (0.079s)
[395.579472] Starting dynamic subtest: vcs1
[395.649792] Dynamic subtest vcs1: SUCCESS (0.084s)
[395.662092] Starting dynamic subtest: vecs0
[395.734722] Dynamic subtest vecs0: SUCCESS (0.082s)
[395.747898] Starting dynamic subtest: ccs0
[395.829206] Dynamic subtest ccs0: SUCCESS (0.093s)
[395.831777] Subtest fifo: SUCCESS (0.449s)
[397.380842] [104/156] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[397.483318] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[397.487283] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[397.580605] [105/156] (625s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[397.688631] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[401.657354] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.974s)
[402.864376] [106/156] (620s left) kms_psr (fbc-pr-sprite-render)
[402.972010] Starting subtest: fbc-pr-sprite-render
[402.976457] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[403.046203] [107/156] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[403.153536] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[403.157766] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[403.235436] [108/156] (620s left) kms_addfb_basic (invalid-get-prop)
[403.300272] Starting subtest: invalid-get-prop
[403.302331] Subtest invalid-get-prop: SUCCESS (0.000s)
[403.441853] [109/156] (619s left) kms_plane_alpha_blend (constant-alpha-max)
[403.534899] Starting subtest: constant-alpha-max
[403.831780] Starting dynamic subtest: pipe-A-eDP-1
[404.995270] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.154s)
[405.006210] Starting dynamic subtest: pipe-D-eDP-1
[406.749082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.758s)
[406.751382] Subtest constant-alpha-max: SUCCESS (3.214s)
[407.634562] [110/156] (615s left) gem_exec_reloc (basic-cpu-read-active)
[407.715623] Subtest basic-cpu-read-active: SKIP (0.000s)
[407.789489] [111/156] (615s left) kms_invalid_mode (clock-too-high)
[407.881991] Starting subtest: clock-too-high
[407.884203] Starting dynamic subtest: pipe-A-eDP-1
[408.167635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[408.180400] Starting dynamic subtest: pipe-B-eDP-1
[408.184396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[408.194842] Starting dynamic subtest: pipe-C-eDP-1
[408.199006] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[408.211453] Starting dynamic subtest: pipe-D-eDP-1
[408.215987] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[408.218244] Subtest clock-too-high: SUCCESS (0.295s)
[409.054984] [112/156] (614s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[409.161482] Starting subtest: psr2-plane-move-sf-dmg-area
[409.163938] Starting dynamic subtest: pipe-A-eDP-1
[413.693472] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.538s)
[413.708631] Starting dynamic subtest: pipe-B-eDP-1
[418.997502] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.298s)
[418.999784] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.841s)
[419.871299] [113/156] (603s left) kms_prop_blob (invalid-set-prop)
[419.923816] Starting subtest: invalid-set-prop
[419.925770] Subtest invalid-set-prop: SUCCESS (0.000s)
[420.016736] [114/156] (603s left) gem_mmap_gtt (medium-copy)
[420.074265] Subtest medium-copy: SKIP (0.000s)
[420.138048] [115/156] (603s left) perf (invalid-remove-userspace-config)
[420.223178] Starting subtest: invalid-remove-userspace-config
[420.230275] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[420.273196] [116/156] (603s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[420.371205] Starting subtest: x-tiled-64bpp-rotate-90
[420.390454] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[420.516536] [117/156] (603s left) gem_ppgtt (blt-vs-render-ctx0)
[420.574680] Starting subtest: blt-vs-render-ctx0
[453.620735] Subtest blt-vs-render-ctx0: SUCCESS (33.045s)
[453.745084] [118/156] (569s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[453.883050] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[453.887328] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[453.985601] [119/156] (569s left) kms_rotation_crc (bad-tiling)
[454.087307] Starting subtest: bad-tiling
[454.091409] Subtest bad-tiling: SKIP (0.001s)
[454.165229] [120/156] (569s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[454.268466] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[454.272459] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[454.366167] [121/156] (569s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[454.464718] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[454.468817] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[454.579581] [122/156] (569s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[454.968362] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[455.774028] [123/156] (568s left) kms_psr (pr-primary-blt)
[455.874816] Starting subtest: pr-primary-blt
[455.879255] Subtest pr-primary-blt: SKIP (0.000s)
[455.965294] [124/156] (568s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[456.074669] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[460.494718] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.425s)
[461.695195] [125/156] (562s left) gem_softpin (zero)
[461.750200] Starting subtest: zero
[461.754863] Subtest zero: SUCCESS (0.004s)
[461.869613] [126/156] (562s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[461.964903] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[461.968963] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[462.083576] [127/156] (562s left) gem_exec_schedule (u-semaphore-noskip)
[462.163451] Starting subtest: u-semaphore-noskip
[462.571326] Subtest u-semaphore-noskip: SUCCESS (0.412s)
[462.918240] [128/156] (561s left) gem_softpin (evict-snoop-interruptible)
[462.979626] Starting subtest: evict-snoop-interruptible
[462.984028] Subtest evict-snoop-interruptible: SKIP (0.000s)
[463.099638] [129/156] (561s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[463.193900] Starting subtest: plane-upscale-20x20-with-modifiers
[463.196128] Starting dynamic subtest: pipe-A
[463.529389] Dynamic subtest pipe-A: SUCCESS (0.338s)
[463.542837] Starting dynamic subtest: pipe-B
[464.979901] Dynamic subtest pipe-B: SUCCESS (1.449s)
[464.995155] Starting dynamic subtest: pipe-C
[466.417361] Dynamic subtest pipe-C: SUCCESS (1.436s)
[466.428181] Starting dynamic subtest: pipe-D
[467.858895] Dynamic subtest pipe-D: SUCCESS (1.440s)
[467.861101] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.668s)
[469.022841] [130/156] (555s left) gem_pxp (reject-modify-context-protection-on)
[469.138465] Starting subtest: reject-modify-context-protection-on
[469.140847] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[469.248400] [131/156] (555s left) kms_cdclk (mode-transition-all-outputs)
[469.344883] Starting subtest: mode-transition-all-outputs
[469.637782] Subtest mode-transition-all-outputs: SKIP (0.286s)
[470.462519] [132/156] (553s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[470.570971] Starting subtest: fbcpsrhdr-slowdraw
[470.574910] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[470.669352] [133/156] (553s left) gem_exec_reloc (basic-write-cpu-active)
[470.733532] Subtest basic-write-cpu-active: SKIP (0.000s)
[470.823743] [134/156] (553s left) kms_draw_crc (draw-method-blt)
[470.927951] Starting subtest: draw-method-blt
[470.929842] Starting dynamic subtest: xrgb8888-untiled
[471.181249] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[471.196825] Starting dynamic subtest: rgb565-untiled
[471.381291] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[471.392557] Starting dynamic subtest: xrgb2101010-untiled
[471.603062] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[471.613818] Starting dynamic subtest: xbgr16161616f-untiled
[471.825751] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[471.837190] Starting dynamic subtest: xrgb8888-xtiled
[471.947750] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[471.958985] Starting dynamic subtest: rgb565-xtiled
[472.069965] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[472.084074] Starting dynamic subtest: xrgb2101010-xtiled
[472.181302] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s)
[472.194193] Starting dynamic subtest: xbgr16161616f-xtiled
[472.303309] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[472.314144] Starting dynamic subtest: xrgb8888-4tiled
[472.425659] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[472.436784] Starting dynamic subtest: rgb565-4tiled
[472.536660] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[472.547714] Starting dynamic subtest: xrgb2101010-4tiled
[472.647633] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[472.658677] Starting dynamic subtest: xbgr16161616f-4tiled
[472.769926] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[472.771825] Subtest draw-method-blt: SUCCESS (1.845s)
[472.889430] [135/156] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[472.992940] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[472.996378] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[473.091115] [136/156] (551s left) sw_sync (sync_multi_consumer_producer)
[473.130121] Starting subtest: sync_multi_consumer_producer
[473.428022] Subtest sync_multi_consumer_producer: SUCCESS (0.298s)
[473.493334] [137/156] (551s left) gem_exec_fence (submit-chain)
[473.658635] Starting subtest: submit-chain
[473.676797] Subtest submit-chain: SUCCESS (0.018s)
[475.371552] [138/156] (549s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[475.472554] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[475.484672] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[475.562472] [139/156] (549s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[475.658093] Starting subtest: y-tiled-addfb-size-offset-overflow
[475.662511] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[475.754197] [140/156] (548s left) gen9_exec_parse (secure-batches)
[475.806432] Subtest secure-batches: SKIP (0.000s)
[475.876874] [141/156] (548s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[475.970446] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[475.974805] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[476.045496] [142/156] (548s left) kms_cursor_legacy (single-move)
[476.155425] Starting subtest: single-move
[476.157770] Starting dynamic subtest: pipe-A
[481.537734] Dynamic subtest pipe-A: SUCCESS (5.378s)
[481.553387] Starting dynamic subtest: pipe-B
[486.921274] Dynamic subtest pipe-B: SUCCESS (5.380s)
[486.935115] Starting dynamic subtest: pipe-C
[492.303560] Dynamic subtest pipe-C: SUCCESS (5.379s)
[492.316891] Starting dynamic subtest: pipe-D
[497.686650] Dynamic subtest pipe-D: SUCCESS (5.379s)
[497.700389] Starting dynamic subtest: all-pipes
[503.074131] Dynamic subtest all-pipes: SUCCESS (5.386s)
[503.076361] Subtest single-move: SUCCESS (26.915s)
[503.222679] [143/156] (521s left) gem_ctx_shared (create-shared-gtt)
[503.283398] Starting subtest: create-shared-gtt
[505.436864] Subtest create-shared-gtt: SUCCESS (2.152s)
[505.750231] [144/156] (519s left) kms_lease (lease-revoke)
[505.847832] Starting subtest: lease-revoke
[505.850201] Starting dynamic subtest: pipe-A-eDP-1
[505.884950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.036s)
[505.896864] Starting dynamic subtest: pipe-B-eDP-1
[505.914779] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[505.926233] Starting dynamic subtest: pipe-C-eDP-1
[505.943614] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[505.954916] Starting dynamic subtest: pipe-D-eDP-1
[505.972085] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[505.974378] Subtest lease-revoke: SUCCESS (0.127s)
[506.104146] [145/156] (518s left) i915_module_load (resize-bar)
[506.137138] Starting subtest: resize-bar
[506.144557] Subtest resize-bar: SKIP (0.007s)
[506.187349] [146/156] (518s left) perf (disabled-read-error)
[506.295258] Starting subtest: disabled-read-error
[506.311816] Subtest disabled-read-error: SUCCESS (0.016s)
[506.361109] [147/156] (518s left) kms_vrr (flip-dpms)
[506.464270] Starting subtest: flip-dpms
[506.470576] Subtest flip-dpms: SKIP (0.000s)
[506.538908] [148/156] (518s left) kms_psr (psr-primary-blt)
[506.627896] Starting subtest: psr-primary-blt
[506.630209] Starting dynamic subtest: eDP-1
[508.345890] Dynamic subtest eDP-1: SUCCESS (1.718s)
[508.348219] Subtest psr-primary-blt: SUCCESS (1.719s)
[509.206315] [149/156] (515s left) gem_userptr_blits (invalid-null-pointer)
[509.270413] Starting subtest: invalid-null-pointer
[509.272375] Subtest invalid-null-pointer: SUCCESS (0.001s)
[509.392268] [150/156] (515s left) gem_exec_params (dr1-dirt)
[509.454967] Starting subtest: DR1-dirt
[509.457340] Subtest DR1-dirt: SUCCESS (0.000s)
[509.581442] [151/156] (515s left) gem_eio (wait-wedge-immediate)
[509.801266] Starting subtest: wait-wedge-immediate
[511.334604] Subtest wait-wedge-immediate: SUCCESS (1.535s)
[511.466554] [152/156] (513s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[511.586473] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[511.590974] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[511.732822] [153/156] (513s left) gem_userptr_blits (dmabuf-unsync)
[511.795817] Subtest dmabuf-unsync: SKIP (0.000s)
[511.942768] [154/156] (513s left) kms_color_pipeline (plane-ctm3x4)
[512.046843] Starting subtest: plane-ctm3x4
[512.215983] Starting dynamic subtest: pipe-A-plane-0
[512.359707] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[512.371564] Starting dynamic subtest: pipe-A-plane-1
[512.515460] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[512.526929] Starting dynamic subtest: pipe-A-plane-2
[512.671267] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[513.945374] Starting dynamic subtest: pipe-B-plane-0
[514.079430] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[514.090948] Starting dynamic subtest: pipe-B-plane-1
[514.212608] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[514.224678] Starting dynamic subtest: pipe-B-plane-2
[514.346253] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[515.521429] Starting dynamic subtest: pipe-C-plane-0
[515.633309] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[515.645497] Starting dynamic subtest: pipe-C-plane-1
[515.744309] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[515.756510] Starting dynamic subtest: pipe-C-plane-2
[515.877722] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[517.083039] Starting dynamic subtest: pipe-D-plane-0
[517.195399] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s)
[517.206713] Starting dynamic subtest: pipe-D-plane-1
[517.307082] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s)
[517.319203] Starting dynamic subtest: pipe-D-plane-2
[517.418192] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[517.704921] Subtest plane-ctm3x4: SUCCESS (5.658s)
[518.531425] [155/156] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[518.629000] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[525.426753] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.802s)
[525.587832] [156/156] (499s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[525.697433] Starting subtest: fbchdr-tiling-linear
[525.701547] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[525.782138] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: core_debugfs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_query
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: i915_pm_rpm
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: tools_test
results: parsing output: 20/ for test: sysfs_timeslice_duration
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_atomic_interruptible
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: gem_ctx_engines
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: i915_drm_fdinfo
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_cursor_crc
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: gem_gpgpu_fill
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: core_setmaster
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: fbdev
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_ctx_create
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: syncobj_basic
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_prime
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: sriov_basic
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: api_intel_allocator
results: parsing output: 89/ for test: kms_hdr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_plane_alpha_blend
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_prop_blob
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_ppgtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_chamelium_edid
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_pxp
results: parsing output: 130/ for test: kms_cdclk
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_reloc
results: parsing output: 133/ for test: kms_draw_crc
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: sw_sync
results: parsing output: 136/ for test: gem_exec_fence
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: gen9_exec_parse
results: parsing output: 140/ for test: kms_flip_scaled_crc
results: parsing output: 141/ for test: kms_cursor_legacy
results: parsing output: 142/ for test: gem_ctx_shared
results: parsing output: 143/ for test: kms_lease
results: parsing output: 144/ for test: i915_module_load
results: parsing output: 145/ for test: perf
results: parsing output: 146/ for test: kms_vrr
results: parsing output: 147/ for test: kms_psr
results: parsing output: 148/ for test: gem_userptr_blits
results: parsing output: 149/ for test: gem_exec_params
results: parsing output: 150/ for test: gem_eio
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: gem_userptr_blits
results: parsing output: 153/ for test: kms_color_pipeline
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.