[61.058277] Initializing watchdogs [61.058324] /dev/watchdog0 [61.075564] [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] [61.079867] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.082184] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.085473] [001/132] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [61.167471] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [61.275235] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [61.349476] [002/132] (960s left) kms_chamelium_frames (dp-crc-multiple) [61.735827] Subtest dp-crc-multiple: SKIP (0.000s) [62.581836] [003/132] (959s left) gem_userptr_blits (sync-unmap-after-close) [62.676096] Starting subtest: sync-unmap-after-close [62.693741] Subtest sync-unmap-after-close: SUCCESS (0.019s) [62.813013] [004/132] (958s left) kms_psr (pr-sprite-plane-onoff) [62.914990] Starting subtest: pr-sprite-plane-onoff [62.919111] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [62.982479] [005/132] (958s left) i915_drm_fdinfo (most-busy-idle-check-all) [63.030153] Starting subtest: most-busy-idle-check-all [63.032392] Starting dynamic subtest: rcs0 [63.039344] Dynamic subtest rcs0: SKIP (0.005s) [63.045993] Starting dynamic subtest: bcs0 [63.050149] Dynamic subtest bcs0: SKIP (0.000s) [63.056713] Starting dynamic subtest: vcs0 [63.060682] Dynamic subtest vcs0: SKIP (0.000s) [63.067304] Starting dynamic subtest: vcs1 [63.071468] Dynamic subtest vcs1: SKIP (0.000s) [63.078035] Starting dynamic subtest: vecs0 [63.082060] Dynamic subtest vecs0: SKIP (0.000s) [63.088459] Starting dynamic subtest: ccs0 [63.092551] Dynamic subtest ccs0: SKIP (0.000s) [63.096786] Subtest most-busy-idle-check-all: SKIP (0.008s) [63.129146] [006/132] (958s left) gem_ctx_isolation (nonpriv) [63.218041] Starting subtest: nonpriv [63.220356] Starting dynamic subtest: rcs0 [63.452137] Dynamic subtest rcs0: SUCCESS (0.235s) [63.461828] Starting dynamic subtest: bcs0 [63.698110] Dynamic subtest bcs0: SUCCESS (0.246s) [63.706251] Starting dynamic subtest: vcs0 [63.946267] Dynamic subtest vcs0: SUCCESS (0.249s) [63.955947] Starting dynamic subtest: vcs1 [65.118977] Dynamic subtest vcs1: SUCCESS (1.175s) [65.128707] Starting dynamic subtest: vecs0 [67.255014] Dynamic subtest vecs0: SUCCESS (2.141s) [67.265418] Starting dynamic subtest: ccs0 [69.151785] Dynamic subtest ccs0: SUCCESS (1.899s) [69.154302] Subtest nonpriv: SUCCESS (5.948s) [69.386544] [007/132] (952s left) gem_exec_fence (syncobj-timeline-unused-fence) [69.976340] Starting subtest: syncobj-timeline-unused-fence [69.984594] Subtest syncobj-timeline-unused-fence: SUCCESS (0.010s) [71.028819] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [71.031519] [008/132] (950s left) sw_sync (sync_multi_producer_single_consumer) [71.066920] Starting subtest: sync_multi_producer_single_consumer [72.140544] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [72.198100] [009/132] (949s left) kms_cursor_edge_walk (64x64-left-edge) [72.283576] Starting subtest: 64x64-left-edge [72.285864] Starting dynamic subtest: pipe-A-eDP-1 [75.758443] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s) [75.766959] Starting dynamic subtest: pipe-D-eDP-1 [78.885648] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s) [78.888076] Subtest 64x64-left-edge: SUCCESS (6.606s) [79.712700] [010/132] (942s left) i915_selftest (perf) [81.337817] Starting subtest: perf [81.340387] Starting dynamic subtest: engine_cs [85.631974] Dynamic subtest engine_cs: SUCCESS (4.293s) [85.641931] Starting dynamic subtest: request [90.877804] Dynamic subtest request: SUCCESS (5.245s) [90.886142] Starting dynamic subtest: migrate [93.637994] Dynamic subtest migrate: SUCCESS (2.759s) [93.646939] Starting dynamic subtest: region [99.228615] Dynamic subtest region: SUCCESS (5.590s) [99.231071] Subtest perf: SUCCESS (17.889s) [99.257785] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [99.258544] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [99.261655] [011/132] (922s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [100.801098] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [101.813890] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.014s) [101.921451] [FACT kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [101.922616] [FACT kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)] new: kernel.kmod_is_loaded.i915: true [101.926098] [012/132] (920s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [102.019444] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [102.023347] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [102.105835] [013/132] (919s left) kms_atomic_interruptible (legacy-setmode) [102.189050] Starting subtest: legacy-setmode [102.191067] Starting dynamic subtest: pipe-A-eDP-1 [109.109302] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.920s) [109.111704] Subtest legacy-setmode: SUCCESS (6.920s) [109.978628] [014/132] (912s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [110.091787] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [110.096493] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [111.243405] [015/132] (910s left) gem_exec_schedule (preemptive-hang) [111.423423] Starting subtest: preemptive-hang [111.425428] Starting dynamic subtest: rcs0 [121.024511] Dynamic subtest rcs0: SUCCESS (9.604s) [121.035532] Starting dynamic subtest: bcs0 [130.046695] Dynamic subtest bcs0: SUCCESS (9.020s) [130.056019] Starting dynamic subtest: vcs0 [139.002800] Dynamic subtest vcs0: SUCCESS (8.955s) [139.010336] Starting dynamic subtest: vcs1 [148.026898] Dynamic subtest vcs1: SUCCESS (9.023s) [148.036945] Starting dynamic subtest: vecs0 [157.053213] Dynamic subtest vecs0: SUCCESS (9.025s) [157.063312] Starting dynamic subtest: ccs0 [166.012011] Dynamic subtest ccs0: SUCCESS (8.959s) [166.014343] Subtest preemptive-hang: SUCCESS (54.591s) [166.258216] [016/132] (855s left) gem_lmem_swapping (verify-random-ccs) [166.305157] Subtest verify-random-ccs: SKIP (0.000s) [166.344243] [017/132] (855s left) kms_cursor_legacy (single-move) [166.468887] Starting subtest: single-move [166.471314] Starting dynamic subtest: pipe-A [171.852442] Dynamic subtest pipe-A: SUCCESS (5.379s) [171.863070] Starting dynamic subtest: pipe-B [177.236635] Dynamic subtest pipe-B: SUCCESS (5.381s) [177.245742] Starting dynamic subtest: pipe-C [182.616406] Dynamic subtest pipe-C: SUCCESS (5.380s) [182.626013] Starting dynamic subtest: pipe-D [187.998093] Dynamic subtest pipe-D: SUCCESS (5.380s) [188.008165] Starting dynamic subtest: all-pipes [193.385933] Dynamic subtest all-pipes: SUCCESS (5.386s) [193.388481] Subtest single-move: SUCCESS (26.912s) [193.528886] [018/132] (828s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [193.616311] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [193.618767] Starting dynamic subtest: pipe-A-eDP-1 [194.449082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s) [194.457585] Starting dynamic subtest: pipe-B-eDP-1 [196.054906] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.602s) [196.062650] Starting dynamic subtest: pipe-C-eDP-1 [197.544361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s) [197.554144] Starting dynamic subtest: pipe-D-eDP-1 [199.060949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s) [199.063219] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.436s) [200.236059] [019/132] (822s left) kms_rmfb (close-fd) [200.326541] Starting subtest: close-fd [200.328819] Starting dynamic subtest: pipe-A-eDP-1 [200.434764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s) [200.442362] Starting dynamic subtest: pipe-B-eDP-1 [201.595301] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s) [201.604960] Starting dynamic subtest: pipe-C-eDP-1 [202.725302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s) [202.734161] Starting dynamic subtest: pipe-D-eDP-1 [203.860556] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [203.862679] Subtest close-fd: SUCCESS (3.534s) [205.072011] [020/132] (817s left) gem_mmap_gtt (basic-short) [205.132740] Subtest basic-short: SKIP (0.000s) [205.204725] [021/132] (817s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [205.253890] Starting subtest: multi-wait-for-submit-available-submitted-signaled [205.256155] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [205.350962] [022/132] (817s left) kms_color (degamma) [205.447484] Starting subtest: degamma [205.449688] Starting dynamic subtest: pipe-A-eDP-1 [206.193518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s) [206.202059] Starting dynamic subtest: pipe-B-eDP-1 [207.613429] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s) [207.622656] Starting dynamic subtest: pipe-C-eDP-1 [208.973948] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s) [208.981866] Starting dynamic subtest: pipe-D-eDP-1 [210.303481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s) [210.305772] Subtest degamma: SUCCESS (4.855s) [211.088821] [023/132] (811s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [211.142063] Starting subtest: etime-single-wait-for-submit-unsubmitted [211.250519] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s) [211.325509] [024/132] (811s left) gem_softpin (allocator-evict) [211.398803] Starting subtest: allocator-evict [211.401221] Starting dynamic subtest: rcs0 [234.445874] Dynamic subtest rcs0: SUCCESS (23.045s) [234.457075] Starting dynamic subtest: bcs0 [258.030302] Dynamic subtest bcs0: SUCCESS (23.582s) [258.038667] Starting dynamic subtest: vcs0 [281.922482] Dynamic subtest vcs0: SUCCESS (23.891s) [281.931082] Starting dynamic subtest: vcs1 [305.396107] Dynamic subtest vcs1: SUCCESS (23.471s) [305.406443] Starting dynamic subtest: vecs0 [329.185945] Dynamic subtest vecs0: SUCCESS (23.787s) [329.196755] Starting dynamic subtest: ccs0 [352.651650] Dynamic subtest ccs0: SUCCESS (23.464s) [352.654029] Subtest allocator-evict: SUCCESS (141.247s) [352.730814] [025/132] (669s left) kms_plane_scaling (planes-scaler-unity-scaling) [352.876226] Starting subtest: planes-scaler-unity-scaling [352.878589] Starting dynamic subtest: pipe-A [352.938279] Dynamic subtest pipe-A: SUCCESS (0.064s) [352.946405] Starting dynamic subtest: pipe-B [354.114992] Dynamic subtest pipe-B: SUCCESS (1.175s) [354.125076] Starting dynamic subtest: pipe-C [355.227375] Dynamic subtest pipe-C: SUCCESS (1.111s) [355.240505] Starting dynamic subtest: pipe-D [356.581881] Dynamic subtest pipe-D: SUCCESS (1.354s) [356.584121] Subtest planes-scaler-unity-scaling: SUCCESS (3.708s) [357.743874] [026/132] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [357.868532] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [365.291469] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.423s) [365.437413] [027/132] (657s left) gem_eio (in-flight-contexts-1us) [365.671069] Starting subtest: in-flight-contexts-1us [376.939623] Subtest in-flight-contexts-1us: SUCCESS (11.268s) [377.075382] [028/132] (645s left) gem_mmap_offset (ptrace) [377.146546] Starting subtest: ptrace [377.148932] Starting dynamic subtest: smem0-wb [377.164674] Dynamic subtest smem0-wb: SUCCESS (0.017s) [377.175736] Starting dynamic subtest: smem0-wc [377.189790] Dynamic subtest smem0-wc: SUCCESS (0.024s) [377.198412] Starting dynamic subtest: smem0-uc [377.210832] Dynamic subtest smem0-uc: SUCCESS (0.020s) [377.213537] Subtest ptrace: SUCCESS (0.067s) [377.340836] [029/132] (645s left) syncobj_wait (wait-for-submit-snapshot) [377.401269] Starting subtest: wait-for-submit-snapshot [377.482819] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [377.559457] [030/132] (645s left) kms_psr (psr2-sprite-blt) [377.667584] Starting subtest: psr2-sprite-blt [377.669849] Starting dynamic subtest: eDP-1 [379.445528] Dynamic subtest eDP-1: SUCCESS (1.776s) [379.447888] Subtest psr2-sprite-blt: SUCCESS (1.778s) [380.309071] [031/132] (642s left) gem_exec_balancer (full-pulse) [380.370639] Starting subtest: full-pulse [384.769278] Subtest full-pulse: SUCCESS (4.398s) [385.083917] [032/132] (637s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [385.191822] Starting subtest: fbcpsr-stridechange [391.432075] Subtest fbcpsr-stridechange: SUCCESS (6.243s) [391.579746] [033/132] (631s left) gem_exec_schedule (semaphore-noskip) [391.664624] Starting subtest: semaphore-noskip [392.076961] Subtest semaphore-noskip: SUCCESS (0.419s) [392.430269] [034/132] (630s left) kms_pm_dc (dc6-psr) [393.526774] Starting subtest: dc6-psr [396.408262] Subtest dc6-psr: SUCCESS (2.882s) [397.273155] [035/132] (625s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [397.374197] Starting subtest: yf-tiled-64bpp-rotate-90 [397.378771] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [397.478324] [036/132] (625s left) perf_pmu (busy-accuracy-98) [397.523316] Starting subtest: busy-accuracy-98 [397.525645] Starting dynamic subtest: rcs0 [400.559728] Dynamic subtest rcs0: SUCCESS (3.037s) [400.571176] Starting dynamic subtest: bcs0 [403.615025] Dynamic subtest bcs0: SUCCESS (3.054s) [403.625819] Starting dynamic subtest: vcs0 [406.662247] Dynamic subtest vcs0: SUCCESS (3.044s) [406.673686] Starting dynamic subtest: vcs1 [409.705131] Dynamic subtest vcs1: SUCCESS (3.042s) [409.716258] Starting dynamic subtest: vecs0 [412.747572] Dynamic subtest vecs0: SUCCESS (3.041s) [412.758118] Starting dynamic subtest: ccs0 [415.803297] Dynamic subtest ccs0: SUCCESS (3.054s) [415.805729] Subtest busy-accuracy-98: SUCCESS (18.281s) [415.930183] [037/132] (607s left) fbdev (eof) [415.968870] Starting subtest: eof [415.971210] Subtest eof: SUCCESS (0.000s) [416.047044] [038/132] (607s left) dumb_buffer (map-invalid-size) [416.095911] Starting subtest: map-invalid-size [416.098404] Subtest map-invalid-size: SUCCESS (0.000s) [416.196747] [039/132] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [416.291298] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [416.295604] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [416.401571] [040/132] (606s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [416.497535] Starting subtest: 2x-flip-vs-absolute-wf_vblank [416.506282] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s) [416.589485] [041/132] (606s left) kms_feature_discovery (psr1) [416.677854] Starting subtest: psr1 [416.680086] Subtest psr1: SUCCESS (0.000s) [416.754885] [042/132] (606s left) gem_create (create-ext-placement-each) [416.918058] Starting subtest: create-ext-placement-each [416.921035] Subtest create-ext-placement-each: SUCCESS (0.000s) [417.027288] [043/132] (606s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [417.122980] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [423.926835] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.806s) [424.068159] [044/132] (599s left) prime_mmap (test_reprime) [424.124572] Starting subtest: test_reprime [424.127188] Starting dynamic subtest: test_reprime-smem [424.152082] Dynamic subtest test_reprime-smem: SUCCESS (0.031s) [424.154886] Subtest test_reprime: SUCCESS (0.031s) [424.257974] [045/132] (599s left) gem_mmap_gtt (big-bo) [424.315484] Subtest big-bo: SKIP (0.000s) [424.374467] [046/132] (599s left) gem_ctx_persistence (heartbeat-hostile) [424.439507] Starting subtest: heartbeat-hostile [424.444153] Subtest heartbeat-hostile: SKIP (0.000s) [424.547293] [047/132] (598s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [424.642067] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [424.653117] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s) [424.760022] [048/132] (598s left) gem_basic (create-close) [424.821156] Starting subtest: create-close [424.825507] Subtest create-close: SUCCESS (0.000s) [424.931417] [049/132] (598s left) syncobj_wait (multi-wait-submitted-signaled) [424.992802] Starting subtest: multi-wait-submitted-signaled [424.994525] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [425.095948] [050/132] (598s left) i915_pm_rc6_residency (rc6-accuracy) [425.163063] Starting subtest: rc6-accuracy [425.164677] Starting dynamic subtest: gt0 [428.334409] Dynamic subtest gt0: SUCCESS (3.168s) [428.344052] Starting dynamic subtest: gt1 [431.505974] Dynamic subtest gt1: SUCCESS (3.168s) [431.508475] Subtest rc6-accuracy: SUCCESS (6.342s) [431.585489] [051/132] (592s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [431.689594] Starting subtest: psr-2p-scndscrn-cur-indfb-move [431.693884] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [431.787226] [052/132] (591s left) gem_pxp (hw-rejects-pxp-buffer) [431.912049] Starting subtest: hw-rejects-pxp-buffer [431.917077] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [432.018031] [053/132] (591s left) gem_exec_capture (pi) [432.086295] Starting subtest: pi [432.088605] Starting dynamic subtest: rcs0 [435.998882] Dynamic subtest rcs0: SUCCESS (3.912s) [436.009095] Starting dynamic subtest: bcs0 [439.805629] Dynamic subtest bcs0: SUCCESS (3.805s) [439.819274] Starting dynamic subtest: vcs0 [443.763955] Dynamic subtest vcs0: SUCCESS (3.957s) [443.775659] Starting dynamic subtest: vcs1 [447.653446] Dynamic subtest vcs1: SUCCESS (3.888s) [447.663297] Starting dynamic subtest: vecs0 [451.481038] Dynamic subtest vecs0: SUCCESS (3.827s) [451.490310] Starting dynamic subtest: ccs0 [455.343805] Dynamic subtest ccs0: SUCCESS (3.861s) [455.346305] Subtest pi: SUCCESS (23.258s) [455.425916] [054/132] (568s left) gen9_exec_parse (bb-start-param) [455.523064] Subtest bb-start-param: SKIP (0.000s) [455.589177] [055/132] (568s left) kms_pipe_crc_basic (nonblocking-crc) [455.699985] Starting subtest: nonblocking-crc [455.702329] Starting dynamic subtest: pipe-A-eDP-1 [456.435329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s) [456.445488] Starting dynamic subtest: pipe-B-eDP-1 [457.916944] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.478s) [457.926887] Starting dynamic subtest: pipe-C-eDP-1 [459.262239] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s) [459.272236] Starting dynamic subtest: pipe-D-eDP-1 [460.584490] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s) [460.586836] Subtest nonblocking-crc: SUCCESS (4.887s) [461.399596] [056/132] (562s left) gem_exec_fence (syncobj-invalid-wait) [461.839436] Starting subtest: syncobj-invalid-wait [461.842038] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [463.002707] [057/132] (560s left) gem_exec_whisper (basic-queues-all) [463.062409] Starting subtest: basic-queues-all [474.870076] Subtest basic-queues-all: SUCCESS (11.802s) [475.054743] [058/132] (548s left) kms_psr (fbc-pr-sprite-mmap-gtt) [475.151148] Starting subtest: fbc-pr-sprite-mmap-gtt [475.155494] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [475.225940] [059/132] (548s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [475.327995] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [475.332609] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [475.431600] [060/132] (548s left) syncobj_timeline (invalid-signal-illegal-handle) [475.479602] Starting subtest: invalid-signal-illegal-handle [475.481821] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [475.551503] [061/132] (548s left) sw_sync (sync_expired_merge) [475.592090] Starting subtest: sync_expired_merge [476.667300] Subtest sync_expired_merge: SUCCESS (1.074s) [476.732084] [062/132] (547s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [476.802257] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [476.869298] [063/132] (547s left) kms_lease (setcrtc-implicit-plane) [476.980562] Starting subtest: setcrtc-implicit-plane [476.982662] Starting dynamic subtest: pipe-A-eDP-1 [477.476560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s) [477.486345] Starting dynamic subtest: pipe-B-eDP-1 [478.641299] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s) [478.651410] Starting dynamic subtest: pipe-C-eDP-1 [479.763762] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s) [479.773591] Starting dynamic subtest: pipe-D-eDP-1 [480.885561] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s) [480.887434] Subtest setcrtc-implicit-plane: SUCCESS (3.903s) [481.735236] [064/132] (542s left) kms_flip (flip-vs-suspend-interruptible) [481.823778] Starting subtest: flip-vs-suspend-interruptible [481.825982] Starting dynamic subtest: A-eDP1 [531.362850] Dynamic subtest A-eDP1: SUCCESS (4.708s) [531.373825] Starting dynamic subtest: B-eDP1 [580.339058] Dynamic subtest B-eDP1: SUCCESS (4.470s) [580.350195] Starting dynamic subtest: C-eDP1 [629.357256] Dynamic subtest C-eDP1: SUCCESS (4.520s) [629.367747] Starting dynamic subtest: D-eDP1 [678.363212] Dynamic subtest D-eDP1: SUCCESS (4.536s) [678.366294] Subtest flip-vs-suspend-interruptible: SUCCESS (18.244s) [679.546228] [065/132] (344s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [679.695745] Starting subtest: dp-mst-lic-type-0-hdcp14 [679.700436] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [679.818529] [066/132] (344s left) perf (gen8-unprivileged-single-ctx-counters) [679.946632] Starting subtest: gen8-unprivileged-single-ctx-counters [679.950798] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [679.991700] [067/132] (344s left) kms_fbcon_fbt (psr-suspend) [680.048581] Starting subtest: psr-suspend [729.354866] Subtest psr-suspend: SUCCESS (19.925s) [729.425756] [068/132] (294s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [729.524504] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [729.528402] Starting dynamic subtest: A-eDP1 [733.171717] Dynamic subtest A-eDP1: SUCCESS (3.670s) [733.185232] Starting dynamic subtest: B-eDP1 [736.465771] Dynamic subtest B-eDP1: SUCCESS (3.307s) [736.475910] Starting dynamic subtest: C-eDP1 [739.597514] Dynamic subtest C-eDP1: SUCCESS (3.139s) [739.608427] Starting dynamic subtest: D-eDP1 [742.712114] Dynamic subtest D-eDP1: SUCCESS (3.122s) [742.716996] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.252s) [743.520424] [069/132] (280s left) gem_render_copy_redux (flink-interruptible) [743.592521] Starting subtest: flink-interruptible [744.342538] Subtest flink-interruptible: SUCCESS (0.753s) [744.488852] [070/132] (279s left) kms_invalid_mode (int-max-clock) [744.577799] Starting subtest: int-max-clock [744.579779] Starting dynamic subtest: pipe-A-eDP-1 [744.866841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [744.877590] Starting dynamic subtest: pipe-B-eDP-1 [744.879717] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [744.889396] Starting dynamic subtest: pipe-C-eDP-1 [744.891273] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [744.900558] Starting dynamic subtest: pipe-D-eDP-1 [744.902434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [744.904353] Subtest int-max-clock: SUCCESS (0.295s) [745.741162] [071/132] (278s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [745.842791] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [745.845146] Starting dynamic subtest: pipe-A-eDP-1 [745.937304] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [745.949060] Starting dynamic subtest: pipe-B-eDP-1 [747.104111] Dynamic subtest pipe-B-eDP-1: SKIP (1.166s) [747.108141] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.267s) [748.289881] [072/132] (276s left) kms_addfb_basic (legacy-format) [748.351130] Starting subtest: legacy-format [748.377899] Subtest legacy-format: SUCCESS (0.021s) [748.505336] [073/132] (276s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [748.596818] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [748.599128] Starting dynamic subtest: pipe-A-default-mode [749.763206] Dynamic subtest pipe-A-default-mode: SKIP (1.165s) [749.766940] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.166s) [749.899130] [074/132] (274s left) kms_universal_plane (universal-plane-functional) [749.989165] Starting subtest: universal-plane-functional [749.991497] Starting dynamic subtest: pipe-A-eDP-1 [753.884507] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.895s) [753.897180] Starting dynamic subtest: pipe-B-eDP-1 [758.431707] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.552s) [758.443468] Starting dynamic subtest: pipe-C-eDP-1 [762.776661] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.342s) [762.788097] Starting dynamic subtest: pipe-D-eDP-1 [767.149498] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.368s) [767.151723] Subtest universal-plane-functional: SUCCESS (17.163s) [767.952743] [075/132] (256s left) kms_frontbuffer_tracking (psr-slowdraw) [768.056302] Starting subtest: psr-slowdraw [793.208592] Subtest psr-slowdraw: SUCCESS (25.159s) [793.328029] [076/132] (231s left) kms_async_flips (invalid-async-flip) [793.420521] Starting subtest: invalid-async-flip [793.804908] Starting dynamic subtest: pipe-A-eDP-1 [794.592551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s) [794.956784] Starting dynamic subtest: pipe-B-eDP-1 [795.726631] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.779s) [796.083736] Starting dynamic subtest: pipe-C-eDP-1 [796.841217] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [797.199760] Starting dynamic subtest: pipe-D-eDP-1 [797.973678] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s) [797.975999] Subtest invalid-async-flip: SUCCESS (4.555s) [799.125824] [077/132] (225s left) kms_busy (extended-modeset-hang-newfb) [799.214704] Starting subtest: extended-modeset-hang-newfb [799.217026] Starting dynamic subtest: pipe-A [833.282597] Dynamic subtest pipe-A: SUCCESS (34.069s) [833.295578] Starting dynamic subtest: pipe-D [856.183714] Dynamic subtest pipe-D: SUCCESS (22.896s) [856.186067] Subtest extended-modeset-hang-newfb: SUCCESS (56.970s) [856.988536] [078/132] (167s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [857.097629] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [857.110002] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [857.227409] [079/132] (167s left) api_intel_bb (misplaced-blitter) [857.286415] Starting subtest: misplaced-blitter [857.297636] Subtest misplaced-blitter: SUCCESS (0.013s) [857.430635] [080/132] (167s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [857.527310] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [857.531663] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [857.630690] [081/132] (167s left) kms_flip (plain-flip-fb-recreate-interruptible) [857.729111] Starting subtest: plain-flip-fb-recreate-interruptible [857.731635] Starting dynamic subtest: A-eDP1 [866.590900] Dynamic subtest A-eDP1: SUCCESS (8.861s) [866.601796] Starting dynamic subtest: B-eDP1 [875.415656] Dynamic subtest B-eDP1: SUCCESS (8.824s) [875.431034] Starting dynamic subtest: C-eDP1 [884.234730] Dynamic subtest C-eDP1: SUCCESS (8.818s) [884.247443] Starting dynamic subtest: D-eDP1 [893.073811] Dynamic subtest D-eDP1: SUCCESS (8.839s) [893.078692] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.355s) [894.263114] [082/132] (130s left) gem_userptr_blits (invalid-null-pointer) [894.329257] Starting subtest: invalid-null-pointer [894.331310] Subtest invalid-null-pointer: SUCCESS (0.001s) [894.463444] [083/132] (130s left) gem_mmap_gtt (isolation) [894.517441] Subtest isolation: SKIP (0.000s) [894.579096] [084/132] (130s left) gem_exec_params (no-bsd) [894.632138] Starting subtest: no-bsd [894.634152] Subtest no-bsd: SUCCESS (0.002s) [896.385728] [085/132] (128s left) gem_mmap_wc (invalid-flags) [896.438744] Subtest invalid-flags: SKIP (0.000s) [896.542164] [086/132] (128s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [896.638026] Starting subtest: psr-rgb101010-draw-render [904.107044] Subtest psr-rgb101010-draw-render: SUCCESS (7.473s) [904.259678] [087/132] (120s left) kms_force_connector_basic (force-edid) [904.344978] Starting subtest: force-edid [904.707526] Subtest force-edid: SUCCESS (0.365s) [904.860685] [088/132] (120s left) kms_flip (2x-plain-flip) [904.964105] Starting subtest: 2x-plain-flip [904.974962] Subtest 2x-plain-flip: SKIP (0.010s) [905.068843] [089/132] (120s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [905.163277] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [905.165287] Starting dynamic subtest: pipe-A-eDP-1 [905.184108] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [905.194835] Starting dynamic subtest: pipe-B-eDP-1 [905.212817] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [905.222641] Starting dynamic subtest: pipe-C-eDP-1 [905.239845] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [905.248805] Starting dynamic subtest: pipe-D-eDP-1 [905.266977] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [905.270304] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [907.404210] [090/132] (117s left) perf_pmu (enable-race) [907.446124] Starting subtest: enable-race [907.448482] Starting dynamic subtest: rcs0 [920.213180] Dynamic subtest rcs0: SUCCESS (12.771s) [920.227231] Starting dynamic subtest: bcs0 [932.954826] Dynamic subtest bcs0: SUCCESS (12.743s) [932.965280] Starting dynamic subtest: vcs0 [948.350758] Dynamic subtest vcs0: SUCCESS (15.396s) [948.363647] Starting dynamic subtest: vcs1 [964.286863] Dynamic subtest vcs1: SUCCESS (15.929s) [964.298827] Starting dynamic subtest: vecs0 [980.285401] Dynamic subtest vecs0: SUCCESS (15.991s) [980.298064] Starting dynamic subtest: ccs0 [993.029496] Dynamic subtest ccs0: SUCCESS (12.741s) [993.032868] Subtest enable-race: SUCCESS (85.584s) [993.155470] [091/132] ( 32s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [993.262181] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [993.266184] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [993.331830] [092/132] ( 32s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [993.437801] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [994.396003] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.957s) [994.531351] [093/132] ( 30s left) syncobj_basic (bad-handle-to-fd) [994.592060] Starting subtest: bad-handle-to-fd [994.593965] Subtest bad-handle-to-fd: SUCCESS (0.000s) [994.690401] [094/132] ( 30s left) kms_plane_multiple (2x-tiling-x) [994.786405] Starting subtest: 2x-tiling-x [994.789772] Subtest 2x-tiling-x: SKIP (0.000s) [994.866810] [095/132] ( 30s left) syncobj_timeline (wait-all-interrupted) [994.913918] Starting subtest: wait-all-interrupted [995.018401] Subtest wait-all-interrupted: SUCCESS (0.103s) [995.108110] [096/132] ( 30s left) kms_vblank (ts-continuation-modeset-hang) [995.199142] Starting subtest: ts-continuation-modeset-hang [995.201561] Starting dynamic subtest: pipe-A-eDP-1 [1022.086731] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.883s) [1022.102859] Starting dynamic subtest: pipe-D-eDP-1 [1046.144285] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.057s) [1046.146155] Subtest ts-continuation-modeset-hang: SUCCESS (50.945s) [1046.969137] Overall timeout time exceeded, stopping. [1046.986079] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_chamelium_frames results: parsing output: 2/ for test: gem_userptr_blits results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: i915_drm_fdinfo results: parsing output: 5/ for test: gem_ctx_isolation results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: sw_sync results: parsing output: 8/ for test: kms_cursor_edge_walk results: parsing output: 9/ for test: i915_selftest results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_atomic_interruptible results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: gem_lmem_swapping results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: kms_rmfb results: parsing output: 19/ for test: gem_mmap_gtt results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: kms_color results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: gem_softpin results: parsing output: 24/ for test: kms_plane_scaling results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_eio results: parsing output: 27/ for test: gem_mmap_offset results: parsing output: 28/ for test: syncobj_wait results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: gem_exec_balancer results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: kms_pm_dc results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: perf_pmu results: parsing output: 36/ for test: fbdev results: parsing output: 37/ for test: dumb_buffer results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_feature_discovery results: parsing output: 41/ for test: gem_create results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: prime_mmap results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: gem_ctx_persistence results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: gem_basic results: parsing output: 48/ for test: syncobj_wait results: parsing output: 49/ for test: i915_pm_rc6_residency results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_pxp results: parsing output: 52/ for test: gem_exec_capture results: parsing output: 53/ for test: gen9_exec_parse results: parsing output: 54/ for test: kms_pipe_crc_basic results: parsing output: 55/ for test: gem_exec_fence results: parsing output: 56/ for test: gem_exec_whisper results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: sw_sync results: parsing output: 61/ for test: gem_mmap_wc results: parsing output: 62/ for test: kms_lease results: parsing output: 63/ for test: kms_flip results: parsing output: 64/ for test: kms_content_protection results: parsing output: 65/ for test: perf results: parsing output: 66/ for test: kms_fbcon_fbt results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: gem_render_copy_redux results: parsing output: 69/ for test: kms_invalid_mode results: parsing output: 70/ for test: kms_psr2_sf results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: kms_universal_plane results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_async_flips results: parsing output: 76/ for test: kms_busy results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: api_intel_bb results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: gem_userptr_blits results: parsing output: 82/ for test: gem_mmap_gtt results: parsing output: 83/ for test: gem_exec_params results: parsing output: 84/ for test: gem_mmap_wc results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_force_connector_basic results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: perf_pmu results: parsing output: 90/ for test: kms_psr2_sf results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: syncobj_basic results: parsing output: 93/ for test: kms_plane_multiple results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: kms_vblank results: parsing output: 96/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 97/ for test: kms_chamelium_color results: no output, setting notrun results: parsing output: 98/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 99/ for test: kms_plane results: no output, setting notrun results: parsing output: 100/ for test: template results: no output, setting notrun results: parsing output: 101/ for test: kms_chamelium_hpd results: no output, setting notrun results: parsing output: 102/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 103/ for test: i915_pm_freq_api results: no output, setting notrun results: parsing output: 104/ for test: kms_psr results: no output, setting notrun results: parsing output: 105/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 106/ for test: gem_exec_params results: no output, setting notrun results: parsing output: 107/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 108/ for test: prime_vgem results: no output, setting notrun results: parsing output: 109/ for test: api_intel_allocator results: no output, setting notrun results: parsing output: 110/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 111/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 112/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 113/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 114/ for test: gem_exec_suspend results: no output, setting notrun results: parsing output: 115/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 116/ for test: kms_psr results: no output, setting notrun results: parsing output: 117/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 118/ for test: gem_ctx_shared results: no output, setting notrun results: parsing output: 119/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 120/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 121/ for test: kms_ccs results: no output, setting notrun results: parsing output: 122/ for test: kms_plane results: no output, setting notrun results: parsing output: 123/ for test: gem_partial_pwrite_pread results: no output, setting notrun results: parsing output: 124/ for test: gem_ctx_create results: no output, setting notrun results: parsing output: 125/ for test: kms_frontbuffer_tracking 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_cursor_crc results: no output, setting notrun results: parsing output: 128/ for test: kms_psr_stress_test results: no output, setting notrun results: parsing output: 129/ for test: prime_busy results: no output, setting notrun results: parsing output: 130/ for test: gem_exec_whisper results: no output, setting notrun results: parsing output: 131/ for test: kms_addfb_basic results: no output, setting notrun Done.