[60.200554] Initializing watchdogs
[60.200603]   /dev/watchdog0
[60.214899] [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]
[60.219583] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.221688] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.223620] [001/134] (960s left) kms_flip (2x-flip-vs-wf_vblank)
[60.324711] Starting subtest: 2x-flip-vs-wf_vblank
[60.335822] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[60.442978] [002/134] (960s left) gem_ctx_persistence (file)
[60.496188] Starting subtest: file
[60.651501] Subtest file: SUCCESS (0.156s)
[60.799532] [003/134] (959s left) gem_readwrite (write-bad-handle)
[60.857777] Subtest write-bad-handle: SKIP (0.000s)
[60.921648] [004/134] (959s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[61.010729] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[61.049069] Starting dynamic subtest: pipe-A-plane-0
[61.050934] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[61.057129] Starting dynamic subtest: pipe-A-plane-3
[61.058867] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[61.064055] Starting dynamic subtest: pipe-A-plane-5
[61.065800] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[62.121473] Starting dynamic subtest: pipe-B-plane-0
[62.123234] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[62.128500] Starting dynamic subtest: pipe-B-plane-3
[62.130234] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[62.135404] Starting dynamic subtest: pipe-B-plane-5
[62.137153] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[62.434107] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.421s)
[63.303891] [005/134] (957s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[63.428082] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[64.429248] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.001s)
[65.241872] [006/134] (955s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[65.342790] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[72.399394] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.055s)
[72.571641] [007/134] (948s left) gem_userptr_blits (userfault)
[72.622508] Starting subtest: userfault
[72.625581] Subtest userfault: SUCCESS (0.005s)
[72.786047] [008/134] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[77.747054] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[77.747981] Starting dynamic subtest: pipe-A-eDP-1
[78.558066] Dynamic subtest pipe-A-eDP-1: SKIP (0.809s)
[78.564286] Starting dynamic subtest: pipe-B-eDP-1
[79.688987] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[79.690763] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.942s)
[80.875256] [009/134] (940s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[80.930199] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[80.976199] [010/134] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[81.072256] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[81.073962] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[81.186945] [011/134] (939s left) kms_psr (fbc-psr2-no-drrs)
[81.271081] Starting subtest: fbc-psr2-no-drrs
[81.272017] Starting dynamic subtest: eDP-1
[81.273716] Dynamic subtest eDP-1: SKIP (0.000s)
[81.275315] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[81.345374] [012/134] (939s left) gem_exec_schedule (u-submit-golden-slice)
[81.401127] Starting subtest: u-submit-golden-slice
[81.402067] Starting dynamic subtest: rcs0
[81.440524] Dynamic subtest rcs0: SUCCESS (0.039s)
[81.447168] Starting dynamic subtest: bcs0
[81.470244] Dynamic subtest bcs0: SUCCESS (0.030s)
[81.479585] Starting dynamic subtest: vcs0
[81.500414] Dynamic subtest vcs0: SUCCESS (0.030s)
[81.506818] Starting dynamic subtest: vcs1
[81.529749] Dynamic subtest vcs1: SUCCESS (0.029s)
[81.535985] Starting dynamic subtest: vecs0
[81.556830] Dynamic subtest vecs0: SUCCESS (0.027s)
[81.562795] Starting dynamic subtest: ccs0
[81.585520] Dynamic subtest ccs0: SUCCESS (0.028s)
[81.586358] Subtest u-submit-golden-slice: SUCCESS (0.185s)
[83.026873] [013/134] (938s left) gem_mmap_gtt (hang-busy)
[83.078945] Subtest hang-busy: SKIP (0.000s)
[83.141614] [014/134] (937s left) sysfs_timeslice_duration (idempotent)
[83.204230] Starting subtest: idempotent
[83.205085] Starting dynamic subtest: vecs0
[83.205921] Dynamic subtest vecs0: SUCCESS (0.000s)
[83.211963] Starting dynamic subtest: ccs0
[83.212828] Dynamic subtest ccs0: SUCCESS (0.000s)
[83.218337] Starting dynamic subtest: vcs0
[83.219143] Dynamic subtest vcs0: SUCCESS (0.000s)
[83.224603] Starting dynamic subtest: bcs0
[83.225474] Dynamic subtest bcs0: SUCCESS (0.000s)
[83.231855] Starting dynamic subtest: rcs0
[83.232690] Dynamic subtest rcs0: SUCCESS (0.000s)
[83.237715] Starting dynamic subtest: vcs1
[83.238581] Dynamic subtest vcs1: SUCCESS (0.000s)
[83.239437] Subtest idempotent: SUCCESS (0.004s)
[83.357961] [015/134] (937s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[83.455737] Starting subtest: fbc-1p-pri-indfb-multidraw
[96.680084] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.223s)
[98.085319] [016/134] (923s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[98.179738] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[98.181915] Starting dynamic subtest: A-eDP1
[101.796312] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[101.802660] Starting dynamic subtest: B-eDP1
[105.007602] Dynamic subtest B-eDP1: SUCCESS (3.211s)
[105.014563] Starting dynamic subtest: C-eDP1
[108.117923] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[108.124308] Starting dynamic subtest: D-eDP1
[111.208449] Dynamic subtest D-eDP1: SUCCESS (3.090s)
[111.210374] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.030s)
[112.010379] [017/134] (909s left) gem_exec_capture (userptr)
[112.064936] Starting subtest: userptr
[112.912733] Subtest userptr: SUCCESS (0.846s)
[113.049054] [018/134] (908s left) kms_hdr (invalid-metadata-sizes)
[113.145373] Starting subtest: invalid-metadata-sizes
[113.148045] Subtest invalid-metadata-sizes: SKIP (0.000s)
[113.220826] [019/134] (908s left) gem_mmap_offset (perf)
[113.275399] Starting subtest: perf
[113.276433] Starting dynamic subtest: smem0
[113.658311] Dynamic subtest smem0: SUCCESS (0.381s)
[113.659482] Subtest perf: SUCCESS (0.382s)
[113.794666] [020/134] (907s left) gem_exec_await (wide-contexts)
[114.017340] Starting subtest: wide-contexts
[137.664477] Subtest wide-contexts: SUCCESS (23.647s)
[137.856410] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[137.859692] [021/134] (883s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[137.986864] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[137.987966] Starting dynamic subtest: pipe-A-eDP-1
[137.996963] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.004681] Starting dynamic subtest: pipe-B-eDP-1
[138.013334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.020134] Starting dynamic subtest: pipe-C-eDP-1
[138.028509] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.034724] Starting dynamic subtest: pipe-D-eDP-1
[138.043351] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.044983] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[140.201322] [022/134] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[140.246398] Starting subtest: basic-x-tiled-legacy
[140.248345] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[140.400948] [023/134] (881s left) kms_feature_discovery (chamelium)
[140.499711] Starting subtest: chamelium
[140.501725] Subtest chamelium: SKIP (0.000s)
[140.575789] [024/134] (880s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[140.664599] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[140.665572] Starting dynamic subtest: pipe-A-default-mode
[141.847301] Dynamic subtest pipe-A-default-mode: SKIP (1.181s)
[141.848872] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.182s)
[142.010058] [025/134] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[142.105362] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[142.107075] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[142.220059] [026/134] (879s left) drm_read (empty-nonblock)
[142.385132] Starting subtest: empty-nonblock
[142.386220] Subtest empty-nonblock: SUCCESS (0.000s)
[142.537868] [027/134] (878s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[142.635748] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[143.416553] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[143.574636] [028/134] (877s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[143.673030] Starting subtest: y-tiled-32bpp-rotate-270
[143.674918] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[143.767904] [029/134] (877s left) kms_plane_scaling (intel-max-src-size)
[143.866940] Starting subtest: intel-max-src-size
[143.869885] Subtest intel-max-src-size: SKIP (0.000s)
[143.979267] [030/134] (877s left) gem_mmap_wc (read-write)
[144.033030] Subtest read-write: SKIP (0.000s)
[144.088806] [031/134] (877s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[144.184782] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[145.185504] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.001s)
[145.326901] [032/134] (876s left) kms_psr2_su (frontbuffer-xrgb8888)
[145.374923] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[145.428886] [033/134] (876s left) gen9_exec_parse (shadow-peek)
[145.476867] Subtest shadow-peek: SKIP (0.000s)
[145.535212] [034/134] (876s left) gem_exec_schedule (smoketest)
[145.722119] Starting subtest: smoketest
[145.723401] Starting dynamic subtest: rcs0
[151.234961] Dynamic subtest rcs0: SUCCESS (5.479s)
[151.247735] Starting dynamic subtest: bcs0
[156.772308] Dynamic subtest bcs0: SUCCESS (5.550s)
[156.779854] Starting dynamic subtest: vcs0
[162.269892] Dynamic subtest vcs0: SUCCESS (5.496s)
[162.278117] Starting dynamic subtest: vcs1
[167.774097] Dynamic subtest vcs1: SUCCESS (5.503s)
[167.786341] Starting dynamic subtest: vecs0
[173.285934] Dynamic subtest vecs0: SUCCESS (5.509s)
[173.293945] Starting dynamic subtest: ccs0
[178.771679] Dynamic subtest ccs0: SUCCESS (5.486s)
[178.772535] Subtest smoketest: SUCCESS (33.029s)
[179.004335] [035/134] (842s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[179.102041] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[179.102974] Starting dynamic subtest: pipe-A-eDP-1
[179.124706] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[179.132228] Starting dynamic subtest: pipe-B-eDP-1
[179.153414] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[179.159894] Starting dynamic subtest: pipe-C-eDP-1
[179.181075] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[179.188259] Starting dynamic subtest: pipe-D-eDP-1
[179.210598] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[179.212294] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[181.382187] [036/134] (840s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[181.473398] Starting subtest: 2x-flip-vs-modeset-vs-hang
[181.483613] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[181.572516] [037/134] (840s left) kms_psr (psr2-cursor-mmap-cpu)
[181.664349] Starting subtest: psr2-cursor-mmap-cpu
[181.665266] Starting dynamic subtest: eDP-1
[183.364550] Dynamic subtest eDP-1: SUCCESS (1.700s)
[183.365444] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.701s)
[184.171946] [038/134] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[184.268640] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[184.270322] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[184.402811] [039/134] (837s left) syncobj_wait (reset-during-wait-for-submit)
[184.451366] Starting subtest: reset-during-wait-for-submit
[184.556942] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[184.637440] [040/134] (837s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[185.208522] Starting subtest: syncobj-timeline-multiple-ext-nodes
[185.211732] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[187.026292] [041/134] (834s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[187.131463] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[187.142719] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[187.239281] [042/134] (834s left) i915_pm_rpm (debugfs-read)
[189.066972] Starting subtest: debugfs-read
[190.227330] Subtest debugfs-read: SUCCESS (1.159s)
[190.602768] [043/134] (831s left) gem_pxp (protected-raw-src-copy-not-readible)
[190.717487] Starting subtest: protected-raw-src-copy-not-readible
[190.777460] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[190.925215] [044/134] (831s left) gem_exec_schedule (implicit-read-write)
[190.997042] Starting subtest: implicit-read-write
[190.998065] Starting dynamic subtest: rcs0
[191.140755] Dynamic subtest rcs0: SUCCESS (0.143s)
[191.150928] Starting dynamic subtest: vcs0
[191.218971] Dynamic subtest vcs0: SUCCESS (0.078s)
[191.228486] Starting dynamic subtest: vcs1
[191.299454] Dynamic subtest vcs1: SUCCESS (0.079s)
[191.309308] Starting dynamic subtest: vecs0
[191.375604] Dynamic subtest vecs0: SUCCESS (0.075s)
[191.385413] Starting dynamic subtest: ccs0
[191.455850] Dynamic subtest ccs0: SUCCESS (0.080s)
[191.457307] Subtest implicit-read-write: SUCCESS (0.459s)
[193.035229] [045/134] (829s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[193.132308] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[193.134653] Starting dynamic subtest: A-eDP1
[196.707719] Dynamic subtest A-eDP1: SUCCESS (3.572s)
[196.715174] Starting dynamic subtest: B-eDP1
[199.894848] Dynamic subtest B-eDP1: SUCCESS (3.186s)
[199.902094] Starting dynamic subtest: C-eDP1
[203.108094] Dynamic subtest C-eDP1: SUCCESS (3.212s)
[203.115565] Starting dynamic subtest: D-eDP1
[206.247928] Dynamic subtest D-eDP1: SUCCESS (3.139s)
[206.249856] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.117s)
[207.054485] [046/134] (815s left) gem_exec_create (madvise)
[207.110611] Starting subtest: madvise
[207.111638] Starting dynamic subtest: smem
[229.017188] Dynamic subtest smem: SUCCESS (21.903s)
[229.018590] Subtest madvise: SUCCESS (21.904s)
[229.988167] [047/134] (792s left) gem_exec_reloc (basic-gtt-read-noreloc)
[230.037997] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[230.118384] [048/134] (792s left) syncobj_timeline (etime-single-wait-all-submitted)
[230.170833] Starting subtest: etime-single-wait-all-submitted
[230.273853] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[230.358151] [049/134] (791s left) kms_selftest (drm_dp_mst_helper)
[230.391819] Starting subtest: drm_dp_mst_helper
[230.449356] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[230.588227] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.139s)
[230.597431] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[230.722169] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.134s)
[230.729846] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[230.805427] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.082s)
[230.806305] Subtest drm_dp_mst_helper: SUCCESS (0.413s)
[230.990315] [050/134] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[231.083877] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[239.628802] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.545s)
[239.760701] [051/134] (782s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[239.846407] Starting subtest: flip-vs-dpms-on-nop-interruptible
[239.848667] Starting dynamic subtest: A-eDP1
[241.737856] Dynamic subtest A-eDP1: SUCCESS (1.889s)
[241.747208] Starting dynamic subtest: B-eDP1
[243.576096] Dynamic subtest B-eDP1: SUCCESS (1.837s)
[243.586709] Starting dynamic subtest: C-eDP1
[245.479702] Dynamic subtest C-eDP1: SUCCESS (1.901s)
[245.487798] Starting dynamic subtest: D-eDP1
[247.311230] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[247.314320] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.466s)
[248.495828] [052/134] (773s left) gem_exec_balancer (parallel-keep-in-fence)
[248.744041] Starting subtest: parallel-keep-in-fence
[249.858976] Subtest parallel-keep-in-fence: SUCCESS (1.115s)
[249.982857] [053/134] (772s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[250.065075] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[250.065913] Starting dynamic subtest: pipe-A-eDP-1
[250.130935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[250.139710] Starting dynamic subtest: pipe-B-eDP-1
[250.191678] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[250.199996] Starting dynamic subtest: pipe-C-eDP-1
[250.253850] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[250.262092] Starting dynamic subtest: pipe-D-eDP-1
[250.314967] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[250.315864] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.251s)
[252.482175] [054/134] (769s left) kms_cursor_legacy (torture-bo)
[252.632790] Starting subtest: torture-bo
[252.633638] Starting dynamic subtest: pipe-A
[258.460595] Dynamic subtest pipe-A: SUCCESS (5.866s)
[258.467615] Starting dynamic subtest: pipe-B
[265.876485] Dynamic subtest pipe-B: SUCCESS (7.411s)
[265.886159] Starting dynamic subtest: pipe-C
[272.445899] Dynamic subtest pipe-C: SUCCESS (6.568s)
[272.455866] Starting dynamic subtest: pipe-D
[279.378819] Dynamic subtest pipe-D: SUCCESS (6.929s)
[279.388445] Starting dynamic subtest: all-pipes
[285.187572] Dynamic subtest all-pipes: SUCCESS (5.805s)
[285.188890] Subtest torture-bo: SUCCESS (32.590s)
[285.351897] [055/134] (737s left) gem_mmap (bad-offset)
[285.405314] Subtest bad-offset: SKIP (0.000s)
[285.469433] [056/134] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[285.562618] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[292.903075] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.341s)
[293.064433] [057/134] (729s left) syncobj_timeline (single-wait-signaled)
[293.130772] Starting subtest: single-wait-signaled
[293.131665] Subtest single-wait-signaled: SUCCESS (0.000s)
[293.256969] [058/134] (729s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[298.285839] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[298.289962] Starting dynamic subtest: pipe-A-eDP-1
[299.071074] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s)
[299.079549] Starting dynamic subtest: pipe-B-eDP-1
[300.217203] Dynamic subtest pipe-B-eDP-1: SKIP (1.144s)
[300.218869] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.931s)
[301.402904] [059/134] (721s left) kms_flip (plain-flip-fb-recreate)
[301.496558] Starting subtest: plain-flip-fb-recreate
[301.498681] Starting dynamic subtest: A-eDP1
[310.396057] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[310.405061] Starting dynamic subtest: B-eDP1
[319.228572] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[319.237072] Starting dynamic subtest: C-eDP1
[328.053934] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[328.064074] Starting dynamic subtest: D-eDP1
[336.892091] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[336.894404] Subtest plain-flip-fb-recreate: SUCCESS (35.396s)
[338.094718] [060/134] (684s left) perf (gen12-mi-rpc)
[338.223914] Starting subtest: gen12-mi-rpc
[338.224801] Starting dynamic subtest: rcs0
[338.242435] Dynamic subtest rcs0: SUCCESS (0.018s)
[338.243362] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[338.281426] [061/134] (684s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[338.413218] Starting subtest: plane-lut1d-pre-ctm3x4
[338.427315] Starting dynamic subtest: pipe-A-eDP-1
[338.878748] Dynamic subtest pipe-A-eDP-1: FAIL (0.301s)
[339.763057] Starting dynamic subtest: pipe-B-eDP-1
[340.272927] Dynamic subtest pipe-B-eDP-1: FAIL (0.322s)
[341.188185] Starting dynamic subtest: pipe-C-eDP-1
[341.661921] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[342.519968] Starting dynamic subtest: pipe-D-eDP-1
[342.958800] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[343.055897] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.642s)
[343.922137] [062/134] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[344.023502] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[353.466390] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.442s)
[353.605394] [063/134] (669s left) i915_pm_freq_api (freq-basic-api)
[353.675379] Starting subtest: freq-basic-api
[353.676374] Starting dynamic subtest: gt0
[353.678667] Dynamic subtest gt0: SUCCESS (0.003s)
[353.686491] Starting dynamic subtest: gt1
[353.687410] Dynamic subtest gt1: SUCCESS (0.003s)
[353.688285] Subtest freq-basic-api: SUCCESS (0.007s)
[353.766754] [064/134] (668s left) kms_cursor_crc (cursor-offscreen-32x10)
[353.931915] Starting subtest: cursor-offscreen-32x10
[353.971780] Subtest cursor-offscreen-32x10: SKIP (0.038s)
[354.250364] [065/134] (668s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[354.347733] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[354.349494] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[354.439163] [066/134] (668s left) kms_cdclk (mode-transition-all-outputs)
[354.537983] Starting subtest: mode-transition-all-outputs
[354.838374] Subtest mode-transition-all-outputs: SKIP (0.299s)
[355.654167] [067/134] (667s left) gem_ctx_param (invalid-set-no-zeromap)
[355.713703] Starting subtest: invalid-set-no-zeromap
[355.714775] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[355.793592] [068/134] (667s left) gen9_exec_parse (bb-secure)
[355.851852] Subtest bb-secure: SKIP (0.000s)
[355.914559] [069/134] (667s left) gem_render_copy (y-tiled-ccs-to-linear)
[355.982651] Starting subtest: y-tiled-ccs-to-linear
[355.984662] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[356.174405] [070/134] (666s left) kms_panel_fitting (atomic-fastset)
[356.264808] Starting subtest: atomic-fastset
[356.265804] Starting dynamic subtest: pipe-A-eDP-1
[356.427210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s)
[356.436109] Starting dynamic subtest: pipe-B-eDP-1
[357.622865] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.195s)
[357.630285] Starting dynamic subtest: pipe-C-eDP-1
[358.809436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s)
[358.817445] Starting dynamic subtest: pipe-D-eDP-1
[359.956205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[359.957056] Subtest atomic-fastset: SUCCESS (3.693s)
[361.219780] [071/134] (661s left) syncobj_timeline (invalid-transfer-non-existent-point)
[361.272872] Starting subtest: invalid-transfer-non-existent-point
[361.273816] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[361.396519] [072/134] (661s left) api_intel_bb (render)
[361.448924] Starting subtest: render
[361.449869] Starting dynamic subtest: render-none-512
[361.548070] Dynamic subtest render-none-512: SUCCESS (0.099s)
[361.557273] Starting dynamic subtest: render-none-1024
[361.923708] Dynamic subtest render-none-1024: SUCCESS (0.373s)
[361.932739] Starting dynamic subtest: render-x-512
[362.007030] Dynamic subtest render-x-512: SUCCESS (0.084s)
[362.016125] Starting dynamic subtest: render-x-1024
[362.355714] Dynamic subtest render-x-1024: SUCCESS (0.346s)
[362.364746] Starting dynamic subtest: render-y-512
[362.439069] Dynamic subtest render-y-512: SUCCESS (0.084s)
[362.448110] Starting dynamic subtest: render-y-1024
[362.959381] Dynamic subtest render-y-1024: SUCCESS (0.517s)
[362.960621] Subtest render: SUCCESS (1.510s)
[363.101933] [073/134] (659s left) gem_blits (basic)
[363.155778] Starting subtest: basic
[364.849899] Subtest basic: SUCCESS (1.692s)
[364.986558] [074/134] (658s left) api_intel_bb (blit-noreloc-keep-cache)
[365.038288] Starting subtest: blit-noreloc-keep-cache
[365.048810] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s)
[365.191336] [075/134] (657s left) prime_vgem (busy)
[365.262121] Starting subtest: busy
[365.263053] Starting dynamic subtest: rcs0
[365.332917] Dynamic subtest rcs0: SUCCESS (0.070s)
[365.342429] Starting dynamic subtest: bcs0
[365.414423] Dynamic subtest bcs0: SUCCESS (0.080s)
[365.423035] Starting dynamic subtest: vcs0
[365.463658] Dynamic subtest vcs0: SUCCESS (0.047s)
[365.470464] Starting dynamic subtest: vcs1
[365.510103] Dynamic subtest vcs1: SUCCESS (0.046s)
[365.516872] Starting dynamic subtest: vecs0
[365.558516] Dynamic subtest vecs0: SUCCESS (0.048s)
[365.565752] Starting dynamic subtest: ccs0
[365.603236] Dynamic subtest ccs0: SUCCESS (0.044s)
[365.605300] Subtest busy: SUCCESS (0.342s)
[365.756777] [076/134] (657s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[365.853099] Starting subtest: coverage-vs-premult-vs-constant
[366.138338] Starting dynamic subtest: pipe-A-eDP-1
[366.679530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[366.686688] Starting dynamic subtest: pipe-D-eDP-1
[368.020072] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[368.020921] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.168s)
[368.883050] [077/134] (654s left) kms_rotation_crc (cursor-rotation-180)
[368.976294] Starting subtest: cursor-rotation-180
[370.445706] Subtest cursor-rotation-180: SUCCESS (1.470s)
[371.659956] [078/134] (651s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[371.777505] Starting subtest: basic-flip-after-cursor-atomic
[372.689327] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.911s)
[373.494145] [079/134] (649s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[373.546700] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[373.548466] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[373.734152] [080/134] (649s left) kms_flip_scaled_crc (flip-nv12-linear-to-nv12-linear-reflect-x)
[373.818320] Starting subtest: flip-NV12-linear-to-NV12-linear-reflect-x
[373.819227] Starting dynamic subtest: pipe-A-default-mode
[374.946644] Dynamic subtest pipe-A-default-mode: SKIP (1.126s)
[374.948533] Subtest flip-NV12-linear-to-NV12-linear-reflect-x: SKIP (1.127s)
[375.112255] [081/134] (648s left) kms_lease (setcrtc-implicit-plane)
[375.200044] Starting subtest: setcrtc-implicit-plane
[375.200999] Starting dynamic subtest: pipe-A-eDP-1
[375.669418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s)
[375.676598] Starting dynamic subtest: pipe-B-eDP-1
[376.784990] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.114s)
[376.795337] Starting dynamic subtest: pipe-C-eDP-1
[377.875260] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.086s)
[377.882439] Starting dynamic subtest: pipe-D-eDP-1
[379.013433] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[379.014262] Subtest setcrtc-implicit-plane: SUCCESS (3.815s)
[379.863481] [082/134] (643s left) gem_exec_balancer (bonded-chain)
[379.916622] Starting subtest: bonded-chain
[386.893214] Subtest bonded-chain: SUCCESS (6.974s)
[387.227333] [083/134] (636s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[387.313165] Starting subtest: fbc-psr-sprite-mmap-cpu
[387.314040] Starting dynamic subtest: eDP-1
[387.315732] Dynamic subtest eDP-1: SKIP (0.000s)
[387.317365] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[387.395230] [084/134] (636s left) gem_exec_params (invalid-batch-start-offset)
[387.441264] Starting subtest: invalid-batch-start-offset
[387.443577] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[387.584320] [085/134] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[387.680594] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[394.151122] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.471s)
[394.270901] [086/134] (629s left) kms_psr (psr2-no-drrs)
[394.378565] Starting subtest: psr2-no-drrs
[394.379471] Starting dynamic subtest: eDP-1
[395.965687] Dynamic subtest eDP-1: SUCCESS (1.586s)
[395.966500] Subtest psr2-no-drrs: SUCCESS (1.587s)
[396.785463] [087/134] (626s left) kms_plane_scaling (planes-upscale-factor-0-25)
[396.872068] Starting subtest: planes-upscale-factor-0-25
[396.872872] Starting dynamic subtest: pipe-A
[396.933529] Dynamic subtest pipe-A: SUCCESS (0.062s)
[396.940966] Starting dynamic subtest: pipe-B
[398.103104] Dynamic subtest pipe-B: SUCCESS (1.168s)
[398.113458] Starting dynamic subtest: pipe-C
[399.209870] Dynamic subtest pipe-C: SUCCESS (1.106s)
[399.217067] Starting dynamic subtest: pipe-D
[400.340922] Dynamic subtest pipe-D: SUCCESS (1.130s)
[400.341824] Subtest planes-upscale-factor-0-25: SUCCESS (3.470s)
[401.507279] [088/134] (622s left) i915_query (test-query-geometry-subslices)
[401.552076] Starting subtest: test-query-geometry-subslices
[401.552903] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[401.666671] [089/134] (621s left) gem_spin_batch (resubmit-new-all)
[401.727664] Starting subtest: resubmit-new-all
[401.728556] Starting dynamic subtest: rcs0
[401.739228] Dynamic subtest rcs0: SUCCESS (0.012s)
[401.748552] Starting dynamic subtest: bcs0
[401.749426] Dynamic subtest bcs0: SUCCESS (0.009s)
[401.756405] Starting dynamic subtest: vcs0
[401.758398] Dynamic subtest vcs0: SUCCESS (0.009s)
[401.765258] Starting dynamic subtest: vcs1
[401.767847] Dynamic subtest vcs1: SUCCESS (0.009s)
[401.774836] Starting dynamic subtest: vecs0
[401.777558] Dynamic subtest vecs0: SUCCESS (0.009s)
[401.784473] Starting dynamic subtest: ccs0
[401.787219] Dynamic subtest ccs0: SUCCESS (0.009s)
[401.788069] Subtest resubmit-new-all: SUCCESS (0.062s)
[402.949766] [090/134] (620s left) prime_vgem (basic-fence-mmap)
[403.020456] Starting subtest: basic-fence-mmap
[403.022062] Subtest basic-fence-mmap: SKIP (0.000s)
[403.148053] [091/134] (620s left) i915_query (query-topology-matches-eu-total)
[403.210304] Starting subtest: query-topology-matches-eu-total
[403.211272] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[403.325354] [092/134] (620s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[403.451023] Starting subtest: flip-vs-cursor-legacy
[410.620588] Subtest flip-vs-cursor-legacy: SUCCESS (7.170s)
[411.450184] [093/134] (612s left) perf_pmu (invalid-init)
[411.496165] Starting subtest: invalid-init
[411.497118] Subtest invalid-init: SUCCESS (0.000s)
[411.624448] [094/134] (612s left) sw_sync (sync_multi_producer_single_consumer)
[411.665304] Starting subtest: sync_multi_producer_single_consumer
[412.743835] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[412.821886] [095/134] (610s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[412.942917] Starting subtest: short-flip-after-cursor-toggle
[413.865557] Subtest short-flip-after-cursor-toggle: SUCCESS (0.921s)
[414.685640] [096/134] (609s left) gem_exec_params (secure-non-master)
[414.750114] Starting subtest: secure-non-master
[414.752051] Subtest secure-non-master: SKIP (0.000s)
[414.875750] [097/134] (608s left) gem_ctx_shared (q-independent)
[414.938573] Starting subtest: Q-independent
[414.939547] Starting dynamic subtest: rcs0
[415.007685] Dynamic subtest rcs0: SUCCESS (0.068s)
[415.016868] Starting dynamic subtest: vcs0
[415.047839] Dynamic subtest vcs0: SUCCESS (0.040s)
[415.056253] Starting dynamic subtest: vcs1
[415.090065] Dynamic subtest vcs1: SUCCESS (0.042s)
[415.098870] Starting dynamic subtest: vecs0
[415.134406] Dynamic subtest vecs0: SUCCESS (0.041s)
[415.142705] Starting dynamic subtest: ccs0
[415.175267] Dynamic subtest ccs0: SUCCESS (0.042s)
[415.176193] Subtest Q-independent: SUCCESS (0.237s)
[417.056677] [098/134] (606s left) gem_exec_reloc (basic-wc-cpu)
[417.121214] Subtest basic-wc-cpu: SKIP (0.000s)
[417.204407] [099/134] (606s left) prime_mmap (test_userptr)
[417.257922] Starting subtest: test_userptr
[417.258936] Starting dynamic subtest: test_userptr-smem
[417.259923] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[417.260875] Subtest test_userptr: SUCCESS (0.001s)
[417.377883] [100/134] (606s left) kms_async_flips (test-cursor-atomic)
[417.473647] Starting subtest: test-cursor-atomic
[417.475235] Subtest test-cursor-atomic: SKIP (0.000s)
[418.742787] [101/134] (605s left) gem_exec_whisper (basic-sync-all)
[418.799160] Starting subtest: basic-sync-all
[425.074319] Subtest basic-sync-all: SUCCESS (6.274s)
[425.268799] [102/134] (598s left) kms_pm_rpm (legacy-planes)
[427.085090] Starting subtest: legacy-planes
[427.086894] Starting dynamic subtest: plane-64
[435.364528] Dynamic subtest plane-64: SUCCESS (8.278s)
[435.376402] Starting dynamic subtest: plane-94
[443.668906] Dynamic subtest plane-94: SUCCESS (8.302s)
[443.679983] Starting dynamic subtest: plane-124
[451.971261] Dynamic subtest plane-124: SUCCESS (8.299s)
[451.986213] Starting dynamic subtest: plane-134
[460.354389] Dynamic subtest plane-134: SUCCESS (8.379s)
[460.355734] Subtest legacy-planes: SUCCESS (33.270s)
[460.735377] [103/134] (563s left) syncobj_timeline (reset-during-wait-for-submit)
[460.790940] Starting subtest: reset-during-wait-for-submit
[460.893392] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[460.988310] [104/134] (563s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[461.108961] Starting subtest: cursorA-vs-flipA-toggle
[472.234394] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.124s)
[473.046113] [105/134] (551s left) syncobj_basic (bad-destroy)
[473.100073] Starting subtest: bad-destroy
[473.101086] Subtest bad-destroy: SUCCESS (0.000s)
[473.198204] [106/134] (550s left) kms_cursor_crc (cursor-tearing-position-change)
[473.309473] Starting subtest: cursor-tearing-position-change
[473.311897] Starting dynamic subtest: pipe-A-eDP-1
[473.885285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[473.892858] Starting dynamic subtest: pipe-D-eDP-1
[475.068862] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s)
[475.069772] Subtest cursor-tearing-position-change: SUCCESS (1.759s)
[475.907644] [107/134] (548s left) kms_chamelium_frames (hdmi-crc-fast)
[476.311288] Subtest hdmi-crc-fast: SKIP (0.000s)
[477.097643] [108/134] (547s left) gem_close_race (multigpu-basic-process)
[477.162467] Starting subtest: multigpu-basic-process
[477.164364] Subtest multigpu-basic-process: SKIP (0.000s)
[477.417119] [109/134] (546s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[477.561071] Starting subtest: cursor-rapid-movement-32x32
[477.600297] Subtest cursor-rapid-movement-32x32: SKIP (0.038s)
[477.886788] [110/134] (546s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[477.982843] Starting subtest: psr-rgb565-draw-blt
[484.929824] Subtest psr-rgb565-draw-blt: SUCCESS (6.946s)
[485.080272] [111/134] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[485.173554] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[485.175395] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[485.303698] [112/134] (539s left) kms_prop_blob (basic)
[485.357187] Starting subtest: basic
[485.358233] Subtest basic: SUCCESS (0.000s)
[485.465656] [113/134] (538s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[485.844899] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[486.681484] [114/134] (537s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[486.783344] Starting subtest: crc-primary-suspend-y-tiled-ccs
[486.784219] Starting dynamic subtest: pipe-A-eDP-1
[486.787654] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.795689] Starting dynamic subtest: pipe-B-eDP-1
[486.799056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.806533] Starting dynamic subtest: pipe-C-eDP-1
[486.809855] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.817376] Starting dynamic subtest: pipe-D-eDP-1
[486.820681] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.822381] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[489.064782] [115/134] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[489.162322] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[489.164063] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[489.286614] [116/134] (535s left) dmabuf_sync_file (export-multiwait)
[489.321790] Starting subtest: export-multiwait
[489.322707] Subtest export-multiwait: SUCCESS (0.000s)
[489.409635] [117/134] (535s left) kms_atomic_interruptible (legacy-cursor)
[489.507295] Starting subtest: legacy-cursor
[489.508150] Starting dynamic subtest: pipe-A-eDP-1
[496.900491] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.392s)
[496.901405] Subtest legacy-cursor: SUCCESS (7.395s)
[497.737093] [118/134] (526s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[497.834868] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[497.836533] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[497.937378] [119/134] (526s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[498.039122] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[498.040742] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[498.159178] [120/134] (526s left) perf (low-oa-exponent-permissions)
[498.253089] Starting subtest: low-oa-exponent-permissions
[498.286796] Subtest low-oa-exponent-permissions: SUCCESS (0.034s)
[498.322088] [121/134] (526s left) perf_pmu (semaphore-wait-idle)
[498.353636] Starting subtest: semaphore-wait-idle
[498.354612] Starting dynamic subtest: rcs0
[498.870419] Dynamic subtest rcs0: SUCCESS (0.513s)
[498.881429] Starting dynamic subtest: bcs0
[499.383859] Dynamic subtest bcs0: SUCCESS (0.510s)
[499.393747] Starting dynamic subtest: vcs0
[499.896800] Dynamic subtest vcs0: SUCCESS (0.510s)
[499.906481] Starting dynamic subtest: vcs1
[500.409752] Dynamic subtest vcs1: SUCCESS (0.510s)
[500.419529] Starting dynamic subtest: vecs0
[500.923963] Dynamic subtest vecs0: SUCCESS (0.511s)
[500.935421] Starting dynamic subtest: ccs0
[501.440146] Dynamic subtest ccs0: SUCCESS (0.513s)
[501.441780] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[503.017949] [122/134] (521s left) kms_joiner (invalid-modeset-ultra-joiner)
[503.133857] Starting subtest: invalid-modeset-ultra-joiner
[503.135714] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[503.236160] [123/134] (521s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[503.277876] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[503.387063] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[503.467439] [124/134] (521s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[503.565589] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[503.567302] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[503.700472] [125/134] (521s left) kms_content_protection (dp-mst-type-0)
[503.839845] Starting subtest: dp-mst-type-0
[503.842066] Subtest dp-mst-type-0: SKIP (0.000s)
[503.982870] [126/134] (520s left) kms_plane (pixel-format-x-tiled-modifier)
[504.071321] Starting subtest: pixel-format-x-tiled-modifier
[504.098665] Starting dynamic subtest: pipe-A-plane-0
[504.676583] Dynamic subtest pipe-A-plane-0: SUCCESS (0.578s)
[504.692827] Starting dynamic subtest: pipe-A-plane-3
[505.109539] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[505.117638] Starting dynamic subtest: pipe-A-plane-5
[505.119481] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[506.219787] Starting dynamic subtest: pipe-B-plane-0
[506.823795] Dynamic subtest pipe-B-plane-0: SUCCESS (0.611s)
[506.831491] Starting dynamic subtest: pipe-B-plane-3
[507.190441] Dynamic subtest pipe-B-plane-3: SUCCESS (0.366s)
[507.198179] Starting dynamic subtest: pipe-B-plane-5
[507.199884] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[507.496951] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.427s)
[508.295132] [127/134] (516s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[508.408556] Starting subtest: 4-tiled-16bpp-rotate-270
[508.430044] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[508.573555] [128/134] (516s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[508.656456] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[508.657417] Starting dynamic subtest: pipe-A-eDP-1
[508.666102] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[508.674332] Starting dynamic subtest: pipe-B-eDP-1
[508.683257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[508.691203] Starting dynamic subtest: pipe-C-eDP-1
[508.699924] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[508.707650] Starting dynamic subtest: pipe-D-eDP-1
[508.716501] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[508.718268] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[510.876859] [129/134] (514s left) sw_sync (timeline_closed)
[510.912871] Starting subtest: timeline_closed
[510.913763] Subtest timeline_closed: SUCCESS (0.000s)
[510.986301] [130/134] (513s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[511.087284] Starting subtest: x-tiled-8bpp-rotate-0
[512.269056] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.182s)
[512.437841] [131/134] (512s left) kms_vblank (wait-idle-hang)
[512.539261] Starting subtest: wait-idle-hang
[512.540160] Starting dynamic subtest: pipe-A-eDP-1
[538.708055] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.166s)
[538.718216] Starting dynamic subtest: pipe-D-eDP-1
[563.738785] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[563.739752] Subtest wait-idle-hang: SUCCESS (51.197s)
[564.540912] [132/134] (460s left) sw_sync (timeline_closed_signaled)
[564.569072] Starting subtest: timeline_closed_signaled
[564.569951] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[564.643794] [133/134] (460s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[564.729605] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[564.731199] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[564.855976] [134/134] (460s left) kms_vblank (query-busy-hang)
[564.947144] Starting subtest: query-busy-hang
[564.947980] Starting dynamic subtest: pipe-A-eDP-1
[591.746968] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.797s)
[591.757110] Starting dynamic subtest: pipe-D-eDP-1
[616.737661] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.986s)
[616.738489] Subtest query-busy-hang: SUCCESS (51.788s)
[617.598558] 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.