[74.097097] Initializing watchdogs [74.097212] /dev/watchdog0 [74.111892] [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] [74.116182] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [74.118354] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [74.121756] [001/133] (960s left) vgem_basic (busy-fence) [74.211267] Starting subtest: busy-fence [74.213411] Subtest busy-fence: SUCCESS (0.000s) [74.276353] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [74.280432] [002/133] (960s left) i915_pm_rpm (gem-execbuf-stress-pc8) [76.436255] Starting subtest: gem-execbuf-stress-pc8 [76.480896] Subtest gem-execbuf-stress-pc8: SKIP (0.043s) [76.811978] [003/133] (957s left) vgem_basic (dmabuf-mmap) [76.869851] Starting subtest: dmabuf-mmap [76.875296] Subtest dmabuf-mmap: SUCCESS (0.008s) [76.929653] [004/133] (957s left) gem_exec_parallel (fds) [76.985846] Starting subtest: fds [76.988066] Starting dynamic subtest: rcs0 [79.300876] Dynamic subtest rcs0: SUCCESS (2.314s) [79.311713] Starting dynamic subtest: bcs0 [82.696728] Dynamic subtest bcs0: SUCCESS (3.393s) [82.707150] Starting dynamic subtest: vcs0 [86.662802] Dynamic subtest vcs0: SUCCESS (3.964s) [86.673263] Starting dynamic subtest: vcs1 [90.569232] Dynamic subtest vcs1: SUCCESS (3.906s) [90.577160] Starting dynamic subtest: vecs0 [94.678784] Dynamic subtest vecs0: SUCCESS (4.108s) [94.689433] Starting dynamic subtest: ccs0 [98.210947] Dynamic subtest ccs0: SUCCESS (3.532s) [98.213086] Subtest fds: SUCCESS (21.224s) [98.405069] [005/133] (936s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [98.508766] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [98.512997] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [98.576364] [006/133] (936s left) drm_read (short-buffer-nonblock) [98.736837] Starting subtest: short-buffer-nonblock [98.739203] Subtest short-buffer-nonblock: SUCCESS (0.000s) [98.845856] [007/133] (936s left) gem_userptr_blits (mmap-offset-banned) [98.910365] Starting subtest: mmap-offset-banned [98.912227] Starting dynamic subtest: wb [98.914488] Dynamic subtest wb: SUCCESS (0.000s) [98.921623] Starting dynamic subtest: wc [98.923726] Dynamic subtest wc: SUCCESS (0.000s) [98.930861] Starting dynamic subtest: uc [98.933060] Dynamic subtest uc: SUCCESS (0.000s) [98.935149] Subtest mmap-offset-banned: SUCCESS (0.002s) [99.015711] [008/133] (935s left) gem_exec_whisper (basic-sync) [99.073585] Starting subtest: basic-sync [105.808414] Subtest basic-sync: SUCCESS (6.713s) [105.970442] [009/133] (928s left) gem_create (create-ext-cpu-access-sanity-check) [106.141884] Starting subtest: create-ext-cpu-access-sanity-check [106.147339] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [106.220689] [010/133] (928s left) kms_addfb_basic (no-handle) [106.273234] Starting subtest: no-handle [106.275309] Subtest no-handle: SUCCESS (0.000s) [106.417532] [011/133] (928s left) gem_exec_fence (keep-in-fence) [106.592732] Starting subtest: keep-in-fence [106.595305] Starting dynamic subtest: rcs0 [106.653951] Dynamic subtest rcs0: SUCCESS (0.061s) [106.664240] Starting dynamic subtest: bcs0 [106.706471] Dynamic subtest bcs0: SUCCESS (0.052s) [106.716082] Starting dynamic subtest: vcs0 [108.293252] Dynamic subtest vcs0: SUCCESS (1.584s) [108.302978] Starting dynamic subtest: vcs1 [110.276038] Dynamic subtest vcs1: SUCCESS (1.982s) [110.285984] Starting dynamic subtest: vecs0 [112.377723] Dynamic subtest vecs0: SUCCESS (2.047s) [112.387957] Starting dynamic subtest: ccs0 [112.560091] Dynamic subtest ccs0: SUCCESS (0.236s) [112.562930] Subtest keep-in-fence: SUCCESS (5.967s) [114.402270] [012/133] (920s left) gem_userptr_blits (map-fixed-invalidate-overlap) [114.474564] Starting subtest: map-fixed-invalidate-overlap [114.478760] Subtest map-fixed-invalidate-overlap: SKIP (0.000s) [114.598740] [013/133] (920s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [114.705707] Starting subtest: primary-4-tiled-reflect-x-0 [121.662329] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.959s) [122.875634] [014/133] (912s left) kms_async_flips (test-time-stamp) [122.978712] Starting subtest: test-time-stamp [123.355479] Starting dynamic subtest: pipe-A-eDP-1 [124.182865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s) [124.564090] Starting dynamic subtest: pipe-B-eDP-1 [125.324278] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s) [125.708844] Starting dynamic subtest: pipe-C-eDP-1 [126.467092] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s) [126.831117] Starting dynamic subtest: pipe-D-eDP-1 [127.595089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s) [127.597632] Subtest test-time-stamp: SUCCESS (4.616s) [128.753060] [015/133] (906s left) kms_cursor_legacy (single-bo) [128.859438] Starting subtest: single-bo [128.861785] Starting dynamic subtest: pipe-A [134.294865] Dynamic subtest pipe-A: SUCCESS (5.379s) [134.305052] Starting dynamic subtest: pipe-B [139.675996] Dynamic subtest pipe-B: SUCCESS (5.380s) [139.687092] Starting dynamic subtest: pipe-C [145.058999] Dynamic subtest pipe-C: SUCCESS (5.380s) [145.069296] Starting dynamic subtest: pipe-D [150.440495] Dynamic subtest pipe-D: SUCCESS (5.380s) [150.451975] Starting dynamic subtest: all-pipes [155.828352] Dynamic subtest all-pipes: SUCCESS (5.388s) [155.830983] Subtest single-bo: SUCCESS (26.914s) [155.932680] [016/133] (879s left) gem_exec_schedule (in-order) [156.005135] Starting subtest: in-order [156.007579] Starting dynamic subtest: rcs0 [156.120329] Dynamic subtest rcs0: SUCCESS (0.120s) [156.133816] Starting dynamic subtest: vcs0 [156.215490] Dynamic subtest vcs0: SUCCESS (0.094s) [156.226592] Starting dynamic subtest: vcs1 [156.312070] Dynamic subtest vcs1: SUCCESS (0.095s) [156.324161] Starting dynamic subtest: vecs0 [156.410770] Dynamic subtest vecs0: SUCCESS (0.098s) [156.421755] Starting dynamic subtest: ccs0 [156.515991] Dynamic subtest ccs0: SUCCESS (0.105s) [156.518742] Subtest in-order: SUCCESS (0.517s) [157.338363] [017/133] (877s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [157.435212] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [157.439195] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [157.525240] [018/133] (877s left) i915_suspend (fence-restore-tiled2untiled) [157.589387] Starting subtest: fence-restore-tiled2untiled [157.593651] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [157.695255] [019/133] (877s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [157.796472] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [165.397735] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.604s) [165.519473] [020/133] (869s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [165.616918] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [165.621302] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [165.706244] [021/133] (869s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [165.808137] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [165.810299] Starting dynamic subtest: pipe-A-eDP-1 [165.832865] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [165.842188] Starting dynamic subtest: pipe-B-eDP-1 [165.862723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [165.870628] Starting dynamic subtest: pipe-C-eDP-1 [165.891088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [165.898578] Starting dynamic subtest: pipe-D-eDP-1 [165.919082] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [165.923032] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s) [168.025057] [022/133] (867s left) kms_plane_scaling (planes-scaler-unity-scaling) [168.118055] Starting subtest: planes-scaler-unity-scaling [168.120228] Starting dynamic subtest: pipe-A [168.179672] Dynamic subtest pipe-A: SUCCESS (0.063s) [168.190042] Starting dynamic subtest: pipe-B [169.357060] Dynamic subtest pipe-B: SUCCESS (1.177s) [169.369281] Starting dynamic subtest: pipe-C [170.467635] Dynamic subtest pipe-C: SUCCESS (1.110s) [170.478421] Starting dynamic subtest: pipe-D [171.603602] Dynamic subtest pipe-D: SUCCESS (1.136s) [171.605971] Subtest planes-scaler-unity-scaling: SUCCESS (3.488s) [172.759543] [023/133] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [172.871594] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [172.875619] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [172.971392] [024/133] (862s left) kms_psr (pr-suspend) [173.070041] Starting subtest: pr-suspend [173.074536] Subtest pr-suspend: SKIP (0.000s) [173.143476] [025/133] (862s left) kms_busy (basic) [173.235245] Starting subtest: basic [173.237540] Starting dynamic subtest: flip [173.828479] Dynamic subtest flip: SUCCESS (0.591s) [173.836970] Starting dynamic subtest: modeset [177.300389] Dynamic subtest modeset: SUCCESS (3.471s) [177.302630] Subtest basic: SUCCESS (4.063s) [178.122126] [026/133] (857s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [178.225074] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [178.229745] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [179.323515] [027/133] (856s left) kms_pm_rpm (legacy-planes) [181.450572] Starting subtest: legacy-planes [181.453194] Starting dynamic subtest: plane-65 [189.738383] Dynamic subtest plane-65: SUCCESS (8.287s) [189.749871] Starting dynamic subtest: plane-95 [198.037057] Dynamic subtest plane-95: SUCCESS (8.296s) [198.048662] Starting dynamic subtest: plane-125 [206.353348] Dynamic subtest plane-125: SUCCESS (8.315s) [206.364618] Starting dynamic subtest: plane-135 [215.056216] Dynamic subtest plane-135: SUCCESS (8.701s) [215.058870] Subtest legacy-planes: SUCCESS (33.606s) [215.442378] [028/133] (820s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [215.558109] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [215.560379] Starting dynamic subtest: pipe-A-eDP-1 [215.582990] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [215.591768] Starting dynamic subtest: pipe-B-eDP-1 [215.613173] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [215.620420] Starting dynamic subtest: pipe-C-eDP-1 [215.641771] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [215.649115] Starting dynamic subtest: pipe-D-eDP-1 [215.670902] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [215.675180] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [217.803664] [029/133] (817s left) api_intel_allocator (reopen) [217.856909] Starting subtest: reopen [217.859226] Subtest reopen: SUCCESS (0.004s) [217.971661] [030/133] (817s left) gem_exec_flush (basic-wb-rw-default) [218.031777] Starting subtest: basic-wb-rw-default [223.517129] Subtest basic-wb-rw-default: SUCCESS (5.457s) [223.670821] [031/133] (812s left) prime_busy (hang) [223.737961] Starting subtest: hang [223.740405] Starting dynamic subtest: rcs0 [249.832721] Dynamic subtest rcs0: SUCCESS (26.080s) [249.842526] Starting dynamic subtest: bcs0 [256.972710] Dynamic subtest bcs0: SUCCESS (7.150s) [256.982858] Starting dynamic subtest: vcs0 [263.952558] Dynamic subtest vcs0: SUCCESS (6.976s) [263.960501] Starting dynamic subtest: vcs1 [270.924659] Dynamic subtest vcs1: SUCCESS (6.974s) [270.935077] Starting dynamic subtest: vecs0 [277.963932] Dynamic subtest vecs0: SUCCESS (7.036s) [277.974152] Starting dynamic subtest: ccs0 [291.804014] Dynamic subtest ccs0: SUCCESS (13.837s) [291.806428] Subtest hang: SUCCESS (68.060s) [291.918082] [032/133] (743s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [292.005019] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [292.007290] Starting dynamic subtest: pipe-A-eDP-1 [292.029538] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [292.039511] Starting dynamic subtest: pipe-B-eDP-1 [292.060972] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [292.068843] Starting dynamic subtest: pipe-C-eDP-1 [292.091201] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [292.101053] Starting dynamic subtest: pipe-D-eDP-1 [292.122751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [292.126855] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s) [294.192356] [033/133] (741s left) kms_pipe_crc_basic (hang-read-crc) [294.291130] Starting subtest: hang-read-crc [294.293492] Starting dynamic subtest: pipe-A-eDP-1 [296.345245] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.053s) [296.354132] Starting dynamic subtest: pipe-B-eDP-1 [299.006548] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.661s) [299.015136] Starting dynamic subtest: pipe-C-eDP-1 [301.623791] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s) [301.633473] Starting dynamic subtest: pipe-D-eDP-1 [304.292983] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.669s) [304.295349] Subtest hang-read-crc: SUCCESS (10.003s) [305.121939] [034/133] (730s left) gem_exec_balancer (fairslice) [305.182969] Starting subtest: fairslice [308.095274] Subtest fairslice: SUCCESS (2.910s) [308.403849] [035/133] (727s left) kms_content_protection (lic-type-0-hdcp14) [308.555983] Starting subtest: lic-type-0-hdcp14 [308.560443] Subtest lic-type-0-hdcp14: SKIP (0.000s) [308.685085] [036/133] (727s left) gen7_exec_parse (bitmasks) [308.737439] Subtest bitmasks: SKIP (0.000s) [308.802773] [037/133] (727s left) gem_mmap_gtt (basic-write-gtt) [308.850466] Subtest basic-write-gtt: SKIP (0.000s) [308.903089] [038/133] (727s left) syncobj_eventfd (binary-wait) [308.962512] Starting subtest: binary-wait [308.971324] Subtest binary-wait: SUCCESS (0.010s) [309.047979] [039/133] (727s left) kms_properties (crtc-properties-atomic) [309.149253] Starting subtest: crtc-properties-atomic [309.151469] Starting dynamic subtest: pipe-A-eDP-1 [309.598694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s) [309.611127] Starting dynamic subtest: pipe-B-eDP-1 [310.795909] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s) [310.805442] Starting dynamic subtest: pipe-C-eDP-1 [311.915304] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s) [311.924710] Starting dynamic subtest: pipe-D-eDP-1 [313.047650] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [313.049920] Subtest crtc-properties-atomic: SUCCESS (3.899s) [313.864501] [040/133] (722s left) kms_lease (atomic-implicit-crtc) [313.961187] Starting subtest: atomic-implicit-crtc [313.963265] Starting dynamic subtest: pipe-A-eDP-1 [313.974283] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [313.984492] Starting dynamic subtest: pipe-B-eDP-1 [313.995698] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [314.006930] Starting dynamic subtest: pipe-C-eDP-1 [314.017102] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [314.025533] Starting dynamic subtest: pipe-D-eDP-1 [314.036067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s) [314.037870] Subtest atomic-implicit-crtc: SUCCESS (0.035s) [314.106106] [041/133] (722s left) kms_prop_blob (blob-multiple) [314.156537] Starting subtest: blob-multiple [314.158797] Subtest blob-multiple: SUCCESS (0.002s) [314.265811] [042/133] (722s left) gem_readwrite (beyond-eob) [314.335734] Subtest beyond-EOB: SKIP (0.000s) [314.394928] [043/133] (721s left) gem_exec_fence (syncobj-timeline-wait) [314.964260] Starting subtest: syncobj-timeline-wait [316.309112] Subtest syncobj-timeline-wait: SUCCESS (1.345s) [318.342952] [044/133] (718s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [318.452438] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [323.109776] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.661s) [324.255300] [045/133] (712s left) gem_softpin (noreloc) [324.325538] Starting subtest: noreloc [329.773729] Subtest noreloc: SUCCESS (5.394s) [329.846061] [046/133] (706s left) gem_mmap_gtt (cpuset-big-copy) [329.912115] Subtest cpuset-big-copy: SKIP (0.000s) [329.975558] [047/133] (706s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [330.084603] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [330.088981] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [330.170538] [048/133] (706s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [330.267273] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [336.953454] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.690s) [337.066888] [049/133] (699s left) syncobj_wait (multi-wait-all-for-submit-submitted) [337.120756] Starting subtest: multi-wait-all-for-submit-submitted [337.223985] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [337.296258] [050/133] (699s left) kms_big_fb (y-tiled-8bpp-rotate-0) [337.402232] Starting subtest: y-tiled-8bpp-rotate-0 [337.406198] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [337.495841] [051/133] (699s left) kms_cursor_crc (cursor-random-32x32) [337.641284] Starting subtest: cursor-random-32x32 [337.686748] Subtest cursor-random-32x32: SKIP (0.040s) [337.976204] [052/133] (698s left) kms_chamelium_audio (dp-audio-edid) [338.358044] Subtest dp-audio-edid: SKIP (0.000s) [339.170874] [053/133] (697s left) gem_ctx_shared (single-timeline) [339.242069] Starting subtest: single-timeline [339.262383] Subtest single-timeline: SUCCESS (0.013s) [339.495494] [054/133] (697s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [339.587953] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [339.590254] Starting dynamic subtest: pipe-A-default-mode [342.328555] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s) [342.330704] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.740s) [343.191194] [055/133] (693s left) kms_big_fb (4-tiled-8bpp-rotate-0) [343.294831] Starting subtest: 4-tiled-8bpp-rotate-0 [344.496810] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.202s) [344.633163] [056/133] (692s left) kms_big_fb (x-tiled-32bpp-rotate-270) [344.721159] Starting subtest: x-tiled-32bpp-rotate-270 [344.741763] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s) [344.854928] [057/133] (692s left) gem_mmap_gtt (hang-busy) [344.917486] Subtest hang-busy: SKIP (0.000s) [344.987701] [058/133] (691s left) gem_exec_whisper (basic-contexts-priority) [345.053261] Starting subtest: basic-contexts-priority [369.947922] Subtest basic-contexts-priority: SUCCESS (24.840s) [370.081947] [059/133] (666s left) gem_mmap_gtt (medium-copy-odd) [370.148138] Subtest medium-copy-odd: SKIP (0.000s) [370.207180] [060/133] (666s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [370.316718] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [371.152524] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s) [371.312869] [061/133] (665s left) gem_exec_schedule (u-fairslice) [371.388620] Starting subtest: u-fairslice [371.390796] Starting dynamic subtest: rcs0 [373.453503] Dynamic subtest rcs0: SUCCESS (2.022s) [373.466633] Starting dynamic subtest: bcs0 [375.424257] Dynamic subtest bcs0: SUCCESS (2.019s) [375.433836] Starting dynamic subtest: vcs0 [377.492958] Dynamic subtest vcs0: SUCCESS (2.020s) [377.503990] Starting dynamic subtest: vcs1 [379.467634] Dynamic subtest vcs1: SUCCESS (2.021s) [379.478368] Starting dynamic subtest: vecs0 [381.534108] Dynamic subtest vecs0: SUCCESS (2.018s) [381.543694] Starting dynamic subtest: ccs0 [383.508683] Dynamic subtest ccs0: SUCCESS (2.023s) [383.510702] Subtest u-fairslice: SUCCESS (12.127s) [383.819757] [062/133] (653s left) vgem_slow (nohang) [383.870794] Starting subtest: nohang [394.260484] Subtest nohang: SUCCESS (10.338s) [394.301712] [063/133] (642s left) kms_properties (plane-properties-atomic) [394.393245] Starting subtest: plane-properties-atomic [394.395584] Starting dynamic subtest: pipe-A-eDP-1 [394.938699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s) [394.949047] Starting dynamic subtest: pipe-B-eDP-1 [396.264500] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.325s) [396.274982] Starting dynamic subtest: pipe-C-eDP-1 [397.487985] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s) [397.498189] Starting dynamic subtest: pipe-D-eDP-1 [398.730080] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s) [398.732423] Subtest plane-properties-atomic: SUCCESS (4.339s) [399.533710] [064/133] (637s left) kms_rotation_crc (sprite-rotation-180) [399.613742] Starting subtest: sprite-rotation-180 [406.344248] Subtest sprite-rotation-180: SUCCESS (6.732s) [407.494759] [065/133] (629s left) gem_reg_read (timestamp-moving) [407.555701] Starting subtest: timestamp-moving [408.556064] Subtest timestamp-moving: SUCCESS (1.001s) [408.644749] [066/133] (628s left) kms_psr (fbc-psr-sprite-mmap-gtt) [408.742990] Starting subtest: fbc-psr-sprite-mmap-gtt [408.745118] Starting dynamic subtest: eDP-1 [408.749034] Dynamic subtest eDP-1: SKIP (0.000s) [408.752941] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [408.818216] [067/133] (628s left) gem_flink_basic (double-flink) [408.879846] Starting subtest: double-flink [408.881748] Subtest double-flink: SUCCESS (0.000s) [409.004408] [068/133] (628s left) gem_render_copy (yf-tiled-to-vebox-linear) [409.067241] Starting subtest: yf-tiled-to-vebox-linear [409.071815] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [409.245918] [069/133] (628s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [409.640306] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [410.420125] [070/133] (626s left) kms_color_pipeline (plane-ctm3x4-lut1d) [410.515091] Starting subtest: plane-ctm3x4-lut1d [410.637777] Starting dynamic subtest: pipe-A-plane-0 [410.837629] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s) [410.847164] Starting dynamic subtest: pipe-A-plane-1 [410.973595] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s) [410.982360] Starting dynamic subtest: pipe-A-plane-2 [411.140336] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [412.343627] Starting dynamic subtest: pipe-B-plane-0 [412.481057] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [412.490017] Starting dynamic subtest: pipe-B-plane-1 [412.627182] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s) [412.636055] Starting dynamic subtest: pipe-B-plane-2 [412.780910] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [413.962668] Starting dynamic subtest: pipe-C-plane-0 [414.085494] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [414.094180] Starting dynamic subtest: pipe-C-plane-1 [414.229917] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [414.239692] Starting dynamic subtest: pipe-C-plane-2 [414.396587] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [415.603954] Starting dynamic subtest: pipe-D-plane-0 [415.736350] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [415.745788] Starting dynamic subtest: pipe-D-plane-1 [415.870299] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [415.882363] Starting dynamic subtest: pipe-D-plane-2 [416.036316] Dynamic subtest pipe-D-plane-2: SUCCESS (0.164s) [416.323077] Subtest plane-ctm3x4-lut1d: SUCCESS (5.808s) [417.166989] [071/133] (620s left) gem_exec_reloc (basic-wc-read-active) [417.226048] Subtest basic-wc-read-active: SKIP (0.000s) [417.305219] [072/133] (620s left) kms_vrr (lobf) [417.397876] Starting subtest: lobf [417.401790] Subtest lobf: SKIP (0.000s) [417.469306] [073/133] (620s left) kms_plane (pixel-format-4-tiled-modifier) [417.565099] Starting subtest: pixel-format-4-tiled-modifier [417.591229] Starting dynamic subtest: pipe-A-plane-0 [418.200990] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s) [418.209385] Starting dynamic subtest: pipe-A-plane-3 [418.623539] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s) [418.634534] Starting dynamic subtest: pipe-A-plane-5 [418.638119] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [419.755743] Starting dynamic subtest: pipe-B-plane-0 [420.393779] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s) [420.402975] Starting dynamic subtest: pipe-B-plane-3 [420.804498] Dynamic subtest pipe-B-plane-3: SUCCESS (0.409s) [420.813257] Starting dynamic subtest: pipe-B-plane-5 [420.816845] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [421.111764] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.549s) [421.935852] [074/133] (615s left) kms_cursor_crc (cursor-sliding-512x512) [422.224801] Starting subtest: cursor-sliding-512x512 [422.229334] Subtest cursor-sliding-512x512: SKIP (0.001s) [422.383628] [075/133] (615s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [422.477763] Starting subtest: async-flip-with-page-flip-events-linear-atomic [422.852503] Starting dynamic subtest: pipe-A-eDP-1 [425.650276] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.745s) [425.961873] Starting dynamic subtest: pipe-B-eDP-1 [428.776671] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s) [429.091206] Starting dynamic subtest: pipe-C-eDP-1 [431.905411] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s) [432.227784] Starting dynamic subtest: pipe-D-eDP-1 [435.032570] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s) [435.034932] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.505s) [436.175739] [076/133] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [436.265693] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [436.270184] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [436.384544] [077/133] (601s left) kms_vblank (query-forked-hang) [436.464236] Starting subtest: query-forked-hang [436.466442] Starting dynamic subtest: pipe-A-eDP-1 [463.112887] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.646s) [463.127240] Starting dynamic subtest: pipe-D-eDP-1 [488.058065] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.944s) [488.060774] Subtest query-forked-hang: SUCCESS (51.595s) [488.939880] [078/133] (548s left) kms_psr (psr2-cursor-mmap-cpu) [489.034878] Starting subtest: psr2-cursor-mmap-cpu [489.036990] Starting dynamic subtest: eDP-1 [490.713528] Dynamic subtest eDP-1: SUCCESS (1.676s) [490.715526] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.677s) [491.524246] [079/133] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [491.631214] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [498.652360] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.024s) [498.765385] [080/133] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [498.859958] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [502.376087] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.521s) [503.526158] [081/133] (534s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [503.632078] Starting subtest: pr-overlay-primary-update-sf-dmg-area [503.636561] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [503.702927] [082/133] (534s left) kms_selftest (drm_dp_mst_helper) [503.748888] Starting subtest: drm_dp_mst_helper [503.803347] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [503.900550] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.095s) [503.910473] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [504.006864] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.107s) [504.015267] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [504.139476] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.133s) [504.141867] Subtest drm_dp_mst_helper: SUCCESS (0.390s) [504.316882] [083/133] (533s left) kms_cursor_crc (cursor-offscreen-128x128) [504.530720] Starting subtest: cursor-offscreen-128x128 [504.535564] Starting dynamic subtest: pipe-A-eDP-1 [506.466836] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s) [506.496922] Starting dynamic subtest: pipe-D-eDP-1 [509.113521] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.626s) [509.115990] Subtest cursor-offscreen-128x128: SUCCESS (4.583s) [509.987429] [084/133] (527s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [510.085270] Starting subtest: fbc-psr2-cursor-mmap-gtt [510.087490] Starting dynamic subtest: eDP-1 [510.091493] Dynamic subtest eDP-1: SKIP (0.000s) [510.095420] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [510.156966] [085/133] (527s left) syncobj_timeline (wait-all-interrupted) [510.225170] Starting subtest: wait-all-interrupted [510.328513] Subtest wait-all-interrupted: SUCCESS (0.104s) [510.414075] [086/133] (527s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [510.501811] Starting subtest: primary-yf-tiled-reflect-x-90 [510.506181] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [510.577784] [087/133] (527s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [510.674190] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [510.678521] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [510.777458] [088/133] (527s left) kms_feature_discovery (display-1x) [510.873373] Starting subtest: display-1x [510.875714] Subtest display-1x: SUCCESS (0.000s) [510.943604] [089/133] (527s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [511.040394] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [511.044664] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [511.138426] [090/133] (527s left) kms_big_fb (linear-64bpp-rotate-90) [511.245336] Starting subtest: linear-64bpp-rotate-90 [511.264097] Subtest linear-64bpp-rotate-90: SKIP (0.018s) [511.388541] [091/133] (526s left) gem_softpin (allocator-basic-reserve) [511.438163] Starting subtest: allocator-basic-reserve [511.503980] Subtest allocator-basic-reserve: SUCCESS (0.066s) [511.614307] [092/133] (526s left) fbdev (unaligned-write) [511.651986] Starting subtest: unaligned-write [511.753527] Subtest unaligned-write: SUCCESS (0.101s) [511.816560] [093/133] (526s left) gem_render_copy (y-tiled) [511.868804] Starting subtest: y-tiled [511.873306] Subtest y-tiled: SKIP (0.000s) [512.067737] [094/133] (526s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [512.127432] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [512.129448] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [512.253240] [095/133] (526s left) gem_ctx_param (invalid-param-get) [512.309740] Starting subtest: invalid-param-get [512.311951] Subtest invalid-param-get: SUCCESS (0.001s) [512.405243] [096/133] (526s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [512.494152] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [512.498432] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [512.581719] [097/133] (525s left) gem_ctx_exec (basic-norecovery) [512.636051] Starting subtest: basic-norecovery [512.962689] Subtest basic-norecovery: SUCCESS (0.327s) [513.085280] [098/133] (525s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [513.147897] Starting subtest: x-tiled-to-vebox-yf-tiled [513.151489] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [513.343565] [099/133] (525s left) kms_frontbuffer_tracking (fbc-stridechange) [513.442789] Starting subtest: fbc-stridechange [516.685947] Subtest fbc-stridechange: SUCCESS (3.246s) [517.893244] [100/133] (520s left) syncobj_wait (reset-unsignaled) [517.946552] Starting subtest: reset-unsignaled [517.948942] Subtest reset-unsignaled: SUCCESS (0.000s) [518.041350] [101/133] (520s left) perf_pmu (most-busy-idle-check-all) [518.079146] Starting subtest: most-busy-idle-check-all [518.081231] Starting dynamic subtest: rcs0 [519.300899] Dynamic subtest rcs0: SUCCESS (1.222s) [519.314744] Starting dynamic subtest: bcs0 [521.283785] Dynamic subtest bcs0: SUCCESS (1.980s) [521.305367] Starting dynamic subtest: vcs0 [523.333478] Dynamic subtest vcs0: SUCCESS (2.044s) [523.346034] Starting dynamic subtest: vcs1 [525.315734] Dynamic subtest vcs1: SUCCESS (1.980s) [525.328845] Starting dynamic subtest: vecs0 [527.299353] Dynamic subtest vecs0: SUCCESS (1.981s) [527.313041] Starting dynamic subtest: ccs0 [529.284066] Dynamic subtest ccs0: SUCCESS (1.983s) [529.287040] Subtest most-busy-idle-check-all: SUCCESS (11.207s) [529.381184] [102/133] (509s left) syncobj_timeline (invalid-signal-illegal-handle) [529.434624] Starting subtest: invalid-signal-illegal-handle [529.436861] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [529.543372] [103/133] (509s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [529.644078] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [529.646201] Starting dynamic subtest: pipe-A-eDP-1 [540.959488] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.315s) [540.969493] Starting dynamic subtest: pipe-B-eDP-1 [553.009865] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.048s) [553.011737] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.366s) [553.852754] [104/133] (484s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [553.944506] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [553.948831] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [554.042066] [105/133] (484s left) i915_drm_fdinfo (all-busy-idle-check-all) [554.084633] Starting subtest: all-busy-idle-check-all [554.088693] Subtest all-busy-idle-check-all: SKIP (0.003s) [554.155347] [106/133] (484s left) kms_flip (flip-vs-rmfb) [554.238797] Starting subtest: flip-vs-rmfb [554.241516] Starting dynamic subtest: A-eDP1 [562.941940] Dynamic subtest A-eDP1: SUCCESS (8.703s) [562.951934] Starting dynamic subtest: B-eDP1 [571.578783] Dynamic subtest B-eDP1: SUCCESS (8.635s) [571.591752] Starting dynamic subtest: C-eDP1 [580.207830] Dynamic subtest C-eDP1: SUCCESS (8.626s) [580.221538] Starting dynamic subtest: D-eDP1 [588.843587] Dynamic subtest D-eDP1: SUCCESS (8.633s) [588.848335] Subtest flip-vs-rmfb: SUCCESS (34.610s) [590.029097] [107/133] (448s left) dmabuf_sync_file (export-wait-after-attach) [590.073496] Starting subtest: export-wait-after-attach [590.075426] Subtest export-wait-after-attach: SUCCESS (0.001s) [590.131358] [108/133] (448s left) kms_getfb (getfb2-handle-protection) [590.227227] Starting subtest: getfb2-handle-protection [590.245370] Subtest getfb2-handle-protection: SUCCESS (0.019s) [590.353378] [109/133] (448s left) kms_invalid_mode (zero-clock) [590.440601] Starting subtest: zero-clock [590.442986] Starting dynamic subtest: pipe-A-eDP-1 [590.726361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [590.735635] Starting dynamic subtest: pipe-B-eDP-1 [590.737856] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [590.746742] Starting dynamic subtest: pipe-C-eDP-1 [590.749053] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [590.758564] Starting dynamic subtest: pipe-D-eDP-1 [590.760965] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [590.763318] Subtest zero-clock: SUCCESS (0.297s) [591.573518] [110/133] (447s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [591.665499] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [599.097724] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.435s) [599.210457] [111/133] (439s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [599.307206] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [599.311438] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [599.411520] [112/133] (439s left) i915_drm_fdinfo (virtual-busy-idle-all) [599.457054] Starting subtest: virtual-busy-idle-all [599.461424] Subtest virtual-busy-idle-all: SKIP (0.000s) [599.521466] [113/133] (439s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [599.621633] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [599.625710] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [599.703129] [114/133] (439s left) perf (i915-ref-count) [599.778524] Starting subtest: i915-ref-count [599.844389] Subtest i915-ref-count: SUCCESS (0.069s) [599.904337] [115/133] (439s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [600.281749] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [601.095495] [116/133] (438s left) kms_atomic_transition (plane-all-transition-nonblocking) [601.186207] Starting subtest: plane-all-transition-nonblocking [601.188571] Starting dynamic subtest: pipe-A-eDP-1 [603.683937] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s) [604.011238] Starting dynamic subtest: pipe-B-eDP-1 [607.248047] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.246s) [607.544359] Subtest plane-all-transition-nonblocking: SUCCESS (6.359s) [608.388915] [117/133] (430s left) gem_softpin (evict-active-interruptible) [608.451961] Starting subtest: evict-active-interruptible [608.457713] Subtest evict-active-interruptible: SUCCESS (0.005s) [608.582371] [118/133] (430s left) kms_plane (plane-panning-bottom-right) [608.674360] Starting subtest: plane-panning-bottom-right [608.676672] Starting dynamic subtest: pipe-A [610.316733] Dynamic subtest pipe-A: SUCCESS (1.642s) [610.327547] Starting dynamic subtest: pipe-B [612.726088] Dynamic subtest pipe-B: SUCCESS (2.408s) [612.728314] Subtest plane-panning-bottom-right: SUCCESS (4.053s) [613.593262] [119/133] (425s left) gem_madvise (dontneed-before-exec) [613.634038] Starting subtest: dontneed-before-exec [613.657815] Subtest dontneed-before-exec: SKIP (0.021s) [613.719280] [120/133] (425s left) gem_mmap_offset (ptrace) [613.777149] Starting subtest: ptrace [613.779532] Starting dynamic subtest: smem0-wb [613.797265] Dynamic subtest smem0-wb: SUCCESS (0.019s) [613.809466] Starting dynamic subtest: smem0-wc [613.817836] Dynamic subtest smem0-wc: SUCCESS (0.020s) [613.827407] Starting dynamic subtest: smem0-uc [613.836393] Dynamic subtest smem0-uc: SUCCESS (0.018s) [613.838831] Subtest ptrace: SUCCESS (0.062s) [613.963367] [121/133] (425s left) gem_ctx_persistence (legacy-engines-mixed) [614.022859] Starting subtest: legacy-engines-mixed [614.025265] Starting dynamic subtest: render [614.122387] Dynamic subtest render: SUCCESS (0.098s) [614.135079] Starting dynamic subtest: bsd1 [614.183186] Dynamic subtest bsd1: SUCCESS (0.058s) [614.197978] Starting dynamic subtest: bsd2 [614.237963] Dynamic subtest bsd2: SUCCESS (0.052s) [614.249864] Starting dynamic subtest: blt [614.287334] Dynamic subtest blt: SUCCESS (0.047s) [614.298722] Starting dynamic subtest: vebox [614.343868] Dynamic subtest vebox: SUCCESS (0.054s) [614.346646] Subtest legacy-engines-mixed: SUCCESS (0.322s) [614.422947] [122/133] (425s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [614.516785] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [614.520272] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [614.609326] [123/133] (424s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [614.699303] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [614.702764] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [614.806754] [124/133] (424s left) core_getclient (basic) [614.850256] Starting subtest: basic [614.851821] Subtest basic: SUCCESS (0.000s) [614.937545] [125/133] (424s left) syncobj_timeline (multi-wait-available-submitted-signaled) [614.992830] Starting subtest: multi-wait-available-submitted-signaled [614.994904] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [615.096814] [126/133] (424s left) gem_fence_thrash (bo-write-verify-threaded-x) [615.137751] Starting subtest: bo-write-verify-threaded-x [615.156033] Subtest bo-write-verify-threaded-x: SKIP (0.019s) [615.229182] [127/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [615.316601] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [615.320011] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [615.415454] [128/133] (424s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [615.517711] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [622.026445] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.511s) [622.186135] [129/133] (417s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [622.307607] Starting subtest: cursorA-vs-flipA-varying-size [633.435828] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.124s) [634.266119] [130/133] (405s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [634.384727] Starting subtest: cursorA-vs-flipA-legacy [645.511354] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.127s) [646.385503] [131/133] (393s left) gen3_render_linear_blits [646.501944] [132/133] (393s left) kms_pm_rpm (basic-pci-d3-state) [648.428531] Starting subtest: basic-pci-d3-state [649.914766] Subtest basic-pci-d3-state: SUCCESS (1.483s) [650.000409] [133/133] (390s left) gem_exec_balancer (parallel-ordering) [650.260848] Starting subtest: parallel-ordering [651.233855] Subtest parallel-ordering: SUCCESS (0.973s) [651.358210] Closing watchdogs results: parsing output: 0/ for test: vgem_basic results: parsing output: 1/ for test: i915_pm_rpm results: parsing output: 2/ for test: vgem_basic results: parsing output: 3/ for test: gem_exec_parallel results: parsing output: 4/ for test: kms_plane results: parsing output: 5/ for test: drm_read results: parsing output: 6/ for test: gem_userptr_blits results: parsing output: 7/ for test: gem_exec_whisper results: parsing output: 8/ for test: gem_create results: parsing output: 9/ for test: kms_addfb_basic results: parsing output: 10/ for test: gem_exec_fence results: parsing output: 11/ for test: gem_userptr_blits results: parsing output: 12/ for test: kms_rotation_crc results: parsing output: 13/ for test: kms_async_flips results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: gem_exec_schedule results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: i915_suspend results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_plane_scaling results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_busy results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: kms_pm_rpm results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: api_intel_allocator results: parsing output: 29/ for test: gem_exec_flush results: parsing output: 30/ for test: prime_busy results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: kms_pipe_crc_basic results: parsing output: 33/ for test: gem_exec_balancer results: parsing output: 34/ for test: kms_content_protection results: parsing output: 35/ for test: gen7_exec_parse results: parsing output: 36/ for test: gem_mmap_gtt results: parsing output: 37/ for test: syncobj_eventfd results: parsing output: 38/ for test: kms_properties results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: kms_prop_blob results: parsing output: 41/ for test: gem_readwrite results: parsing output: 42/ for test: gem_exec_fence results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_softpin results: parsing output: 45/ for test: gem_mmap_gtt results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: syncobj_wait results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_cursor_crc results: parsing output: 51/ for test: kms_chamelium_audio results: parsing output: 52/ for test: gem_ctx_shared results: parsing output: 53/ for test: kms_flip_scaled_crc results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: gem_mmap_gtt results: parsing output: 57/ for test: gem_exec_whisper results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: gem_exec_schedule results: parsing output: 61/ for test: vgem_slow results: parsing output: 62/ for test: kms_properties results: parsing output: 63/ for test: kms_rotation_crc results: parsing output: 64/ for test: gem_reg_read results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: gem_flink_basic results: parsing output: 67/ for test: gem_render_copy results: parsing output: 68/ for test: kms_chamelium_hpd results: parsing output: 69/ for test: kms_color_pipeline results: parsing output: 70/ for test: gem_exec_reloc results: parsing output: 71/ for test: kms_vrr results: parsing output: 72/ for test: kms_plane results: parsing output: 73/ for test: kms_cursor_crc results: parsing output: 74/ for test: kms_async_flips results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_vblank results: parsing output: 77/ for test: kms_psr results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_psr2_sf results: parsing output: 81/ for test: kms_selftest results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: syncobj_timeline results: parsing output: 85/ for test: kms_rotation_crc results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_feature_discovery results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: gem_softpin results: parsing output: 91/ for test: fbdev results: parsing output: 92/ for test: gem_render_copy results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: gem_ctx_param results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: gem_ctx_exec results: parsing output: 97/ for test: gem_render_copy results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: perf_pmu results: parsing output: 101/ for test: syncobj_timeline results: parsing output: 102/ for test: kms_psr2_sf results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: i915_drm_fdinfo results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: dmabuf_sync_file results: parsing output: 107/ for test: kms_getfb results: parsing output: 108/ for test: kms_invalid_mode results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: i915_drm_fdinfo results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: perf results: parsing output: 114/ for test: kms_chamelium_frames results: parsing output: 115/ for test: kms_atomic_transition results: parsing output: 116/ for test: gem_softpin results: parsing output: 117/ for test: kms_plane results: parsing output: 118/ for test: gem_madvise results: parsing output: 119/ for test: gem_mmap_offset results: parsing output: 120/ for test: gem_ctx_persistence results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: core_getclient results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: gem_fence_thrash results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: gen3_render_linear_blits results: parsing output: 131/ for test: kms_pm_rpm results: parsing output: 132/ for test: gem_exec_balancer Done.