bitbucket-branch-source-plugin icon indicating copy to clipboard operation
bitbucket-branch-source-plugin copied to clipboard

Bitbucket users being blocked on "Scan Organization Folder" and pipelines

Open ricardojdsilva87 opened this issue 4 years ago • 18 comments

Your checklist for this issue

  • [x] Jenkins version 2.245

  • [x] Plugin version 2.9.0

  • [x] Bitbucket cloud 7.2.0

  • [ ] Bitbucket server and version

Description

Hello Since around 3 weeks ago we started having a strange behaviour on bitbucket checkout, the users started being blocked in the scanning organization selection with the following error:

ERROR: [Mon Jul 27 12:36:33 CEST 2020] Could not refresh actions for navigator com.cloudbees.jenkins.plugins.bitbucket.BitbucketSCMNavigator@248cc3ec
com.cloudbees.jenkins.plugins.bitbucket.api.BitbucketRequestException: HTTP request error. Status: 401: .
HttpResponseProxy{HTTP/1.1 401  [Content-Type: application/json;charset=UTF-8, Date: Mon, 27 Jul 2020 10:36:33 GMT, vary: accept-encoding, WWW-Authenticate: Basic realm="Atlassian Bitbucket", X-AREQUESTID: @IC7BIZx756x5439124x0, X-ASEN: SEN-9644435, transfer-encoding: chunked, Connection: keep-alive] org.apache.http.client.entity.DecompressingEntity@635d13df}
	at com.cloudbees.jenkins.plugins.bitbucket.server.client.BitbucketServerAPIClient.getRequest(BitbucketServerAPIClient.java:862)
	at com.cloudbees.jenkins.plugins.bitbucket.server.client.BitbucketServerAPIClient.getTeam(BitbucketServerAPIClient.java:734)
Caused: java.io.IOException: I/O error when accessing URL: /rest/api/1.0/projects/OW-APPS-SAMS
	at com.cloudbees.jenkins.plugins.bitbucket.server.client.BitbucketServerAPIClient.getTeam(BitbucketServerAPIClient.java:739)
	at com.cloudbees.jenkins.plugins.bitbucket.BitbucketSCMNavigator.retrieveActions(BitbucketSCMNavigator.java:539)
	at jenkins.scm.api.SCMNavigator.fetchActions(SCMNavigator.java:332)
	at jenkins.branch.OrganizationFolder.computeChildren(OrganizationFolder.java:440)
	at com.cloudbees.hudson.plugins.folder.computed.ComputedFolder.updateChildren(ComputedFolder.java:278)
	at com.cloudbees.hudson.plugins.folder.computed.FolderComputation.run(FolderComputation.java:165)
	at jenkins.branch.OrganizationFolder$OrganizationScan.run(OrganizationFolder.java:970)
	at hudson.model.ResourceController.execute(ResourceController.java:97)

Sometimes the error that appears is related to the captcha selection. This means that the username/password were entered incorrectly too many times. Thing here is that if we manually access bitbucket, the same password that is configured on Jenkins works with no issue and we can unblock the user. This seems to be random and we are not sure why it started happening, we've already rolled back plugin and jenkins versions with no luck. We have also tried using the passwords in CASC files and using the AWS secrets manager and again the behaviour is the same. Asking the bitbucket team they showed us that the user/password were being received incorrectly, meaning that Jenkins/bitbucket plugin is sending the incorrect information.

Not sure what to look for next. Anyone have the same issue? Thanks

ricardojdsilva87 avatar Jul 27 '20 10:07 ricardojdsilva87

@ricardojdsilva87

Asking the bitbucket team they showed us that the user/password were being received incorrectly, meaning that Jenkins/bitbucket plugin is sending the incorrect information.

Please provide more detail about how they are being sent incorrectly.

Could this be related to #328 ?

bitwiseman avatar Jul 27 '20 22:07 bitwiseman

Hello @bitwiseman, Seems that the issue might be related to this: https://github.com/jenkinsci/bitbucket-branch-source-plugin/issues/183#issuecomment-542485398 The bitbucket team showed us the logs and it seems that the avatar request integrated in the scm plugin is doing several retries without user and password leading to the user being blocked and thus being noticeable in the branch-source plugin. We'll see what we can do to workaround on this. Thanks for the help, I'll close the issue

ricardojdsilva87 avatar Jul 28 '20 10:07 ricardojdsilva87

@bitwiseman sorry to bring this up again, but is there any possibility that the avatars are part of the bitbucket-branch-source plugin? I've checked the code and it seems that the URL is built here: https://github.com/jenkinsci/bitbucket-branch-source-plugin/blob/53773c8b9fca9965a8b0808ad71f5f02745b3913/src/main/java/com/cloudbees/jenkins/plugins/bitbucket/avatars/AvatarCache.java#L161

Not sure how to do it, but is there the possibility to use also the credentials configured to build the pipelines? Thanks

ricardojdsilva87 avatar Jul 28 '20 14:07 ricardojdsilva87

@ricardojdsilva87
Yeah, the call stacks for branch source plugins can get pretty wild.

This is actually the call that fetches the image: https://github.com/jenkinsci/bitbucket-branch-source-plugin/blob/53773c8b9fca9965a8b0808ad71f5f02745b3913/src/main/java/com/cloudbees/jenkins/plugins/bitbucket/avatars/AvatarCache.java#L624

And that calls into AvatarCacheSource.fetch(): https://github.com/jenkinsci/bitbucket-branch-source-plugin/blob/53773c8b9fca9965a8b0808ad71f5f02745b3913/src/main/java/com/cloudbees/jenkins/plugins/bitbucket/avatars/AvatarCacheSource.java#L56

AvatarCacheSource is implemented in two places in this plugin.

BitbucketTeamMetadataAction.BitbucketAvatarCacheSource : https://github.com/jenkinsci/bitbucket-branch-source-plugin/blob/53773c8b9fca9965a8b0808ad71f5f02745b3913/src/main/java/com/cloudbees/jenkins/plugins/bitbucket/BitbucketTeamMetadataAction.java#L61

UrlAvatarCacheSource https://github.com/jenkinsci/bitbucket-branch-source-plugin/blob/53773c8b9fca9965a8b0808ad71f5f02745b3913/src/main/java/com/cloudbees/jenkins/plugins/bitbucket/avatars/UrlAvatarCacheSource.java#L43

If you look at the first one, it implements an AvatarCacheSource that includes credentials. So, we have at least one example of how it can be done.

What we don't know is whether credentials are available where UrlAvatarCacheSource is being constructed so they could be added, but it seems possible.

Can you get the FINE level logs from UrlAvatarCacheSource so maybe we can figure out when the calls are being made?

bitwiseman avatar Jul 28 '20 17:07 bitwiseman

The comment above was for versions prior to 2.6.0 - since then getting Avatars should be using same credentials as other calls. Is it possible something else is causing trigger of the captcha at which point Avatar code is stuck and starts hammering it because it cannot authenticate? Alternatively is it possible you have one of the jobs with invalid credentials?

The only other thing I can think of is that API changed and it, for some reason, triggers an authentication required instead of invalid request.

mlasevich avatar Jul 28 '20 19:07 mlasevich

This sounds similar to the issue described in more detail here: https://github.com/jenkinsci/bitbucket-branch-source-plugin/issues/321

The avatar code stores a copy of the credential and it uses that rather than the value from the credential store. So when the password is updated, the avatar fetch continues to use the old value of the credential. There is a workaround explained in the linked issue. But in the end because we have many Jenkins instances & it was causing lots of catpcha's, we blocked requests for avatar.png from Jenkins user agents as another workaround.

Cyanoth avatar Jul 29 '20 09:07 Cyanoth

@Cyanoth , Thanks for the tip. We have around 150 users in this case, we'll check if that workaround makes any diference in the behaviour. I've did a little test and in fact the state.xml is only updated if there is another correct credential saved and a "scan organization" is triggered. After that I've put back the original credential. I'll check the behaviour and let you know about how it went.

Update: Checking the before and after state.xml we have the following: Before:

<jenkins.branch.OrganizationFolder_-State plugin="[email protected]">
  <actions>
    <entry>
      <string>com.cloudbees.jenkins.plugins.bitbucket.BitbucketSCMNavigator::URL</string>
      <list>
        <jenkins.scm.api.metadata.ObjectMetadataAction plugin="[email protected]">
          <objectDisplayName>NAME</objectDisplayName>
          <objectUrl>URL</objectUrl>
        </jenkins.scm.api.metadata.ObjectMetadataAction>
        <com.cloudbees.jenkins.plugins.bitbucket.BitbucketTeamMetadataAction plugin="[email protected]">
          <avatarSource>
            <serverUrl>URL</serverUrl>
            <credentials class="com.cloudbees.plugins.credentials.impl.UsernamePasswordCredentialsImpl" plugin="[email protected]">
              <scope>GLOBAL</scope>
              <id>ID</id>
              <description>DESCRIPTION</description>
              <username>USER</username>
              <password>PASSWORD_HASH</password>
            </credentials>
            <repoOwner>OWNER</repoOwner>
          </avatarSource>
        </com.cloudbees.jenkins.plugins.bitbucket.BitbucketTeamMetadataAction>
        <com.cloudbees.jenkins.plugins.bitbucket.BitbucketLink plugin="[email protected]">
          <iconClassName>icon-bitbucket-logo</iconClassName>
          <url>URL</url>
        </com.cloudbees.jenkins.plugins.bitbucket.BitbucketLink>
      </list>
    </entry>
  </actions>
</jenkins.branch.OrganizationFolder_-State>

After:

<?xml version='1.1' encoding='UTF-8'?>
<jenkins.branch.OrganizationFolder_-State plugin="[email protected]">
  <actions>
    <entry>
      <string>com.cloudbees.jenkins.plugins.bitbucket.BitbucketSCMNavigator::URL</string>
      <list>
        <jenkins.scm.api.metadata.ObjectMetadataAction plugin="[email protected]">
          <objectDisplayName>iNAME</objectDisplayName>
          <objectUrl>URL</objectUrl>
        </jenkins.scm.api.metadata.ObjectMetadataAction>
        <com.cloudbees.jenkins.plugins.bitbucket.BitbucketTeamMetadataAction plugin="[email protected]">
          <avatarSource>
            <serverUrl>URL</serverUrl>
            <credentials class="com.cloudbees.plugins.credentials.impl.UsernamePasswordCredentialsImpl" plugin="[email protected]">
              <scope>GLOBAL</scope>
              <id>ID</id>
              <description>DESCRIPTION</description>
              <username>USERNAME</username>
              <password>PASSWORD_HASH</password>
            </credentials>
            <repoOwner>OWNER</repoOwner>
          </avatarSource>
        </com.cloudbees.jenkins.plugins.bitbucket.BitbucketTeamMetadataAction>
        <com.cloudbees.jenkins.plugins.bitbucket.BitbucketLink plugin="[email protected]">
          <iconClassName>icon-bitbucket-logo</iconClassName>
          <url>URL</url>
        </com.cloudbees.jenkins.plugins.bitbucket.BitbucketLink>
      </list>
    </entry>
  </actions>
</jenkins.branch.OrganizationFolder_-State>

It seems that after switching the user, every field was updated, thing is that this works only if the user have the same username/password. Seems odd to me since we did not changed the passwords. We'll check on the following days what is the behaviour.

Thanks

ricardojdsilva87 avatar Jul 29 '20 11:07 ricardojdsilva87

That makes sense. It should be possible to fix. I will take a look at the code.

mlasevich avatar Jul 29 '20 13:07 mlasevich

So, I may need some help here... Upon looking at the code, Avatar Cache gets a StandardCredentials object when creating the action and then keeps it for fetching cache as needed. It would be my assumption that if the underlying credentials were changed, this object would be updated behind the scenes by Jenkins, but you know what they say about assumptions...

So the question is - if StandardCredentials is not kept up to date, is there way to refresh it? If not I am looking at making BitbucketCredentials into an object instead of just a class with static methods and cache the items needed to fetch the credentials instead of credentials themselves. Then fetch credentials every time we use them - which should fix the issue. (Assuming it is safe to cache SCMSourceOwner... here we go assuming again)

What do you think, @bitwiseman ?

mlasevich avatar Jul 29 '20 14:07 mlasevich

@ricardojdsilva87 Use triple-backtick for your multiline code blocks (I edited you comment to use them this time).

bitwiseman avatar Jul 29 '20 23:07 bitwiseman

@mlasevich The credentials are looked up here:

https://github.com/jenkinsci/bitbucket-branch-source-plugin/blob/b0f0c4928b6d6f162ac68dd4bb50a97160672f4f/src/main/java/com/cloudbees/jenkins/plugins/bitbucket/BitbucketSCMNavigator.java#L520-L525

So the question is - if StandardCredentials is not kept up to date, is there way to refresh it?

I do not know if they are kept up-to-date. A new auth token is generated from them for each request, but that is not the same thing.

Credentials can be looked up again by Id: https://github.com/jenkinsci/credentials-plugin/blob/master/docs/consumer.adoc#retrieve-a-previously-selected-credentials-instance.

bitwiseman avatar Jul 30 '20 00:07 bitwiseman

@bitwiseman That is super useful. Let me take a stab at it (may not be until next week though)

mlasevich avatar Jul 30 '20 00:07 mlasevich

@bitwiseman - Here is a draft, see if this makes sense.

mlasevich avatar Jul 30 '20 00:07 mlasevich

hi

I'm wondering if it is fixed or when it will be as I also happen to need this working :)

Thank you

pcellix avatar Sep 09 '20 09:09 pcellix

@pcellix Please try the incremental version noted in #334 and report back results in that PR.

bitwiseman avatar Sep 09 '20 18:09 bitwiseman

I have tried the incremental version and it doesn't work. There is an error in the logs:

Dec 15 08:26:57 playground java[21423]: 2020-12-15 08:26:57.613+0000 [id=78] WARNING h.ExpressionFactory2$JexlExpression#evaluate: Caught exception evaluating: it.getImageOf(iconSize) in /. Reason: java.lang.NullPointerExcDec 15 08:26:57 playground java[21423]: java.lang.NullPointerException Dec 15 08:26:57 playground java[21423]: at com.cloudbees.jenkins.plugins.bitbucket.BitbucketTeamMetadataAction$BitbucketAvatarCacheSource.hashKey(BitbucketTeamMetadataAction.java:91) Dec 15 08:26:57 playground java[21423]: at com.cloudbees.jenkins.plugins.bitbucket.avatars.AvatarCache.buildUrl(AvatarCache.java:157) Dec 15 08:26:57 playground java[21423]: at com.cloudbees.jenkins.plugins.bitbucket.BitbucketTeamMetadataAction.getAvatarImageOf(BitbucketTeamMetadataAction.java:135) Dec 15 08:26:57 playground java[21423]: at jenkins.branch.MetadataActionFolderIcon.getImageOf(MetadataActionFolderIcon.java:121) Dec 15 08:26:57 playground java[21423]: at sun.reflect.GeneratedMethodAccessor148.invoke(Unknown Source) Dec 15 08:26:57 playground java[21423]: at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) Dec 15 08:26:57 playground java[21423]: at java.lang.reflect.Method.invoke(Method.java:498) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jexl.util.introspection.UberspectImpl$VelMethodImpl.invoke(UberspectImpl.java:258) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jexl.parser.ASTMethod.execute(ASTMethod.java:104) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jexl.parser.ASTReference.execute(ASTReference.java:83) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jexl.parser.ASTReference.value(ASTReference.java:57) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jexl.parser.ASTReferenceExpression.value(ASTReferenceExpression.java:51) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jexl.ExpressionImpl.evaluate(ExpressionImpl.java:80) Dec 15 08:26:57 playground java[21423]: at hudson.ExpressionFactory2$JexlExpression.evaluate(ExpressionFactory2.java:74) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$3.run(CoreTagLibrary.java:134) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:161) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.OtherwiseTag.doTag(OtherwiseTag.java:41) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:161) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:38) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:161) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.OtherwiseTag.doTag(OtherwiseTag.java:41) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:161) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.ChooseTag.doTag(ChooseTag.java:38) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$1.run(CoreTagLibrary.java:98) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$2.run(CoreTagLibrary.java:105) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript.run(CallTagLibScript.java:120) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$2.run(CoreTagLibrary.java:105) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.JellyViewScript.run(JellyViewScript.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.IncludeTag.doTag(IncludeTag.java:147) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:161) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.ForEachTag.doTag(ForEachTag.java:150) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$2.run(CoreTagLibrary.java:105) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript.run(CallTagLibScript.java:120) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:161) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.TagSupport.invokeBody(TagSupport.java:161) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.ForEachTag.doTag(ForEachTag.java:150) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$1.run(CoreTagLibrary.java:98) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$2.run(CoreTagLibrary.java:105) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript.run(CallTagLibScript.java:120) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.groovy.JellyBuilder.doInvokeMethod(JellyBuilder.java:271) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.groovy.Namespace$ProxyImpl.invoke(Namespace.java:92) Dec 15 08:26:57 playground java[21423]: at com.sun.proxy.$Proxy64.projectView(Unknown Source) Dec 15 08:26:57 playground java[21423]: at lib.JenkinsTagLib$projectView$1.call(Unknown Source) Dec 15 08:26:57 playground java[21423]: at hudson.model.View.main.run(main.groovy:16) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.groovy.GroovierJellyScript.run(GroovierJellyScript.java:74) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.groovy.GroovierJellyScript.run(GroovierJellyScript.java:62) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.IncludeTag.doTag(IncludeTag.java:147) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript$1.run(CallTagLibScript.java:99) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$1.run(CoreTagLibrary.java:98) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$2.run(CoreTagLibrary.java:105) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript.run(CallTagLibScript.java:120) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript$1.run(CallTagLibScript.java:99) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ReallyStaticTagLibrary$1.run(ReallyStaticTagLibrary.java:100) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript$1.run(CallTagLibScript.java:99) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.define.InvokeBodyTag.doTag(InvokeBodyTag.java:91) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$2.run(CoreTagLibrary.java:105) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript.run(CallTagLibScript.java:120) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.ScriptBlock.run(ScriptBlock.java:95) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.tags.core.CoreTagLibrary$2.run(CoreTagLibrary.java:105) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CallTagLibScript.run(CallTagLibScript.java:120) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.CompressTag.doTag(CompressTag.java:44) Dec 15 08:26:57 playground java[21423]: at org.apache.commons.jelly.impl.TagScript.run(TagScript.java:269) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.JellyViewScript.run(JellyViewScript.java:95) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.DefaultScriptInvoker.invokeScript(DefaultScriptInvoker.java:64) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.DefaultScriptInvoker.invokeScript(DefaultScriptInvoker.java:54) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ScriptInvoker.execute(ScriptInvoker.java:56) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.ScriptInvoker.execute(ScriptInvoker.java:43) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.Facet.handleIndexRequest(Facet.java:284) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.jelly.JellyFacet.handleIndexRequest(JellyFacet.java:100) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.IndexViewDispatcher.dispatch(IndexViewDispatcher.java:32) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.Stapler.tryInvoke(Stapler.java:766) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.Stapler.invoke(Stapler.java:898) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.Stapler.tryInvoke(Stapler.java:834) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.Stapler.invoke(Stapler.java:898) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.Stapler.invoke(Stapler.java:694) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.Stapler.service(Stapler.java:240) Dec 15 08:26:57 playground java[21423]: at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:763) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1631) Dec 15 08:26:57 playground java[21423]: at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:154) Dec 15 08:26:57 playground java[21423]: at jenkins.security.ResourceDomainFilter.doFilter(ResourceDomainFilter.java:76) Dec 15 08:26:57 playground java[21423]: at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:151) Dec 15 08:26:57 playground java[21423]: at jenkins.telemetry.impl.UserLanguages$AcceptLanguageFilter.doFilter(UserLanguages.java:129) Dec 15 08:26:57 playground java[21423]: at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:151) Dec 15 08:26:57 playground java[21423]: at hudson.plugins.audit_trail.AuditTrailFilter.doFilter(AuditTrailFilter.java:109) Dec 15 08:26:57 playground java[21423]: at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:151) Dec 15 08:26:57 playground java[21423]: at com.atlassian.bitbucket.jenkins.internal.applink.oauth.serviceprovider.auth.OAuth1aRequestFilter.doFilter(OAuth1aRequestFilter.java:109) Dec 15 08:26:57 playground java[21423]: at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:151) Dec 15 08:26:57 playground java[21423]: at jenkins.metrics.impl.MetricsFilter.doFilter(MetricsFilter.java:125) Dec 15 08:26:57 playground java[21423]: at hudson.util.PluginServletFilter$1.doFilter(PluginServletFilter.java:151) Dec 15 08:26:57 playground java[21423]: at hudson.util.PluginServletFilter.doFilter(PluginServletFilter.java:157) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1618) Dec 15 08:26:57 playground java[21423]: at hudson.security.csrf.CrumbFilter.doFilter(CrumbFilter.java:159) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1618) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:84) Dec 15 08:26:57 playground java[21423]: at hudson.security.UnwrapSecurityExceptionFilter.doFilter(UnwrapSecurityExceptionFilter.java:51) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:87) Dec 15 08:26:57 playground java[21423]: at jenkins.security.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:119) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:87) Dec 15 08:26:57 playground java[21423]: at org.acegisecurity.providers.anonymous.AnonymousProcessingFilter.doFilter(AnonymousProcessingFilter.java:125) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:87) Dec 15 08:26:57 playground java[21423]: at org.acegisecurity.ui.rememberme.RememberMeProcessingFilter.doFilter(RememberMeProcessingFilter.java:142) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:87) Dec 15 08:26:57 playground java[21423]: at org.acegisecurity.ui.AbstractProcessingFilter.doFilter(AbstractProcessingFilter.java:271) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:87) Dec 15 08:26:57 playground java[21423]: at jenkins.security.BasicHeaderProcessor.doFilter(BasicHeaderProcessor.java:93) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:87) Dec 15 08:26:57 playground java[21423]: at org.acegisecurity.context.HttpSessionContextIntegrationFilter.doFilter(HttpSessionContextIntegrationFilter.java:249) Dec 15 08:26:57 playground java[21423]: at hudson.security.HttpSessionContextIntegrationFilter2.doFilter(HttpSessionContextIntegrationFilter2.java:67) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter$1.doFilter(ChainedServletFilter.java:87) Dec 15 08:26:57 playground java[21423]: at hudson.security.ChainedServletFilter.doFilter(ChainedServletFilter.java:90) Dec 15 08:26:57 playground java[21423]: at hudson.security.HudsonFilter.doFilter(HudsonFilter.java:171) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1618) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.compression.CompressionFilter.doFilter(CompressionFilter.java:51) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1618) Dec 15 08:26:57 playground java[21423]: at hudson.util.CharacterEncodingFilter.doFilter(CharacterEncodingFilter.java:82) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1618) Dec 15 08:26:57 playground java[21423]: at org.kohsuke.stapler.DiagnosticThreadNameFilter.doFilter(DiagnosticThreadNameFilter.java:30) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1618) Dec 15 08:26:57 playground java[21423]: at jenkins.security.SuspiciousRequestFilter.doFilter(SuspiciousRequestFilter.java:36) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1618) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:549) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:578) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1369) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:489) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1284) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.RequestLogHandler.handle(RequestLogHandler.java:54) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.Server.handle(Server.java:501) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:556) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:272) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:375) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806) Dec 15 08:26:57 playground java[21423]: at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938) Dec 15 08:26:57 playground java[21423]: at java.lang.Thread.run(Thread.java:748)

Jenkins 2.270 openjdk version "1.8.0_275" OpenJDK Runtime Environment Corretto-8.275.01.1 (build 1.8.0_275-b01) OpenJDK 64-Bit Server VM Corretto-8.275.01.1 (build 25.275-b01, mixed mode) Bitbucket 6.10.5

aisachenka avatar Dec 15 '20 09:12 aisachenka

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.

stale[bot] avatar Apr 16 '22 08:04 stale[bot]

Is this related to #620 and #632 ?

I appreciate the original ticket is over 2 years old but I've started encountering the same/very similar issues within the last couple of months.

Jenkins version: 2.363 Bitbucket Branch Source version: 784.v7fcdc7c670f6 BitBucket Server version: 7.21.4

ag0783 avatar Oct 04 '22 13:10 ag0783