[44.608341] Initializing watchdogs [44.608522] /dev/watchdog0 [44.618954] [001/171] (960s left) i915_module_load (load) [44.769087] Starting subtest: load [46.438058] Subtest load: SUCCESS (1.668s) [46.466994] [002/171] (958s left) core_auth (basic-auth) [46.705860] Starting subtest: basic-auth [46.709411] Subtest basic-auth: SUCCESS (0.002s) [46.798178] [003/171] (958s left) debugfs_test (read_all_entries) [47.022263] Starting subtest: read_all_entries [47.191074] Subtest read_all_entries: SUCCESS (0.169s) [47.328540] [004/171] (957s left) debugfs_test (basic-hwmon) [47.471849] Starting subtest: basic-hwmon [47.474261] Subtest basic-hwmon: SKIP (0.001s) [47.611336] [005/171] (957s left) fbdev (eof) [47.754402] Starting subtest: eof [47.755536] Subtest eof: SUCCESS (0.000s) [47.811128] [006/171] (957s left) fbdev (info) [47.940580] Starting subtest: info [47.941708] Subtest info: SUCCESS (0.000s) [48.011139] [007/171] (957s left) fbdev (nullptr) [48.154207] Starting subtest: nullptr [48.155235] Subtest nullptr: SUCCESS (0.000s) [48.211174] [008/171] (957s left) fbdev (read) [48.354337] Starting subtest: read [49.881356] Subtest read: SUCCESS (1.525s) [49.946621] [009/171] (955s left) fbdev (write) [50.090691] Starting subtest: write [50.881841] Subtest write: SUCCESS (0.791s) [50.947857] [010/171] (954s left) gem_basic (bad-close) [51.081157] Starting subtest: bad-close [51.083858] Subtest bad-close: SUCCESS (0.000s) [51.145704] [011/171] (954s left) gem_basic (create-close) [51.277189] Starting subtest: create-close [51.279760] Subtest create-close: SUCCESS (0.002s) [51.363560] [012/171] (954s left) gem_basic (create-fd-close) [51.495076] Starting subtest: create-fd-close [51.498143] Subtest create-fd-close: SUCCESS (0.001s) [51.578823] [013/171] (953s left) gem_busy (busy@all-engines) [51.731129] Starting subtest: busy [51.732879] Starting dynamic subtest: all-engines [51.788364] Dynamic subtest all-engines: SUCCESS (0.057s) [51.789514] Subtest busy: SUCCESS (0.058s) [52.114578] [014/171] (953s left) gem_close_race (basic-process) [52.266321] Starting subtest: basic-process [52.334593] Subtest basic-process: SUCCESS (0.067s) [52.514674] [015/171] (952s left) gem_close_race (basic-threads) [52.666798] Starting subtest: basic-threads [53.801801] Subtest basic-threads: SUCCESS (1.135s) [53.979601] [016/171] (951s left) gem_ctx_create (basic) [54.125501] Starting subtest: basic [54.126588] Subtest basic: SUCCESS (0.000s) [54.314619] [017/171] (951s left) gem_ctx_create (basic-files) [54.459353] Starting subtest: basic-files [56.482511] Subtest basic-files: SUCCESS (2.023s) [56.716072] [018/171] (948s left) gem_ctx_exec (basic) [56.856410] Starting subtest: basic [56.860158] Subtest basic: SUCCESS (0.004s) [56.935560] [019/171] (948s left) gem_exec_basic (basic) [57.075888] Starting subtest: basic [57.078131] Starting dynamic subtest: rcs0-smem [57.080114] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [57.091534] Starting dynamic subtest: bcs0-smem [57.092683] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [57.102518] Starting dynamic subtest: vcs0-smem [57.103790] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [57.112957] Starting dynamic subtest: vecs0-smem [57.114340] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [57.115898] Subtest basic: SUCCESS (0.007s) [57.281088] [020/171] (948s left) gem_exec_create (basic) [57.430788] Starting subtest: basic [57.432783] Starting dynamic subtest: smem [59.477580] Dynamic subtest smem: SUCCESS (2.046s) [59.478976] Subtest basic: SUCCESS (2.047s) [59.665077] [021/171] (945s left) gem_exec_fence (basic-busy) [59.938457] Starting subtest: basic-busy [59.940491] Starting dynamic subtest: rcs0 [59.952242] Dynamic subtest rcs0: SUCCESS (0.016s) [59.964851] Starting dynamic subtest: bcs0 [59.973119] Dynamic subtest bcs0: SUCCESS (0.018s) [59.984611] Starting dynamic subtest: vcs0 [59.987327] Dynamic subtest vcs0: SUCCESS (0.013s) [59.998476] Starting dynamic subtest: vecs0 [60.000811] Dynamic subtest vecs0: SUCCESS (0.015s) [60.001961] Subtest basic-busy: SUCCESS (0.064s) [60.632664] [022/171] (944s left) gem_exec_fence (basic-wait) [60.905985] Starting subtest: basic-wait [60.907387] Starting dynamic subtest: rcs0 [60.924360] Dynamic subtest rcs0: SUCCESS (0.021s) [60.936961] Starting dynamic subtest: bcs0 [60.940285] Dynamic subtest bcs0: SUCCESS (0.016s) [60.954246] Starting dynamic subtest: vcs0 [60.955971] Dynamic subtest vcs0: SUCCESS (0.012s) [60.966436] Starting dynamic subtest: vecs0 [60.967550] Dynamic subtest vecs0: SUCCESS (0.015s) [60.968721] Subtest basic-wait: SUCCESS (0.065s) [61.532273] [023/171] (944s left) gem_exec_fence (basic-await) [61.802177] Starting subtest: basic-await [61.803406] Starting dynamic subtest: rcs0 [61.894934] Dynamic subtest rcs0: SUCCESS (0.093s) [61.904841] Starting dynamic subtest: bcs0 [61.985103] Dynamic subtest bcs0: SUCCESS (0.089s) [61.995273] Starting dynamic subtest: vcs0 [62.076907] Dynamic subtest vcs0: SUCCESS (0.093s) [62.088156] Starting dynamic subtest: vecs0 [62.174802] Dynamic subtest vecs0: SUCCESS (0.097s) [62.176045] Subtest basic-await: SUCCESS (0.374s) [62.749351] [024/171] (942s left) gem_exec_fence (nb-await) [63.020081] Starting subtest: nb-await [63.022668] Starting dynamic subtest: rcs0 [63.087850] Dynamic subtest rcs0: SUCCESS (0.068s) [63.097711] Starting dynamic subtest: bcs0 [63.156923] Dynamic subtest bcs0: SUCCESS (0.066s) [63.168760] Starting dynamic subtest: vcs0 [63.221321] Dynamic subtest vcs0: SUCCESS (0.063s) [63.233501] Starting dynamic subtest: vecs0 [63.281994] Dynamic subtest vecs0: SUCCESS (0.063s) [63.283213] Subtest nb-await: SUCCESS (0.263s) [63.864438] [025/171] (941s left) gem_exec_gttfill (basic) [64.015584] Starting subtest: basic [76.440697] Subtest basic: SUCCESS (12.425s) [76.633585] [026/171] (929s left) gem_exec_parallel (engines) [76.882504] Starting subtest: engines [76.883809] Starting dynamic subtest: basic [79.692743] Dynamic subtest basic: SUCCESS (2.810s) [79.704895] Starting dynamic subtest: contexts [83.435388] Dynamic subtest contexts: SUCCESS (3.738s) [83.446766] Starting dynamic subtest: fds [87.589607] Dynamic subtest fds: SUCCESS (4.158s) [87.601558] Starting dynamic subtest: userptr [90.766939] Dynamic subtest userptr: SUCCESS (3.177s) [90.768186] Subtest engines: SUCCESS (13.885s) [90.949532] [027/171] (914s left) gem_exec_store (basic) [91.103302] Starting subtest: basic [91.153227] Subtest basic: SUCCESS (0.049s) [91.332311] [028/171] (914s left) gem_flink_basic (bad-flink) [91.465138] Starting subtest: bad-flink [91.466268] Subtest bad-flink: SUCCESS (0.000s) [91.531657] [029/171] (914s left) gem_flink_basic (bad-open) [91.662257] Starting subtest: bad-open [91.663309] Subtest bad-open: SUCCESS (0.000s) [91.732982] [030/171] (914s left) gem_flink_basic (basic) [91.866376] Starting subtest: basic [91.867431] Subtest basic: SUCCESS (0.000s) [91.947985] [031/171] (913s left) gem_flink_basic (double-flink) [92.080363] Starting subtest: double-flink [92.081419] Subtest double-flink: SUCCESS (0.000s) [92.179659] [032/171] (913s left) gem_flink_basic (flink-lifetime) [92.310498] Starting subtest: flink-lifetime [92.311737] Subtest flink-lifetime: SUCCESS (0.002s) [92.399220] [033/171] (913s left) gem_huc_copy (huc-copy) [92.546776] Starting subtest: huc-copy [92.552162] Subtest huc-copy: SKIP (0.000s) [92.633299] [034/171] (913s left) gem_linear_blits (basic) [92.920389] Starting subtest: basic [92.935347] Subtest basic: SUCCESS (0.015s) [93.064639] [035/171] (912s left) gem_mmap (basic) [93.295576] Starting subtest: basic [93.301862] Subtest basic: SUCCESS (0.002s) [93.381853] [036/171] (912s left) gem_mmap_gtt (basic) [93.516276] Starting subtest: basic [93.518971] Subtest basic: SUCCESS (0.001s) [93.570156] [037/171] (912s left) gem_render_linear_blits (basic) [93.705528] Starting subtest: basic [93.767701] Subtest basic: SUCCESS (0.060s) [93.820755] [038/171] (912s left) gem_render_tiled_blits (basic) [93.956336] Starting subtest: basic [94.041720] Subtest basic: SUCCESS (0.084s) [94.087943] [039/171] (911s left) gem_ringfill (basic-all) [94.425475] Starting subtest: basic-all [95.607878] Subtest basic-all: SUCCESS (1.184s) [95.698980] [040/171] (910s left) gem_softpin (allocator-basic) [95.851782] Starting subtest: allocator-basic [96.033923] Subtest allocator-basic: SUCCESS (0.180s) [96.147640] [041/171] (909s left) gem_softpin (allocator-basic-reserve) [96.292573] Starting subtest: allocator-basic-reserve [96.462230] Subtest allocator-basic-reserve: SUCCESS (0.163s) [96.563469] [042/171] (909s left) gem_softpin (safe-alignment) [96.703335] Starting subtest: safe-alignment [96.725517] Subtest safe-alignment: SUCCESS (0.019s) [96.814551] [043/171] (909s left) gem_sync (basic-all) [96.966317] Starting subtest: basic-all [99.571755] Subtest basic-all: SUCCESS (2.604s) [99.749354] [044/171] (906s left) gem_sync (basic-each) [99.899311] Starting subtest: basic-each [102.245461] Subtest basic-each: SUCCESS (2.346s) [102.432252] [045/171] (903s left) gem_tiled_blits (basic) [102.704279] Starting subtest: basic [102.738613] Subtest basic: SUCCESS (0.035s) [102.874443] [046/171] (903s left) gem_tiled_fence_blits (basic) [103.251791] Starting subtest: basic [103.280444] Subtest basic: SUCCESS (0.029s) [103.420689] [047/171] (902s left) gem_tiled_pread_basic [103.933291] [048/171] (902s left) gem_wait (busy@all-engines) [104.088168] Starting subtest: busy [104.089572] Starting dynamic subtest: all-engines [104.607439] Dynamic subtest all-engines: SUCCESS (0.518s) [104.608666] Subtest busy: SUCCESS (0.519s) [104.816653] [049/171] (901s left) gem_wait (wait@all-engines) [104.970374] Starting subtest: wait [104.973905] Starting dynamic subtest: all-engines [106.001883] Dynamic subtest all-engines: SUCCESS (1.031s) [106.003049] Subtest wait: SUCCESS (1.031s) [106.217390] [050/171] (900s left) i915_getparams_basic (basic-eu-total) [106.348985] Starting subtest: basic-eu-total [106.351251] Subtest basic-eu-total: SUCCESS (0.000s) [106.416470] [051/171] (899s left) i915_getparams_basic (basic-subslice-total) [106.549303] Starting subtest: basic-subslice-total [106.551401] Subtest basic-subslice-total: SUCCESS (0.000s) [106.618801] [052/171] (899s left) i915_hangman (error-state-basic) [106.770664] Starting subtest: error-state-basic [106.784444] Subtest error-state-basic: SUCCESS (0.013s) [106.865127] [053/171] (899s left) i915_pciid [107.065264] [054/171] (899s left) kms_addfb_basic (addfb25-bad-modifier) [107.201683] Starting subtest: addfb25-bad-modifier [107.204981] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [107.348744] [055/171] (899s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [107.481659] Starting subtest: addfb25-framebuffer-vs-set-tiling [107.482781] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [107.632144] [056/171] (898s left) kms_addfb_basic (addfb25-modifier-no-flag) [107.767631] Starting subtest: addfb25-modifier-no-flag [107.768913] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [107.933966] [057/171] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [108.072963] Starting subtest: addfb25-x-tiled-legacy [108.074059] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [108.214954] [058/171] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [108.349925] Starting subtest: addfb25-x-tiled-mismatch-legacy [108.351156] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [108.498193] [059/171] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [108.699547] Starting subtest: addfb25-yf-tiled-legacy [108.700845] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [108.781750] [060/171] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy) [108.982570] Starting subtest: addfb25-y-tiled-legacy [108.983727] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [109.065226] [061/171] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [109.267961] Starting subtest: addfb25-y-tiled-small-legacy [109.270376] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [109.348117] [062/171] (897s left) kms_addfb_basic (bad-pitch-0) [109.480777] Starting subtest: bad-pitch-0 [109.481891] Subtest bad-pitch-0: SUCCESS (0.000s) [109.631466] [063/171] (896s left) kms_addfb_basic (bad-pitch-1024) [109.763714] Starting subtest: bad-pitch-1024 [109.764939] Subtest bad-pitch-1024: SUCCESS (0.000s) [109.915104] [064/171] (896s left) kms_addfb_basic (bad-pitch-128) [110.050368] Starting subtest: bad-pitch-128 [110.051439] Subtest bad-pitch-128: SUCCESS (0.000s) [110.198268] [065/171] (896s left) kms_addfb_basic (bad-pitch-256) [110.330296] Starting subtest: bad-pitch-256 [110.331442] Subtest bad-pitch-256: SUCCESS (0.000s) [110.481384] [066/171] (896s left) kms_addfb_basic (bad-pitch-32) [110.613903] Starting subtest: bad-pitch-32 [110.615067] Subtest bad-pitch-32: SUCCESS (0.000s) [110.764786] [067/171] (895s left) kms_addfb_basic (bad-pitch-63) [110.896675] Starting subtest: bad-pitch-63 [110.897832] Subtest bad-pitch-63: SUCCESS (0.000s) [111.048248] [068/171] (895s left) kms_addfb_basic (bad-pitch-65536) [111.179544] Starting subtest: bad-pitch-65536 [111.180784] Subtest bad-pitch-65536: SUCCESS (0.001s) [111.331601] [069/171] (895s left) kms_addfb_basic (bad-pitch-999) [111.465915] Starting subtest: bad-pitch-999 [111.467070] Subtest bad-pitch-999: SUCCESS (0.000s) [111.597302] [070/171] (895s left) kms_addfb_basic (basic) [111.729879] Starting subtest: basic [111.731133] Subtest basic: SUCCESS (0.000s) [111.881416] [071/171] (894s left) kms_addfb_basic (basic-x-tiled-legacy) [112.016341] Starting subtest: basic-x-tiled-legacy [112.017537] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.164736] [072/171] (894s left) kms_addfb_basic (basic-y-tiled-legacy) [112.299443] Starting subtest: basic-y-tiled-legacy [112.300624] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [112.448089] [073/171] (894s left) kms_addfb_basic (bo-too-small) [112.647222] Starting subtest: bo-too-small [112.648267] Subtest bo-too-small: SUCCESS (0.001s) [112.731901] [074/171] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [112.931349] Starting subtest: bo-too-small-due-to-tiling [112.932548] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [113.036047] [075/171] (893s left) kms_addfb_basic (clobberred-modifier) [113.170824] Starting subtest: clobberred-modifier [113.172192] Subtest clobberred-modifier: SUCCESS (0.000s) [113.314807] [076/171] (893s left) kms_addfb_basic (framebuffer-vs-set-tiling) [113.450989] Starting subtest: framebuffer-vs-set-tiling [113.452313] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.598220] [077/171] (893s left) kms_addfb_basic (invalid-get-prop) [113.729955] Starting subtest: invalid-get-prop [113.731330] Subtest invalid-get-prop: SUCCESS (0.000s) [113.881569] [078/171] (893s left) kms_addfb_basic (invalid-get-prop-any) [114.016818] Starting subtest: invalid-get-prop-any [114.018139] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.164771] [079/171] (892s left) kms_addfb_basic (invalid-set-prop) [114.297533] Starting subtest: invalid-set-prop [114.298743] Subtest invalid-set-prop: SUCCESS (0.000s) [114.448144] [080/171] (892s left) kms_addfb_basic (invalid-set-prop-any) [114.582760] Starting subtest: invalid-set-prop-any [114.584129] Subtest invalid-set-prop-any: SUCCESS (0.000s) [114.731498] [081/171] (892s left) kms_addfb_basic (no-handle) [114.866696] Starting subtest: no-handle [114.867979] Subtest no-handle: SUCCESS (0.000s) [115.014838] [082/171] (892s left) kms_addfb_basic (size-max) [115.216190] Starting subtest: size-max [115.217267] Subtest size-max: SUCCESS (0.000s) [115.298185] [083/171] (891s left) kms_addfb_basic (small-bo) [115.500340] Starting subtest: small-bo [115.501364] Subtest small-bo: SUCCESS (0.000s) [115.582226] [084/171] (891s left) kms_addfb_basic (tile-pitch-mismatch) [115.714662] Starting subtest: tile-pitch-mismatch [115.715819] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [115.864832] [085/171] (891s left) kms_addfb_basic (too-high) [116.070479] Starting subtest: too-high [116.073241] Subtest too-high: SUCCESS (0.003s) [116.147368] [086/171] (891s left) kms_addfb_basic (too-wide) [116.344379] Starting subtest: too-wide [116.345447] Subtest too-wide: SUCCESS (0.000s) [116.431305] [087/171] (890s left) kms_addfb_basic (unused-handle) [116.565777] Starting subtest: unused-handle [116.567168] Subtest unused-handle: SUCCESS (0.001s) [116.714805] [088/171] (890s left) kms_addfb_basic (unused-modifier) [116.846996] Starting subtest: unused-modifier [116.848756] Subtest unused-modifier: SUCCESS (0.000s) [116.998200] [089/171] (890s left) kms_addfb_basic (unused-offsets) [117.129849] Starting subtest: unused-offsets [117.131119] Subtest unused-offsets: SUCCESS (0.000s) [117.281522] [090/171] (889s left) kms_addfb_basic (unused-pitches) [117.412453] Starting subtest: unused-pitches [117.413558] Subtest unused-pitches: SUCCESS (0.000s) [117.564854] [091/171] (889s left) kms_busy (basic) [117.781784] Starting subtest: basic [117.785629] Starting dynamic subtest: flip [118.667633] Dynamic subtest flip: SUCCESS (0.876s) [118.686870] Starting dynamic subtest: modeset [120.058709] Dynamic subtest modeset: SUCCESS (1.385s) [120.060603] Subtest basic: SUCCESS (2.272s) [120.243247] [092/171] (887s left) kms_chamelium_hpd (dp-hpd-fast) [120.668855] Subtest dp-hpd-fast: SKIP (0.000s) [120.813250] [093/171] (886s left) kms_chamelium_edid (dp-edid-read) [121.235579] Subtest dp-edid-read: SKIP (0.000s) [121.383820] [094/171] (885s left) kms_chamelium_frames (dp-crc-fast) [121.820166] Subtest dp-crc-fast: SKIP (0.000s) [121.970970] [095/171] (885s left) kms_chamelium_hpd (hdmi-hpd-fast) [122.393694] Subtest hdmi-hpd-fast: SKIP (0.000s) [122.546236] [096/171] (884s left) kms_chamelium_edid (hdmi-edid-read) [122.962647] Subtest hdmi-edid-read: SKIP (0.000s) [123.112489] [097/171] (884s left) kms_chamelium_frames (hdmi-crc-fast) [123.532955] Subtest hdmi-crc-fast: SKIP (0.000s) [123.684372] [098/171] (883s left) kms_chamelium_hpd (vga-hpd-fast) [124.108044] Subtest vga-hpd-fast: SKIP (0.000s) [124.244263] [099/171] (883s left) kms_chamelium_edid (vga-edid-read) [124.646635] Subtest vga-edid-read: SKIP (0.000s) [124.799407] [100/171] (882s left) kms_prop_blob (basic) [124.933227] Starting subtest: basic [124.934382] Subtest basic: SUCCESS (0.000s) [125.007127] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [125.201258] Starting subtest: basic-busy-flip-before-cursor-atomic [125.203547] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [125.274070] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [125.473250] Starting subtest: basic-busy-flip-before-cursor-legacy [125.475613] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [125.557540] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [125.756392] Starting subtest: basic-flip-after-cursor-atomic [126.954607] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.198s) [127.149552] [104/171] (880s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [127.354408] Starting subtest: basic-flip-after-cursor-legacy [128.539519] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.185s) [128.735177] [105/171] (878s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [128.936525] Starting subtest: basic-flip-after-cursor-varying-size [130.147189] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.212s) [130.327324] [106/171] (877s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [130.526056] Starting subtest: basic-flip-before-cursor-atomic [131.754447] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.228s) [131.951087] [107/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [132.149347] Starting subtest: basic-flip-before-cursor-legacy [133.346934] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.197s) [133.542187] [108/171] (874s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [133.744441] Starting subtest: basic-flip-before-cursor-varying-size [134.923620] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.180s) [135.121390] [109/171] (872s left) kms_flip (basic-flip-vs-dpms) [135.302907] Starting subtest: basic-flip-vs-dpms [135.308974] Starting dynamic subtest: A-HDMI-A2 [136.698454] Dynamic subtest A-HDMI-A2: SUCCESS (1.389s) [136.720875] Starting dynamic subtest: B-HDMI-A2 [137.850912] Dynamic subtest B-HDMI-A2: SUCCESS (1.138s) [137.875935] Starting dynamic subtest: C-HDMI-A2 [138.971462] Dynamic subtest C-HDMI-A2: SUCCESS (1.119s) [138.972574] Subtest basic-flip-vs-dpms: SUCCESS (3.669s) [139.174683] [110/171] (868s left) kms_flip (basic-flip-vs-modeset) [139.362810] Starting subtest: basic-flip-vs-modeset [139.369947] Starting dynamic subtest: A-HDMI-A2 [140.769118] Dynamic subtest A-HDMI-A2: SUCCESS (1.399s) [140.794038] Starting dynamic subtest: B-HDMI-A2 [141.833327] Dynamic subtest B-HDMI-A2: SUCCESS (1.048s) [141.855891] Starting dynamic subtest: C-HDMI-A2 [143.022783] Dynamic subtest C-HDMI-A2: SUCCESS (1.192s) [143.026672] Subtest basic-flip-vs-modeset: SUCCESS (3.661s) [143.236317] [111/171] (864s left) kms_flip (basic-flip-vs-wf_vblank) [143.423841] Starting subtest: basic-flip-vs-wf_vblank [143.430410] Starting dynamic subtest: A-HDMI-A2 [144.956476] Dynamic subtest A-HDMI-A2: SUCCESS (1.520s) [144.979870] Starting dynamic subtest: B-HDMI-A2 [146.387793] Dynamic subtest B-HDMI-A2: SUCCESS (1.432s) [146.414915] Starting dynamic subtest: C-HDMI-A2 [147.816747] Dynamic subtest C-HDMI-A2: SUCCESS (1.414s) [147.817991] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.388s) [148.192212] [112/171] (859s left) kms_flip (basic-plain-flip) [148.377992] Starting subtest: basic-plain-flip [148.384700] Starting dynamic subtest: A-HDMI-A2 [149.625797] Dynamic subtest A-HDMI-A2: SUCCESS (1.238s) [149.646888] Starting dynamic subtest: B-HDMI-A2 [150.785750] Dynamic subtest B-HDMI-A2: SUCCESS (1.150s) [150.805883] Starting dynamic subtest: C-HDMI-A2 [151.930925] Dynamic subtest C-HDMI-A2: SUCCESS (1.135s) [151.937569] Subtest basic-plain-flip: SUCCESS (3.553s) [152.343040] [113/171] (855s left) kms_force_connector_basic (force-connector-state) [152.596446] Starting subtest: force-connector-state [154.195520] Subtest force-connector-state: SUCCESS (1.599s) [154.787569] [114/171] (853s left) kms_force_connector_basic (force-edid) [155.042792] Starting subtest: force-edid [155.112829] Subtest force-edid: SUCCESS (0.072s) [155.387559] [115/171] (852s left) kms_force_connector_basic (force-load-detect) [155.640836] Starting subtest: force-load-detect [155.644386] Subtest force-load-detect: SKIP (0.000s) [155.920087] [116/171] (851s left) kms_force_connector_basic (prune-stale-modes) [156.174364] Starting subtest: prune-stale-modes [156.240362] Subtest prune-stale-modes: SUCCESS (0.065s) [156.519998] [117/171] (851s left) kms_frontbuffer_tracking (basic) [156.752723] Starting subtest: basic [159.565500] Subtest basic: SUCCESS (2.807s) [159.654357] [118/171] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [159.872061] Starting subtest: compare-crc-sanitycheck [159.875226] Starting dynamic subtest: pipe-A-HDMI-A-2 [160.474062] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.592s) [160.498152] Starting dynamic subtest: pipe-B-HDMI-A-2 [161.560508] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.078s) [161.587903] Starting dynamic subtest: pipe-C-HDMI-A-2 [163.022251] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.443s) [163.024130] Subtest compare-crc-sanitycheck: SUCCESS (3.151s) [163.225234] [119/171] (844s left) kms_pipe_crc_basic (hang-read-crc) [163.440443] Starting subtest: hang-read-crc [163.445970] Starting dynamic subtest: pipe-A-HDMI-A-2 [165.004063] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.557s) [165.027906] Starting dynamic subtest: pipe-B-HDMI-A-2 [166.829919] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.813s) [166.851873] Starting dynamic subtest: pipe-C-HDMI-A-2 [169.612214] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.775s) [169.613306] Subtest hang-read-crc: SUCCESS (6.171s) [169.884594] [120/171] (838s left) kms_pipe_crc_basic (nonblocking-crc) [170.105806] Starting subtest: nonblocking-crc [170.113104] Starting dynamic subtest: pipe-A-HDMI-A-2 [170.889101] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.777s) [170.911883] Starting dynamic subtest: pipe-B-HDMI-A-2 [172.172314] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.271s) [172.198878] Starting dynamic subtest: pipe-C-HDMI-A-2 [173.533250] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.348s) [173.534336] Subtest nonblocking-crc: SUCCESS (3.426s) [173.742780] [121/171] (834s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [173.970776] Starting subtest: nonblocking-crc-frame-sequence [173.975140] Starting dynamic subtest: pipe-A-HDMI-A-2 [174.737585] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.764s) [174.761874] Starting dynamic subtest: pipe-B-HDMI-A-2 [175.782156] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.032s) [175.806528] Starting dynamic subtest: pipe-C-HDMI-A-2 [177.059136] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.274s) [177.060190] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.091s) [177.263792] [122/171] (830s left) kms_pipe_crc_basic (read-crc) [177.486941] Starting subtest: read-crc [177.490770] Starting dynamic subtest: pipe-A-HDMI-A-2 [178.203534] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.713s) [178.227091] Starting dynamic subtest: pipe-B-HDMI-A-2 [179.262310] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.047s) [179.284973] Starting dynamic subtest: pipe-C-HDMI-A-2 [180.604068] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.328s) [180.605166] Subtest read-crc: SUCCESS (3.116s) [180.808245] [123/171] (827s left) kms_pipe_crc_basic (read-crc-frame-sequence) [181.025844] Starting subtest: read-crc-frame-sequence [181.031287] Starting dynamic subtest: pipe-A-HDMI-A-2 [181.746798] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.713s) [181.768874] Starting dynamic subtest: pipe-B-HDMI-A-2 [182.959293] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.205s) [182.985897] Starting dynamic subtest: pipe-C-HDMI-A-2 [184.081998] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.108s) [184.083240] Subtest read-crc-frame-sequence: SUCCESS (3.054s) [184.288859] [124/171] (823s left) kms_psr (primary_page_flip) [184.428267] Subtest primary_page_flip: SKIP (0.000s) [184.476196] [125/171] (823s left) kms_psr (cursor_plane_move) [184.612556] Subtest cursor_plane_move: SKIP (0.000s) [184.659473] [126/171] (823s left) kms_psr (sprite_plane_onoff) [184.791394] Subtest sprite_plane_onoff: SKIP (0.000s) [184.842689] [127/171] (823s left) kms_psr (primary_mmap_gtt) [184.975329] Subtest primary_mmap_gtt: SKIP (0.000s) [185.026072] [128/171] (823s left) kms_setmode (basic-clone-single-crtc) [185.161387] Starting subtest: basic-clone-single-crtc [185.165238] Subtest basic-clone-single-crtc: SKIP (0.000s) [185.237954] [129/171] (823s left) i915_pm_backlight (basic-brightness) [185.452089] Subtest basic-brightness: SKIP (0.000s) [185.492988] [130/171] (822s left) i915_pm_rpm (basic-pci-d3-state) [187.364244] Starting subtest: basic-pci-d3-state [188.063323] Subtest basic-pci-d3-state: SUCCESS (0.705s) [188.296917] [131/171] (820s left) i915_pm_rpm (basic-rte) [188.426764] Starting subtest: basic-rte [190.697899] Subtest basic-rte: SUCCESS (2.265s) [191.493123] [132/171] (816s left) i915_pm_rps (basic-api) [191.642768] Starting subtest: basic-api [191.654130] Subtest basic-api: SUCCESS (0.011s) [191.741438] [133/171] (816s left) prime_self_import (basic-llseek-bad) [191.875440] Starting subtest: basic-llseek-bad [191.883686] Subtest basic-llseek-bad: SUCCESS (0.008s) [191.958080] [134/171] (816s left) prime_self_import (basic-llseek-size) [192.089767] Starting subtest: basic-llseek-size [192.098493] Subtest basic-llseek-size: SUCCESS (0.009s) [192.174604] [135/171] (816s left) prime_self_import (basic-with_fd_dup) [192.309218] Starting subtest: basic-with_fd_dup [192.320941] Subtest basic-with_fd_dup: SUCCESS (0.012s) [192.407650] [136/171] (816s left) prime_self_import (basic-with_one_bo) [192.536916] Starting subtest: basic-with_one_bo [192.547952] Subtest basic-with_one_bo: SUCCESS (0.011s) [192.630077] [137/171] (815s left) prime_self_import (basic-with_one_bo_two_files) [192.757178] Starting subtest: basic-with_one_bo_two_files [192.768276] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s) [192.857918] [138/171] (815s left) prime_self_import (basic-with_two_bos) [192.989656] Starting subtest: basic-with_two_bos [192.999223] Subtest basic-with_two_bos: SUCCESS (0.010s) [193.074714] [139/171] (815s left) prime_vgem (basic-fence-flip) [193.233738] Starting subtest: basic-fence-flip [193.755600] Subtest basic-fence-flip: SUCCESS (0.522s) [193.842327] [140/171] (814s left) prime_vgem (basic-fence-mmap) [193.996521] Starting subtest: basic-fence-mmap [194.047574] Subtest basic-fence-mmap: SUCCESS (0.050s) [194.125592] [141/171] (814s left) prime_vgem (basic-fence-read) [194.282423] Starting subtest: basic-fence-read [194.367702] Subtest basic-fence-read: SUCCESS (0.083s) [194.442165] [142/171] (814s left) prime_vgem (basic-gtt) [194.609811] Starting subtest: basic-gtt [194.642776] Subtest basic-gtt: SUCCESS (0.032s) [194.724633] [143/171] (813s left) prime_vgem (basic-read) [194.875404] Starting subtest: basic-read [194.921863] Subtest basic-read: SUCCESS (0.046s) [195.008916] [144/171] (813s left) prime_vgem (basic-write) [195.160142] Starting subtest: basic-write [195.213358] Subtest basic-write: SUCCESS (0.053s) [195.291465] [145/171] (813s left) prime_vgem (basic-userptr) [195.445757] Starting subtest: basic-userptr [195.464523] Subtest basic-userptr: SKIP (0.018s) [195.563244] [146/171] (813s left) vgem_basic (setversion) [195.712809] Starting subtest: setversion [195.714997] Subtest setversion: SUCCESS (0.000s) [195.774618] [147/171] (812s left) vgem_basic (create) [195.912799] Starting subtest: create [195.915851] Subtest create: SUCCESS (0.002s) [195.974611] [148/171] (812s left) vgem_basic (debugfs) [196.112860] Starting subtest: debugfs [196.115957] Subtest debugfs: SUCCESS (0.002s) [196.174521] [149/171] (812s left) vgem_basic (dmabuf-export) [196.313228] Starting subtest: dmabuf-export [196.320418] Subtest dmabuf-export: SUCCESS (0.007s) [196.408824] [150/171] (812s left) vgem_basic (dmabuf-fence) [196.547871] Starting subtest: dmabuf-fence [196.549210] Subtest dmabuf-fence: SUCCESS (0.002s) [196.607967] [151/171] (812s left) vgem_basic (dmabuf-fence-before) [196.746117] Starting subtest: dmabuf-fence-before [196.749300] Subtest dmabuf-fence-before: SUCCESS (0.001s) [196.808121] [152/171] (812s left) vgem_basic (dmabuf-mmap) [196.946489] Starting subtest: dmabuf-mmap [196.978468] Subtest dmabuf-mmap: SUCCESS (0.032s) [197.041328] [153/171] (811s left) vgem_basic (mmap) [197.180854] Starting subtest: mmap [197.199560] Subtest mmap: SUCCESS (0.020s) [197.258669] [154/171] (811s left) vgem_basic (second-client) [197.396895] Starting subtest: second-client [197.444984] Subtest second-client: SUCCESS (0.049s) [197.508135] [155/171] (811s left) vgem_basic (sysfs) [197.646073] Starting subtest: sysfs [197.649084] Subtest sysfs: SUCCESS (0.003s) [197.708067] [156/171] (811s left) core_hotunplug (unbind-rebind) [197.929512] Starting subtest: unbind-rebind [199.548933] Subtest unbind-rebind: SUCCESS (1.619s) [199.641466] [157/171] (809s left) vgem_basic (unload) [199.960199] Starting subtest: unload [228.811794] Subtest unload: SUCCESS (28.851s) [228.930895] [158/171] (780s left) i915_module_load (reload) [229.068798] Starting subtest: reload [231.468878] Subtest reload: SUCCESS (2.397s) [231.502763] [159/171] (777s left) gem_lmem_swapping (basic) [231.868426] Subtest basic: SKIP (0.000s) [231.943897] [160/171] (777s left) gem_lmem_swapping (parallel-random-engines) [232.190265] Subtest parallel-random-engines: SKIP (0.000s) [232.231318] [161/171] (776s left) gem_lmem_swapping (random-engines) [232.371033] Subtest random-engines: SKIP (0.000s) [232.414634] [162/171] (776s left) gem_lmem_swapping (verify-random) [232.556694] Subtest verify-random: SKIP (0.000s) [232.597558] [163/171] (776s left) i915_pm_rpm (module-reload) [234.648802] Starting subtest: module-reload [242.746537] Subtest module-reload: SUCCESS (8.096s) [242.771577] [164/171] (766s left) i915_selftest (live) [242.927375] Starting subtest: live [242.930414] Starting dynamic subtest: sanitycheck [243.870144] Dynamic subtest sanitycheck: SUCCESS (0.938s) [243.884864] Starting dynamic subtest: uncore [244.772189] Dynamic subtest uncore: SUCCESS (0.901s) [244.785876] Starting dynamic subtest: workarounds [245.860743] Dynamic subtest workarounds: SUCCESS (1.088s) [245.878031] Starting dynamic subtest: gt_engines [247.224134] Dynamic subtest gt_engines: SUCCESS (1.362s) [247.234231] Starting dynamic subtest: gt_timelines [259.443995] Dynamic subtest gt_timelines: SUCCESS (12.217s) [259.455319] Starting dynamic subtest: gt_contexts [260.496787] Dynamic subtest gt_contexts: SUCCESS (1.052s) [260.507792] Starting dynamic subtest: gt_lrc [264.086064] Dynamic subtest gt_lrc: SUCCESS (3.588s) [264.096382] Starting dynamic subtest: gt_mocs [264.967077] Dynamic subtest gt_mocs: SUCCESS (0.881s) [264.981863] Starting dynamic subtest: gt_pm [272.745019] Dynamic subtest gt_pm: SUCCESS (7.776s) [272.755409] Starting dynamic subtest: gt_heartbeat [273.745057] Dynamic subtest gt_heartbeat: SUCCESS (1.000s) [273.754666] Starting dynamic subtest: requests [280.905062] Dynamic subtest requests: SUCCESS (7.158s) [280.916549] Starting dynamic subtest: migrate [284.591205] Dynamic subtest migrate: SUCCESS (3.684s) [284.601945] Starting dynamic subtest: active [285.407924] Dynamic subtest active: SUCCESS (0.817s) [285.422802] Starting dynamic subtest: objects [288.455730] Dynamic subtest objects: SUCCESS (3.045s) [288.466248] Starting dynamic subtest: mman [295.024704] Dynamic subtest mman: SUCCESS (6.568s) [295.035211] Starting dynamic subtest: dmabuf [295.833206] Dynamic subtest dmabuf: SUCCESS (0.809s) [295.849105] Starting dynamic subtest: vma [296.769507] Dynamic subtest vma: SUCCESS (0.935s) [296.780999] Starting dynamic subtest: coherency [299.867584] Dynamic subtest coherency: SUCCESS (3.095s) [299.878334] Starting dynamic subtest: gtt [310.111125] Dynamic subtest gtt: SUCCESS (10.245s) [310.123995] Starting dynamic subtest: gem [311.000200] Dynamic subtest gem: SUCCESS (0.886s) [311.015982] Starting dynamic subtest: evict [314.204047] Dynamic subtest evict: SUCCESS (3.202s) [314.214706] Starting dynamic subtest: hugepages [320.822912] Dynamic subtest hugepages: SUCCESS (6.617s) [320.833961] Starting dynamic subtest: gem_contexts [337.646664] Dynamic subtest gem_contexts: SUCCESS (16.822s) [337.657802] Starting dynamic subtest: client [338.526863] Dynamic subtest client: SUCCESS (0.881s) [338.543204] Starting dynamic subtest: gem_migrate [339.434157] Dynamic subtest gem_migrate: SUCCESS (0.906s) [339.451166] Starting dynamic subtest: reset [344.570949] Dynamic subtest reset: SUCCESS (5.135s) [344.582459] Starting dynamic subtest: memory_region [345.336043] Dynamic subtest memory_region: SUCCESS (0.765s) [345.351979] Starting dynamic subtest: hangcheck [369.200182] Dynamic subtest hangcheck: SUCCESS (23.862s) [369.211179] Starting dynamic subtest: execlists [379.007975] Dynamic subtest execlists: SUCCESS (9.806s) [379.022465] Starting dynamic subtest: ring_submission [379.811712] Dynamic subtest ring_submission: SUCCESS (0.805s) [379.828059] Starting dynamic subtest: perf [380.773090] Dynamic subtest perf: SUCCESS (0.960s) [380.787060] Starting dynamic subtest: slpc [381.589791] Dynamic subtest slpc: SUCCESS (0.816s) [381.606995] Starting dynamic subtest: guc [382.447199] Dynamic subtest guc: SUCCESS (0.856s) [382.463277] Starting dynamic subtest: guc_multi_lrc [383.250115] Dynamic subtest guc_multi_lrc: SUCCESS (0.802s) [383.268991] Starting dynamic subtest: guc_hang [384.048989] Dynamic subtest guc_hang: SUCCESS (0.798s) [384.063965] Starting dynamic subtest: late_gt_pm [384.807093] Dynamic subtest late_gt_pm: SUCCESS (0.757s) [384.808248] Subtest live: SUCCESS (141.878s) [384.873063] [165/171] (624s left) dmabuf (all-tests) [385.012588] Starting subtest: all-tests [385.015371] Starting dynamic subtest: sanitycheck [385.044560] Dynamic subtest sanitycheck: SUCCESS (0.029s) [385.060179] Starting dynamic subtest: dma_fence [385.192742] Dynamic subtest dma_fence: SUCCESS (0.139s) [385.203636] Starting dynamic subtest: dma_fence_chain [403.065060] Dynamic subtest dma_fence_chain: SUCCESS (17.862s) [403.081876] Starting dynamic subtest: dma_fence_unwrap [403.084333] Dynamic subtest dma_fence_unwrap: SUCCESS (0.023s) [403.104793] Starting dynamic subtest: dma_resv [403.110045] Dynamic subtest dma_resv: SUCCESS (0.027s) [403.111134] Subtest all-tests: SUCCESS (18.096s) [403.132741] [166/171] (606s left) i915_suspend (basic-s2idle-without-i915) [403.265182] Starting subtest: basic-s2idle-without-i915 [422.665956] Subtest basic-s2idle-without-i915: SUCCESS (3.997s) [429.913554] [167/171] (601s left) i915_suspend (basic-s3-without-i915) [430.054904] Starting subtest: basic-s3-without-i915 [450.032905] Subtest basic-s3-without-i915: SUCCESS (4.415s) [453.285728] [168/171] (597s left) gem_exec_suspend (basic-s0) [453.454464] Starting subtest: basic-S0 [453.458707] Starting dynamic subtest: smem [474.471025] Dynamic subtest smem: SUCCESS (4.687s) [474.472128] Subtest basic-S0: SUCCESS (4.689s) [479.272028] [169/171] (592s left) gem_exec_suspend (basic-s3) [479.423016] Starting subtest: basic-S3 [479.424973] Starting dynamic subtest: smem [500.817549] Dynamic subtest smem: SUCCESS (5.806s) [500.818671] Subtest basic-S3: SUCCESS (5.808s) [503.972196] [170/171] (586s left) kms_chamelium_hpd (common-hpd-after-suspend) [504.375459] Subtest common-hpd-after-suspend: SKIP (0.000s) [504.545209] [171/171] (585s left) kms_pipe_crc_basic (suspend-read-crc) [504.759868] Starting subtest: suspend-read-crc [504.765115] Starting dynamic subtest: pipe-A-HDMI-A-2 [525.502853] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.392s) [525.529006] Starting dynamic subtest: pipe-B-HDMI-A-2 [546.542192] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.723s) [546.568064] Starting dynamic subtest: pipe-C-HDMI-A-2 [567.892893] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.324s) [567.894041] Subtest suspend-read-crc: SUCCESS (14.466s) [570.076365] Closing watchdogs Done.