[61.801061] Initializing watchdogs
[61.801105]   /dev/watchdog0
[61.816158] [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.820776] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.823494] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.825586] [001/133] (960s left) kms_chamelium_frames (vga-frame-dump)
[62.224544] Subtest vga-frame-dump: SKIP (0.000s)
[63.067879] [002/133] (959s left) gem_userptr_blits (unsync-unmap-cycles)
[63.144814] Subtest unsync-unmap-cycles: SKIP (0.000s)
[63.271972] [003/133] (959s left) kms_flip (flip-vs-wf_vblank-interruptible)
[63.363945] Starting subtest: flip-vs-wf_vblank-interruptible
[63.365921] Starting dynamic subtest: A-eDP1
[65.282808] Dynamic subtest A-eDP1: SUCCESS (1.913s)
[65.290220] Starting dynamic subtest: B-eDP1
[67.216954] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[67.226299] Starting dynamic subtest: C-eDP1
[69.137824] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[69.148122] Starting dynamic subtest: D-eDP1
[71.078050] Dynamic subtest D-eDP1: SUCCESS (1.936s)
[71.080856] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.706s)
[72.304490] [004/133] (950s left) kms_sequence (get-forked-busy)
[72.395538] Starting subtest: get-forked-busy
[72.396633] Starting dynamic subtest: pipe-A-eDP-1
[74.343117] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[74.349413] Starting dynamic subtest: pipe-B-eDP-1
[76.924406] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.579s)
[76.933712] Starting dynamic subtest: pipe-C-eDP-1
[79.539074] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[79.549112] Starting dynamic subtest: pipe-D-eDP-1
[82.167759] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.627s)
[82.169272] Subtest get-forked-busy: SUCCESS (9.769s)
[83.050306] [005/133] (939s left) gen9_exec_parse (allowed-single)
[83.111273] Subtest allowed-single: SKIP (0.000s)
[83.173966] [006/133] (939s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[83.260627] Starting subtest: plane-upscale-20x20-with-rotation
[83.261514] Starting dynamic subtest: pipe-A
[83.487057] Dynamic subtest pipe-A: SUCCESS (0.226s)
[83.496104] Starting dynamic subtest: pipe-B
[84.745103] Dynamic subtest pipe-B: SUCCESS (1.257s)
[84.750977] Starting dynamic subtest: pipe-C
[86.093780] Dynamic subtest pipe-C: SUCCESS (1.348s)
[86.100882] Starting dynamic subtest: pipe-D
[87.432160] Dynamic subtest pipe-D: SUCCESS (1.337s)
[87.432971] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.171s)
[88.598598] [007/133] (933s left) kms_lease (empty-lease)
[88.679211] Starting subtest: empty-lease
[88.680183] Starting dynamic subtest: pipe-A-eDP-1
[88.681121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[88.688096] Starting dynamic subtest: pipe-B-eDP-1
[88.688953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[88.694653] Starting dynamic subtest: pipe-C-eDP-1
[88.695529] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[88.701270] Starting dynamic subtest: pipe-D-eDP-1
[88.702080] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[88.702900] Subtest empty-lease: SUCCESS (0.007s)
[88.777225] [008/133] (933s left) kms_chamelium_frames (dp-crc-single)
[89.153129] Subtest dp-crc-single: SKIP (0.000s)
[89.908024] [009/133] (932s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[89.994379] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[89.996140] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[91.100312] [010/133] (931s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[91.163096] Starting subtest: map-fixed-invalidate-overlap-busy
[91.164901] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[91.264222] [011/133] (931s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[91.351610] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[91.353485] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[91.451813] [012/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[91.751356] Starting subtest: cursor-sliding-max-size
[91.754751] Subtest cursor-sliding-max-size: SKIP (0.000s)
[91.880253] [013/133] (930s left) kms_joiner (basic-force-ultra-joiner)
[91.965962] Starting subtest: basic-force-ultra-joiner
[91.967860] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[92.037898] [014/133] (930s left) kms_psr (fbc-psr2-sprite-blt)
[92.135332] Starting subtest: fbc-psr2-sprite-blt
[92.136237] Starting dynamic subtest: eDP-1
[92.137896] Dynamic subtest eDP-1: SKIP (0.000s)
[92.139966] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[92.204402] [015/133] (930s left) gem_cs_tlb (engines)
[92.265721] Starting subtest: engines
[92.266749] Starting dynamic subtest: rcs0
[94.427052] Dynamic subtest rcs0: SUCCESS (2.151s)
[94.433215] Starting dynamic subtest: bcs0
[96.579810] Dynamic subtest bcs0: SUCCESS (2.151s)
[96.588434] Starting dynamic subtest: vcs0
[98.769325] Dynamic subtest vcs0: SUCCESS (2.152s)
[98.778263] Starting dynamic subtest: vcs1
[100.885467] Dynamic subtest vcs1: SUCCESS (2.152s)
[100.893786] Starting dynamic subtest: vecs0
[103.038416] Dynamic subtest vecs0: SUCCESS (2.152s)
[103.046962] Starting dynamic subtest: ccs0
[105.228042] Dynamic subtest ccs0: SUCCESS (2.153s)
[105.229237] Subtest engines: SUCCESS (12.914s)
[105.308892] [016/133] (917s left) core_setmaster (master-drop-set-user)
[105.383277] Starting subtest: master-drop-set-user
[105.412803] Subtest master-drop-set-user: SUCCESS (0.030s)
[105.442650] [017/133] (917s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[105.538121] Starting subtest: plane-lut1d-ctm3x4-lut1d
[105.719386] Starting dynamic subtest: pipe-A-plane-0
[105.963815] Dynamic subtest pipe-A-plane-0: FAIL (0.179s)
[105.973725] Starting dynamic subtest: pipe-A-plane-1
[106.146725] Dynamic subtest pipe-A-plane-1: FAIL (0.162s)
[106.156136] Starting dynamic subtest: pipe-A-plane-2
[106.330940] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[107.404744] Starting dynamic subtest: pipe-B-plane-0
[107.677060] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[107.682908] Starting dynamic subtest: pipe-B-plane-1
[107.862499] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[107.868706] Starting dynamic subtest: pipe-B-plane-2
[108.054525] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[109.125316] Starting dynamic subtest: pipe-C-plane-0
[109.417789] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[109.424039] Starting dynamic subtest: pipe-C-plane-1
[109.587730] Dynamic subtest pipe-C-plane-1: FAIL (0.168s)
[109.594358] Starting dynamic subtest: pipe-C-plane-2
[109.758678] Dynamic subtest pipe-C-plane-2: FAIL (0.164s)
[110.776820] Starting dynamic subtest: pipe-D-plane-0
[111.087525] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[111.093738] Starting dynamic subtest: pipe-D-plane-1
[111.279193] Dynamic subtest pipe-D-plane-1: FAIL (0.155s)
[111.285618] Starting dynamic subtest: pipe-D-plane-2
[111.481829] Dynamic subtest pipe-D-plane-2: FAIL (0.352s)
[111.730253] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (6.191s)
[112.557462] [018/133] (910s left) gem_lmem_swapping (verify-ccs)
[112.599449] Subtest verify-ccs: SKIP (0.000s)
[112.634615] [019/133] (910s left) kms_psr (pr-suspend)
[112.733892] Starting subtest: pr-suspend
[112.735721] Subtest pr-suspend: SKIP (0.000s)
[112.797211] [020/133] (910s left) gem_exec_params (invalid-fence-in-submit)
[112.849216] Starting subtest: invalid-fence-in-submit
[112.853199] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[112.965115] [021/133] (909s left) perf_pmu (all-busy-check-all)
[113.001267] Starting subtest: all-busy-check-all
[114.912879] Subtest all-busy-check-all: SUCCESS (1.902s)
[114.980366] [022/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[115.073146] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[115.074990] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[115.164286] [023/133] (907s left) sysfs_timeslice_duration (duration)
[115.228345] Starting subtest: duration
[115.229270] Starting dynamic subtest: vecs0
[129.854413] Dynamic subtest vecs0: SUCCESS (14.615s)
[129.862692] Starting dynamic subtest: ccs0
[142.997043] Dynamic subtest ccs0: SUCCESS (13.122s)
[143.005773] Starting dynamic subtest: vcs0
[157.887485] Dynamic subtest vcs0: SUCCESS (14.907s)
[157.896042] Starting dynamic subtest: bcs0
[171.025408] Dynamic subtest bcs0: SUCCESS (13.135s)
[171.033964] Starting dynamic subtest: rcs0
[184.165921] Dynamic subtest rcs0: SUCCESS (13.134s)
[184.178988] Starting dynamic subtest: vcs1
[197.886441] Dynamic subtest vcs1: SUCCESS (13.723s)
[197.887756] Subtest duration: SUCCESS (82.646s)
[197.948932] [024/133] (825s left) kms_fbcon_fbt (fbc-suspend)
[198.001677] Starting subtest: fbc-suspend
[248.318196] Subtest fbc-suspend: SUCCESS (20.235s)
[251.711640] [025/133] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[251.811755] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[256.172723] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.326s)
[257.365346] [026/133] (767s left) gem_softpin (allocator-basic-reserve)
[257.416812] Starting subtest: allocator-basic-reserve
[257.486570] Subtest allocator-basic-reserve: SUCCESS (0.069s)
[257.602308] [027/133] (767s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[257.654684] Starting subtest: rel-constants-invalid-rel-gen5
[257.655626] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[257.739385] [028/133] (767s left) syncobj_timeline (etime-single-wait-all-submitted)
[257.788739] Starting subtest: etime-single-wait-all-submitted
[257.893664] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[257.980237] [029/133] (767s left) gem_tiled_fence_blits (basic)
[258.040690] Subtest basic: SKIP (0.000s)
[258.095569] [030/133] (767s left) kms_chamelium_audio (hdmi-audio)
[258.475406] Subtest hdmi-audio: SKIP (0.000s)
[259.276964] [031/133] (765s left) gem_pread (snoop)
[259.324043] Subtest snoop: SKIP (0.000s)
[259.380821] [032/133] (765s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[259.475461] Starting subtest: crc-primary-suspend-y-tiled-ccs
[259.476326] Starting dynamic subtest: pipe-A-eDP-1
[259.479916] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[259.487243] Starting dynamic subtest: pipe-B-eDP-1
[259.490954] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[259.498105] Starting dynamic subtest: pipe-C-eDP-1
[259.501730] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[259.508817] Starting dynamic subtest: pipe-D-eDP-1
[259.512322] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[259.514079] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[261.768163] [033/133] (763s left) i915_selftest (live)
[265.070826] Starting subtest: live
[265.072029] Starting dynamic subtest: sanitycheck
[267.820704] Dynamic subtest sanitycheck: SUCCESS (2.747s)
[267.829150] Starting dynamic subtest: uncore
[272.160128] Dynamic subtest uncore: SUCCESS (4.332s)
[272.168836] Starting dynamic subtest: workarounds
[288.752827] Dynamic subtest workarounds: FAIL (16.537s)
[288.758974] Starting dynamic subtest: gt_engines
[291.771084] Dynamic subtest gt_engines: SUCCESS (3.068s)
[291.778393] Starting dynamic subtest: gt_timelines
[307.806398] Dynamic subtest gt_timelines: SUCCESS (16.032s)
[307.815367] Starting dynamic subtest: gt_contexts
[312.150589] Dynamic subtest gt_contexts: SUCCESS (4.341s)
[312.159459] Starting dynamic subtest: gt_lrc
[316.523102] Dynamic subtest gt_lrc: SUCCESS (4.370s)
[316.531918] Starting dynamic subtest: gt_mocs
[319.472455] Dynamic subtest gt_mocs: SUCCESS (2.949s)
[319.478151] Starting dynamic subtest: gt_pm
[326.213893] Dynamic subtest gt_pm: SUCCESS (6.737s)
[326.222568] Starting dynamic subtest: gt_heartbeat
[330.573243] Dynamic subtest gt_heartbeat: SUCCESS (4.356s)
[330.581554] Starting dynamic subtest: gt_tlb
[339.973219] Dynamic subtest gt_tlb: SUCCESS (9.394s)
[339.982166] Starting dynamic subtest: requests
[353.551976] Dynamic subtest requests: SUCCESS (13.578s)
[353.560779] Starting dynamic subtest: migrate
[359.324201] Dynamic subtest migrate: SUCCESS (5.771s)
[359.333085] Starting dynamic subtest: active
[363.672660] Dynamic subtest active: SUCCESS (4.348s)
[363.681549] Starting dynamic subtest: objects
[368.399664] Dynamic subtest objects: SUCCESS (4.725s)
[368.408559] Starting dynamic subtest: mman
[373.358991] Dynamic subtest mman: SUCCESS (4.958s)
[373.367679] Starting dynamic subtest: dmabuf
[377.674068] Dynamic subtest dmabuf: SUCCESS (4.314s)
[377.681855] Starting dynamic subtest: vma
[382.008561] Dynamic subtest vma: SUCCESS (4.331s)
[382.015580] Starting dynamic subtest: coherency
[387.538799] Dynamic subtest coherency: SUCCESS (5.527s)
[387.547409] Starting dynamic subtest: gtt
[397.357245] Dynamic subtest gtt: SUCCESS (9.816s)
[397.366183] Starting dynamic subtest: gem
[405.574099] Dynamic subtest gem: SUCCESS (8.214s)
[405.582787] Starting dynamic subtest: evict
[411.047272] Dynamic subtest evict: SUCCESS (5.478s)
[411.054853] Starting dynamic subtest: hugepages
[419.841610] Dynamic subtest hugepages: SUCCESS (8.782s)
[419.850662] Starting dynamic subtest: gem_contexts
[446.951947] Dynamic subtest gem_contexts: SUCCESS (27.109s)
[446.960342] Starting dynamic subtest: client
[451.264134] Dynamic subtest client: SUCCESS (4.303s)
[451.273357] Starting dynamic subtest: gem_migrate
[455.652813] Dynamic subtest gem_migrate: SUCCESS (4.386s)
[455.661400] Starting dynamic subtest: reset
[459.960682] Dynamic subtest reset: SUCCESS (4.305s)
[459.970163] Starting dynamic subtest: memory_region
[464.229063] Dynamic subtest memory_region: SUCCESS (4.265s)
[464.237403] Starting dynamic subtest: hangcheck
[477.451102] Dynamic subtest hangcheck: SUCCESS (13.219s)
[477.460034] Starting dynamic subtest: execlists
[481.804170] Dynamic subtest execlists: SUCCESS (4.353s)
[481.813134] Starting dynamic subtest: ring_submission
[486.139839] Dynamic subtest ring_submission: SUCCESS (4.335s)
[486.148033] Starting dynamic subtest: perf
[490.423243] Dynamic subtest perf: SUCCESS (4.282s)
[490.431639] Starting dynamic subtest: slpc
[504.527466] Dynamic subtest slpc: SUCCESS (14.104s)
[504.536630] Starting dynamic subtest: guc
[508.500788] Dynamic subtest guc: SUCCESS (3.972s)
[508.509049] Starting dynamic subtest: guc_multi_lrc
[512.826800] Dynamic subtest guc_multi_lrc: SUCCESS (4.325s)
[512.835400] Starting dynamic subtest: guc_hang
[517.766050] Dynamic subtest guc_hang: SUCCESS (4.938s)
[517.773373] Starting dynamic subtest: late_gt_pm
[520.565791] Dynamic subtest late_gt_pm: SUCCESS (2.797s)
[520.567043] Subtest live: FAIL (255.461s)
[520.588956] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[520.590676] [034/133] (504s left) kms_async_flips (async-flip-dpms)
[522.166600] Starting subtest: async-flip-dpms
[522.548422] Starting dynamic subtest: pipe-A-eDP-1
[526.430467] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.882s)
[526.810438] Starting dynamic subtest: pipe-B-eDP-1
[529.606116] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.802s)
[529.975318] Starting dynamic subtest: pipe-C-eDP-1
[532.766414] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.800s)
[533.141557] Starting dynamic subtest: pipe-D-eDP-1
[535.926259] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.791s)
[535.927341] Subtest async-flip-dpms: SUCCESS (13.761s)
[537.128435] [FACT kms_async_flips (async-flip-dpms)] new: kernel.kmod_is_loaded.i915: true
[537.130585] [035/133] (488s left) perf_pmu (busy-start)
[537.174354] Starting subtest: busy-start
[537.175168] Starting dynamic subtest: rcs0
[539.727850] Dynamic subtest rcs0: SUCCESS (2.553s)
[539.739729] Starting dynamic subtest: bcs0
[542.289719] Dynamic subtest bcs0: SUCCESS (2.547s)
[542.299661] Starting dynamic subtest: vcs0
[545.897332] Dynamic subtest vcs0: SUCCESS (3.609s)
[545.907276] Starting dynamic subtest: vcs1
[549.865020] Dynamic subtest vcs1: SUCCESS (3.964s)
[549.875663] Starting dynamic subtest: vecs0
[553.898062] Dynamic subtest vecs0: SUCCESS (4.030s)
[553.908243] Starting dynamic subtest: ccs0
[556.450965] Dynamic subtest ccs0: SUCCESS (2.547s)
[556.452208] Subtest busy-start: SUCCESS (19.265s)
[556.528522] [036/133] (468s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[556.626076] Starting subtest: fbc-tiling-linear
[560.371106] Subtest fbc-tiling-linear: SUCCESS (3.745s)
[561.507091] [037/133] (463s left) gem_ccs (ctrl-surf-copy)
[561.559687] Starting subtest: ctrl-surf-copy
[561.561617] Subtest ctrl-surf-copy: SKIP (0.000s)
[561.645361] [038/133] (463s left) gem_exec_create (legacy)
[561.699526] Starting subtest: legacy
[561.700486] Starting dynamic subtest: smem
[564.908484] Dynamic subtest smem: SUCCESS (3.198s)
[564.909825] Subtest legacy: SUCCESS (3.201s)
[565.080912] [039/133] (460s left) gem_pread (exhaustion)
[565.136069] Subtest exhaustion: SKIP (0.000s)
[565.189692] [040/133] (460s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[565.276529] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[565.277334] Starting dynamic subtest: pipe-A-eDP-1
[565.340143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[565.656567] Starting dynamic subtest: pipe-B-eDP-1
[566.419828] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[566.734232] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.457s)
[567.583259] [041/133] (457s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[567.678696] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[567.679656] Starting dynamic subtest: pipe-A-eDP-1
[573.587715] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.908s)
[573.595103] Starting dynamic subtest: pipe-B-eDP-1
[580.239540] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s)
[580.240424] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.561s)
[581.095604] [042/133] (444s left) kms_atomic (atomic-invalid-params)
[581.181505] Starting subtest: atomic-invalid-params
[581.182336] Starting dynamic subtest: pipe-A-eDP-1
[581.592175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[581.593056] Subtest atomic-invalid-params: SUCCESS (0.411s)
[582.428452] [043/133] (443s left) i915_drm_fdinfo (busy-hang)
[582.467713] Starting subtest: busy-hang
[582.468526] Starting dynamic subtest: rcs0
[582.488326] Dynamic subtest rcs0: SKIP (0.021s)
[582.497682] Starting dynamic subtest: bcs0
[582.499220] Dynamic subtest bcs0: SKIP (0.001s)
[582.506254] Starting dynamic subtest: vcs0
[582.508111] Dynamic subtest vcs0: SKIP (0.000s)
[582.515003] Starting dynamic subtest: vcs1
[582.517068] Dynamic subtest vcs1: SKIP (0.000s)
[582.524176] Starting dynamic subtest: vecs0
[582.526082] Dynamic subtest vecs0: SKIP (0.000s)
[582.532981] Starting dynamic subtest: ccs0
[582.534652] Dynamic subtest ccs0: SKIP (0.000s)
[582.536250] Subtest busy-hang: SKIP (0.027s)
[582.563420] [044/133] (443s left) prime_self_import (basic-with_two_bos)
[582.601901] Starting subtest: basic-with_two_bos
[582.625110] Subtest basic-with_two_bos: SUCCESS (0.024s)
[582.735295] [045/133] (442s left) kms_pm_rpm (basic-pci-d3-state)
[585.069205] Starting subtest: basic-pci-d3-state
[586.530672] Subtest basic-pci-d3-state: SUCCESS (1.463s)
[586.612657] [046/133] (439s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[586.705373] Starting subtest: flip-vs-dpms-off-vs-modeset
[586.707173] Starting dynamic subtest: A-eDP1
[590.327360] Dynamic subtest A-eDP1: SUCCESS (3.619s)
[590.336001] Starting dynamic subtest: B-eDP1
[593.550369] Dynamic subtest B-eDP1: SUCCESS (3.222s)
[593.561213] Starting dynamic subtest: C-eDP1
[596.674810] Dynamic subtest C-eDP1: SUCCESS (3.123s)
[596.692955] Starting dynamic subtest: D-eDP1
[599.769159] Dynamic subtest D-eDP1: SUCCESS (3.089s)
[599.771340] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.064s)
[600.563791] [047/133] (425s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[600.826021] Starting subtest: cursor-rapid-movement-256x85
[600.877934] Subtest cursor-rapid-movement-256x85: SKIP (0.050s)
[601.046564] [048/133] (424s left) kms_rotation_crc (bad-pixel-format)
[601.127602] Starting subtest: bad-pixel-format
[601.129298] Subtest bad-pixel-format: SKIP (0.001s)
[601.196318] [049/133] (424s left) kms_plane_multiple (2x-tiling-none)
[601.282690] Starting subtest: 2x-tiling-none
[601.284446] Subtest 2x-tiling-none: SKIP (0.000s)
[601.347931] [050/133] (424s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[601.443943] Starting subtest: psr-shrfb-scaledprimary
[607.281485] Subtest psr-shrfb-scaledprimary: SUCCESS (5.836s)
[607.425331] [051/133] (418s left) kms_plane (pixel-format-4-tiled-modifier)
[607.515686] Starting subtest: pixel-format-4-tiled-modifier
[607.543389] Starting dynamic subtest: pipe-A-plane-0
[608.176544] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[608.185798] Starting dynamic subtest: pipe-A-plane-3
[608.587778] Dynamic subtest pipe-A-plane-3: SUCCESS (0.409s)
[608.597026] Starting dynamic subtest: pipe-A-plane-5
[608.598691] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[609.677780] Starting dynamic subtest: pipe-B-plane-0
[610.347567] Dynamic subtest pipe-B-plane-0: SUCCESS (0.677s)
[610.357273] Starting dynamic subtest: pipe-B-plane-3
[610.803349] Dynamic subtest pipe-B-plane-3: SUCCESS (0.453s)
[610.812721] Starting dynamic subtest: pipe-B-plane-5
[610.814602] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[611.112787] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.597s)
[611.936530] [052/133] (413s left) gem_userptr_blits (set-cache-level)
[611.987812] Starting subtest: set-cache-level
[611.989540] Subtest set-cache-level: SKIP (0.000s)
[612.104949] [053/133] (413s left) syncobj_timeline (wait-all-snapshot)
[612.147165] Starting subtest: wait-all-snapshot
[612.228934] Subtest wait-all-snapshot: SUCCESS (0.082s)
[612.297366] [054/133] (413s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[612.390944] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[612.392647] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[612.471502] [055/133] (413s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[612.562660] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[612.564304] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[612.665621] [056/133] (413s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[612.722113] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[612.723066] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[612.813914] [057/133] (413s left) gem_ctx_persistence (legacy-engines-mixed-process)
[612.863135] Starting subtest: legacy-engines-mixed-process
[612.863987] Starting dynamic subtest: render
[614.828652] Dynamic subtest render: SUCCESS (1.964s)
[614.839681] Starting dynamic subtest: bsd1
[616.890964] Dynamic subtest bsd1: SUCCESS (2.059s)
[616.903137] Starting dynamic subtest: bsd2
[618.866967] Dynamic subtest bsd2: SUCCESS (1.973s)
[618.878780] Starting dynamic subtest: blt
[620.815199] Dynamic subtest blt: SUCCESS (1.945s)
[620.824045] Starting dynamic subtest: vebox
[622.891887] Dynamic subtest vebox: SUCCESS (2.076s)
[622.893057] Subtest legacy-engines-mixed-process: SUCCESS (10.028s)
[622.970827] [058/133] (403s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[623.087250] Starting subtest: y-tiled-64bpp-rotate-90
[623.089065] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[623.177374] [059/133] (402s left) prime_vgem (shrink)
[623.315516] Starting subtest: shrink
[623.328599] Subtest shrink: SUCCESS (0.012s)
[623.436439] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[623.438451] [060/133] (402s left) api_intel_bb (simple-bb-ctx)
[623.490704] Starting subtest: simple-bb-ctx
[623.498628] Subtest simple-bb-ctx: SUCCESS (0.009s)
[623.633960] [061/133] (402s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[623.725213] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[623.727066] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[623.810351] [062/133] (402s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[623.946176] Starting subtest: dp-mst-type-1-suspend-resume
[623.947884] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[624.055054] [063/133] (402s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[624.100677] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[624.205126] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[624.291115] [064/133] (402s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[624.388637] Starting subtest: x-tiled-64bpp-rotate-0
[625.968537] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.580s)
[626.133109] [065/133] (400s left) gem_exec_reloc (basic-cpu-wc)
[626.181100] Subtest basic-cpu-wc: SKIP (0.000s)
[626.249601] [066/133] (400s left) syncobj_timeline (reset-during-wait-for-submit)
[626.294043] Starting subtest: reset-during-wait-for-submit
[626.398989] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[626.472480] [067/133] (399s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[626.564134] Starting subtest: plane-all-modeset-transition-fencing
[626.565906] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[626.654343] [068/133] (399s left) gem_lmem_swapping (basic)
[626.695334] Subtest basic: SKIP (0.000s)
[626.744266] [069/133] (399s left) syncobj_timeline (invalid-query-zero-handles)
[626.787485] Starting subtest: invalid-query-zero-handles
[626.788616] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[626.882426] [070/133] (399s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[626.994213] Starting subtest: short-flip-before-cursor-atomic-transitions
[627.947967] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.953s)
[628.762246] [071/133] (397s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[628.858032] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[632.927851] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.069s)
[634.079618] [072/133] (392s left) gem_basic (bad-close)
[634.127720] Starting subtest: bad-close
[634.129599] Subtest bad-close: SUCCESS (0.000s)
[634.214034] [073/133] (392s left) kms_psr (fbc-psr2-suspend)
[634.304663] Starting subtest: fbc-psr2-suspend
[634.305565] Starting dynamic subtest: eDP-1
[634.307192] Dynamic subtest eDP-1: SKIP (0.000s)
[634.308766] Subtest fbc-psr2-suspend: SKIP (0.001s)
[634.381969] [074/133] (392s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[634.475806] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[634.476780] Starting dynamic subtest: pipe-A-eDP-1
[634.494668] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.503867] Starting dynamic subtest: pipe-B-eDP-1
[634.513046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.521212] Starting dynamic subtest: pipe-C-eDP-1
[634.530309] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.538342] Starting dynamic subtest: pipe-D-eDP-1
[634.547249] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.548958] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[636.724310] [075/133] (389s left) gem_mmap_gtt (hang-busy)
[636.771989] Subtest hang-busy: SKIP (0.000s)
[636.828380] [076/133] (389s left) gem_exec_fence (syncobj-repeat)
[637.256273] Starting subtest: syncobj-repeat
[637.469315] Subtest syncobj-repeat: SUCCESS (0.203s)
[638.951112] [077/133] (387s left) gem_userptr_blits (usage-restrictions)
[639.007046] Starting subtest: usage-restrictions
[639.007996] Subtest usage-restrictions: SUCCESS (0.000s)
[639.139372] [078/133] (387s left) kms_addfb_basic (bad-pitch-0)
[639.189575] Starting subtest: bad-pitch-0
[639.190452] Subtest bad-pitch-0: SUCCESS (0.000s)
[639.328755] [079/133] (387s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[639.432450] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[647.021190] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.588s)
[647.167127] [080/133] (379s left) kms_psr (psr-sprite-plane-onoff)
[647.257477] Starting subtest: psr-sprite-plane-onoff
[647.258495] Starting dynamic subtest: eDP-1
[649.014391] Dynamic subtest eDP-1: SUCCESS (1.757s)
[649.015124] Subtest psr-sprite-plane-onoff: SUCCESS (1.758s)
[649.842138] [081/133] (377s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[649.941796] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[649.943535] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[650.011502] [082/133] (376s left) kms_dp_link_training (non-uhbr-sst)
[650.103720] Starting subtest: non-uhbr-sst
[650.107558] Subtest non-uhbr-sst: SKIP (0.000s)
[650.172358] [083/133] (376s left) gem_exec_balancer (full)
[650.237786] Starting subtest: full
[654.739346] Subtest full: SUCCESS (4.498s)
[655.060575] [084/133] (371s left) gem_mmap_wc (read-write-distinct)
[655.128007] Subtest read-write-distinct: SKIP (0.000s)
[655.181844] [085/133] (371s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[655.277885] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[655.279727] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[655.372468] [086/133] (371s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[655.482338] Starting subtest: cursorB-vs-flipB-atomic-transitions
[655.483944] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[655.621226] [087/133] (371s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[655.707755] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[655.708605] Starting dynamic subtest: pipe-A-eDP-1
[655.831391] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[655.840858] Starting dynamic subtest: pipe-B-eDP-1
[657.022359] Dynamic subtest pipe-B-eDP-1: SKIP (1.189s)
[657.023952] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.314s)
[658.219713] [088/133] (368s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[658.314839] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[665.946257] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.631s)
[666.088699] [089/133] (361s left) kms_prime (basic-crc-hybrid)
[666.173665] Subtest basic-crc-hybrid: SKIP (0.000s)
[666.258219] [090/133] (360s left) kms_flip (2x-flip-vs-fences)
[666.339595] Starting subtest: 2x-flip-vs-fences
[666.341354] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[666.416062] [091/133] (360s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[666.511527] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[666.512494] Starting dynamic subtest: pipe-A-eDP-1
[666.520890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[666.529525] Starting dynamic subtest: pipe-B-eDP-1
[666.537927] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[666.546667] Starting dynamic subtest: pipe-C-eDP-1
[666.554571] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[666.562699] Starting dynamic subtest: pipe-D-eDP-1
[666.571075] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[666.572720] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[668.706417] [092/133] (358s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[668.767936] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[668.769698] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[668.942712] [093/133] (358s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[669.035901] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[673.502164] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.465s)
[674.727942] [094/133] (352s left) gem_ctx_param (invalid-size-set)
[674.780719] Starting subtest: invalid-size-set
[674.781622] Subtest invalid-size-set: SUCCESS (0.001s)
[674.869746] [095/133] (352s left) kms_properties (colorop-properties-legacy)
[674.965549] Starting subtest: colorop-properties-legacy
[674.966445] Starting dynamic subtest: pipe-A-eDP-1
[675.320943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[675.329948] Starting dynamic subtest: pipe-B-eDP-1
[676.367966] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.046s)
[676.376225] Starting dynamic subtest: pipe-C-eDP-1
[677.396209] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.027s)
[677.404756] Starting dynamic subtest: pipe-D-eDP-1
[678.441029] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.043s)
[678.442002] Subtest colorop-properties-legacy: SUCCESS (3.475s)
[679.238443] [096/133] (348s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[679.337094] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[679.338733] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[679.419915] [097/133] (348s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[679.512667] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[679.513633] Starting dynamic subtest: pipe-A-eDP-1
[679.521530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[679.530102] Starting dynamic subtest: pipe-B-eDP-1
[679.537811] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[679.545977] Starting dynamic subtest: pipe-C-eDP-1
[679.554168] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[679.562062] Starting dynamic subtest: pipe-D-eDP-1
[679.569790] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[679.570568] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[681.804436] [098/133] (345s left) gem_exec_reloc (basic-wc-active)
[681.862735] Subtest basic-wc-active: SKIP (0.000s)
[681.918875] [099/133] (345s left) kms_vrr (flip-suspend)
[682.009085] Starting subtest: flip-suspend
[682.011861] Subtest flip-suspend: SKIP (0.000s)
[682.078151] [100/133] (345s left) kms_pipe_crc_basic (hang-read-crc)
[682.166858] Starting subtest: hang-read-crc
[682.167776] Starting dynamic subtest: pipe-A-eDP-1
[684.287999] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[684.301374] Starting dynamic subtest: pipe-B-eDP-1
[687.057305] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[687.066759] Starting dynamic subtest: pipe-C-eDP-1
[689.692735] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.632s)
[689.701589] Starting dynamic subtest: pipe-D-eDP-1
[692.361644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s)
[692.362576] Subtest hang-read-crc: SUCCESS (10.194s)
[693.182454] [101/133] (334s left) gem_softpin (evict-active-interruptible)
[693.248874] Starting subtest: evict-active-interruptible
[693.255755] Subtest evict-active-interruptible: SUCCESS (0.007s)
[693.362114] [102/133] (334s left) gem_fence_thrash (bo-write-verify-y)
[693.391459] Starting subtest: bo-write-verify-y
[693.409334] Subtest bo-write-verify-y: SKIP (0.016s)
[693.469170] [103/133] (334s left) kms_big_fb (linear-8bpp-rotate-0)
[693.553645] Starting subtest: linear-8bpp-rotate-0
[694.823157] Subtest linear-8bpp-rotate-0: SUCCESS (1.269s)
[694.929836] [104/133] (332s left) gem_render_copy (y-tiled)
[694.977574] Starting subtest: y-tiled
[694.979228] Subtest y-tiled: SKIP (0.000s)
[695.156996] [105/133] (332s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[695.253804] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[695.255729] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[695.321821] [106/133] (332s left) kms_draw_crc (draw-method-blt)
[695.415633] Starting subtest: draw-method-blt
[695.416575] Starting dynamic subtest: xrgb8888-untiled
[695.648356] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[695.656785] Starting dynamic subtest: rgb565-untiled
[695.881756] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[695.898138] Starting dynamic subtest: xrgb2101010-untiled
[696.104096] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[696.112777] Starting dynamic subtest: xbgr16161616f-untiled
[696.315216] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[696.324115] Starting dynamic subtest: xrgb8888-xtiled
[696.437394] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[696.446090] Starting dynamic subtest: rgb565-xtiled
[696.549058] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[696.568137] Starting dynamic subtest: xrgb2101010-xtiled
[696.670892] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[696.680788] Starting dynamic subtest: xbgr16161616f-xtiled
[696.793517] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.120s)
[696.802105] Starting dynamic subtest: xrgb8888-4tiled
[696.915901] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[696.933036] Starting dynamic subtest: rgb565-4tiled
[697.037828] Dynamic subtest rgb565-4tiled: SUCCESS (0.119s)
[697.048418] Starting dynamic subtest: xrgb2101010-4tiled
[697.149117] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[697.159134] Starting dynamic subtest: xbgr16161616f-4tiled
[697.271023] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[697.273166] Subtest draw-method-blt: SUCCESS (1.857s)
[697.394180] [107/133] (330s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[697.508656] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[698.190153] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[698.335044] [108/133] (329s left) gem_exec_whisper (basic-contexts-priority-all)
[698.408172] Starting subtest: basic-contexts-priority-all
[722.901492] Subtest basic-contexts-priority-all: SUCCESS (24.442s)
[723.034267] [109/133] (304s left) kms_hdr (static-swap)
[723.123984] Starting subtest: static-swap
[723.128640] Subtest static-swap: SKIP (0.001s)
[723.200780] [110/133] (304s left) kms_force_connector_basic (force-connector-state)
[723.265628] Starting subtest: force-connector-state
[723.894412] Subtest force-connector-state: SUCCESS (0.630s)
[724.851727] [111/133] (303s left) i915_pm_rc6_residency (rc6-accuracy)
[724.927029] Starting subtest: rc6-accuracy
[724.927969] Starting dynamic subtest: gt0
[728.108080] Dynamic subtest gt0: SUCCESS (3.169s)
[728.121058] Starting dynamic subtest: gt1
[731.315846] Dynamic subtest gt1: SUCCESS (3.170s)
[731.316875] Subtest rc6-accuracy: SUCCESS (6.345s)
[731.355402] [112/133] (296s left) i915_pm_freq_api (freq-reset-multiple)
[731.407679] Starting subtest: freq-reset-multiple
[731.408578] Starting dynamic subtest: gt0
[741.092857] Dynamic subtest gt0: SUCCESS (9.689s)
[741.101747] Starting dynamic subtest: gt1
[749.532112] Dynamic subtest gt1: SUCCESS (8.434s)
[749.533324] Subtest freq-reset-multiple: SUCCESS (18.126s)
[749.597202] [113/133] (278s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[749.688268] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[750.747091] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.059s)
[750.867112] [114/133] (277s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[750.961109] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[758.020263] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.063s)
[758.153655] [115/133] (269s left) gem_exec_params (no-blt)
[758.209148] Starting subtest: no-blt
[758.210851] Subtest no-blt: SUCCESS (0.002s)
[758.320696] [116/133] (269s left) kms_vblank (ts-continuation-dpms-suspend)
[758.405555] Starting subtest: ts-continuation-dpms-suspend
[758.406447] Starting dynamic subtest: pipe-A-eDP-1
[775.591782] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.271s)
[775.602523] Starting dynamic subtest: pipe-D-eDP-1
[793.577379] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.834s)
[793.578434] Subtest ts-continuation-dpms-suspend: SUCCESS (5.109s)
[800.462591] [117/133] (233s left) gem_ringfill (basic-all)
[805.915967] Starting subtest: basic-all
[807.062115] Subtest basic-all: SUCCESS (1.148s)
[807.188642] [118/133] (227s left) perf (low-oa-exponent-permissions)
[807.322068] Starting subtest: low-oa-exponent-permissions
[807.358411] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[807.404276] [119/133] (226s left) gem_ctx_persistence (engines-cleanup)
[807.463391] Starting subtest: engines-cleanup
[807.464388] Starting dynamic subtest: rcs0
[807.565160] Dynamic subtest rcs0: SUCCESS (0.101s)
[807.578724] Starting dynamic subtest: bcs0
[807.596147] Dynamic subtest bcs0: SUCCESS (0.030s)
[807.604838] Starting dynamic subtest: vcs0
[807.668720] Dynamic subtest vcs0: SUCCESS (0.071s)
[807.681501] Starting dynamic subtest: vcs1
[807.728733] Dynamic subtest vcs1: SUCCESS (0.058s)
[807.741061] Starting dynamic subtest: vecs0
[807.784372] Dynamic subtest vecs0: SUCCESS (0.054s)
[807.795598] Starting dynamic subtest: ccs0
[807.809200] Dynamic subtest ccs0: SUCCESS (0.023s)
[807.810051] Subtest engines-cleanup: SUCCESS (0.347s)
[807.910467] [120/133] (226s left) kms_cursor_crc (cursor-onscreen-64x64)
[808.111347] Starting subtest: cursor-onscreen-64x64
[808.117373] Starting dynamic subtest: pipe-A-eDP-1
[810.477193] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.363s)
[810.510599] Starting dynamic subtest: pipe-D-eDP-1
[813.209641] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.710s)
[813.210619] Subtest cursor-onscreen-64x64: SUCCESS (5.105s)
[814.078211] [121/133] (220s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[814.169623] Starting subtest: plane-scaler-unity-scaling-with-rotation
[814.170467] Starting dynamic subtest: pipe-A
[814.430094] Dynamic subtest pipe-A: SUCCESS (0.261s)
[814.442009] Starting dynamic subtest: pipe-B
[815.732353] Dynamic subtest pipe-B: SUCCESS (1.303s)
[815.748300] Starting dynamic subtest: pipe-C
[817.032984] Dynamic subtest pipe-C: SUCCESS (1.300s)
[817.043188] Starting dynamic subtest: pipe-D
[818.331168] Dynamic subtest pipe-D: SUCCESS (1.298s)
[818.331981] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.167s)
[819.462451] [122/133] (214s left) gem_exec_schedule (implicit-write-read)
[819.518948] Starting subtest: implicit-write-read
[819.519829] Starting dynamic subtest: rcs0
[819.633363] Dynamic subtest rcs0: SUCCESS (0.114s)
[819.645175] Starting dynamic subtest: vcs0
[819.723925] Dynamic subtest vcs0: SUCCESS (0.090s)
[819.736943] Starting dynamic subtest: vcs1
[819.811491] Dynamic subtest vcs1: SUCCESS (0.086s)
[819.822929] Starting dynamic subtest: vecs0
[819.893748] Dynamic subtest vecs0: SUCCESS (0.081s)
[819.908369] Starting dynamic subtest: ccs0
[819.990858] Dynamic subtest ccs0: SUCCESS (0.096s)
[819.992557] Subtest implicit-write-read: SUCCESS (0.472s)
[821.043048] [123/133] (213s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[821.132570] Starting subtest: psr-rgb565-draw-blt
[828.291658] Subtest psr-rgb565-draw-blt: SUCCESS (7.163s)
[828.412434] [124/133] (206s left) kms_psr (psr2-sprite-mmap-cpu)
[828.507411] Starting subtest: psr2-sprite-mmap-cpu
[828.508196] Starting dynamic subtest: eDP-1
[830.226655] Dynamic subtest eDP-1: SUCCESS (1.719s)
[830.227614] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.720s)
[831.061872] [125/133] (203s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[831.156858] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[831.158731] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[831.244622] [126/133] (203s left) gem_ctx_shared (single-timeline)
[831.309459] Starting subtest: single-timeline
[831.321748] Subtest single-timeline: SUCCESS (0.012s)
[831.551598] [127/133] (203s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[831.642218] Starting subtest: plane-primary-toggle-with-vblank-wait
[831.643047] Starting dynamic subtest: pipe-A-eDP-1
[831.816837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[832.122856] Starting dynamic subtest: pipe-B-eDP-1
[833.032402] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.919s)
[833.331065] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.688s)
[834.155651] [128/133] (200s left) syncobj_basic (create-signaled)
[834.208370] Starting subtest: create-signaled
[834.209216] Subtest create-signaled: SUCCESS (0.000s)
[834.299064] [129/133] (200s left) api_intel_allocator (two-level-inception-interruptible)
[834.353738] Starting subtest: two-level-inception-interruptible
[839.805763] Subtest two-level-inception-interruptible: SUCCESS (5.409s)
[839.908837] [130/133] (194s left) kms_flip (wf_vblank-ts-check-interruptible)
[840.005151] Starting subtest: wf_vblank-ts-check-interruptible
[840.006636] Starting dynamic subtest: A-eDP1
[848.900267] Dynamic subtest A-eDP1: SUCCESS (8.872s)
[848.911078] Starting dynamic subtest: B-eDP1
[857.790986] Dynamic subtest B-eDP1: SUCCESS (8.890s)
[857.802606] Starting dynamic subtest: C-eDP1
[866.684981] Dynamic subtest C-eDP1: SUCCESS (8.882s)
[866.699488] Starting dynamic subtest: D-eDP1
[875.544645] Dynamic subtest D-eDP1: SUCCESS (8.896s)
[875.545749] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.553s)
[876.735875] [131/133] (158s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[876.829410] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[876.830991] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[876.934730] [132/133] (157s left) gem_partial_pwrite_pread (write-uncached)
[876.994183] Subtest write-uncached: SKIP (0.000s)
[877.057078] [133/133] (157s left) gem_exec_schedule (smoketest)
[877.238744] Starting subtest: smoketest
[877.239705] Starting dynamic subtest: rcs0
[882.795926] Dynamic subtest rcs0: SUCCESS (5.502s)
[882.806460] Starting dynamic subtest: bcs0
[888.313155] Dynamic subtest bcs0: SUCCESS (5.516s)
[888.326265] Starting dynamic subtest: vcs0
[893.805114] Dynamic subtest vcs0: SUCCESS (5.489s)
[893.816570] Starting dynamic subtest: vcs1
[899.298411] Dynamic subtest vcs1: SUCCESS (5.493s)
[899.310820] Starting dynamic subtest: vecs0
[904.796222] Dynamic subtest vecs0: SUCCESS (5.495s)
[904.807826] Starting dynamic subtest: ccs0
[910.305394] Dynamic subtest ccs0: SUCCESS (5.497s)
[910.306280] Subtest smoketest: SUCCESS (33.000s)
[910.472060] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_sequence
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: kms_chamelium_frames
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_joiner
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_cs_tlb
results: parsing output: 15/ for test: core_setmaster
results: parsing output: 16/ for test: kms_color_pipeline
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: sysfs_timeslice_duration
results: parsing output: 23/ for test: kms_fbcon_fbt
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_softpin
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_tiled_fence_blits
results: parsing output: 29/ for test: kms_chamelium_audio
results: parsing output: 30/ for test: gem_pread
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: i915_selftest
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: gem_exec_create
results: parsing output: 38/ for test: gem_pread
results: parsing output: 39/ for test: kms_atomic_transition
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_atomic
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: kms_plane_multiple
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_basic
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_dp_link_training
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_prime
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: kms_properties
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_vrr
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: gem_fence_thrash
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_draw_crc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_hdr
results: parsing output: 109/ for test: kms_force_connector_basic
results: parsing output: 110/ for test: i915_pm_rc6_residency
results: parsing output: 111/ for test: i915_pm_freq_api
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: gem_ringfill
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_shared
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_partial_pwrite_pread
results: parsing output: 132/ for test: gem_exec_schedule
Done.