[59.537526] Initializing watchdogs
[59.537573]   /dev/watchdog0
[59.551561] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.556127] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.558214] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.560111] [001/134] (960s left) kms_flip (2x-flip-vs-wf_vblank)
[59.676794] Starting subtest: 2x-flip-vs-wf_vblank
[59.687513] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[59.770149] [002/134] (960s left) gem_ctx_persistence (file)
[59.828501] Starting subtest: file
[59.970231] Subtest file: SUCCESS (0.141s)
[60.110758] [003/134] (960s left) gem_readwrite (write-bad-handle)
[60.169349] Subtest write-bad-handle: SKIP (0.000s)
[60.233126] [004/134] (959s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[60.316341] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[60.355153] Starting dynamic subtest: pipe-A-plane-0
[60.356982] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[60.362372] Starting dynamic subtest: pipe-A-plane-3
[60.364055] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[60.370482] Starting dynamic subtest: pipe-A-plane-5
[60.372289] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[61.432389] Starting dynamic subtest: pipe-B-plane-0
[61.434042] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[61.439593] Starting dynamic subtest: pipe-B-plane-3
[61.441443] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[61.446910] Starting dynamic subtest: pipe-B-plane-5
[61.448875] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[61.738945] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.422s)
[62.599193] [005/134] (957s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[62.723503] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[63.698539] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.975s)
[64.523044] [006/134] (955s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[64.615269] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[71.921174] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.304s)
[72.080196] [007/134] (948s left) gem_userptr_blits (userfault)
[72.147436] Starting subtest: userfault
[72.154174] Subtest userfault: SUCCESS (0.009s)
[72.298486] [008/134] (947s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[77.309158] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[77.310303] Starting dynamic subtest: pipe-A-eDP-1
[78.117402] Dynamic subtest pipe-A-eDP-1: SKIP (0.807s)
[78.124187] Starting dynamic subtest: pipe-B-eDP-1
[79.249507] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[79.251307] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.941s)
[80.438340] [009/134] (939s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[80.494153] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[80.569839] [010/134] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[80.667434] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[80.669047] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[80.791217] [011/134] (939s left) kms_psr (fbc-psr2-no-drrs)
[80.872020] Starting subtest: fbc-psr2-no-drrs
[80.872966] Starting dynamic subtest: eDP-1
[80.874725] Dynamic subtest eDP-1: SKIP (0.000s)
[80.876424] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[80.945692] [012/134] (939s left) gem_exec_schedule (u-submit-golden-slice)
[81.015354] Starting subtest: u-submit-golden-slice
[81.016277] Starting dynamic subtest: rcs0
[81.049676] Dynamic subtest rcs0: SUCCESS (0.034s)
[81.055411] Starting dynamic subtest: bcs0
[81.079407] Dynamic subtest bcs0: SUCCESS (0.029s)
[81.085364] Starting dynamic subtest: vcs0
[81.111329] Dynamic subtest vcs0: SUCCESS (0.032s)
[81.117541] Starting dynamic subtest: vcs1
[81.141177] Dynamic subtest vcs1: SUCCESS (0.029s)
[81.147126] Starting dynamic subtest: vecs0
[81.170222] Dynamic subtest vecs0: SUCCESS (0.029s)
[81.176071] Starting dynamic subtest: ccs0
[81.199052] Dynamic subtest ccs0: SUCCESS (0.028s)
[81.200016] Subtest u-submit-golden-slice: SUCCESS (0.184s)
[83.020275] [013/134] (937s left) gem_mmap_gtt (hang-busy)
[83.081081] Subtest hang-busy: SKIP (0.000s)
[83.147128] [014/134] (937s left) sysfs_timeslice_duration (idempotent)
[83.199196] Starting subtest: idempotent
[83.200180] Starting dynamic subtest: vecs0
[83.201092] Dynamic subtest vecs0: SUCCESS (0.000s)
[83.207625] Starting dynamic subtest: ccs0
[83.208497] Dynamic subtest ccs0: SUCCESS (0.000s)
[83.213932] Starting dynamic subtest: vcs0
[83.214843] Dynamic subtest vcs0: SUCCESS (0.000s)
[83.220423] Starting dynamic subtest: bcs0
[83.221276] Dynamic subtest bcs0: SUCCESS (0.000s)
[83.226687] Starting dynamic subtest: rcs0
[83.227586] Dynamic subtest rcs0: SUCCESS (0.000s)
[83.232975] Starting dynamic subtest: vcs1
[83.233887] Dynamic subtest vcs1: SUCCESS (0.000s)
[83.234792] Subtest idempotent: SUCCESS (0.004s)
[83.319207] [015/134] (937s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[83.421835] Starting subtest: fbc-1p-pri-indfb-multidraw
[96.750374] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.329s)
[98.131927] [016/134] (922s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[98.233204] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[98.235161] Starting dynamic subtest: A-eDP1
[101.828683] Dynamic subtest A-eDP1: SUCCESS (3.592s)
[101.835512] Starting dynamic subtest: B-eDP1
[105.023805] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[105.030432] Starting dynamic subtest: C-eDP1
[108.121959] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[108.128065] Starting dynamic subtest: D-eDP1
[111.244554] Dynamic subtest D-eDP1: SUCCESS (3.122s)
[111.246555] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.013s)
[112.063750] [017/134] (908s left) gem_exec_capture (userptr)
[112.126669] Starting subtest: userptr
[112.988072] Subtest userptr: SUCCESS (0.861s)
[113.133190] [018/134] (907s left) kms_hdr (invalid-metadata-sizes)
[113.224257] Starting subtest: invalid-metadata-sizes
[113.226760] Subtest invalid-metadata-sizes: SKIP (0.000s)
[113.311343] [019/134] (907s left) gem_mmap_offset (perf)
[113.366927] Starting subtest: perf
[113.367891] Starting dynamic subtest: smem0
[113.720366] Dynamic subtest smem0: SUCCESS (0.351s)
[113.721490] Subtest perf: SUCCESS (0.352s)
[113.849439] [020/134] (906s left) gem_exec_await (wide-contexts)
[114.060392] Starting subtest: wide-contexts
[137.775516] Subtest wide-contexts: SUCCESS (23.715s)
[137.967635] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[137.970552] [021/134] (882s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[138.096871] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[138.097697] Starting dynamic subtest: pipe-A-eDP-1
[138.105526] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.112047] Starting dynamic subtest: pipe-B-eDP-1
[138.120075] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.126700] Starting dynamic subtest: pipe-C-eDP-1
[138.134430] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.140522] Starting dynamic subtest: pipe-D-eDP-1
[138.148704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.150250] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[140.310748] [022/134] (880s left) kms_addfb_basic (basic-x-tiled-legacy)
[140.366095] Starting subtest: basic-x-tiled-legacy
[140.367962] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[140.532585] [023/134] (880s left) kms_feature_discovery (chamelium)
[140.617112] Starting subtest: chamelium
[140.618946] Subtest chamelium: SKIP (0.000s)
[140.702760] [024/134] (880s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[140.798392] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[140.799286] Starting dynamic subtest: pipe-A-default-mode
[141.963090] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[141.964912] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.164s)
[142.132768] [025/134] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[142.239763] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[142.241473] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[142.364490] [026/134] (878s left) drm_read (empty-nonblock)
[142.510371] Starting subtest: empty-nonblock
[142.511325] Subtest empty-nonblock: SUCCESS (0.000s)
[142.689527] [027/134] (878s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[142.788081] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[143.569430] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[143.757059] [028/134] (877s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[143.858396] Starting subtest: y-tiled-32bpp-rotate-270
[143.860218] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[143.968437] [029/134] (876s left) kms_plane_scaling (intel-max-src-size)
[144.067896] Starting subtest: intel-max-src-size
[144.070978] Subtest intel-max-src-size: SKIP (0.000s)
[144.193083] [030/134] (876s left) gem_mmap_wc (read-write)
[144.247640] Subtest read-write: SKIP (0.000s)
[144.308066] [031/134] (876s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[144.409591] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[145.399660] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.990s)
[145.542996] [032/134] (875s left) kms_psr2_su (frontbuffer-xrgb8888)
[145.604545] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[145.666485] [033/134] (875s left) gen9_exec_parse (shadow-peek)
[145.728849] Subtest shadow-peek: SKIP (0.000s)
[145.802763] [034/134] (875s left) gem_exec_schedule (smoketest)
[145.979760] Starting subtest: smoketest
[145.980796] Starting dynamic subtest: rcs0
[151.516289] Dynamic subtest rcs0: SUCCESS (5.514s)
[151.527804] Starting dynamic subtest: bcs0
[157.019367] Dynamic subtest bcs0: SUCCESS (5.503s)
[157.026990] Starting dynamic subtest: vcs0
[162.515581] Dynamic subtest vcs0: SUCCESS (5.497s)
[162.527117] Starting dynamic subtest: vcs1
[168.018508] Dynamic subtest vcs1: SUCCESS (5.495s)
[168.026621] Starting dynamic subtest: vecs0
[173.519749] Dynamic subtest vecs0: SUCCESS (5.502s)
[173.529968] Starting dynamic subtest: ccs0
[179.024931] Dynamic subtest ccs0: SUCCESS (5.504s)
[179.025777] Subtest smoketest: SUCCESS (33.021s)
[179.194464] [035/134] (841s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[179.297862] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[179.298858] Starting dynamic subtest: pipe-A-eDP-1
[179.322573] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[179.331551] Starting dynamic subtest: pipe-B-eDP-1
[179.353068] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[179.359788] Starting dynamic subtest: pipe-C-eDP-1
[179.381482] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[179.388214] Starting dynamic subtest: pipe-D-eDP-1
[179.411707] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[179.413486] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[181.498872] [036/134] (839s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[181.597787] Starting subtest: 2x-flip-vs-modeset-vs-hang
[181.608534] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[181.730319] [037/134] (839s left) kms_psr (psr2-cursor-mmap-cpu)
[181.821093] Starting subtest: psr2-cursor-mmap-cpu
[181.821932] Starting dynamic subtest: eDP-1
[183.466561] Dynamic subtest eDP-1: SUCCESS (1.646s)
[183.467480] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.646s)
[184.281259] [038/134] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[184.373327] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[184.375068] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[184.481635] [039/134] (836s left) syncobj_wait (reset-during-wait-for-submit)
[184.543273] Starting subtest: reset-during-wait-for-submit
[184.648960] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[184.728858] [040/134] (836s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[185.312380] Starting subtest: syncobj-timeline-multiple-ext-nodes
[185.315945] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[187.007302] [041/134] (834s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[187.094977] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[187.106406] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[187.233845] [042/134] (834s left) i915_pm_rpm (debugfs-read)
[189.056896] Starting subtest: debugfs-read
[190.202753] Subtest debugfs-read: SUCCESS (1.144s)
[190.577754] [043/134] (830s left) gem_pxp (protected-raw-src-copy-not-readible)
[190.710684] Starting subtest: protected-raw-src-copy-not-readible
[190.769032] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[190.920335] [044/134] (830s left) gem_exec_schedule (implicit-read-write)
[190.992815] Starting subtest: implicit-read-write
[190.993814] Starting dynamic subtest: rcs0
[191.091922] Dynamic subtest rcs0: SUCCESS (0.100s)
[191.101071] Starting dynamic subtest: vcs0
[191.168061] Dynamic subtest vcs0: SUCCESS (0.076s)
[191.178247] Starting dynamic subtest: vcs1
[191.244657] Dynamic subtest vcs1: SUCCESS (0.076s)
[191.253321] Starting dynamic subtest: vecs0
[191.318622] Dynamic subtest vecs0: SUCCESS (0.074s)
[191.327591] Starting dynamic subtest: ccs0
[191.397646] Dynamic subtest ccs0: SUCCESS (0.078s)
[191.398940] Subtest implicit-read-write: SUCCESS (0.406s)
[193.053512] [045/134] (828s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[193.151019] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[193.153506] Starting dynamic subtest: A-eDP1
[196.786926] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[196.794366] Starting dynamic subtest: B-eDP1
[199.994395] Dynamic subtest B-eDP1: SUCCESS (3.206s)
[200.001834] Starting dynamic subtest: C-eDP1
[203.100213] Dynamic subtest C-eDP1: SUCCESS (3.106s)
[203.107641] Starting dynamic subtest: D-eDP1
[206.202347] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[206.203287] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.052s)
[206.993816] [046/134] (814s left) gem_exec_create (madvise)
[207.050742] Starting subtest: madvise
[207.051846] Starting dynamic subtest: smem
[227.994769] Dynamic subtest smem: SUCCESS (20.941s)
[227.996235] Subtest madvise: SUCCESS (20.941s)
[228.927788] [047/134] (792s left) gem_exec_reloc (basic-gtt-read-noreloc)
[228.993836] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[229.076703] [048/134] (792s left) syncobj_timeline (etime-single-wait-all-submitted)
[229.136962] Starting subtest: etime-single-wait-all-submitted
[229.246059] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[229.325843] [049/134] (792s left) kms_selftest (drm_dp_mst_helper)
[229.357062] Starting subtest: drm_dp_mst_helper
[229.396532] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[229.528116] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.132s)
[229.536694] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[229.626323] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.099s)
[229.633688] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[229.764142] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.136s)
[229.765027] Subtest drm_dp_mst_helper: SUCCESS (0.406s)
[229.963463] [050/134] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[230.069229] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[238.878315] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.810s)
[239.001662] [051/134] (782s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[239.108203] Starting subtest: flip-vs-dpms-on-nop-interruptible
[239.110542] Starting dynamic subtest: A-eDP1
[240.974507] Dynamic subtest A-eDP1: SUCCESS (1.864s)
[240.984480] Starting dynamic subtest: B-eDP1
[242.788505] Dynamic subtest B-eDP1: SUCCESS (1.812s)
[242.798678] Starting dynamic subtest: C-eDP1
[244.611162] Dynamic subtest C-eDP1: SUCCESS (1.821s)
[244.620585] Starting dynamic subtest: D-eDP1
[246.443153] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[246.445785] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.337s)
[247.620299] [052/134] (774s left) gem_exec_balancer (parallel-keep-in-fence)
[247.883809] Starting subtest: parallel-keep-in-fence
[248.982780] Subtest parallel-keep-in-fence: SUCCESS (1.101s)
[249.087821] [053/134] (772s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[249.178294] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[249.179228] Starting dynamic subtest: pipe-A-eDP-1
[249.244176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[249.253818] Starting dynamic subtest: pipe-B-eDP-1
[249.310937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.065s)
[249.319467] Starting dynamic subtest: pipe-C-eDP-1
[249.372628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[249.380748] Starting dynamic subtest: pipe-D-eDP-1
[249.435204] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[249.436089] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.258s)
[251.684717] [054/134] (770s left) kms_cursor_legacy (torture-bo)
[251.791915] Starting subtest: torture-bo
[251.792878] Starting dynamic subtest: pipe-A
[258.396052] Dynamic subtest pipe-A: SUCCESS (6.600s)
[258.405798] Starting dynamic subtest: pipe-B
[265.420516] Dynamic subtest pipe-B: SUCCESS (7.023s)
[265.430024] Starting dynamic subtest: pipe-C
[272.150857] Dynamic subtest pipe-C: SUCCESS (6.727s)
[272.171219] Starting dynamic subtest: pipe-D
[277.804409] Dynamic subtest pipe-D: SUCCESS (5.651s)
[277.814323] Starting dynamic subtest: all-pipes
[284.441450] Dynamic subtest all-pipes: SUCCESS (6.634s)
[284.442912] Subtest torture-bo: SUCCESS (32.646s)
[284.617367] [055/134] (737s left) gem_mmap (bad-offset)
[284.670035] Subtest bad-offset: SKIP (0.000s)
[284.717384] [056/134] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[284.820058] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[292.060981] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.241s)
[292.215270] [057/134] (729s left) syncobj_timeline (single-wait-signaled)
[292.273787] Starting subtest: single-wait-signaled
[292.274693] Subtest single-wait-signaled: SUCCESS (0.000s)
[292.386067] [058/134] (729s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[297.382527] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[297.384839] Starting dynamic subtest: pipe-A-eDP-1
[298.177018] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s)
[298.185294] Starting dynamic subtest: pipe-B-eDP-1
[299.311948] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[299.313632] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.930s)
[300.499167] [059/134] (721s left) kms_flip (plain-flip-fb-recreate)
[300.583141] Starting subtest: plain-flip-fb-recreate
[300.585105] Starting dynamic subtest: A-eDP1
[309.491989] Dynamic subtest A-eDP1: SUCCESS (8.907s)
[309.501605] Starting dynamic subtest: B-eDP1
[318.327873] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[318.338859] Starting dynamic subtest: C-eDP1
[327.143282] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[327.150919] Starting dynamic subtest: D-eDP1
[335.985997] Dynamic subtest D-eDP1: SUCCESS (8.841s)
[335.988209] Subtest plain-flip-fb-recreate: SUCCESS (35.404s)
[337.182198] [060/134] (684s left) perf (gen12-mi-rpc)
[337.312234] Starting subtest: gen12-mi-rpc
[337.313044] Starting dynamic subtest: rcs0
[337.331029] Dynamic subtest rcs0: SUCCESS (0.018s)
[337.331891] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[337.364436] [061/134] (684s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[337.494957] Starting subtest: plane-lut1d-pre-ctm3x4
[337.508672] Starting dynamic subtest: pipe-A-eDP-1
[338.008532] Dynamic subtest pipe-A-eDP-1: FAIL (0.349s)
[338.947518] Starting dynamic subtest: pipe-B-eDP-1
[339.414087] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[340.283220] Starting dynamic subtest: pipe-C-eDP-1
[340.749673] Dynamic subtest pipe-C-eDP-1: FAIL (0.267s)
[341.614112] Starting dynamic subtest: pipe-D-eDP-1
[342.110200] Dynamic subtest pipe-D-eDP-1: FAIL (0.286s)
[342.201348] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.707s)
[343.010158] [062/134] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[343.118910] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[352.386448] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.265s)
[352.529263] [063/134] (669s left) i915_pm_freq_api (freq-basic-api)
[352.589220] Starting subtest: freq-basic-api
[352.590109] Starting dynamic subtest: gt0
[352.592485] Dynamic subtest gt0: SUCCESS (0.003s)
[352.600205] Starting dynamic subtest: gt1
[352.600983] Dynamic subtest gt1: SUCCESS (0.003s)
[352.601816] Subtest freq-basic-api: SUCCESS (0.008s)
[352.679010] [064/134] (669s left) kms_cursor_crc (cursor-offscreen-32x10)
[352.838227] Starting subtest: cursor-offscreen-32x10
[352.878813] Subtest cursor-offscreen-32x10: SKIP (0.039s)
[353.186483] [065/134] (668s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[353.296604] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[353.298423] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[353.418513] [066/134] (668s left) kms_cdclk (mode-transition-all-outputs)
[353.512761] Starting subtest: mode-transition-all-outputs
[353.807405] Subtest mode-transition-all-outputs: SKIP (0.293s)
[354.623466] [067/134] (667s left) gem_ctx_param (invalid-set-no-zeromap)
[354.666434] Starting subtest: invalid-set-no-zeromap
[354.667376] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[354.736400] [068/134] (667s left) gen9_exec_parse (bb-secure)
[354.786364] Subtest bb-secure: SKIP (0.000s)
[354.846530] [069/134] (667s left) gem_render_copy (y-tiled-ccs-to-linear)
[354.895391] Starting subtest: y-tiled-ccs-to-linear
[354.897534] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[355.084949] [070/134] (667s left) kms_panel_fitting (atomic-fastset)
[355.177464] Starting subtest: atomic-fastset
[355.178340] Starting dynamic subtest: pipe-A-eDP-1
[355.319805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[355.328883] Starting dynamic subtest: pipe-B-eDP-1
[356.579737] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[356.589474] Starting dynamic subtest: pipe-C-eDP-1
[357.762615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s)
[357.769846] Starting dynamic subtest: pipe-D-eDP-1
[358.899452] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[358.900310] Subtest atomic-fastset: SUCCESS (3.723s)
[360.147553] [071/134] (662s left) syncobj_timeline (invalid-transfer-non-existent-point)
[360.202392] Starting subtest: invalid-transfer-non-existent-point
[360.203372] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[360.330006] [072/134] (662s left) api_intel_bb (render)
[360.385824] Starting subtest: render
[360.386755] Starting dynamic subtest: render-none-512
[360.493820] Dynamic subtest render-none-512: SUCCESS (0.107s)
[360.502301] Starting dynamic subtest: render-none-1024
[360.883395] Dynamic subtest render-none-1024: SUCCESS (0.388s)
[360.892770] Starting dynamic subtest: render-x-512
[360.967737] Dynamic subtest render-x-512: SUCCESS (0.085s)
[360.977030] Starting dynamic subtest: render-x-1024
[361.314370] Dynamic subtest render-x-1024: SUCCESS (0.344s)
[361.324428] Starting dynamic subtest: render-y-512
[361.399812] Dynamic subtest render-y-512: SUCCESS (0.086s)
[361.409448] Starting dynamic subtest: render-y-1024
[361.746024] Dynamic subtest render-y-1024: SUCCESS (0.343s)
[361.747669] Subtest render: SUCCESS (1.360s)
[361.839115] [073/134] (660s left) gem_blits (basic)
[361.898944] Starting subtest: basic
[363.462028] Subtest basic: SUCCESS (1.561s)
[363.602529] [074/134] (658s left) api_intel_bb (blit-noreloc-keep-cache)
[363.660777] Starting subtest: blit-noreloc-keep-cache
[363.675604] Subtest blit-noreloc-keep-cache: SUCCESS (0.016s)
[363.838502] [075/134] (658s left) prime_vgem (busy)
[363.933400] Starting subtest: busy
[363.934399] Starting dynamic subtest: rcs0
[364.015080] Dynamic subtest rcs0: SUCCESS (0.081s)
[364.024723] Starting dynamic subtest: bcs0
[364.117266] Dynamic subtest bcs0: SUCCESS (0.100s)
[364.124195] Starting dynamic subtest: vcs0
[364.159871] Dynamic subtest vcs0: SUCCESS (0.041s)
[364.167073] Starting dynamic subtest: vcs1
[364.207866] Dynamic subtest vcs1: SUCCESS (0.047s)
[364.215173] Starting dynamic subtest: vecs0
[364.253706] Dynamic subtest vecs0: SUCCESS (0.045s)
[364.260887] Starting dynamic subtest: ccs0
[364.304309] Dynamic subtest ccs0: SUCCESS (0.050s)
[364.305769] Subtest busy: SUCCESS (0.372s)
[364.463765] [076/134] (658s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[364.557969] Starting subtest: coverage-vs-premult-vs-constant
[364.844558] Starting dynamic subtest: pipe-A-eDP-1
[365.394829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[365.402252] Starting dynamic subtest: pipe-D-eDP-1
[366.746737] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[366.748126] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.188s)
[367.612682] [077/134] (654s left) kms_rotation_crc (cursor-rotation-180)
[367.714487] Starting subtest: cursor-rotation-180
[369.167772] Subtest cursor-rotation-180: SUCCESS (1.454s)
[370.364742] [078/134] (652s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[370.491855] Starting subtest: basic-flip-after-cursor-atomic
[371.404225] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.912s)
[372.214534] [079/134] (650s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[372.280176] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[372.282146] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[372.468516] [080/134] (650s left) kms_flip_scaled_crc (flip-nv12-linear-to-nv12-linear-reflect-x)
[372.562046] Starting subtest: flip-NV12-linear-to-NV12-linear-reflect-x
[372.563053] Starting dynamic subtest: pipe-A-default-mode
[373.686107] Dynamic subtest pipe-A-default-mode: SKIP (1.123s)
[373.688075] Subtest flip-NV12-linear-to-NV12-linear-reflect-x: SKIP (1.125s)
[373.852665] [081/134] (648s left) kms_lease (setcrtc-implicit-plane)
[373.956538] Starting subtest: setcrtc-implicit-plane
[373.961746] Starting dynamic subtest: pipe-A-eDP-1
[374.421551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[374.430735] Starting dynamic subtest: pipe-B-eDP-1
[375.578942] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[375.586466] Starting dynamic subtest: pipe-C-eDP-1
[376.725457] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.145s)
[376.732840] Starting dynamic subtest: pipe-D-eDP-1
[377.826784] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[377.827684] Subtest setcrtc-implicit-plane: SUCCESS (3.871s)
[378.678579] [082/134] (644s left) gem_exec_balancer (bonded-chain)
[378.736462] Starting subtest: bonded-chain
[385.709296] Subtest bonded-chain: SUCCESS (6.972s)
[386.060768] [083/134] (636s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[386.156027] Starting subtest: fbc-psr-sprite-mmap-cpu
[386.156885] Starting dynamic subtest: eDP-1
[386.158576] Dynamic subtest eDP-1: SKIP (0.000s)
[386.160398] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[386.236149] [084/134] (636s left) gem_exec_params (invalid-batch-start-offset)
[386.288514] Starting subtest: invalid-batch-start-offset
[386.289419] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[386.431261] [085/134] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[386.531034] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[392.994817] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.465s)
[393.137288] [086/134] (629s left) kms_psr (psr2-no-drrs)
[393.234159] Starting subtest: psr2-no-drrs
[393.234974] Starting dynamic subtest: eDP-1
[394.884469] Dynamic subtest eDP-1: SUCCESS (1.649s)
[394.885332] Subtest psr2-no-drrs: SUCCESS (1.650s)
[395.694352] [087/134] (627s left) kms_plane_scaling (planes-upscale-factor-0-25)
[395.782458] Starting subtest: planes-upscale-factor-0-25
[395.783369] Starting dynamic subtest: pipe-A
[395.843995] Dynamic subtest pipe-A: SUCCESS (0.062s)
[395.852999] Starting dynamic subtest: pipe-B
[397.022506] Dynamic subtest pipe-B: SUCCESS (1.177s)
[397.043928] Starting dynamic subtest: pipe-C
[398.140864] Dynamic subtest pipe-C: SUCCESS (1.116s)
[398.155062] Starting dynamic subtest: pipe-D
[399.262500] Dynamic subtest pipe-D: SUCCESS (1.119s)
[399.263491] Subtest planes-upscale-factor-0-25: SUCCESS (3.481s)
[400.427539] [088/134] (622s left) i915_query (test-query-geometry-subslices)
[400.483960] Starting subtest: test-query-geometry-subslices
[400.484934] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[400.605807] [089/134] (622s left) gem_spin_batch (resubmit-new-all)
[400.667311] Starting subtest: resubmit-new-all
[400.668213] Starting dynamic subtest: rcs0
[400.677974] Dynamic subtest rcs0: SUCCESS (0.012s)
[400.686201] Starting dynamic subtest: bcs0
[400.690301] Dynamic subtest bcs0: SUCCESS (0.012s)
[400.697416] Starting dynamic subtest: vcs0
[400.699555] Dynamic subtest vcs0: SUCCESS (0.009s)
[400.706786] Starting dynamic subtest: vcs1
[400.709874] Dynamic subtest vcs1: SUCCESS (0.009s)
[400.719527] Starting dynamic subtest: vecs0
[400.720397] Dynamic subtest vecs0: SUCCESS (0.009s)
[400.727749] Starting dynamic subtest: ccs0
[400.728717] Dynamic subtest ccs0: SUCCESS (0.008s)
[400.729584] Subtest resubmit-new-all: SUCCESS (0.062s)
[401.927868] [090/134] (621s left) prime_vgem (basic-fence-mmap)
[402.011388] Starting subtest: basic-fence-mmap
[402.013221] Subtest basic-fence-mmap: SKIP (0.000s)
[402.130240] [091/134] (620s left) i915_query (query-topology-matches-eu-total)
[402.188146] Starting subtest: query-topology-matches-eu-total
[402.189011] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[402.295623] [092/134] (620s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[402.419098] Starting subtest: flip-vs-cursor-legacy
[409.539769] Subtest flip-vs-cursor-legacy: SUCCESS (7.119s)
[410.361539] [093/134] (612s left) perf_pmu (invalid-init)
[410.398689] Starting subtest: invalid-init
[410.399693] Subtest invalid-init: SUCCESS (0.000s)
[410.526111] [094/134] (612s left) sw_sync (sync_multi_producer_single_consumer)
[410.570246] Starting subtest: sync_multi_producer_single_consumer
[411.648147] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[411.711601] [095/134] (611s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[411.837132] Starting subtest: short-flip-after-cursor-toggle
[412.751206] Subtest short-flip-after-cursor-toggle: SUCCESS (0.913s)
[413.609118] [096/134] (609s left) gem_exec_params (secure-non-master)
[413.662219] Starting subtest: secure-non-master
[413.663815] Subtest secure-non-master: SKIP (0.000s)
[413.777100] [097/134] (609s left) gem_ctx_shared (q-independent)
[413.841826] Starting subtest: Q-independent
[413.842754] Starting dynamic subtest: rcs0
[413.912911] Dynamic subtest rcs0: SUCCESS (0.071s)
[413.921112] Starting dynamic subtest: vcs0
[413.955174] Dynamic subtest vcs0: SUCCESS (0.041s)
[413.963324] Starting dynamic subtest: vcs1
[413.989606] Dynamic subtest vcs1: SUCCESS (0.034s)
[413.997156] Starting dynamic subtest: vecs0
[414.025483] Dynamic subtest vecs0: SUCCESS (0.035s)
[414.032460] Starting dynamic subtest: ccs0
[414.069997] Dynamic subtest ccs0: SUCCESS (0.044s)
[414.071027] Subtest Q-independent: SUCCESS (0.229s)
[416.021546] [098/134] (607s left) gem_exec_reloc (basic-wc-cpu)
[416.083948] Subtest basic-wc-cpu: SKIP (0.000s)
[416.170297] [099/134] (607s left) prime_mmap (test_userptr)
[416.224816] Starting subtest: test_userptr
[416.227061] Starting dynamic subtest: test_userptr-smem
[416.227872] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[416.228730] Subtest test_userptr: SUCCESS (0.003s)
[416.367901] [100/134] (606s left) kms_async_flips (test-cursor-atomic)
[416.468313] Starting subtest: test-cursor-atomic
[416.469956] Subtest test-cursor-atomic: SKIP (0.000s)
[417.649116] [101/134] (605s left) gem_exec_whisper (basic-sync-all)
[417.703561] Starting subtest: basic-sync-all
[425.846077] Subtest basic-sync-all: SUCCESS (8.139s)
[426.032763] [102/134] (597s left) kms_pm_rpm (legacy-planes)
[428.076276] Starting subtest: legacy-planes
[428.077228] Starting dynamic subtest: plane-64
[436.748048] Dynamic subtest plane-64: SUCCESS (8.673s)
[436.757833] Starting dynamic subtest: plane-94
[445.018313] Dynamic subtest plane-94: SUCCESS (8.268s)
[445.029387] Starting dynamic subtest: plane-124
[453.257880] Dynamic subtest plane-124: SUCCESS (8.235s)
[453.270414] Starting dynamic subtest: plane-134
[461.553069] Dynamic subtest plane-134: SUCCESS (8.293s)
[461.556736] Subtest legacy-planes: SUCCESS (33.480s)
[461.939503] [103/134] (561s left) syncobj_timeline (reset-during-wait-for-submit)
[461.991086] Starting subtest: reset-during-wait-for-submit
[462.094384] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[462.169079] [104/134] (561s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[462.278403] Starting subtest: cursorA-vs-flipA-toggle
[473.390098] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.111s)
[474.244428] [105/134] (549s left) syncobj_basic (bad-destroy)
[474.308394] Starting subtest: bad-destroy
[474.309453] Subtest bad-destroy: SUCCESS (0.000s)
[474.437871] [106/134] (549s left) kms_cursor_crc (cursor-tearing-position-change)
[474.558526] Starting subtest: cursor-tearing-position-change
[474.559487] Starting dynamic subtest: pipe-A-eDP-1
[475.131378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[475.140372] Starting dynamic subtest: pipe-D-eDP-1
[476.373163] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[476.374119] Subtest cursor-tearing-position-change: SUCCESS (1.814s)
[477.213063] [107/134] (546s left) kms_chamelium_frames (hdmi-crc-fast)
[477.578860] Subtest hdmi-crc-fast: SKIP (0.000s)
[478.405193] [108/134] (545s left) gem_close_race (multigpu-basic-process)
[478.457642] Starting subtest: multigpu-basic-process
[478.459385] Subtest multigpu-basic-process: SKIP (0.000s)
[478.683292] [109/134] (544s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[478.808874] Starting subtest: cursor-rapid-movement-32x32
[478.848957] Subtest cursor-rapid-movement-32x32: SKIP (0.038s)
[479.124076] [110/134] (544s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[479.231788] Starting subtest: psr-rgb565-draw-blt
[486.179961] Subtest psr-rgb565-draw-blt: SUCCESS (6.949s)
[486.322055] [111/134] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[486.418149] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[486.419867] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[486.547668] [112/134] (537s left) kms_prop_blob (basic)
[486.610497] Starting subtest: basic
[486.611599] Subtest basic: SUCCESS (0.000s)
[486.728661] [113/134] (536s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[487.118673] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[487.958091] [114/134] (535s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[488.053079] Starting subtest: crc-primary-suspend-y-tiled-ccs
[488.053894] Starting dynamic subtest: pipe-A-eDP-1
[488.057233] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[488.064786] Starting dynamic subtest: pipe-B-eDP-1
[488.068061] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[488.075468] Starting dynamic subtest: pipe-C-eDP-1
[488.078727] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[488.086195] Starting dynamic subtest: pipe-D-eDP-1
[488.089422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[488.091020] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[490.273246] [115/134] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[490.370081] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[490.371751] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[490.487486] [116/134] (533s left) dmabuf_sync_file (export-multiwait)
[490.519518] Starting subtest: export-multiwait
[490.520319] Subtest export-multiwait: SUCCESS (0.001s)
[490.595163] [117/134] (533s left) kms_atomic_interruptible (legacy-cursor)
[490.680444] Starting subtest: legacy-cursor
[490.681277] Starting dynamic subtest: pipe-A-eDP-1
[498.090618] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.408s)
[498.091581] Subtest legacy-cursor: SUCCESS (7.409s)
[498.947525] [118/134] (524s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[499.042305] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[499.043986] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[499.175774] [119/134] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[499.266808] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[499.268506] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[499.395505] [120/134] (524s left) perf (low-oa-exponent-permissions)
[499.505043] Starting subtest: low-oa-exponent-permissions
[499.535589] Subtest low-oa-exponent-permissions: SUCCESS (0.031s)
[499.582238] [121/134] (524s left) perf_pmu (semaphore-wait-idle)
[499.618116] Starting subtest: semaphore-wait-idle
[499.618988] Starting dynamic subtest: rcs0
[500.134484] Dynamic subtest rcs0: SUCCESS (0.513s)
[500.144260] Starting dynamic subtest: bcs0
[500.649642] Dynamic subtest bcs0: SUCCESS (0.512s)
[500.659830] Starting dynamic subtest: vcs0
[501.163590] Dynamic subtest vcs0: SUCCESS (0.510s)
[501.173823] Starting dynamic subtest: vcs1
[501.676831] Dynamic subtest vcs1: SUCCESS (0.510s)
[501.687061] Starting dynamic subtest: vecs0
[502.191315] Dynamic subtest vecs0: SUCCESS (0.511s)
[502.200470] Starting dynamic subtest: ccs0
[502.707233] Dynamic subtest ccs0: SUCCESS (0.513s)
[502.708829] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[503.974956] [122/134] (520s left) kms_joiner (invalid-modeset-ultra-joiner)
[504.074732] Starting subtest: invalid-modeset-ultra-joiner
[504.076347] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[504.153999] [123/134] (519s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[504.223566] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[504.304852] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[504.388672] [124/134] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[504.489656] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[504.491450] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[504.635740] [125/134] (519s left) kms_content_protection (dp-mst-type-0)
[504.770507] Starting subtest: dp-mst-type-0
[504.772374] Subtest dp-mst-type-0: SKIP (0.000s)
[504.915060] [126/134] (519s left) kms_plane (pixel-format-x-tiled-modifier)
[505.018313] Starting subtest: pixel-format-x-tiled-modifier
[505.046263] Starting dynamic subtest: pipe-A-plane-0
[505.668216] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[505.676213] Starting dynamic subtest: pipe-A-plane-3
[506.046062] Dynamic subtest pipe-A-plane-3: SUCCESS (0.377s)
[506.054523] Starting dynamic subtest: pipe-A-plane-5
[506.056278] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[507.120562] Starting dynamic subtest: pipe-B-plane-0
[507.710900] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s)
[507.719034] Starting dynamic subtest: pipe-B-plane-3
[508.121951] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[508.129728] Starting dynamic subtest: pipe-B-plane-5
[508.131367] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[508.430497] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.412s)
[509.298540] [127/134] (514s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[509.413903] Starting subtest: 4-tiled-16bpp-rotate-270
[509.433644] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[509.579640] [128/134] (514s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[509.669124] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[509.669975] Starting dynamic subtest: pipe-A-eDP-1
[509.678208] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.685897] Starting dynamic subtest: pipe-B-eDP-1
[509.694248] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.704061] Starting dynamic subtest: pipe-C-eDP-1
[509.712158] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.719743] Starting dynamic subtest: pipe-D-eDP-1
[509.727780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.729322] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[511.876606] [129/134] (512s left) sw_sync (timeline_closed)
[511.918180] Starting subtest: timeline_closed
[511.919104] Subtest timeline_closed: SUCCESS (0.000s)
[511.975793] [130/134] (512s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[512.084118] Starting subtest: x-tiled-8bpp-rotate-0
[513.163743] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.080s)
[513.350568] [131/134] (511s left) kms_vblank (wait-idle-hang)
[513.451184] Starting subtest: wait-idle-hang
[513.452121] Starting dynamic subtest: pipe-A-eDP-1
[539.746614] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.293s)
[539.755877] Starting dynamic subtest: pipe-D-eDP-1
[554.644578] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.894s)
[554.645391] Subtest wait-idle-hang: SUCCESS (41.192s)
[555.526393] [132/134] (468s left) sw_sync (timeline_closed_signaled)
[555.570182] Starting subtest: timeline_closed_signaled
[555.571121] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[555.636536] [133/134] (468s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[555.721259] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[555.722944] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.847954] [134/134] (468s left) kms_vblank (query-busy-hang)
[555.938373] Starting subtest: query-busy-hang
[555.939153] Starting dynamic subtest: pipe-A-eDP-1
[582.747510] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.807s)
[582.758241] Starting dynamic subtest: pipe-D-eDP-1
[607.714567] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[607.715449] Subtest query-busy-hang: SUCCESS (51.773s)
[608.608511] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_readwrite
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: gem_mmap_wc
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_exec_capture
results: parsing output: 17/ for test: kms_hdr
results: parsing output: 18/ for test: gem_mmap_offset
results: parsing output: 19/ for test: gem_exec_await
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: kms_feature_discovery
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: drm_read
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_psr2_su
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: gem_pxp
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: gem_exec_create
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_selftest
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: gem_mmap
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: i915_pm_freq_api
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_cdclk
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: kms_panel_fitting
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: gem_blits
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: prime_vgem
results: parsing output: 75/ for test: kms_plane_alpha_blend
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: gem_exec_whisper
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_chamelium_frames
results: parsing output: 107/ for test: gem_close_race
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_prop_blob
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: dmabuf_sync_file
results: parsing output: 116/ for test: kms_atomic_interruptible
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_joiner
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: sw_sync
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_vblank
Done.