builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1466663079.31 results: success (0) buildid: 20160622203037 builduid: 3bd9b7c0bcc44ce08e5c2d2c485b41c1 revision: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.311755) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.312207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.312512) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.363889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.364246) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 23:24:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-06-22 23:24:39 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.453929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.454289) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020587 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.504257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:39.504686) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3724c395569322ea7f9fbf4a76d8b0734e9b8cda --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3724c395569322ea7f9fbf4a76d8b0734e9b8cda --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 23:24:40,091 truncating revision to first 12 chars 2016-06-22 23:24:40,091 Setting DEBUG logging. 2016-06-22 23:24:40,091 attempt 1/10 2016-06-22 23:24:40,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3724c3955693?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 23:24:40,518 unpacking tar archive at: fx-team-3724c3955693/testing/mozharness/ program finished with exit code 0 elapsedTime=0.768164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:40.286994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:40.287369) ========= script_repo_revision: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:40.287825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:40.288169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 23:24:40.297349) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2016-06-22 23:24:40.297730) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:24:40 INFO - MultiFileLogger online at 20160622 23:24:40 in /builds/slave/test 23:24:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:24:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:40 INFO - {'append_to_log': False, 23:24:40 INFO - 'base_work_dir': '/builds/slave/test', 23:24:40 INFO - 'blob_upload_branch': 'Fx-Team', 23:24:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:40 INFO - 'branch': 'Fx-Team', 23:24:40 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:40 INFO - 'config_files': ('talos/linux_config.py',), 23:24:40 INFO - 'default_actions': ('clobber', 23:24:40 INFO - 'read-buildbot-config', 23:24:40 INFO - 'download-and-extract', 23:24:40 INFO - 'populate-webroot', 23:24:40 INFO - 'create-virtualenv', 23:24:40 INFO - 'install', 23:24:40 INFO - 'run-tests'), 23:24:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:40 INFO - 'download_minidump_stackwalk': True, 23:24:40 INFO - 'download_symbols': 'ondemand', 23:24:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:40 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:40 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:40 INFO - 'installer_path': 'installer.exe', 23:24:40 INFO - 'log_level': 'info', 23:24:40 INFO - 'log_name': 'talos', 23:24:40 INFO - 'log_to_console': True, 23:24:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:24:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:24:40 INFO - 'opt_config_files': (), 23:24:40 INFO - 'pip_index': False, 23:24:40 INFO - 'sps_profile': False, 23:24:40 INFO - 'sps_profile_interval': 0, 23:24:40 INFO - 'suite': 'dromaeojs', 23:24:40 INFO - 'system_bits': '32', 23:24:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:40 INFO - 'title': 'talos-linux64-ix-027', 23:24:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:40 INFO - 'use_talos_json': True, 23:24:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:40 INFO - 'work_dir': 'build'} 23:24:40 INFO - ##### 23:24:40 INFO - ##### Running clobber step. 23:24:40 INFO - ##### 23:24:40 INFO - Running pre-action listener: _resource_record_pre_action 23:24:40 INFO - Running main action method: clobber 23:24:40 INFO - rmtree: /builds/slave/test/build 23:24:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:41 INFO - Running post-action listener: _resource_record_post_action 23:24:41 INFO - ##### 23:24:41 INFO - ##### Finished clobber step (success) 23:24:41 INFO - ##### 23:24:41 INFO - ##### 23:24:41 INFO - ##### Running read-buildbot-config step. 23:24:41 INFO - ##### 23:24:41 INFO - Running pre-action listener: _resource_record_pre_action 23:24:41 INFO - Running main action method: read_buildbot_config 23:24:41 INFO - Using buildbot properties: 23:24:41 INFO - { 23:24:41 INFO - "project": "", 23:24:41 INFO - "product": "firefox", 23:24:41 INFO - "script_repo_revision": "production", 23:24:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:24:41 INFO - "repository": "", 23:24:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:24:41 INFO - "buildid": "20160622203037", 23:24:41 INFO - "pgo_build": "True", 23:24:41 INFO - "basedir": "/builds/slave/test", 23:24:41 INFO - "buildnumber": 1278, 23:24:41 INFO - "slavename": "talos-linux64-ix-027", 23:24:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:24:41 INFO - "platform": "ubuntu64_hw", 23:24:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:24:41 INFO - "branch": "fx-team", 23:24:41 INFO - "repo_path": "integration/fx-team", 23:24:41 INFO - "revision": "3724c395569322ea7f9fbf4a76d8b0734e9b8cda", 23:24:41 INFO - "stage_platform": "linux64-pgo", 23:24:41 INFO - "builduid": "3bd9b7c0bcc44ce08e5c2d2c485b41c1", 23:24:41 INFO - "slavebuilddir": "test" 23:24:41 INFO - } 23:24:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:24:41 INFO - Running post-action listener: _resource_record_post_action 23:24:41 INFO - ##### 23:24:41 INFO - ##### Finished read-buildbot-config step (success) 23:24:41 INFO - ##### 23:24:41 INFO - ##### 23:24:41 INFO - ##### Running download-and-extract step. 23:24:41 INFO - ##### 23:24:41 INFO - Running pre-action listener: _resource_record_pre_action 23:24:41 INFO - Running main action method: download_and_extract 23:24:41 INFO - mkdir: /builds/slave/test/build/tests 23:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:41 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:24:42 INFO - Downloaded 1361 bytes. 23:24:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:24:42 INFO - Using the following test package requirements: 23:24:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:24:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:24:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'jsshell-linux-x86_64.zip'], 23:24:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:24:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:24:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:24:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:24:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:24:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:42 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:24:43 INFO - Downloaded 24269895 bytes. 23:24:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:24:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:24:45 INFO - Return code: 0 23:24:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:45 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:25:06 INFO - Downloaded 24269895 bytes. 23:25:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:25:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:25:08 INFO - Return code: 0 23:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:08 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:25:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:25:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:25:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:25:09 INFO - Downloaded 14405384 bytes. 23:25:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:25:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:25:09 INFO - Return code: 0 23:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:09 INFO - https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:25:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:25:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:25:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:25:12 INFO - Downloaded 60156108 bytes. 23:25:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:25:12 INFO - mkdir: /builds/slave/test/properties 23:25:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:25:12 INFO - Writing to file /builds/slave/test/properties/build_url 23:25:12 INFO - Contents: 23:25:12 INFO - build_url:https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:25:12 INFO - Running post-action listener: _resource_record_post_action 23:25:12 INFO - Running post-action listener: set_extra_try_arguments 23:25:12 INFO - ##### 23:25:12 INFO - ##### Finished download-and-extract step (success) 23:25:12 INFO - ##### 23:25:12 INFO - ##### 23:25:12 INFO - ##### Running populate-webroot step. 23:25:12 INFO - ##### 23:25:12 INFO - Running pre-action listener: _resource_record_pre_action 23:25:12 INFO - Running main action method: populate_webroot 23:25:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:25:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:25:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:25:12 INFO - '--tppagecycles', 23:25:12 INFO - '7'], 23:25:12 INFO - 'tests': ['tsvgm']}}, 23:25:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:25:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:25:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:25:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:25:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:25:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:25:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['damp', 'tps']}, 23:25:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'tests': ['damp', 'tps']}, 23:25:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['dromaeo_dom']}, 23:25:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:25:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['basic_compositor_video']}, 23:25:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:25:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['a11yr', 23:25:12 INFO - 'ts_paint', 23:25:12 INFO - 'tpaint', 23:25:12 INFO - 'sessionrestore', 23:25:12 INFO - 'sessionrestore_no_auto_restore', 23:25:12 INFO - 'tabpaint']}, 23:25:12 INFO - 'other-e10s': {'tests': ['a11yr', 23:25:12 INFO - 'ts_paint', 23:25:12 INFO - 'tpaint', 23:25:12 INFO - 'sessionrestore', 23:25:12 INFO - 'sessionrestore_no_auto_restore', 23:25:12 INFO - 'tabpaint']}, 23:25:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:25:12 INFO - 'ts_paint', 23:25:12 INFO - 'tpaint', 23:25:12 INFO - 'sessionrestore', 23:25:12 INFO - 'sessionrestore_no_auto_restore', 23:25:12 INFO - 'tabpaint']}, 23:25:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:25:12 INFO - 'ts_paint', 23:25:12 INFO - 'tpaint', 23:25:12 INFO - 'sessionrestore', 23:25:12 INFO - 'sessionrestore_no_auto_restore', 23:25:12 INFO - 'tabpaint']}, 23:25:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['a11yr', 23:25:12 INFO - 'ts_paint', 23:25:12 INFO - 'tpaint', 23:25:12 INFO - 'sessionrestore', 23:25:12 INFO - 'sessionrestore_no_auto_restore', 23:25:12 INFO - 'tabpaint']}, 23:25:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['a11yr', 23:25:12 INFO - 'ts_paint', 23:25:12 INFO - 'tpaint', 23:25:12 INFO - 'sessionrestore', 23:25:12 INFO - 'sessionrestore_no_auto_restore', 23:25:12 INFO - 'tabpaint']}, 23:25:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['tsvgx', 23:25:12 INFO - 'tsvgr_opacity', 23:25:12 INFO - 'tart', 23:25:12 INFO - 'tscrollx', 23:25:12 INFO - 'cart']}, 23:25:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:25:12 INFO - 'tsvgr_opacity', 23:25:12 INFO - 'tart', 23:25:12 INFO - 'tscrollx', 23:25:12 INFO - 'cart']}, 23:25:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'talos_options': ['--disable-e10s'], 23:25:12 INFO - 'tests': ['tp5o']}, 23:25:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'tests': ['tp5o']}, 23:25:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'talos_options': ['--disable-e10s', 23:25:12 INFO - '--xperf_path', 23:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:25:12 INFO - 'tests': ['tp5n']}, 23:25:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:12 INFO - 'talos_options': ['--xperf_path', 23:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:25:12 INFO - 'tests': ['tp5n']}}, 23:25:12 INFO - 'talos.zip': {'path': '', 23:25:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:25:12 INFO - Running post-action listener: _resource_record_post_action 23:25:12 INFO - ##### 23:25:12 INFO - ##### Finished populate-webroot step (success) 23:25:12 INFO - ##### 23:25:12 INFO - ##### 23:25:12 INFO - ##### Running create-virtualenv step. 23:25:12 INFO - ##### 23:25:12 INFO - Running pre-action listener: _resource_record_pre_action 23:25:12 INFO - Running main action method: create_virtualenv 23:25:12 INFO - Creating virtualenv /builds/slave/test/build/venv 23:25:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:25:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:25:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:25:12 INFO - Using real prefix '/usr' 23:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:25:13 INFO - Installing distribute.............................................................................................................................................................................................done. 23:25:15 INFO - Installing pip.................done. 23:25:15 INFO - Return code: 0 23:25:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:25:15 INFO - Using env: {'DISPLAY': ':0', 23:25:15 INFO - 'HOME': '/home/cltbld', 23:25:15 INFO - 'LANG': 'en_US.UTF-8', 23:25:15 INFO - 'LANGUAGE': 'en_US:en', 23:25:15 INFO - 'LOGNAME': 'cltbld', 23:25:15 INFO - 'MAIL': '/var/mail/cltbld', 23:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:15 INFO - 'MOZ_NO_REMOTE': '1', 23:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:15 INFO - 'NO_EM_RESTART': '1', 23:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:15 INFO - 'PWD': '/builds/slave/test', 23:25:15 INFO - 'SHELL': '/bin/bash', 23:25:15 INFO - 'SHLVL': '1', 23:25:15 INFO - 'TERM': 'linux', 23:25:15 INFO - 'TMOUT': '86400', 23:25:15 INFO - 'USER': 'cltbld', 23:25:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:15 INFO - '_': '/tools/buildbot/bin/python'} 23:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:25:15 INFO - Cleaning up... 23:25:15 INFO - Return code: 0 23:25:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:25:15 INFO - Using env: {'DISPLAY': ':0', 23:25:15 INFO - 'HOME': '/home/cltbld', 23:25:15 INFO - 'LANG': 'en_US.UTF-8', 23:25:15 INFO - 'LANGUAGE': 'en_US:en', 23:25:15 INFO - 'LOGNAME': 'cltbld', 23:25:15 INFO - 'MAIL': '/var/mail/cltbld', 23:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:15 INFO - 'MOZ_NO_REMOTE': '1', 23:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:15 INFO - 'NO_EM_RESTART': '1', 23:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:15 INFO - 'PWD': '/builds/slave/test', 23:25:15 INFO - 'SHELL': '/bin/bash', 23:25:15 INFO - 'SHLVL': '1', 23:25:15 INFO - 'TERM': 'linux', 23:25:15 INFO - 'TMOUT': '86400', 23:25:15 INFO - 'USER': 'cltbld', 23:25:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:15 INFO - '_': '/tools/buildbot/bin/python'} 23:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:15 INFO - Downloading/unpacking psutil>=3.1.1 23:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:25:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:25:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:25:17 INFO - Installing collected packages: psutil 23:25:17 INFO - Running setup.py install for psutil 23:25:17 INFO - building 'psutil._psutil_linux' extension 23:25:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:25:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:25:18 INFO - building 'psutil._psutil_posix' extension 23:25:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:25:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:25:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:25:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:25:18 INFO - Successfully installed psutil 23:25:18 INFO - Cleaning up... 23:25:18 INFO - Return code: 0 23:25:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:25:18 INFO - Using env: {'DISPLAY': ':0', 23:25:18 INFO - 'HOME': '/home/cltbld', 23:25:18 INFO - 'LANG': 'en_US.UTF-8', 23:25:18 INFO - 'LANGUAGE': 'en_US:en', 23:25:18 INFO - 'LOGNAME': 'cltbld', 23:25:18 INFO - 'MAIL': '/var/mail/cltbld', 23:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:18 INFO - 'MOZ_NO_REMOTE': '1', 23:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:18 INFO - 'NO_EM_RESTART': '1', 23:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:18 INFO - 'PWD': '/builds/slave/test', 23:25:18 INFO - 'SHELL': '/bin/bash', 23:25:18 INFO - 'SHLVL': '1', 23:25:18 INFO - 'TERM': 'linux', 23:25:18 INFO - 'TMOUT': '86400', 23:25:18 INFO - 'USER': 'cltbld', 23:25:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:18 INFO - '_': '/tools/buildbot/bin/python'} 23:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:25:20 INFO - Installing collected packages: mozsystemmonitor 23:25:20 INFO - Running setup.py install for mozsystemmonitor 23:25:20 INFO - Successfully installed mozsystemmonitor 23:25:20 INFO - Cleaning up... 23:25:20 INFO - Return code: 0 23:25:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:25:20 INFO - Using env: {'DISPLAY': ':0', 23:25:20 INFO - 'HOME': '/home/cltbld', 23:25:20 INFO - 'LANG': 'en_US.UTF-8', 23:25:20 INFO - 'LANGUAGE': 'en_US:en', 23:25:20 INFO - 'LOGNAME': 'cltbld', 23:25:20 INFO - 'MAIL': '/var/mail/cltbld', 23:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:20 INFO - 'MOZ_NO_REMOTE': '1', 23:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:20 INFO - 'NO_EM_RESTART': '1', 23:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:20 INFO - 'PWD': '/builds/slave/test', 23:25:20 INFO - 'SHELL': '/bin/bash', 23:25:20 INFO - 'SHLVL': '1', 23:25:20 INFO - 'TERM': 'linux', 23:25:20 INFO - 'TMOUT': '86400', 23:25:20 INFO - 'USER': 'cltbld', 23:25:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:20 INFO - '_': '/tools/buildbot/bin/python'} 23:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:20 INFO - Downloading/unpacking jsonschema==2.5.1 23:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:25:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:22 INFO - Downloading functools32-3.2.3-2.tar.gz 23:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:25:23 INFO - warning: no files found matching '*.txt' 23:25:23 INFO - no previously-included directories found matching 'build' 23:25:23 INFO - no previously-included directories found matching 'dist' 23:25:23 INFO - no previously-included directories found matching '.git*' 23:25:23 INFO - Installing collected packages: jsonschema, functools32 23:25:23 INFO - Running setup.py install for functools32 23:25:23 INFO - warning: no files found matching '*.txt' 23:25:23 INFO - no previously-included directories found matching 'build' 23:25:23 INFO - no previously-included directories found matching 'dist' 23:25:23 INFO - no previously-included directories found matching '.git*' 23:25:23 INFO - Successfully installed jsonschema functools32 23:25:23 INFO - Cleaning up... 23:25:23 INFO - Return code: 0 23:25:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:25:23 INFO - Using env: {'DISPLAY': ':0', 23:25:23 INFO - 'HOME': '/home/cltbld', 23:25:23 INFO - 'LANG': 'en_US.UTF-8', 23:25:23 INFO - 'LANGUAGE': 'en_US:en', 23:25:23 INFO - 'LOGNAME': 'cltbld', 23:25:23 INFO - 'MAIL': '/var/mail/cltbld', 23:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:23 INFO - 'MOZ_NO_REMOTE': '1', 23:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:23 INFO - 'NO_EM_RESTART': '1', 23:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:23 INFO - 'PWD': '/builds/slave/test', 23:25:23 INFO - 'SHELL': '/bin/bash', 23:25:23 INFO - 'SHLVL': '1', 23:25:23 INFO - 'TERM': 'linux', 23:25:23 INFO - 'TMOUT': '86400', 23:25:23 INFO - 'USER': 'cltbld', 23:25:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:23 INFO - '_': '/tools/buildbot/bin/python'} 23:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:23 INFO - Downloading/unpacking blobuploader==1.2.4 23:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:25 INFO - Downloading blobuploader-1.2.4.tar.gz 23:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:25:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:25:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:26 INFO - Downloading docopt-0.6.1.tar.gz 23:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:25:26 INFO - Installing collected packages: blobuploader, requests, docopt 23:25:26 INFO - Running setup.py install for blobuploader 23:25:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:25:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:25:26 INFO - Running setup.py install for requests 23:25:26 INFO - Running setup.py install for docopt 23:25:26 INFO - Successfully installed blobuploader requests docopt 23:25:26 INFO - Cleaning up... 23:25:26 INFO - Return code: 0 23:25:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:25:26 INFO - Using env: {'DISPLAY': ':0', 23:25:26 INFO - 'HOME': '/home/cltbld', 23:25:26 INFO - 'LANG': 'en_US.UTF-8', 23:25:26 INFO - 'LANGUAGE': 'en_US:en', 23:25:26 INFO - 'LOGNAME': 'cltbld', 23:25:26 INFO - 'MAIL': '/var/mail/cltbld', 23:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:26 INFO - 'MOZ_NO_REMOTE': '1', 23:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:26 INFO - 'NO_EM_RESTART': '1', 23:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:26 INFO - 'PWD': '/builds/slave/test', 23:25:26 INFO - 'SHELL': '/bin/bash', 23:25:26 INFO - 'SHLVL': '1', 23:25:26 INFO - 'TERM': 'linux', 23:25:26 INFO - 'TMOUT': '86400', 23:25:26 INFO - 'USER': 'cltbld', 23:25:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:26 INFO - '_': '/tools/buildbot/bin/python'} 23:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:26 INFO - Running setup.py (path:/tmp/pip-bq2Poa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:26 INFO - Running setup.py (path:/tmp/pip-sSxs6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:27 INFO - Running setup.py (path:/tmp/pip-FekUUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:27 INFO - Running setup.py (path:/tmp/pip-KEs5Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:27 INFO - Running setup.py (path:/tmp/pip-hy3xCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:27 INFO - Running setup.py (path:/tmp/pip-HnTYnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:27 INFO - Running setup.py (path:/tmp/pip-hbXWdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:27 INFO - Running setup.py (path:/tmp/pip-m6KVfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:27 INFO - Running setup.py (path:/tmp/pip-atxFTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:27 INFO - Running setup.py (path:/tmp/pip-4TASy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:27 INFO - Running setup.py (path:/tmp/pip-FqiNsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:27 INFO - Running setup.py (path:/tmp/pip-_avXWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:27 INFO - Running setup.py (path:/tmp/pip-Crln9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:27 INFO - Running setup.py (path:/tmp/pip-Ilq1MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:27 INFO - Running setup.py (path:/tmp/pip-z359sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:27 INFO - Running setup.py (path:/tmp/pip-pL15jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:28 INFO - Running setup.py (path:/tmp/pip-Wsb7Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:25:28 INFO - Running setup.py install for manifestparser 23:25:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Running setup.py install for mozcrash 23:25:28 INFO - Running setup.py install for mozdebug 23:25:28 INFO - Running setup.py install for mozdevice 23:25:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Running setup.py install for mozfile 23:25:28 INFO - Running setup.py install for mozhttpd 23:25:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Running setup.py install for mozinfo 23:25:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Running setup.py install for mozInstall 23:25:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:25:28 INFO - Running setup.py install for mozleak 23:25:29 INFO - Running setup.py install for mozlog 23:25:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:25:29 INFO - Running setup.py install for moznetwork 23:25:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:25:29 INFO - Running setup.py install for mozprocess 23:25:29 INFO - Running setup.py install for mozprofile 23:25:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:25:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:25:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:25:29 INFO - Running setup.py install for mozrunner 23:25:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:25:29 INFO - Running setup.py install for mozscreenshot 23:25:29 INFO - Running setup.py install for moztest 23:25:29 INFO - Running setup.py install for mozversion 23:25:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:25:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:25:29 INFO - Cleaning up... 23:25:29 INFO - Return code: 0 23:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:25:29 INFO - Using env: {'DISPLAY': ':0', 23:25:29 INFO - 'HOME': '/home/cltbld', 23:25:29 INFO - 'LANG': 'en_US.UTF-8', 23:25:29 INFO - 'LANGUAGE': 'en_US:en', 23:25:29 INFO - 'LOGNAME': 'cltbld', 23:25:29 INFO - 'MAIL': '/var/mail/cltbld', 23:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:29 INFO - 'MOZ_NO_REMOTE': '1', 23:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:29 INFO - 'NO_EM_RESTART': '1', 23:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:29 INFO - 'PWD': '/builds/slave/test', 23:25:29 INFO - 'SHELL': '/bin/bash', 23:25:29 INFO - 'SHLVL': '1', 23:25:29 INFO - 'TERM': 'linux', 23:25:29 INFO - 'TMOUT': '86400', 23:25:29 INFO - 'USER': 'cltbld', 23:25:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:29 INFO - '_': '/tools/buildbot/bin/python'} 23:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:30 INFO - Running setup.py (path:/tmp/pip-Urxwbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:30 INFO - Running setup.py (path:/tmp/pip-LPCpoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:30 INFO - Running setup.py (path:/tmp/pip-3QTnjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:30 INFO - Running setup.py (path:/tmp/pip-Y2_7HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:30 INFO - Running setup.py (path:/tmp/pip-k3mqFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:30 INFO - Running setup.py (path:/tmp/pip-LH_82H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:30 INFO - Running setup.py (path:/tmp/pip-ZuoJ9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:30 INFO - Running setup.py (path:/tmp/pip-HoQwPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:30 INFO - Running setup.py (path:/tmp/pip-eL_Cxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:30 INFO - Running setup.py (path:/tmp/pip-yjR49v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:30 INFO - Running setup.py (path:/tmp/pip-S_uaxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:30 INFO - Running setup.py (path:/tmp/pip-koL13y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:31 INFO - Running setup.py (path:/tmp/pip-h35duB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:31 INFO - Running setup.py (path:/tmp/pip-87_zld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:31 INFO - Running setup.py (path:/tmp/pip-9ljBCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:31 INFO - Running setup.py (path:/tmp/pip-qgo4eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:31 INFO - Running setup.py (path:/tmp/pip-6q8wDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:25:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:25:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:33 INFO - Downloading blessings-1.6.tar.gz 23:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:25:33 INFO - Installing collected packages: blessings 23:25:33 INFO - Running setup.py install for blessings 23:25:33 INFO - Successfully installed blessings 23:25:33 INFO - Cleaning up... 23:25:33 INFO - Return code: 0 23:25:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:25:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:33 INFO - Reading from file tmpfile_stdout 23:25:33 INFO - Current package versions: 23:25:33 INFO - argparse == 1.2.1 23:25:33 INFO - blessings == 1.6 23:25:33 INFO - blobuploader == 1.2.4 23:25:33 INFO - docopt == 0.6.1 23:25:33 INFO - functools32 == 3.2.3-2 23:25:33 INFO - jsonschema == 2.5.1 23:25:33 INFO - manifestparser == 1.1 23:25:33 INFO - mozInstall == 1.12 23:25:33 INFO - mozcrash == 0.17 23:25:33 INFO - mozdebug == 0.1 23:25:33 INFO - mozdevice == 0.48 23:25:33 INFO - mozfile == 1.2 23:25:33 INFO - mozhttpd == 0.7 23:25:33 INFO - mozinfo == 0.9 23:25:33 INFO - mozleak == 0.1 23:25:33 INFO - mozlog == 3.2 23:25:33 INFO - moznetwork == 0.27 23:25:33 INFO - mozprocess == 0.22 23:25:33 INFO - mozprofile == 0.28 23:25:33 INFO - mozrunner == 6.11 23:25:33 INFO - mozscreenshot == 0.1 23:25:33 INFO - mozsystemmonitor == 0.3 23:25:33 INFO - moztest == 0.7 23:25:33 INFO - mozversion == 1.4 23:25:33 INFO - psutil == 3.1.1 23:25:33 INFO - requests == 1.2.3 23:25:33 INFO - wsgiref == 0.1.2 23:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:25:33 INFO - Using env: {'DISPLAY': ':0', 23:25:33 INFO - 'HOME': '/home/cltbld', 23:25:33 INFO - 'LANG': 'en_US.UTF-8', 23:25:33 INFO - 'LANGUAGE': 'en_US:en', 23:25:33 INFO - 'LOGNAME': 'cltbld', 23:25:33 INFO - 'MAIL': '/var/mail/cltbld', 23:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:33 INFO - 'MOZ_NO_REMOTE': '1', 23:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:33 INFO - 'NO_EM_RESTART': '1', 23:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:33 INFO - 'PWD': '/builds/slave/test', 23:25:33 INFO - 'SHELL': '/bin/bash', 23:25:33 INFO - 'SHLVL': '1', 23:25:33 INFO - 'TERM': 'linux', 23:25:33 INFO - 'TMOUT': '86400', 23:25:33 INFO - 'USER': 'cltbld', 23:25:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:33 INFO - '_': '/tools/buildbot/bin/python'} 23:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:25:33 INFO - Cleaning up... 23:25:33 INFO - Return code: 0 23:25:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:25:33 INFO - Using env: {'DISPLAY': ':0', 23:25:33 INFO - 'HOME': '/home/cltbld', 23:25:33 INFO - 'LANG': 'en_US.UTF-8', 23:25:33 INFO - 'LANGUAGE': 'en_US:en', 23:25:33 INFO - 'LOGNAME': 'cltbld', 23:25:33 INFO - 'MAIL': '/var/mail/cltbld', 23:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:33 INFO - 'MOZ_NO_REMOTE': '1', 23:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:33 INFO - 'NO_EM_RESTART': '1', 23:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:33 INFO - 'PWD': '/builds/slave/test', 23:25:33 INFO - 'SHELL': '/bin/bash', 23:25:33 INFO - 'SHLVL': '1', 23:25:33 INFO - 'TERM': 'linux', 23:25:33 INFO - 'TMOUT': '86400', 23:25:33 INFO - 'USER': 'cltbld', 23:25:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:33 INFO - '_': '/tools/buildbot/bin/python'} 23:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:25:34 INFO - Cleaning up... 23:25:34 INFO - Return code: 0 23:25:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04440c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2504190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:25:34 INFO - Using env: {'DISPLAY': ':0', 23:25:34 INFO - 'HOME': '/home/cltbld', 23:25:34 INFO - 'LANG': 'en_US.UTF-8', 23:25:34 INFO - 'LANGUAGE': 'en_US:en', 23:25:34 INFO - 'LOGNAME': 'cltbld', 23:25:34 INFO - 'MAIL': '/var/mail/cltbld', 23:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:34 INFO - 'MOZ_NO_REMOTE': '1', 23:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:34 INFO - 'NO_EM_RESTART': '1', 23:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:34 INFO - 'PWD': '/builds/slave/test', 23:25:34 INFO - 'SHELL': '/bin/bash', 23:25:34 INFO - 'SHLVL': '1', 23:25:34 INFO - 'TERM': 'linux', 23:25:34 INFO - 'TMOUT': '86400', 23:25:34 INFO - 'USER': 'cltbld', 23:25:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:34 INFO - '_': '/tools/buildbot/bin/python'} 23:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:34 INFO - Downloading/unpacking flake8 23:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:25:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:25:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:37 INFO - no previously-included directories found matching 'docs/_build' 23:25:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:25:37 INFO - Running setup.py install for pep8 23:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:37 INFO - no previously-included directories found matching 'docs/_build' 23:25:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:25:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:25:37 INFO - Cleaning up... 23:25:37 INFO - Return code: 0 23:25:37 INFO - Running post-action listener: _resource_record_post_action 23:25:37 INFO - Running post-action listener: _start_resource_monitoring 23:25:37 INFO - Starting resource monitoring. 23:25:37 INFO - ##### 23:25:37 INFO - ##### Finished create-virtualenv step (success) 23:25:37 INFO - ##### 23:25:37 INFO - ##### 23:25:37 INFO - ##### Running install step. 23:25:37 INFO - ##### 23:25:37 INFO - Running pre-action listener: _resource_record_pre_action 23:25:37 INFO - Running main action method: install 23:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:37 INFO - Reading from file tmpfile_stdout 23:25:37 INFO - Detecting whether we're running mozinstall >=1.0... 23:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:25:37 INFO - Reading from file tmpfile_stdout 23:25:37 INFO - Output received: 23:25:37 INFO - Usage: mozinstall [options] installer 23:25:37 INFO - Options: 23:25:37 INFO - -h, --help show this help message and exit 23:25:37 INFO - -d DEST, --destination=DEST 23:25:37 INFO - Directory to install application into. [default: 23:25:37 INFO - "/builds/slave/test"] 23:25:37 INFO - --app=APP Application being installed. [default: firefox] 23:25:37 INFO - mkdir: /builds/slave/test/build/application 23:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:25:54 INFO - Reading from file tmpfile_stdout 23:25:54 INFO - Output received: 23:25:54 INFO - /builds/slave/test/build/application/firefox/firefox 23:25:54 INFO - Running post-action listener: _resource_record_post_action 23:25:54 INFO - ##### 23:25:54 INFO - ##### Finished install step (success) 23:25:54 INFO - ##### 23:25:54 INFO - ##### 23:25:54 INFO - ##### Running run-tests step. 23:25:54 INFO - ##### 23:25:54 INFO - Running pre-action listener: _resource_record_pre_action 23:25:54 INFO - Running main action method: run_tests 23:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:54 INFO - Python 2.7.3 23:25:54 INFO - Return code: 0 23:25:54 INFO - grabbing minidump binary from tooltool 23:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2502230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25026c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:25:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:25:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:25:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:54 INFO - Return code: 0 23:25:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:25:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:25:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:25:55 INFO - Return code: 0 23:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:25:55 INFO - Using env: {'DISPLAY': ':0', 23:25:55 INFO - 'HOME': '/home/cltbld', 23:25:55 INFO - 'LANG': 'en_US.UTF-8', 23:25:55 INFO - 'LANGUAGE': 'en_US:en', 23:25:55 INFO - 'LOGNAME': 'cltbld', 23:25:55 INFO - 'MAIL': '/var/mail/cltbld', 23:25:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:55 INFO - 'MOZ_NO_REMOTE': '1', 23:25:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:55 INFO - 'NO_EM_RESTART': '1', 23:25:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:55 INFO - 'PWD': '/builds/slave/test', 23:25:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:55 INFO - 'SHELL': '/bin/bash', 23:25:55 INFO - 'SHLVL': '1', 23:25:55 INFO - 'TERM': 'linux', 23:25:55 INFO - 'TMOUT': '86400', 23:25:55 INFO - 'USER': 'cltbld', 23:25:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306', 23:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:55 INFO - '_': '/tools/buildbot/bin/python'} 23:25:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:25:55 INFO - mozversion application_buildid: 20160622203037 23:25:55 INFO - mozversion application_changeset: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda 23:25:55 INFO - mozversion application_display_name: Nightly 23:25:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:55 INFO - mozversion application_name: Firefox 23:25:55 INFO - mozversion application_remotingname: firefox 23:25:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:25:55 INFO - mozversion application_vendor: Mozilla 23:25:55 INFO - mozversion application_version: 50.0a1 23:25:55 INFO - mozversion platform_buildid: 20160622203037 23:25:55 INFO - mozversion platform_changeset: 3724c395569322ea7f9fbf4a76d8b0734e9b8cda 23:25:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:25:55 INFO - mozversion platform_version: 50.0a1 23:25:55 INFO - using testdate: 1466663155 23:25:55 INFO - actual date: 1466663155 23:25:55 INFO - starting webserver on 'localhost:42649' 23:25:55 INFO - SUITE-START | Running 2 tests 23:25:55 INFO - TEST-START | dromaeo_css 23:25:55 INFO - operating with platform_type : linux_ 23:25:55 INFO - Initialising browser for dromaeo_css test... 23:25:55 INFO - TEST-INFO | started process 5349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKmYNwk/profile http://localhost:42649/getInfo.html) 23:26:00 INFO - PROCESS | 5349 | __metrics Screen width/height:1600/1200 23:26:00 INFO - PROCESS | 5349 | colorDepth:24 23:26:00 INFO - PROCESS | 5349 | Browser inner width/height: 1024/697 23:26:00 INFO - PROCESS | 5349 | __metrics 23:26:00 INFO - PROCESS | 5349 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:26:02 INFO - TEST-INFO | 5349: exit 0 23:26:02 INFO - Browser initialized. 23:26:02 INFO - Running cycle 1/1 for dromaeo_css test... 23:26:02 INFO - TEST-INFO | started process 5430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKmYNwk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:26:14 INFO - PROCESS | 5430 | RSS: Main: 174510080 23:26:14 INFO - PROCESS | 5430 | 23:27:04 INFO - PROCESS | 5430 | 1466663224678 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:29:13 INFO - PROCESS | 5430 | Cycle 1(1): loaded http://localhost:42649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42649/tests/dromaeo/cssquery-ext.html) 23:29:14 INFO - PROCESS | 5430 | RSS: Main: 298569728 23:29:14 INFO - PROCESS | 5430 | 23:32:17 INFO - PROCESS | 5430 | Cycle 1(1): loaded http://localhost:42649/tests/dromaeo/cssquery-ext.html (next: http://localhost:42649/tests/dromaeo/cssquery-jquery.html) 23:32:17 INFO - PROCESS | 5430 | RSS: Main: 259563520 23:32:17 INFO - PROCESS | 5430 | 23:35:19 INFO - PROCESS | 5430 | Cycle 1(1): loaded http://localhost:42649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42649/tests/dromaeo/cssquery-mootools.html) 23:35:20 INFO - PROCESS | 5430 | RSS: Main: 257118208 23:35:20 INFO - PROCESS | 5430 | 23:38:22 INFO - PROCESS | 5430 | Cycle 1(1): loaded http://localhost:42649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42649/tests/dromaeo/cssquery-prototype.html) 23:38:22 INFO - PROCESS | 5430 | RSS: Main: 258928640 23:38:22 INFO - PROCESS | 5430 | 23:41:25 INFO - PROCESS | 5430 | Cycle 1(1): loaded http://localhost:42649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42649/tests/dromaeo/cssquery-yui.html) 23:41:26 INFO - PROCESS | 5430 | RSS: Main: 248004608 23:41:26 INFO - PROCESS | 5430 | 23:44:28 INFO - PROCESS | 5430 | Cycle 1(1): loaded http://localhost:42649/tests/dromaeo/cssquery-yui.html (next: http://localhost:42649/tests/dromaeo/cssquery-dojo.html) 23:44:29 INFO - PROCESS | 5430 | RSS: Main: 291414016 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | __start_tp_report 23:44:29 INFO - PROCESS | 5430 | _x_x_mozilla_page_load 23:44:29 INFO - PROCESS | 5430 | _x_x_mozilla_page_load_details 23:44:29 INFO - PROCESS | 5430 | |i|pagename|runs| 23:44:29 INFO - PROCESS | 5430 | |0;dojo.html;3092.6443459002207;3117.703818137277;3117.9844100779496;3147.3705258948216;3148.5906832111823;5209.947900520993;5237.292965449663;5289.788408463657;5302.549283310918;5335.9199612005805;5305.283786688806;5316.6544174628625;5328.5470734987575;5347.064263753838;5381.354237491497;4815.638827087965;4860.270959356089;4891.828785992491;4906.681065730734;5013.248012798092;4923.113839508887;4928.654994150411;4971.105201063807;4989.476105008976;5006.949930500685;4762.28565715142;4776.188048031826;4824.396950381202;4826.32431459596;4846.684965477232;4817.229243321051;4842.927356089662;4844.733539655317;4872.098661747588;4919.557239848431;4854.417469903598;4867.586255168279;4872.756362181912;4878.512148785128;4909.680870743426;5210.322658054429;5242.580593552507;5283.313169287968;5287.550558202519;5326.467353264681;5683.744231509592;5702.429757024306;5725.885482290331;5732.570057245724;5738.139279108125;5623.156526521055;5731.398203188647;5765.913511297334;5766.740496677659;5779.046457334534;5318.361796584396;5386.138217885159;5388.811391601275;5461.563074953994;5464.180372944051;5938.198343223609;5971.343152253248;5972.193753843176;5973.820785376359;5974.551908606872;5491.395946445888;5540.695261760561;5581.776728930798;5611.410801865827;5618.634788738719;5605.691686957175;5617.073182924772;5660.8867822643315;5685.118806584986;5693.715314234271;5663.603547751618;5665.9716701417055;5667.1782591524;5671.092625179951;5675.943240567624;5638.4925356718095;5648.85877853057;5697.401772813878;5711.543076553866;5722.484976352148;4254.149170165979;4277.743335399886;4279.16556271524;4321.935170972438;4326.718763280377;3917.2361389529337;3965.266425711253;3975.602439756059;3989.6409323161056;4010.5588385277597;5551.084071128299;5557.77768889248;5561.082421400504;5562.666240025612;5569.777208911598;5643.915341269884;5648.49163575272;5859.765609375577;5860.824175274749;5905.970470147622;5410.323709536308;5449.4005659377435;5456.154296084113;5457.181422786613;5509.862253443696;4797.952020479751;4830.95169048305;4842.225243960949;4848.490908454632;4883.121038213156;5865.589408741433;5917.763289468373;5941.702914854326;5978.730957106941;5995.790147344822;5824.796132135355;5829.94170058294;5831.591788574929;5836.328822185503;5837.67892765902;5999.730012149376;6014.308354539109;6019.849503762441;6040.667763272886;6044.304904935989;5542.251796007487;5550.861228469321;5562.638428502134;5593.02122128634;5736.512396446349;5695.829125126253;5699.772009119589;5699.829005129687;5700.828975130753;5721.170430287501;5569.526590239875;5580.86047848807;5581.6371935824045;5582.804601838916;5582.939241544093;5410.269613602113;5585.078462053716;5631.943680563142;5652.971735141298;5678.858028549319;5540.058190107611;5567.860803479945;5588.329400471969;5589.385167631476;5589.916151257653;5403.621746477709;5699.686517241592;5741.684207368635;5757.91363129545;5765.336986246635;5339.252504649275;5339.359276886643;5363.517283444508;5388.218708287355;5453.345598528043 23:44:29 INFO - PROCESS | 5430 | |1;ext.html;577.6072270855816;611.5994023914336;619.0250355689786;625.3184029407945;633.7274971762146;29967.10098697037;33143.1714207145;41070.38394424082;41677.58322416775;41730.791346043305;43530;43942;43970.34044489335;43978.56021439793;44007.119857602826;8863.778405539848;9030.142136497023;9031.819363612723;9033.367664263504;9035.819283614324;8888.333374996868;8939.150780675825;9008.909910900873;9026.684066057689;9026.819463610724;9079.364444488889;9106.499142547158;9133.45199288045;9139.405938613969;9142.314326425512;9050.049744776803;9053;9067.637294508211;9087.227585655228;9089.363744537884;8925.73222803317;8991.325650576233;9000.909990900138;9001.279897608176;9004.054574269672;39879.8006009971;40110.39834402486;40206;40220.59779402227;40355;3414.2488652496413;3451.361498122855;3471.340445315407;3511.332846759133;3779.8677046303246;31312.843435782903;31380.37239255202;31920.840395798106;32132.518012229837;32996.50505242423;4117.155983023473;4182.498100227992;4213.199492096492;4228.217779710732;4419.226635338803;350282;353343;353423;354058;354438.2278088619;58236;58961.41038589645;58977.70511147503;59003.70498147482;59013.99999999914;34969.47545786815;35759;35827.4625880612;37809.24381512354;37815.43276850849;15637.530874073796;15651;15697.529074127795;15700.214989250491;15709.764353534707;11862.051035917106;11950.462229199708;11950.940245298718;11954.76090478203;11954.880451195551;19128.330508432417;19238.326658566883;19292.710609340873;19294.421167365002;19343.4196974091;6608.893819904733;6751.324867513209;6880.931190688029;6947.5831450113155;6982.79051628452;883.1786438612153;983.2674657380297;1003.7139415266614;1070.400575677623;1078.4524207761888;32182.390880455885;32185.51721724176;32453.887462059152;32494.187645308582;32645.673543264264;1101.763120928988;1145.0896537252904;1172.7366183266379;1178.1517307538559;1225.7548490301974;16469.670606587802;17144.571385715455;17170.31318747261;17231.56921076958;17442;607986;608100;611443;614187;614498;57265.71367143221;57753.422465774805;57767;58410.707946459996;58481.70759146177;1211.1703483114095;1325.1452812935602;1356.2337279437086;1368.5620601407652;1375.8624137586162;32317.192070197492;33241;33547.83226083854;33733.954379071096;33746;49067.50932490629;49312.50687493079;49831.750841245565;49838.750806245735;49863.75068124636;400738;402072;404101;404893;404934;24538;28060.719392806626;44713;45351.54648453473;45422;45692;50172.498275016784;50176;51275;51509.7424512875;40857;41560.584394155674;41858.790706046275;42957.57042429661;43700.78149609231;41117.177656447304;41722.58277417187;42287.4853158037;42465;42632.14735705207;40290.1941961165;40855.59144408637;41319;41746;42210;36085.81957090198;37648.811755941046;37730.62269377271;38255.42616860694;38375.80812095922;27866.16401507958;28383.574246386735;28490.715092848804;28654.14037578876;28738.425231495672 23:44:29 INFO - PROCESS | 5430 | |2;jquery.html;379.7873191013032;380.68403225323004;397.51106139448484;399.1776939504619;405.5275603921432;17431.825681743194;19631.509212269666;19962;20011.399658010247;20035.899820500894;17934.5516362091;18132.546686332847;18301.267949282046;18418.631627367446;18701.34545290915;5583.637063590863;5660.858478538028;5731.312242530902;5782.681952492611;5787.50806181475;5468.671879687212;5598.356189038272;5600.85997850055;5616.185653080322;5628.690422026787;5566.109422492402;5574.080276754331;5578.665280083188;5588.413216612258;5694.487496125348;5414.296141501599;5516.117421212627;5539.390667026624;5561.110222364423;5673.546116310686;4854.6116310695415;4908.509149085098;4921.8523444296725;5003.424606170301;5009.073321435546;22107.668384974237;22249;22455.438614034618;22761.88619056911;22819.657705134436;2296.379977406091;2381.1783037100918;2606.4135569496902;2929.6191495105713;3020.75833933287;13925.651858703512;14009.0193686442;14139;14288.642783930485;14658.560243192722;1878.1736036144189;1928.469670840516;1931.9323823666246;1955.4915721912264;2022.7572691277142;73559;77043;77140.61429692815;80009.19990800075;81134.59432702858;9803.754906127262;10386.844197337046;10839.783204335869;10851.348919064723;11013.944930275458;15349.309281082154;15418.152001640017;15462.14958177311;15488.225588720745;15505.922470387575;7556.508826926232;7648.42636802242;7649.502782319131;7670.27132422419;7794.181610930884;7259.310365515267;7285.635718214068;7444.399454117391;7462.067241594801;7569.318761311399;4555.794989225493;4666.440027196758;4683.7892294846815;4728.196206644879;4799.568038876518;1855.4433669898976;1909.3794516782102;1922.5866438715743;1929.2379510093435;1952.287415093509;871.4858233642182;931.7297983584684;998;1003.6487229469627;1008.1531513528524;17681.557961050818;18411.447656570323;18880.24479020824;18907.43277701671;19261;949.5252373813094;954.6515521834481;954.8472244440856;988.1699372527112;994.597188138805;10453.425061621683;10644.148468122532;10648.307859989076;10707.625233116803;10718.517666705016;435508;497299;500088;503501;504832;94754.52622736842;96705.51647241719;96862.51568742111;97593;98045.5097724521;935.9953200233955;941.4727752458508;957.7031120352713;964.002257663315;989.3420875117966;16403.753943691092;16594.50216493507;16753.24610392511;16812.075335856156;16955.067471289196;40783.796081019405;41451.7927410361;41624.375634366115;42742.358864616435;42968;55816.720916396785;56022.837487875484;57265.42734572768;58185.418145818;58425.12362314654;8289.792755180928;8381.37139714536;8404.53775042354;8405.117462666332;8531.658733650584;9450.480223587769;11590.246633968765;12932.676683082998;13012.089153759145;13221;11207;11467.369294688871;11506.482208300478;11763.705907352385;11887.643370698894;5331.134927177765;10977.17671174681;11462.140339474407;11464.94267528657;11613.3612651305;11457.369844658624;11570.479328430072;11734.647960561197;11992.76014479723;12130.636080917586;7210.71157153708;7454.552726836408;7575.810604734926;7916.604169791372;8782.516961567175;11049.72375690582;11640.708982275512;11732.12009099304;11738.530458781896;11795.764084718428 23:44:29 INFO - PROCESS | 5430 | |3;mootools.html;1316.7629826631203;1421.1473116130323;1465.54568083894;1485.2054151029201;1541.160067763069;8097.352211823055;8421.789455263613;8433.325333973282;8714.085021072791;8719.128087191279;8451.746447606567;8623.310135189186;8636.352273579476;8639.222469977702;8643.74068777936;2052.917883284667;2120.8515403921733;2121.7559980602196;2368;2394.1261439574605;2335.194357946514;2402;2405.386626410263;2419.0444774314224;2427.854328740272;2292.3123063081093;2297.310806757974;2311.884405779713;2314.085936055257;2343.94140146496;2004.5088953206412;2250.763669814662;2332.090484710964;2342.3441436397834;2345.4722687395283;2319.512902290521;2363.1728894886824;2366.0299277296226;2366.0654041653625;2369.087901158049;8792.120787921222;8909.287257019489;8918.152775486318;8927.419717718392;8940.195382415548;5030.949690503121;5136.717480538568;5140.485951404867;5146.691198528063;5149.124648809711;3180.745540356766;3273.738100951918;3371.7134043606325;3394.7623666343366;3404.285100128976;1137.7212582917155;1140.3727949627755;1146.707589564664;1170.8477897873306;1180.887815657511;11635.069194464422;11702.356370399624;11704.765904681859;11725.882741172565;11734.765304693943;4346.456692913386;4426.822927082945;4516.187086324428;4534.7052441591195;4535.206338890681;9788.314817962817;9804.558794854105;9806.313558050868;9895.406275623342;9904.752381190528;5115.820946266937;5174.508421699932;5179.093658609803;5186.507281808223;5187.58499320061;4147.315692910636;4701.153792317347;4787.353707249476;4791.928121078186;4879.585235255043;3868.5357757069332;3870.4581358609817;3952.525696916331;3977.3636218204947;4010.7593544387432;1208.5045131496045;1216.4951545108859;1240.2620440837868;1244.2037096258402;1248.5528364405866;876.4259410086404;878.0604752914448;988.836841921075;991.2218908157062;1028.6965345223177;6060.33336333003;6187.659678717624;6280.874382512324;6308.968455157695;6397.904031439532;929.4005366538545;936.4942930817418;954.6992697300328;964.5611246882792;971.9514024298899;4309.935350969738;4314.61168494837;4355.216061109031;4455.77721113943;4465.93458964637;10631.149508039338;10639.095676867399;10978.780424391627;10982.450877456095;11003.669889903316;10681.412522311191;10740.140788736882;10793;10804.405757683246;10812.405317707602;7804.141544430108;8076.636551355085;8135.430519863553;8297.83404331922;8443.662253509914;5978.133170690313;6349.777757778455;6370.394812492991;6400.135981642418;6446.7098980546925;10248.333858299187;10266.178705703674;10361.637342693271;10509.31689440184;10521.263511554118;10373.325733827278;10426.27016108865;10522.31604945676;10538.631147909786;10604.734881628021;8238.464499807493;8355.248027677539;8383.28742056932;8479.448835825651;8498.362622803192;8414.495130291958;8440.451370660887;8473.322134229124;8475.872861907199;8521;7135.429165666838;7530.962345188458;7934.722284720007;7944.126146124037;8017.158198389086;7459.962700186465;7607.505512141693;7769.223077692185;7803.297703206512;7817.296443319901;6992.475564332797;6993.685284162123;7078.8938165928585;7087.220405755466;7092.25531319204;5205;5245.186996015624;5274.947250527445;5331.120365139708;5334.279872217201;4942.604591632589;5059.443461219336;5201.817936372209;5277.340332458442;5299.364076310867 23:44:29 INFO - PROCESS | 5430 | |4;prototype.html;304.5416647944843;312.9076922307919;318.22988368149083;325.2795058944438;329.32652725177013;5110.693358398498;5142.460041695615;5279.6040296977735;5299.258103865457;5332.546733527654;5238.8690282742955;5247.795925711201;5250.369955605323;5255.76349064292;5282.894342113165;4109.28087584673;4127.750376045047;4149.128682976579;4162.8126734296875;4171.019810344566;3932.1742434088874;3950.2889479893606;4111.095558977036;4134.751914885116;4171.332586786115;4082.4080508326274;4085.1625416789634;4118.629323360897;4119.958800411988;4122.443470131524;4090.713650044498;4115.238680844023;4126.42230087788;4129.938050929239;4147.129102888397;3407.1993081625797;3666;3673.8530458781615;3676.3015027144756;3678.6021311901573;5052.520010598987;5095.847124586268;5110.8466745997675;5125.3080834087295;5128.948710512922;4678.23983849527;4694.694844835109;4699.530046995274;4706.858794236178;4708.387909571768;5293.6294459387855;5372.865678358073;5489.3412790465;5514.6691198527815;5528.612997090206;3889.1638297765835;3921.1961547882615;3924.5675328505176;3929.4302326162547;3931.3513270310364;5626.578006649518;5637.7181140942785;5656.943430565724;5668.744906479218;5721.656700598019;3965.2862484752445;3995.62041606047;4001.639852413297;4005.2790497710107;4008.318585840414;3817.3892177251505;4004.519457665099;4006.2187873364414;4006.3990401439432;4031.07285324377;4531.278114316538;4582.518835522289;4584.174848527297;4623.583877451046;4631.235846085358;5516.393196748354;5535.6955367455175;5554.694491802989;5589.608727389125;5593;1303.7131830997166;1307.9542216022394;1366.4670778396433;1373.9587812365644;1379.7930310453312;864.5720368417674;864.7103220421229;875.4134729731095;878.1525827576291;880.295763389286;4646.279826626878;4689.484156742756;4702.401183597593;4721.598664113589;4770.616521208811;4967.60259179272;4999.600111968654;4999.850004499871;5004.674696144739;5008.749562521859;4615.215413379734;4715.434147902273;4726.251287023823;4733.60358694186;4793.664443488992;2599.8830052647677;2693.8653067346554;2701.540738074532;2706.7428594283906;2714.83710977342;5207.739613019334;5208.661437006583;5214.556762675139;5249.451411833518;5255;4849.733264670406;4863.319135321058;5042.243663450512;5074;5144.408393034774;4965.939135258972;5095.363079615048;5101.821436249714;5130.48695130484;5152.92270615941;4851.927221091757;4864.562189402971;4902.872339361896;4979.526944940225;5033.949660503348;4684.5549672781035;4887.189865827235;4894.339264199288;4940.654154209171;4951.282064100613;5071.695698258116;5116.872078198075;5137.484442089667;5144.742762861917;5147.742612869416;3525.7483593324;3569.821958753657;3607.314610224154;3621.7826930384263;3765.7008332125374;5499.615026948075;5630.943690563206;5630.971845140748;5672.14917762339;5678.176664383559;5441.83674489766;5478.205660179172;5500.862478438071;5558.944410556004;5573.554115670656;5217.478252174752;5444.26502422168;5445.156000819879;5515.510812080796;5560.026190702242;5352.250684904038;5389.892202156013;5402.27069345649;5427.83716488506;5432;5510.366307874646;5549.1676248563035;5564.8330550083565;5570.415106413769;5583.218349431164;5125.282460455464;5347.705876176848;5396.541293990055;5398.487143721497;5400.648957817729 23:44:29 INFO - PROCESS | 5430 | |5;yui.html;751.9548827070377;773.5590713293425;797.9999999999999;816.3102178659033;838.1827717974979;13794.10338328008;15020.09879407235;15846.76229856553;16378.099204543745;16422.507324780247;14095.295235238224;14181.78727319091;14201;14211.78682319766;14230.715385692305;782.8473447677691;785.4776573578563;789.0058526256901;789.5657388436366;790.3598085550693;666.7233098264214;776.1268572855538;789.5775759968418;792.7146227358146;795.558465051896;807.9878801817978;810.2383759266271;810.3517186250975;811.4847072109224;812.0985705866483;683.8769021576114;806.3871457692137;806.4072906413782;806.5604245686086;808.030363563723;594.1711312718733;598.8413070536311;600.4835841176584;601.308495230484;602.2652364115771;13748.106373085717;13760.518381856587;13781.173129612256;13888.23614701191;13897.513587024405;13198;13253.668658283523;13562.59312220635;13822.308884555732;13825.101368411122;11731.366963185466;11873.881261187364;12170.208936419192;12751.87248127516;13525.120867143603;3878.4957955465893;3939.606039396066;3951.38753493209;3989.0625702959783;4114.897127571835;75952.24047759507;76102;76319.61840190818;76803;77291.61354193193;10199.18406527476;10567.788644227072;11121.666350009513;11136.220464567565;11302.208845380908;19221.32725354606;19412.320568780306;20018.799812001984;20024.299149529696;21045.579088418144;8349.54077525742;8388.286995605442;8398.580070996426;8414.537200453911;8428.072911979678;4740.420917542484;4768.237082066853;4771.856844294677;4824.276358546246;4846.830360937351;3408.437607794736;3540.592831824322;3546.66306700863;3551.4317709166407;3557.3952428087287;604.1089393145076;614.3978900677362;617.139090968097;618.6504624887015;650.0963660511892;580.4572724502603;658.1444122640548;689.9931000690029;730.2296077638143;737.5464089584974;9496.525173741285;9523.57143928525;9544.9977752335;9819.214462843098;9938.900610993942;573.5956150913596;664.6676661669165;692.988237173732;712.9648857377329;738.6824013640264;4596.264597664358;4800.807967681254;4929.383827021622;4937.580305673986;4949.703017818871;68219;68601;69504.3049569508;104398.47800760948;113527.43236283766;98874.5056274714;99614;100274;100381;101059.49470252602;67813.66093169601;84590.5770471156;85880.57059714786;89948;90063;9520.714378568655;9596.95201523988;9645.228381729585;9744.220462362851;9768.218542516439;47843.28235076407;49202.507974921224;49938.50061499484;50641;50674.692651125064;74144;76888;77024.2297577017;78481;78846.21153788618;12233;12302.630921072383;12811.807822882478;12827.102102853083;12994.54519091865;13540.661483462993;13675.316234188449;13740.244286564335;14497.130172189702;14648.707025859636;12571;12730.17253878495;12936.353182341034;13107.410166542339;13259.071864969359;12630.557930472389;12670.113092083466;12968.610941671765;13021.804672929724;13407;12410.503579856704;13309.733805323645;13417;13484.86515134836;13866.584002479942;10516.842247366143;10654.946725266323;10740.83888741654;10802.735673942681;11030.889691103308;10311.329763565343;10728.195385345975;11024.944875275572;11277.379744114152;11431.314121152758 23:44:29 INFO - PROCESS | 5430 | __end_tp_report 23:44:29 INFO - PROCESS | 5430 | __start_cc_report 23:44:29 INFO - PROCESS | 5430 | _x_x_mozilla_cycle_collect,985 23:44:29 INFO - PROCESS | 5430 | __end_cc_report 23:44:29 INFO - PROCESS | 5430 | __startTimestamp1466664269115__endTimestamp 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | ------- Summary: start ------- 23:44:29 INFO - PROCESS | 5430 | Number of tests: 6 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | [#0] dojo.html Cycles:165 Average:5321.27 Median:5551.08 stddev:608.74 (11.0%) stddev-sans-first:584.96 23:44:29 INFO - PROCESS | 5430 | Values: 3092.6 3117.7 3118.0 3147.4 3148.6 5209.9 5237.3 5289.8 5302.5 5335.9 5305.3 5316.7 5328.5 5347.1 5381.4 4815.6 4860.3 4891.8 4906.7 5013.2 4923.1 4928.7 4971.1 4989.5 5006.9 4762.3 4776.2 4824.4 4826.3 4846.7 4817.2 4842.9 4844.7 4872.1 4919.6 4854.4 4867.6 4872.8 4878.5 4909.7 5210.3 5242.6 5283.3 5287.6 5326.5 5683.7 5702.4 5725.9 5732.6 5738.1 5623.2 5731.4 5765.9 5766.7 5779.0 5318.4 5386.1 5388.8 5461.6 5464.2 5938.2 5971.3 5972.2 5973.8 5974.6 5491.4 5540.7 5581.8 5611.4 5618.6 5605.7 5617.1 5660.9 5685.1 5693.7 5663.6 5666.0 5667.2 5671.1 5675.9 5638.5 5648.9 5697.4 5711.5 5722.5 4254.1 4277.7 4279.2 4321.9 4326.7 3917.2 3965.3 3975.6 3989.6 4010.6 5551.1 5557.8 5561.1 5562.7 5569.8 5643.9 5648.5 5859.8 5860.8 5906.0 5410.3 5449.4 5456.2 5457.2 5509.9 4798.0 4831.0 4842.2 4848.5 4883.1 5865.6 5917.8 5941.7 5978.7 5995.8 5824.8 5829.9 5831.6 5836.3 5837.7 5999.7 6014.3 6019.8 6040.7 6044.3 5542.3 5550.9 5562.6 5593.0 5736.5 5695.8 5699.8 5699.8 5700.8 5721.2 5569.5 5580.9 5581.6 5582.8 5582.9 5410.3 5585.1 5631.9 5653.0 5678.9 5540.1 5567.9 5588.3 5589.4 5589.9 5403.6 5699.7 5741.7 5757.9 5765.3 5339.3 5339.4 5363.5 5388.2 5453.3 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | [#1] ext.html Cycles:180 Average:61013.05 Median:41093.78 stddev:124930.32 (304.0%) stddev-sans-first:125198.37 23:44:29 INFO - PROCESS | 5430 | Values: 577.6 611.6 619.0 625.3 633.7 29967.1 33143.2 41070.4 41677.6 41730.8 43530.0 43942.0 43970.3 43978.6 44007.1 8863.8 9030.1 9031.8 9033.4 9035.8 8888.3 8939.2 9008.9 9026.7 9026.8 9079.4 9106.5 9133.5 9139.4 9142.3 9050.0 9053.0 9067.6 9087.2 9089.4 8925.7 8991.3 9000.9 9001.3 9004.1 39879.8 40110.4 40206.0 40220.6 40355.0 3414.2 3451.4 3471.3 3511.3 3779.9 31312.8 31380.4 31920.8 32132.5 32996.5 4117.2 4182.5 4213.2 4228.2 4419.2 350282.0 353343.0 353423.0 354058.0 354438.2 58236.0 58961.4 58977.7 59003.7 59014.0 34969.5 35759.0 35827.5 37809.2 37815.4 15637.5 15651.0 15697.5 15700.2 15709.8 11862.1 11950.5 11950.9 11954.8 11954.9 19128.3 19238.3 19292.7 19294.4 19343.4 6608.9 6751.3 6880.9 6947.6 6982.8 883.2 983.3 1003.7 1070.4 1078.5 32182.4 32185.5 32453.9 32494.2 32645.7 1101.8 1145.1 1172.7 1178.2 1225.8 16469.7 17144.6 17170.3 17231.6 17442.0 607986.0 608100.0 611443.0 614187.0 614498.0 57265.7 57753.4 57767.0 58410.7 58481.7 1211.2 1325.1 1356.2 1368.6 1375.9 32317.2 33241.0 33547.8 33734.0 33746.0 49067.5 49312.5 49831.8 49838.8 49863.8 400738.0 402072.0 404101.0 404893.0 404934.0 24538.0 28060.7 44713.0 45351.5 45422.0 45692.0 50172.5 50176.0 51275.0 51509.7 40857.0 41560.6 41858.8 42957.6 43700.8 41117.2 41722.6 42287.5 42465.0 42632.1 40290.2 40855.6 41319.0 41746.0 42210.0 36085.8 37648.8 37730.6 38255.4 38375.8 27866.2 28383.6 28490.7 28654.1 28738.4 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | [#2] jquery.html Cycles:180 Average:28847.41 Median:41538.08 stddev:80706.79 (194.3%) stddev-sans-first:80904.89 23:44:29 INFO - PROCESS | 5430 | Values: 379.8 380.7 397.5 399.2 405.5 17431.8 19631.5 19962.0 20011.4 20035.9 17934.6 18132.5 18301.3 18418.6 18701.3 5583.6 5660.9 5731.3 5782.7 5787.5 5468.7 5598.4 5600.9 5616.2 5628.7 5566.1 5574.1 5578.7 5588.4 5694.5 5414.3 5516.1 5539.4 5561.1 5673.5 4854.6 4908.5 4921.9 5003.4 5009.1 22107.7 22249.0 22455.4 22761.9 22819.7 2296.4 2381.2 2606.4 2929.6 3020.8 13925.7 14009.0 14139.0 14288.6 14658.6 1878.2 1928.5 1931.9 1955.5 2022.8 73559.0 77043.0 77140.6 80009.2 81134.6 9803.8 10386.8 10839.8 10851.3 11013.9 15349.3 15418.2 15462.1 15488.2 15505.9 7556.5 7648.4 7649.5 7670.3 7794.2 7259.3 7285.6 7444.4 7462.1 7569.3 4555.8 4666.4 4683.8 4728.2 4799.6 1855.4 1909.4 1922.6 1929.2 1952.3 871.5 931.7 998.0 1003.6 1008.2 17681.6 18411.4 18880.2 18907.4 19261.0 949.5 954.7 954.8 988.2 994.6 10453.4 10644.1 10648.3 10707.6 10718.5 435508.0 497299.0 500088.0 503501.0 504832.0 94754.5 96705.5 96862.5 97593.0 98045.5 936.0 941.5 957.7 964.0 989.3 16403.8 16594.5 16753.2 16812.1 16955.1 40783.8 41451.8 41624.4 42742.4 42968.0 55816.7 56022.8 57265.4 58185.4 58425.1 8289.8 8381.4 8404.5 8405.1 8531.7 9450.5 11590.2 12932.7 13012.1 13221.0 11207.0 11467.4 11506.5 11763.7 11887.6 5331.1 10977.2 11462.1 11464.9 11613.4 11457.4 11570.5 11734.6 11992.8 12130.6 7210.7 7454.6 7575.8 7916.6 8782.5 11049.7 11640.7 11732.1 11738.5 11795.8 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | [#3] mootools.html Cycles:180 Average:5799.63 Median:4911.09 stddev:3273.66 (66.7%) stddev-sans-first:3265.51 23:44:29 INFO - PROCESS | 5430 | Values: 1316.8 1421.1 1465.5 1485.2 1541.2 8097.4 8421.8 8433.3 8714.1 8719.1 8451.7 8623.3 8636.4 8639.2 8643.7 2052.9 2120.9 2121.8 2368.0 2394.1 2335.2 2402.0 2405.4 2419.0 2427.9 2292.3 2297.3 2311.9 2314.1 2343.9 2004.5 2250.8 2332.1 2342.3 2345.5 2319.5 2363.2 2366.0 2366.1 2369.1 8792.1 8909.3 8918.2 8927.4 8940.2 5030.9 5136.7 5140.5 5146.7 5149.1 3180.7 3273.7 3371.7 3394.8 3404.3 1137.7 1140.4 1146.7 1170.8 1180.9 11635.1 11702.4 11704.8 11725.9 11734.8 4346.5 4426.8 4516.2 4534.7 4535.2 9788.3 9804.6 9806.3 9895.4 9904.8 5115.8 5174.5 5179.1 5186.5 5187.6 4147.3 4701.2 4787.4 4791.9 4879.6 3868.5 3870.5 3952.5 3977.4 4010.8 1208.5 1216.5 1240.3 1244.2 1248.6 876.4 878.1 988.8 991.2 1028.7 6060.3 6187.7 6280.9 6309.0 6397.9 929.4 936.5 954.7 964.6 972.0 4309.9 4314.6 4355.2 4455.8 4465.9 10631.1 10639.1 10978.8 10982.5 11003.7 10681.4 10740.1 10793.0 10804.4 10812.4 7804.1 8076.6 8135.4 8297.8 8443.7 5978.1 6349.8 6370.4 6400.1 6446.7 10248.3 10266.2 10361.6 10509.3 10521.3 10373.3 10426.3 10522.3 10538.6 10604.7 8238.5 8355.2 8383.3 8479.4 8498.4 8414.5 8440.5 8473.3 8475.9 8521.0 7135.4 7531.0 7934.7 7944.1 8017.2 7460.0 7607.5 7769.2 7803.3 7817.3 6992.5 6993.7 7078.9 7087.2 7092.3 5205.0 5245.2 5274.9 5331.1 5334.3 4942.6 5059.4 5201.8 5277.3 5299.4 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | [#4] prototype.html Cycles:180 Average:4439.68 Median:4966.77 stddev:1291.87 (26.0%) stddev-sans-first:1257.66 23:44:29 INFO - PROCESS | 5430 | Values: 304.5 312.9 318.2 325.3 329.3 5110.7 5142.5 5279.6 5299.3 5332.5 5238.9 5247.8 5250.4 5255.8 5282.9 4109.3 4127.8 4149.1 4162.8 4171.0 3932.2 3950.3 4111.1 4134.8 4171.3 4082.4 4085.2 4118.6 4120.0 4122.4 4090.7 4115.2 4126.4 4129.9 4147.1 3407.2 3666.0 3673.9 3676.3 3678.6 5052.5 5095.8 5110.8 5125.3 5128.9 4678.2 4694.7 4699.5 4706.9 4708.4 5293.6 5372.9 5489.3 5514.7 5528.6 3889.2 3921.2 3924.6 3929.4 3931.4 5626.6 5637.7 5656.9 5668.7 5721.7 3965.3 3995.6 4001.6 4005.3 4008.3 3817.4 4004.5 4006.2 4006.4 4031.1 4531.3 4582.5 4584.2 4623.6 4631.2 5516.4 5535.7 5554.7 5589.6 5593.0 1303.7 1308.0 1366.5 1374.0 1379.8 864.6 864.7 875.4 878.2 880.3 4646.3 4689.5 4702.4 4721.6 4770.6 4967.6 4999.6 4999.9 5004.7 5008.7 4615.2 4715.4 4726.3 4733.6 4793.7 2599.9 2693.9 2701.5 2706.7 2714.8 5207.7 5208.7 5214.6 5249.5 5255.0 4849.7 4863.3 5042.2 5074.0 5144.4 4965.9 5095.4 5101.8 5130.5 5152.9 4851.9 4864.6 4902.9 4979.5 5033.9 4684.6 4887.2 4894.3 4940.7 4951.3 5071.7 5116.9 5137.5 5144.7 5147.7 3525.7 3569.8 3607.3 3621.8 3765.7 5499.6 5630.9 5631.0 5672.1 5678.2 5441.8 5478.2 5500.9 5558.9 5573.6 5217.5 5444.3 5445.2 5515.5 5560.0 5352.3 5389.9 5402.3 5427.8 5432.0 5510.4 5549.2 5564.8 5570.4 5583.2 5125.3 5347.7 5396.5 5398.5 5400.6 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - PROCESS | 5430 | [#5] yui.html Cycles:180 Average:19747.25 Median:4812.54 stddev:27877.50 (579.3%) stddev-sans-first:27919.21 23:44:29 INFO - PROCESS | 5430 | Values: 752.0 773.6 798.0 816.3 838.2 13794.1 15020.1 15846.8 16378.1 16422.5 14095.3 14181.8 14201.0 14211.8 14230.7 782.8 785.5 789.0 789.6 790.4 666.7 776.1 789.6 792.7 795.6 808.0 810.2 810.4 811.5 812.1 683.9 806.4 806.4 806.6 808.0 594.2 598.8 600.5 601.3 602.3 13748.1 13760.5 13781.2 13888.2 13897.5 13198.0 13253.7 13562.6 13822.3 13825.1 11731.4 11873.9 12170.2 12751.9 13525.1 3878.5 3939.6 3951.4 3989.1 4114.9 75952.2 76102.0 76319.6 76803.0 77291.6 10199.2 10567.8 11121.7 11136.2 11302.2 19221.3 19412.3 20018.8 20024.3 21045.6 8349.5 8388.3 8398.6 8414.5 8428.1 4740.4 4768.2 4771.9 4824.3 4846.8 3408.4 3540.6 3546.7 3551.4 3557.4 604.1 614.4 617.1 618.7 650.1 580.5 658.1 690.0 730.2 737.5 9496.5 9523.6 9545.0 9819.2 9938.9 573.6 664.7 693.0 713.0 738.7 4596.3 4800.8 4929.4 4937.6 4949.7 68219.0 68601.0 69504.3 104398.5 113527.4 98874.5 99614.0 100274.0 100381.0 101059.5 67813.7 84590.6 85880.6 89948.0 90063.0 9520.7 9597.0 9645.2 9744.2 9768.2 47843.3 49202.5 49938.5 50641.0 50674.7 74144.0 76888.0 77024.2 78481.0 78846.2 12233.0 12302.6 12811.8 12827.1 12994.5 13540.7 13675.3 13740.2 14497.1 14648.7 12571.0 12730.2 12936.4 13107.4 13259.1 12630.6 12670.1 12968.6 13021.8 13407.0 12410.5 13309.7 13417.0 13484.9 13866.6 10516.8 10654.9 10740.8 10802.7 11030.9 10311.3 10728.2 11024.9 11277.4 11431.3 23:44:29 INFO - PROCESS | 5430 | -------- Summary: end -------- 23:44:29 INFO - PROCESS | 5430 | 23:44:29 INFO - TEST-INFO | 5430: exit 0 23:44:29 INFO - TEST-OK | dromaeo_css | took 1114044ms 23:44:29 INFO - TEST-START | kraken 23:44:29 INFO - operating with platform_type : linux_ 23:44:29 INFO - Initialising browser for kraken test... 23:44:29 INFO - TEST-INFO | started process 5612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI6fs5e/profile http://localhost:42649/getInfo.html) 23:44:33 INFO - PROCESS | 5612 | __metrics Screen width/height:1600/1200 23:44:33 INFO - PROCESS | 5612 | colorDepth:24 23:44:33 INFO - PROCESS | 5612 | Browser inner width/height: 1024/697 23:44:33 INFO - PROCESS | 5612 | __metrics 23:44:34 INFO - PROCESS | 5612 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:44:35 INFO - TEST-INFO | 5612: exit 0 23:44:35 INFO - Browser initialized. 23:44:35 INFO - Running cycle 1/1 for kraken test... 23:44:35 INFO - TEST-INFO | started process 5699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI6fs5e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:44:47 INFO - PROCESS | 5699 | RSS: Main: 174505984 23:44:47 INFO - PROCESS | 5699 | 23:44:50 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42649/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:51 INFO - PROCESS | 5699 | RSS: Main: 232648704 23:44:51 INFO - PROCESS | 5699 | 23:44:53 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42649/tests/kraken/driver.html?testName=audio-dft) 23:44:54 INFO - PROCESS | 5699 | RSS: Main: 222203904 23:44:54 INFO - PROCESS | 5699 | 23:44:57 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42649/tests/kraken/driver.html?testName=audio-fft) 23:44:58 INFO - PROCESS | 5699 | RSS: Main: 286580736 23:44:58 INFO - PROCESS | 5699 | 23:45:00 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42649/tests/kraken/driver.html?testName=audio-oscillator) 23:45:00 INFO - PROCESS | 5699 | RSS: Main: 197644288 23:45:00 INFO - PROCESS | 5699 | 23:45:03 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42649/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:45:03 INFO - PROCESS | 5699 | RSS: Main: 202211328 23:45:03 INFO - PROCESS | 5699 | 23:45:06 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42649/tests/kraken/driver.html?testName=imaging-darkroom) 23:45:07 INFO - PROCESS | 5699 | RSS: Main: 238112768 23:45:07 INFO - PROCESS | 5699 | 23:45:10 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42649/tests/kraken/driver.html?testName=imaging-desaturate) 23:45:11 INFO - PROCESS | 5699 | RSS: Main: 238415872 23:45:11 INFO - PROCESS | 5699 | 23:45:14 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42649/tests/kraken/driver.html?testName=json-parse-financial) 23:45:14 INFO - PROCESS | 5699 | RSS: Main: 237301760 23:45:14 INFO - PROCESS | 5699 | 23:45:16 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42649/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:45:16 INFO - PROCESS | 5699 | RSS: Main: 226295808 23:45:16 INFO - PROCESS | 5699 | 23:45:18 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:45:19 INFO - PROCESS | 5699 | RSS: Main: 230387712 23:45:19 INFO - PROCESS | 5699 | 23:45:21 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:45:21 INFO - PROCESS | 5699 | RSS: Main: 238411776 23:45:21 INFO - PROCESS | 5699 | 23:45:24 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:45:25 INFO - PROCESS | 5699 | RSS: Main: 239132672 23:45:25 INFO - PROCESS | 5699 | 23:45:27 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:45:28 INFO - PROCESS | 5699 | RSS: Main: 239329280 23:45:28 INFO - PROCESS | 5699 | 23:45:29 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:42649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42649/tests/kraken/driver.html?testName=ai-astar) 23:45:30 INFO - PROCESS | 5699 | RSS: Main: 282075136 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | __start_tp_report 23:45:30 INFO - PROCESS | 5699 | _x_x_mozilla_page_load 23:45:30 INFO - PROCESS | 5699 | _x_x_mozilla_page_load_details 23:45:30 INFO - PROCESS | 5699 | |i|pagename|runs| 23:45:30 INFO - PROCESS | 5699 | |0;ai-astar;104;112;110;109;113;111;110;110;110;113 23:45:30 INFO - PROCESS | 5699 | |1;audio-beat-detection;150;123;127;192;138;130;150;125;179;126 23:45:30 INFO - PROCESS | 5699 | |2;audio-dft;161;162;162;159;160;160;162;161;161;162 23:45:30 INFO - PROCESS | 5699 | |3;audio-fft;75;83;74;126;77;77;75;73;98;76 23:45:30 INFO - PROCESS | 5699 | |4;audio-oscillator;86;85;116;86;87;98;123;85;85;135 23:45:30 INFO - PROCESS | 5699 | |5;imaging-gaussian-blur;117;116;117;116;116;116;116;117;117;117 23:45:30 INFO - PROCESS | 5699 | |6;imaging-darkroom;146;147;146;146;145;145;146;145;147;146 23:45:30 INFO - PROCESS | 5699 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;96;95 23:45:30 INFO - PROCESS | 5699 | |8;json-parse-financial;55;55;56;53;54;53;54;54;55;54 23:45:30 INFO - PROCESS | 5699 | |9;json-stringify-tinderbox;60;62;61;62;61;62;62;61;61;62 23:45:30 INFO - PROCESS | 5699 | |10;stanford-crypto-aes;84;83;78;81;83;87;81;81;92;81 23:45:30 INFO - PROCESS | 5699 | |11;stanford-crypto-ccm;130;126;125;120;131;121;137;126;141;132 23:45:30 INFO - PROCESS | 5699 | |12;stanford-crypto-pbkdf2;163;161;163;161;166;160;160;163;159;158 23:45:30 INFO - PROCESS | 5699 | |13;stanford-crypto-sha256-iterative;63;64;64;62;63;63;65;63;60;61 23:45:30 INFO - PROCESS | 5699 | __end_tp_report 23:45:30 INFO - PROCESS | 5699 | __start_cc_report 23:45:30 INFO - PROCESS | 5699 | _x_x_mozilla_cycle_collect,1632 23:45:30 INFO - PROCESS | 5699 | __end_cc_report 23:45:30 INFO - PROCESS | 5699 | __startTimestamp1466664330226__endTimestamp 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | ------- Summary: start ------- 23:45:30 INFO - PROCESS | 5699 | Number of tests: 14 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:2.57 (2.3%) stddev-sans-first:1.45 23:45:30 INFO - PROCESS | 5699 | Values: 104.0 112.0 110.0 109.0 113.0 111.0 110.0 110.0 110.0 113.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:144.00 stddev:24.15 (16.8%) stddev-sans-first:25.51 23:45:30 INFO - PROCESS | 5699 | Values: 150.0 123.0 127.0 192.0 138.0 130.0 150.0 125.0 179.0 126.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 23:45:30 INFO - PROCESS | 5699 | Values: 161.0 162.0 162.0 159.0 160.0 160.0 162.0 161.0 161.0 162.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:16.67 (21.8%) stddev-sans-first:17.41 23:45:30 INFO - PROCESS | 5699 | Values: 75.0 83.0 74.0 126.0 77.0 77.0 75.0 73.0 98.0 76.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:85.50 stddev:18.95 (22.2%) stddev-sans-first:19.54 23:45:30 INFO - PROCESS | 5699 | Values: 86.0 85.0 116.0 86.0 87.0 98.0 123.0 85.0 85.0 135.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:45:30 INFO - PROCESS | 5699 | Values: 117.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:45:30 INFO - PROCESS | 5699 | Values: 146.0 147.0 146.0 146.0 145.0 145.0 146.0 145.0 147.0 146.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:45:30 INFO - PROCESS | 5699 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.95 (1.7%) stddev-sans-first:0.97 23:45:30 INFO - PROCESS | 5699 | Values: 55.0 55.0 56.0 53.0 54.0 53.0 54.0 54.0 55.0 54.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 23:45:30 INFO - PROCESS | 5699 | Values: 60.0 62.0 61.0 62.0 61.0 62.0 62.0 61.0 61.0 62.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:3.93 (4.7%) stddev-sans-first:4.15 23:45:30 INFO - PROCESS | 5699 | Values: 84.0 83.0 78.0 81.0 83.0 87.0 81.0 81.0 92.0 81.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:130.50 stddev:6.67 (5.1%) stddev-sans-first:7.07 23:45:30 INFO - PROCESS | 5699 | Values: 130.0 126.0 125.0 120.0 131.0 121.0 137.0 126.0 141.0 132.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:2.37 (1.5%) stddev-sans-first:2.44 23:45:30 INFO - PROCESS | 5699 | Values: 163.0 161.0 163.0 161.0 166.0 160.0 160.0 163.0 159.0 158.0 23:45:30 INFO - PROCESS | 5699 | 23:45:30 INFO - PROCESS | 5699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 23:45:30 INFO - PROCESS | 5699 | Values: 63.0 64.0 64.0 62.0 63.0 63.0 65.0 63.0 60.0 61.0 23:45:30 INFO - PROCESS | 5699 | -------- Summary: end -------- 23:45:30 INFO - PROCESS | 5699 | 23:45:31 INFO - TEST-INFO | 5699: exit 0 23:45:31 INFO - TEST-OK | kraken | took 61295ms 23:45:31 INFO - SUITE-END | took 1175s 23:45:31 INFO - Completed test suite (00:19:35) 23:45:31 INFO - javascript benchmark 23:45:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.6443459002207, 3117.703818137277, 3117.9844100779496, 3147.3705258948216, 3148.5906832111823, 5209.947900520993, 5237.292965449663, 5289.788408463657, 5302.549283310918, 5335.9199612005805, 5305.283786688806, 5316.6544174628625, 5328.5470734987575, 5347.064263753838, 5381.354237491497, 4815.638827087965, 4860.270959356089, 4891.828785992491, 4906.681065730734, 5013.248012798092, 4923.113839508887, 4928.654994150411, 4971.105201063807, 4989.476105008976, 5006.949930500685, 4762.28565715142, 4776.188048031826, 4824.396950381202, 4826.32431459596, 4846.684965477232, 4817.229243321051, 4842.927356089662, 4844.733539655317, 4872.098661747588, 4919.557239848431, 4854.417469903598, 4867.586255168279, 4872.756362181912, 4878.512148785128, 4909.680870743426, 5210.322658054429, 5242.580593552507, 5283.313169287968, 5287.550558202519, 5326.467353264681, 5683.744231509592, 5702.429757024306, 5725.885482290331, 5732.570057245724, 5738.139279108125, 5623.156526521055, 5731.398203188647, 5765.913511297334, 5766.740496677659, 5779.046457334534, 5318.361796584396, 5386.138217885159, 5388.811391601275, 5461.563074953994, 5464.180372944051, 5938.198343223609, 5971.343152253248, 5972.193753843176, 5973.820785376359, 5974.551908606872, 5491.395946445888, 5540.695261760561, 5581.776728930798, 5611.410801865827, 5618.634788738719, 5605.691686957175, 5617.073182924772, 5660.8867822643315, 5685.118806584986, 5693.715314234271, 5663.603547751618, 5665.9716701417055, 5667.1782591524, 5671.092625179951, 5675.943240567624, 5638.4925356718095, 5648.85877853057, 5697.401772813878, 5711.543076553866, 5722.484976352148, 4254.149170165979, 4277.743335399886, 4279.16556271524, 4321.935170972438, 4326.718763280377, 3917.2361389529337, 3965.266425711253, 3975.602439756059, 3989.6409323161056, 4010.5588385277597, 5551.084071128299, 5557.77768889248, 5561.082421400504, 5562.666240025612, 5569.777208911598, 5643.915341269884, 5648.49163575272, 5859.765609375577, 5860.824175274749, 5905.970470147622, 5410.323709536308, 5449.4005659377435, 5456.154296084113, 5457.181422786613, 5509.862253443696, 4797.952020479751, 4830.95169048305, 4842.225243960949, 4848.490908454632, 4883.121038213156, 5865.589408741433, 5917.763289468373, 5941.702914854326, 5978.730957106941, 5995.790147344822, 5824.796132135355, 5829.94170058294, 5831.591788574929, 5836.328822185503, 5837.67892765902, 5999.730012149376, 6014.308354539109, 6019.849503762441, 6040.667763272886, 6044.304904935989, 5542.251796007487, 5550.861228469321, 5562.638428502134, 5593.02122128634, 5736.512396446349, 5695.829125126253, 5699.772009119589, 5699.829005129687, 5700.828975130753, 5721.170430287501, 5569.526590239875, 5580.86047848807, 5581.6371935824045, 5582.804601838916, 5582.939241544093, 5410.269613602113, 5585.078462053716, 5631.943680563142, 5652.971735141298, 5678.858028549319, 5540.058190107611, 5567.860803479945, 5588.329400471969, 5589.385167631476, 5589.916151257653, 5403.621746477709, 5699.686517241592, 5741.684207368635, 5757.91363129545, 5765.336986246635, 5339.252504649275, 5339.359276886643, 5363.517283444508, 5388.218708287355, 5453.345598528043], "value": 5280.267976117685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6072270855816, 611.5994023914336, 619.0250355689786, 625.3184029407945, 633.7274971762146, 29967.10098697037, 33143.1714207145, 41070.38394424082, 41677.58322416775, 41730.791346043305, 43530.0, 43942.0, 43970.34044489335, 43978.56021439793, 44007.119857602826, 8863.778405539848, 9030.142136497023, 9031.819363612723, 9033.367664263504, 9035.819283614324, 8888.333374996868, 8939.150780675825, 9008.909910900873, 9026.684066057689, 9026.819463610724, 9079.364444488889, 9106.499142547158, 9133.45199288045, 9139.405938613969, 9142.314326425512, 9050.049744776803, 9053.0, 9067.637294508211, 9087.227585655228, 9089.363744537884, 8925.73222803317, 8991.325650576233, 9000.909990900138, 9001.279897608176, 9004.054574269672, 39879.8006009971, 40110.39834402486, 40206.0, 40220.59779402227, 40355.0, 3414.2488652496413, 3451.361498122855, 3471.340445315407, 3511.332846759133, 3779.8677046303246, 31312.843435782903, 31380.37239255202, 31920.840395798106, 32132.518012229837, 32996.50505242423, 4117.155983023473, 4182.498100227992, 4213.199492096492, 4228.217779710732, 4419.226635338803, 350282.0, 353343.0, 353423.0, 354058.0, 354438.2278088619, 58236.0, 58961.41038589645, 58977.70511147503, 59003.70498147482, 59013.99999999914, 34969.47545786815, 35759.0, 35827.4625880612, 37809.24381512354, 37815.43276850849, 15637.530874073796, 15651.0, 15697.529074127795, 15700.214989250491, 15709.764353534707, 11862.051035917106, 11950.462229199708, 11950.940245298718, 11954.76090478203, 11954.880451195551, 19128.330508432417, 19238.326658566883, 19292.710609340873, 19294.421167365002, 19343.4196974091, 6608.893819904733, 6751.324867513209, 6880.931190688029, 6947.5831450113155, 6982.79051628452, 883.1786438612153, 983.2674657380297, 1003.7139415266614, 1070.400575677623, 1078.4524207761888, 32182.390880455885, 32185.51721724176, 32453.887462059152, 32494.187645308582, 32645.673543264264, 1101.763120928988, 1145.0896537252904, 1172.7366183266379, 1178.1517307538559, 1225.7548490301974, 16469.670606587802, 17144.571385715455, 17170.31318747261, 17231.56921076958, 17442.0, 607986.0, 608100.0, 611443.0, 614187.0, 614498.0, 57265.71367143221, 57753.422465774805, 57767.0, 58410.707946459996, 58481.70759146177, 1211.1703483114095, 1325.1452812935602, 1356.2337279437086, 1368.5620601407652, 1375.8624137586162, 32317.192070197492, 33241.0, 33547.83226083854, 33733.954379071096, 33746.0, 49067.50932490629, 49312.50687493079, 49831.750841245565, 49838.750806245735, 49863.75068124636, 400738.0, 402072.0, 404101.0, 404893.0, 404934.0, 24538.0, 28060.719392806626, 44713.0, 45351.54648453473, 45422.0, 45692.0, 50172.498275016784, 50176.0, 51275.0, 51509.7424512875, 40857.0, 41560.584394155674, 41858.790706046275, 42957.57042429661, 43700.78149609231, 41117.177656447304, 41722.58277417187, 42287.4853158037, 42465.0, 42632.14735705207, 40290.1941961165, 40855.59144408637, 41319.0, 41746.0, 42210.0, 36085.81957090198, 37648.811755941046, 37730.62269377271, 38255.42616860694, 38375.80812095922, 27866.16401507958, 28383.574246386735, 28490.715092848804, 28654.14037578876, 28738.425231495672], "value": 19965.750964445448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.7873191013032, 380.68403225323004, 397.51106139448484, 399.1776939504619, 405.5275603921432, 17431.825681743194, 19631.509212269666, 19962.0, 20011.399658010247, 20035.899820500894, 17934.5516362091, 18132.546686332847, 18301.267949282046, 18418.631627367446, 18701.34545290915, 5583.637063590863, 5660.858478538028, 5731.312242530902, 5782.681952492611, 5787.50806181475, 5468.671879687212, 5598.356189038272, 5600.85997850055, 5616.185653080322, 5628.690422026787, 5566.109422492402, 5574.080276754331, 5578.665280083188, 5588.413216612258, 5694.487496125348, 5414.296141501599, 5516.117421212627, 5539.390667026624, 5561.110222364423, 5673.546116310686, 4854.6116310695415, 4908.509149085098, 4921.8523444296725, 5003.424606170301, 5009.073321435546, 22107.668384974237, 22249.0, 22455.438614034618, 22761.88619056911, 22819.657705134436, 2296.379977406091, 2381.1783037100918, 2606.4135569496902, 2929.6191495105713, 3020.75833933287, 13925.651858703512, 14009.0193686442, 14139.0, 14288.642783930485, 14658.560243192722, 1878.1736036144189, 1928.469670840516, 1931.9323823666246, 1955.4915721912264, 2022.7572691277142, 73559.0, 77043.0, 77140.61429692815, 80009.19990800075, 81134.59432702858, 9803.754906127262, 10386.844197337046, 10839.783204335869, 10851.348919064723, 11013.944930275458, 15349.309281082154, 15418.152001640017, 15462.14958177311, 15488.225588720745, 15505.922470387575, 7556.508826926232, 7648.42636802242, 7649.502782319131, 7670.27132422419, 7794.181610930884, 7259.310365515267, 7285.635718214068, 7444.399454117391, 7462.067241594801, 7569.318761311399, 4555.794989225493, 4666.440027196758, 4683.7892294846815, 4728.196206644879, 4799.568038876518, 1855.4433669898976, 1909.3794516782102, 1922.5866438715743, 1929.2379510093435, 1952.287415093509, 871.4858233642182, 931.7297983584684, 998.0, 1003.6487229469627, 1008.1531513528524, 17681.557961050818, 18411.447656570323, 18880.24479020824, 18907.43277701671, 19261.0, 949.5252373813094, 954.6515521834481, 954.8472244440856, 988.1699372527112, 994.597188138805, 10453.425061621683, 10644.148468122532, 10648.307859989076, 10707.625233116803, 10718.517666705016, 435508.0, 497299.0, 500088.0, 503501.0, 504832.0, 94754.52622736842, 96705.51647241719, 96862.51568742111, 97593.0, 98045.5097724521, 935.9953200233955, 941.4727752458508, 957.7031120352713, 964.002257663315, 989.3420875117966, 16403.753943691092, 16594.50216493507, 16753.24610392511, 16812.075335856156, 16955.067471289196, 40783.796081019405, 41451.7927410361, 41624.375634366115, 42742.358864616435, 42968.0, 55816.720916396785, 56022.837487875484, 57265.42734572768, 58185.418145818, 58425.12362314654, 8289.792755180928, 8381.37139714536, 8404.53775042354, 8405.117462666332, 8531.658733650584, 9450.480223587769, 11590.246633968765, 12932.676683082998, 13012.089153759145, 13221.0, 11207.0, 11467.369294688871, 11506.482208300478, 11763.705907352385, 11887.643370698894, 5331.134927177765, 10977.17671174681, 11462.140339474407, 11464.94267528657, 11613.3612651305, 11457.369844658624, 11570.479328430072, 11734.647960561197, 11992.76014479723, 12130.636080917586, 7210.71157153708, 7454.552726836408, 7575.810604734926, 7916.604169791372, 8782.516961567175, 11049.72375690582, 11640.708982275512, 11732.12009099304, 11738.530458781896, 11795.764084718428], "value": 9078.485628277693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.7629826631203, 1421.1473116130323, 1465.54568083894, 1485.2054151029201, 1541.160067763069, 8097.352211823055, 8421.789455263613, 8433.325333973282, 8714.085021072791, 8719.128087191279, 8451.746447606567, 8623.310135189186, 8636.352273579476, 8639.222469977702, 8643.74068777936, 2052.917883284667, 2120.8515403921733, 2121.7559980602196, 2368.0, 2394.1261439574605, 2335.194357946514, 2402.0, 2405.386626410263, 2419.0444774314224, 2427.854328740272, 2292.3123063081093, 2297.310806757974, 2311.884405779713, 2314.085936055257, 2343.94140146496, 2004.5088953206412, 2250.763669814662, 2332.090484710964, 2342.3441436397834, 2345.4722687395283, 2319.512902290521, 2363.1728894886824, 2366.0299277296226, 2366.0654041653625, 2369.087901158049, 8792.120787921222, 8909.287257019489, 8918.152775486318, 8927.419717718392, 8940.195382415548, 5030.949690503121, 5136.717480538568, 5140.485951404867, 5146.691198528063, 5149.124648809711, 3180.745540356766, 3273.738100951918, 3371.7134043606325, 3394.7623666343366, 3404.285100128976, 1137.7212582917155, 1140.3727949627755, 1146.707589564664, 1170.8477897873306, 1180.887815657511, 11635.069194464422, 11702.356370399624, 11704.765904681859, 11725.882741172565, 11734.765304693943, 4346.456692913386, 4426.822927082945, 4516.187086324428, 4534.7052441591195, 4535.206338890681, 9788.314817962817, 9804.558794854105, 9806.313558050868, 9895.406275623342, 9904.752381190528, 5115.820946266937, 5174.508421699932, 5179.093658609803, 5186.507281808223, 5187.58499320061, 4147.315692910636, 4701.153792317347, 4787.353707249476, 4791.928121078186, 4879.585235255043, 3868.5357757069332, 3870.4581358609817, 3952.525696916331, 3977.3636218204947, 4010.7593544387432, 1208.5045131496045, 1216.4951545108859, 1240.2620440837868, 1244.2037096258402, 1248.5528364405866, 876.4259410086404, 878.0604752914448, 988.836841921075, 991.2218908157062, 1028.6965345223177, 6060.33336333003, 6187.659678717624, 6280.874382512324, 6308.968455157695, 6397.904031439532, 929.4005366538545, 936.4942930817418, 954.6992697300328, 964.5611246882792, 971.9514024298899, 4309.935350969738, 4314.61168494837, 4355.216061109031, 4455.77721113943, 4465.93458964637, 10631.149508039338, 10639.095676867399, 10978.780424391627, 10982.450877456095, 11003.669889903316, 10681.412522311191, 10740.140788736882, 10793.0, 10804.405757683246, 10812.405317707602, 7804.141544430108, 8076.636551355085, 8135.430519863553, 8297.83404331922, 8443.662253509914, 5978.133170690313, 6349.777757778455, 6370.394812492991, 6400.135981642418, 6446.7098980546925, 10248.333858299187, 10266.178705703674, 10361.637342693271, 10509.31689440184, 10521.263511554118, 10373.325733827278, 10426.27016108865, 10522.31604945676, 10538.631147909786, 10604.734881628021, 8238.464499807493, 8355.248027677539, 8383.28742056932, 8479.448835825651, 8498.362622803192, 8414.495130291958, 8440.451370660887, 8473.322134229124, 8475.872861907199, 8521.0, 7135.429165666838, 7530.962345188458, 7934.722284720007, 7944.126146124037, 8017.158198389086, 7459.962700186465, 7607.505512141693, 7769.223077692185, 7803.297703206512, 7817.296443319901, 6992.475564332797, 6993.685284162123, 7078.8938165928585, 7087.220405755466, 7092.25531319204, 5205.0, 5245.186996015624, 5274.947250527445, 5331.120365139708, 5334.279872217201, 4942.604591632589, 5059.443461219336, 5201.817936372209, 5277.340332458442, 5299.364076310867], "value": 4635.076648853674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.5416647944843, 312.9076922307919, 318.22988368149083, 325.2795058944438, 329.32652725177013, 5110.693358398498, 5142.460041695615, 5279.6040296977735, 5299.258103865457, 5332.546733527654, 5238.8690282742955, 5247.795925711201, 5250.369955605323, 5255.76349064292, 5282.894342113165, 4109.28087584673, 4127.750376045047, 4149.128682976579, 4162.8126734296875, 4171.019810344566, 3932.1742434088874, 3950.2889479893606, 4111.095558977036, 4134.751914885116, 4171.332586786115, 4082.4080508326274, 4085.1625416789634, 4118.629323360897, 4119.958800411988, 4122.443470131524, 4090.713650044498, 4115.238680844023, 4126.42230087788, 4129.938050929239, 4147.129102888397, 3407.1993081625797, 3666.0, 3673.8530458781615, 3676.3015027144756, 3678.6021311901573, 5052.520010598987, 5095.847124586268, 5110.8466745997675, 5125.3080834087295, 5128.948710512922, 4678.23983849527, 4694.694844835109, 4699.530046995274, 4706.858794236178, 4708.387909571768, 5293.6294459387855, 5372.865678358073, 5489.3412790465, 5514.6691198527815, 5528.612997090206, 3889.1638297765835, 3921.1961547882615, 3924.5675328505176, 3929.4302326162547, 3931.3513270310364, 5626.578006649518, 5637.7181140942785, 5656.943430565724, 5668.744906479218, 5721.656700598019, 3965.2862484752445, 3995.62041606047, 4001.639852413297, 4005.2790497710107, 4008.318585840414, 3817.3892177251505, 4004.519457665099, 4006.2187873364414, 4006.3990401439432, 4031.07285324377, 4531.278114316538, 4582.518835522289, 4584.174848527297, 4623.583877451046, 4631.235846085358, 5516.393196748354, 5535.6955367455175, 5554.694491802989, 5589.608727389125, 5593.0, 1303.7131830997166, 1307.9542216022394, 1366.4670778396433, 1373.9587812365644, 1379.7930310453312, 864.5720368417674, 864.7103220421229, 875.4134729731095, 878.1525827576291, 880.295763389286, 4646.279826626878, 4689.484156742756, 4702.401183597593, 4721.598664113589, 4770.616521208811, 4967.60259179272, 4999.600111968654, 4999.850004499871, 5004.674696144739, 5008.749562521859, 4615.215413379734, 4715.434147902273, 4726.251287023823, 4733.60358694186, 4793.664443488992, 2599.8830052647677, 2693.8653067346554, 2701.540738074532, 2706.7428594283906, 2714.83710977342, 5207.739613019334, 5208.661437006583, 5214.556762675139, 5249.451411833518, 5255.0, 4849.733264670406, 4863.319135321058, 5042.243663450512, 5074.0, 5144.408393034774, 4965.939135258972, 5095.363079615048, 5101.821436249714, 5130.48695130484, 5152.92270615941, 4851.927221091757, 4864.562189402971, 4902.872339361896, 4979.526944940225, 5033.949660503348, 4684.5549672781035, 4887.189865827235, 4894.339264199288, 4940.654154209171, 4951.282064100613, 5071.695698258116, 5116.872078198075, 5137.484442089667, 5144.742762861917, 5147.742612869416, 3525.7483593324, 3569.821958753657, 3607.314610224154, 3621.7826930384263, 3765.7008332125374, 5499.615026948075, 5630.943690563206, 5630.971845140748, 5672.14917762339, 5678.176664383559, 5441.83674489766, 5478.205660179172, 5500.862478438071, 5558.944410556004, 5573.554115670656, 5217.478252174752, 5444.26502422168, 5445.156000819879, 5515.510812080796, 5560.026190702242, 5352.250684904038, 5389.892202156013, 5402.27069345649, 5427.83716488506, 5432.0, 5510.366307874646, 5549.1676248563035, 5564.8330550083565, 5570.415106413769, 5583.218349431164, 5125.282460455464, 5347.705876176848, 5396.541293990055, 5398.487143721497, 5400.648957817729], "value": 4024.9260563341245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.9548827070377, 773.5590713293425, 797.9999999999999, 816.3102178659033, 838.1827717974979, 13794.10338328008, 15020.09879407235, 15846.76229856553, 16378.099204543745, 16422.507324780247, 14095.295235238224, 14181.78727319091, 14201.0, 14211.78682319766, 14230.715385692305, 782.8473447677691, 785.4776573578563, 789.0058526256901, 789.5657388436366, 790.3598085550693, 666.7233098264214, 776.1268572855538, 789.5775759968418, 792.7146227358146, 795.558465051896, 807.9878801817978, 810.2383759266271, 810.3517186250975, 811.4847072109224, 812.0985705866483, 683.8769021576114, 806.3871457692137, 806.4072906413782, 806.5604245686086, 808.030363563723, 594.1711312718733, 598.8413070536311, 600.4835841176584, 601.308495230484, 602.2652364115771, 13748.106373085717, 13760.518381856587, 13781.173129612256, 13888.23614701191, 13897.513587024405, 13198.0, 13253.668658283523, 13562.59312220635, 13822.308884555732, 13825.101368411122, 11731.366963185466, 11873.881261187364, 12170.208936419192, 12751.87248127516, 13525.120867143603, 3878.4957955465893, 3939.606039396066, 3951.38753493209, 3989.0625702959783, 4114.897127571835, 75952.24047759507, 76102.0, 76319.61840190818, 76803.0, 77291.61354193193, 10199.18406527476, 10567.788644227072, 11121.666350009513, 11136.220464567565, 11302.208845380908, 19221.32725354606, 19412.320568780306, 20018.799812001984, 20024.299149529696, 21045.579088418144, 8349.54077525742, 8388.286995605442, 8398.580070996426, 8414.537200453911, 8428.072911979678, 4740.420917542484, 4768.237082066853, 4771.856844294677, 4824.276358546246, 4846.830360937351, 3408.437607794736, 3540.592831824322, 3546.66306700863, 3551.4317709166407, 3557.3952428087287, 604.1089393145076, 614.3978900677362, 617.139090968097, 618.6504624887015, 650.0963660511892, 580.4572724502603, 658.1444122640548, 689.9931000690029, 730.2296077638143, 737.5464089584974, 9496.525173741285, 9523.57143928525, 9544.9977752335, 9819.214462843098, 9938.900610993942, 573.5956150913596, 664.6676661669165, 692.988237173732, 712.9648857377329, 738.6824013640264, 4596.264597664358, 4800.807967681254, 4929.383827021622, 4937.580305673986, 4949.703017818871, 68219.0, 68601.0, 69504.3049569508, 104398.47800760948, 113527.43236283766, 98874.5056274714, 99614.0, 100274.0, 100381.0, 101059.49470252602, 67813.66093169601, 84590.5770471156, 85880.57059714786, 89948.0, 90063.0, 9520.714378568655, 9596.95201523988, 9645.228381729585, 9744.220462362851, 9768.218542516439, 47843.28235076407, 49202.507974921224, 49938.50061499484, 50641.0, 50674.692651125064, 74144.0, 76888.0, 77024.2297577017, 78481.0, 78846.21153788618, 12233.0, 12302.630921072383, 12811.807822882478, 12827.102102853083, 12994.54519091865, 13540.661483462993, 13675.316234188449, 13740.244286564335, 14497.130172189702, 14648.707025859636, 12571.0, 12730.17253878495, 12936.353182341034, 13107.410166542339, 13259.071864969359, 12630.557930472389, 12670.113092083466, 12968.610941671765, 13021.804672929724, 13407.0, 12410.503579856704, 13309.733805323645, 13417.0, 13484.86515134836, 13866.584002479942, 10516.842247366143, 10654.946725266323, 10740.83888741654, 10802.735673942681, 11030.889691103308, 10311.329763565343, 10728.195385345975, 11024.944875275572, 11277.379744114152, 11431.314121152758], "value": 7334.1120560963545, "unit": "score"}], "name": "dromaeo_css", "value": 7126.244665690929, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 110.0, 109.0, 113.0, 111.0, 110.0, 110.0, 110.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 127.0, 192.0, 138.0, 130.0, 150.0, 125.0, 179.0, 126.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 159.0, 160.0, 160.0, 162.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 74.0, 126.0, 77.0, 77.0, 75.0, 73.0, 98.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 116.0, 86.0, 87.0, 98.0, 123.0, 85.0, 85.0, 135.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 53.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 78.0, 81.0, 83.0, 87.0, 81.0, 81.0, 92.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 125.0, 120.0, 131.0, 121.0, 137.0, 126.0, 141.0, 132.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 166.0, 160.0, 160.0, 163.0, 159.0, 158.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 63.0, 63.0, 65.0, 63.0, 60.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1507.2, "alertThreshold": 2.0}]} 23:45:31 INFO - Return code: 0 23:45:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:45:31 INFO - # TBPL SUCCESS # 23:45:31 INFO - Running post-action listener: _resource_record_post_action 23:45:31 INFO - ##### 23:45:31 INFO - ##### Finished run-tests step (success) 23:45:31 INFO - ##### 23:45:31 INFO - Running post-run listener: _resource_record_post_run 23:45:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 551665664; Read time: 0; Write time: 432612 23:45:31 INFO - TinderboxPrint: CPU usage
13.3% 23:45:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:45:31 INFO - TinderboxPrint: I/O write bytes / time
551,665,664 / 432,612 23:45:31 INFO - TinderboxPrint: CPU idle
8,263.5 (86.7%) 23:45:31 INFO - TinderboxPrint: CPU user
1,216.0 (12.8%) 23:45:31 INFO - TinderboxPrint: Swap in / out
0 / 0 23:45:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256684032; Read time: 0; Write time: 240348 23:45:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294981632; Read time: 0; Write time: 192264 23:45:32 INFO - Running post-run listener: _upload_blobber_files 23:45:32 INFO - Blob upload gear active. 23:45:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:45:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:45:32 INFO - (blobuploader) - INFO - Open directory for files ... 23:45:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:45:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:45:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:36 INFO - (blobuploader) - INFO - Done attempting. 23:45:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:45:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:45:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:37 INFO - (blobuploader) - INFO - Done attempting. 23:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:45:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:38 INFO - (blobuploader) - INFO - Done attempting. 23:45:38 INFO - (blobuploader) - INFO - Iteration through files over. 23:45:38 INFO - Return code: 0 23:45:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:45:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:45:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7401bdb12548cd991d7f3b0aa2bf31c6170d672599255095550dd568c4e9107651cc7017dd6fd9ac62a6990443475ecd95f613440fca30cd82271dbc8e3c352", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef635241747e6be96d98dc434cacacabdf95d1cc1b0dbbe485640aa775fc2a0084e10fd0f58a33c012114bc59e79f800ed89a58230ecf2834ef4f4e7f85ef88a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1024e4ca5990253add27e5aad75dcc50d1a83fca5779c60604c35551e7dcbe7aae7600bcc6a1f1890009cc39e78ffa405fd1c5a06d3a0652747d3e16179956c7"} 23:45:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:45:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:45:38 INFO - Contents: 23:45:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7401bdb12548cd991d7f3b0aa2bf31c6170d672599255095550dd568c4e9107651cc7017dd6fd9ac62a6990443475ecd95f613440fca30cd82271dbc8e3c352", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef635241747e6be96d98dc434cacacabdf95d1cc1b0dbbe485640aa775fc2a0084e10fd0f58a33c012114bc59e79f800ed89a58230ecf2834ef4f4e7f85ef88a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1024e4ca5990253add27e5aad75dcc50d1a83fca5779c60604c35551e7dcbe7aae7600bcc6a1f1890009cc39e78ffa405fd1c5a06d3a0652747d3e16179956c7"} 23:45:38 INFO - Running post-run listener: copy_logs_to_upload_dir 23:45:38 INFO - Copying logs to upload dir... 23:45:38 INFO - mkdir: /builds/slave/test/build/upload/logs 23:45:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.619681 ========= master_lag: 74.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2016-06-22 23:46:52.296020) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-22 23:46:52.306811) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7401bdb12548cd991d7f3b0aa2bf31c6170d672599255095550dd568c4e9107651cc7017dd6fd9ac62a6990443475ecd95f613440fca30cd82271dbc8e3c352", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef635241747e6be96d98dc434cacacabdf95d1cc1b0dbbe485640aa775fc2a0084e10fd0f58a33c012114bc59e79f800ed89a58230ecf2834ef4f4e7f85ef88a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1024e4ca5990253add27e5aad75dcc50d1a83fca5779c60604c35551e7dcbe7aae7600bcc6a1f1890009cc39e78ffa405fd1c5a06d3a0652747d3e16179956c7"} build_url:https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/DrqVNH28TfKqRHsD8WnsBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7401bdb12548cd991d7f3b0aa2bf31c6170d672599255095550dd568c4e9107651cc7017dd6fd9ac62a6990443475ecd95f613440fca30cd82271dbc8e3c352", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef635241747e6be96d98dc434cacacabdf95d1cc1b0dbbe485640aa775fc2a0084e10fd0f58a33c012114bc59e79f800ed89a58230ecf2834ef4f4e7f85ef88a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1024e4ca5990253add27e5aad75dcc50d1a83fca5779c60604c35551e7dcbe7aae7600bcc6a1f1890009cc39e78ffa405fd1c5a06d3a0652747d3e16179956c7"}' ========= master_lag: 2.44 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-06-22 23:46:54.755451) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:46:54.755836) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1466661170.991840-1588055306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 23:46:55.146756) ========= ========= Started reboot skipped (results: 3, elapsed: 12 secs) (at 2016-06-22 23:46:55.151107) ========= ========= Finished reboot skipped (results: 3, elapsed: 12 secs) (at 2016-06-22 23:47:07.762290) ========= ========= Total master_lag: 77.26 =========