[38.866416] Initializing watchdogs [38.866477] /dev/watchdog0 [38.871910] [001/171] (960s left) i915_module_load (load) [38.927681] Starting subtest: load [39.839256] Subtest load: SUCCESS (0.912s) [39.853622] [002/171] (959s left) core_auth (basic-auth) [39.941342] Starting subtest: basic-auth [39.943156] Subtest basic-auth: SUCCESS (0.000s) [40.001790] [003/171] (959s left) debugfs_test (read_all_entries) [40.058452] Starting subtest: read_all_entries [40.106423] Subtest read_all_entries: SUCCESS (0.048s) [40.216991] [004/171] (959s left) debugfs_test (basic-hwmon) [40.276741] Starting subtest: basic-hwmon [40.279799] Subtest basic-hwmon: SKIP (0.000s) [40.383787] [005/171] (959s left) fbdev (eof) [40.439570] Starting subtest: eof [40.441139] Subtest eof: SUCCESS (0.000s) [40.486502] [006/171] (958s left) fbdev (info) [40.540718] Starting subtest: info [40.542193] Subtest info: SUCCESS (0.000s) [40.612598] [007/171] (958s left) fbdev (nullptr) [40.739787] Starting subtest: nullptr [40.741937] Subtest nullptr: SUCCESS (0.000s) [40.785872] [008/171] (958s left) fbdev (read) [40.872888] Starting subtest: read [41.089913] Subtest read: SUCCESS (0.217s) [41.134096] [009/171] (958s left) fbdev (write) [41.189553] Starting subtest: write [41.301103] Subtest write: SUCCESS (0.112s) [41.334906] [010/171] (958s left) gem_basic (bad-close) [41.391603] Starting subtest: bad-close [41.394856] Subtest bad-close: SUCCESS (0.000s) [41.460259] [011/171] (958s left) gem_basic (create-close) [41.522866] Starting subtest: create-close [41.526231] Subtest create-close: SUCCESS (0.000s) [41.588629] [012/171] (957s left) gem_basic (create-fd-close) [41.667670] Starting subtest: create-fd-close [41.671052] Subtest create-fd-close: SUCCESS (0.000s) [41.738105] [013/171] (957s left) gem_busy (busy@all-engines) [41.837843] Starting subtest: busy [41.839435] Starting dynamic subtest: all-engines [41.860172] Dynamic subtest all-engines: SUCCESS (0.022s) [41.861898] Subtest busy: SUCCESS (0.022s) [42.210995] [014/171] (957s left) gem_close_race (basic-process) [42.272734] Starting subtest: basic-process [42.328159] Subtest basic-process: SUCCESS (0.055s) [42.496903] [015/171] (957s left) gem_close_race (basic-threads) [42.580991] Starting subtest: basic-threads [43.792933] Subtest basic-threads: SUCCESS (1.212s) [44.001477] [016/171] (955s left) gem_ctx_create (basic) [44.101801] Starting subtest: basic [44.103255] Subtest basic: SUCCESS (0.000s) [44.318207] [017/171] (955s left) gem_ctx_create (basic-files) [44.389959] Starting subtest: basic-files [46.399660] Subtest basic-files: SUCCESS (2.010s) [46.657397] [018/171] (953s left) gem_ctx_exec (basic) [46.751717] Starting subtest: basic [46.753282] Subtest basic: SUCCESS (0.002s) [46.849914] [019/171] (952s left) gem_exec_basic (basic) [46.916256] Starting subtest: basic [46.917839] Starting dynamic subtest: rcs0-smem [46.919258] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [46.924619] Starting dynamic subtest: bcs0-smem [46.926220] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [46.931197] Starting dynamic subtest: vcs0-smem [46.932775] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [46.937777] Starting dynamic subtest: vecs0-smem [46.939408] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [46.941903] Subtest basic: SUCCESS (0.002s) [47.142992] [020/171] (952s left) gem_exec_create (basic) [47.216853] Starting subtest: basic [47.218637] Starting dynamic subtest: smem [49.256884] Dynamic subtest smem: SUCCESS (2.040s) [49.258496] Subtest basic: SUCCESS (2.040s) [49.460311] [021/171] (950s left) gem_exec_fence (basic-busy) [49.661815] Starting subtest: basic-busy [49.664583] Starting dynamic subtest: rcs0 [49.703190] Dynamic subtest rcs0: SUCCESS (0.041s) [49.712494] Starting dynamic subtest: bcs0 [49.733778] Dynamic subtest bcs0: SUCCESS (0.031s) [49.738902] Starting dynamic subtest: vcs0 [49.758812] Dynamic subtest vcs0: SUCCESS (0.025s) [49.765757] Starting dynamic subtest: vecs0 [49.781930] Dynamic subtest vecs0: SUCCESS (0.023s) [49.783857] Subtest basic-busy: SUCCESS (0.121s) [50.318123] [022/171] (949s left) gem_exec_fence (basic-wait) [50.501522] Starting subtest: basic-wait [50.503217] Starting dynamic subtest: rcs0 [50.535900] Dynamic subtest rcs0: SUCCESS (0.034s) [50.545707] Starting dynamic subtest: bcs0 [50.569987] Dynamic subtest bcs0: SUCCESS (0.033s) [50.592972] Starting dynamic subtest: vcs0 [50.617072] Dynamic subtest vcs0: SUCCESS (0.046s) [50.639890] Starting dynamic subtest: vecs0 [50.661498] Dynamic subtest vecs0: SUCCESS (0.045s) [50.663700] Subtest basic-wait: SUCCESS (0.160s) [51.138251] [023/171] (948s left) gem_exec_fence (basic-await) [51.350890] Starting subtest: basic-await [51.353576] Starting dynamic subtest: rcs0 [51.436914] Dynamic subtest rcs0: SUCCESS (0.086s) [51.444449] Starting dynamic subtest: bcs0 [51.513191] Dynamic subtest bcs0: SUCCESS (0.076s) [51.533169] Starting dynamic subtest: vcs0 [51.609966] Dynamic subtest vcs0: SUCCESS (0.097s) [51.617764] Starting dynamic subtest: vecs0 [51.686917] Dynamic subtest vecs0: SUCCESS (0.076s) [51.689458] Subtest basic-await: SUCCESS (0.336s) [52.261874] [024/171] (947s left) gem_exec_fence (nb-await) [52.431568] Starting subtest: nb-await [52.432942] Starting dynamic subtest: rcs0 [52.490698] Dynamic subtest rcs0: SUCCESS (0.058s) [52.498838] Starting dynamic subtest: bcs0 [52.549285] Dynamic subtest bcs0: SUCCESS (0.059s) [52.562319] Starting dynamic subtest: vcs0 [52.611123] Dynamic subtest vcs0: SUCCESS (0.061s) [52.632915] Starting dynamic subtest: vecs0 [52.680568] Dynamic subtest vecs0: SUCCESS (0.069s) [52.683215] Subtest nb-await: SUCCESS (0.248s) [53.221719] [025/171] (946s left) gem_exec_gttfill (basic) [53.279552] Starting subtest: basic [58.172704] Subtest basic: SUCCESS (4.893s) [58.334804] [026/171] (941s left) gem_exec_parallel (engines) [58.440315] Starting subtest: engines [58.441708] Starting dynamic subtest: basic [59.883511] Dynamic subtest basic: SUCCESS (1.443s) [59.890540] Starting dynamic subtest: contexts [62.423886] Dynamic subtest contexts: SUCCESS (2.540s) [62.429830] Starting dynamic subtest: fds [64.636884] Dynamic subtest fds: SUCCESS (2.213s) [64.642828] Starting dynamic subtest: userptr [66.264119] Dynamic subtest userptr: SUCCESS (1.627s) [66.266106] Subtest engines: SUCCESS (7.823s) [66.461113] [027/171] (933s left) gem_exec_store (basic) [66.548386] Starting subtest: basic [66.600952] Subtest basic: SUCCESS (0.053s) [66.771061] [028/171] (933s left) gem_flink_basic (bad-flink) [66.832623] Starting subtest: bad-flink [66.834241] Subtest bad-flink: SUCCESS (0.000s) [66.885921] [029/171] (933s left) gem_flink_basic (bad-open) [66.941049] Starting subtest: bad-open [66.942690] Subtest bad-open: SUCCESS (0.000s) [67.007345] [030/171] (932s left) gem_flink_basic (basic) [67.066811] Starting subtest: basic [67.068219] Subtest basic: SUCCESS (0.000s) [67.157887] [031/171] (932s left) gem_flink_basic (double-flink) [67.221998] Starting subtest: double-flink [67.223486] Subtest double-flink: SUCCESS (0.000s) [67.293386] [032/171] (932s left) gem_flink_basic (flink-lifetime) [67.375451] Starting subtest: flink-lifetime [67.377077] Subtest flink-lifetime: SUCCESS (0.001s) [67.459828] [033/171] (932s left) gem_huc_copy (huc-copy) [67.525063] Starting subtest: huc-copy [67.528216] Subtest huc-copy: SKIP (0.000s) [67.615179] [034/171] (932s left) gem_linear_blits (basic) [67.749972] Starting subtest: basic [67.754078] Subtest basic: SUCCESS (0.004s) [67.898302] [035/171] (932s left) gem_mmap (basic) [68.032816] Starting subtest: basic [68.041088] Subtest basic: SUCCESS (0.000s) [68.143785] [036/171] (931s left) gem_mmap_gtt (basic) [68.222549] Starting subtest: basic [68.224223] Subtest basic: SUCCESS (0.000s) [68.281509] [037/171] (931s left) gem_render_linear_blits (basic) [68.368325] Starting subtest: basic [68.389362] Subtest basic: SUCCESS (0.022s) [68.429996] [038/171] (931s left) gem_render_tiled_blits (basic) [68.491142] Starting subtest: basic [68.512008] Subtest basic: SUCCESS (0.022s) [68.546865] [039/171] (931s left) gem_ringfill (basic-all) [68.794279] Starting subtest: basic-all [69.943235] Subtest basic-all: SUCCESS (1.153s) [70.081424] [040/171] (930s left) gem_softpin (allocator-basic) [70.186728] Starting subtest: allocator-basic [70.243747] Subtest allocator-basic: SUCCESS (0.058s) [70.346072] [041/171] (929s left) gem_softpin (allocator-basic-reserve) [70.410167] Starting subtest: allocator-basic-reserve [70.467727] Subtest allocator-basic-reserve: SUCCESS (0.058s) [70.560221] [042/171] (929s left) gem_softpin (safe-alignment) [70.616676] Starting subtest: safe-alignment [70.622656] Subtest safe-alignment: SUCCESS (0.007s) [70.713626] [043/171] (929s left) gem_sync (basic-all) [70.787233] Starting subtest: basic-all [72.832377] Subtest basic-all: SUCCESS (2.051s) [73.005488] [044/171] (927s left) gem_sync (basic-each) [73.072201] Starting subtest: basic-each [75.146185] Subtest basic-each: SUCCESS (2.081s) [75.365927] [045/171] (924s left) gem_tiled_blits (basic) [75.514325] Starting subtest: basic [75.524095] Subtest basic: SUCCESS (0.010s) [75.657638] [046/171] (924s left) gem_tiled_fence_blits (basic) [75.845341] Starting subtest: basic [75.852044] Subtest basic: SUCCESS (0.007s) [75.979894] [047/171] (924s left) gem_tiled_pread_basic [76.221913] [048/171] (924s left) gem_wait (busy@all-engines) [76.287635] Starting subtest: busy [76.289248] Starting dynamic subtest: all-engines [76.801692] Dynamic subtest all-engines: SUCCESS (0.514s) [76.803160] Subtest busy: SUCCESS (0.514s) [76.979618] [049/171] (923s left) gem_wait (wait@all-engines) [77.040455] Starting subtest: wait [77.042017] Starting dynamic subtest: all-engines [78.071050] Dynamic subtest all-engines: SUCCESS (1.029s) [78.073741] Subtest wait: SUCCESS (1.030s) [78.271777] [050/171] (922s left) i915_getparams_basic (basic-eu-total) [78.336718] Starting subtest: basic-eu-total [78.339936] Subtest basic-eu-total: SUCCESS (0.000s) [78.386229] [051/171] (922s left) i915_getparams_basic (basic-subslice-total) [78.441184] Starting subtest: basic-subslice-total [78.444577] Subtest basic-subslice-total: SUCCESS (0.000s) [78.507428] [052/171] (921s left) i915_hangman (error-state-basic) [78.605282] Starting subtest: error-state-basic [78.613199] Subtest error-state-basic: SUCCESS (0.007s) [78.671205] [053/171] (921s left) i915_pciid [78.806251] [054/171] (921s left) kms_addfb_basic (addfb25-bad-modifier) [78.867789] Starting subtest: addfb25-bad-modifier [78.869748] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [79.001875] [055/171] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [79.063718] Starting subtest: addfb25-framebuffer-vs-set-tiling [79.065156] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.185215] [056/171] (921s left) kms_addfb_basic (addfb25-modifier-no-flag) [79.239452] Starting subtest: addfb25-modifier-no-flag [79.240929] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [79.351657] [057/171] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy) [79.404604] Starting subtest: addfb25-x-tiled-legacy [79.405952] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [79.518306] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [79.571675] Starting subtest: addfb25-x-tiled-mismatch-legacy [79.573395] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [79.685119] [059/171] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [79.787277] Starting subtest: addfb25-yf-tiled-legacy [79.788759] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [79.851336] [060/171] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy) [79.953162] Starting subtest: addfb25-y-tiled-legacy [79.954604] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [80.035258] [061/171] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [80.144290] Starting subtest: addfb25-y-tiled-small-legacy [80.145747] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [80.218238] [062/171] (920s left) kms_addfb_basic (bad-pitch-0) [80.272358] Starting subtest: bad-pitch-0 [80.273916] Subtest bad-pitch-0: SUCCESS (0.000s) [80.401704] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024) [80.455196] Starting subtest: bad-pitch-1024 [80.456765] Subtest bad-pitch-1024: SUCCESS (0.000s) [80.584917] [064/171] (920s left) kms_addfb_basic (bad-pitch-128) [80.638533] Starting subtest: bad-pitch-128 [80.640089] Subtest bad-pitch-128: SUCCESS (0.000s) [80.751416] [065/171] (919s left) kms_addfb_basic (bad-pitch-256) [80.804925] Starting subtest: bad-pitch-256 [80.806333] Subtest bad-pitch-256: SUCCESS (0.000s) [80.935149] [066/171] (919s left) kms_addfb_basic (bad-pitch-32) [80.988142] Starting subtest: bad-pitch-32 [80.989594] Subtest bad-pitch-32: SUCCESS (0.000s) [81.101851] [067/171] (919s left) kms_addfb_basic (bad-pitch-63) [81.155205] Starting subtest: bad-pitch-63 [81.156689] Subtest bad-pitch-63: SUCCESS (0.000s) [81.268163] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536) [81.328547] Starting subtest: bad-pitch-65536 [81.330141] Subtest bad-pitch-65536: SUCCESS (0.000s) [81.451816] [069/171] (919s left) kms_addfb_basic (bad-pitch-999) [81.520232] Starting subtest: bad-pitch-999 [81.522918] Subtest bad-pitch-999: SUCCESS (0.000s) [81.668315] [070/171] (919s left) kms_addfb_basic (basic) [81.723540] Starting subtest: basic [81.725058] Subtest basic: SUCCESS (0.000s) [81.835203] [071/171] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [81.888453] Starting subtest: basic-x-tiled-legacy [81.889907] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [82.018300] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy) [82.076283] Starting subtest: basic-y-tiled-legacy [82.077786] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [82.201865] [073/171] (918s left) kms_addfb_basic (bo-too-small) [82.303154] Starting subtest: bo-too-small [82.304645] Subtest bo-too-small: SUCCESS (0.000s) [82.368306] [074/171] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling) [82.469534] Starting subtest: bo-too-small-due-to-tiling [82.471027] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [82.551996] [075/171] (918s left) kms_addfb_basic (clobberred-modifier) [82.610159] Starting subtest: clobberred-modifier [82.611663] Subtest clobberred-modifier: SUCCESS (0.000s) [82.718332] [076/171] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling) [82.770867] Starting subtest: framebuffer-vs-set-tiling [82.772403] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [82.901706] [077/171] (917s left) kms_addfb_basic (invalid-get-prop) [82.959788] Starting subtest: invalid-get-prop [82.961738] Subtest invalid-get-prop: SUCCESS (0.000s) [83.085296] [078/171] (917s left) kms_addfb_basic (invalid-get-prop-any) [83.139517] Starting subtest: invalid-get-prop-any [83.140962] Subtest invalid-get-prop-any: SUCCESS (0.000s) [83.268308] [079/171] (917s left) kms_addfb_basic (invalid-set-prop) [83.326502] Starting subtest: invalid-set-prop [83.327971] Subtest invalid-set-prop: SUCCESS (0.000s) [83.468731] [080/171] (917s left) kms_addfb_basic (invalid-set-prop-any) [83.555239] Starting subtest: invalid-set-prop-any [83.556635] Subtest invalid-set-prop-any: SUCCESS (0.000s) [83.685051] [081/171] (917s left) kms_addfb_basic (no-handle) [83.738503] Starting subtest: no-handle [83.740027] Subtest no-handle: SUCCESS (0.000s) [83.868533] [082/171] (917s left) kms_addfb_basic (size-max) [83.969291] Starting subtest: size-max [83.970618] Subtest size-max: SUCCESS (0.000s) [84.051775] [083/171] (916s left) kms_addfb_basic (small-bo) [84.152372] Starting subtest: small-bo [84.153803] Subtest small-bo: SUCCESS (0.000s) [84.235331] [084/171] (916s left) kms_addfb_basic (tile-pitch-mismatch) [84.293640] Starting subtest: tile-pitch-mismatch [84.295159] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [84.418137] [085/171] (916s left) kms_addfb_basic (too-high) [84.519046] Starting subtest: too-high [84.520511] Subtest too-high: SUCCESS (0.000s) [84.585087] [086/171] (916s left) kms_addfb_basic (too-wide) [84.688145] Starting subtest: too-wide [84.689629] Subtest too-wide: SUCCESS (0.000s) [84.769288] [087/171] (916s left) kms_addfb_basic (unused-handle) [84.825898] Starting subtest: unused-handle [84.827410] Subtest unused-handle: SUCCESS (0.000s) [84.935096] [088/171] (916s left) kms_addfb_basic (unused-modifier) [84.988475] Starting subtest: unused-modifier [84.989749] Subtest unused-modifier: SUCCESS (0.000s) [85.101351] [089/171] (915s left) kms_addfb_basic (unused-offsets) [85.154772] Starting subtest: unused-offsets [85.156071] Subtest unused-offsets: SUCCESS (0.000s) [85.268188] [090/171] (915s left) kms_addfb_basic (unused-pitches) [85.321580] Starting subtest: unused-pitches [85.322944] Subtest unused-pitches: SUCCESS (0.000s) [85.434659] [091/171] (915s left) kms_busy (basic) [85.538703] Starting subtest: basic [85.540095] Starting dynamic subtest: flip [86.076980] Dynamic subtest flip: SUCCESS (0.538s) [86.084636] Starting dynamic subtest: modeset [86.485405] Dynamic subtest modeset: SUCCESS (0.407s) [86.486857] Subtest basic: SUCCESS (0.946s) [86.599186] [092/171] (914s left) kms_chamelium_hpd (dp-hpd-fast) [86.724716] Subtest dp-hpd-fast: SKIP (0.000s) [86.773599] [093/171] (914s left) kms_chamelium_edid (dp-edid-read) [86.901568] Subtest dp-edid-read: SKIP (0.000s) [86.947619] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast) [87.076343] Subtest dp-crc-fast: SKIP (0.000s) [87.124094] [095/171] (913s left) kms_chamelium_hpd (hdmi-hpd-fast) [87.253293] Subtest hdmi-hpd-fast: SKIP (0.000s) [87.301290] [096/171] (913s left) kms_chamelium_edid (hdmi-edid-read) [87.430750] Subtest hdmi-edid-read: SKIP (0.000s) [87.479831] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast) [87.607713] Subtest hdmi-crc-fast: SKIP (0.000s) [87.656889] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast) [87.785669] Subtest vga-hpd-fast: SKIP (0.000s) [87.833236] [099/171] (913s left) kms_chamelium_edid (vga-edid-read) [87.962807] Subtest vga-edid-read: SKIP (0.000s) [88.010292] [100/171] (913s left) kms_prop_blob (basic) [88.064120] Starting subtest: basic [88.065967] Subtest basic: SUCCESS (0.000s) [88.112844] [101/171] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [88.215450] Starting subtest: basic-busy-flip-before-cursor-atomic [88.218400] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [88.262850] [102/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [88.366543] Starting subtest: basic-busy-flip-before-cursor-legacy [88.369613] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [88.429658] [103/171] (912s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [88.530653] Starting subtest: basic-flip-after-cursor-atomic [89.437186] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.905s) [89.538237] [104/171] (911s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [89.641967] Starting subtest: basic-flip-after-cursor-legacy [90.545881] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.904s) [90.648379] [105/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [90.750333] Starting subtest: basic-flip-after-cursor-varying-size [91.673200] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.922s) [91.779350] [106/171] (909s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [91.882149] Starting subtest: basic-flip-before-cursor-atomic [92.787786] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.905s) [92.875664] [107/171] (908s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [92.979180] Starting subtest: basic-flip-before-cursor-legacy [93.900296] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.920s) [93.987062] [108/171] (907s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [94.092294] Starting subtest: basic-flip-before-cursor-varying-size [94.995721] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.903s) [95.086406] [109/171] (906s left) kms_flip (basic-flip-vs-dpms) [95.177981] Starting subtest: basic-flip-vs-dpms [95.179597] Starting dynamic subtest: A-HDMI-A1 [96.026736] Dynamic subtest A-HDMI-A1: SUCCESS (0.849s) [96.033802] Starting dynamic subtest: B-HDMI-A1 [96.845735] Dynamic subtest B-HDMI-A1: SUCCESS (0.818s) [96.852074] Starting dynamic subtest: C-HDMI-A1 [97.654948] Dynamic subtest C-HDMI-A1: SUCCESS (0.810s) [97.656430] Subtest basic-flip-vs-dpms: SUCCESS (2.481s) [97.765117] [110/171] (903s left) kms_flip (basic-flip-vs-modeset) [97.859021] Starting subtest: basic-flip-vs-modeset [97.860531] Starting dynamic subtest: A-HDMI-A1 [98.671042] Dynamic subtest A-HDMI-A1: SUCCESS (0.810s) [98.677709] Starting dynamic subtest: B-HDMI-A1 [99.438355] Dynamic subtest B-HDMI-A1: SUCCESS (0.767s) [99.444713] Starting dynamic subtest: C-HDMI-A1 [100.213843] Dynamic subtest C-HDMI-A1: SUCCESS (0.774s) [100.215208] Subtest basic-flip-vs-modeset: SUCCESS (2.357s) [100.310490] [111/171] (900s left) kms_flip (basic-flip-vs-wf_vblank) [100.405553] Starting subtest: basic-flip-vs-wf_vblank [100.406945] Starting dynamic subtest: A-HDMI-A1 [101.502165] Dynamic subtest A-HDMI-A1: SUCCESS (1.097s) [101.509474] Starting dynamic subtest: B-HDMI-A1 [102.574980] Dynamic subtest B-HDMI-A1: SUCCESS (1.072s) [102.581384] Starting dynamic subtest: C-HDMI-A1 [103.663405] Dynamic subtest C-HDMI-A1: SUCCESS (1.087s) [103.664966] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.262s) [103.766037] [112/171] (897s left) kms_flip (basic-plain-flip) [103.858998] Starting subtest: basic-plain-flip [103.860552] Starting dynamic subtest: A-HDMI-A1 [104.674545] Dynamic subtest A-HDMI-A1: SUCCESS (0.815s) [104.682580] Starting dynamic subtest: B-HDMI-A1 [105.464109] Dynamic subtest B-HDMI-A1: SUCCESS (0.789s) [105.472129] Starting dynamic subtest: C-HDMI-A1 [106.253095] Dynamic subtest C-HDMI-A1: SUCCESS (0.788s) [106.256674] Subtest basic-plain-flip: SUCCESS (2.397s) [106.389385] [113/171] (894s left) kms_force_connector_basic (force-connector-state) [106.548477] Starting subtest: force-connector-state [106.893631] Subtest force-connector-state: SUCCESS (0.345s) [107.292426] [114/171] (894s left) kms_force_connector_basic (force-edid) [107.445609] Starting subtest: force-edid [107.581834] Subtest force-edid: SUCCESS (0.135s) [107.775634] [115/171] (893s left) kms_force_connector_basic (force-load-detect) [107.926886] Starting subtest: force-load-detect [107.930113] Subtest force-load-detect: SKIP (0.000s) [108.125548] [116/171] (893s left) kms_force_connector_basic (prune-stale-modes) [108.276730] Starting subtest: prune-stale-modes [108.411547] Subtest prune-stale-modes: SUCCESS (0.135s) [108.608863] [117/171] (892s left) kms_frontbuffer_tracking (basic) [108.717348] Starting subtest: basic [111.111659] Subtest basic: SUCCESS (2.398s) [111.212541] [118/171] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [111.319762] Starting subtest: compare-crc-sanitycheck-xr24 [111.321232] Starting dynamic subtest: pipe-A-HDMI-A-1 [111.685046] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.364s) [111.692569] Starting dynamic subtest: pipe-B-HDMI-A-1 [112.024470] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.337s) [112.032553] Starting dynamic subtest: pipe-C-HDMI-A-1 [112.377631] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.352s) [112.379064] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.058s) [112.470403] [119/171] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [112.574086] Starting subtest: compare-crc-sanitycheck-nv12 [112.594390] Starting dynamic subtest: pipe-A-HDMI-A-1 [112.962204] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.388s) [112.969801] Starting dynamic subtest: pipe-B-HDMI-A-1 [113.346062] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.381s) [113.352623] Starting dynamic subtest: pipe-C-HDMI-A-1 [113.355332] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [113.356616] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.774s) [113.453656] [120/171] (887s left) kms_pipe_crc_basic (hang-read-crc) [113.555154] Starting subtest: hang-read-crc [113.556464] Starting dynamic subtest: pipe-A-HDMI-A-1 [114.382615] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.825s) [114.389111] Starting dynamic subtest: pipe-B-HDMI-A-1 [115.210087] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.826s) [115.216898] Starting dynamic subtest: pipe-C-HDMI-A-1 [116.109430] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.898s) [116.110881] Subtest hang-read-crc: SUCCESS (2.553s) [116.190265] [121/171] (885s left) kms_pipe_crc_basic (nonblocking-crc) [116.294559] Starting subtest: nonblocking-crc [116.296179] Starting dynamic subtest: pipe-A-HDMI-A-1 [116.782155] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.484s) [116.789522] Starting dynamic subtest: pipe-B-HDMI-A-1 [117.259700] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.477s) [117.267310] Starting dynamic subtest: pipe-C-HDMI-A-1 [117.775519] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.515s) [117.776936] Subtest nonblocking-crc: SUCCESS (1.480s) [117.855705] [122/171] (883s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [117.957774] Starting subtest: nonblocking-crc-frame-sequence [117.959214] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.445111] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.487s) [118.453287] Starting dynamic subtest: pipe-B-HDMI-A-1 [118.932213] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.484s) [118.938612] Starting dynamic subtest: pipe-C-HDMI-A-1 [119.446541] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.514s) [119.448012] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.488s) [119.526688] [123/171] (881s left) kms_pipe_crc_basic (read-crc) [119.631720] Starting subtest: read-crc [119.633497] Starting dynamic subtest: pipe-A-HDMI-A-1 [120.068715] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.437s) [120.077310] Starting dynamic subtest: pipe-B-HDMI-A-1 [120.484451] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.413s) [120.491440] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.931765] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.446s) [120.933355] Subtest read-crc: SUCCESS (1.300s) [121.012463] [124/171] (880s left) kms_pipe_crc_basic (read-crc-frame-sequence) [121.117448] Starting subtest: read-crc-frame-sequence [121.118965] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.536917] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.418s) [121.544199] Starting dynamic subtest: pipe-B-HDMI-A-1 [121.947624] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.411s) [121.954393] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.395821] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.446s) [122.397429] Subtest read-crc-frame-sequence: SUCCESS (1.278s) [122.475913] [125/171] (879s left) kms_psr (primary_page_flip) [122.533546] Subtest primary_page_flip: SKIP (0.000s) [122.553437] [126/171] (878s left) kms_psr (cursor_plane_move) [122.608557] Subtest cursor_plane_move: SKIP (0.000s) [122.635895] [127/171] (878s left) kms_psr (sprite_plane_onoff) [122.693156] Subtest sprite_plane_onoff: SKIP (0.000s) [122.720680] [128/171] (878s left) kms_psr (primary_mmap_gtt) [122.778898] Subtest primary_mmap_gtt: SKIP (0.000s) [122.803391] [129/171] (878s left) kms_setmode (basic-clone-single-crtc) [122.860518] Starting subtest: basic-clone-single-crtc [122.865444] Subtest basic-clone-single-crtc: SKIP (0.000s) [122.930776] [130/171] (878s left) i915_pm_backlight (basic-brightness) [123.065380] Subtest basic-brightness: SKIP (0.000s) [123.087107] [131/171] (878s left) i915_pm_rpm (basic-pci-d3-state) [124.489920] Starting subtest: basic-pci-d3-state [135.258180] Subtest basic-pci-d3-state: FAIL (10.730s) [135.509545] [132/171] (866s left) i915_pm_rpm (basic-rte) [135.564728] Starting subtest: basic-rte [147.768324] Subtest basic-rte: FAIL (12.085s) [158.669316] [133/171] (842s left) i915_pm_rps (basic-api) [158.729449] Starting subtest: basic-api [158.731055] Subtest basic-api: SUCCESS (0.002s) [158.788716] [134/171] (842s left) prime_self_import (basic-llseek-bad) [158.866555] Starting subtest: basic-llseek-bad [158.869600] Subtest basic-llseek-bad: SUCCESS (0.001s) [158.944688] [135/171] (842s left) prime_self_import (basic-llseek-size) [159.035912] Starting subtest: basic-llseek-size [159.039213] Subtest basic-llseek-size: SUCCESS (0.002s) [159.110461] [136/171] (842s left) prime_self_import (basic-with_fd_dup) [159.193052] Starting subtest: basic-with_fd_dup [159.196432] Subtest basic-with_fd_dup: SUCCESS (0.002s) [159.280444] [137/171] (842s left) prime_self_import (basic-with_one_bo) [159.333216] Starting subtest: basic-with_one_bo [159.336178] Subtest basic-with_one_bo: SUCCESS (0.002s) [159.382667] [138/171] (842s left) prime_self_import (basic-with_one_bo_two_files) [159.445148] Starting subtest: basic-with_one_bo_two_files [159.447839] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [159.534700] [139/171] (842s left) prime_self_import (basic-with_two_bos) [159.621746] Starting subtest: basic-with_two_bos [159.624583] Subtest basic-with_two_bos: SUCCESS (0.002s) [159.720420] [140/171] (842s left) prime_vgem (basic-fence-flip) [159.840786] Starting subtest: basic-fence-flip [160.224578] Subtest basic-fence-flip: SUCCESS (0.384s) [160.318796] [141/171] (841s left) prime_vgem (basic-fence-mmap) [160.379129] Starting subtest: basic-fence-mmap [160.394184] Subtest basic-fence-mmap: SUCCESS (0.016s) [160.486797] [142/171] (841s left) prime_vgem (basic-fence-read) [160.572144] Starting subtest: basic-fence-read [160.595160] Subtest basic-fence-read: SUCCESS (0.025s) [160.713554] [143/171] (841s left) prime_vgem (basic-gtt) [160.812401] Starting subtest: basic-gtt [160.818550] Subtest basic-gtt: SUCCESS (0.007s) [160.895019] [144/171] (840s left) prime_vgem (basic-read) [160.977911] Starting subtest: basic-read [160.988069] Subtest basic-read: SUCCESS (0.011s) [161.099336] [145/171] (840s left) prime_vgem (basic-write) [161.195385] Starting subtest: basic-write [161.207444] Subtest basic-write: SUCCESS (0.013s) [161.297860] [146/171] (840s left) vgem_basic (setversion) [161.375495] Starting subtest: setversion [161.378543] Subtest setversion: SUCCESS (0.000s) [161.422443] [147/171] (840s left) vgem_basic (create) [161.492221] Starting subtest: create [161.493751] Subtest create: SUCCESS (0.000s) [161.538881] [148/171] (840s left) vgem_basic (debugfs) [161.609258] Starting subtest: debugfs [161.610841] Subtest debugfs: SUCCESS (0.000s) [161.659149] [149/171] (840s left) vgem_basic (dmabuf-export) [161.725788] Starting subtest: dmabuf-export [161.728708] Subtest dmabuf-export: SUCCESS (0.001s) [161.796816] [150/171] (840s left) vgem_basic (dmabuf-fence) [161.858919] Starting subtest: dmabuf-fence [161.860337] Subtest dmabuf-fence: SUCCESS (0.000s) [161.905743] [151/171] (840s left) vgem_basic (dmabuf-fence-before) [161.975689] Starting subtest: dmabuf-fence-before [161.977425] Subtest dmabuf-fence-before: SUCCESS (0.000s) [162.029961] [152/171] (840s left) vgem_basic (dmabuf-mmap) [162.125599] Starting subtest: dmabuf-mmap [162.133204] Subtest dmabuf-mmap: SUCCESS (0.009s) [162.170426] [153/171] (839s left) vgem_basic (mmap) [162.227154] Starting subtest: mmap [162.230607] Subtest mmap: SUCCESS (0.006s) [162.270378] [154/171] (839s left) vgem_basic (second-client) [162.325700] Starting subtest: second-client [162.359102] Subtest second-client: SUCCESS (0.033s) [162.423878] [155/171] (839s left) vgem_basic (sysfs) [162.526601] Starting subtest: sysfs [162.528225] Subtest sysfs: SUCCESS (0.000s) [162.571760] [156/171] (839s left) core_hotunplug (unbind-rebind) [162.659141] Starting subtest: unbind-rebind [163.572670] Subtest unbind-rebind: SUCCESS (0.914s) [163.605354] [157/171] (838s left) vgem_basic (unload) [163.661801] Starting subtest: unload [192.565143] Subtest unload: SUCCESS (28.902s) [192.658323] [158/171] (809s left) i915_module_load (reload) [192.712628] Starting subtest: reload [194.560574] Subtest reload: SUCCESS (1.850s) [194.582022] [159/171] (807s left) gem_lmem_swapping (basic) [194.657509] Subtest basic: SKIP (0.000s) [194.686292] [160/171] (807s left) gem_lmem_swapping (parallel-random-engines) [194.743053] Subtest parallel-random-engines: SKIP (0.000s) [194.768645] [161/171] (807s left) gem_lmem_swapping (random-engines) [194.825019] Subtest random-engines: SKIP (0.000s) [194.852223] [162/171] (807s left) gem_lmem_swapping (verify-random) [194.912783] Subtest verify-random: SKIP (0.000s) [194.935397] [163/171] (807s left) i915_pm_rpm (module-reload) [196.622177] Starting subtest: module-reload [214.903175] Subtest module-reload: FAIL (18.065s) [215.029909] [164/171] (787s left) i915_selftest (live) [215.852812] Starting subtest: live [215.855491] Starting dynamic subtest: sanitycheck [216.380171] Dynamic subtest sanitycheck: SUCCESS (0.527s) [216.386052] Starting dynamic subtest: uncore [216.867198] Dynamic subtest uncore: SUCCESS (0.486s) [216.873757] Starting dynamic subtest: workarounds [217.543152] Dynamic subtest workarounds: SUCCESS (0.675s) [217.548736] Starting dynamic subtest: gt_engines [218.511059] Dynamic subtest gt_engines: SUCCESS (0.967s) [218.516656] Starting dynamic subtest: gt_timelines [224.443026] Dynamic subtest gt_timelines: SUCCESS (5.931s) [224.448299] Starting dynamic subtest: gt_contexts [225.033151] Dynamic subtest gt_contexts: SUCCESS (0.589s) [225.038725] Starting dynamic subtest: gt_lrc [227.838183] Dynamic subtest gt_lrc: SUCCESS (2.804s) [227.843537] Starting dynamic subtest: gt_mocs [228.380122] Dynamic subtest gt_mocs: SUCCESS (0.541s) [228.385692] Starting dynamic subtest: gt_pm [230.777197] Dynamic subtest gt_pm: SUCCESS (2.396s) [230.783205] Starting dynamic subtest: gt_heartbeat [231.391123] Dynamic subtest gt_heartbeat: SUCCESS (0.613s) [231.396552] Starting dynamic subtest: gt_tlb [232.732212] Dynamic subtest gt_tlb: SUCCESS (1.340s) [232.738223] Starting dynamic subtest: requests [239.465193] Dynamic subtest requests: SUCCESS (6.732s) [239.470479] Starting dynamic subtest: migrate [242.829064] Dynamic subtest migrate: SUCCESS (3.363s) [242.834449] Starting dynamic subtest: active [243.310496] Dynamic subtest active: SUCCESS (0.480s) [243.317055] Starting dynamic subtest: objects [244.365938] Dynamic subtest objects: SUCCESS (1.055s) [244.371525] Starting dynamic subtest: mman [248.187100] Dynamic subtest mman: SUCCESS (3.820s) [248.193043] Starting dynamic subtest: dmabuf [248.749020] Dynamic subtest dmabuf: SUCCESS (0.561s) [248.754422] Starting dynamic subtest: vma [249.278932] Dynamic subtest vma: SUCCESS (0.529s) [249.284196] Starting dynamic subtest: coherency [250.371048] Dynamic subtest coherency: SUCCESS (1.091s) [250.376837] Starting dynamic subtest: gtt [258.366946] Dynamic subtest gtt: SUCCESS (7.995s) [258.372304] Starting dynamic subtest: gem [258.918952] Dynamic subtest gem: SUCCESS (0.551s) [258.924502] Starting dynamic subtest: evict [260.166147] Dynamic subtest evict: SUCCESS (1.246s) [260.171786] Starting dynamic subtest: hugepages [266.660481] Dynamic subtest hugepages: SUCCESS (6.493s) [266.666558] Starting dynamic subtest: gem_contexts [278.804121] Dynamic subtest gem_contexts: SUCCESS (12.143s) [278.809158] Starting dynamic subtest: client [279.300139] Dynamic subtest client: SUCCESS (0.495s) [279.306049] Starting dynamic subtest: gem_migrate [279.757243] Dynamic subtest gem_migrate: SUCCESS (0.456s) [279.763012] Starting dynamic subtest: reset [280.563079] Dynamic subtest reset: SUCCESS (0.805s) [280.568706] Starting dynamic subtest: memory_region [281.026138] Dynamic subtest memory_region: SUCCESS (0.462s) [281.033079] Starting dynamic subtest: hangcheck [304.531178] Dynamic subtest hangcheck: SUCCESS (23.504s) [304.536623] Starting dynamic subtest: execlists [312.788098] Dynamic subtest execlists: SUCCESS (8.256s) [312.793534] Starting dynamic subtest: ring_submission [313.252217] Dynamic subtest ring_submission: SUCCESS (0.463s) [313.257875] Starting dynamic subtest: perf [313.848209] Dynamic subtest perf: SUCCESS (0.595s) [313.853850] Starting dynamic subtest: slpc [314.310152] Dynamic subtest slpc: SUCCESS (0.461s) [314.316306] Starting dynamic subtest: guc [314.818305] Dynamic subtest guc: SUCCESS (0.507s) [314.823784] Starting dynamic subtest: guc_multi_lrc [315.310147] Dynamic subtest guc_multi_lrc: SUCCESS (0.491s) [315.317757] Starting dynamic subtest: guc_hang [315.767097] Dynamic subtest guc_hang: SUCCESS (0.456s) [315.772861] Starting dynamic subtest: late_gt_pm [316.296992] Dynamic subtest late_gt_pm: SUCCESS (0.529s) [316.298734] Subtest live: SUCCESS (100.446s) [316.508380] [165/171] (685s left) dmabuf (all-tests) [316.566648] Starting subtest: all-tests [316.568746] Starting dynamic subtest: sanitycheck [316.634908] Dynamic subtest sanitycheck: SUCCESS (0.068s) [316.654215] Starting dynamic subtest: dma_fence [316.827039] Dynamic subtest dma_fence: SUCCESS (0.190s) [316.834526] Starting dynamic subtest: dma_fence_chain [327.335154] Dynamic subtest dma_fence_chain: SUCCESS (10.507s) [327.341989] Starting dynamic subtest: dma_fence_unwrap [327.404188] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s) [327.425269] Starting dynamic subtest: dma_resv [327.484031] Dynamic subtest dma_resv: SUCCESS (0.077s) [327.485896] Subtest all-tests: SUCCESS (10.918s) [327.508165] [166/171] (674s left) i915_suspend (basic-s2idle-without-i915) [327.592821] Starting subtest: basic-s2idle-without-i915 [344.653849] Subtest basic-s2idle-without-i915: SUCCESS (1.917s) [350.781681] [167/171] (672s left) i915_suspend (basic-s3-without-i915) [350.841222] Starting subtest: basic-s3-without-i915 [368.726538] Subtest basic-s3-without-i915: SUCCESS (1.939s) [380.873990] [168/171] (670s left) gem_exec_suspend (basic-s0) [380.993103] Starting subtest: basic-S0 [380.995009] Starting dynamic subtest: smem [397.775640] Dynamic subtest smem: SUCCESS (1.754s) [397.777546] Subtest basic-S0: SUCCESS (1.755s) [400.939876] [169/171] (668s left) gem_exec_suspend (basic-s3) [401.001921] Starting subtest: basic-S3 [401.003731] Starting dynamic subtest: smem [418.791436] Dynamic subtest smem: SUCCESS (1.789s) [418.792788] Subtest basic-S3: SUCCESS (1.790s) [431.006176] [170/171] (666s left) kms_chamelium_hpd (common-hpd-after-suspend) [431.187734] Subtest common-hpd-after-suspend: SKIP (0.000s) [431.238282] [171/171] (666s left) kms_pipe_crc_basic (suspend-read-crc) [431.340761] Starting subtest: suspend-read-crc [431.342280] Starting dynamic subtest: pipe-A-HDMI-A-1 [449.811133] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.635s) [449.819451] Starting dynamic subtest: pipe-B-HDMI-A-1 [467.805359] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.597s) [467.813871] Starting dynamic subtest: pipe-C-HDMI-A-1 [485.843598] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.600s) [485.845291] Subtest suspend-read-crc: SUCCESS (4.835s) [489.896250] Closing watchdogs Done.