[47.812580] Initializing watchdogs [47.812758] /dev/watchdog0 [47.823182] [001/171] (960s left) i915_module_load (load) [47.966090] Starting subtest: load [50.013478] Subtest load: SUCCESS (2.044s) [50.059020] [002/171] (958s left) core_auth (basic-auth) [50.381819] Starting subtest: basic-auth [50.385668] Subtest basic-auth: SUCCESS (0.001s) [50.453576] [003/171] (957s left) debugfs_test (read_all_entries) [50.591927] Starting subtest: read_all_entries [50.659919] Subtest read_all_entries: SUCCESS (0.067s) [51.480875] [004/171] (956s left) debugfs_test (basic-hwmon) [51.618938] Starting subtest: basic-hwmon [51.622803] Subtest basic-hwmon: SKIP (0.000s) [52.229083] [005/171] (956s left) fbdev (eof) [52.370807] Starting subtest: eof [52.372528] Subtest eof: SUCCESS (0.000s) [52.428263] [006/171] (956s left) fbdev (info) [52.554242] Starting subtest: info [52.556129] Subtest info: SUCCESS (0.000s) [52.627800] [007/171] (955s left) fbdev (nullptr) [52.769754] Starting subtest: nullptr [52.771502] Subtest nullptr: SUCCESS (0.000s) [52.827673] [008/171] (955s left) fbdev (read) [52.969155] Starting subtest: read [53.180446] Subtest read: SUCCESS (0.210s) [53.246232] [009/171] (955s left) fbdev (write) [53.388083] Starting subtest: write [53.491256] Subtest write: SUCCESS (0.105s) [53.546318] [010/171] (954s left) gem_basic (bad-close) [53.674361] Starting subtest: bad-close [53.677804] Subtest bad-close: SUCCESS (0.000s) [53.745145] [011/171] (954s left) gem_basic (create-close) [53.875300] Starting subtest: create-close [53.878681] Subtest create-close: SUCCESS (0.000s) [53.943704] [012/171] (954s left) gem_basic (create-fd-close) [54.075961] Starting subtest: create-fd-close [54.080214] Subtest create-fd-close: SUCCESS (0.000s) [54.146089] [013/171] (954s left) gem_busy (busy@all-engines) [54.318906] Starting subtest: busy [54.322599] Starting dynamic subtest: all-engines [54.352948] Dynamic subtest all-engines: SUCCESS (0.034s) [54.354939] Subtest busy: SUCCESS (0.034s) [54.691430] [014/171] (953s left) gem_close_race (basic-process) [54.845686] Starting subtest: basic-process [54.897322] Subtest basic-process: SUCCESS (0.052s) [55.075693] [015/171] (953s left) gem_close_race (basic-threads) [55.223829] Starting subtest: basic-threads [56.369877] Subtest basic-threads: SUCCESS (1.146s) [56.555720] [016/171] (952s left) gem_ctx_create (basic) [56.694539] Starting subtest: basic [56.696812] Subtest basic: SUCCESS (0.000s) [56.871143] [017/171] (951s left) gem_ctx_create (basic-files) [57.018058] Starting subtest: basic-files [59.033837] Subtest basic-files: SUCCESS (2.022s) [59.306511] [018/171] (949s left) gem_ctx_exec (basic) [59.515195] Starting subtest: basic [59.517192] Subtest basic: SUCCESS (0.001s) [59.568599] [019/171] (949s left) gem_exec_basic (basic) [59.708772] Starting subtest: basic [59.711416] Starting dynamic subtest: rcs0-smem [59.713134] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [59.720855] Starting dynamic subtest: vcs0-smem [59.722715] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [59.724460] Subtest basic: SUCCESS (0.002s) [59.880940] [020/171] (948s left) gem_exec_create (basic) [60.023777] Starting subtest: basic [60.025953] Starting dynamic subtest: smem [62.060535] Dynamic subtest smem: SUCCESS (2.037s) [62.062587] Subtest basic: SUCCESS (2.037s) [62.459566] [021/171] (946s left) gem_exec_fence (basic-busy) [62.728403] Starting subtest: basic-busy [62.730560] Starting dynamic subtest: rcs0 [62.738311] Dynamic subtest rcs0: SUCCESS (0.011s) [62.747250] Starting dynamic subtest: vcs0 [62.753240] Dynamic subtest vcs0: SUCCESS (0.016s) [62.755377] Subtest basic-busy: SUCCESS (0.027s) [63.257082] [022/171] (945s left) gem_exec_fence (basic-wait) [63.519037] Starting subtest: basic-wait [63.520840] Starting dynamic subtest: rcs0 [63.529702] Dynamic subtest rcs0: SUCCESS (0.011s) [63.538207] Starting dynamic subtest: vcs0 [63.540174] Dynamic subtest vcs0: SUCCESS (0.010s) [63.542175] Subtest basic-wait: SUCCESS (0.021s) [63.991402] [023/171] (944s left) gem_exec_fence (basic-await) [64.260709] Starting subtest: basic-await [64.262611] Starting dynamic subtest: rcs0 [64.331155] Dynamic subtest rcs0: SUCCESS (0.072s) [64.340470] Starting dynamic subtest: vcs0 [64.402472] Dynamic subtest vcs0: SUCCESS (0.071s) [64.404783] Subtest basic-await: SUCCESS (0.144s) [64.855413] [024/171] (944s left) gem_exec_fence (nb-await) [65.118654] Starting subtest: nb-await [65.120769] Starting dynamic subtest: rcs0 [65.170250] Dynamic subtest rcs0: SUCCESS (0.055s) [65.178813] Starting dynamic subtest: vcs0 [65.225333] Dynamic subtest vcs0: SUCCESS (0.054s) [65.227895] Subtest nb-await: SUCCESS (0.110s) [65.689430] [025/171] (943s left) gem_exec_gttfill (basic) [65.835207] Starting subtest: basic [74.789484] Subtest basic: SUCCESS (8.957s) [74.968998] [026/171] (933s left) gem_exec_parallel (engines) [75.205563] Starting subtest: engines [75.209478] Starting dynamic subtest: basic [77.069309] Dynamic subtest basic: SUCCESS (1.864s) [77.078241] Starting dynamic subtest: contexts [79.252723] Dynamic subtest contexts: SUCCESS (2.181s) [79.264145] Starting dynamic subtest: fds [79.267506] Dynamic subtest fds: SKIP (0.001s) [79.277939] Starting dynamic subtest: userptr [81.138419] Dynamic subtest userptr: SUCCESS (1.887s) [81.140516] Subtest engines: SUCCESS (5.933s) [81.325455] [027/171] (927s left) gem_exec_store (basic) [81.469029] Starting subtest: basic [81.493442] Subtest basic: SUCCESS (0.025s) [81.672403] [028/171] (927s left) gem_flink_basic (bad-flink) [81.799369] Starting subtest: bad-flink [81.801152] Subtest bad-flink: SUCCESS (0.000s) [81.872916] [029/171] (927s left) gem_flink_basic (bad-open) [81.999143] Starting subtest: bad-open [82.000867] Subtest bad-open: SUCCESS (0.000s) [82.072805] [030/171] (926s left) gem_flink_basic (basic) [82.198686] Starting subtest: basic [82.200542] Subtest basic: SUCCESS (0.000s) [82.271189] [031/171] (926s left) gem_flink_basic (double-flink) [82.396786] Starting subtest: double-flink [82.398736] Subtest double-flink: SUCCESS (0.000s) [82.470085] [032/171] (926s left) gem_flink_basic (flink-lifetime) [82.595785] Starting subtest: flink-lifetime [82.597709] Subtest flink-lifetime: SUCCESS (0.001s) [82.671415] [033/171] (926s left) gem_huc_copy (huc-copy) [82.803676] Subtest huc-copy: SKIP (0.000s) [82.839871] [034/171] (926s left) gem_linear_blits (basic) [83.120143] Starting subtest: basic [83.135775] Subtest basic: SUCCESS (0.015s) [83.258105] [035/171] (925s left) gem_mmap (basic) [83.487131] Starting subtest: basic [83.495817] Subtest basic: SUCCESS (0.001s) [83.567968] [036/171] (925s left) gem_mmap_gtt (basic) [83.701466] Starting subtest: basic [83.703198] Subtest basic: SUCCESS (0.001s) [83.753406] [037/171] (925s left) gem_render_linear_blits (basic) [83.883336] Starting subtest: basic [83.929279] Subtest basic: SUCCESS (0.043s) [83.990662] [038/171] (925s left) gem_render_tiled_blits (basic) [84.122169] Starting subtest: basic [84.168897] Subtest basic: SUCCESS (0.044s) [84.202262] [039/171] (924s left) gem_ringfill (basic-all) [84.385087] Starting subtest: basic-all [85.498876] Subtest basic-all: SUCCESS (1.115s) [85.565271] [040/171] (923s left) gem_softpin (allocator-basic) [85.702565] Subtest allocator-basic: SKIP (0.000s) [85.765555] [041/171] (923s left) gem_softpin (allocator-basic-reserve) [85.898492] Subtest allocator-basic-reserve: SKIP (0.000s) [85.964875] [042/171] (923s left) gem_softpin (safe-alignment) [86.099335] Starting subtest: safe-alignment [86.105189] Subtest safe-alignment: SUCCESS (0.008s) [86.179350] [043/171] (923s left) gem_sync (basic-all) [86.326705] Starting subtest: basic-all [88.370656] Subtest basic-all: SUCCESS (2.045s) [88.558977] [044/171] (920s left) gem_sync (basic-each) [88.699684] Starting subtest: basic-each [90.818686] Subtest basic-each: SUCCESS (2.120s) [91.003841] [045/171] (918s left) gem_tiled_blits (basic) [91.282748] Starting subtest: basic [91.312690] Subtest basic: SUCCESS (0.030s) [91.421716] [046/171] (917s left) gem_tiled_fence_blits (basic) [91.814621] Starting subtest: basic [91.830058] Subtest basic: SUCCESS (0.014s) [91.955163] [047/171] (917s left) gem_tiled_pread_basic [92.434083] [048/171] (916s left) gem_wait (busy@all-engines) [92.583811] Starting subtest: busy [92.586764] Starting dynamic subtest: all-engines [93.095939] Dynamic subtest all-engines: SUCCESS (0.512s) [93.097725] Subtest busy: SUCCESS (0.512s) [93.316037] [049/171] (916s left) gem_wait (wait@all-engines) [93.461302] Starting subtest: wait [93.464425] Starting dynamic subtest: all-engines [94.478080] Dynamic subtest all-engines: SUCCESS (1.016s) [94.479883] Subtest wait: SUCCESS (1.017s) [94.681948] [050/171] (914s left) i915_getparams_basic (basic-eu-total) [94.810285] Starting subtest: basic-eu-total [94.814555] Subtest basic-eu-total: SUCCESS (0.000s) [94.878379] [051/171] (914s left) i915_getparams_basic (basic-subslice-total) [95.004464] Starting subtest: basic-subslice-total [95.008271] Subtest basic-subslice-total: SUCCESS (0.000s) [95.078217] [052/171] (914s left) i915_hangman (error-state-basic) [95.215036] Starting subtest: error-state-basic [95.227555] Subtest error-state-basic: SUCCESS (0.012s) [95.282396] [053/171] (914s left) i915_pciid [95.480277] [054/171] (914s left) kms_addfb_basic (addfb25-bad-modifier) [96.131067] Starting subtest: addfb25-bad-modifier [96.132880] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [97.190723] [055/171] (912s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [97.834283] Starting subtest: addfb25-framebuffer-vs-set-tiling [97.835972] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [98.704242] [056/171] (910s left) kms_addfb_basic (addfb25-modifier-no-flag) [99.359962] Starting subtest: addfb25-modifier-no-flag [99.361819] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [100.235099] [057/171] (909s left) kms_addfb_basic (addfb25-x-tiled-legacy) [100.882062] Starting subtest: addfb25-x-tiled-legacy [100.883869] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [101.781523] [058/171] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [102.436332] Starting subtest: addfb25-x-tiled-mismatch-legacy [102.438146] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [103.294689] [059/171] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [104.341941] Starting subtest: addfb25-yf-tiled-legacy [104.343890] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [104.826075] [060/171] (904s left) kms_addfb_basic (addfb25-y-tiled-legacy) [105.866115] Starting subtest: addfb25-y-tiled-legacy [105.867950] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [106.554794] [061/171] (903s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [107.598673] Starting subtest: addfb25-y-tiled-small-legacy [107.602157] Subtest addfb25-y-tiled-small-legacy: SKIP (0.001s) [108.085282] [062/171] (901s left) kms_addfb_basic (bad-pitch-0) [108.218909] Starting subtest: bad-pitch-0 [108.220683] Subtest bad-pitch-0: SUCCESS (0.000s) [109.599356] [063/171] (900s left) kms_addfb_basic (bad-pitch-1024) [109.731939] Starting subtest: bad-pitch-1024 [109.733700] Subtest bad-pitch-1024: SUCCESS (0.000s) [111.190558] [064/171] (898s left) kms_addfb_basic (bad-pitch-128) [111.395833] Starting subtest: bad-pitch-128 [111.418893] Subtest bad-pitch-128: SUCCESS (0.000s) [112.759455] [065/171] (897s left) kms_addfb_basic (bad-pitch-256) [112.891112] Starting subtest: bad-pitch-256 [112.892863] Subtest bad-pitch-256: SUCCESS (0.000s) [114.289095] [066/171] (895s left) kms_addfb_basic (bad-pitch-32) [114.421854] Starting subtest: bad-pitch-32 [114.423644] Subtest bad-pitch-32: SUCCESS (0.000s) [115.837291] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [115.970618] Starting subtest: bad-pitch-63 [115.972392] Subtest bad-pitch-63: SUCCESS (0.000s) [117.516457] [068/171] (892s left) kms_addfb_basic (bad-pitch-65536) [117.649942] Starting subtest: bad-pitch-65536 [117.651903] Subtest bad-pitch-65536: SUCCESS (0.001s) [119.047545] [069/171] (890s left) kms_addfb_basic (bad-pitch-999) [119.181407] Starting subtest: bad-pitch-999 [119.183255] Subtest bad-pitch-999: SUCCESS (0.000s) [120.593308] [070/171] (889s left) kms_addfb_basic (basic) [120.729110] Starting subtest: basic [120.730941] Subtest basic: SUCCESS (0.000s) [122.173987] [071/171] (887s left) kms_addfb_basic (basic-x-tiled-legacy) [123.658494] Starting subtest: basic-x-tiled-legacy [123.682223] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [123.787356] [072/171] (886s left) kms_addfb_basic (basic-y-tiled-legacy) [125.498733] Starting subtest: basic-y-tiled-legacy [125.650381] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [125.838703] [073/171] (884s left) kms_addfb_basic (bo-too-small) [126.504968] Starting subtest: bo-too-small [126.506953] Subtest bo-too-small: SUCCESS (0.001s) [127.578831] [074/171] (883s left) kms_addfb_basic (bo-too-small-due-to-tiling) [128.308392] Starting subtest: bo-too-small-due-to-tiling [128.310120] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [129.193035] [075/171] (881s left) kms_addfb_basic (clobberred-modifier) [129.327631] Starting subtest: clobberred-modifier [129.329518] Subtest clobberred-modifier: SUCCESS (0.000s) [130.756882] [076/171] (879s left) kms_addfb_basic (framebuffer-vs-set-tiling) [132.214503] Starting subtest: framebuffer-vs-set-tiling [132.216476] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [132.303345] [077/171] (878s left) kms_addfb_basic (invalid-get-prop) [133.765555] Starting subtest: invalid-get-prop [133.767458] Subtest invalid-get-prop: SUCCESS (0.000s) [133.866999] [078/171] (876s left) kms_addfb_basic (invalid-get-prop-any) [135.334331] Starting subtest: invalid-get-prop-any [135.336184] Subtest invalid-get-prop-any: SUCCESS (0.000s) [135.430783] [079/171] (875s left) kms_addfb_basic (invalid-set-prop) [136.936545] Starting subtest: invalid-set-prop [136.960353] Subtest invalid-set-prop: SUCCESS (0.000s) [137.280615] [080/171] (873s left) kms_addfb_basic (invalid-set-prop-any) [138.770758] Starting subtest: invalid-set-prop-any [138.772869] Subtest invalid-set-prop-any: SUCCESS (0.000s) [138.873775] [081/171] (871s left) kms_addfb_basic (no-handle) [139.005120] Starting subtest: no-handle [139.006820] Subtest no-handle: SUCCESS (0.000s) [140.421350] [082/171] (870s left) kms_addfb_basic (size-max) [141.089926] Starting subtest: size-max [141.091855] Subtest size-max: SUCCESS (0.000s) [141.984147] [083/171] (868s left) kms_addfb_basic (small-bo) [142.654093] Starting subtest: small-bo [142.655903] Subtest small-bo: SUCCESS (0.000s) [143.547884] [084/171] (867s left) kms_addfb_basic (tile-pitch-mismatch) [145.020961] Starting subtest: tile-pitch-mismatch [145.023355] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [145.111185] [085/171] (865s left) kms_addfb_basic (too-high) [145.775563] Starting subtest: too-high [145.777428] Subtest too-high: SUCCESS (0.002s) [146.674842] [086/171] (864s left) kms_addfb_basic (too-wide) [147.350182] Starting subtest: too-wide [147.351988] Subtest too-wide: SUCCESS (0.000s) [148.460038] [087/171] (862s left) kms_addfb_basic (unused-handle) [148.594683] Starting subtest: unused-handle [148.596460] Subtest unused-handle: SUCCESS (0.000s) [150.052274] [088/171] (860s left) kms_addfb_basic (unused-modifier) [150.186728] Starting subtest: unused-modifier [150.188493] Subtest unused-modifier: SUCCESS (0.000s) [151.664603] [089/171] (859s left) kms_addfb_basic (unused-offsets) [151.796518] Starting subtest: unused-offsets [151.798447] Subtest unused-offsets: SUCCESS (0.000s) [153.245790] [090/171] (857s left) kms_addfb_basic (unused-pitches) [153.377760] Starting subtest: unused-pitches [153.379489] Subtest unused-pitches: SUCCESS (0.000s) [154.825158] [091/171] (856s left) kms_busy (basic) [155.513327] Starting subtest: basic [155.515282] Starting dynamic subtest: flip [156.302136] Dynamic subtest flip: SUCCESS (0.774s) [156.326628] Starting dynamic subtest: modeset [157.133140] Dynamic subtest modeset: SUCCESS (0.835s) [157.136944] Subtest basic: SUCCESS (1.611s) [157.712752] [092/171] (853s left) kms_chamelium_hpd (dp-hpd-fast) [158.505062] Subtest dp-hpd-fast: SKIP (0.000s) [158.840734] [093/171] (852s left) kms_chamelium_edid (dp-edid-read) [159.653764] Subtest dp-edid-read: SKIP (0.000s) [159.801187] [094/171] (851s left) kms_chamelium_frames (dp-crc-fast) [160.591153] Subtest dp-crc-fast: SKIP (0.000s) [160.715720] [095/171] (850s left) kms_chamelium_hpd (hdmi-hpd-fast) [161.556711] Subtest hdmi-hpd-fast: SKIP (0.000s) [161.706344] [096/171] (849s left) kms_chamelium_edid (hdmi-edid-read) [162.494535] Subtest hdmi-edid-read: SKIP (0.000s) [162.646215] [097/171] (848s left) kms_chamelium_frames (hdmi-crc-fast) [163.452690] Subtest hdmi-crc-fast: SKIP (0.000s) [163.602657] [098/171] (847s left) kms_chamelium_hpd (vga-hpd-fast) [164.391051] Subtest vga-hpd-fast: SKIP (0.000s) [164.540477] [099/171] (846s left) kms_chamelium_edid (vga-edid-read) [165.329475] Subtest vga-edid-read: SKIP (0.000s) [165.481703] [100/171] (845s left) kms_prop_blob (basic) [165.618897] Starting subtest: basic [165.620805] Subtest basic: SUCCESS (0.000s) [165.690939] [101/171] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [166.393380] Starting subtest: basic-busy-flip-before-cursor-atomic [167.460539] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.061s) [167.647248] [102/171] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [168.351640] Starting subtest: basic-busy-flip-before-cursor-legacy [169.430476] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.081s) [169.984647] [103/171] (841s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [170.687696] Starting subtest: basic-flip-after-cursor-atomic [171.737332] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.049s) [171.916231] [104/171] (839s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [172.619643] Starting subtest: basic-flip-after-cursor-legacy [173.685632] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.064s) [173.869856] [105/171] (837s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [174.569951] Starting subtest: basic-flip-after-cursor-varying-size [175.641303] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.067s) [175.821277] [106/171] (835s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [176.524644] Starting subtest: basic-flip-before-cursor-atomic [177.595477] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.075s) [177.744101] [107/171] (833s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [178.443102] Starting subtest: basic-flip-before-cursor-legacy [179.531223] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.085s) [179.711182] [108/171] (831s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [180.419052] Starting subtest: basic-flip-before-cursor-varying-size [181.467911] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.047s) [181.840364] [109/171] (829s left) kms_flip (basic-flip-vs-dpms) [182.374337] Starting subtest: basic-flip-vs-dpms [182.376073] Starting dynamic subtest: A-VGA1 [183.233816] Dynamic subtest A-VGA1: SUCCESS (0.862s) [183.251310] Starting dynamic subtest: B-VGA1 [183.968136] Dynamic subtest B-VGA1: SUCCESS (0.732s) [183.982647] Starting dynamic subtest: A-HDMI-A1 [184.764750] Dynamic subtest A-HDMI-A1: SUCCESS (0.796s) [184.782606] Starting dynamic subtest: B-HDMI-A1 [185.538322] Dynamic subtest B-HDMI-A1: SUCCESS (0.774s) [185.540084] Subtest basic-flip-vs-dpms: SUCCESS (3.174s) [185.731130] [110/171] (825s left) kms_flip (basic-flip-vs-modeset) [186.277551] Starting subtest: basic-flip-vs-modeset [186.279344] Starting dynamic subtest: A-VGA1 [187.113773] Dynamic subtest A-VGA1: SUCCESS (0.834s) [187.133655] Starting dynamic subtest: B-VGA1 [187.752069] Dynamic subtest B-VGA1: SUCCESS (0.642s) [187.769683] Starting dynamic subtest: A-HDMI-A1 [188.580641] Dynamic subtest A-HDMI-A1: SUCCESS (0.821s) [188.595792] Starting dynamic subtest: B-HDMI-A1 [189.370167] Dynamic subtest B-HDMI-A1: SUCCESS (0.793s) [189.371914] Subtest basic-flip-vs-modeset: SUCCESS (3.099s) [189.557580] [111/171] (822s left) kms_flip (basic-flip-vs-wf_vblank) [190.093693] Starting subtest: basic-flip-vs-wf_vblank [190.095425] Starting dynamic subtest: A-VGA1 [191.202737] Dynamic subtest A-VGA1: SUCCESS (1.112s) [191.217642] Starting dynamic subtest: B-VGA1 [192.210767] Dynamic subtest B-VGA1: SUCCESS (1.007s) [192.227647] Starting dynamic subtest: A-HDMI-A1 [193.447068] Dynamic subtest A-HDMI-A1: SUCCESS (1.231s) [193.464551] Starting dynamic subtest: B-HDMI-A1 [194.749708] Dynamic subtest B-HDMI-A1: SUCCESS (1.290s) [194.751779] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.645s) [195.434914] [112/171] (816s left) kms_flip (basic-plain-flip) [196.073244] Starting subtest: basic-plain-flip [196.096136] Starting dynamic subtest: A-VGA1 [196.802284] Dynamic subtest A-VGA1: SUCCESS (0.785s) [196.820707] Starting dynamic subtest: B-VGA1 [197.532034] Dynamic subtest B-VGA1: SUCCESS (0.725s) [197.551698] Starting dynamic subtest: A-HDMI-A1 [198.299683] Dynamic subtest A-HDMI-A1: SUCCESS (0.769s) [198.317669] Starting dynamic subtest: B-HDMI-A1 [199.109445] Dynamic subtest B-HDMI-A1: SUCCESS (0.806s) [199.111284] Subtest basic-plain-flip: SUCCESS (3.095s) [199.405200] [113/171] (812s left) kms_force_connector_basic (force-connector-state) [199.601075] Starting subtest: force-connector-state [200.408713] Subtest force-connector-state: SUCCESS (0.806s) [200.977389] [114/171] (810s left) kms_force_connector_basic (force-edid) [201.171446] Starting subtest: force-edid [201.499336] Subtest force-edid: SUCCESS (0.329s) [201.974877] [115/171] (809s left) kms_force_connector_basic (force-load-detect) [202.178810] Starting subtest: force-load-detect [202.360085] Subtest force-load-detect: SUCCESS (0.183s) [202.901206] [116/171] (808s left) kms_force_connector_basic (prune-stale-modes) [203.099964] Starting subtest: prune-stale-modes [203.422380] Subtest prune-stale-modes: SUCCESS (0.323s) [203.949486] [117/171] (807s left) kms_frontbuffer_tracking (basic) [204.661846] Starting subtest: basic [204.988744] Subtest basic: SKIP (0.319s) [205.113994] [118/171] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [205.812060] Starting subtest: compare-crc-sanitycheck [205.813836] Starting dynamic subtest: pipe-A-HDMI-A-1 [206.205022] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.393s) [206.221570] Starting dynamic subtest: pipe-B-HDMI-A-1 [206.652767] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.442s) [206.659690] Subtest compare-crc-sanitycheck: SUCCESS (0.839s) [207.060271] [119/171] (804s left) kms_pipe_crc_basic (hang-read-crc) [207.766514] Starting subtest: hang-read-crc [207.768285] Starting dynamic subtest: pipe-A-HDMI-A-1 [208.895712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.141s) [208.916675] Starting dynamic subtest: pipe-B-HDMI-A-1 [210.071138] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.173s) [210.072979] Subtest hang-read-crc: SUCCESS (2.317s) [210.247357] [120/171] (801s left) kms_pipe_crc_basic (nonblocking-crc) [210.936640] Starting subtest: nonblocking-crc [210.938496] Starting dynamic subtest: pipe-A-HDMI-A-1 [211.521773] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.588s) [211.538283] Starting dynamic subtest: pipe-B-HDMI-A-1 [212.154547] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.632s) [212.156320] Subtest nonblocking-crc: SUCCESS (1.221s) [212.309688] [121/171] (799s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [213.019674] Starting subtest: nonblocking-crc-frame-sequence [213.021471] Starting dynamic subtest: pipe-A-HDMI-A-1 [213.617965] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.599s) [213.635624] Starting dynamic subtest: pipe-B-HDMI-A-1 [214.254871] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.635s) [214.256710] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.238s) [214.413691] [122/171] (797s left) kms_pipe_crc_basic (read-crc) [215.111891] Starting subtest: read-crc [215.113677] Starting dynamic subtest: pipe-A-HDMI-A-1 [215.640969] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.492s) [215.665228] Starting dynamic subtest: pipe-B-HDMI-A-1 [216.151623] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.512s) [216.174865] Subtest read-crc: SUCCESS (1.006s) [216.690324] [123/171] (795s left) kms_pipe_crc_basic (read-crc-frame-sequence) [217.391671] Starting subtest: read-crc-frame-sequence [217.393451] Starting dynamic subtest: pipe-A-HDMI-A-1 [217.930947] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.544s) [217.949693] Starting dynamic subtest: pipe-B-HDMI-A-1 [218.525753] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.594s) [218.527706] Subtest read-crc-frame-sequence: SUCCESS (1.140s) [218.682283] [124/171] (793s left) kms_psr (primary_page_flip) [218.822819] Subtest primary_page_flip: SKIP (0.000s) [218.868570] [125/171] (793s left) kms_psr (cursor_plane_move) [219.005300] Subtest cursor_plane_move: SKIP (0.000s) [219.051331] [126/171] (792s left) kms_psr (sprite_plane_onoff) [219.186076] Subtest sprite_plane_onoff: SKIP (0.000s) [219.217689] [127/171] (792s left) kms_psr (primary_mmap_gtt) [219.353250] Subtest primary_mmap_gtt: SKIP (0.000s) [219.400566] [128/171] (792s left) kms_setmode (basic-clone-single-crtc) [219.537962] Starting subtest: basic-clone-single-crtc [219.543084] Subtest basic-clone-single-crtc: SKIP (0.000s) [219.613192] [129/171] (792s left) i915_pm_backlight (basic-brightness) [220.301904] Subtest basic-brightness: SKIP (0.000s) [220.365297] [130/171] (791s left) i915_pm_rpm (basic-pci-d3-state) [232.419338] Subtest basic-pci-d3-state: SKIP (0.000s) [232.707798] [131/171] (779s left) i915_pm_rpm (basic-rte) [232.841602] Starting subtest: basic-rte [244.808229] Subtest basic-rte: SKIP (11.947s) [245.066687] [132/171] (767s left) i915_pm_rps (basic-api) [245.215302] Subtest basic-api: SKIP (0.000s) [245.251116] [133/171] (766s left) prime_self_import (basic-llseek-bad) [245.378833] Starting subtest: basic-llseek-bad [245.381822] Subtest basic-llseek-bad: SUCCESS (0.002s) [245.463847] [134/171] (766s left) prime_self_import (basic-llseek-size) [245.593989] Starting subtest: basic-llseek-size [245.595877] Subtest basic-llseek-size: SUCCESS (0.003s) [245.662909] [135/171] (766s left) prime_self_import (basic-with_fd_dup) [245.794199] Starting subtest: basic-with_fd_dup [245.795939] Subtest basic-with_fd_dup: SUCCESS (0.003s) [245.877733] [136/171] (766s left) prime_self_import (basic-with_one_bo) [246.010806] Starting subtest: basic-with_one_bo [246.013214] Subtest basic-with_one_bo: SUCCESS (0.004s) [246.082943] [137/171] (766s left) prime_self_import (basic-with_one_bo_two_files) [246.210556] Starting subtest: basic-with_one_bo_two_files [246.216773] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [246.296893] [138/171] (766s left) prime_self_import (basic-with_two_bos) [246.428431] Starting subtest: basic-with_two_bos [246.430502] Subtest basic-with_two_bos: SUCCESS (0.003s) [246.512122] [139/171] (765s left) prime_vgem (basic-fence-flip) [246.655145] Starting subtest: basic-fence-flip [247.801341] Subtest basic-fence-flip: SUCCESS (1.145s) [248.016674] [140/171] (764s left) prime_vgem (basic-fence-mmap) [248.162469] Starting subtest: basic-fence-mmap [248.223925] Subtest basic-fence-mmap: SUCCESS (0.056s) [248.298502] [141/171] (764s left) prime_vgem (basic-fence-read) [248.444668] Starting subtest: basic-fence-read [248.519572] Subtest basic-fence-read: SUCCESS (0.074s) [248.602047] [142/171] (763s left) prime_vgem (basic-gtt) [248.743526] Starting subtest: basic-gtt [248.764364] Subtest basic-gtt: SUCCESS (0.020s) [248.849392] [143/171] (763s left) prime_vgem (basic-read) [248.993340] Starting subtest: basic-read [249.030456] Subtest basic-read: SUCCESS (0.037s) [249.116349] [144/171] (763s left) prime_vgem (basic-write) [249.258680] Starting subtest: basic-write [249.297219] Subtest basic-write: SUCCESS (0.038s) [249.381165] [145/171] (763s left) prime_vgem (basic-userptr) [249.525225] Starting subtest: basic-userptr [249.541756] Subtest basic-userptr: SKIP (0.015s) [249.620637] [146/171] (762s left) vgem_basic (setversion) [249.768801] Starting subtest: setversion [249.772818] Subtest setversion: SUCCESS (0.000s) [249.832420] [147/171] (762s left) vgem_basic (create) [249.968424] Starting subtest: create [249.970600] Subtest create: SUCCESS (0.000s) [250.031384] [148/171] (762s left) vgem_basic (debugfs) [250.167138] Starting subtest: debugfs [250.170558] Subtest debugfs: SUCCESS (0.001s) [250.229032] [149/171] (762s left) vgem_basic (dmabuf-export) [250.367340] Starting subtest: dmabuf-export [250.373698] Subtest dmabuf-export: SUCCESS (0.003s) [250.446990] [150/171] (762s left) vgem_basic (dmabuf-fence) [250.583463] Starting subtest: dmabuf-fence [250.586787] Subtest dmabuf-fence: SUCCESS (0.001s) [250.647377] [151/171] (762s left) vgem_basic (dmabuf-fence-before) [250.783129] Starting subtest: dmabuf-fence-before [250.785891] Subtest dmabuf-fence-before: SUCCESS (0.001s) [250.846365] [152/171] (761s left) vgem_basic (dmabuf-mmap) [250.982196] Starting subtest: dmabuf-mmap [251.010080] Subtest dmabuf-mmap: SUCCESS (0.028s) [251.063989] [153/171] (761s left) vgem_basic (mmap) [251.233137] Starting subtest: mmap [251.253747] Subtest mmap: SUCCESS (0.021s) [251.310465] [154/171] (761s left) vgem_basic (second-client) [251.448143] Starting subtest: second-client [251.498636] Subtest second-client: SUCCESS (0.049s) [251.561515] [155/171] (761s left) vgem_basic (sysfs) [251.697682] Starting subtest: sysfs [251.699831] Subtest sysfs: SUCCESS (0.001s) [251.759094] [156/171] (761s left) core_hotunplug (unbind-rebind) [251.914073] Starting subtest: unbind-rebind [253.370904] Subtest unbind-rebind: SUCCESS (1.457s) [253.433458] [157/171] (759s left) vgem_basic (unload) [253.620145] Starting subtest: unload [282.444157] Subtest unload: SUCCESS (28.822s) [282.575425] [158/171] (730s left) i915_module_load (reload) [282.707149] Starting subtest: reload [285.261793] Subtest reload: SUCCESS (2.553s) [285.318418] [159/171] (727s left) gem_lmem_swapping (basic) [285.562993] Subtest basic: SKIP (0.000s) [285.608307] [160/171] (727s left) gem_lmem_swapping (parallel-random-engines) [285.751868] Subtest parallel-random-engines: SKIP (0.000s) [285.790855] [161/171] (727s left) gem_lmem_swapping (random-engines) [285.935957] Subtest random-engines: SKIP (0.000s) [285.974147] [162/171] (726s left) gem_lmem_swapping (verify-random) [286.118261] Subtest verify-random: SKIP (0.000s) [286.157173] [163/171] (726s left) i915_pm_rpm (module-reload) [298.247832] Subtest module-reload: SKIP (0.000s) [298.532667] [164/171] (714s left) i915_selftest (live) [299.374412] Starting subtest: live [299.398222] Starting dynamic subtest: sanitycheck [300.237084] Dynamic subtest sanitycheck: SUCCESS (0.904s) [300.246350] Starting dynamic subtest: uncore [300.998196] Dynamic subtest uncore: SUCCESS (0.759s) [301.008892] Starting dynamic subtest: workarounds [301.781073] Dynamic subtest workarounds: SUCCESS (0.782s) [301.790579] Starting dynamic subtest: gt_engines [302.633490] Dynamic subtest gt_engines: SUCCESS (0.851s) [302.642938] Starting dynamic subtest: gt_timelines [308.352651] Dynamic subtest gt_timelines: SUCCESS (5.717s) [308.362522] Starting dynamic subtest: gt_contexts [309.216127] Dynamic subtest gt_contexts: SUCCESS (0.862s) [309.226318] Starting dynamic subtest: gt_lrc [309.994333] Dynamic subtest gt_lrc: SUCCESS (0.777s) [310.004190] Starting dynamic subtest: gt_mocs [310.778252] Dynamic subtest gt_mocs: SUCCESS (0.783s) [310.786625] Starting dynamic subtest: gt_pm [312.010518] Dynamic subtest gt_pm: SUCCESS (1.231s) [312.018982] Starting dynamic subtest: gt_heartbeat [312.879536] Dynamic subtest gt_heartbeat: SUCCESS (0.868s) [312.890273] Starting dynamic subtest: requests [317.231882] Dynamic subtest requests: SUCCESS (4.351s) [317.242499] Starting dynamic subtest: migrate [318.028039] Dynamic subtest migrate: SUCCESS (0.794s) [318.038648] Starting dynamic subtest: active [318.838303] Dynamic subtest active: SUCCESS (0.810s) [318.849667] Starting dynamic subtest: objects [321.292662] Dynamic subtest objects: SUCCESS (2.453s) [321.303793] Starting dynamic subtest: mman [327.958648] Dynamic subtest mman: SUCCESS (6.664s) [327.967943] Starting dynamic subtest: dmabuf [328.817162] Dynamic subtest dmabuf: SUCCESS (0.859s) [328.830921] Starting dynamic subtest: vma [329.647261] Dynamic subtest vma: SUCCESS (0.829s) [329.656773] Starting dynamic subtest: coherency [331.815166] Dynamic subtest coherency: SUCCESS (2.167s) [331.825356] Starting dynamic subtest: gtt [335.973786] Dynamic subtest gtt: SUCCESS (4.157s) [335.983834] Starting dynamic subtest: gem [336.833228] Dynamic subtest gem: SUCCESS (0.859s) [336.846899] Starting dynamic subtest: evict [337.585298] Dynamic subtest evict: SUCCESS (0.751s) [337.593576] Starting dynamic subtest: hugepages [338.391481] Dynamic subtest hugepages: SUCCESS (0.805s) [338.399548] Starting dynamic subtest: gem_contexts [342.374317] Dynamic subtest gem_contexts: SUCCESS (3.982s) [342.384595] Starting dynamic subtest: client [343.181244] Dynamic subtest client: SUCCESS (0.806s) [343.190833] Starting dynamic subtest: gem_migrate [343.978281] Dynamic subtest gem_migrate: SUCCESS (0.796s) [343.992863] Starting dynamic subtest: reset [344.917188] Dynamic subtest reset: SUCCESS (0.938s) [344.927855] Starting dynamic subtest: memory_region [345.706273] Dynamic subtest memory_region: SUCCESS (0.788s) [345.720868] Starting dynamic subtest: hangcheck [348.065322] Dynamic subtest hangcheck: SUCCESS (2.358s) [348.075332] Starting dynamic subtest: execlists [348.891871] Dynamic subtest execlists: SUCCESS (0.825s) [348.902455] Starting dynamic subtest: ring_submission [349.696431] Dynamic subtest ring_submission: SUCCESS (0.803s) [349.710881] Starting dynamic subtest: perf [350.514932] Dynamic subtest perf: SUCCESS (0.817s) [350.525432] Starting dynamic subtest: slpc [351.310279] Dynamic subtest slpc: SUCCESS (0.794s) [351.319642] Starting dynamic subtest: guc [352.130176] Dynamic subtest guc: SUCCESS (0.818s) [352.140851] Starting dynamic subtest: guc_multi_lrc [352.957917] Dynamic subtest guc_multi_lrc: SUCCESS (0.826s) [352.969147] Starting dynamic subtest: guc_hang [353.795243] Dynamic subtest guc_hang: SUCCESS (0.837s) [353.805584] Starting dynamic subtest: late_gt_pm [354.612199] Dynamic subtest late_gt_pm: SUCCESS (0.816s) [354.614226] Subtest live: SUCCESS (55.281s) [354.682064] [165/171] (658s left) dmabuf (all-tests) [354.828889] Starting subtest: all-tests [354.835158] Starting dynamic subtest: sanitycheck [354.857097] Dynamic subtest sanitycheck: SUCCESS (0.028s) [354.867837] Starting dynamic subtest: dma_fence [355.001339] Dynamic subtest dma_fence: SUCCESS (0.144s) [355.016620] Starting dynamic subtest: dma_fence_chain [375.664482] Dynamic subtest dma_fence_chain: SUCCESS (20.660s) [375.674849] Starting dynamic subtest: dma_fence_unwrap [375.689334] Dynamic subtest dma_fence_unwrap: SUCCESS (0.026s) [375.703110] Starting dynamic subtest: dma_resv [375.724124] Dynamic subtest dma_resv: SUCCESS (0.027s) [375.725865] Subtest all-tests: SUCCESS (20.890s) [375.742665] [166/171] (637s left) i915_suspend (basic-s2idle-without-i915) [375.872579] Starting subtest: basic-s2idle-without-i915 [395.960899] Subtest basic-s2idle-without-i915: SUCCESS (3.793s) [400.197884] [167/171] (633s left) i915_suspend (basic-s3-without-i915) [400.339502] Starting subtest: basic-s3-without-i915 [418.043424] Subtest basic-s3-without-i915: SUCCESS (2.379s) [425.566565] [168/171] (630s left) gem_exec_suspend (basic-s0) [425.729569] Starting subtest: basic-S0 [425.733160] Starting dynamic subtest: smem [443.422773] Dynamic subtest smem: SUCCESS (7.264s) [443.424553] Subtest basic-S0: SUCCESS (7.265s) [447.613149] [169/171] (622s left) gem_exec_suspend (basic-s3) [447.764050] Starting subtest: basic-S3 [447.766553] Starting dynamic subtest: smem [465.598094] Dynamic subtest smem: SUCCESS (2.303s) [465.599863] Subtest basic-S3: SUCCESS (2.305s) [473.785358] [170/171] (620s left) kms_chamelium_hpd (common-hpd-after-suspend) [474.607269] Subtest common-hpd-after-suspend: SKIP (0.000s) [474.980282] [171/171] (618s left) kms_pipe_crc_basic (suspend-read-crc) [475.684576] Starting subtest: suspend-read-crc [475.687729] Starting dynamic subtest: pipe-A-HDMI-A-1 [493.674376] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.135s) [493.693416] Starting dynamic subtest: pipe-B-HDMI-A-1 [511.678994] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.225s) [511.680815] Subtest suspend-read-crc: SUCCESS (4.362s) [519.178546] Closing watchdogs Done.