[48.531331] Initializing watchdogs
[48.531780]   /dev/watchdog0
[48.559611] [001/162] (960s left) i915_module_load (load)
[48.973858] Starting subtest: load
[53.911557] Subtest load: SUCCESS (4.938s)
[54.014798] [002/162] (955s left) core_auth (basic-auth)
[55.199354] Starting subtest: basic-auth
[55.206177] Subtest basic-auth: SUCCESS (0.005s)
[55.357491] [003/162] (953s left) debugfs_test (read_all_entries)
[55.777096] Starting subtest: read_all_entries
[57.144768] Subtest read_all_entries: SUCCESS (1.367s)
[57.399995] [004/162] (951s left) debugfs_test (basic-hwmon)
[57.804276] Starting subtest: basic-hwmon
[57.817705] Subtest basic-hwmon: SKIP (0.000s)
[58.059576] [005/162] (951s left) fbdev (eof)
[58.455798] Starting subtest: eof
[58.462819] Subtest eof: SUCCESS (0.001s)
[58.596944] [006/162] (950s left) fbdev (info)
[58.971975] Starting subtest: info
[58.978951] Subtest info: SUCCESS (0.000s)
[59.119292] [007/162] (950s left) fbdev (nullptr)
[59.461224] Starting subtest: nullptr
[59.468400] Subtest nullptr: SUCCESS (0.000s)
[59.601718] [008/162] (949s left) fbdev (read)
[59.995356] Starting subtest: read
[65.608780] Subtest read: SUCCESS (5.605s)
[65.701098] [009/162] (943s left) fbdev (write)
[66.098557] Starting subtest: write
[69.337489] Subtest write: SUCCESS (3.232s)
[69.510255] [010/162] (940s left) gem_basic (bad-close)
[69.883580] Starting subtest: bad-close
[69.897987] Subtest bad-close: SUCCESS (0.000s)
[70.036693] [011/162] (939s left) gem_basic (create-close)
[70.419756] Starting subtest: create-close
[70.432954] Subtest create-close: SUCCESS (0.000s)
[70.578883] [012/162] (939s left) gem_basic (create-fd-close)
[70.957175] Starting subtest: create-fd-close
[70.970576] Subtest create-fd-close: SUCCESS (0.001s)
[71.133375] [013/162] (938s left) gem_busy (busy@all-engines)
[71.583724] Starting subtest: busy
[71.591053] Starting dynamic subtest: all-engines
[71.793318] Dynamic subtest all-engines: SUCCESS (0.209s)
[71.800677] Subtest busy: SUCCESS (0.210s)
[73.316237] [014/162] (936s left) gem_close_race (basic-process)
[73.765169] Starting subtest: basic-process
[73.867577] Subtest basic-process: SUCCESS (0.102s)
[74.156527] [015/162] (935s left) gem_close_race (basic-threads)
[74.611149] Starting subtest: basic-threads
[76.066610] Subtest basic-threads: SUCCESS (1.462s)
[76.340760] [016/162] (933s left) gem_ctx_create (basic)
[76.770439] Starting subtest: basic
[76.777360] Subtest basic: SUCCESS (0.000s)
[77.057422] [017/162] (933s left) gem_ctx_create (basic-files)
[77.481137] Starting subtest: basic-files
[79.550544] Subtest basic-files: SUCCESS (2.069s)
[81.253468] [018/162] (929s left) gem_ctx_exec (basic)
[81.647546] Starting subtest: basic
[81.665386] Subtest basic: SUCCESS (0.019s)
[81.866555] [019/162] (928s left) gem_exec_basic (basic)
[82.289408] Starting subtest: basic
[82.296796] Starting dynamic subtest: rcs0-smem
[82.304165] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[82.347254] Starting dynamic subtest: bcs0-smem
[82.354069] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[82.385825] Starting dynamic subtest: vcs0-smem
[82.392843] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[82.425154] Starting dynamic subtest: vcs1-smem
[82.432505] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[82.464297] Starting dynamic subtest: vecs0-smem
[82.471269] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[82.502740] Starting dynamic subtest: ccs0-smem
[82.509657] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[82.516542] Subtest basic: SUCCESS (0.023s)
[84.287620] [020/162] (926s left) gem_exec_create (basic)
[84.730414] Starting subtest: basic
[84.737880] Starting dynamic subtest: smem
[88.158203] Dynamic subtest smem: SUCCESS (3.420s)
[88.165750] Subtest basic: SUCCESS (3.421s)
[88.442726] [021/162] (922s left) gem_exec_fence (basic-busy)
[89.053503] Starting subtest: basic-busy
[89.060922] Starting dynamic subtest: rcs0
[89.113740] Dynamic subtest rcs0: SUCCESS (0.070s)
[89.147772] Starting dynamic subtest: bcs0
[89.171538] Dynamic subtest bcs0: SUCCESS (0.057s)
[89.209672] Starting dynamic subtest: vcs0
[89.224446] Dynamic subtest vcs0: SUCCESS (0.043s)
[89.256998] Starting dynamic subtest: vcs1
[89.271575] Dynamic subtest vcs1: SUCCESS (0.026s)
[89.303962] Starting dynamic subtest: vecs0
[89.317341] Dynamic subtest vecs0: SUCCESS (0.036s)
[89.354459] Starting dynamic subtest: ccs0
[89.367636] Dynamic subtest ccs0: SUCCESS (0.059s)
[89.374279] Subtest basic-busy: SUCCESS (0.296s)
[91.432710] [022/162] (919s left) gem_exec_fence (basic-wait)
[92.027254] Starting subtest: basic-wait
[92.034485] Starting dynamic subtest: rcs0
[92.106306] Dynamic subtest rcs0: SUCCESS (0.086s)
[92.144061] Starting dynamic subtest: bcs0
[92.165776] Dynamic subtest bcs0: SUCCESS (0.059s)
[92.201150] Starting dynamic subtest: vcs0
[92.208230] Dynamic subtest vcs0: SUCCESS (0.035s)
[92.242710] Starting dynamic subtest: vcs1
[92.249994] Dynamic subtest vcs1: SUCCESS (0.039s)
[92.283168] Starting dynamic subtest: vecs0
[92.290235] Dynamic subtest vecs0: SUCCESS (0.030s)
[92.325187] Starting dynamic subtest: ccs0
[92.332285] Dynamic subtest ccs0: SUCCESS (0.059s)
[92.339230] Subtest basic-wait: SUCCESS (0.313s)
[94.321466] [023/162] (916s left) gem_exec_fence (basic-await)
[94.920707] Starting subtest: basic-await
[94.927900] Starting dynamic subtest: rcs0
[95.157402] Dynamic subtest rcs0: SUCCESS (0.244s)
[95.195394] Starting dynamic subtest: bcs0
[95.380508] Dynamic subtest bcs0: SUCCESS (0.222s)
[95.415957] Starting dynamic subtest: vcs0
[95.602440] Dynamic subtest vcs0: SUCCESS (0.221s)
[95.638371] Starting dynamic subtest: vcs1
[95.826147] Dynamic subtest vcs1: SUCCESS (0.223s)
[95.862147] Starting dynamic subtest: vecs0
[96.046433] Dynamic subtest vecs0: SUCCESS (0.219s)
[96.081446] Starting dynamic subtest: ccs0
[96.280416] Dynamic subtest ccs0: SUCCESS (0.233s)
[96.287442] Subtest basic-await: SUCCESS (1.368s)
[98.348967] [024/162] (912s left) gem_exec_fence (nb-await)
[98.951543] Starting subtest: nb-await
[98.958353] Starting dynamic subtest: rcs0
[99.057097] Dynamic subtest rcs0: SUCCESS (0.113s)
[99.085933] Starting dynamic subtest: bcs0
[99.136910] Dynamic subtest bcs0: SUCCESS (0.080s)
[99.168565] Starting dynamic subtest: vcs0
[99.218100] Dynamic subtest vcs0: SUCCESS (0.080s)
[99.254155] Starting dynamic subtest: vcs1
[99.301947] Dynamic subtest vcs1: SUCCESS (0.083s)
[99.336196] Starting dynamic subtest: vecs0
[99.384732] Dynamic subtest vecs0: SUCCESS (0.082s)
[99.420443] Starting dynamic subtest: ccs0
[99.470918] Dynamic subtest ccs0: SUCCESS (0.085s)
[99.477855] Subtest nb-await: SUCCESS (0.528s)
[101.274416] [025/162] (909s left) gem_exec_gttfill (basic)
[101.720909] Starting subtest: basic
[113.187571] Subtest basic: SUCCESS (11.458s)
[113.472719] [026/162] (897s left) gem_exec_parallel (engines)
[114.053788] Starting subtest: engines
[114.061434] Starting dynamic subtest: basic
[117.193065] Dynamic subtest basic: SUCCESS (3.147s)
[117.232169] Starting dynamic subtest: contexts
[123.586176] Dynamic subtest contexts: SUCCESS (6.383s)
[123.610984] Starting dynamic subtest: fds
[130.921734] Dynamic subtest fds: SUCCESS (7.334s)
[130.939449] Starting dynamic subtest: userptr
[135.195512] Dynamic subtest userptr: SUCCESS (4.274s)
[135.202668] Subtest engines: SUCCESS (21.142s)
[135.523131] [027/162] (875s left) gem_exec_store (basic)
[135.976599] Starting subtest: basic
[137.169255] Subtest basic: SUCCESS (1.191s)
[137.456730] [028/162] (873s left) gem_flink_basic (bad-flink)
[137.813205] Starting subtest: bad-flink
[137.820135] Subtest bad-flink: SUCCESS (0.000s)
[137.972403] [029/162] (873s left) gem_flink_basic (bad-open)
[138.358676] Starting subtest: bad-open
[138.365569] Subtest bad-open: SUCCESS (0.000s)
[138.526718] [030/162] (872s left) gem_flink_basic (basic)
[138.906772] Starting subtest: basic
[138.913766] Subtest basic: SUCCESS (0.000s)
[139.090176] [031/162] (872s left) gem_flink_basic (double-flink)
[139.402763] Starting subtest: double-flink
[139.409831] Subtest double-flink: SUCCESS (0.000s)
[139.528990] [032/162] (871s left) gem_flink_basic (flink-lifetime)
[139.906263] Starting subtest: flink-lifetime
[139.913385] Subtest flink-lifetime: SUCCESS (0.007s)
[140.100447] [033/162] (871s left) gem_huc_copy (huc-copy)
[140.518452] Starting subtest: huc-copy
[140.534409] Subtest huc-copy: SUCCESS (0.016s)
[142.311894] [034/162] (869s left) gem_linear_blits (basic)
[143.179256] Starting subtest: basic
[143.210438] Subtest basic: SUCCESS (0.040s)
[143.447819] [035/162] (868s left) gem_mmap (basic)
[143.974791] Subtest basic: SKIP (0.000s)
[144.097413] [036/162] (867s left) gem_mmap_gtt (basic)
[144.491693] Subtest basic: SKIP (0.000s)
[144.613710] [037/162] (867s left) gem_render_linear_blits (basic)
[145.012651] Starting subtest: basic
[145.185798] Subtest basic: SUCCESS (0.173s)
[145.357361] [038/162] (866s left) gem_render_tiled_blits (basic)
[145.758395] Subtest basic: SKIP (0.000s)
[145.873847] [039/162] (866s left) gem_ringfill (basic-all)
[152.163102] Starting subtest: basic-all
[153.480127] Subtest basic-all: SUCCESS (1.320s)
[154.271469] [040/162] (857s left) gem_softpin (allocator-basic)
[154.682713] Starting subtest: allocator-basic
[155.246599] Subtest allocator-basic: SUCCESS (0.556s)
[155.482656] [041/162] (856s left) gem_softpin (allocator-basic-reserve)
[155.887198] Starting subtest: allocator-basic-reserve
[156.459748] Subtest allocator-basic-reserve: SUCCESS (0.564s)
[156.687932] [042/162] (855s left) gem_softpin (safe-alignment)
[157.093147] Starting subtest: safe-alignment
[157.189207] Subtest safe-alignment: SUCCESS (0.096s)
[159.331974] [043/162] (852s left) gem_sync (basic-all)
[159.788142] Starting subtest: basic-all
[163.144941] Subtest basic-all: SUCCESS (3.368s)
[163.445122] [044/162] (848s left) gem_sync (basic-each)
[163.889588] Starting subtest: basic-each
[167.120581] Subtest basic-each: SUCCESS (3.234s)
[167.397880] [045/162] (845s left) gem_tiled_blits (basic)
[167.802178] Subtest basic: SKIP (0.000s)
[167.915513] [046/162] (844s left) gem_tiled_fence_blits (basic)
[168.328288] Subtest basic: SKIP (0.000s)
[168.445718] [047/162] (844s left) gem_tiled_pread_basic
[168.948235] [048/162] (843s left) gem_wait (busy@all-engines)
[169.416666] Starting subtest: busy
[169.423465] Starting dynamic subtest: all-engines
[171.151730] Dynamic subtest all-engines: SUCCESS (1.733s)
[171.158520] Subtest busy: SUCCESS (1.734s)
[171.516726] [049/162] (841s left) gem_wait (wait@all-engines)
[171.981877] Starting subtest: wait
[171.988881] Starting dynamic subtest: all-engines
[173.127574] Dynamic subtest all-engines: SUCCESS (1.146s)
[173.134775] Subtest wait: SUCCESS (1.147s)
[173.495205] [050/162] (839s left) i915_getparams_basic (basic-eu-total)
[173.890445] Starting subtest: basic-eu-total
[173.903840] Subtest basic-eu-total: SUCCESS (0.000s)
[174.047200] [051/162] (838s left) i915_getparams_basic (basic-subslice-total)
[174.427978] Starting subtest: basic-subslice-total
[174.442177] Subtest basic-subslice-total: SUCCESS (0.000s)
[174.578836] [052/162] (838s left) i915_hangman (error-state-basic)
[175.036866] Starting subtest: error-state-basic
[176.124551] Subtest error-state-basic: SUCCESS (1.086s)
[176.289160] [053/162] (836s left) i915_pciid
[176.807139] [054/162] (836s left) kms_addfb_basic (addfb25-bad-modifier)
[177.199405] Starting subtest: addfb25-bad-modifier
[177.206195] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[177.497844] [055/162] (835s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[177.893862] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[178.146686] [056/162] (835s left) kms_addfb_basic (addfb25-modifier-no-flag)
[178.532386] Starting subtest: addfb25-modifier-no-flag
[178.539297] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[178.787534] [057/162] (834s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[179.184549] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[179.443955] [058/162] (834s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[179.813098] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[180.063141] [059/162] (833s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[180.490255] Starting subtest: addfb25-yf-tiled-legacy
[180.497191] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[180.634448] [060/162] (833s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[181.125062] Starting subtest: addfb25-y-tiled-legacy
[181.132259] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[181.298897] [061/162] (832s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[181.784254] Starting subtest: addfb25-y-tiled-small-legacy
[181.798822] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[181.947465] [062/162] (831s left) kms_addfb_basic (bad-pitch-0)
[182.333152] Starting subtest: bad-pitch-0
[182.340045] Subtest bad-pitch-0: SUCCESS (0.000s)
[182.575633] [063/162] (831s left) kms_addfb_basic (bad-pitch-1024)
[182.947182] Starting subtest: bad-pitch-1024
[182.954233] Subtest bad-pitch-1024: SUCCESS (0.000s)
[183.219265] [064/162] (830s left) kms_addfb_basic (bad-pitch-128)
[183.613155] Starting subtest: bad-pitch-128
[183.620139] Subtest bad-pitch-128: SUCCESS (0.000s)
[183.904249] [065/162] (830s left) kms_addfb_basic (bad-pitch-256)
[184.290778] Starting subtest: bad-pitch-256
[184.297617] Subtest bad-pitch-256: SUCCESS (0.000s)
[184.575553] [066/162] (829s left) kms_addfb_basic (bad-pitch-32)
[184.957340] Starting subtest: bad-pitch-32
[184.964364] Subtest bad-pitch-32: SUCCESS (0.000s)
[185.232153] [067/162] (829s left) kms_addfb_basic (bad-pitch-63)
[185.619744] Starting subtest: bad-pitch-63
[185.626703] Subtest bad-pitch-63: SUCCESS (0.000s)
[185.914647] [068/162] (828s left) kms_addfb_basic (bad-pitch-65536)
[186.299389] Starting subtest: bad-pitch-65536
[186.306334] Subtest bad-pitch-65536: SUCCESS (0.001s)
[186.579623] [069/162] (827s left) kms_addfb_basic (bad-pitch-999)
[186.968242] Starting subtest: bad-pitch-999
[186.975403] Subtest bad-pitch-999: SUCCESS (0.000s)
[187.256658] [070/162] (827s left) kms_addfb_basic (basic)
[187.641604] Starting subtest: basic
[187.648754] Subtest basic: SUCCESS (0.000s)
[187.925109] [071/162] (826s left) kms_addfb_basic (basic-x-tiled-legacy)
[188.324907] Starting subtest: basic-x-tiled-legacy
[188.338304] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[188.598716] [072/162] (826s left) kms_addfb_basic (basic-y-tiled-legacy)
[188.996861] Starting subtest: basic-y-tiled-legacy
[189.010594] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[189.266751] [073/162] (825s left) kms_addfb_basic (bo-too-small)
[189.759688] Starting subtest: bo-too-small
[189.766779] Subtest bo-too-small: SUCCESS (0.002s)
[189.923784] [074/162] (825s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[190.415486] Starting subtest: bo-too-small-due-to-tiling
[190.428972] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[190.572869] [075/162] (824s left) kms_addfb_basic (clobberred-modifier)
[190.951569] Starting subtest: clobberred-modifier
[190.965064] Subtest clobberred-modifier: SKIP (0.000s)
[191.228521] [076/162] (823s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[191.619333] Starting subtest: framebuffer-vs-set-tiling
[191.632610] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[191.890281] [077/162] (823s left) kms_addfb_basic (invalid-get-prop)
[192.269604] Starting subtest: invalid-get-prop
[192.277508] Subtest invalid-get-prop: SUCCESS (0.000s)
[192.564653] [078/162] (822s left) kms_addfb_basic (invalid-get-prop-any)
[192.960805] Starting subtest: invalid-get-prop-any
[192.967887] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[193.229139] [079/162] (822s left) kms_addfb_basic (invalid-set-prop)
[193.621421] Starting subtest: invalid-set-prop
[193.629103] Subtest invalid-set-prop: SUCCESS (0.000s)
[193.912125] [080/162] (821s left) kms_addfb_basic (invalid-set-prop-any)
[194.298972] Starting subtest: invalid-set-prop-any
[194.306162] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[194.567977] [081/162] (821s left) kms_addfb_basic (no-handle)
[194.957708] Starting subtest: no-handle
[194.964962] Subtest no-handle: SUCCESS (0.000s)
[195.238825] [082/162] (820s left) kms_addfb_basic (size-max)
[195.736169] Starting subtest: size-max
[195.746670] Subtest size-max: SUCCESS (0.000s)
[195.892637] [083/162] (819s left) kms_addfb_basic (small-bo)
[196.388373] Starting subtest: small-bo
[196.396056] Subtest small-bo: SUCCESS (0.000s)
[196.519528] [084/162] (819s left) kms_addfb_basic (tile-pitch-mismatch)
[196.911831] Starting subtest: tile-pitch-mismatch
[196.925350] Subtest tile-pitch-mismatch: SKIP (0.000s)
[197.178360] [085/162] (818s left) kms_addfb_basic (too-high)
[197.659303] Starting subtest: too-high
[197.666283] Subtest too-high: SUCCESS (0.003s)
[197.814320] [086/162] (818s left) kms_addfb_basic (too-wide)
[198.296882] Starting subtest: too-wide
[198.303738] Subtest too-wide: SUCCESS (0.000s)
[198.461213] [087/162] (817s left) kms_addfb_basic (unused-handle)
[198.838955] Starting subtest: unused-handle
[198.846070] Subtest unused-handle: SUCCESS (0.000s)
[199.092637] [088/162] (817s left) kms_addfb_basic (unused-modifier)
[199.469907] Starting subtest: unused-modifier
[199.477305] Subtest unused-modifier: SUCCESS (0.000s)
[199.730641] [089/162] (816s left) kms_addfb_basic (unused-offsets)
[200.109972] Starting subtest: unused-offsets
[200.117257] Subtest unused-offsets: SUCCESS (0.000s)
[200.396110] [090/162] (816s left) kms_addfb_basic (unused-pitches)
[200.793137] Starting subtest: unused-pitches
[200.800278] Subtest unused-pitches: SUCCESS (0.000s)
[201.062092] [091/162] (815s left) kms_busy (basic)
[201.575102] Starting subtest: basic
[201.582225] Starting dynamic subtest: flip
[203.317897] Dynamic subtest flip: SUCCESS (1.742s)
[203.365717] Starting dynamic subtest: modeset
[207.579835] Dynamic subtest modeset: SUCCESS (4.258s)
[207.587317] Subtest basic: SUCCESS (6.008s)
[208.537700] [092/162] (808s left) kms_prop_blob (basic)
[208.925714] Starting subtest: basic
[208.933187] Subtest basic: SUCCESS (0.000s)
[209.070867] [093/162] (807s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[209.660203] Starting subtest: basic-busy-flip-before-cursor-atomic
[209.674159] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[209.978850] [094/162] (806s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[210.563191] Starting subtest: basic-busy-flip-before-cursor-legacy
[210.577230] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[210.881412] [095/162] (806s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[211.460105] Starting subtest: basic-flip-after-cursor-atomic
[212.835638] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.379s)
[213.783165] [096/162] (803s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[214.373982] Starting subtest: basic-flip-after-cursor-legacy
[215.816775] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.444s)
[216.763133] [097/162] (800s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[217.341538] Starting subtest: basic-flip-after-cursor-varying-size
[218.734055] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.394s)
[219.677564] [098/162] (797s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[220.258922] Starting subtest: basic-flip-before-cursor-atomic
[221.693684] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.434s)
[222.633447] [099/162] (794s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[223.234349] Starting subtest: basic-flip-before-cursor-legacy
[224.608708] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.375s)
[225.558950] [100/162] (791s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[226.156049] Starting subtest: basic-flip-before-cursor-varying-size
[227.612044] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.458s)
[228.566373] [101/162] (788s left) kms_flip (basic-flip-vs-dpms)
[228.984924] Starting subtest: basic-flip-vs-dpms
[229.002972] Starting dynamic subtest: A-eDP1
[232.408091] Dynamic subtest A-eDP1: SUCCESS (3.402s)
[232.454373] Starting dynamic subtest: B-eDP1
[235.038299] Dynamic subtest B-eDP1: SUCCESS (2.628s)
[235.082959] Starting dynamic subtest: C-eDP1
[237.668678] Dynamic subtest C-eDP1: SUCCESS (2.624s)
[237.709178] Starting dynamic subtest: D-eDP1
[240.251466] Dynamic subtest D-eDP1: SUCCESS (2.583s)
[240.271717] Subtest basic-flip-vs-dpms: SUCCESS (11.300s)
[241.192852] [102/162] (776s left) kms_flip (basic-flip-vs-modeset)
[241.604963] Starting subtest: basic-flip-vs-modeset
[241.625502] Starting dynamic subtest: A-eDP1
[244.997336] Dynamic subtest A-eDP1: SUCCESS (3.368s)
[245.036719] Starting dynamic subtest: B-eDP1
[247.470396] Dynamic subtest B-eDP1: SUCCESS (2.468s)
[247.511210] Starting dynamic subtest: C-eDP1
[249.920272] Dynamic subtest C-eDP1: SUCCESS (2.444s)
[249.965305] Starting dynamic subtest: D-eDP1
[252.385684] Dynamic subtest D-eDP1: SUCCESS (2.464s)
[252.402959] Subtest basic-flip-vs-modeset: SUCCESS (10.809s)
[253.320527] [103/162] (764s left) kms_flip (basic-flip-vs-wf_vblank)
[253.733214] Starting subtest: basic-flip-vs-wf_vblank
[253.753662] Starting dynamic subtest: A-eDP1
[256.250693] Dynamic subtest A-eDP1: SUCCESS (2.497s)
[256.292767] Starting dynamic subtest: B-eDP1
[258.571808] Dynamic subtest B-eDP1: SUCCESS (2.318s)
[258.612362] Starting dynamic subtest: C-eDP1
[260.891655] Dynamic subtest C-eDP1: SUCCESS (2.311s)
[260.944764] Starting dynamic subtest: D-eDP1
[263.235886] Dynamic subtest D-eDP1: SUCCESS (2.340s)
[263.259860] Subtest basic-flip-vs-wf_vblank: SUCCESS (9.538s)
[264.850862] [104/162] (752s left) kms_flip (basic-plain-flip)
[265.277821] Starting subtest: basic-plain-flip
[265.294049] Starting dynamic subtest: A-eDP1
[267.556761] Dynamic subtest A-eDP1: SUCCESS (2.262s)
[267.608044] Starting dynamic subtest: B-eDP1
[269.671222] Dynamic subtest B-eDP1: SUCCESS (2.110s)
[269.723223] Starting dynamic subtest: C-eDP1
[271.759071] Dynamic subtest C-eDP1: SUCCESS (2.079s)
[271.799334] Starting dynamic subtest: D-eDP1
[273.853443] Dynamic subtest D-eDP1: SUCCESS (2.090s)
[273.877521] Subtest basic-plain-flip: SUCCESS (8.614s)
[275.468462] [105/162] (742s left) kms_force_connector_basic (force-connector-state)
[275.866480] Starting subtest: force-connector-state
[278.373377] Subtest force-connector-state: SUCCESS (2.504s)
[279.260860] [106/162] (738s left) kms_force_connector_basic (force-edid)
[279.647106] Starting subtest: force-edid
[279.948157] Subtest force-edid: SUCCESS (0.297s)
[280.193944] [107/162] (737s left) kms_force_connector_basic (force-load-detect)
[280.582246] Starting subtest: force-load-detect
[280.595063] Subtest force-load-detect: SKIP (0.000s)
[280.796060] [108/162] (737s left) kms_force_connector_basic (prune-stale-modes)
[281.186646] Starting subtest: prune-stale-modes
[281.400857] Subtest prune-stale-modes: SKIP (0.207s)
[281.650600] [109/162] (736s left) kms_frontbuffer_tracking (basic)
[282.168724] Starting subtest: basic
[295.427149] Subtest basic: SUCCESS (13.262s)
[295.622474] [110/162] (722s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[296.128726] Starting subtest: compare-crc-sanitycheck-xr24
[296.135740] Starting dynamic subtest: pipe-A-eDP-1
[297.344675] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.206s)
[297.387189] Starting dynamic subtest: pipe-B-eDP-1
[299.211965] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.860s)
[299.252855] Starting dynamic subtest: pipe-C-eDP-1
[300.776731] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s)
[300.822620] Starting dynamic subtest: pipe-D-eDP-1
[302.465168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.687s)
[302.472170] Subtest compare-crc-sanitycheck-xr24: SUCCESS (6.345s)
[303.420242] [111/162] (714s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[303.912665] Starting subtest: compare-crc-sanitycheck-nv12
[303.919692] Starting dynamic subtest: pipe-A-eDP-1
[305.598634] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.678s)
[305.650969] Starting dynamic subtest: pipe-B-eDP-1
[307.962527] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.352s)
[308.006327] Starting dynamic subtest: pipe-C-eDP-1
[310.539607] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.564s)
[310.592399] Starting dynamic subtest: pipe-D-eDP-1
[313.438502] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.891s)
[313.445591] Subtest compare-crc-sanitycheck-nv12: SUCCESS (9.531s)
[314.397707] [112/162] (704s left) kms_pipe_crc_basic (hang-read-crc)
[314.912163] Starting subtest: hang-read-crc
[314.919695] Starting dynamic subtest: pipe-A-eDP-1
[319.237180] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.319s)
[319.291364] Starting dynamic subtest: pipe-B-eDP-1
[324.655288] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.406s)
[324.709225] Starting dynamic subtest: pipe-C-eDP-1
[330.387617] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.717s)
[330.432665] Starting dynamic subtest: pipe-D-eDP-1
[336.107621] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.708s)
[336.114756] Subtest hang-read-crc: SUCCESS (21.195s)
[337.052109] [113/162] (681s left) kms_pipe_crc_basic (nonblocking-crc)
[337.542921] Starting subtest: nonblocking-crc
[337.549879] Starting dynamic subtest: pipe-A-eDP-1
[338.834820] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.283s)
[338.879860] Starting dynamic subtest: pipe-B-eDP-1
[340.906089] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.063s)
[340.960633] Starting dynamic subtest: pipe-C-eDP-1
[343.147233] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.226s)
[343.192855] Starting dynamic subtest: pipe-D-eDP-1
[345.143812] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.989s)
[345.151158] Subtest nonblocking-crc: SUCCESS (7.607s)
[346.090319] [114/162] (672s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[346.617645] Starting subtest: nonblocking-crc-frame-sequence
[346.624700] Starting dynamic subtest: pipe-A-eDP-1
[347.949213] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.320s)
[347.996283] Starting dynamic subtest: pipe-B-eDP-1
[350.004611] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.049s)
[350.059812] Starting dynamic subtest: pipe-C-eDP-1
[352.262044] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s)
[352.285109] Starting dynamic subtest: pipe-D-eDP-1
[354.838609] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s)
[354.845885] Subtest nonblocking-crc-frame-sequence: SUCCESS (8.224s)
[355.796382] [115/162] (662s left) kms_pipe_crc_basic (read-crc)
[356.295314] Starting subtest: read-crc
[356.304887] Starting dynamic subtest: pipe-A-eDP-1
[357.544149] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.237s)
[357.591392] Starting dynamic subtest: pipe-B-eDP-1
[359.470687] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.920s)
[359.515099] Starting dynamic subtest: pipe-C-eDP-1
[361.666889] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.180s)
[361.712911] Starting dynamic subtest: pipe-D-eDP-1
[364.256162] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s)
[364.263164] Subtest read-crc: SUCCESS (7.962s)
[365.202909] [116/162] (653s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[365.712167] Starting subtest: read-crc-frame-sequence
[365.719189] Starting dynamic subtest: pipe-A-eDP-1
[366.989610] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.266s)
[367.035597] Starting dynamic subtest: pipe-B-eDP-1
[368.942187] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.943s)
[368.990429] Starting dynamic subtest: pipe-C-eDP-1
[370.616176] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.667s)
[370.663117] Starting dynamic subtest: pipe-D-eDP-1
[373.062535] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[373.069685] Subtest read-crc-frame-sequence: SUCCESS (7.354s)
[374.042828] [117/162] (644s left) kms_psr (primary_page_flip)
[374.571293] Starting subtest: primary_page_flip
[377.804353] Subtest primary_page_flip: SUCCESS (3.237s)
[378.747832] [118/162] (640s left) kms_psr (cursor_plane_move)
[379.252238] Starting subtest: cursor_plane_move
[382.377914] Subtest cursor_plane_move: SUCCESS (3.121s)
[383.312255] [119/162] (635s left) kms_psr (sprite_plane_onoff)
[383.820145] Starting subtest: sprite_plane_onoff
[387.167825] Subtest sprite_plane_onoff: SUCCESS (3.351s)
[388.110188] [120/162] (631s left) kms_psr (primary_mmap_gtt)
[388.621441] Starting subtest: primary_mmap_gtt
[391.575123] Subtest primary_mmap_gtt: SKIP (2.942s)
[391.942423] [121/162] (627s left) kms_setmode (basic-clone-single-crtc)
[392.332699] Starting subtest: basic-clone-single-crtc
[392.352558] Subtest basic-clone-single-crtc: SKIP (0.003s)
[392.469484] [122/162] (626s left) i915_pm_backlight (basic-brightness)
[392.987148] Starting subtest: basic-brightness
[393.334321] Starting dynamic subtest: eDP-1
[394.041983] Dynamic subtest eDP-1: SUCCESS (0.712s)
[394.048820] Subtest basic-brightness: SUCCESS (1.058s)
[394.998099] [123/162] (624s left) i915_pm_rpm (basic-pci-d3-state)
[397.364389] Starting subtest: basic-pci-d3-state
[402.537915] Subtest basic-pci-d3-state: SUCCESS (5.175s)
[402.731435] [124/162] (616s left) i915_pm_rpm (basic-rte)
[403.102192] Starting subtest: basic-rte
[409.713876] Subtest basic-rte: SUCCESS (6.605s)
[411.573902] [125/162] (608s left) i915_pm_rps (basic-api)
[411.999282] Starting subtest: basic-api
[412.013520] Subtest basic-api: SKIP (0.001s)
[412.174879] [126/162] (607s left) prime_self_import (basic-llseek-bad)
[412.550419] Starting subtest: basic-llseek-bad
[412.564810] Subtest basic-llseek-bad: SUCCESS (0.010s)
[412.719938] [127/162] (607s left) prime_self_import (basic-llseek-size)
[413.090318] Starting subtest: basic-llseek-size
[413.104170] Subtest basic-llseek-size: SUCCESS (0.013s)
[413.277497] [128/162] (606s left) prime_self_import (basic-with_fd_dup)
[413.651526] Starting subtest: basic-with_fd_dup
[413.665408] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[413.841414] [129/162] (606s left) prime_self_import (basic-with_one_bo)
[414.210873] Starting subtest: basic-with_one_bo
[414.233932] Subtest basic-with_one_bo: SUCCESS (0.018s)
[414.376197] [130/162] (605s left) prime_self_import (basic-with_one_bo_two_files)
[414.760526] Starting subtest: basic-with_one_bo_two_files
[414.774311] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[414.978690] [131/162] (605s left) prime_self_import (basic-with_two_bos)
[415.361269] Starting subtest: basic-with_two_bos
[415.384227] Subtest basic-with_two_bos: SUCCESS (0.017s)
[415.587154] [132/162] (604s left) prime_vgem (basic-fence-flip)
[416.043531] Starting subtest: basic-fence-flip
[416.808190] Subtest basic-fence-flip: SUCCESS (0.765s)
[417.027866] [133/162] (603s left) prime_vgem (basic-fence-mmap)
[417.471629] Starting subtest: basic-fence-mmap
[417.486497] Subtest basic-fence-mmap: SKIP (0.000s)
[417.661314] [134/162] (602s left) prime_vgem (basic-fence-read)
[418.086990] Starting subtest: basic-fence-read
[418.121263] Subtest basic-fence-read: SKIP (0.026s)
[418.289486] [135/162] (602s left) prime_vgem (basic-gtt)
[418.729537] Starting subtest: basic-gtt
[418.743228] Subtest basic-gtt: SKIP (0.000s)
[418.914092] [136/162] (601s left) prime_vgem (basic-read)
[419.350809] Starting subtest: basic-read
[419.385680] Subtest basic-read: SKIP (0.026s)
[419.559602] [137/162] (601s left) prime_vgem (basic-write)
[419.979446] Starting subtest: basic-write
[420.029483] Subtest basic-write: SKIP (0.048s)
[420.184496] [138/162] (600s left) vgem_basic (setversion)
[420.597920] Starting subtest: setversion
[420.614227] Subtest setversion: SUCCESS (0.000s)
[420.744734] [139/162] (600s left) vgem_basic (create)
[421.168131] Starting subtest: create
[421.175142] Subtest create: SUCCESS (0.001s)
[421.318875] [140/162] (599s left) vgem_basic (debugfs)
[421.743788] Starting subtest: debugfs
[421.750885] Subtest debugfs: SUCCESS (0.002s)
[421.891296] [141/162] (599s left) vgem_basic (dmabuf-export)
[422.305389] Starting subtest: dmabuf-export
[422.319704] Subtest dmabuf-export: SUCCESS (0.011s)
[422.514458] [142/162] (598s left) vgem_basic (dmabuf-fence)
[422.937146] Starting subtest: dmabuf-fence
[422.944139] Subtest dmabuf-fence: SUCCESS (0.002s)
[423.086467] [143/162] (598s left) vgem_basic (dmabuf-fence-before)
[423.513105] Starting subtest: dmabuf-fence-before
[423.519997] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[423.662798] [144/162] (597s left) vgem_basic (dmabuf-mmap)
[424.074259] Starting subtest: dmabuf-mmap
[424.118179] Subtest dmabuf-mmap: SUCCESS (0.055s)
[424.276792] [145/162] (597s left) vgem_basic (mmap)
[424.682601] Starting subtest: mmap
[424.709306] Subtest mmap: SUCCESS (0.038s)
[424.814448] [146/162] (596s left) vgem_basic (second-client)
[425.227079] Starting subtest: second-client
[425.268777] Subtest second-client: SUCCESS (0.043s)
[425.406758] [147/162] (596s left) vgem_basic (sysfs)
[425.834313] Starting subtest: sysfs
[425.841737] Subtest sysfs: SUCCESS (0.002s)
[425.981900] [148/162] (595s left) core_hotunplug (unbind-rebind)
[426.514985] Starting subtest: unbind-rebind
[432.115742] Subtest unbind-rebind: SUCCESS (5.605s)
[432.237982] [149/162] (589s left) vgem_basic (unload)
[432.638596] Starting subtest: unload
[461.839764] Subtest unload: SUCCESS (29.193s)
[462.135317] [150/162] (559s left) i915_module_load (reload)
[462.518811] Starting subtest: reload
[469.540172] Subtest reload: SUCCESS (7.019s)
[469.597905] [151/162] (552s left) gem_lmem_swapping (basic)
[469.994668] Subtest basic: SKIP (0.000s)
[470.114436] [152/162] (552s left) gem_lmem_swapping (parallel-random-engines)
[470.519985] Subtest parallel-random-engines: SKIP (0.000s)
[470.627637] [153/162] (551s left) gem_lmem_swapping (random-engines)
[471.038388] Subtest random-engines: SKIP (0.000s)
[471.146346] [154/162] (551s left) gem_lmem_swapping (verify-random)
[471.569527] Subtest verify-random: SKIP (0.000s)
[471.679861] [155/162] (550s left) i915_pm_rpm (module-reload)
[478.644335] Starting subtest: module-reload
[508.279974] Subtest module-reload: SUCCESS (29.625s)
[508.350699] [156/162] (514s left) i915_selftest (live)
[508.750230] Starting subtest: live
[508.757178] Starting dynamic subtest: sanitycheck
[512.858719] Dynamic subtest sanitycheck: SUCCESS (4.099s)
[512.892115] Starting dynamic subtest: uncore
[516.973945] Dynamic subtest uncore: SUCCESS (4.111s)
[517.007135] Starting dynamic subtest: workarounds
[522.161591] Dynamic subtest workarounds: SUCCESS (5.183s)
[522.195054] Starting dynamic subtest: gt_engines
[526.587298] Dynamic subtest gt_engines: SUCCESS (4.422s)
[526.621342] Starting dynamic subtest: gt_timelines
[546.486718] Dynamic subtest gt_timelines: SUCCESS (19.895s)
[546.528965] Starting dynamic subtest: gt_contexts
[550.609322] Dynamic subtest gt_contexts: SUCCESS (4.117s)
[550.642820] Starting dynamic subtest: gt_lrc
[556.976344] Dynamic subtest gt_lrc: SUCCESS (6.364s)
[557.030591] Starting dynamic subtest: gt_mocs
[576.218648] Dynamic subtest gt_mocs: FAIL (17.985s)
[576.249693] Starting dynamic subtest: gt_pm
[579.876205] Dynamic subtest gt_pm: SUCCESS (4.907s)
[579.909419] Starting dynamic subtest: gt_heartbeat
[584.154927] Dynamic subtest gt_heartbeat: SUCCESS (4.273s)
[584.189345] Starting dynamic subtest: gt_tlb
[590.093798] Dynamic subtest gt_tlb: SUCCESS (5.932s)
[590.135693] Starting dynamic subtest: requests
[628.497610] Dynamic subtest requests: FAIL (37.437s)
[628.532557] Starting dynamic subtest: migrate
[636.247973] Dynamic subtest migrate: SUCCESS (8.713s)
[636.263274] Starting dynamic subtest: active
[640.266361] Dynamic subtest active: SUCCESS (4.014s)
[640.301262] Starting dynamic subtest: objects
[647.344759] Dynamic subtest objects: SUCCESS (7.074s)
[647.378432] Starting dynamic subtest: mman
[655.467431] Dynamic subtest mman: SUCCESS (8.118s)
[655.522258] Starting dynamic subtest: dmabuf
[659.622443] Dynamic subtest dmabuf: SUCCESS (4.151s)
[659.654710] Starting dynamic subtest: vma
[663.673664] Dynamic subtest vma: SUCCESS (4.039s)
[663.716243] Starting dynamic subtest: coherency
[670.281906] Dynamic subtest coherency: SUCCESS (6.612s)
[670.315582] Starting dynamic subtest: gtt
[681.276553] Dynamic subtest gtt: SUCCESS (10.990s)
[681.310119] Starting dynamic subtest: gem
[688.781542] Dynamic subtest gem: SUCCESS (7.501s)
[688.816379] Starting dynamic subtest: evict
[695.483124] Dynamic subtest evict: SUCCESS (6.699s)
[695.517107] Starting dynamic subtest: hugepages
[705.671976] Dynamic subtest hugepages: SUCCESS (10.185s)
[705.706407] Starting dynamic subtest: gem_contexts
[757.514774] Dynamic subtest gem_contexts: SUCCESS (51.838s)
[757.562120] Starting dynamic subtest: client
[761.438244] Dynamic subtest client: SUCCESS (3.919s)
[761.464675] Starting dynamic subtest: gem_migrate
[765.079888] Dynamic subtest gem_migrate: SUCCESS (3.636s)
[765.136265] Starting dynamic subtest: reset
[769.250157] Dynamic subtest reset: SUCCESS (4.166s)
[769.284918] Starting dynamic subtest: memory_region
[773.380344] Dynamic subtest memory_region: SUCCESS (4.128s)
[773.414910] Starting dynamic subtest: hangcheck
[791.919293] Dynamic subtest hangcheck: SUCCESS (18.534s)
[791.976763] Starting dynamic subtest: execlists
[795.530492] Dynamic subtest execlists: SUCCESS (3.607s)
[795.564807] Starting dynamic subtest: ring_submission
[799.624659] Dynamic subtest ring_submission: SUCCESS (4.091s)
[799.681881] Starting dynamic subtest: perf
[803.958240] Dynamic subtest perf: SUCCESS (4.329s)
[803.993326] Starting dynamic subtest: slpc
[819.178891] Dynamic subtest slpc: SUCCESS (15.216s)
[819.214870] Starting dynamic subtest: guc
[825.259059] Dynamic subtest guc: SUCCESS (6.073s)
[825.293265] Starting dynamic subtest: guc_multi_lrc
[829.232510] Dynamic subtest guc_multi_lrc: SUCCESS (3.968s)
[829.266977] Starting dynamic subtest: guc_hang
[834.192782] Dynamic subtest guc_hang: SUCCESS (4.956s)
[834.230815] Starting dynamic subtest: late_gt_pm
[838.365127] Dynamic subtest late_gt_pm: SUCCESS (4.168s)
[838.372130] Subtest live: FAIL (329.606s)
[838.647392] [157/162] (183s left) dmabuf (all-tests)
[839.025591] Starting subtest: all-tests
[839.033113] Starting dynamic subtest: sanitycheck
[839.109388] Dynamic subtest sanitycheck: SUCCESS (0.082s)
[839.146140] Starting dynamic subtest: dma_fence
[839.309162] Dynamic subtest dma_fence: SUCCESS (0.196s)
[839.343223] Starting dynamic subtest: dma_fence_chain
[855.615272] Dynamic subtest dma_fence_chain: SUCCESS (16.294s)
[855.655099] Starting dynamic subtest: dma_fence_unwrap
[855.700206] Dynamic subtest dma_fence_unwrap: SUCCESS (0.089s)
[855.729557] Starting dynamic subtest: dma_resv
[855.796177] Dynamic subtest dma_resv: SUCCESS (0.091s)
[855.803139] Subtest all-tests: SUCCESS (16.773s)
[855.876306] [158/162] (166s left) i915_suspend (basic-s2idle-without-i915)
[856.257158] Starting subtest: basic-s2idle-without-i915
[881.710747] Subtest basic-s2idle-without-i915: SUCCESS (25.453s)
[882.252527] [159/162] (140s left) i915_suspend (basic-s3-without-i915)
[882.640332] Starting subtest: basic-s3-without-i915
[887.007473] Subtest basic-s3-without-i915: SKIP (4.355s)
[889.658916] [160/162] (133s left) gem_exec_suspend (basic-s0)
[889.959797] Starting subtest: basic-S0
[889.968908] Starting dynamic subtest: smem
[916.176382] Dynamic subtest smem: SUCCESS (26.208s)
[916.184114] Subtest basic-S0: SUCCESS (26.213s)
[916.427126] [161/162] (106s left) gem_exec_suspend (basic-s3)
[916.865407] Starting subtest: basic-S3
[916.873882] Starting dynamic subtest: smem
[947.152909] Dynamic subtest smem: SUCCESS (30.277s)
[947.160164] Subtest basic-S3: SUCCESS (30.281s)
[950.409071] [162/162] ( 75s left) kms_pipe_crc_basic (suspend-read-crc)
[950.936062] Starting subtest: suspend-read-crc
[950.943506] Starting dynamic subtest: pipe-A-eDP-1
[973.528693] Dynamic subtest pipe-A-eDP-1: SUCCESS (22.583s)
[973.580494] Starting dynamic subtest: pipe-B-eDP-1
[995.440235] Dynamic subtest pipe-B-eDP-1: SUCCESS (21.901s)
[995.479187] Starting dynamic subtest: pipe-C-eDP-1
[1018.560548] Dynamic subtest pipe-C-eDP-1: SUCCESS (23.110s)
[1018.599133] Starting dynamic subtest: pipe-D-eDP-1
[1041.608842] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.041s)
[1041.615948] Subtest suspend-read-crc: SUCCESS (90.677s)
[1045.571990] Overall timeout time exceeded, stopping.
[1045.573430] Closing watchdogs
Done.