[56.630824] Initializing watchdogs
[56.630869]   /dev/watchdog0
[56.644193] [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]
[56.648334] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.650461] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.653845] [001/131] (960s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[56.795654] Starting subtest: 4-tiled-32bpp-rotate-270
[56.827364] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.030s)
[56.946394] [002/131] (960s left) kms_rotation_crc (multiplane-rotation)
[57.041147] Starting subtest: multiplane-rotation
[74.367452] Subtest multiplane-rotation: SUCCESS (17.326s)
[74.516242] [003/131] (942s left) perf (invalid-oa-metric-set-id)
[74.656200] Starting subtest: invalid-oa-metric-set-id
[74.666215] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[74.708799] [004/131] (942s left) syncobj_wait (wait-any-snapshot)
[74.769063] Starting subtest: wait-any-snapshot
[74.848936] Subtest wait-any-snapshot: SUCCESS (0.081s)
[74.943176] [005/131] (942s left) kms_psr (fbc-psr2-primary-blt)
[75.041542] Starting subtest: fbc-psr2-primary-blt
[75.043464] Starting dynamic subtest: eDP-1
[75.047141] Dynamic subtest eDP-1: SKIP (0.000s)
[75.050913] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[75.132391] [006/131] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[80.106559] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[80.108928] Starting dynamic subtest: pipe-A-eDP-1
[92.142930] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.034s)
[92.151266] Starting dynamic subtest: pipe-B-eDP-1
[104.170944] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.025s)
[104.173323] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.064s)
[105.052292] [007/131] (912s left) i915_pm_rc6_residency (media-rc6-accuracy)
[105.119195] Starting subtest: media-rc6-accuracy
[105.123742] Subtest media-rc6-accuracy: SKIP (0.000s)
[105.229990] [008/131] (912s left) core_getversion (basic)
[105.271439] Starting subtest: basic
[105.276155] Subtest basic: SUCCESS (0.000s)
[105.364347] [009/131] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[105.457604] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[105.461805] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[105.599040] [010/131] (911s left) kms_debugfs (display-off-read-all)
[105.694305] Starting subtest: display-off-read-all
[105.981694] Subtest display-off-read-all: SUCCESS (0.288s)
[106.800109] [011/131] (910s left) syncobj_timeline (host-signal-points)
[106.855370] Starting subtest: host-signal-points
[106.857627] Subtest host-signal-points: SUCCESS (0.004s)
[106.977672] [012/131] (910s left) gem_exec_store (basic)
[107.052561] Starting subtest: basic
[107.175616] Subtest basic: SUCCESS (0.125s)
[107.380630] [013/131] (910s left) gem_exec_flush (basic-wb-rw-default)
[107.444942] Starting subtest: basic-wb-rw-default
[112.904255] Subtest basic-wb-rw-default: SUCCESS (5.460s)
[113.109267] [014/131] (904s left) vgem_basic (setversion)
[113.188023] Starting subtest: setversion
[113.192489] Subtest setversion: SUCCESS (0.000s)
[113.262195] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[113.265748] [015/131] (904s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[113.313917] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[113.418783] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[113.520825] [016/131] (904s left) kms_legacy_colorkey (basic)
[113.615401] Starting subtest: basic
[113.617815] Starting dynamic subtest: pipe-A
[113.660746] Dynamic subtest pipe-A: SUCCESS (0.045s)
[113.670683] Starting dynamic subtest: pipe-B
[113.673055] Dynamic subtest pipe-B: SUCCESS (0.001s)
[113.679807] Starting dynamic subtest: pipe-C
[113.682055] Dynamic subtest pipe-C: SUCCESS (0.000s)
[113.688726] Starting dynamic subtest: pipe-D
[113.690626] Dynamic subtest pipe-D: SUCCESS (0.000s)
[113.692548] Subtest basic: SUCCESS (0.049s)
[113.752440] [017/131] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[113.858604] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[117.827610] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.973s)
[118.997603] [018/131] (898s left) kms_rmfb (close-fd)
[119.089102] Starting subtest: close-fd
[119.091304] Starting dynamic subtest: pipe-A-eDP-1
[119.196182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[119.204925] Starting dynamic subtest: pipe-B-eDP-1
[120.324284] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[120.332691] Starting dynamic subtest: pipe-C-eDP-1
[121.452955] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[121.461456] Starting dynamic subtest: pipe-D-eDP-1
[122.591656] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[122.593794] Subtest close-fd: SUCCESS (3.504s)
[123.825835] [019/131] (894s left) kms_atomic_interruptible (legacy-dpms)
[123.924401] Starting subtest: legacy-dpms
[123.927053] Starting dynamic subtest: pipe-A-eDP-1
[131.333397] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.412s)
[131.335719] Subtest legacy-dpms: SUCCESS (7.413s)
[132.176364] [020/131] (885s left) gem_ctx_persistence (legacy-engines-hostile)
[132.248970] Starting subtest: legacy-engines-hostile
[132.251292] Starting dynamic subtest: render
[132.372981] Dynamic subtest render: SUCCESS (0.124s)
[132.383585] Starting dynamic subtest: bsd1
[132.452534] Dynamic subtest bsd1: SUCCESS (0.077s)
[132.461595] Starting dynamic subtest: bsd2
[132.588861] Dynamic subtest bsd2: SUCCESS (0.134s)
[132.599178] Starting dynamic subtest: blt
[132.704035] Dynamic subtest blt: SUCCESS (0.112s)
[132.714147] Starting dynamic subtest: vebox
[132.825223] Dynamic subtest vebox: SUCCESS (0.119s)
[132.828050] Subtest legacy-engines-hostile: SUCCESS (0.577s)
[132.926890] [021/131] (884s left) gem_exec_whisper (basic-queues-forked-all)
[132.993557] Starting subtest: basic-queues-forked-all
[153.150216] Subtest basic-queues-forked-all: SUCCESS (20.152s)
[153.357340] [022/131] (864s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[153.453892] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[153.456053] Starting dynamic subtest: pipe-A-eDP-1
[154.326927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.866s)
[154.336950] Starting dynamic subtest: pipe-B-eDP-1
[155.879600] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[155.889335] Starting dynamic subtest: pipe-C-eDP-1
[157.381188] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.499s)
[157.391544] Starting dynamic subtest: pipe-D-eDP-1
[158.938795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s)
[158.941087] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.478s)
[160.120514] [023/131] (857s left) kms_content_protection (legacy-hdcp14)
[160.259486] Starting subtest: legacy-hdcp14
[160.264289] Subtest legacy-hdcp14: SKIP (0.000s)
[160.414329] [024/131] (857s left) kms_frontbuffer_tracking (fbc-tiling-y)
[160.514577] Starting subtest: fbc-tiling-y
[160.518997] Subtest fbc-tiling-y: SKIP (0.000s)
[160.633711] [025/131] (857s left) syncobj_wait (single-wait-for-submit-submitted)
[160.692905] Starting subtest: single-wait-for-submit-submitted
[160.795486] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[160.895237] [026/131] (857s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[161.014551] Starting subtest: cursorB-vs-flipB-atomic
[161.019256] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[161.184827] [027/131] (856s left) kms_flip (2x-blocking-absolute-wf_vblank)
[161.280454] Starting subtest: 2x-blocking-absolute-wf_vblank
[161.288276] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[161.395357] [028/131] (856s left) gem_mmap_offset (partial-unmap)
[161.455766] Starting subtest: partial-unmap
[161.458046] Starting dynamic subtest: smem0
[161.964346] Dynamic subtest smem0: SUCCESS (0.511s)
[161.966979] Subtest partial-unmap: SUCCESS (0.512s)
[162.124993] [029/131] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[162.241812] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[169.249163] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.010s)
[169.398295] [030/131] (848s left) kms_vblank (ts-continuation-idle-hang)
[169.494428] Starting subtest: ts-continuation-idle-hang
[169.496665] Starting dynamic subtest: pipe-A-eDP-1
[195.670267] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.172s)
[195.683301] Starting dynamic subtest: pipe-D-eDP-1
[220.698738] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[220.701145] Subtest ts-continuation-idle-hang: SUCCESS (51.203s)
[221.585315] [031/131] (796s left) gem_userptr_blits (readonly-unsync)
[221.661714] Subtest readonly-unsync: SKIP (0.000s)
[221.829421] [032/131] (796s left) gem_mmap (short-mmap)
[221.900576] Subtest short-mmap: SKIP (0.000s)
[221.967660] [033/131] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[222.057631] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[222.062091] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[222.194824] [034/131] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[222.304983] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[222.309161] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[222.448267] [035/131] (796s left) kms_chamelium_color (ctm-green-to-red)
[222.541264] Subtest ctm-green-to-red: SKIP (0.000s)
[222.588536] [036/131] (795s left) kms_frontbuffer_tracking (psr-suspend)
[222.693177] Starting subtest: psr-suspend
[261.245675] Subtest psr-suspend: SUCCESS (11.585s)
[261.413927] [037/131] (757s left) gem_spin_batch (engines)
[261.493911] Starting subtest: engines
[261.496370] Starting dynamic subtest: rcs0
[264.732002] Dynamic subtest rcs0: SUCCESS (3.228s)
[264.743908] Starting dynamic subtest: bcs0
[267.970352] Dynamic subtest bcs0: SUCCESS (3.232s)
[267.978825] Starting dynamic subtest: vcs0
[271.205527] Dynamic subtest vcs0: SUCCESS (3.230s)
[271.216580] Starting dynamic subtest: vcs1
[274.444634] Dynamic subtest vcs1: SUCCESS (3.234s)
[274.455669] Starting dynamic subtest: vecs0
[277.679234] Dynamic subtest vecs0: SUCCESS (3.230s)
[277.690322] Starting dynamic subtest: ccs0
[280.914471] Dynamic subtest ccs0: SUCCESS (3.232s)
[280.917139] Subtest engines: SUCCESS (19.400s)
[281.188719] [038/131] (737s left) kms_psr (fbc-pr-sprite-blt)
[281.290500] Starting subtest: fbc-pr-sprite-blt
[281.294926] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[281.388719] [039/131] (737s left) kms_psr (fbc-psr-primary-mmap-gtt)
[281.493455] Starting subtest: fbc-psr-primary-mmap-gtt
[281.495586] Starting dynamic subtest: eDP-1
[281.499527] Dynamic subtest eDP-1: SKIP (0.000s)
[281.503520] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[281.585241] [040/131] (737s left) gem_exec_schedule (preempt-hang)
[281.762741] Starting subtest: preempt-hang
[281.765807] Starting dynamic subtest: rcs0
[281.980706] Dynamic subtest rcs0: SUCCESS (0.217s)
[281.989666] Starting dynamic subtest: bcs0
[282.193709] Dynamic subtest bcs0: SUCCESS (0.212s)
[282.202775] Starting dynamic subtest: vcs0
[282.400990] Dynamic subtest vcs0: SUCCESS (0.205s)
[282.409065] Starting dynamic subtest: vcs1
[282.608723] Dynamic subtest vcs1: SUCCESS (0.208s)
[282.618654] Starting dynamic subtest: vecs0
[282.870934] Dynamic subtest vecs0: SUCCESS (0.261s)
[282.883304] Starting dynamic subtest: ccs0
[283.096521] Dynamic subtest ccs0: SUCCESS (0.223s)
[283.098801] Subtest preempt-hang: SUCCESS (1.332s)
[284.002074] [041/131] (734s left) gem_pxp (create-regular-context-1)
[284.125699] Starting subtest: create-regular-context-1
[284.128188] Subtest create-regular-context-1: SUCCESS (0.002s)
[284.264639] [042/131] (734s left) kms_big_fb (linear-32bpp-rotate-270)
[284.385870] Starting subtest: linear-32bpp-rotate-270
[284.406473] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[284.568667] [043/131] (734s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[284.669571] Starting subtest: fbc-shrfb-scaledprimary
[287.716628] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.050s)
[288.889866] [044/131] (729s left) kms_getfb (getfb-reject-nv12)
[288.994526] Starting subtest: getfb-reject-nv12
[288.996751] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[289.175009] [045/131] (729s left) gem_exec_parallel (contexts)
[289.247891] Starting subtest: contexts
[289.250507] Starting dynamic subtest: rcs0
[292.150873] Dynamic subtest rcs0: SUCCESS (2.902s)
[292.163311] Starting dynamic subtest: bcs0
[295.443273] Dynamic subtest bcs0: SUCCESS (3.289s)
[295.452274] Starting dynamic subtest: vcs0
[299.315966] Dynamic subtest vcs0: SUCCESS (3.868s)
[299.325077] Starting dynamic subtest: vcs1
[303.330123] Dynamic subtest vcs1: SUCCESS (4.010s)
[303.339166] Starting dynamic subtest: vecs0
[307.343646] Dynamic subtest vecs0: SUCCESS (4.009s)
[307.355955] Starting dynamic subtest: ccs0
[310.917035] Dynamic subtest ccs0: SUCCESS (3.570s)
[310.919247] Subtest contexts: SUCCESS (21.664s)
[311.134179] [046/131] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[311.238660] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[311.242974] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[311.380169] [047/131] (707s left) prime_mmap_coherency (ioctl-errors)
[311.447730] Starting subtest: ioctl-errors
[325.708248] Subtest ioctl-errors: SUCCESS (14.255s)
[325.940022] [048/131] (693s left) kms_3d (basic)
[326.038923] Starting subtest: basic
[328.001992] Subtest basic: SUCCESS (1.965s)
[328.482955] [049/131] (690s left) gem_ctx_param (set-priority-not-supported)
[328.541483] Starting subtest: set-priority-not-supported
[328.546135] Subtest set-priority-not-supported: SKIP (0.000s)
[328.642436] [050/131] (690s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[328.750893] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[328.753182] Starting dynamic subtest: pipe-A-default-mode
[329.044063] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[329.048835] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.292s)
[329.909824] [051/131] (689s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[329.999907] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[330.002306] Starting dynamic subtest: pipe-A-eDP-1
[330.023284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[330.035300] Starting dynamic subtest: pipe-B-eDP-1
[330.055271] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[330.063702] Starting dynamic subtest: pipe-C-eDP-1
[330.083103] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[330.091809] Starting dynamic subtest: pipe-D-eDP-1
[330.111375] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[330.113610] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[332.317669] [052/131] (686s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[337.399240] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[337.403979] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[338.226825] [053/131] (680s left) kms_psr (psr-sprite-mmap-cpu)
[338.320591] Starting subtest: psr-sprite-mmap-cpu
[338.322890] Starting dynamic subtest: eDP-1
[340.078928] Dynamic subtest eDP-1: SUCCESS (1.757s)
[340.080853] Subtest psr-sprite-mmap-cpu: SUCCESS (1.758s)
[340.926353] [054/131] (678s left) syncobj_wait (single-wait-signaled)
[340.980267] Starting subtest: single-wait-signaled
[340.982509] Subtest single-wait-signaled: SUCCESS (0.000s)
[341.122422] [055/131] (678s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[341.235040] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[341.239000] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[341.366871] [056/131] (677s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[341.455715] Starting subtest: bad-aux-stride-yf-tiled-ccs
[341.457990] Starting dynamic subtest: pipe-A-eDP-1
[341.481539] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[341.490815] Starting dynamic subtest: pipe-B-eDP-1
[341.512477] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[341.521082] Starting dynamic subtest: pipe-C-eDP-1
[341.542745] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[341.551207] Starting dynamic subtest: pipe-D-eDP-1
[341.573055] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[341.577456] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[343.719950] [057/131] (675s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[343.835818] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[343.839891] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[343.956309] [058/131] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[344.052717] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[344.057020] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[344.177954] [059/131] (675s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[344.232169] Starting subtest: verify-pxp-stale-buf-optout-execution
[345.297433] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.061s)
[345.454152] [060/131] (674s left) kms_plane (plane-position-hole-dpms)
[345.554599] Starting subtest: plane-position-hole-dpms
[346.071310] Starting dynamic subtest: pipe-A-plane-1
[348.419061] Dynamic subtest pipe-A-plane-1: SUCCESS (2.347s)
[348.429637] Starting dynamic subtest: pipe-A-plane-2
[350.715899] Dynamic subtest pipe-A-plane-2: SUCCESS (2.293s)
[350.724840] Starting dynamic subtest: pipe-A-plane-3
[353.020874] Dynamic subtest pipe-A-plane-3: SUCCESS (2.303s)
[353.030802] Starting dynamic subtest: pipe-A-plane-4
[355.321914] Dynamic subtest pipe-A-plane-4: SUCCESS (2.300s)
[355.331114] Starting dynamic subtest: pipe-A-plane-5
[355.352593] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[356.554713] Starting dynamic subtest: pipe-B-plane-1
[358.944159] Dynamic subtest pipe-B-plane-1: SUCCESS (2.400s)
[358.954397] Starting dynamic subtest: pipe-B-plane-2
[361.312892] Dynamic subtest pipe-B-plane-2: SUCCESS (2.366s)
[361.323222] Starting dynamic subtest: pipe-B-plane-3
[363.625823] Dynamic subtest pipe-B-plane-3: SUCCESS (2.315s)
[363.636140] Starting dynamic subtest: pipe-B-plane-4
[366.001158] Dynamic subtest pipe-B-plane-4: SUCCESS (2.377s)
[366.010926] Starting dynamic subtest: pipe-B-plane-5
[366.024580] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[366.026700] Subtest plane-position-hole-dpms: SUCCESS (20.476s)
[366.822751] [061/131] (652s left) perf (gen12-mi-rpc)
[366.953210] Starting subtest: gen12-mi-rpc
[366.955665] Starting dynamic subtest: rcs0
[366.972470] Dynamic subtest rcs0: SUCCESS (0.017s)
[366.974607] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[367.013652] [062/131] (652s left) gem_ctx_param (invalid-param-set)
[367.070491] Starting subtest: invalid-param-set
[367.072796] Subtest invalid-param-set: SUCCESS (0.000s)
[367.224753] [063/131] (652s left) gem_ctx_shared (q-independent)
[367.298118] Starting subtest: Q-independent
[367.300526] Starting dynamic subtest: rcs0
[367.365102] Dynamic subtest rcs0: SUCCESS (0.066s)
[367.377158] Starting dynamic subtest: vcs0
[367.414772] Dynamic subtest vcs0: SUCCESS (0.049s)
[367.426095] Starting dynamic subtest: vcs1
[367.449567] Dynamic subtest vcs1: SUCCESS (0.034s)
[367.459274] Starting dynamic subtest: vecs0
[367.488873] Dynamic subtest vecs0: SUCCESS (0.038s)
[367.501563] Starting dynamic subtest: ccs0
[367.531535] Dynamic subtest ccs0: SUCCESS (0.042s)
[367.533931] Subtest Q-independent: SUCCESS (0.234s)
[369.022535] [064/131] (650s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[369.114273] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[369.116104] Starting dynamic subtest: pipe-A-eDP-1
[371.333069] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.218s)
[371.343112] Starting dynamic subtest: pipe-B-eDP-1
[373.463908] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.132s)
[373.473039] Starting dynamic subtest: pipe-C-eDP-1
[375.543508] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.080s)
[375.552937] Starting dynamic subtest: pipe-D-eDP-1
[377.595478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.051s)
[377.597765] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.487s)
[378.805587] [065/131] (640s left) kms_lease (atomic-implicit-crtc)
[378.909410] Starting subtest: atomic-implicit-crtc
[378.911586] Starting dynamic subtest: pipe-A-eDP-1
[378.922375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[378.932953] Starting dynamic subtest: pipe-B-eDP-1
[378.943967] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[378.952560] Starting dynamic subtest: pipe-C-eDP-1
[378.963044] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[378.971692] Starting dynamic subtest: pipe-D-eDP-1
[378.982047] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[378.984109] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[379.087031] [066/131] (640s left) gem_exec_reloc (basic-wc)
[379.158777] Subtest basic-wc: SKIP (0.000s)
[379.248199] [067/131] (640s left) syncobj_timeline (transfer-timeline-point)
[379.307207] Starting subtest: transfer-timeline-point
[379.309492] Subtest transfer-timeline-point: SUCCESS (0.000s)
[379.449535] [068/131] (640s left) api_intel_bb (reset-flags)
[379.515255] Starting subtest: reset-flags
[379.521533] Subtest reset-flags: SUCCESS (0.007s)
[379.671095] [069/131] (640s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[379.777874] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[379.779699] Starting dynamic subtest: pipe-A-default-mode
[382.475693] Dynamic subtest pipe-A-default-mode: SUCCESS (2.699s)
[382.478054] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.701s)
[383.310695] [070/131] (636s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[383.422663] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[383.424483] Starting dynamic subtest: pipe-A-eDP-1
[383.565163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.133s)
[383.576810] Starting dynamic subtest: pipe-B-eDP-1
[383.596815] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[383.605828] Starting dynamic subtest: pipe-C-eDP-1
[383.624485] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[383.633122] Starting dynamic subtest: pipe-D-eDP-1
[383.651807] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[383.654029] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s)
[385.796309] [071/131] (634s left) sw_sync (sync_merge_invalid)
[385.840227] Starting subtest: sync_merge_invalid
[385.870258] Subtest sync_merge_invalid: SUCCESS (0.030s)
[385.957769] [072/131] (634s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[386.058568] Starting subtest: yf-tiled-32bpp-rotate-180
[386.063062] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[386.199021] [073/131] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[386.305039] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[393.259513] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.957s)
[393.420491] [074/131] (626s left) gem_userptr_blits (sd-probe)
[393.483934] Starting subtest: sd-probe
[393.485840] Subtest sd-probe: SUCCESS (0.000s)
[393.647482] [075/131] (626s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[393.721878] Subtest no-spare-fences-busy: SKIP (0.000s)
[393.791259] [076/131] (626s left) kms_plane_cursor (viewport)
[393.878301] Starting subtest: viewport
[393.882718] Starting dynamic subtest: pipe-A-eDP-1-size-64
[396.341703] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.463s)
[396.402636] Starting dynamic subtest: pipe-A-eDP-1-size-128
[398.832340] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.437s)
[398.893064] Starting dynamic subtest: pipe-A-eDP-1-size-256
[401.310739] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.426s)
[401.670579] Starting dynamic subtest: pipe-B-eDP-1-size-64
[404.851348] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.191s)
[404.912874] Starting dynamic subtest: pipe-B-eDP-1-size-128
[407.308519] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.406s)
[407.368719] Starting dynamic subtest: pipe-B-eDP-1-size-256
[409.787272] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.426s)
[410.139555] Starting dynamic subtest: pipe-C-eDP-1-size-64
[412.925386] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.797s)
[412.963865] Starting dynamic subtest: pipe-C-eDP-1-size-128
[414.993349] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.035s)
[415.033479] Starting dynamic subtest: pipe-C-eDP-1-size-256
[417.102930] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.079s)
[417.435065] Starting dynamic subtest: pipe-D-eDP-1-size-64
[420.207624] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.784s)
[420.253285] Starting dynamic subtest: pipe-D-eDP-1-size-128
[422.274870] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.036s)
[422.319127] Starting dynamic subtest: pipe-D-eDP-1-size-256
[424.396882] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.091s)
[424.715771] Subtest viewport: SUCCESS (30.836s)
[425.593757] [077/131] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[425.699721] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[425.704658] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.819957] [078/131] (594s left) syncobj_timeline (multi-wait-available-signaled)
[425.887187] Starting subtest: multi-wait-available-signaled
[425.889503] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[426.017708] [079/131] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[426.121113] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[426.125287] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[426.267249] [080/131] (594s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[426.331432] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[426.398428] [081/131] (593s left) gem_exec_reloc (basic-cpu-noreloc)
[426.470634] Subtest basic-cpu-noreloc: SKIP (0.000s)
[426.547903] [082/131] (593s left) kms_vblank (crtc-id)
[426.644107] Starting subtest: crtc-id
[426.646085] Starting dynamic subtest: pipe-A-eDP-1
[427.096851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[427.122403] Starting dynamic subtest: pipe-D-eDP-1
[428.263499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s)
[428.265687] Subtest crtc-id: SUCCESS (1.618s)
[429.094928] [083/131] (591s left) gem_exec_balancer (parallel-bb-first)
[429.351112] Starting subtest: parallel-bb-first
[430.274639] Subtest parallel-bb-first: SUCCESS (0.922s)
[430.954048] [084/131] (589s left) syncobj_timeline (device-submit-unordered)
[431.024396] Starting subtest: device-submit-unordered
[431.026721] Subtest device-submit-unordered: SUCCESS (0.000s)
[431.147643] [085/131] (589s left) gem_exec_parallel (userptr)
[431.215816] Starting subtest: userptr
[431.218231] Starting dynamic subtest: rcs0
[432.769525] Dynamic subtest rcs0: SUCCESS (1.556s)
[432.781920] Starting dynamic subtest: bcs0
[434.265739] Dynamic subtest bcs0: SUCCESS (1.494s)
[434.278746] Starting dynamic subtest: vcs0
[435.912155] Dynamic subtest vcs0: SUCCESS (1.642s)
[435.924477] Starting dynamic subtest: vcs1
[437.867740] Dynamic subtest vcs1: SUCCESS (1.955s)
[437.880102] Starting dynamic subtest: vecs0
[439.851530] Dynamic subtest vecs0: SUCCESS (1.981s)
[439.864664] Starting dynamic subtest: ccs0
[441.359006] Dynamic subtest ccs0: SUCCESS (1.506s)
[441.361492] Subtest userptr: SUCCESS (10.145s)
[441.569406] [086/131] (579s left) api_intel_allocator (reopen)
[441.634129] Starting subtest: reopen
[441.637091] Subtest reopen: SUCCESS (0.006s)
[441.799498] [087/131] (578s left) kms_color_pipeline (plane-lut1d-lut1d)
[441.898260] Starting subtest: plane-lut1d-lut1d
[441.913856] Starting dynamic subtest: pipe-A-eDP-1
[442.615283] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[443.328725] Starting dynamic subtest: pipe-B-eDP-1
[444.146504] Dynamic subtest pipe-B-eDP-1: FAIL (0.304s)
[444.725850] Starting dynamic subtest: pipe-C-eDP-1
[445.590836] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[446.030867] Starting dynamic subtest: pipe-D-eDP-1
[446.884599] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[446.886924] Subtest plane-lut1d-lut1d: FAIL (4.670s)
[447.393969] [088/131] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[447.508369] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[451.778454] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.273s)
[453.010585] [089/131] (567s left) kms_flip (flip-vs-absolute-wf_vblank)
[453.099748] Starting subtest: flip-vs-absolute-wf_vblank
[453.102074] Starting dynamic subtest: A-eDP1
[461.990943] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[462.001739] Starting dynamic subtest: B-eDP1
[470.902006] Dynamic subtest B-eDP1: SUCCESS (8.908s)
[470.911698] Starting dynamic subtest: C-eDP1
[479.779361] Dynamic subtest C-eDP1: SUCCESS (8.873s)
[479.791575] Starting dynamic subtest: D-eDP1
[488.683019] Dynamic subtest D-eDP1: SUCCESS (8.902s)
[488.685252] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.581s)
[489.901495] [090/131] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[489.991084] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[489.995136] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[490.133862] [091/131] (530s left) i915_suspend (basic-s2idle-without-i915)
[490.175023] Starting subtest: basic-s2idle-without-i915
[511.270347] Subtest basic-s2idle-without-i915: SUCCESS (5.903s)
[511.398911] [092/131] (509s left) kms_pm_rpm (basic-rte)
[511.445694] Starting subtest: basic-rte
[514.595441] Subtest basic-rte: SUCCESS (3.145s)
[516.378908] [093/131] (504s left) i915_pm_freq_api (freq-reset)
[516.440308] Starting subtest: freq-reset
[516.442675] Starting dynamic subtest: gt0
[516.591341] Dynamic subtest gt0: SUCCESS (0.148s)
[516.599576] Starting dynamic subtest: gt1
[516.722845] Dynamic subtest gt1: SUCCESS (0.127s)
[516.724809] Subtest freq-reset: SUCCESS (0.277s)
[516.812573] [094/131] (504s left) i915_drm_fdinfo (all-busy-idle-check-all)
[516.854737] Starting subtest: all-busy-idle-check-all
[516.861285] Subtest all-busy-idle-check-all: SKIP (0.004s)
[516.953281] [095/131] (504s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[517.060930] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[517.139201] [096/131] (503s left) gen9_exec_parse (basic-rejected-ctx-param)
[517.205790] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[517.276554] [097/131] (503s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[517.368746] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[517.371058] Starting dynamic subtest: pipe-A
[517.392043] Dynamic subtest pipe-A: SKIP (0.018s)
[517.400478] Starting dynamic subtest: pipe-B
[517.467053] Dynamic subtest pipe-B: SKIP (0.072s)
[517.475874] Starting dynamic subtest: pipe-C
[517.506128] Dynamic subtest pipe-C: SKIP (0.037s)
[517.514056] Starting dynamic subtest: pipe-D
[517.541766] Dynamic subtest pipe-D: SKIP (0.036s)
[517.545749] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.170s)
[517.657350] [098/131] (503s left) gem_ctx_isolation (preservation)
[517.720115] Starting subtest: preservation
[517.722335] Starting dynamic subtest: rcs0
[517.864832] Dynamic subtest rcs0: SUCCESS (0.144s)
[517.874291] Starting dynamic subtest: bcs0
[518.030649] Dynamic subtest bcs0: SUCCESS (0.165s)
[518.040255] Starting dynamic subtest: vcs0
[518.198621] Dynamic subtest vcs0: SUCCESS (0.167s)
[518.210671] Starting dynamic subtest: vcs1
[520.237878] Dynamic subtest vcs1: SUCCESS (2.036s)
[520.246630] Starting dynamic subtest: vecs0
[522.194388] Dynamic subtest vecs0: SUCCESS (1.954s)
[522.204101] Starting dynamic subtest: ccs0
[524.203931] Dynamic subtest ccs0: SUCCESS (2.008s)
[524.207137] Subtest preservation: SUCCESS (6.479s)
[524.488809] [099/131] (496s left) kms_feature_discovery (display-2x)
[524.590545] Starting subtest: display-2x
[524.594968] Subtest display-2x: SKIP (0.000s)
[524.713012] [100/131] (496s left) perf_pmu (event-wait)
[524.761788] Starting subtest: event-wait
[524.764124] Starting dynamic subtest: rcs0
[524.768551] Dynamic subtest rcs0: SKIP (0.000s)
[524.772966] Subtest event-wait: SKIP (0.001s)
[524.887916] [101/131] (496s left) gem_ctx_engines (execute-oneforall)
[524.948269] Starting subtest: execute-oneforall
[525.415579] Subtest execute-oneforall: SUCCESS (0.467s)
[527.199369] [102/131] (494s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[527.309780] Starting subtest: y-tiled-64bpp-rotate-0
[527.314046] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[527.455427] [103/131] (493s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[527.519950] Subtest untiled-to-tiled: SKIP (0.000s)
[527.613382] [104/131] (493s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[528.004509] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[528.779603] [105/131] (492s left) gem_mmap (big-bo)
[528.843150] Subtest big-bo: SKIP (0.000s)
[528.916581] [106/131] (492s left) gem_exec_fence (syncobj-signal)
[529.371173] Starting subtest: syncobj-signal
[529.376950] Subtest syncobj-signal: SUCCESS (0.005s)
[531.212069] [107/131] (490s left) kms_cursor_edge_walk (128x128-left-edge)
[531.307844] Starting subtest: 128x128-left-edge
[531.310156] Starting dynamic subtest: pipe-A-eDP-1
[534.776157] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[534.791764] Starting dynamic subtest: pipe-D-eDP-1
[537.903630] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[537.905603] Subtest 128x128-left-edge: SUCCESS (6.594s)
[538.741768] [108/131] (482s left) syncobj_wait (single-wait-submitted)
[538.799133] Starting subtest: single-wait-submitted
[538.906921] Subtest single-wait-submitted: SUCCESS (0.108s)
[539.005688] [109/131] (482s left) kms_atomic (plane-invalid-params-fence)
[539.106825] Starting subtest: plane-invalid-params-fence
[539.109148] Starting dynamic subtest: pipe-A-eDP-1
[539.466423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[539.469053] Subtest plane-invalid-params-fence: SUCCESS (0.362s)
[540.367258] [110/131] (481s left) gem_exec_await (wide-contexts)
[540.541833] Starting subtest: wide-contexts
[563.943961] Subtest wide-contexts: SUCCESS (23.404s)
[564.166286] [111/131] (457s left) kms_prop_blob (invalid-get-prop)
[564.260083] Starting subtest: invalid-get-prop
[564.262012] Subtest invalid-get-prop: SUCCESS (0.000s)
[564.386125] [112/131] (457s left) kms_psr (psr2-primary-page-flip)
[564.502287] Starting subtest: psr2-primary-page-flip
[564.504551] Starting dynamic subtest: eDP-1
[566.214552] Dynamic subtest eDP-1: SUCCESS (1.711s)
[566.216731] Subtest psr2-primary-page-flip: SUCCESS (1.712s)
[567.119530] [113/131] (454s left) gem_userptr_blits (invalid-null-pointer)
[567.186749] Starting subtest: invalid-null-pointer
[567.188733] Subtest invalid-null-pointer: SUCCESS (0.001s)
[567.349613] [114/131] (454s left) syncobj_timeline (reset-multiple-signaled)
[567.418298] Starting subtest: reset-multiple-signaled
[567.420798] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[567.556935] [115/131] (454s left) gem_exec_async (forked-writes)
[567.618309] Starting subtest: forked-writes
[567.620712] Starting dynamic subtest: rcs0
[567.645641] Dynamic subtest rcs0: SUCCESS (0.027s)
[567.659943] Starting dynamic subtest: bcs0
[567.671812] Dynamic subtest bcs0: SUCCESS (0.025s)
[567.681640] Starting dynamic subtest: vcs0
[567.694366] Dynamic subtest vcs0: SUCCESS (0.022s)
[567.704860] Starting dynamic subtest: vcs1
[567.720086] Dynamic subtest vcs1: SUCCESS (0.025s)
[567.732271] Starting dynamic subtest: vecs0
[567.746013] Dynamic subtest vecs0: SUCCESS (0.025s)
[567.756057] Starting dynamic subtest: ccs0
[567.769742] Dynamic subtest ccs0: SUCCESS (0.023s)
[567.771878] Subtest forked-writes: SUCCESS (0.152s)
[568.052878] [116/131] (453s left) kms_plane_scaling (planes-downscale-factor-0-75)
[568.144140] Starting subtest: planes-downscale-factor-0-75
[568.146412] Starting dynamic subtest: pipe-A
[568.165614] Dynamic subtest pipe-A: SKIP (0.018s)
[568.174560] Starting dynamic subtest: pipe-B
[568.203057] Dynamic subtest pipe-B: SKIP (0.034s)
[568.212408] Starting dynamic subtest: pipe-C
[568.236697] Dynamic subtest pipe-C: SKIP (0.034s)
[568.245301] Starting dynamic subtest: pipe-D
[568.270149] Dynamic subtest pipe-D: SKIP (0.032s)
[568.274282] Subtest planes-downscale-factor-0-75: SKIP (0.123s)
[568.390303] [117/131] (453s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[568.444752] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[568.513466] [118/131] (453s left) dumb_buffer (map-uaf)
[568.573473] Starting subtest: map-uaf
[568.578447] Subtest map-uaf: SUCCESS (0.005s)
[568.716121] [119/131] (453s left) kms_fbcon_fbt (fbc-suspend)
[568.770574] Starting subtest: fbc-suspend
[618.992991] Subtest fbc-suspend: SUCCESS (19.485s)
[620.322785] [120/131] (401s left) perf (blocking)
[620.466009] Starting subtest: blocking
[620.467851] Starting dynamic subtest: 0-rcs0
[630.494480] Dynamic subtest 0-rcs0: SUCCESS (10.018s)
[630.504536] Starting dynamic subtest: 1-vcs0
[640.521114] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[640.523258] Subtest blocking: SUCCESS (20.040s)
[640.573875] [121/131] (381s left) kms_cursor_crc (cursor-onscreen-128x128)
[640.787505] Starting subtest: cursor-onscreen-128x128
[640.792680] Starting dynamic subtest: pipe-A-eDP-1
[642.914817] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.123s)
[642.948439] Starting dynamic subtest: pipe-D-eDP-1
[645.758526] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.814s)
[645.760712] Subtest cursor-onscreen-128x128: SUCCESS (4.966s)
[646.646435] [122/131] (375s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[646.957905] Starting subtest: cursor-rapid-movement-512x170
[646.962354] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[647.151555] [123/131] (374s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[647.273954] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[648.252790] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.978s)
[649.076562] [124/131] (373s left) gem_exec_schedule (preempt-self)
[649.142179] Starting subtest: preempt-self
[649.144053] Starting dynamic subtest: rcs0
[649.160598] Dynamic subtest rcs0: SUCCESS (0.027s)
[649.171312] Starting dynamic subtest: bcs0
[649.177432] Dynamic subtest bcs0: SUCCESS (0.016s)
[649.186172] Starting dynamic subtest: vcs0
[649.193664] Dynamic subtest vcs0: SUCCESS (0.016s)
[649.202639] Starting dynamic subtest: vcs1
[649.211302] Dynamic subtest vcs1: SUCCESS (0.017s)
[649.220244] Starting dynamic subtest: vecs0
[649.229576] Dynamic subtest vecs0: SUCCESS (0.018s)
[649.238529] Starting dynamic subtest: ccs0
[649.244476] Dynamic subtest ccs0: SUCCESS (0.014s)
[649.246640] Subtest preempt-self: SUCCESS (0.111s)
[650.960722] [125/131] (371s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[651.069821] Starting subtest: x-tiled-64bpp-rotate-180
[652.670317] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.601s)
[652.872807] [126/131] (369s left) kms_flip (2x-flip-vs-modeset)
[652.973443] Starting subtest: 2x-flip-vs-modeset
[652.980742] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[653.084453] [127/131] (369s left) perf_pmu (most-busy-check-all)
[653.125614] Starting subtest: most-busy-check-all
[653.128221] Starting dynamic subtest: rcs0
[654.788312] Dynamic subtest rcs0: SUCCESS (1.663s)
[654.802779] Starting dynamic subtest: bcs0
[656.770035] Dynamic subtest bcs0: SUCCESS (1.979s)
[656.783679] Starting dynamic subtest: vcs0
[658.817365] Dynamic subtest vcs0: SUCCESS (2.044s)
[658.829730] Starting dynamic subtest: vcs1
[660.801689] Dynamic subtest vcs1: SUCCESS (1.983s)
[660.814644] Starting dynamic subtest: vecs0
[662.787574] Dynamic subtest vecs0: SUCCESS (1.982s)
[662.809332] Starting dynamic subtest: ccs0
[664.705332] Dynamic subtest ccs0: SUCCESS (1.916s)
[664.708245] Subtest most-busy-check-all: SUCCESS (11.583s)
[664.846728] [128/131] (357s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[665.247286] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[666.067114] [129/131] (356s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[666.131623] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[666.135929] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[666.338925] [130/131] (356s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[666.444863] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[666.448912] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[666.550881] [131/131] (355s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[666.655160] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[673.465856] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.811s)
[673.621404] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_rotation_crc
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: i915_pm_rc6_residency
results: parsing output: 7/ for test: core_getversion
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_debugfs
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_exec_store
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_legacy_colorkey
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_rmfb
results: parsing output: 18/ for test: kms_atomic_interruptible
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_color
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_exec_parallel
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: prime_mmap_coherency
results: parsing output: 47/ for test: kms_3d
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: gem_fenced_exec_thrash
results: parsing output: 75/ for test: kms_plane_cursor
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: api_intel_allocator
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_suspend
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: gem_ctx_isolation
results: parsing output: 98/ for test: kms_feature_discovery
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_ctx_engines
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_set_tiling_vs_blt
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_mmap
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_cursor_edge_walk
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: gem_exec_await
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_exec_async
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: dumb_buffer
results: parsing output: 118/ for test: kms_fbcon_fbt
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.