koji

#2931 [1.25.0] kojira flooding log files of the hub
Closed: Duplicate by tkopecek. Opened by frank-mdc.

Closed: Duplicate
Reopen Issue

When the kojirad runs. it will flooding the log of the hub with lines like this:

[Mon Jun 28 06:47:53.259097 2021] [wsgi:error] [pid 554427:tid 140094677690112] [client XXX:44622] 2021-06-28 06:47:53,258 [ERROR] m=None u=None p=554427 r=XXX:44622 koji.xmlrpc: original: <class '_mod_wsgi_df1c13776110deb1e020020636703560.ModXMLRPCRequestHandler'>

kojira itself will not report any errors.

If you enable debug, it is still this one line or is there some extended traceback?
Edited by tkopecek

Metadata Update from @tkopecek:
- Custom field Size adjusted to None

Hi, then I will see many more messages:

[Mon Jun 28 08:53:28.371780 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,371 [ERROR] m=None u=None p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: original: <class '_mod_wsgi_df1c13776110deb1e020020636703560.ModXMLRPCRequestHandler'>
[Mon Jun 28 08:53:28.372219 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,372 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b"\\n        SELECT authtype,callnum,exclusive,expired,master,start_time,EXTRACT(EPOCH FROM start_time),update_time,EXTRACT(EPOCH FROM update_time),user_id FROM sessions\\n        WHERE id = 1533\\n        AND key = '3-u3fKne3Avlv3nNQyx2Z'\\n        AND hostip = 'XX.XX.XX.XX'\\n        FOR UPDATE\\n        "
[Mon Jun 28 08:53:28.373632 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,373 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0013 seconds
[Mon Jun 28 08:53:28.373735 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,373 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.373826 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,373 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT name,status,usertype FROM users WHERE id=3'
[Mon Jun 28 08:53:28.374325 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,374 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.374403 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,374 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.374491 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,374 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT id FROM sessions WHERE user_id=3\\n            AND "exclusive" = TRUE AND expired = FALSE'
[Mon Jun 28 08:53:28.375078 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,375 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.375140 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,375 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.375217 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,375 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET update_time=NOW() WHERE id = 1533'
[Mon Jun 28 08:53:28.375859 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,375 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0006 seconds
[Mon Jun 28 08:53:28.377243 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,377 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET callnum=56 WHERE id = 1533'
[Mon Jun 28 08:53:28.378138 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,378 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0008 seconds
[Mon Jun 28 08:53:28.378225 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,378 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Handling method getExternalRepoList for session 1533 (#56)
[Mon Jun 28 08:53:28.378314 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,378 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Params: (22,)
[Mon Jun 28 08:53:28.378374 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,378 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Opts: {}
[Mon Jun 28 08:53:28.378544 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,378 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 22)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.379465 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,379 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0008 seconds
[Mon Jun 28 08:53:28.379535 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,379 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.379676 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,379 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 22)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.380898 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,380 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0011 seconds
[Mon Jun 28 08:53:28.380975 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,380 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.381102 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,381 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT parent_id,name,priority,maxdepth,intransitive,noconfig,pkg_filter FROM tag_inheritance JOIN tag ON parent_id = id\\n    WHERE (active = TRUE) AND tag_id = 22\\n    ORDER BY priority\\n    '
[Mon Jun 28 08:53:28.382949 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,382 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0018 seconds
[Mon Jun 28 08:53:28.383016 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,382 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.383173 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,383 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 22)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.384022 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,383 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0008 seconds
[Mon Jun 28 08:53:28.384091 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,384 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.384230 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,384 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 22)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.384730 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,384 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.384791 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,384 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.384950 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,384 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT arches, external_repo.id, external_repo.name, merge_mode, priority, tag.id, tag.name, url\\n  FROM tag_external_repos\\n  JOIN tag ON tag_external_repos.tag_id = tag.id\\n  JOIN external_repo ON tag_external_repos.external_repo_id = external_repo.id\\n  JOIN external_repo_config ON external_repo.id = external_repo_config.external_repo_id\\n WHERE ((external_repo_config.active = TRUE))\\n   AND ((tag_external_repos.active = TRUE))\\n   AND (tag.id = 22)\\n \\n ORDER BY priority\\n\\n \\n'
[Mon Jun 28 08:53:28.387238 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,387 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0022 seconds
[Mon Jun 28 08:53:28.387308 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,387 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.387411 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,387 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Completed method getExternalRepoList for session 1533 (#56): 0.008974 seconds, rss 55032, stime 0.087411
[Mon Jun 28 08:53:28.387691 2021] [wsgi:error] [pid 593499:tid 140349179680512] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,387 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Returning 2309 bytes after 0.017097 seconds
[Mon Jun 28 08:53:28.498621 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,498 [ERROR] m=None u=None p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: original: <class '_mod_wsgi_df1c13776110deb1e020020636703560.ModXMLRPCRequestHandler'>
[Mon Jun 28 08:53:28.499005 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,498 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b"\\n        SELECT authtype,callnum,exclusive,expired,master,start_time,EXTRACT(EPOCH FROM start_time),update_time,EXTRACT(EPOCH FROM update_time),user_id FROM sessions\\n        WHERE id = 1533\\n        AND key = '3-u3fKne3Avlv3nNQyx2Z'\\n        AND hostip = 'XX.XX.XX.XX'\\n        FOR UPDATE\\n        "
[Mon Jun 28 08:53:28.500377 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,500 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0012 seconds
[Mon Jun 28 08:53:28.500495 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,500 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.500593 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,500 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT name,status,usertype FROM users WHERE id=3'
[Mon Jun 28 08:53:28.501054 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,501 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.501118 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,501 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.501217 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,501 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT id FROM sessions WHERE user_id=3\\n            AND "exclusive" = TRUE AND expired = FALSE'
[Mon Jun 28 08:53:28.501772 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,501 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.501827 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,501 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.501911 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,501 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET update_time=NOW() WHERE id = 1533'
[Mon Jun 28 08:53:28.502530 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,502 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.503523 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,503 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET callnum=57 WHERE id = 1533'
[Mon Jun 28 08:53:28.504284 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,504 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0007 seconds
[Mon Jun 28 08:53:28.504372 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,504 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Handling method getExternalRepoList for session 1533 (#57)
[Mon Jun 28 08:53:28.504472 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,504 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Params: (12,)
[Mon Jun 28 08:53:28.504534 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,504 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Opts: {}
[Mon Jun 28 08:53:28.504702 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,504 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 12)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.505607 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,505 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0008 seconds
[Mon Jun 28 08:53:28.505680 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,505 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.505828 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,505 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 12)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.506375 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,506 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.506440 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,506 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.506561 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,506 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT parent_id,name,priority,maxdepth,intransitive,noconfig,pkg_filter FROM tag_inheritance JOIN tag ON parent_id = id\\n    WHERE (active = TRUE) AND tag_id = 12\\n    ORDER BY priority\\n    '
[Mon Jun 28 08:53:28.507385 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,507 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0008 seconds
[Mon Jun 28 08:53:28.507448 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,507 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.507605 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,507 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 12)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.508394 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,508 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0007 seconds
[Mon Jun 28 08:53:28.508458 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,508 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.508600 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,508 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 12)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.509007 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,508 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:28.509069 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,509 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.509226 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,509 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT arches, external_repo.id, external_repo.name, merge_mode, priority, tag.id, tag.name, url\\n  FROM tag_external_repos\\n  JOIN tag ON tag_external_repos.tag_id = tag.id\\n  JOIN external_repo ON tag_external_repos.external_repo_id = external_repo.id\\n  JOIN external_repo_config ON external_repo.id = external_repo_config.external_repo_id\\n WHERE ((external_repo_config.active = TRUE))\\n   AND ((tag_external_repos.active = TRUE))\\n   AND (tag.id = 12)\\n \\n ORDER BY priority\\n\\n \\n'
[Mon Jun 28 08:53:28.510566 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,510 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0013 seconds
[Mon Jun 28 08:53:28.510638 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,510 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.510769 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,510 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Completed method getExternalRepoList for session 1533 (#57): 0.006169 seconds, rss 55032, stime 0.088486
[Mon Jun 28 08:53:28.511131 2021] [wsgi:error] [pid 593499:tid 140349171287808] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,511 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Returning 5144 bytes after 0.013759 seconds
[Mon Jun 28 08:53:28.795812 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,795 [ERROR] m=None u=None p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: original: <class '_mod_wsgi_df1c13776110deb1e020020636703560.ModXMLRPCRequestHandler'>
[Mon Jun 28 08:53:28.796188 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,796 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b"\\n        SELECT authtype,callnum,exclusive,expired,master,start_time,EXTRACT(EPOCH FROM start_time),update_time,EXTRACT(EPOCH FROM update_time),user_id FROM sessions\\n        WHERE id = 1533\\n        AND key = '3-u3fKne3Avlv3nNQyx2Z'\\n        AND hostip = 'XX.XX.XX.XX'\\n        FOR UPDATE\\n        "
[Mon Jun 28 08:53:28.797649 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,797 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0013 seconds
[Mon Jun 28 08:53:28.797754 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,797 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.797856 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,797 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT name,status,usertype FROM users WHERE id=3'
[Mon Jun 28 08:53:28.798410 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,798 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.798497 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,798 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.798591 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,798 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT id FROM sessions WHERE user_id=3\\n            AND "exclusive" = TRUE AND expired = FALSE'
[Mon Jun 28 08:53:28.799186 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,799 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.799250 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,799 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.799323 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,799 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET update_time=NOW() WHERE id = 1533'
[Mon Jun 28 08:53:28.799948 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,799 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0006 seconds
[Mon Jun 28 08:53:28.800835 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,800 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET callnum=58 WHERE id = 1533'
[Mon Jun 28 08:53:28.801734 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,801 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0008 seconds
[Mon Jun 28 08:53:28.801820 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,801 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Handling method getExternalRepoList for session 1533 (#58)
[Mon Jun 28 08:53:28.801910 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,801 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Params: (8,)
[Mon Jun 28 08:53:28.801985 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,801 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Opts: {}
[Mon Jun 28 08:53:28.802171 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,802 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 8)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.803963 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,803 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0017 seconds
[Mon Jun 28 08:53:28.804035 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,803 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.804175 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,804 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 8)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.805232 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,805 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0010 seconds
[Mon Jun 28 08:53:28.805300 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,805 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.805443 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,805 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT parent_id,name,priority,maxdepth,intransitive,noconfig,pkg_filter FROM tag_inheritance JOIN tag ON parent_id = id\\n    WHERE (active = TRUE) AND tag_id = 8\\n    ORDER BY priority\\n    '
[Mon Jun 28 08:53:28.807172 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,807 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0017 seconds
[Mon Jun 28 08:53:28.807236 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,807 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.807379 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,807 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 8)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.808104 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,808 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0007 seconds
[Mon Jun 28 08:53:28.808169 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,808 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.808289 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,808 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 8)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.808761 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,808 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.808821 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,808 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.809001 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,808 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT arches, external_repo.id, external_repo.name, merge_mode, priority, tag.id, tag.name, url\\n  FROM tag_external_repos\\n  JOIN tag ON tag_external_repos.tag_id = tag.id\\n  JOIN external_repo ON tag_external_repos.external_repo_id = external_repo.id\\n  JOIN external_repo_config ON external_repo.id = external_repo_config.external_repo_id\\n WHERE ((external_repo_config.active = TRUE))\\n   AND ((tag_external_repos.active = TRUE))\\n   AND (tag.id = 8)\\n \\n ORDER BY priority\\n\\n \\n'
[Mon Jun 28 08:53:28.811478 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,811 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0024 seconds
[Mon Jun 28 08:53:28.811549 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,811 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.811650 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,811 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Completed method getExternalRepoList for session 1533 (#58): 0.009589 seconds, rss 55032, stime 0.089416
[Mon Jun 28 08:53:28.811950 2021] [wsgi:error] [pid 593499:tid 140349162895104] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,811 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Returning 3650 bytes after 0.017301 seconds
[Mon Jun 28 08:53:28.978283 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,978 [ERROR] m=None u=None p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: original: <class '_mod_wsgi_df1c13776110deb1e020020636703560.ModXMLRPCRequestHandler'>
[Mon Jun 28 08:53:28.978631 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,978 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b"\\n        SELECT authtype,callnum,exclusive,expired,master,start_time,EXTRACT(EPOCH FROM start_time),update_time,EXTRACT(EPOCH FROM update_time),user_id FROM sessions\\n        WHERE id = 1533\\n        AND key = '3-u3fKne3Avlv3nNQyx2Z'\\n        AND hostip = 'XX.XX.XX.XX'\\n        FOR UPDATE\\n        "
[Mon Jun 28 08:53:28.980827 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,980 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0021 seconds
[Mon Jun 28 08:53:28.980925 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,980 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.981048 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,981 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT name,status,usertype FROM users WHERE id=3'
[Mon Jun 28 08:53:28.981597 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,981 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.981663 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,981 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.981751 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,981 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT id FROM sessions WHERE user_id=3\\n            AND "exclusive" = TRUE AND expired = FALSE'
[Mon Jun 28 08:53:28.982421 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,982 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0006 seconds
[Mon Jun 28 08:53:28.982485 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,982 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.982561 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,982 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET update_time=NOW() WHERE id = 1533'
[Mon Jun 28 08:53:28.983284 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,983 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0007 seconds
[Mon Jun 28 08:53:28.984302 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,984 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET callnum=59 WHERE id = 1533'
[Mon Jun 28 08:53:28.985254 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,985 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0009 seconds
[Mon Jun 28 08:53:28.985366 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,985 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Handling method getExternalRepoList for session 1533 (#59)
[Mon Jun 28 08:53:28.985453 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,985 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Params: (9,)
[Mon Jun 28 08:53:28.985514 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,985 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Opts: {}
[Mon Jun 28 08:53:28.985707 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,985 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 9)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.986495 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,986 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0007 seconds
[Mon Jun 28 08:53:28.986573 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,986 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.986711 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,986 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 9)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.987182 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,987 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.987254 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,987 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.987393 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,987 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT parent_id,name,priority,maxdepth,intransitive,noconfig,pkg_filter FROM tag_inheritance JOIN tag ON parent_id = id\\n    WHERE (active = TRUE) AND tag_id = 9\\n    ORDER BY priority\\n    '
[Mon Jun 28 08:53:28.987985 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,987 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.988053 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,988 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.988199 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,988 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 9)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.988809 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,988 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:28.988874 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,988 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.989007 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,988 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 9)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:28.989424 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,989 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:28.989488 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,989 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.989655 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,989 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT arches, external_repo.id, external_repo.name, merge_mode, priority, tag.id, tag.name, url\\n  FROM tag_external_repos\\n  JOIN tag ON tag_external_repos.tag_id = tag.id\\n  JOIN external_repo ON tag_external_repos.external_repo_id = external_repo.id\\n  JOIN external_repo_config ON external_repo.id = external_repo_config.external_repo_id\\n WHERE ((external_repo_config.active = TRUE))\\n   AND ((tag_external_repos.active = TRUE))\\n   AND (tag.id = 9)\\n \\n ORDER BY priority\\n\\n \\n'
[Mon Jun 28 08:53:28.990837 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,990 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0010 seconds
[Mon Jun 28 08:53:28.990930 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,990 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.991045 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,991 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Completed method getExternalRepoList for session 1533 (#59): 0.005470 seconds, rss 55032, stime 0.091443
[Mon Jun 28 08:53:28.991346 2021] [wsgi:error] [pid 593499:tid 140349146109696] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,991 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Returning 2939 bytes after 0.014359 seconds
[Mon Jun 28 08:53:28.994882 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,994 [ERROR] m=None u=None p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: original: <class '_mod_wsgi_df1c13776110deb1e020020636703560.ModXMLRPCRequestHandler'>
[Mon Jun 28 08:53:28.995223 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,995 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b"\\n        SELECT authtype,callnum,exclusive,expired,master,start_time,EXTRACT(EPOCH FROM start_time),update_time,EXTRACT(EPOCH FROM update_time),user_id FROM sessions\\n        WHERE id = 1533\\n        AND key = '3-u3fKne3Avlv3nNQyx2Z'\\n        AND hostip = 'XX.XX.XX.XX'\\n        FOR UPDATE\\n        "
[Mon Jun 28 08:53:28.996386 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,996 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0011 seconds
[Mon Jun 28 08:53:28.996482 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,996 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.996568 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,996 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT name,status,usertype FROM users WHERE id=3'
[Mon Jun 28 08:53:28.996931 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,996 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:28.997000 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,996 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.997090 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,997 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT id FROM sessions WHERE user_id=3\\n            AND "exclusive" = TRUE AND expired = FALSE'
[Mon Jun 28 08:53:28.997461 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,997 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:28.997515 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,997 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:28.997591 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,997 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET update_time=NOW() WHERE id = 1533'
[Mon Jun 28 08:53:28.998037 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,997 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.998751 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,998 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET callnum=60 WHERE id = 1533'
[Mon Jun 28 08:53:28.999265 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,999 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:28.999345 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,999 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Handling method getExternalRepoList for session 1533 (#60)
[Mon Jun 28 08:53:28.999439 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,999 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Params: (21,)
[Mon Jun 28 08:53:28.999498 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,999 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Opts: {}
[Mon Jun 28 08:53:28.999648 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:28,999 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 21)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.000244 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,000 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:29.000316 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,000 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.000451 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,000 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 21)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.000835 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,000 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:29.000893 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,000 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.001038 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,001 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT parent_id,name,priority,maxdepth,intransitive,noconfig,pkg_filter FROM tag_inheritance JOIN tag ON parent_id = id\\n    WHERE (active = TRUE) AND tag_id = 21\\n    ORDER BY priority\\n    '
[Mon Jun 28 08:53:29.001566 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,001 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:29.001624 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,001 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.001773 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,001 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 21)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.002292 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,002 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:29.002358 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,002 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.002489 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,002 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 21)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.002855 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,002 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:29.002922 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,002 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.003107 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,003 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT arches, external_repo.id, external_repo.name, merge_mode, priority, tag.id, tag.name, url\\n  FROM tag_external_repos\\n  JOIN tag ON tag_external_repos.tag_id = tag.id\\n  JOIN external_repo ON tag_external_repos.external_repo_id = external_repo.id\\n  JOIN external_repo_config ON external_repo.id = external_repo_config.external_repo_id\\n WHERE ((external_repo_config.active = TRUE))\\n   AND ((tag_external_repos.active = TRUE))\\n   AND (tag.id = 21)\\n \\n ORDER BY priority\\n\\n \\n'
[Mon Jun 28 08:53:29.003983 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,003 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0008 seconds
[Mon Jun 28 08:53:29.004051 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,004 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.004154 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,004 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Completed method getExternalRepoList for session 1533 (#60): 0.004591 seconds, rss 55032, stime 0.092367
[Mon Jun 28 08:53:29.004421 2021] [wsgi:error] [pid 593499:tid 140348592486144] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,004 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Returning 2309 bytes after 0.010399 seconds
[Mon Jun 28 08:53:29.112444 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,112 [ERROR] m=None u=None p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: original: <class '_mod_wsgi_df1c13776110deb1e020020636703560.ModXMLRPCRequestHandler'>
[Mon Jun 28 08:53:29.112808 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,112 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b"\\n        SELECT authtype,callnum,exclusive,expired,master,start_time,EXTRACT(EPOCH FROM start_time),update_time,EXTRACT(EPOCH FROM update_time),user_id FROM sessions\\n        WHERE id = 1533\\n        AND key = '3-u3fKne3Avlv3nNQyx2Z'\\n        AND hostip = 'XX.XX.XX.XX'\\n        FOR UPDATE\\n        "
[Mon Jun 28 08:53:29.114061 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,113 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0011 seconds
[Mon Jun 28 08:53:29.114159 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,114 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.114261 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,114 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT name,status,usertype FROM users WHERE id=3'
[Mon Jun 28 08:53:29.114631 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,114 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:29.114698 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,114 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.114790 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,114 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT id FROM sessions WHERE user_id=3\\n            AND "exclusive" = TRUE AND expired = FALSE'
[Mon Jun 28 08:53:29.115147 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,115 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:29.115205 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,115 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchone operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.115283 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,115 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET update_time=NOW() WHERE id = 1533'
[Mon Jun 28 08:53:29.115707 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,115 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:29.116413 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,116 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: b'UPDATE sessions SET callnum=61 WHERE id = 1533'
[Mon Jun 28 08:53:29.116875 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,116 [DEBUG] m=getExternalRepoList u=None p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:29.116966 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,116 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Handling method getExternalRepoList for session 1533 (#61)
[Mon Jun 28 08:53:29.117061 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,117 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Params: (13,)
[Mon Jun 28 08:53:29.117122 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,117 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Opts: {}
[Mon Jun 28 08:53:29.117296 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,117 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 13)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.117862 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,117 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0005 seconds
[Mon Jun 28 08:53:29.117924 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,117 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.118082 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,118 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 13)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.118468 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,118 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:29.118528 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,118 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.118640 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,118 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'SELECT parent_id,name,priority,maxdepth,intransitive,noconfig,pkg_filter FROM tag_inheritance JOIN tag ON parent_id = id\\n    WHERE (active = TRUE) AND tag_id = 13\\n    ORDER BY priority\\n    '
[Mon Jun 28 08:53:29.119109 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,119 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:29.119171 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,119 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.119323 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,119 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT tag_config.arches, tag.id, tag_config.locked, tag_config.maven_include_all, tag_config.maven_support, tag.name, permissions.name, tag_config.perm_id\\n  FROM tag_config\\n  JOIN tag ON tag.id = tag_config.tag_id\\n  LEFT OUTER JOIN permissions ON tag_config.perm_id = permissions.id\\n WHERE ((tag_config.active = TRUE))\\n   AND (tag.id = 13)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.119789 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,119 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0004 seconds
[Mon Jun 28 08:53:29.119848 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,119 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.119985 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,119 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT CASE WHEN value IS NULL THEN TRUE ELSE FALSE END, key, value\\n  FROM tag_extra\\n\\n WHERE ((tag_extra.active = TRUE))\\n   AND (tag_id = 13)\\n   AND (value IS NOT NULL)\\n \\n \\n\\n \\n'
[Mon Jun 28 08:53:29.120355 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,120 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0003 seconds
[Mon Jun 28 08:53:29.120413 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,120 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.120571 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,120 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: b'\\nSELECT arches, external_repo.id, external_repo.name, merge_mode, priority, tag.id, tag.name, url\\n  FROM tag_external_repos\\n  JOIN tag ON tag_external_repos.tag_id = tag.id\\n  JOIN external_repo ON tag_external_repos.external_repo_id = external_repo.id\\n  JOIN external_repo_config ON external_repo.id = external_repo_config.external_repo_id\\n WHERE ((external_repo_config.active = TRUE))\\n   AND ((tag_external_repos.active = TRUE))\\n   AND (tag.id = 13)\\n \\n ORDER BY priority\\n\\n \\n'
[Mon Jun 28 08:53:29.121341 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,121 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: Execute operation completed in 0.0007 seconds
[Mon Jun 28 08:53:29.121414 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,121 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.db: fetchall operation completed in 0.0000 seconds
[Mon Jun 28 08:53:29.121525 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,121 [INFO] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Completed method getExternalRepoList for session 1533 (#61): 0.004333 seconds, rss 55032, stime 0.093452
[Mon Jun 28 08:53:29.121852 2021] [wsgi:error] [pid 593499:tid 140348584093440] [client XX.XX.XX.XX:39926] 2021-06-28 08:53:29,121 [DEBUG] m=getExternalRepoList u=kojira.foo.foo p=593499 r=XX.XX.XX.XX:39926 koji.xmlrpc: Returning 5144 bytes after 0.010671 seconds

this should be a duplicate of #2929

Metadata Update from @tkopecek:
- Issue close_status updated to: Duplicate
- Issue status updated to: Closed (was: Open)

This issue has been migrated to Fedora Forge:
https://forge.fedoraproject.org/koji/koji/issues/2931

Please continue any further discussion there.
Metadata
None
None
None
None
Low
None
Static archive. pagure.io was sunset in 2026; this is a read-only snapshot.
Red Hat Logo

Fedora is sponsored by Red Hat. Learn more about the relationship between Red Hat and Fedora »

© Red Hat, Inc. and others.