[62.088750] Initializing watchdogs
[62.088793]   /dev/watchdog0
[62.102188] [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]
[62.106660] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.108973] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.112500] [001/134] (960s left) kms_flip (2x-flip-vs-wf_vblank)
[62.240322] Starting subtest: 2x-flip-vs-wf_vblank
[62.249092] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[62.340913] [002/134] (960s left) gem_ctx_persistence (file)
[62.394986] Starting subtest: file
[62.519881] Subtest file: SUCCESS (0.124s)
[62.645894] [003/134] (960s left) gem_readwrite (write-bad-handle)
[62.707361] Subtest write-bad-handle: SKIP (0.000s)
[62.770002] [004/134] (959s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[62.848062] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[62.883866] Starting dynamic subtest: pipe-A-plane-0
[62.888452] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[62.897417] Starting dynamic subtest: pipe-A-plane-3
[62.901958] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[62.908844] Starting dynamic subtest: pipe-A-plane-5
[62.912248] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[63.964772] Starting dynamic subtest: pipe-B-plane-0
[63.969236] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[63.975598] Starting dynamic subtest: pipe-B-plane-3
[63.979948] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[63.986384] Starting dynamic subtest: pipe-B-plane-5
[63.990749] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[64.277022] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.421s)
[65.149537] [005/134] (957s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[65.264881] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[66.269237] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.999s)
[67.127645] [006/134] (955s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[67.264710] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[74.265354] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.990s)
[74.435358] [007/134] (948s left) gem_userptr_blits (userfault)
[74.499890] Starting subtest: userfault
[74.502100] Subtest userfault: SUCCESS (0.006s)
[74.674140] [008/134] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[79.734025] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[79.736363] Starting dynamic subtest: pipe-A-eDP-1
[80.526132] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[80.542989] Starting dynamic subtest: pipe-B-eDP-1
[81.659868] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[81.664171] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.923s)
[82.963341] [009/134] (939s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[83.022351] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[83.086965] [010/134] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[83.190177] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[83.194104] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[83.304884] [011/134] (939s left) kms_psr (fbc-psr2-no-drrs)
[83.395777] Starting subtest: fbc-psr2-no-drrs
[83.398126] Starting dynamic subtest: eDP-1
[83.402393] Dynamic subtest eDP-1: SKIP (0.000s)
[83.406724] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[83.478094] [012/134] (939s left) gem_exec_schedule (u-submit-golden-slice)
[83.552696] Starting subtest: u-submit-golden-slice
[83.554936] Starting dynamic subtest: rcs0
[83.578472] Dynamic subtest rcs0: SUCCESS (0.034s)
[83.587507] Starting dynamic subtest: bcs0
[83.606546] Dynamic subtest bcs0: SUCCESS (0.028s)
[83.615269] Starting dynamic subtest: vcs0
[83.637063] Dynamic subtest vcs0: SUCCESS (0.030s)
[83.645272] Starting dynamic subtest: vcs1
[83.668670] Dynamic subtest vcs1: SUCCESS (0.031s)
[83.677755] Starting dynamic subtest: vecs0
[83.694899] Dynamic subtest vecs0: SUCCESS (0.026s)
[83.702158] Starting dynamic subtest: ccs0
[83.727260] Dynamic subtest ccs0: SUCCESS (0.032s)
[83.729480] Subtest u-submit-golden-slice: SUCCESS (0.183s)
[85.012085] [013/134] (938s left) gem_mmap_gtt (hang-busy)
[85.069968] Subtest hang-busy: SKIP (0.000s)
[85.139226] [014/134] (937s left) sysfs_timeslice_duration (idempotent)
[85.201290] Starting subtest: idempotent
[85.203759] Starting dynamic subtest: vecs0
[85.206128] Dynamic subtest vecs0: SUCCESS (0.000s)
[85.218024] Starting dynamic subtest: ccs0
[85.219975] Dynamic subtest ccs0: SUCCESS (0.000s)
[85.227784] Starting dynamic subtest: vcs0
[85.229716] Dynamic subtest vcs0: SUCCESS (0.000s)
[85.235953] Starting dynamic subtest: bcs0
[85.237891] Dynamic subtest bcs0: SUCCESS (0.000s)
[85.246982] Starting dynamic subtest: rcs0
[85.249192] Dynamic subtest rcs0: SUCCESS (0.000s)
[85.255862] Starting dynamic subtest: vcs1
[85.258043] Dynamic subtest vcs1: SUCCESS (0.000s)
[85.260116] Subtest idempotent: SUCCESS (0.004s)
[85.333924] [015/134] (937s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[85.443804] Starting subtest: fbc-1p-pri-indfb-multidraw
[98.705735] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.260s)
[100.086081] [016/134] (923s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[100.188302] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[100.190538] Starting dynamic subtest: A-eDP1
[103.767524] Dynamic subtest A-eDP1: SUCCESS (3.575s)
[103.776823] Starting dynamic subtest: B-eDP1
[106.964317] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[106.971687] Starting dynamic subtest: C-eDP1
[110.080125] Dynamic subtest C-eDP1: SUCCESS (3.112s)
[110.091768] Starting dynamic subtest: D-eDP1
[113.189251] Dynamic subtest D-eDP1: SUCCESS (3.111s)
[113.191559] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.000s)
[113.994697] [017/134] (909s left) gem_exec_capture (userptr)
[114.061553] Starting subtest: userptr
[114.898955] Subtest userptr: SUCCESS (0.836s)
[115.046944] [018/134] (908s left) kms_hdr (invalid-metadata-sizes)
[115.137696] Starting subtest: invalid-metadata-sizes
[115.144719] Subtest invalid-metadata-sizes: SKIP (0.000s)
[115.244412] [019/134] (908s left) gem_mmap_offset (perf)
[115.305802] Starting subtest: perf
[115.307750] Starting dynamic subtest: smem0
[115.668052] Dynamic subtest smem0: SUCCESS (0.361s)
[115.670715] Subtest perf: SUCCESS (0.361s)
[115.770630] [020/134] (907s left) gem_exec_await (wide-contexts)
[115.993901] Starting subtest: wide-contexts
[139.820077] Subtest wide-contexts: SUCCESS (23.822s)
[140.018708] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[140.023250] [021/134] (883s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[140.180899] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[140.183076] Starting dynamic subtest: pipe-A-eDP-1
[140.204965] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[140.213796] Starting dynamic subtest: pipe-B-eDP-1
[140.234715] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[140.242279] Starting dynamic subtest: pipe-C-eDP-1
[140.263392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[140.270819] Starting dynamic subtest: pipe-D-eDP-1
[140.292110] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[140.296073] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[142.466231] [022/134] (880s left) kms_addfb_basic (basic-x-tiled-legacy)
[142.536088] Starting subtest: basic-x-tiled-legacy
[142.540549] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[142.717532] [023/134] (880s left) kms_feature_discovery (chamelium)
[142.802768] Starting subtest: chamelium
[142.807167] Subtest chamelium: SKIP (0.000s)
[142.885916] [024/134] (880s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[142.988963] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[142.991344] Starting dynamic subtest: pipe-A-default-mode
[144.118289] Dynamic subtest pipe-A-default-mode: SKIP (1.127s)
[144.122142] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.128s)
[144.329867] [025/134] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[144.441680] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[144.445804] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[144.546267] [026/134] (879s left) drm_read (empty-nonblock)
[144.727894] Starting subtest: empty-nonblock
[144.730454] Subtest empty-nonblock: SUCCESS (0.000s)
[144.875834] [027/134] (878s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[144.990190] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[145.747830] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.759s)
[145.986949] [028/134] (877s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[146.088242] Starting subtest: y-tiled-32bpp-rotate-270
[146.092325] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[146.191927] [029/134] (877s left) kms_plane_scaling (intel-max-src-size)
[146.286706] Starting subtest: intel-max-src-size
[146.293202] Subtest intel-max-src-size: SKIP (0.000s)
[146.402968] [030/134] (877s left) gem_mmap_wc (read-write)
[146.448567] Subtest read-write: SKIP (0.000s)
[146.510357] [031/134] (877s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[146.611336] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[147.678460] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.067s)
[147.821207] [032/134] (876s left) kms_psr2_su (frontbuffer-xrgb8888)
[147.875361] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[147.940271] [033/134] (876s left) gen9_exec_parse (shadow-peek)
[148.005728] Subtest shadow-peek: SKIP (0.000s)
[148.082899] [034/134] (875s left) gem_exec_schedule (smoketest)
[148.259913] Starting subtest: smoketest
[148.262447] Starting dynamic subtest: rcs0
[153.801926] Dynamic subtest rcs0: SUCCESS (5.494s)
[153.810518] Starting dynamic subtest: bcs0
[159.317900] Dynamic subtest bcs0: SUCCESS (5.514s)
[159.326852] Starting dynamic subtest: vcs0
[164.824721] Dynamic subtest vcs0: SUCCESS (5.497s)
[164.838592] Starting dynamic subtest: vcs1
[170.328059] Dynamic subtest vcs1: SUCCESS (5.508s)
[170.339478] Starting dynamic subtest: vecs0
[175.836192] Dynamic subtest vecs0: SUCCESS (5.503s)
[175.845783] Starting dynamic subtest: ccs0
[181.342917] Dynamic subtest ccs0: SUCCESS (5.512s)
[181.345095] Subtest smoketest: SUCCESS (33.034s)
[181.571462] [035/134] (842s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[181.679847] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[181.682207] Starting dynamic subtest: pipe-A-eDP-1
[181.741205] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[181.751131] Starting dynamic subtest: pipe-B-eDP-1
[181.809144] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[181.818451] Starting dynamic subtest: pipe-C-eDP-1
[181.876237] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[181.885241] Starting dynamic subtest: pipe-D-eDP-1
[181.942835] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[181.947466] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[183.859600] [036/134] (840s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[183.953559] Starting subtest: 2x-flip-vs-modeset-vs-hang
[183.964048] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[184.070081] [037/134] (840s left) kms_psr (psr2-cursor-mmap-cpu)
[184.169557] Starting subtest: psr2-cursor-mmap-cpu
[184.171912] Starting dynamic subtest: eDP-1
[185.820978] Dynamic subtest eDP-1: SUCCESS (1.652s)
[185.823234] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.653s)
[186.637705] [038/134] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[186.744060] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[186.748099] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[186.862059] [039/134] (837s left) syncobj_wait (reset-during-wait-for-submit)
[186.930685] Starting subtest: reset-during-wait-for-submit
[187.033433] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[187.118877] [040/134] (837s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[187.696808] Starting subtest: syncobj-timeline-multiple-ext-nodes
[187.702272] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[188.961077] [041/134] (835s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[189.057648] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[189.065778] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[189.168150] [042/134] (835s left) i915_pm_rpm (debugfs-read)
[191.094466] Starting subtest: debugfs-read
[192.252216] Subtest debugfs-read: SUCCESS (1.156s)
[192.634576] [043/134] (831s left) gem_pxp (protected-raw-src-copy-not-readible)
[192.758330] Starting subtest: protected-raw-src-copy-not-readible
[192.815068] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[192.973376] [044/134] (831s left) gem_exec_schedule (implicit-read-write)
[193.039261] Starting subtest: implicit-read-write
[193.041589] Starting dynamic subtest: rcs0
[193.133670] Dynamic subtest rcs0: SUCCESS (0.105s)
[193.144733] Starting dynamic subtest: vcs0
[193.208460] Dynamic subtest vcs0: SUCCESS (0.075s)
[193.220171] Starting dynamic subtest: vcs1
[193.288640] Dynamic subtest vcs1: SUCCESS (0.079s)
[193.300168] Starting dynamic subtest: vecs0
[193.360424] Dynamic subtest vecs0: SUCCESS (0.072s)
[193.369545] Starting dynamic subtest: ccs0
[193.441742] Dynamic subtest ccs0: SUCCESS (0.080s)
[193.444353] Subtest implicit-read-write: SUCCESS (0.414s)
[195.036631] [045/134] (829s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[195.153398] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[195.155757] Starting dynamic subtest: A-eDP1
[198.742816] Dynamic subtest A-eDP1: SUCCESS (3.585s)
[198.752583] Starting dynamic subtest: B-eDP1
[201.940608] Dynamic subtest B-eDP1: SUCCESS (3.197s)
[201.949868] Starting dynamic subtest: C-eDP1
[205.035714] Dynamic subtest C-eDP1: SUCCESS (3.095s)
[205.044904] Starting dynamic subtest: D-eDP1
[208.119488] Dynamic subtest D-eDP1: SUCCESS (3.081s)
[208.121380] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.965s)
[208.937843] [046/134] (815s left) gem_exec_create (madvise)
[209.012605] Starting subtest: madvise
[209.015025] Starting dynamic subtest: smem
[230.999292] Dynamic subtest smem: SUCCESS (21.983s)
[231.001492] Subtest madvise: SUCCESS (21.983s)
[232.408897] [047/134] (792s left) gem_exec_reloc (basic-gtt-read-noreloc)
[232.466734] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[232.560109] [048/134] (791s left) syncobj_timeline (etime-single-wait-all-submitted)
[232.622376] Starting subtest: etime-single-wait-all-submitted
[232.728603] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[232.826562] [049/134] (791s left) kms_selftest (drm_dp_mst_helper)
[232.870972] Starting subtest: drm_dp_mst_helper
[232.909431] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[233.070098] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.159s)
[233.079727] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[233.231151] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.161s)
[233.240524] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[233.396651] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.164s)
[233.398584] Subtest drm_dp_mst_helper: SUCCESS (0.523s)
[233.615118] [050/134] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[233.726660] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[242.472227] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.748s)
[242.623946] [051/134] (782s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[242.730264] Starting subtest: flip-vs-dpms-on-nop-interruptible
[242.732440] Starting dynamic subtest: A-eDP1
[244.605411] Dynamic subtest A-eDP1: SUCCESS (1.874s)
[244.616238] Starting dynamic subtest: B-eDP1
[246.439130] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[246.447445] Starting dynamic subtest: C-eDP1
[248.268472] Dynamic subtest C-eDP1: SUCCESS (1.828s)
[248.277327] Starting dynamic subtest: D-eDP1
[250.097488] Dynamic subtest D-eDP1: SUCCESS (1.827s)
[250.102271] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.372s)
[251.276770] [052/134] (773s left) gem_exec_balancer (parallel-keep-in-fence)
[251.538437] Starting subtest: parallel-keep-in-fence
[252.680520] Subtest parallel-keep-in-fence: SUCCESS (1.141s)
[252.806166] [053/134] (771s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[252.900101] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[252.902352] Starting dynamic subtest: pipe-A-eDP-1
[253.024604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.123s)
[253.047755] Starting dynamic subtest: pipe-B-eDP-1
[253.153625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.126s)
[253.170356] Starting dynamic subtest: pipe-C-eDP-1
[253.216082] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[253.226449] Starting dynamic subtest: pipe-D-eDP-1
[253.289865] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.074s)
[253.292194] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.391s)
[255.556326] [054/134] (769s left) kms_cursor_legacy (torture-bo)
[255.681781] Starting subtest: torture-bo
[255.684213] Starting dynamic subtest: pipe-A
[261.737628] Dynamic subtest pipe-A: SUCCESS (6.053s)
[261.748742] Starting dynamic subtest: pipe-B
[267.481046] Dynamic subtest pipe-B: SUCCESS (5.740s)
[267.492392] Starting dynamic subtest: pipe-C
[273.222340] Dynamic subtest pipe-C: SUCCESS (5.738s)
[273.233289] Starting dynamic subtest: pipe-D
[280.654309] Dynamic subtest pipe-D: SUCCESS (7.431s)
[280.665050] Starting dynamic subtest: all-pipes
[286.808575] Dynamic subtest all-pipes: SUCCESS (6.152s)
[286.811217] Subtest torture-bo: SUCCESS (31.124s)
[286.978610] [055/134] (737s left) gem_mmap (bad-offset)
[287.046263] Subtest bad-offset: SKIP (0.000s)
[287.116150] [056/134] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[287.226510] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[294.534687] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.311s)
[294.714282] [057/134] (730s left) syncobj_timeline (single-wait-signaled)
[294.774268] Starting subtest: single-wait-signaled
[294.776602] Subtest single-wait-signaled: SUCCESS (0.000s)
[294.879433] [058/134] (730s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[299.854111] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[299.856238] Starting dynamic subtest: pipe-A-eDP-1
[300.646401] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[300.655459] Starting dynamic subtest: pipe-B-eDP-1
[301.781125] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[301.785683] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.925s)
[302.975694] [059/134] (722s left) kms_flip (plain-flip-fb-recreate)
[303.075642] Starting subtest: plain-flip-fb-recreate
[303.078117] Starting dynamic subtest: A-eDP1
[311.955851] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[311.965588] Starting dynamic subtest: B-eDP1
[320.784720] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[320.793663] Starting dynamic subtest: C-eDP1
[329.603335] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[329.614461] Starting dynamic subtest: D-eDP1
[338.431744] Dynamic subtest D-eDP1: SUCCESS (8.825s)
[338.435950] Subtest plain-flip-fb-recreate: SUCCESS (35.359s)
[339.632132] [060/134] (685s left) perf (gen12-mi-rpc)
[339.787769] Starting subtest: gen12-mi-rpc
[339.789620] Starting dynamic subtest: rcs0
[339.806975] Dynamic subtest rcs0: SUCCESS (0.019s)
[339.808813] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[339.861602] [061/134] (685s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[340.000091] Starting subtest: plane-lut1d-pre-ctm3x4
[340.015971] Starting dynamic subtest: pipe-A-eDP-1
[340.717056] Dynamic subtest pipe-A-eDP-1: FAIL (0.341s)
[341.400754] Starting dynamic subtest: pipe-B-eDP-1
[342.221231] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[342.730349] Starting dynamic subtest: pipe-C-eDP-1
[343.557320] Dynamic subtest pipe-C-eDP-1: FAIL (0.239s)
[344.061489] Starting dynamic subtest: pipe-D-eDP-1
[344.895603] Dynamic subtest pipe-D-eDP-1: FAIL (0.256s)
[344.898101] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.608s)
[345.460459] [062/134] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[345.557654] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[354.706923] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.151s)
[354.872413] [063/134] (670s left) i915_pm_freq_api (freq-basic-api)
[354.928286] Starting subtest: freq-basic-api
[354.930882] Starting dynamic subtest: gt0
[354.933622] Dynamic subtest gt0: SUCCESS (0.003s)
[354.944210] Starting dynamic subtest: gt1
[354.946600] Dynamic subtest gt1: SUCCESS (0.003s)
[354.948848] Subtest freq-basic-api: SUCCESS (0.008s)
[355.041749] [064/134] (670s left) kms_cursor_crc (cursor-offscreen-32x10)
[355.203110] Starting subtest: cursor-offscreen-32x10
[355.252166] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[355.527196] [065/134] (669s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[355.622557] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[355.626973] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[355.734599] [066/134] (669s left) kms_cdclk (mode-transition-all-outputs)
[355.827491] Starting subtest: mode-transition-all-outputs
[356.123059] Subtest mode-transition-all-outputs: SKIP (0.293s)
[356.942188] [067/134] (668s left) gem_ctx_param (invalid-set-no-zeromap)
[356.997160] Starting subtest: invalid-set-no-zeromap
[356.999515] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[357.091315] [068/134] (668s left) gen9_exec_parse (bb-secure)
[357.149062] Subtest bb-secure: SKIP (0.000s)
[357.216750] [069/134] (668s left) gem_render_copy (y-tiled-ccs-to-linear)
[357.266911] Starting subtest: y-tiled-ccs-to-linear
[357.271484] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[357.471190] [070/134] (667s left) kms_panel_fitting (atomic-fastset)
[357.566141] Starting subtest: atomic-fastset
[357.568503] Starting dynamic subtest: pipe-A-eDP-1
[357.708245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[357.719065] Starting dynamic subtest: pipe-B-eDP-1
[358.877472] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[358.888921] Starting dynamic subtest: pipe-C-eDP-1
[360.067928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.189s)
[360.076007] Starting dynamic subtest: pipe-D-eDP-1
[361.220716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.151s)
[361.222886] Subtest atomic-fastset: SUCCESS (3.657s)
[362.473179] [071/134] (663s left) syncobj_timeline (invalid-transfer-non-existent-point)
[362.526557] Starting subtest: invalid-transfer-non-existent-point
[362.528512] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[362.650644] [072/134] (662s left) api_intel_bb (render)
[362.715759] Starting subtest: render
[362.717827] Starting dynamic subtest: render-none-512
[362.815343] Dynamic subtest render-none-512: SUCCESS (0.100s)
[362.826483] Starting dynamic subtest: render-none-1024
[363.185269] Dynamic subtest render-none-1024: SUCCESS (0.367s)
[363.199216] Starting dynamic subtest: render-x-512
[363.268506] Dynamic subtest render-x-512: SUCCESS (0.084s)
[363.276819] Starting dynamic subtest: render-x-1024
[363.670119] Dynamic subtest render-x-1024: SUCCESS (0.400s)
[363.680721] Starting dynamic subtest: render-y-512
[363.758728] Dynamic subtest render-y-512: SUCCESS (0.088s)
[363.768894] Starting dynamic subtest: render-y-1024
[364.103440] Dynamic subtest render-y-1024: SUCCESS (0.343s)
[364.106290] Subtest render: SUCCESS (1.388s)
[364.250077] [073/134] (661s left) gem_blits (basic)
[364.323213] Starting subtest: basic
[365.954651] Subtest basic: SUCCESS (1.631s)
[366.108862] [074/134] (659s left) api_intel_bb (blit-noreloc-keep-cache)
[366.169427] Starting subtest: blit-noreloc-keep-cache
[366.183594] Subtest blit-noreloc-keep-cache: SUCCESS (0.017s)
[366.352986] [075/134] (659s left) prime_vgem (busy)
[366.449685] Starting subtest: busy
[366.451655] Starting dynamic subtest: rcs0
[366.542712] Dynamic subtest rcs0: SUCCESS (0.094s)
[366.552216] Starting dynamic subtest: bcs0
[366.578066] Dynamic subtest bcs0: SUCCESS (0.035s)
[366.586389] Starting dynamic subtest: vcs0
[366.646927] Dynamic subtest vcs0: SUCCESS (0.068s)
[366.655196] Starting dynamic subtest: vcs1
[366.693922] Dynamic subtest vcs1: SUCCESS (0.046s)
[366.702165] Starting dynamic subtest: vecs0
[366.740742] Dynamic subtest vecs0: SUCCESS (0.046s)
[366.748732] Starting dynamic subtest: ccs0
[366.790814] Dynamic subtest ccs0: SUCCESS (0.049s)
[366.793098] Subtest busy: SUCCESS (0.343s)
[366.921460] [076/134] (658s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[367.010548] Starting subtest: coverage-vs-premult-vs-constant
[367.291797] Starting dynamic subtest: pipe-A-eDP-1
[367.858792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[367.868894] Starting dynamic subtest: pipe-D-eDP-1
[369.169760] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[369.171917] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.158s)
[370.040965] [077/134] (655s left) kms_rotation_crc (cursor-rotation-180)
[370.145716] Starting subtest: cursor-rotation-180
[371.675351] Subtest cursor-rotation-180: SUCCESS (1.531s)
[372.889484] [078/134] (652s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[372.997395] Starting subtest: basic-flip-after-cursor-atomic
[373.911413] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.913s)
[374.741457] [079/134] (651s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[374.812753] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[374.817201] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[375.005594] [080/134] (650s left) kms_flip_scaled_crc (flip-nv12-linear-to-nv12-linear-reflect-x)
[375.098058] Starting subtest: flip-NV12-linear-to-NV12-linear-reflect-x
[375.100318] Starting dynamic subtest: pipe-A-default-mode
[376.270740] Dynamic subtest pipe-A-default-mode: SKIP (1.169s)
[376.275455] Subtest flip-NV12-linear-to-NV12-linear-reflect-x: SKIP (1.171s)
[376.438952] [081/134] (649s left) kms_lease (setcrtc-implicit-plane)
[376.540087] Starting subtest: setcrtc-implicit-plane
[376.542550] Starting dynamic subtest: pipe-A-eDP-1
[376.994232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[377.003329] Starting dynamic subtest: pipe-B-eDP-1
[378.164373] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[378.173300] Starting dynamic subtest: pipe-C-eDP-1
[379.284805] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[379.296516] Starting dynamic subtest: pipe-D-eDP-1
[380.409705] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[380.412186] Subtest setcrtc-implicit-plane: SUCCESS (3.873s)
[381.275633] [082/134] (644s left) gem_exec_balancer (bonded-chain)
[381.329428] Starting subtest: bonded-chain
[388.281223] Subtest bonded-chain: SUCCESS (6.950s)
[388.627102] [083/134] (637s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[388.721927] Starting subtest: fbc-psr-sprite-mmap-cpu
[388.724126] Starting dynamic subtest: eDP-1
[388.728042] Dynamic subtest eDP-1: SKIP (0.000s)
[388.732789] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[388.810740] [084/134] (637s left) gem_exec_params (invalid-batch-start-offset)
[388.859638] Starting subtest: invalid-batch-start-offset
[388.864758] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[389.003913] [085/134] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[389.102974] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[395.612384] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.511s)
[395.749025] [086/134] (630s left) kms_psr (psr2-no-drrs)
[395.850453] Starting subtest: psr2-no-drrs
[395.852819] Starting dynamic subtest: eDP-1
[397.445333] Dynamic subtest eDP-1: SUCCESS (1.595s)
[397.447599] Subtest psr2-no-drrs: SUCCESS (1.596s)
[398.258294] [087/134] (627s left) kms_plane_scaling (planes-upscale-factor-0-25)
[398.355832] Starting subtest: planes-upscale-factor-0-25
[398.358072] Starting dynamic subtest: pipe-A
[398.416334] Dynamic subtest pipe-A: SUCCESS (0.062s)
[398.425862] Starting dynamic subtest: pipe-B
[399.570812] Dynamic subtest pipe-B: SUCCESS (1.152s)
[399.581859] Starting dynamic subtest: pipe-C
[400.679281] Dynamic subtest pipe-C: SUCCESS (1.107s)
[400.689510] Starting dynamic subtest: pipe-D
[401.811255] Dynamic subtest pipe-D: SUCCESS (1.131s)
[401.813747] Subtest planes-upscale-factor-0-25: SUCCESS (3.459s)
[402.971168] [088/134] (623s left) i915_query (test-query-geometry-subslices)
[403.042706] Starting subtest: test-query-geometry-subslices
[403.044938] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[403.170618] [089/134] (623s left) gem_spin_batch (resubmit-new-all)
[403.234045] Starting subtest: resubmit-new-all
[403.236261] Starting dynamic subtest: rcs0
[403.249427] Dynamic subtest rcs0: SUCCESS (0.015s)
[403.259876] Starting dynamic subtest: bcs0
[403.262022] Dynamic subtest bcs0: SUCCESS (0.009s)
[403.270017] Starting dynamic subtest: vcs0
[403.272198] Dynamic subtest vcs0: SUCCESS (0.008s)
[403.279852] Starting dynamic subtest: vcs1
[403.281735] Dynamic subtest vcs1: SUCCESS (0.008s)
[403.289498] Starting dynamic subtest: vecs0
[403.291481] Dynamic subtest vecs0: SUCCESS (0.014s)
[403.299769] Starting dynamic subtest: ccs0
[403.307727] Dynamic subtest ccs0: SUCCESS (0.015s)
[403.309992] Subtest resubmit-new-all: SUCCESS (0.075s)
[404.941694] [090/134] (621s left) prime_vgem (basic-fence-mmap)
[405.023189] Starting subtest: basic-fence-mmap
[405.027318] Subtest basic-fence-mmap: SKIP (0.000s)
[405.125134] [091/134] (621s left) i915_query (query-topology-matches-eu-total)
[405.182121] Starting subtest: query-topology-matches-eu-total
[405.184246] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[405.279845] [092/134] (621s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[405.431985] Starting subtest: flip-vs-cursor-legacy
[412.502253] Subtest flip-vs-cursor-legacy: SUCCESS (7.067s)
[413.327420] [093/134] (613s left) perf_pmu (invalid-init)
[413.369613] Starting subtest: invalid-init
[413.371895] Subtest invalid-init: SUCCESS (0.000s)
[413.490537] [094/134] (612s left) sw_sync (sync_multi_producer_single_consumer)
[413.535878] Starting subtest: sync_multi_producer_single_consumer
[414.610088] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[414.697533] [095/134] (611s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[414.827160] Starting subtest: short-flip-after-cursor-toggle
[415.759722] Subtest short-flip-after-cursor-toggle: SUCCESS (0.934s)
[416.565015] [096/134] (609s left) gem_exec_params (secure-non-master)
[416.620944] Starting subtest: secure-non-master
[416.625153] Subtest secure-non-master: SKIP (0.000s)
[416.751239] [097/134] (609s left) gem_ctx_shared (q-independent)
[416.818181] Starting subtest: Q-independent
[416.820329] Starting dynamic subtest: rcs0
[416.880935] Dynamic subtest rcs0: SUCCESS (0.065s)
[416.892321] Starting dynamic subtest: vcs0
[416.918768] Dynamic subtest vcs0: SUCCESS (0.038s)
[416.927076] Starting dynamic subtest: vcs1
[416.955165] Dynamic subtest vcs1: SUCCESS (0.036s)
[416.964090] Starting dynamic subtest: vecs0
[416.992375] Dynamic subtest vecs0: SUCCESS (0.037s)
[417.001681] Starting dynamic subtest: ccs0
[417.037366] Dynamic subtest ccs0: SUCCESS (0.044s)
[417.039707] Subtest Q-independent: SUCCESS (0.222s)
[419.022374] [098/134] (607s left) gem_exec_reloc (basic-wc-cpu)
[419.104670] Subtest basic-wc-cpu: SKIP (0.000s)
[419.200383] [099/134] (607s left) prime_mmap (test_userptr)
[419.263577] Starting subtest: test_userptr
[419.265950] Starting dynamic subtest: test_userptr-smem
[419.268279] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[419.270608] Subtest test_userptr: SUCCESS (0.001s)
[419.375633] [100/134] (607s left) kms_async_flips (test-cursor-atomic)
[419.485096] Starting subtest: test-cursor-atomic
[419.489165] Subtest test-cursor-atomic: SKIP (0.000s)
[420.710406] [101/134] (606s left) gem_exec_whisper (basic-sync-all)
[420.788749] Starting subtest: basic-sync-all
[427.179243] Subtest basic-sync-all: SUCCESS (6.388s)
[427.375863] [102/134] (599s left) kms_pm_rpm (legacy-planes)
[429.017856] Starting subtest: legacy-planes
[429.019958] Starting dynamic subtest: plane-64
[437.403476] Dynamic subtest plane-64: SUCCESS (8.387s)
[437.415207] Starting dynamic subtest: plane-94
[445.679900] Dynamic subtest plane-94: SUCCESS (8.273s)
[445.691874] Starting dynamic subtest: plane-124
[454.001817] Dynamic subtest plane-124: SUCCESS (8.319s)
[454.013958] Starting dynamic subtest: plane-134
[462.312213] Dynamic subtest plane-134: SUCCESS (8.307s)
[462.315098] Subtest legacy-planes: SUCCESS (33.296s)
[462.689303] [103/134] (564s left) syncobj_timeline (reset-during-wait-for-submit)
[462.750757] Starting subtest: reset-during-wait-for-submit
[462.851035] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[462.945815] [104/134] (563s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[463.061297] Starting subtest: cursorA-vs-flipA-toggle
[474.190454] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.125s)
[475.007102] [105/134] (551s left) syncobj_basic (bad-destroy)
[475.074605] Starting subtest: bad-destroy
[475.076708] Subtest bad-destroy: SUCCESS (0.000s)
[475.197450] [106/134] (551s left) kms_cursor_crc (cursor-tearing-position-change)
[475.314261] Starting subtest: cursor-tearing-position-change
[475.316176] Starting dynamic subtest: pipe-A-eDP-1
[475.888769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[475.898635] Starting dynamic subtest: pipe-D-eDP-1
[477.136094] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[477.138357] Subtest cursor-tearing-position-change: SUCCESS (1.823s)
[477.977586] [107/134] (549s left) kms_chamelium_frames (hdmi-crc-fast)
[478.362705] Subtest hdmi-crc-fast: SKIP (0.000s)
[479.171541] [108/134] (547s left) gem_close_race (multigpu-basic-process)
[479.244831] Starting subtest: multigpu-basic-process
[479.249375] Subtest multigpu-basic-process: SKIP (0.000s)
[479.512513] [109/134] (547s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[479.660140] Starting subtest: cursor-rapid-movement-32x32
[479.717153] Subtest cursor-rapid-movement-32x32: SKIP (0.055s)
[480.042943] [110/134] (547s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[480.153952] Starting subtest: psr-rgb565-draw-blt
[487.122729] Subtest psr-rgb565-draw-blt: SUCCESS (6.971s)
[487.249846] [111/134] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[487.354522] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[487.358955] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[487.457482] [112/134] (539s left) kms_prop_blob (basic)
[487.519123] Starting subtest: basic
[487.521033] Subtest basic: SUCCESS (0.000s)
[487.633448] [113/134] (539s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[488.011067] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[488.822532] [114/134] (538s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[488.915094] Starting subtest: crc-primary-suspend-y-tiled-ccs
[488.917263] Starting dynamic subtest: pipe-A-eDP-1
[488.925885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[488.934915] Starting dynamic subtest: pipe-B-eDP-1
[488.943646] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[488.952861] Starting dynamic subtest: pipe-C-eDP-1
[488.961467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[488.969460] Starting dynamic subtest: pipe-D-eDP-1
[488.977782] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[488.981726] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[491.211863] [115/134] (536s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[491.312181] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[491.316366] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[491.437092] [116/134] (535s left) dmabuf_sync_file (export-multiwait)
[491.477092] Starting subtest: export-multiwait
[491.478943] Subtest export-multiwait: SUCCESS (0.000s)
[491.543939] [117/134] (535s left) kms_atomic_interruptible (legacy-cursor)
[491.633474] Starting subtest: legacy-cursor
[491.635858] Starting dynamic subtest: pipe-A-eDP-1
[499.016791] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.382s)
[499.019199] Subtest legacy-cursor: SUCCESS (7.384s)
[499.869314] [118/134] (527s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[499.963422] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[499.967713] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[500.076478] [119/134] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[500.169246] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[500.173127] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[500.290718] [120/134] (527s left) perf (low-oa-exponent-permissions)
[500.381691] Starting subtest: low-oa-exponent-permissions
[500.417746] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[500.456369] [121/134] (527s left) perf_pmu (semaphore-wait-idle)
[500.497720] Starting subtest: semaphore-wait-idle
[500.499804] Starting dynamic subtest: rcs0
[501.013050] Dynamic subtest rcs0: SUCCESS (0.514s)
[501.024927] Starting dynamic subtest: bcs0
[501.526638] Dynamic subtest bcs0: SUCCESS (0.510s)
[501.546215] Starting dynamic subtest: vcs0
[502.038759] Dynamic subtest vcs0: SUCCESS (0.510s)
[502.048905] Starting dynamic subtest: vcs1
[502.553247] Dynamic subtest vcs1: SUCCESS (0.511s)
[502.565512] Starting dynamic subtest: vecs0
[503.065505] Dynamic subtest vecs0: SUCCESS (0.510s)
[503.074452] Starting dynamic subtest: ccs0
[503.581758] Dynamic subtest ccs0: SUCCESS (0.512s)
[503.584479] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[504.942828] [122/134] (522s left) kms_joiner (invalid-modeset-ultra-joiner)
[505.049556] Starting subtest: invalid-modeset-ultra-joiner
[505.053653] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[505.143920] [123/134] (522s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[505.209628] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[505.311938] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[505.403947] [124/134] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[505.496344] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[505.500589] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[505.620831] [125/134] (522s left) kms_content_protection (dp-mst-type-0)
[505.775219] Starting subtest: dp-mst-type-0
[505.779305] Subtest dp-mst-type-0: SKIP (0.000s)
[505.935129] [126/134] (521s left) kms_plane (pixel-format-x-tiled-modifier)
[506.045500] Starting subtest: pixel-format-x-tiled-modifier
[506.070868] Starting dynamic subtest: pipe-A-plane-0
[506.703538] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[506.712489] Starting dynamic subtest: pipe-A-plane-3
[507.092362] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s)
[507.100571] Starting dynamic subtest: pipe-A-plane-5
[507.103775] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[508.152800] Starting dynamic subtest: pipe-B-plane-0
[508.768080] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[508.777698] Starting dynamic subtest: pipe-B-plane-3
[509.234203] Dynamic subtest pipe-B-plane-3: SUCCESS (0.466s)
[509.243065] Starting dynamic subtest: pipe-B-plane-5
[509.246553] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[509.554537] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.509s)
[510.449379] [127/134] (517s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[510.562164] Starting subtest: 4-tiled-16bpp-rotate-270
[510.581981] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[510.721355] [128/134] (517s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[510.827974] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[510.831543] Starting dynamic subtest: pipe-A-eDP-1
[510.855111] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[510.874307] Starting dynamic subtest: pipe-B-eDP-1
[510.895690] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[510.904172] Starting dynamic subtest: pipe-C-eDP-1
[510.924657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[510.932938] Starting dynamic subtest: pipe-D-eDP-1
[510.954315] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[510.958657] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[513.059164] [129/134] (514s left) sw_sync (timeline_closed)
[513.098049] Starting subtest: timeline_closed
[513.100244] Subtest timeline_closed: SUCCESS (0.000s)
[513.173366] [130/134] (514s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[513.274750] Starting subtest: x-tiled-8bpp-rotate-0
[514.467374] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.191s)
[514.610138] [131/134] (513s left) kms_vblank (wait-idle-hang)
[514.708517] Starting subtest: wait-idle-hang
[514.710331] Starting dynamic subtest: pipe-A-eDP-1
[541.650495] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.941s)
[541.664934] Starting dynamic subtest: pipe-D-eDP-1
[556.701900] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.049s)
[556.704278] Subtest wait-idle-hang: SUCCESS (41.995s)
[557.512178] [132/134] (470s left) sw_sync (timeline_closed_signaled)
[557.549498] Starting subtest: timeline_closed_signaled
[557.551522] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[557.626222] [133/134] (470s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[557.740533] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[557.744800] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[557.861882] [134/134] (470s left) kms_vblank (query-busy-hang)
[557.954338] Starting subtest: query-busy-hang
[557.956272] Starting dynamic subtest: pipe-A-eDP-1
[584.658791] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.702s)
[584.672765] Starting dynamic subtest: pipe-D-eDP-1
[609.677324] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.018s)
[609.679732] Subtest query-busy-hang: SUCCESS (51.725s)
[610.574778] 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.