[58.885448] Initializing watchdogs [58.885496] /dev/watchdog0 [58.900390] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.905089] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.907277] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.909035] [001/132] (960s left) kms_cursor_crc (cursor-offscreen-256x85) [59.192874] Starting subtest: cursor-offscreen-256x85 [59.241596] Subtest cursor-offscreen-256x85: SKIP (0.047s) [59.399701] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [59.482100] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [59.483088] Starting dynamic subtest: pipe-A-eDP-1 [59.511753] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [59.519110] Starting dynamic subtest: pipe-B-eDP-1 [59.540381] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [59.546344] Starting dynamic subtest: pipe-C-eDP-1 [59.566993] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [59.572449] Starting dynamic subtest: pipe-D-eDP-1 [59.594420] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [59.596079] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s) [61.702669] [003/132] (957s left) sysfs_timeslice_duration (duration) [61.761905] Starting subtest: duration [61.762799] Starting dynamic subtest: vecs0 [76.860447] Dynamic subtest vecs0: SUCCESS (15.072s) [76.870386] Starting dynamic subtest: ccs0 [90.002360] Dynamic subtest ccs0: SUCCESS (13.141s) [90.010485] Starting dynamic subtest: vcs0 [103.804939] Dynamic subtest vcs0: SUCCESS (13.796s) [103.813520] Starting dynamic subtest: bcs0 [116.945065] Dynamic subtest bcs0: SUCCESS (13.137s) [116.953287] Starting dynamic subtest: rcs0 [130.089772] Dynamic subtest rcs0: SUCCESS (13.143s) [130.097848] Starting dynamic subtest: vcs1 [144.828979] Dynamic subtest vcs1: SUCCESS (14.739s) [144.830370] Subtest duration: SUCCESS (83.037s) [144.894973] [004/132] (874s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [144.984801] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [144.985889] Starting dynamic subtest: pipe-A-eDP-1 [161.446047] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.994s) [161.454139] Starting dynamic subtest: pipe-B-eDP-1 [179.395905] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.812s) [179.403009] Starting dynamic subtest: pipe-C-eDP-1 [197.394806] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.747s) [197.401366] Starting dynamic subtest: pipe-D-eDP-1 [215.380197] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s) [215.381539] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.297s) [222.639419] [005/132] (802s left) drm_buddy (drm_buddy) [222.689501] Starting subtest: drm_buddy [222.691506] Subtest drm_buddy: SKIP (0.000s) [222.734832] [006/132] (802s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [222.839893] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [223.694591] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s) [223.867758] [007/132] (801s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [223.960735] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [223.961695] Starting dynamic subtest: pipe-A-eDP-1 [224.713837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s) [224.721860] Starting dynamic subtest: pipe-B-eDP-1 [226.497426] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.759s) [226.505095] Starting dynamic subtest: pipe-C-eDP-1 [228.358317] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.842s) [228.365043] Starting dynamic subtest: pipe-D-eDP-1 [230.203829] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s) [230.204830] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.171s) [231.337789] [008/132] (794s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [231.425542] Starting subtest: bad-pixel-format-yf-tiled-ccs [231.426441] Starting dynamic subtest: pipe-A-eDP-1 [231.435030] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [231.442646] Starting dynamic subtest: pipe-B-eDP-1 [231.450996] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [231.457950] Starting dynamic subtest: pipe-C-eDP-1 [231.466078] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [231.472934] Starting dynamic subtest: pipe-D-eDP-1 [231.481388] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [231.482983] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s) [233.609707] [009/132] (792s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [233.661803] Starting subtest: multi-wait-available-unsubmitted-submitted [233.662901] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s) [233.760294] [010/132] (791s left) perf_pmu (event-wait) [233.793909] Starting subtest: event-wait [233.795033] Starting dynamic subtest: rcs0 [233.796940] Dynamic subtest rcs0: SKIP (0.000s) [233.798939] Subtest event-wait: SKIP (0.000s) [233.883314] [011/132] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [233.963275] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [233.965041] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [234.061403] [012/132] (791s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [234.148368] Starting subtest: psr-rgb565-draw-mmap-gtt [234.149992] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [234.232362] [013/132] (791s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [234.326927] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [234.328170] Starting dynamic subtest: pipe-A-eDP-1 [240.210969] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.865s) [240.222855] Starting dynamic subtest: pipe-B-eDP-1 [246.882572] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.658s) [246.883510] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.527s) [247.752416] [014/132] (778s left) kms_psr (fbc-psr2-dpms) [247.851698] Starting subtest: fbc-psr2-dpms [247.852741] Starting dynamic subtest: eDP-1 [247.854606] Dynamic subtest eDP-1: SKIP (0.000s) [247.856418] Subtest fbc-psr2-dpms: SKIP (0.001s) [247.921077] [015/132] (777s left) gem_exec_balancer (parallel-ordering) [248.180104] Starting subtest: parallel-ordering [249.163192] Subtest parallel-ordering: SUCCESS (0.982s) [249.264223] [016/132] (776s left) kms_joiner (basic-big-joiner) [249.352229] Starting subtest: basic-big-joiner [249.353976] Subtest basic-big-joiner: SKIP (0.000s) [249.415419] [017/132] (776s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [249.529865] Starting subtest: flip-vs-cursor-crc-atomic [250.238052] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.707s) [251.084117] [018/132] (774s left) gem_wait (wait) [251.153672] Starting subtest: wait [251.154649] Starting dynamic subtest: all-engines [252.960904] Dynamic subtest all-engines: SUCCESS (1.795s) [252.970737] Starting dynamic subtest: rcs0 [253.996840] Dynamic subtest rcs0: SUCCESS (1.044s) [254.006423] Starting dynamic subtest: bcs0 [255.044270] Dynamic subtest bcs0: SUCCESS (1.046s) [255.054314] Starting dynamic subtest: vcs0 [256.088069] Dynamic subtest vcs0: SUCCESS (1.043s) [256.098540] Starting dynamic subtest: vcs1 [257.132203] Dynamic subtest vcs1: SUCCESS (1.043s) [257.142898] Starting dynamic subtest: vecs0 [258.177195] Dynamic subtest vecs0: SUCCESS (1.044s) [258.187368] Starting dynamic subtest: ccs0 [259.223081] Dynamic subtest ccs0: SUCCESS (1.044s) [259.224527] Subtest wait: SUCCESS (8.069s) [259.443238] [019/132] (766s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [259.534663] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [259.536337] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [259.609320] [020/132] (766s left) kms_flip (2x-flip-vs-expired-vblank) [259.703850] Starting subtest: 2x-flip-vs-expired-vblank [259.715548] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s) [259.793439] [021/132] (766s left) kms_lease (page-flip-implicit-plane) [259.903037] Starting subtest: page-flip-implicit-plane [259.904036] Starting dynamic subtest: pipe-A-eDP-1 [260.383703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s) [260.390889] Starting dynamic subtest: pipe-B-eDP-1 [261.539719] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s) [261.551362] Starting dynamic subtest: pipe-C-eDP-1 [262.652363] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s) [262.661955] Starting dynamic subtest: pipe-D-eDP-1 [263.792373] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [263.793293] Subtest page-flip-implicit-plane: SUCCESS (3.889s) [264.617511] [022/132] (761s left) gem_exec_params (rsvd2-dirt) [264.665594] Starting subtest: rsvd2-dirt [264.667375] Subtest rsvd2-dirt: SKIP (0.000s) [264.749104] [023/132] (761s left) api_intel_bb (blit-reloc-purge-cache) [264.805516] Starting subtest: blit-reloc-purge-cache [264.807362] Subtest blit-reloc-purge-cache: SKIP (0.001s) [264.921830] [024/132] (761s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [265.005432] Starting subtest: fbc-shrfb-scaledprimary [268.225943] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.221s) [269.344872] [025/132] (756s left) i915_pm_rpm (gem-idle) [271.169057] Starting subtest: gem-idle [277.396371] Subtest gem-idle: SUCCESS (6.228s) [277.741093] [026/132] (748s left) kms_big_fb (x-tiled-8bpp-rotate-0) [278.951748] Starting subtest: x-tiled-8bpp-rotate-0 [280.153534] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.202s) [280.258460] [027/132] (746s left) gem_exec_schedule (preempt-contexts) [280.319374] Starting subtest: preempt-contexts [280.320373] Starting dynamic subtest: rcs0 [280.370044] Dynamic subtest rcs0: SUCCESS (0.052s) [280.378006] Starting dynamic subtest: bcs0 [280.434059] Dynamic subtest bcs0: SUCCESS (0.064s) [280.441626] Starting dynamic subtest: vcs0 [280.481188] Dynamic subtest vcs0: SUCCESS (0.047s) [280.488526] Starting dynamic subtest: vcs1 [280.526673] Dynamic subtest vcs1: SUCCESS (0.045s) [280.533847] Starting dynamic subtest: vecs0 [280.569131] Dynamic subtest vecs0: SUCCESS (0.042s) [280.578054] Starting dynamic subtest: ccs0 [280.620965] Dynamic subtest ccs0: SUCCESS (0.051s) [280.622119] Subtest preempt-contexts: SUCCESS (0.303s) [282.098243] [028/132] (744s left) gem_exec_flush (basic-uc-rw-default) [282.156678] Starting subtest: basic-uc-rw-default [287.612102] Subtest basic-uc-rw-default: SUCCESS (5.454s) [287.790280] [029/132] (738s left) kms_color_pipeline (plane-lut1d) [287.876338] Starting subtest: plane-lut1d [288.046309] Starting dynamic subtest: pipe-A-plane-0 [288.280401] Dynamic subtest pipe-A-plane-0: FAIL (0.173s) [288.288537] Starting dynamic subtest: pipe-A-plane-1 [288.464557] Dynamic subtest pipe-A-plane-1: FAIL (0.167s) [288.472850] Starting dynamic subtest: pipe-A-plane-2 [288.639833] Dynamic subtest pipe-A-plane-2: FAIL (0.167s) [289.729264] Starting dynamic subtest: pipe-B-plane-0 [289.985899] Dynamic subtest pipe-B-plane-0: FAIL (0.164s) [289.993296] Starting dynamic subtest: pipe-B-plane-1 [290.160281] Dynamic subtest pipe-B-plane-1: FAIL (0.166s) [290.168117] Starting dynamic subtest: pipe-B-plane-2 [290.348500] Dynamic subtest pipe-B-plane-2: FAIL (0.168s) [291.487410] Starting dynamic subtest: pipe-C-plane-0 [291.758366] Dynamic subtest pipe-C-plane-0: FAIL (0.152s) [291.766189] Starting dynamic subtest: pipe-C-plane-1 [291.907719] Dynamic subtest pipe-C-plane-1: FAIL (0.143s) [291.915970] Starting dynamic subtest: pipe-C-plane-2 [292.090389] Dynamic subtest pipe-C-plane-2: FAIL (0.167s) [293.116212] Starting dynamic subtest: pipe-D-plane-0 [293.407776] Dynamic subtest pipe-D-plane-0: FAIL (0.140s) [293.415173] Starting dynamic subtest: pipe-D-plane-1 [293.599682] Dynamic subtest pipe-D-plane-1: FAIL (0.144s) [293.607424] Starting dynamic subtest: pipe-D-plane-2 [293.789071] Dynamic subtest pipe-D-plane-2: FAIL (0.336s) [294.044187] Subtest plane-lut1d: FAIL (6.166s) [294.886455] [030/132] (731s left) gem_exec_schedule (deep) [295.062477] Starting subtest: deep [295.063422] Starting dynamic subtest: rcs0 [300.210805] Dynamic subtest rcs0: SKIP (5.143s) [300.227716] Starting dynamic subtest: vcs0 [310.333553] Dynamic subtest vcs0: SUCCESS (10.119s) [310.346646] Starting dynamic subtest: vcs1 [321.331250] Dynamic subtest vcs1: SUCCESS (10.996s) [321.344628] Starting dynamic subtest: vecs0 [332.242728] Dynamic subtest vecs0: SUCCESS (10.913s) [332.253634] Starting dynamic subtest: ccs0 [344.485926] Dynamic subtest ccs0: SUCCESS (12.243s) [344.488086] Subtest deep: SUCCESS (49.419s) [345.878868] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true [345.881671] [031/132] (680s left) kms_cursor_crc (cursor-suspend) [346.010707] Starting subtest: cursor-suspend [346.011603] Starting dynamic subtest: pipe-A-eDP-1 [379.709167] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.994s) [379.717546] Starting dynamic subtest: pipe-D-eDP-1 [414.681662] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.506s) [414.682574] Subtest cursor-suspend: SUCCESS (8.504s) [420.559554] [032/132] (610s left) perf (gen8-unprivileged-single-ctx-counters) [420.702871] Starting subtest: gen8-unprivileged-single-ctx-counters [420.704750] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [420.737080] [033/132] (610s left) api_intel_bb (intel-bb-blit-y) [420.776876] Starting subtest: intel-bb-blit-y [424.480140] Subtest intel-bb-blit-y: SUCCESS (3.646s) [424.577914] [034/132] (607s left) prime_mmap (test_refcounting) [424.633818] Starting subtest: test_refcounting [424.634707] Starting dynamic subtest: test_refcounting-smem [424.667662] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s) [424.668616] Subtest test_refcounting: SUCCESS (0.034s) [424.766944] [035/132] (606s left) kms_atomic_transition (modeset-transition) [424.854603] Starting subtest: modeset-transition [424.855460] Starting dynamic subtest: 1x-outputs [435.805182] Dynamic subtest 1x-outputs: SUCCESS (10.883s) [435.807771] Subtest modeset-transition: SUCCESS (10.885s) [436.653898] [036/132] (595s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [436.741736] Starting subtest: plane-downscale-factor-0-5-with-modifiers [436.742552] Starting dynamic subtest: pipe-A [436.760342] Dynamic subtest pipe-A: SKIP (0.016s) [436.768430] Starting dynamic subtest: pipe-B [436.791437] Dynamic subtest pipe-B: SKIP (0.031s) [436.799471] Starting dynamic subtest: pipe-C [436.822699] Dynamic subtest pipe-C: SKIP (0.030s) [436.830617] Starting dynamic subtest: pipe-D [436.853279] Dynamic subtest pipe-D: SKIP (0.030s) [436.854904] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s) [436.933132] [037/132] (594s left) kms_frontbuffer_tracking (fbc-suspend) [437.019866] Starting subtest: fbc-suspend [475.729692] Subtest fbc-suspend: SUCCESS (8.193s) [480.982648] [038/132] (554s left) gem_pxp (display-protected-crc) [481.111875] Starting subtest: display-protected-crc [482.799145] Subtest display-protected-crc: SUCCESS (1.668s) [482.913778] [039/132] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [483.007667] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [483.009487] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [483.108205] [040/132] (552s left) gem_userptr_blits (dmabuf-unsync) [483.154150] Subtest dmabuf-unsync: SKIP (0.000s) [483.277216] [041/132] (552s left) gem_eio (context-create) [483.499823] Starting subtest: context-create [483.827071] Subtest context-create: SUCCESS (0.323s) [483.945065] [042/132] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [484.027221] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [490.900422] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.827s) [491.033545] [043/132] (544s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [491.134221] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [491.136014] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [491.226075] [044/132] (544s left) kms_selftest (drm_dp_mst_helper) [491.255560] Starting subtest: drm_dp_mst_helper [491.329929] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [491.437406] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.107s) [491.447572] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [491.558326] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.119s) [491.566442] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [491.657842] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.098s) [491.658747] Subtest drm_dp_mst_helper: SUCCESS (0.401s) [491.819725] [045/132] (544s left) gem_spin_batch (resubmit-new) [491.871394] Starting subtest: resubmit-new [491.872440] Starting dynamic subtest: rcs0 [491.881302] Dynamic subtest rcs0: SUCCESS (0.009s) [491.893478] Starting dynamic subtest: bcs0 [491.894248] Dynamic subtest bcs0: SUCCESS (0.006s) [491.902398] Starting dynamic subtest: vcs0 [491.903168] Dynamic subtest vcs0: SUCCESS (0.006s) [491.911049] Starting dynamic subtest: vcs1 [491.911964] Dynamic subtest vcs1: SUCCESS (0.004s) [491.920180] Starting dynamic subtest: vecs0 [491.921097] Dynamic subtest vecs0: SUCCESS (0.004s) [491.929185] Starting dynamic subtest: ccs0 [491.930074] Dynamic subtest ccs0: SUCCESS (0.005s) [491.931111] Subtest resubmit-new: SUCCESS (0.040s) [493.750115] [046/132] (542s left) testdisplay [494.053381] [047/132] (542s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [494.157286] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [494.158215] Starting dynamic subtest: pipe-A-eDP-1 [494.280161] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s) [494.289437] Starting dynamic subtest: pipe-B-eDP-1 [495.424475] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s) [495.426143] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.263s) [496.618016] [048/132] (539s left) i915_selftest (live) [499.936865] Starting subtest: live [499.937811] Starting dynamic subtest: sanitycheck [504.292893] Dynamic subtest sanitycheck: SUCCESS (4.352s) [504.301003] Starting dynamic subtest: uncore [508.607115] Dynamic subtest uncore: SUCCESS (4.307s) [508.615297] Starting dynamic subtest: workarounds [513.212743] Dynamic subtest workarounds: SUCCESS (4.599s) [513.222008] Starting dynamic subtest: gt_engines [516.312425] Dynamic subtest gt_engines: SUCCESS (3.096s) [516.323841] Starting dynamic subtest: gt_timelines [531.881826] Dynamic subtest gt_timelines: SUCCESS (15.557s) [531.890029] Starting dynamic subtest: gt_contexts [536.241578] Dynamic subtest gt_contexts: SUCCESS (4.356s) [536.248475] Starting dynamic subtest: gt_lrc [540.667433] Dynamic subtest gt_lrc: SUCCESS (4.421s) [540.676050] Starting dynamic subtest: gt_mocs [543.647827] Dynamic subtest gt_mocs: SUCCESS (2.975s) [543.656443] Starting dynamic subtest: gt_pm [550.358686] Dynamic subtest gt_pm: SUCCESS (6.705s) [550.367540] Starting dynamic subtest: gt_heartbeat [554.676352] Dynamic subtest gt_heartbeat: SUCCESS (4.313s) [554.685403] Starting dynamic subtest: gt_tlb [563.986991] Dynamic subtest gt_tlb: SUCCESS (9.304s) [563.996413] Starting dynamic subtest: requests [577.419574] Dynamic subtest requests: SUCCESS (13.426s) [577.428595] Starting dynamic subtest: migrate [583.146327] Dynamic subtest migrate: SUCCESS (5.729s) [583.155628] Starting dynamic subtest: active [585.872981] Dynamic subtest active: SUCCESS (2.726s) [585.880964] Starting dynamic subtest: objects [590.852053] Dynamic subtest objects: SUCCESS (4.979s) [590.861034] Starting dynamic subtest: mman [594.190337] Dynamic subtest mman: SUCCESS (3.337s) [594.199431] Starting dynamic subtest: dmabuf [596.948551] Dynamic subtest dmabuf: SUCCESS (2.757s) [596.957665] Starting dynamic subtest: vma [601.268207] Dynamic subtest vma: SUCCESS (4.319s) [601.277676] Starting dynamic subtest: coherency [606.403198] Dynamic subtest coherency: SUCCESS (5.133s) [606.411912] Starting dynamic subtest: gtt [618.073758] Dynamic subtest gtt: SUCCESS (11.667s) [618.082848] Starting dynamic subtest: gem [626.328432] Dynamic subtest gem: SUCCESS (8.251s) [626.337852] Starting dynamic subtest: evict [631.812169] Dynamic subtest evict: SUCCESS (5.483s) [631.821191] Starting dynamic subtest: hugepages [642.563202] Dynamic subtest hugepages: SUCCESS (10.747s) [642.572253] Starting dynamic subtest: gem_contexts [669.393100] Dynamic subtest gem_contexts: SUCCESS (26.820s) [669.402093] Starting dynamic subtest: client [673.743879] Dynamic subtest client: SUCCESS (4.348s) [673.752982] Starting dynamic subtest: gem_migrate [678.089954] Dynamic subtest gem_migrate: SUCCESS (4.342s) [678.099140] Starting dynamic subtest: reset [682.418166] Dynamic subtest reset: SUCCESS (4.324s) [682.427108] Starting dynamic subtest: memory_region [686.750425] Dynamic subtest memory_region: SUCCESS (4.330s) [686.759935] Starting dynamic subtest: hangcheck [699.703205] Dynamic subtest hangcheck: SUCCESS (12.948s) [699.711800] Starting dynamic subtest: execlists [704.010897] Dynamic subtest execlists: SUCCESS (4.305s) [704.018232] Starting dynamic subtest: ring_submission [708.328398] Dynamic subtest ring_submission: SUCCESS (4.317s) [708.337124] Starting dynamic subtest: perf [712.693015] Dynamic subtest perf: SUCCESS (4.364s) [712.701631] Starting dynamic subtest: slpc [726.802117] Dynamic subtest slpc: SUCCESS (14.110s) [726.810501] Starting dynamic subtest: guc [730.697763] Dynamic subtest guc: SUCCESS (3.895s) [730.705172] Starting dynamic subtest: guc_multi_lrc [735.026186] Dynamic subtest guc_multi_lrc: SUCCESS (4.328s) [735.034447] Starting dynamic subtest: guc_hang [739.964221] Dynamic subtest guc_hang: SUCCESS (4.936s) [739.973321] Starting dynamic subtest: late_gt_pm [744.291000] Dynamic subtest late_gt_pm: SUCCESS (4.326s) [744.292185] Subtest live: SUCCESS (244.297s) [744.314107] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [744.314800] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [744.317042] [049/132] (291s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [745.897144] Subtest writes-after-reads-uncached: SKIP (0.000s) [745.979063] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [745.980391] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true [745.982871] [050/132] (290s left) kms_getfb (getfb-handle-not-fb) [746.071833] Starting subtest: getfb-handle-not-fb [746.072749] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [746.158802] [051/132] (290s left) kms_psr (fbc-psr-sprite-plane-onoff) [746.243004] Starting subtest: fbc-psr-sprite-plane-onoff [746.243948] Starting dynamic subtest: eDP-1 [746.245948] Dynamic subtest eDP-1: SKIP (0.000s) [746.247752] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [746.311435] [052/132] (289s left) i915_hangman (gt-error-state-capture) [746.395387] Starting subtest: gt-error-state-capture [746.396341] Starting dynamic subtest: rcs0 [757.676074] Dynamic subtest rcs0: SUCCESS (11.272s) [757.685976] Starting dynamic subtest: bcs0 [768.683659] Dynamic subtest bcs0: SUCCESS (11.004s) [768.693471] Starting dynamic subtest: vcs0 [780.649828] Dynamic subtest vcs0: SUCCESS (11.964s) [780.657573] Starting dynamic subtest: vcs1 [792.619235] Dynamic subtest vcs1: SUCCESS (11.964s) [792.629833] Starting dynamic subtest: vecs0 [804.652973] Dynamic subtest vecs0: SUCCESS (12.029s) [804.663735] Starting dynamic subtest: ccs0 [816.620967] Dynamic subtest ccs0: SUCCESS (11.964s) [816.622627] Subtest gt-error-state-capture: SUCCESS (70.212s) [816.733836] [053/132] (219s left) perf (invalid-open-flags) [816.902662] Starting subtest: invalid-open-flags [816.903526] Subtest invalid-open-flags: SUCCESS (0.000s) [816.946199] [054/132] (219s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [817.033760] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [817.035581] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [817.131897] [055/132] (219s left) kms_async_flips (async-flip-with-page-flip-events-linear) [817.217561] Starting subtest: async-flip-with-page-flip-events-linear [817.598239] Starting dynamic subtest: pipe-A-eDP-1 [820.409516] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.801s) [820.762153] Starting dynamic subtest: pipe-B-eDP-1 [823.534662] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s) [823.905716] Starting dynamic subtest: pipe-C-eDP-1 [826.666629] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s) [827.016979] Starting dynamic subtest: pipe-D-eDP-1 [829.801885] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s) [829.803227] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.572s) [830.973060] [056/132] (205s left) sw_sync (alloc_fence) [831.005887] Starting subtest: alloc_fence [831.006816] Subtest alloc_fence: SUCCESS (0.000s) [831.059614] [057/132] (205s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [831.154586] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [831.155522] Starting dynamic subtest: pipe-A-default-mode [832.344478] Dynamic subtest pipe-A-default-mode: SKIP (1.187s) [832.346259] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.189s) [832.462265] [058/132] (204s left) gem_ctx_persistence (heartbeat-close) [832.512663] Starting subtest: heartbeat-close [832.514321] Subtest heartbeat-close: SKIP (0.000s) [832.615895] [059/132] (203s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [832.715318] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [832.716961] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [832.806087] [060/132] (203s left) kms_flip (2x-flip-vs-modeset) [832.890176] Starting subtest: 2x-flip-vs-modeset [832.900659] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [832.977917] [061/132] (203s left) sw_sync (alloc_timeline) [833.015722] Starting subtest: alloc_timeline [833.016638] Subtest alloc_timeline: SUCCESS (0.000s) [833.068160] [062/132] (203s left) gem_exec_fence (syncobj-timeline-chain-engines) [833.604100] Starting subtest: syncobj-timeline-chain-engines [833.727357] Subtest syncobj-timeline-chain-engines: SUCCESS (0.124s) [834.760868] [063/132] (201s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [834.852439] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [834.854102] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [834.919724] [064/132] (201s left) perf_pmu (all-busy-check-all) [834.952906] Starting subtest: all-busy-check-all [836.684510] Subtest all-busy-check-all: SUCCESS (1.722s) [836.784976] [065/132] (199s left) kms_chamelium_frames (hdmi-crc-single) [837.167009] Subtest hdmi-crc-single: SKIP (0.000s) [838.017173] [066/132] (198s left) kms_draw_crc (draw-method-mmap-wc) [838.107061] Starting subtest: draw-method-mmap-wc [838.108127] Starting dynamic subtest: xrgb8888-untiled [838.352305] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s) [838.362118] Starting dynamic subtest: rgb565-untiled [838.585466] Dynamic subtest rgb565-untiled: SUCCESS (0.231s) [838.593923] Starting dynamic subtest: xrgb2101010-untiled [838.807752] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [838.818081] Starting dynamic subtest: xbgr16161616f-untiled [839.007792] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s) [839.016116] Starting dynamic subtest: xrgb8888-xtiled [839.129825] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [839.138441] Starting dynamic subtest: rgb565-xtiled [839.252140] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [839.260481] Starting dynamic subtest: xrgb2101010-xtiled [839.374466] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [839.383044] Starting dynamic subtest: xbgr16161616f-xtiled [839.507859] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [839.517299] Starting dynamic subtest: xrgb8888-4tiled [839.708180] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.198s) [839.717439] Starting dynamic subtest: rgb565-4tiled [839.852449] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s) [839.860924] Starting dynamic subtest: xrgb2101010-4tiled [839.997003] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s) [840.005855] Starting dynamic subtest: xbgr16161616f-4tiled [840.163803] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s) [840.165770] Subtest draw-method-mmap-wc: SUCCESS (2.058s) [840.265910] [067/132] (196s left) kms_content_protection (atomic) [840.401189] Starting subtest: atomic [840.403116] Subtest atomic: SKIP (0.000s) [840.501078] [068/132] (196s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [840.590677] Starting subtest: ccs-on-another-bo-y-tiled-ccs [840.591611] Starting dynamic subtest: pipe-A-eDP-1 [840.600285] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [840.609279] Starting dynamic subtest: pipe-B-eDP-1 [840.618077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [840.629105] Starting dynamic subtest: pipe-C-eDP-1 [840.637171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [840.644993] Starting dynamic subtest: pipe-D-eDP-1 [840.653352] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [840.654987] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [842.913330] [069/132] (193s left) kms_psr (pr-primary-render) [842.994829] Starting subtest: pr-primary-render [842.996361] Subtest pr-primary-render: SKIP (0.000s) [843.062850] [070/132] (193s left) gem_exec_flush (basic-uc-ro-default) [843.116158] Starting subtest: basic-uc-ro-default [848.579090] Subtest basic-uc-ro-default: SUCCESS (5.462s) [848.764425] [071/132] (188s left) kms_dither (fb-8bpc-vs-panel-8bpc) [848.861471] Starting subtest: fb-8bpc-vs-panel-8bpc [848.862299] Starting dynamic subtest: pipe-A-eDP-1 [850.290254] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.426s) [850.291230] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.427s) [851.105166] [072/132] (185s left) gem_madvise (dontneed-after-mmap) [851.134521] Starting subtest: dontneed-after-mmap [851.160419] Subtest dontneed-after-mmap: SUCCESS (0.025s) [851.258469] [073/132] (185s left) kms_plane_alpha_blend (constant-alpha-mid) [851.353934] Starting subtest: constant-alpha-mid [851.643036] Starting dynamic subtest: pipe-A-eDP-1 [852.507622] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.864s) [852.515929] Starting dynamic subtest: pipe-D-eDP-1 [854.044400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s) [854.045692] Subtest constant-alpha-mid: SUCCESS (2.690s) [854.871451] [074/132] (182s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [854.931047] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [854.992484] [075/132] (182s left) kms_flip (2x-flip-vs-wf_vblank) [855.075398] Starting subtest: 2x-flip-vs-wf_vblank [855.086605] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s) [855.165657] [076/132] (181s left) kms_cursor_crc (cursor-sliding-128x42) [855.385645] Starting subtest: cursor-sliding-128x42 [855.430613] Subtest cursor-sliding-128x42: SKIP (0.043s) [855.639227] [077/132] (181s left) kms_psr (psr2-suspend) [855.725162] Starting subtest: psr2-suspend [855.726251] Starting dynamic subtest: eDP-1 [873.628752] Dynamic subtest eDP-1: SUCCESS (3.325s) [873.629562] Subtest psr2-suspend: SUCCESS (3.327s) [886.449009] [078/132] (162s left) gem_mmap_offset (open-flood) [886.500431] Starting subtest: open-flood [907.946060] Subtest open-flood: SUCCESS (21.489s) [908.042419] [079/132] (141s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [908.135359] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [908.137116] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [908.231665] [080/132] (141s left) gem_exec_nop (basic-sequential) [908.288191] Starting subtest: basic-sequential [922.730822] Subtest basic-sequential: SUCCESS (14.447s) [922.939636] [081/132] (126s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [923.039569] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [923.041407] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [923.110017] [082/132] (126s left) gem_mmap_gtt (basic-small-bo-tiledy) [923.168332] Subtest basic-small-bo-tiledY: SKIP (0.000s) [923.220834] [083/132] (126s left) kms_big_fb (y-tiled-64bpp-rotate-90) [923.313427] Starting subtest: y-tiled-64bpp-rotate-90 [923.315509] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [923.402076] [084/132] (126s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [923.494600] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [932.598672] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (9.103s) [932.731384] [085/132] (116s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [932.822749] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [932.824356] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [932.913096] [086/132] (116s left) syncobj_timeline (etime-single-wait-submitted) [932.966960] Starting subtest: etime-single-wait-submitted [933.073129] Subtest etime-single-wait-submitted: SUCCESS (0.106s) [933.151791] [087/132] (116s left) i915_drm_fdinfo (virtual-busy-all) [933.193703] Starting subtest: virtual-busy-all [933.195357] Subtest virtual-busy-all: SKIP (0.000s) [933.254222] [088/132] (116s left) gem_ctx_exec (basic) [933.311824] Starting subtest: basic [933.317189] Subtest basic: SUCCESS (0.006s) [933.434216] [089/132] (116s left) gem_busy (parallel) [933.607992] Starting subtest: parallel [933.609102] Starting dynamic subtest: rcs0 [935.295007] Dynamic subtest rcs0: SUCCESS (1.684s) [935.304990] Starting dynamic subtest: bcs0 [937.279568] Dynamic subtest bcs0: SUCCESS (1.981s) [937.295871] Starting dynamic subtest: vcs0 [939.263386] Dynamic subtest vcs0: SUCCESS (1.981s) [939.274262] Starting dynamic subtest: vcs1 [941.247399] Dynamic subtest vcs1: SUCCESS (1.982s) [941.258958] Starting dynamic subtest: vecs0 [943.231781] Dynamic subtest vecs0: SUCCESS (1.982s) [943.242938] Starting dynamic subtest: ccs0 [945.279148] Dynamic subtest ccs0: SUCCESS (2.045s) [945.280455] Subtest parallel: SUCCESS (11.670s) [945.516218] [090/132] (104s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [945.566473] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [945.567419] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [945.664331] [091/132] (103s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [945.751355] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [945.752861] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [945.840643] [092/132] (103s left) kms_vblank (ts-continuation-dpms-rpm) [945.920686] Starting subtest: ts-continuation-dpms-rpm [945.921576] Starting dynamic subtest: pipe-A-eDP-1 [948.411733] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.490s) [948.421625] Starting dynamic subtest: pipe-D-eDP-1 [950.664364] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.250s) [950.665253] Subtest ts-continuation-dpms-rpm: SUCCESS (4.744s) [951.545693] [093/132] ( 98s left) sw_sync (timeline_closed_signaled) [951.576289] Starting subtest: timeline_closed_signaled [951.577342] Subtest timeline_closed_signaled: SUCCESS (0.000s) [951.631691] [094/132] ( 98s left) gem_lmem_swapping (verify) [951.665330] Subtest verify: SKIP (0.000s) [951.704721] [095/132] ( 98s left) syncobj_wait (invalid-signal-zero-handles) [951.755315] Starting subtest: invalid-signal-zero-handles [951.756311] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [951.841151] [096/132] ( 98s left) kms_pm_rpm (i2c) [953.457993] Starting subtest: i2c [959.037724] Subtest i2c: SUCCESS (5.583s) [959.122719] [097/132] ( 90s left) vgem_basic (setversion) [959.166072] Starting subtest: setversion [959.167843] Subtest setversion: SUCCESS (0.000s) [959.232930] [098/132] ( 90s left) gem_exec_reloc (basic-write-gtt) [959.293552] Subtest basic-write-gtt: SKIP (0.000s) [959.373371] [099/132] ( 90s left) kms_scaling_modes (scaling-mode-center) [959.455897] Starting subtest: scaling-mode-center [959.456887] Starting dynamic subtest: pipe-A-eDP-1 [959.558070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.101s) [959.570376] Starting dynamic subtest: pipe-B-eDP-1 [960.733318] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.172s) [960.747932] Starting dynamic subtest: pipe-C-eDP-1 [961.849454] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s) [961.859925] Starting dynamic subtest: pipe-D-eDP-1 [962.977410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s) [962.978388] Subtest scaling-mode-center: SUCCESS (3.522s) [964.133201] [100/132] ( 85s left) perf_pmu (frequency) [964.167781] Starting subtest: frequency [964.171572] Starting dynamic subtest: gt0 [966.290792] Dynamic subtest gt0: SUCCESS (2.117s) [966.310538] Starting dynamic subtest: idle-gt0 [966.806738] Dynamic subtest idle-gt0: SUCCESS (0.504s) [966.815616] Starting dynamic subtest: gt1 [971.259964] Dynamic subtest gt1: SUCCESS (4.450s) [971.272387] Starting dynamic subtest: idle-gt1 [971.765808] Dynamic subtest idle-gt1: SUCCESS (0.504s) [971.766910] Subtest frequency: SUCCESS (7.594s) [971.859379] [101/132] ( 78s left) kms_big_fb (4-tiled-32bpp-rotate-180) [971.984473] Starting subtest: 4-tiled-32bpp-rotate-180 [973.471337] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.488s) [973.611531] [102/132] ( 76s left) kms_hdr (bpc-switch-dpms) [973.698594] Starting subtest: bpc-switch-dpms [974.800135] Starting dynamic subtest: pipe-A-eDP-1 [979.253454] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.454s) [979.254469] Subtest bpc-switch-dpms: SUCCESS (5.557s) [979.350511] [103/132] ( 70s left) syncobj_timeline (wait-any-interrupted) [979.404755] Starting subtest: wait-any-interrupted [979.513511] Subtest wait-any-interrupted: SUCCESS (0.107s) [979.610605] [104/132] ( 70s left) gem_exec_parallel (contexts) [979.665725] Starting subtest: contexts [979.666881] Starting dynamic subtest: rcs0 [982.683330] Dynamic subtest rcs0: SUCCESS (3.009s) [982.695516] Starting dynamic subtest: bcs0 [986.029214] Dynamic subtest bcs0: SUCCESS (3.344s) [986.040040] Starting dynamic subtest: vcs0 [989.758326] Dynamic subtest vcs0: SUCCESS (3.726s) [989.769928] Starting dynamic subtest: vcs1 [993.771462] Dynamic subtest vcs1: SUCCESS (4.009s) [993.783010] Starting dynamic subtest: vecs0 [997.831823] Dynamic subtest vecs0: SUCCESS (4.056s) [997.842257] Starting dynamic subtest: ccs0 [1001.273819] Dynamic subtest ccs0: SUCCESS (3.439s) [1001.275065] Subtest contexts: SUCCESS (21.596s) [1001.450637] [105/132] ( 48s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [1001.574300] Starting subtest: verify-pxp-key-change-after-suspend-resume [1008.748385] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.174s) [1015.896602] [106/132] ( 41s left) gem_create (create-ext-placement-each) [1016.059452] Starting subtest: create-ext-placement-each [1016.060328] Subtest create-ext-placement-each: SUCCESS (0.000s) [1016.148637] [107/132] ( 41s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [1016.239019] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [1016.239941] Starting dynamic subtest: pipe-A-eDP-1 [1016.247879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [1016.257140] Starting dynamic subtest: pipe-B-eDP-1 [1016.264805] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [1016.273998] Starting dynamic subtest: pipe-C-eDP-1 [1016.280913] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [1016.289761] Starting dynamic subtest: pipe-D-eDP-1 [1016.296576] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [1016.297323] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [1018.479886] [108/132] ( 38s left) gem_close_race (basic-process) [1018.549612] Starting subtest: basic-process [1018.599464] Subtest basic-process: SUCCESS (0.049s) [1018.792173] [109/132] ( 38s left) gem_exec_schedule (u-independent) [1018.858695] Starting subtest: u-independent [1018.859693] Starting dynamic subtest: rcs0 [1020.285766] Dynamic subtest rcs0: SUCCESS (1.418s) [1020.298370] Starting dynamic subtest: vcs0 [1022.283250] Dynamic subtest vcs0: SUCCESS (1.995s) [1022.295099] Starting dynamic subtest: vcs1 [1024.261859] Dynamic subtest vcs1: SUCCESS (1.976s) [1024.280770] Starting dynamic subtest: vecs0 [1026.237783] Dynamic subtest vecs0: SUCCESS (1.973s) [1026.250062] Starting dynamic subtest: ccs0 [1028.285842] Dynamic subtest ccs0: SUCCESS (2.046s) [1028.287196] Subtest u-independent: SUCCESS (9.421s) [1028.575476] [110/132] ( 28s left) gen9_exec_parse (batch-without-end) [1028.629837] Subtest batch-without-end: SKIP (0.000s) [1028.700721] [111/132] ( 28s left) kms_pm_rpm (dpms-mode-unset-lpsp) [1030.418213] Starting subtest: dpms-mode-unset-lpsp [1034.470766] Subtest dpms-mode-unset-lpsp: SUCCESS (4.052s) [1034.862031] [112/132] ( 22s left) kms_chamelium_hpd (vga-hpd) [1035.248001] Subtest vga-hpd: SKIP (0.000s) [1036.055616] [113/132] ( 21s left) gem_lmem_swapping (heavy-multi) [1036.089711] Subtest heavy-multi: SKIP (0.000s) [1036.137206] [114/132] ( 21s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [1036.233526] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf [1036.235186] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [1036.304167] [115/132] ( 21s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [1036.399022] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [1036.400740] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [1036.501044] [116/132] ( 21s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [1036.588091] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [1041.106497] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.520s) [1042.294897] [117/132] ( 15s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [1042.384326] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [1049.733892] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.351s) [1049.849877] [118/132] ( 7s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [1049.933943] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [1049.935627] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [1050.025992] [119/132] ( 7s left) gem_exec_balancer (noheartbeat) [1050.296849] Starting subtest: noheartbeat [1050.298581] Subtest noheartbeat: SKIP (0.000s) [1050.380027] [120/132] ( 7s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [1050.424241] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [1050.528285] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [1050.602474] [121/132] ( 7s left) kms_big_fb (linear-addfb) [1050.703253] Starting subtest: linear-addfb [1050.704208] Subtest linear-addfb: SUCCESS (0.000s) [1050.793299] [122/132] ( 7s left) perf_pmu (busy) [1050.826278] Starting subtest: busy [1050.827113] Starting dynamic subtest: rcs0 [1051.409454] Dynamic subtest rcs0: SUCCESS (0.582s) [1051.423133] Starting dynamic subtest: bcs0 [1051.975267] Dynamic subtest bcs0: SUCCESS (0.563s) [1051.988554] Starting dynamic subtest: vcs0 [1053.240022] Dynamic subtest vcs0: SUCCESS (1.262s) [1053.253611] Starting dynamic subtest: vcs1 [1055.229579] Dynamic subtest vcs1: SUCCESS (1.978s) [1055.241866] Starting dynamic subtest: vecs0 [1057.277255] Dynamic subtest vecs0: SUCCESS (2.045s) [1057.289177] Starting dynamic subtest: ccs0 [1057.846742] Dynamic subtest ccs0: SUCCESS (0.576s) [1057.848195] Subtest busy: SUCCESS (7.022s) [1057.931558] Overall timeout time exceeded, stopping. [1057.948661] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: sysfs_timeslice_duration results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: drm_buddy results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: perf_pmu results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: gem_exec_balancer results: parsing output: 15/ for test: kms_joiner results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: gem_wait results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_lease results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: api_intel_bb results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: i915_pm_rpm results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: gem_exec_schedule results: parsing output: 27/ for test: gem_exec_flush results: parsing output: 28/ for test: kms_color_pipeline results: parsing output: 29/ for test: gem_exec_schedule results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: perf results: parsing output: 32/ for test: api_intel_bb results: parsing output: 33/ for test: prime_mmap results: parsing output: 34/ for test: kms_atomic_transition results: parsing output: 35/ for test: kms_plane_scaling results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_pxp results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_userptr_blits results: parsing output: 40/ for test: gem_eio results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_selftest results: parsing output: 44/ for test: gem_spin_batch results: parsing output: 45/ for test: testdisplay results: parsing output: 46/ for test: kms_psr2_sf results: parsing output: 47/ for test: i915_selftest results: parsing output: 48/ for test: gem_partial_pwrite_pread results: parsing output: 49/ for test: kms_getfb results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_async_flips results: parsing output: 55/ for test: sw_sync results: parsing output: 56/ for test: kms_flip_scaled_crc results: parsing output: 57/ for test: gem_ctx_persistence results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: sw_sync results: parsing output: 61/ for test: gem_exec_fence results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: kms_chamelium_frames results: parsing output: 65/ for test: kms_draw_crc results: parsing output: 66/ for test: kms_content_protection results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: gem_exec_flush results: parsing output: 70/ for test: kms_dither results: parsing output: 71/ for test: gem_madvise results: parsing output: 72/ for test: kms_plane_alpha_blend results: parsing output: 73/ for test: kms_pipe_b_c_ivb results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_cursor_crc results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: gem_mmap_offset results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_nop results: parsing output: 80/ for test: kms_flip_scaled_crc results: parsing output: 81/ for test: gem_mmap_gtt results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: i915_drm_fdinfo results: parsing output: 87/ for test: gem_ctx_exec results: parsing output: 88/ for test: gem_busy results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: kms_flip_scaled_crc results: parsing output: 91/ for test: kms_vblank results: parsing output: 92/ for test: sw_sync results: parsing output: 93/ for test: gem_lmem_swapping results: parsing output: 94/ for test: syncobj_wait results: parsing output: 95/ for test: kms_pm_rpm results: parsing output: 96/ for test: vgem_basic results: parsing output: 97/ for test: gem_exec_reloc results: parsing output: 98/ for test: kms_scaling_modes results: parsing output: 99/ for test: perf_pmu results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: kms_hdr results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: gem_exec_parallel results: parsing output: 104/ for test: gem_pxp results: parsing output: 105/ for test: gem_create results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: gem_close_race results: parsing output: 108/ for test: gem_exec_schedule results: parsing output: 109/ for test: gen9_exec_parse results: parsing output: 110/ for test: kms_pm_rpm results: parsing output: 111/ for test: kms_chamelium_hpd results: parsing output: 112/ for test: gem_lmem_swapping results: parsing output: 113/ for test: kms_psr2_sf results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_exec_balancer results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: perf_pmu results: parsing output: 122/ for test: kms_force_connector_basic results: no output, setting notrun results: parsing output: 123/ for test: gem_ctx_param results: no output, setting notrun results: parsing output: 124/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 125/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 126/ for test: kms_flip results: no output, setting notrun results: parsing output: 127/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 128/ for test: gem_exec_whisper results: no output, setting notrun results: parsing output: 129/ for test: kms_plane_lowres results: no output, setting notrun results: parsing output: 130/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 131/ for test: prime_vgem results: no output, setting notrun Done.