[57.150563] Initializing watchdogs
[57.150607]   /dev/watchdog0
[57.164815] [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]
[57.169118] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.171399] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.175260] [001/132] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[57.296153] Starting subtest: psr-rgb565-draw-mmap-wc
[64.386831] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (7.127s)
[64.539181] [002/132] (953s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[64.661596] Starting subtest: flip-vs-cursor-atomic-transitions
[72.598193] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.950s)
[73.462752] [003/132] (944s left) i915_hangman (engine-error-state-capture)
[73.536302] Starting subtest: engine-error-state-capture
[73.538715] Starting dynamic subtest: rcs0
[76.856036] Dynamic subtest rcs0: SUCCESS (3.322s)
[76.866490] Starting dynamic subtest: bcs0
[82.868333] Dynamic subtest bcs0: SUCCESS (6.011s)
[82.877528] Starting dynamic subtest: vcs0
[88.819839] Dynamic subtest vcs0: SUCCESS (5.950s)
[88.830285] Starting dynamic subtest: vcs1
[93.874254] Dynamic subtest vcs1: SUCCESS (5.053s)
[93.884682] Starting dynamic subtest: vecs0
[99.826716] Dynamic subtest vecs0: SUCCESS (5.951s)
[99.837541] Starting dynamic subtest: ccs0
[104.883415] Dynamic subtest ccs0: SUCCESS (5.054s)
[104.886151] Subtest engine-error-state-capture: SUCCESS (31.347s)
[104.983508] [004/132] (912s left) perf_pmu (frequency)
[105.030131] Starting subtest: frequency
[105.032360] Starting dynamic subtest: gt0
[107.241371] Dynamic subtest gt0: SUCCESS (2.204s)
[107.251344] Starting dynamic subtest: idle-gt0
[107.746308] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[107.754515] Starting dynamic subtest: gt1
[111.897637] Dynamic subtest gt1: SUCCESS (4.148s)
[111.905701] Starting dynamic subtest: idle-gt1
[112.401620] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[112.404143] Subtest frequency: SUCCESS (7.374s)
[112.513885] [005/132] (905s left) kms_pm_dc (dc5-dpms)
[113.617607] Starting subtest: dc5-dpms
[115.703463] Subtest dc5-dpms: SUCCESS (2.084s)
[115.803394] [006/132] (902s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[115.863558] Starting subtest: multi-wait-all-for-submit-available-submitted
[115.866047] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[116.004797] [007/132] (901s left) gen9_exec_parse (basic-rejected)
[116.072356] Subtest basic-rejected: SKIP (0.000s)
[116.133593] [008/132] (901s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[116.243192] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[116.247630] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[116.357364] [009/132] (901s left) gem_exec_schedule (promotion)
[116.438929] Starting subtest: promotion
[116.441070] Starting dynamic subtest: rcs0
[116.538074] Dynamic subtest rcs0: SUCCESS (0.106s)
[116.548893] Starting dynamic subtest: vcs0
[116.629068] Dynamic subtest vcs0: SUCCESS (0.091s)
[116.639771] Starting dynamic subtest: vcs1
[116.714467] Dynamic subtest vcs1: SUCCESS (0.085s)
[116.726835] Starting dynamic subtest: vecs0
[116.795233] Dynamic subtest vecs0: SUCCESS (0.080s)
[116.806472] Starting dynamic subtest: ccs0
[116.881855] Dynamic subtest ccs0: SUCCESS (0.086s)
[116.884153] Subtest promotion: SUCCESS (0.451s)
[118.050815] [010/132] (899s left) kms_rotation_crc (exhaust-fences)
[118.152352] Starting subtest: exhaust-fences
[118.156677] Subtest exhaust-fences: SKIP (0.000s)
[118.249808] [011/132] (899s left) syncobj_wait (signal)
[118.325818] Starting subtest: signal
[118.328119] Subtest signal: SUCCESS (0.000s)
[118.465922] [012/132] (899s left) kms_color (deep-color)
[118.562877] Starting subtest: deep-color
[119.627385] Starting dynamic subtest: pipe-A-eDP-1-gamma
[120.342314] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.716s)
[120.352275] Starting dynamic subtest: pipe-A-eDP-1-degamma
[121.832728] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.490s)
[121.842387] Starting dynamic subtest: pipe-A-eDP-1-ctm
[123.265254] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.431s)
[124.028061] Starting dynamic subtest: pipe-B-eDP-1-gamma
[124.765410] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.741s)
[124.773847] Starting dynamic subtest: pipe-B-eDP-1-degamma
[126.222705] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.457s)
[126.232216] Starting dynamic subtest: pipe-B-eDP-1-ctm
[127.665394] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.443s)
[128.431760] Starting dynamic subtest: pipe-C-eDP-1-gamma
[129.153138] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.730s)
[129.163205] Starting dynamic subtest: pipe-C-eDP-1-degamma
[130.592724] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.438s)
[130.601958] Starting dynamic subtest: pipe-C-eDP-1-ctm
[132.000587] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.407s)
[132.812634] Starting dynamic subtest: pipe-D-eDP-1-gamma
[133.516557] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.710s)
[133.524368] Starting dynamic subtest: pipe-D-eDP-1-degamma
[134.898425] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.380s)
[134.907819] Starting dynamic subtest: pipe-D-eDP-1-ctm
[136.323845] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.425s)
[136.326226] Subtest deep-color: SUCCESS (17.761s)
[137.209963] [013/132] (880s left) gem_exec_fence (syncobj-signal)
[137.661215] Starting subtest: syncobj-signal
[137.666327] Subtest syncobj-signal: SUCCESS (0.005s)
[139.034413] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[139.038097] [014/132] (879s left) gem_exec_balancer (semaphore)
[139.107296] Starting subtest: semaphore
[140.912437] Subtest semaphore: SUCCESS (1.803s)
[141.287694] [015/132] (876s left) gem_workarounds (suspend-resume-context)
[141.361095] Starting subtest: suspend-resume-context
[158.512845] Subtest suspend-resume-context: SUCCESS (2.494s)
[165.677847] [016/132] (859s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[165.790031] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[165.792236] Starting dynamic subtest: pipe-A-eDP-1
[165.814760] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.826167] Starting dynamic subtest: pipe-B-eDP-1
[165.846857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.855539] Starting dynamic subtest: pipe-C-eDP-1
[165.876254] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.884377] Starting dynamic subtest: pipe-D-eDP-1
[165.906911] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.911247] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[168.018490] [017/132] (857s left) gem_spin_batch (resubmit-new)
[168.085050] Starting subtest: resubmit-new
[168.087288] Starting dynamic subtest: rcs0
[168.093399] Dynamic subtest rcs0: SUCCESS (0.009s)
[168.104211] Starting dynamic subtest: bcs0
[168.106337] Dynamic subtest bcs0: SUCCESS (0.004s)
[168.115298] Starting dynamic subtest: vcs0
[168.117525] Dynamic subtest vcs0: SUCCESS (0.004s)
[168.125843] Starting dynamic subtest: vcs1
[168.127940] Dynamic subtest vcs1: SUCCESS (0.004s)
[168.136227] Starting dynamic subtest: vecs0
[168.138394] Dynamic subtest vecs0: SUCCESS (0.004s)
[168.146764] Starting dynamic subtest: ccs0
[168.148910] Dynamic subtest ccs0: SUCCESS (0.005s)
[168.150986] Subtest resubmit-new: SUCCESS (0.032s)
[169.620119] [018/132] (855s left) kms_pm_rpm (i2c)
[171.744422] Starting subtest: i2c
[176.735172] Subtest i2c: SUCCESS (5.055s)
[176.849629] [019/132] (848s left) gem_pxp (display-protected-crc)
[176.969856] Starting subtest: display-protected-crc
[179.230910] Subtest display-protected-crc: SUCCESS (2.280s)
[179.385896] [020/132] (846s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[179.480978] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[179.483234] Starting dynamic subtest: pipe-A-eDP-1
[179.507664] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[179.522093] Starting dynamic subtest: pipe-B-eDP-1
[179.543834] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[179.554397] Starting dynamic subtest: pipe-C-eDP-1
[179.576309] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[179.586741] Starting dynamic subtest: pipe-D-eDP-1
[179.609441] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[179.614070] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[181.747578] [021/132] (843s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[181.837722] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[181.842151] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[182.980607] [022/132] (842s left) i915_selftest (live)
[186.512589] Starting subtest: live
[186.515215] Starting dynamic subtest: sanitycheck
[190.949891] Dynamic subtest sanitycheck: SUCCESS (4.447s)
[190.959164] Starting dynamic subtest: uncore
[195.363469] Dynamic subtest uncore: SUCCESS (4.413s)
[195.373164] Starting dynamic subtest: workarounds
[213.553189] Dynamic subtest workarounds: FAIL (17.702s)
[213.562998] Starting dynamic subtest: gt_engines
[217.783714] Dynamic subtest gt_engines: SUCCESS (4.724s)
[217.793396] Starting dynamic subtest: gt_timelines
[233.746841] Dynamic subtest gt_timelines: SUCCESS (15.968s)
[233.756874] Starting dynamic subtest: gt_contexts
[238.186706] Dynamic subtest gt_contexts: SUCCESS (4.441s)
[238.201730] Starting dynamic subtest: gt_lrc
[242.617514] Dynamic subtest gt_lrc: SUCCESS (4.430s)
[242.626999] Starting dynamic subtest: gt_mocs
[245.686147] Dynamic subtest gt_mocs: SUCCESS (3.068s)
[245.695064] Starting dynamic subtest: gt_pm
[252.526095] Dynamic subtest gt_pm: SUCCESS (6.838s)
[252.535701] Starting dynamic subtest: gt_heartbeat
[256.934901] Dynamic subtest gt_heartbeat: SUCCESS (4.411s)
[256.944320] Starting dynamic subtest: gt_tlb
[266.391072] Dynamic subtest gt_tlb: SUCCESS (9.449s)
[266.400758] Starting dynamic subtest: requests
[280.033091] Dynamic subtest requests: SUCCESS (13.636s)
[280.042833] Starting dynamic subtest: migrate
[288.238133] Dynamic subtest migrate: SUCCESS (8.202s)
[288.253341] Starting dynamic subtest: active
[292.658126] Dynamic subtest active: SUCCESS (4.418s)
[292.668673] Starting dynamic subtest: objects
[297.536467] Dynamic subtest objects: SUCCESS (4.876s)
[297.546129] Starting dynamic subtest: mman
[301.031199] Dynamic subtest mman: SUCCESS (3.494s)
[301.040292] Starting dynamic subtest: dmabuf
[305.489790] Dynamic subtest dmabuf: SUCCESS (4.456s)
[305.500077] Starting dynamic subtest: vma
[309.911521] Dynamic subtest vma: SUCCESS (4.420s)
[309.921544] Starting dynamic subtest: coherency
[315.195562] Dynamic subtest coherency: SUCCESS (5.282s)
[315.205219] Starting dynamic subtest: gtt
[327.232329] Dynamic subtest gtt: SUCCESS (12.037s)
[327.241385] Starting dynamic subtest: gem
[335.340220] Dynamic subtest gem: SUCCESS (8.108s)
[335.349821] Starting dynamic subtest: evict
[340.850151] Dynamic subtest evict: SUCCESS (5.509s)
[340.865921] Starting dynamic subtest: hugepages
[352.085000] Dynamic subtest hugepages: SUCCESS (11.235s)
[352.094545] Starting dynamic subtest: gem_contexts
[380.754406] Dynamic subtest gem_contexts: SUCCESS (28.676s)
[380.764206] Starting dynamic subtest: client
[383.994755] Dynamic subtest client: SUCCESS (3.240s)
[384.005043] Starting dynamic subtest: gem_migrate
[388.439137] Dynamic subtest gem_migrate: SUCCESS (4.440s)
[388.449664] Starting dynamic subtest: reset
[392.822442] Dynamic subtest reset: SUCCESS (4.379s)
[392.832231] Starting dynamic subtest: memory_region
[397.306879] Dynamic subtest memory_region: SUCCESS (4.480s)
[397.317092] Starting dynamic subtest: hangcheck
[410.593883] Dynamic subtest hangcheck: SUCCESS (13.281s)
[410.609575] Starting dynamic subtest: execlists
[415.020872] Dynamic subtest execlists: SUCCESS (4.423s)
[415.030369] Starting dynamic subtest: ring_submission
[419.412138] Dynamic subtest ring_submission: SUCCESS (4.388s)
[419.421774] Starting dynamic subtest: perf
[423.864847] Dynamic subtest perf: SUCCESS (4.450s)
[423.874720] Starting dynamic subtest: slpc
[438.134726] Dynamic subtest slpc: SUCCESS (14.266s)
[438.143936] Starting dynamic subtest: guc
[442.154600] Dynamic subtest guc: SUCCESS (4.017s)
[442.164734] Starting dynamic subtest: guc_multi_lrc
[446.511515] Dynamic subtest guc_multi_lrc: SUCCESS (4.355s)
[446.521715] Starting dynamic subtest: guc_hang
[451.425316] Dynamic subtest guc_hang: SUCCESS (4.911s)
[451.434666] Starting dynamic subtest: late_gt_pm
[455.844834] Dynamic subtest late_gt_pm: SUCCESS (4.418s)
[455.847690] Subtest live: FAIL (269.360s)
[455.876885] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[455.877548] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[455.880682] [023/132] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[457.513434] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[464.365107] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.853s)
[464.525574] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[464.526764] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[464.530498] [024/132] (561s left) perf (gen12-oa-tlb-invalidate)
[464.685093] Starting subtest: gen12-oa-tlb-invalidate
[464.687280] Starting dynamic subtest: 0-rcs0
[474.735487] Dynamic subtest 0-rcs0: SUCCESS (10.049s)
[474.744659] Starting dynamic subtest: 1-vcs1
[484.783594] Dynamic subtest 1-vcs1: SUCCESS (10.047s)
[484.786041] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.099s)
[484.828763] [025/132] (540s left) kms_addfb_basic (too-wide)
[484.929736] Starting subtest: too-wide
[484.932088] Subtest too-wide: SUCCESS (0.000s)
[485.061683] [026/132] (540s left) kms_big_fb (linear-8bpp-rotate-180)
[485.171765] Starting subtest: linear-8bpp-rotate-180
[486.423577] Subtest linear-8bpp-rotate-180: SUCCESS (1.251s)
[486.604372] [027/132] (539s left) kms_getfb (getfb-reject-nv12)
[486.704150] Starting subtest: getfb-reject-nv12
[486.706074] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[486.852222] [028/132] (538s left) kms_plane (plane-panning-bottom-right)
[486.944894] Starting subtest: plane-panning-bottom-right
[486.946437] Starting dynamic subtest: pipe-A
[488.660136] Dynamic subtest pipe-A: SUCCESS (1.713s)
[488.670723] Starting dynamic subtest: pipe-B
[491.025061] Dynamic subtest pipe-B: SUCCESS (2.366s)
[491.027437] Subtest plane-panning-bottom-right: SUCCESS (4.082s)
[491.851376] [029/132] (533s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[491.922540] Starting subtest: map-fixed-invalidate-overlap-busy
[491.927130] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[492.079757] [030/132] (533s left) prime_vgem (basic-write)
[492.164321] Starting subtest: basic-write
[492.173977] Subtest basic-write: SKIP (0.008s)
[492.329214] [031/132] (533s left) gem_exec_whisper (basic-contexts-forked-all)
[492.393552] Starting subtest: basic-contexts-forked-all
[512.567345] Subtest basic-contexts-forked-all: SUCCESS (20.171s)
[512.777061] [032/132] (513s left) kms_psr (fbc-pr-cursor-blt)
[512.881300] Starting subtest: fbc-pr-cursor-blt
[512.885708] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[512.978030] [033/132] (512s left) gen7_exec_parse (basic-allowed)
[513.033978] Subtest basic-allowed: SKIP (0.000s)
[513.120557] [034/132] (512s left) core_auth (getclient-simple)
[513.154038] Starting subtest: getclient-simple
[513.179083] Subtest getclient-simple: SUCCESS (0.024s)
[513.311994] [035/132] (512s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[513.418479] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[513.420690] Starting dynamic subtest: pipe-A-default-mode
[513.724911] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[513.729552] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.303s)
[514.581110] [036/132] (511s left) gem_create (create-ext-placement-sanity-check)
[514.762775] Starting subtest: create-ext-placement-sanity-check
[514.765463] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[514.897199] [037/132] (511s left) kms_psr (psr2-sprite-blt)
[515.004026] Starting subtest: psr2-sprite-blt
[515.006323] Starting dynamic subtest: eDP-1
[516.758125] Dynamic subtest eDP-1: SUCCESS (1.756s)
[516.760373] Subtest psr2-sprite-blt: SUCCESS (1.757s)
[517.672054] [038/132] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[517.785055] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[517.789132] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[517.911113] [039/132] (508s left) gem_ctx_persistence (engines-hang)
[517.973402] Starting subtest: engines-hang
[517.975606] Starting dynamic subtest: rcs0
[518.140381] Dynamic subtest rcs0: SUCCESS (0.167s)
[518.152486] Starting dynamic subtest: bcs0
[518.257358] Dynamic subtest bcs0: SUCCESS (0.115s)
[518.269517] Starting dynamic subtest: vcs0
[518.373556] Dynamic subtest vcs0: SUCCESS (0.114s)
[518.385648] Starting dynamic subtest: vcs1
[518.457333] Dynamic subtest vcs1: SUCCESS (0.082s)
[518.468085] Starting dynamic subtest: vecs0
[518.583086] Dynamic subtest vecs0: SUCCESS (0.124s)
[518.596207] Starting dynamic subtest: ccs0
[518.748293] Dynamic subtest ccs0: SUCCESS (0.162s)
[518.750500] Subtest engines-hang: SUCCESS (0.777s)
[518.848813] [040/132] (507s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[518.986013] Starting subtest: cursorA-vs-flipB-atomic
[518.989739] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[519.155932] [041/132] (507s left) gem_exec_reloc (basic-write-gtt)
[519.226868] Subtest basic-write-gtt: SKIP (0.000s)
[519.314223] [042/132] (507s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[519.372990] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[519.477483] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[519.582090] [043/132] (506s left) gem_render_copy (linear-to-vebox-yf-tiled)
[519.641152] Starting subtest: linear-to-vebox-yf-tiled
[519.645365] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[519.844606] [044/132] (506s left) kms_addfb_basic (invalid-get-prop-any)
[519.904973] Starting subtest: invalid-get-prop-any
[519.907340] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[520.081107] [045/132] (506s left) kms_flip (busy-flip)
[520.181726] Starting subtest: busy-flip
[520.183914] Starting dynamic subtest: A-eDP1
[521.854641] Dynamic subtest A-eDP1: SUCCESS (1.674s)
[521.868261] Starting dynamic subtest: B-eDP1
[523.593612] Dynamic subtest B-eDP1: SUCCESS (1.737s)
[523.608122] Starting dynamic subtest: C-eDP1
[525.311643] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[525.325599] Starting dynamic subtest: D-eDP1
[526.955859] Dynamic subtest D-eDP1: SUCCESS (1.642s)
[526.958303] Subtest busy-flip: SUCCESS (6.781s)
[528.240382] [046/132] (498s left) gem_readwrite (read-bad-handle)
[528.312641] Subtest read-bad-handle: SKIP (0.000s)
[528.389212] [047/132] (498s left) core_getstats (basic)
[528.447883] Starting subtest: basic
[528.450100] Subtest basic: SUCCESS (0.000s)
[528.589152] [048/132] (498s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[528.679098] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[529.314678] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[529.544770] [049/132] (497s left) kms_atomic (plane-invalid-params-fence)
[529.638844] Starting subtest: plane-invalid-params-fence
[529.641161] Starting dynamic subtest: pipe-A-eDP-1
[530.007859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[530.010237] Subtest plane-invalid-params-fence: SUCCESS (0.369s)
[530.881585] [050/132] (495s left) kms_pm_rpm (pc8-residency)
[532.721862] Starting subtest: pc8-residency
[532.727028] Subtest pc8-residency: SKIP (0.000s)
[533.220728] [051/132] (493s left) kms_psr2_su (frontbuffer-xrgb8888)
[533.273842] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[533.346769] [052/132] (493s left) syncobj_timeline (etime-single-wait-submitted)
[533.399542] Starting subtest: etime-single-wait-submitted
[533.508431] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[533.608495] [053/132] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[533.713842] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[533.718365] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[533.847167] [054/132] (493s left) kms_chamelium_color (ctm-blue-to-red)
[533.946953] Subtest ctm-blue-to-red: SKIP (0.000s)
[533.995400] [055/132] (492s left) syncobj_wait (multi-wait-all-signaled)
[534.056695] Starting subtest: multi-wait-all-signaled
[534.058961] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[534.200576] [056/132] (492s left) prime_mmap (test_correct_cpu_write)
[534.262142] Starting subtest: test_correct_cpu_write
[534.264183] Starting dynamic subtest: test_correct_cpu_write-smem
[534.266185] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[534.268177] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[534.393734] [057/132] (492s left) gem_exec_reloc (basic-concurrent16)
[534.457069] Subtest basic-concurrent16: SKIP (0.000s)
[534.525187] [058/132] (492s left) vgem_basic (bad-handle)
[534.566987] Starting subtest: bad-handle
[534.568897] Subtest bad-handle: SUCCESS (0.000s)
[534.651870] [059/132] (492s left) gem_userptr_blits (readonly-pwrite-unsync)
[534.730379] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[534.902385] [060/132] (492s left) gem_exec_schedule (implicit-read-write)
[534.981489] Starting subtest: implicit-read-write
[534.983478] Starting dynamic subtest: rcs0
[535.085612] Dynamic subtest rcs0: SUCCESS (0.109s)
[535.098427] Starting dynamic subtest: vcs0
[535.165602] Dynamic subtest vcs0: SUCCESS (0.079s)
[535.177277] Starting dynamic subtest: vcs1
[535.242380] Dynamic subtest vcs1: SUCCESS (0.076s)
[535.254229] Starting dynamic subtest: vecs0
[535.315190] Dynamic subtest vecs0: SUCCESS (0.072s)
[535.326752] Starting dynamic subtest: ccs0
[535.396660] Dynamic subtest ccs0: SUCCESS (0.080s)
[535.399362] Subtest implicit-read-write: SUCCESS (0.421s)
[536.681259] [061/132] (490s left) gem_tiled_fence_blits (normal)
[536.760634] Subtest normal: SKIP (0.000s)
[536.843311] [062/132] (490s left) i915_pm_rpm (gem-idle)
[538.775238] Starting subtest: gem-idle
[544.977013] Subtest gem-idle: SUCCESS (6.206s)
[545.334447] [063/132] (481s left) kms_content_protection (content-type-change)
[546.637707] Starting subtest: content-type-change
[546.642109] Subtest content-type-change: SKIP (0.000s)
[546.807013] [064/132] (480s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[546.911688] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[550.634058] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.727s)
[551.828655] [065/132] (475s left) kms_vblank (ts-continuation-dpms-suspend)
[551.924193] Starting subtest: ts-continuation-dpms-suspend
[551.926225] Starting dynamic subtest: pipe-A-eDP-1
[570.094167] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.258s)
[570.110063] Starting dynamic subtest: pipe-D-eDP-1
[588.094335] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.901s)
[588.096776] Subtest ts-continuation-dpms-suspend: SUCCESS (5.162s)
[593.929644] [066/132] (438s left) perf_pmu (most-busy-idle-check-all)
[593.993724] Starting subtest: most-busy-idle-check-all
[593.996028] Starting dynamic subtest: rcs0
[594.697533] Dynamic subtest rcs0: FAIL (0.632s)
[594.709465] Starting dynamic subtest: bcs0
[595.578713] Dynamic subtest bcs0: SUCCESS (0.983s)
[595.591264] Starting dynamic subtest: vcs0
[597.563165] Dynamic subtest vcs0: SUCCESS (2.030s)
[597.574301] Starting dynamic subtest: vcs1
[599.611671] Dynamic subtest vcs1: SUCCESS (2.085s)
[599.623960] Starting dynamic subtest: vecs0
[601.595400] Dynamic subtest vecs0: SUCCESS (2.010s)
[601.608455] Starting dynamic subtest: ccs0
[603.579447] Dynamic subtest ccs0: SUCCESS (2.003s)
[603.582220] Subtest most-busy-idle-check-all: FAIL (9.757s)
[603.701070] [067/132] (428s left) gem_exec_balancer (full-pulse)
[603.772364] Starting subtest: full-pulse
[608.452593] Subtest full-pulse: SUCCESS (4.716s)
[608.768262] [068/132] (423s left) kms_invalid_mode (bad-hsync-end)
[608.876930] Starting subtest: bad-hsync-end
[608.879132] Starting dynamic subtest: pipe-A-eDP-1
[609.161526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[609.171898] Starting dynamic subtest: pipe-B-eDP-1
[609.173786] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[609.182684] Starting dynamic subtest: pipe-C-eDP-1
[609.185012] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[609.193976] Starting dynamic subtest: pipe-D-eDP-1
[609.196034] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[609.198126] Subtest bad-hsync-end: SUCCESS (0.290s)
[610.024473] [069/132] (422s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[610.087739] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[610.089687] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[610.214561] [070/132] (422s left) kms_draw_crc (fill-fb)
[610.312091] Starting subtest: fill-fb
[610.773973] Subtest fill-fb: SUCCESS (0.466s)
[610.922174] [071/132] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[611.021508] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[611.025118] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[611.164400] [072/132] (421s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[611.255310] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[618.456912] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.223s)
[618.620840] [073/132] (414s left) syncobj_timeline (multi-wait-submitted-signaled)
[618.693463] Starting subtest: multi-wait-submitted-signaled
[618.695839] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[618.835037] [074/132] (413s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[618.944567] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[618.948670] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[619.086577] [075/132] (413s left) kms_lease (invalid-create-leases)
[619.185892] Starting subtest: invalid-create-leases
[619.190392] Subtest invalid-create-leases: SUCCESS (0.006s)
[619.343913] [076/132] (413s left) gem_render_copy (linear)
[619.397074] Starting subtest: linear
[619.399046] Starting dynamic subtest: smem
[619.434119] Dynamic subtest smem: SUCCESS (0.040s)
[619.436327] Subtest linear: SUCCESS (0.041s)
[619.710259] [077/132] (413s left) gem_mmap_offset (clear-via-pagefault)
[619.776152] Starting subtest: clear-via-pagefault
[619.778457] Starting dynamic subtest: smem0
[653.946167] Dynamic subtest smem0: SUCCESS (34.172s)
[653.948556] Subtest clear-via-pagefault: SUCCESS (34.174s)
[654.101088] [078/132] (378s left) i915_query (query-garbage)
[654.161904] Starting subtest: query-garbage
[654.164166] Subtest query-garbage: SUCCESS (0.000s)
[654.282910] [079/132] (378s left) gem_exec_whisper (basic-queues-forked-all)
[654.349274] Starting subtest: basic-queues-forked-all
[675.760696] Subtest basic-queues-forked-all: SUCCESS (21.414s)
[675.979914] [080/132] (357s left) gem_media_fill (media-fill)
[676.060949] Subtest media-fill: SKIP (0.000s)
[676.216745] [081/132] (356s left) i915_query (query-topology-kernel-writes)
[676.279510] Starting subtest: query-topology-kernel-writes
[676.282196] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[676.416104] [082/132] (356s left) kms_flip (2x-flip-vs-rmfb)
[676.531891] Starting subtest: 2x-flip-vs-rmfb
[676.543156] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[676.694419] [083/132] (356s left) kms_psr (pr-primary-mmap-cpu)
[676.781678] Starting subtest: pr-primary-mmap-cpu
[676.786069] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[676.879336] [084/132] (356s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[676.967029] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[676.970599] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[677.084506] [085/132] (356s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[677.145863] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[677.149654] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[677.354863] [086/132] (355s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[677.481638] Starting subtest: modeset-atomic-cursor-hotspot
[677.486305] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[677.649642] [087/132] (355s left) perf (blocking-parameterized)
[677.762573] Starting subtest: blocking-parameterized
[697.781492] Subtest blocking-parameterized: SUCCESS (20.020s)
[697.831012] [088/132] (335s left) kms_frontbuffer_tracking (psr-1p-rte)
[697.936244] Starting subtest: psr-1p-rte
[703.345147] Subtest psr-1p-rte: SUCCESS (5.409s)
[703.523284] [089/132] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[703.632974] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[703.637249] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[703.776178] [090/132] (329s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[708.931183] Starting subtest: pr-cursor-plane-update-sf
[708.935508] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[709.792448] [091/132] (323s left) kms_async_flips (async-flip-suspend-resume)
[709.891783] Starting subtest: async-flip-suspend-resume
[710.280578] Starting dynamic subtest: pipe-A-eDP-1
[728.522416] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.318s)
[728.911887] Starting dynamic subtest: pipe-B-eDP-1
[747.529481] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.302s)
[747.917823] Starting dynamic subtest: pipe-C-eDP-1
[766.519728] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.301s)
[766.896386] Starting dynamic subtest: pipe-D-eDP-1
[785.539389] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.329s)
[785.541822] Subtest async-flip-suspend-resume: SUCCESS (14.769s)
[792.756930] [092/132] (246s left) prime_mmap_coherency (ioctl-errors)
[792.846445] Starting subtest: ioctl-errors
[810.970200] Subtest ioctl-errors: SUCCESS (18.099s)
[811.125341] [093/132] (228s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[811.264310] Starting subtest: psr-rgb101010-draw-mmap-cpu
[818.319904] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.057s)
[818.443016] [094/132] (221s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[818.556073] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[818.560142] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[818.701184] [095/132] (220s left) kms_fb_coherency (memset-crc)
[818.794315] Starting subtest: memset-crc
[818.796222] Starting dynamic subtest: mmap-offset-wc
[819.220542] Dynamic subtest mmap-offset-wc: SUCCESS (0.426s)
[819.522679] Starting dynamic subtest: mmap-offset-uc
[825.632537] Dynamic subtest mmap-offset-uc: SUCCESS (6.120s)
[825.934567] Subtest memset-crc: SUCCESS (7.138s)
[826.777002] [096/132] (212s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[826.869466] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[826.871709] Starting dynamic subtest: pipe-A-default-mode
[829.587669] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[829.589713] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.719s)
[830.461302] [097/132] (209s left) gem_ppgtt (blt-vs-render-ctxn)
[830.532960] Starting subtest: blt-vs-render-ctxN
[863.413036] Subtest blt-vs-render-ctxN: SUCCESS (32.875s)
[863.593243] [098/132] (176s left) i915_drm_fdinfo (busy-idle)
[863.678914] Starting subtest: busy-idle
[863.681203] Starting dynamic subtest: rcs0
[863.685595] Dynamic subtest rcs0: SKIP (0.001s)
[863.696498] Starting dynamic subtest: bcs0
[863.700386] Dynamic subtest bcs0: SKIP (0.000s)
[863.711132] Starting dynamic subtest: vcs0
[863.715222] Dynamic subtest vcs0: SKIP (0.000s)
[863.725376] Starting dynamic subtest: vcs1
[863.729167] Dynamic subtest vcs1: SKIP (0.000s)
[863.739449] Starting dynamic subtest: vecs0
[863.743847] Dynamic subtest vecs0: SKIP (0.000s)
[863.754179] Starting dynamic subtest: ccs0
[863.758405] Dynamic subtest ccs0: SKIP (0.020s)
[863.762796] Subtest busy-idle: SKIP (0.027s)
[863.807219] [099/132] (176s left) kms_frontbuffer_tracking (fbc-1p-rte)
[863.921413] Starting subtest: fbc-1p-rte
[869.433130] Subtest fbc-1p-rte: SUCCESS (5.516s)
[870.674489] [100/132] (169s left) dumb_buffer (map-valid)
[870.730242] Starting subtest: map-valid
[870.732138] Subtest map-valid: SUCCESS (0.000s)
[870.863899] [101/132] (169s left) kms_chamelium_edid (dp-edid-resolution-list)
[871.253299] Subtest dp-edid-resolution-list: SKIP (0.000s)
[872.059215] [102/132] (167s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[872.146234] Starting subtest: fbc-dirtyfb-ioctl
[872.148144] Starting dynamic subtest: A-eDP-1
[874.738862] Dynamic subtest A-eDP-1: SUCCESS (2.590s)
[874.741203] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.592s)
[875.565771] [103/132] (164s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[875.675517] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[875.679868] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[875.815250] [104/132] (164s left) prime_vgem (fence-wait)
[875.912109] Starting subtest: fence-wait
[875.914791] Starting dynamic subtest: rcs0
[876.981452] Dynamic subtest rcs0: SUCCESS (1.068s)
[876.994933] Starting dynamic subtest: bcs0
[878.066115] Dynamic subtest bcs0: SUCCESS (1.083s)
[878.080368] Starting dynamic subtest: vcs0
[879.120133] Dynamic subtest vcs0: SUCCESS (1.050s)
[879.133830] Starting dynamic subtest: vcs1
[880.161572] Dynamic subtest vcs1: SUCCESS (1.040s)
[880.175244] Starting dynamic subtest: vecs0
[881.202737] Dynamic subtest vecs0: SUCCESS (1.039s)
[881.217155] Starting dynamic subtest: ccs0
[882.248773] Dynamic subtest ccs0: SUCCESS (1.042s)
[882.251557] Subtest fence-wait: SUCCESS (6.336s)
[882.418826] [105/132] (157s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[882.525455] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[882.529537] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[882.648436] [106/132] (157s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[882.757641] Starting subtest: yf-tiled-64bpp-rotate-0
[882.762032] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[882.898798] [107/132] (157s left) gem_ctx_persistence (legacy-engines-mixed)
[882.959991] Starting subtest: legacy-engines-mixed
[882.962404] Starting dynamic subtest: render
[883.068068] Dynamic subtest render: SUCCESS (0.111s)
[883.084573] Starting dynamic subtest: bsd1
[883.149955] Dynamic subtest bsd1: SUCCESS (0.079s)
[883.163080] Starting dynamic subtest: bsd2
[883.230862] Dynamic subtest bsd2: SUCCESS (0.078s)
[883.244493] Starting dynamic subtest: blt
[883.286399] Dynamic subtest blt: SUCCESS (0.053s)
[883.298462] Starting dynamic subtest: vebox
[883.350518] Dynamic subtest vebox: SUCCESS (0.062s)
[883.352600] Subtest legacy-engines-mixed: SUCCESS (0.395s)
[883.456768] [108/132] (156s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[883.550150] Starting subtest: fbc-2p-pri-indfb-multidraw
[883.553558] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[883.670258] [109/132] (156s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[883.770487] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[883.773800] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[883.904724] [110/132] (156s left) syncobj_wait (wait-any-snapshot)
[883.966026] Starting subtest: wait-any-snapshot
[884.048375] Subtest wait-any-snapshot: SUCCESS (0.082s)
[884.179589] [111/132] (156s left) kms_psr (psr-sprite-blt)
[884.277568] Starting subtest: psr-sprite-blt
[884.279574] Starting dynamic subtest: eDP-1
[886.083753] Dynamic subtest eDP-1: SUCCESS (1.805s)
[886.086132] Subtest psr-sprite-blt: SUCCESS (1.806s)
[886.947586] [112/132] (153s left) kms_cursor_crc (cursor-onscreen-256x256)
[887.196938] Starting subtest: cursor-onscreen-256x256
[887.202104] Starting dynamic subtest: pipe-A-eDP-1
[889.335654] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s)
[889.373347] Starting dynamic subtest: pipe-D-eDP-1
[892.105103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s)
[892.107470] Subtest cursor-onscreen-256x256: SUCCESS (4.906s)
[893.007710] [113/132] (147s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[893.120355] Starting subtest: x-tiled-64bpp-rotate-90
[893.139562] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[893.313312] [114/132] (147s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[893.430324] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[893.434648] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[893.600776] [115/132] (146s left) gem_ctx_shared (q-in-order)
[893.673657] Starting subtest: Q-in-order
[893.675627] Starting dynamic subtest: rcs0
[893.787425] Dynamic subtest rcs0: SUCCESS (0.115s)
[893.809691] Starting dynamic subtest: vcs0
[893.870908] Dynamic subtest vcs0: SUCCESS (0.084s)
[893.892056] Starting dynamic subtest: vcs1
[893.947504] Dynamic subtest vcs1: SUCCESS (0.076s)
[893.967130] Starting dynamic subtest: vecs0
[894.023937] Dynamic subtest vecs0: SUCCESS (0.075s)
[894.042254] Starting dynamic subtest: ccs0
[894.100551] Dynamic subtest ccs0: SUCCESS (0.075s)
[894.103141] Subtest Q-in-order: SUCCESS (0.430s)
[895.565513] [116/132] (145s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[895.665160] Starting subtest: fbc-rgb101010-draw-mmap-wc
[900.314338] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.651s)
[901.514592] [117/132] (139s left) syncobj_wait (invalid-reset-zero-handles)
[901.579492] Starting subtest: invalid-reset-zero-handles
[901.581725] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[901.694492] [118/132] (139s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[901.787398] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[901.789994] Starting dynamic subtest: pipe-A
[901.807944] Dynamic subtest pipe-A: SKIP (0.017s)
[901.819970] Starting dynamic subtest: pipe-B
[901.839052] Dynamic subtest pipe-B: SKIP (0.031s)
[901.850462] Starting dynamic subtest: pipe-C
[901.871882] Dynamic subtest pipe-C: SKIP (0.031s)
[901.882345] Starting dynamic subtest: pipe-D
[901.903476] Dynamic subtest pipe-D: SKIP (0.031s)
[901.907671] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.113s)
[902.038417] [119/132] (138s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[902.144346] Starting subtest: y-tiled-16bpp-rotate-90
[902.148699] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[902.268612] [120/132] (138s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[902.357019] Starting subtest: fbc-psr-cursor-mmap-gtt
[902.359272] Starting dynamic subtest: eDP-1
[902.363406] Dynamic subtest eDP-1: SKIP (0.000s)
[902.367720] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[902.457516] [121/132] (138s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[902.543231] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[902.545267] Starting dynamic subtest: pipe-A-eDP-1
[903.288289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[903.300710] Starting dynamic subtest: pipe-B-eDP-1
[905.114050] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.825s)
[905.126922] Starting dynamic subtest: pipe-C-eDP-1
[906.950583] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.835s)
[906.962388] Starting dynamic subtest: pipe-D-eDP-1
[908.769845] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.817s)
[908.772107] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.219s)
[909.925147] [122/132] (130s left) kms_busy (basic)
[910.038667] Starting subtest: basic
[910.040953] Starting dynamic subtest: flip
[910.638863] Dynamic subtest flip: SUCCESS (0.600s)
[910.652932] Starting dynamic subtest: modeset
[914.248277] Dynamic subtest modeset: SUCCESS (3.608s)
[914.250585] Subtest basic: SUCCESS (4.210s)
[915.083357] [123/132] (125s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[915.356044] Starting subtest: cursor-rapid-movement-512x170
[915.360362] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[915.523461] [124/132] (125s left) kms_plane_alpha_blend (constant-alpha-min)
[915.638960] Starting subtest: constant-alpha-min
[915.939378] Starting dynamic subtest: pipe-A-eDP-1
[916.672253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[916.683930] Starting dynamic subtest: pipe-D-eDP-1
[918.123366] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.448s)
[918.125648] Subtest constant-alpha-min: SUCCESS (2.484s)
[918.953009] [125/132] (122s left) prime_self_import (basic-llseek-bad)
[918.991225] Starting subtest: basic-llseek-bad
[919.005553] Subtest basic-llseek-bad: SUCCESS (0.015s)
[919.123322] [126/132] (121s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[919.503316] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[920.345704] [127/132] (120s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[920.439430] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[920.441715] Starting dynamic subtest: A-eDP1
[929.317533] Dynamic subtest A-eDP1: SUCCESS (8.877s)
[929.328589] Starting dynamic subtest: B-eDP1
[938.245616] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[938.258695] Starting dynamic subtest: C-eDP1
[947.161632] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[947.173264] Starting dynamic subtest: D-eDP1
[956.091949] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[956.094152] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.653s)
[957.348175] [128/132] ( 83s left) gem_exec_parallel (fds)
[957.418822] Starting subtest: fds
[957.421163] Starting dynamic subtest: rcs0
[960.396925] Dynamic subtest rcs0: SUCCESS (2.976s)
[960.410911] Starting dynamic subtest: bcs0
[963.944653] Dynamic subtest bcs0: SUCCESS (3.545s)
[963.959107] Starting dynamic subtest: vcs0
[967.739741] Dynamic subtest vcs0: SUCCESS (3.792s)
[967.753736] Starting dynamic subtest: vcs1
[971.690151] Dynamic subtest vcs1: SUCCESS (3.948s)
[971.704480] Starting dynamic subtest: vecs0
[975.725756] Dynamic subtest vecs0: SUCCESS (4.033s)
[975.738182] Starting dynamic subtest: ccs0
[979.368019] Dynamic subtest ccs0: SUCCESS (3.639s)
[979.370512] Subtest fds: SUCCESS (21.946s)
[979.584922] [129/132] ( 61s left) prime_vgem (fence-write-hang)
[979.685520] Subtest fence-write-hang: SKIP (0.000s)
[979.830723] [130/132] ( 61s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[979.930723] Starting subtest: fbc-modesetfrombusy
[983.780804] Subtest fbc-modesetfrombusy: SUCCESS (3.854s)
[984.983463] [131/132] ( 56s left) syncobj_timeline (wait-all-for-submit-snapshot)
[985.031125] Starting subtest: wait-all-for-submit-snapshot
[985.111747] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[985.211206] [132/132] ( 56s left) kms_scaling_modes (scaling-mode-center)
[985.297653] Starting subtest: scaling-mode-center
[985.299657] Starting dynamic subtest: pipe-A-eDP-1
[985.400642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.104s)
[985.414285] Starting dynamic subtest: pipe-B-eDP-1
[986.573679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[986.586751] Starting dynamic subtest: pipe-C-eDP-1
[987.688140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[987.702456] Starting dynamic subtest: pipe-D-eDP-1
[988.830697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[988.832998] Subtest scaling-mode-center: SUCCESS (3.536s)
[990.105972] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: i915_hangman
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gem_workarounds
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: i915_selftest
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_getfb
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: prime_vgem
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: core_auth
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: gem_readwrite
results: parsing output: 46/ for test: core_getstats
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: kms_psr2_su
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: vgem_basic
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: gem_tiled_fence_blits
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_invalid_mode
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: i915_query
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: gem_media_fill
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: prime_mmap_coherency
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_fb_coherency
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_ppgtt
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: dumb_buffer
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_dirtyfb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: prime_self_import
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_exec_parallel
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_scaling_modes
Done.