builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1467191959.99 results: success (0) buildid: 20160628233029 builduid: bcf5534bf1f04266b156d89acb86d2da revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:19.988813) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:19.989516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:19.989951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:20.011611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:20.011873) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 02:19:20-- 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% 38.4M=0s 2016-06-29 02:19:20 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.312367 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:20.339914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:20.340212) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017810 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:20.390428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:20.390819) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1af8a633527ae1c95bf0e630a75f9810be3995d --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 e1af8a633527ae1c95bf0e630a75f9810be3995d --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=9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 02:19:20,566 truncating revision to first 12 chars 2016-06-29 02:19:20,566 Setting DEBUG logging. 2016-06-29 02:19:20,566 attempt 1/10 2016-06-29 02:19:20,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1af8a633527?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 02:19:20,886 unpacking tar archive at: fx-team-e1af8a633527/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:21.248256) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:21.248869) ========= script_repo_revision: e1af8a633527ae1c95bf0e630a75f9810be3995d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:21.249634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:21.250272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:19:21.261416) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 21 secs) (at 2016-06-29 02:19:21.261705) ========= /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=9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:19:21 INFO - MultiFileLogger online at 20160629 02:19:21 in /builds/slave/test 02:19:21 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 02:19:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:21 INFO - {'append_to_log': False, 02:19:21 INFO - 'base_work_dir': '/builds/slave/test', 02:19:21 INFO - 'blob_upload_branch': 'Fx-Team', 02:19:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:21 INFO - 'branch': 'Fx-Team', 02:19:21 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:21 INFO - 'config_files': ('talos/linux_config.py',), 02:19:21 INFO - 'default_actions': ('clobber', 02:19:21 INFO - 'read-buildbot-config', 02:19:21 INFO - 'download-and-extract', 02:19:21 INFO - 'populate-webroot', 02:19:21 INFO - 'create-virtualenv', 02:19:21 INFO - 'install', 02:19:21 INFO - 'run-tests'), 02:19:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:21 INFO - 'download_minidump_stackwalk': True, 02:19:21 INFO - 'download_symbols': 'ondemand', 02:19:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:21 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:21 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:21 INFO - 'installer_path': 'installer.exe', 02:19:21 INFO - 'log_level': 'info', 02:19:21 INFO - 'log_name': 'talos', 02:19:21 INFO - 'log_to_console': True, 02:19:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:19:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:19:21 INFO - 'opt_config_files': (), 02:19:21 INFO - 'pip_index': False, 02:19:21 INFO - 'sps_profile': False, 02:19:21 INFO - 'sps_profile_interval': 0, 02:19:21 INFO - 'suite': 'dromaeojs', 02:19:21 INFO - 'system_bits': '32', 02:19:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:21 INFO - 'title': 'talos-linux64-ix-029', 02:19:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:21 INFO - 'use_talos_json': True, 02:19:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:21 INFO - 'work_dir': 'build'} 02:19:21 INFO - ##### 02:19:21 INFO - ##### Running clobber step. 02:19:21 INFO - ##### 02:19:21 INFO - Running pre-action listener: _resource_record_pre_action 02:19:21 INFO - Running main action method: clobber 02:19:21 INFO - rmtree: /builds/slave/test/build 02:19:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:21 INFO - Running post-action listener: _resource_record_post_action 02:19:21 INFO - ##### 02:19:21 INFO - ##### Finished clobber step (success) 02:19:21 INFO - ##### 02:19:21 INFO - ##### 02:19:21 INFO - ##### Running read-buildbot-config step. 02:19:21 INFO - ##### 02:19:21 INFO - Running pre-action listener: _resource_record_pre_action 02:19:21 INFO - Running main action method: read_buildbot_config 02:19:21 INFO - Using buildbot properties: 02:19:21 INFO - { 02:19:21 INFO - "project": "", 02:19:21 INFO - "product": "firefox", 02:19:21 INFO - "script_repo_revision": "production", 02:19:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:19:21 INFO - "repository": "", 02:19:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:19:21 INFO - "buildid": "20160628233029", 02:19:21 INFO - "pgo_build": "True", 02:19:21 INFO - "basedir": "/builds/slave/test", 02:19:21 INFO - "buildnumber": 843, 02:19:21 INFO - "slavename": "talos-linux64-ix-029", 02:19:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:19:21 INFO - "platform": "ubuntu64_hw", 02:19:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:19:21 INFO - "branch": "fx-team", 02:19:21 INFO - "repo_path": "integration/fx-team", 02:19:21 INFO - "revision": "e1af8a633527ae1c95bf0e630a75f9810be3995d", 02:19:21 INFO - "stage_platform": "linux64-pgo", 02:19:21 INFO - "builduid": "bcf5534bf1f04266b156d89acb86d2da", 02:19:21 INFO - "slavebuilddir": "test" 02:19:21 INFO - } 02:19:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:19:21 INFO - Running post-action listener: _resource_record_post_action 02:19:21 INFO - ##### 02:19:21 INFO - ##### Finished read-buildbot-config step (success) 02:19:21 INFO - ##### 02:19:21 INFO - ##### 02:19:21 INFO - ##### Running download-and-extract step. 02:19:21 INFO - ##### 02:19:21 INFO - Running pre-action listener: _resource_record_pre_action 02:19:21 INFO - Running main action method: download_and_extract 02:19:21 INFO - mkdir: /builds/slave/test/build/tests 02:19:21 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')]} 02:19:21 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:19:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:24 INFO - Downloaded 1361 bytes. 02:19:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:19:24 INFO - Using the following test package requirements: 02:19:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:19:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:19:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'jsshell-linux-x86_64.zip'], 02:19:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:19:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:19:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:19:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:19:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:19:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:19:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:19:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:19:24 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')]} 02:19:24 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:25 INFO - Downloaded 24267054 bytes. 02:19:25 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'] 02:19:25 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 02:19:27 INFO - Return code: 0 02:19:27 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 02:19:27 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')]} 02:19:27 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:19:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:19:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:37 INFO - Downloaded 24267054 bytes. 02:19:37 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'] 02:19:37 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 02:19:38 INFO - Return code: 0 02:19:38 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')]} 02:19:38 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:19:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:19:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:19:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:40 INFO - Downloaded 14405245 bytes. 02:19:40 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'] 02:19:40 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 02:19:40 INFO - Return code: 0 02:19:40 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')]} 02:19:40 INFO - https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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 02:19:41 INFO - Downloaded 60319705 bytes. 02:19:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:41 INFO - mkdir: /builds/slave/test/properties 02:19:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:41 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:41 INFO - Contents: 02:19:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:42 INFO - Running post-action listener: _resource_record_post_action 02:19:42 INFO - Running post-action listener: set_extra_try_arguments 02:19:42 INFO - ##### 02:19:42 INFO - ##### Finished download-and-extract step (success) 02:19:42 INFO - ##### 02:19:42 INFO - ##### 02:19:42 INFO - ##### Running populate-webroot step. 02:19:42 INFO - ##### 02:19:42 INFO - Running pre-action listener: _resource_record_pre_action 02:19:42 INFO - Running main action method: populate_webroot 02:19:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:42 INFO - '--tppagecycles', 02:19:42 INFO - '7'], 02:19:42 INFO - 'tests': ['tsvgm']}}, 02:19:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['damp', 'tps']}, 02:19:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'tests': ['damp', 'tps']}, 02:19:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['dromaeo_dom']}, 02:19:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['basic_compositor_video']}, 02:19:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['a11yr', 02:19:42 INFO - 'ts_paint', 02:19:42 INFO - 'tpaint', 02:19:42 INFO - 'sessionrestore', 02:19:42 INFO - 'sessionrestore_no_auto_restore', 02:19:42 INFO - 'tabpaint']}, 02:19:42 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:42 INFO - 'ts_paint', 02:19:42 INFO - 'tpaint', 02:19:42 INFO - 'sessionrestore', 02:19:42 INFO - 'sessionrestore_no_auto_restore', 02:19:42 INFO - 'tabpaint']}, 02:19:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:42 INFO - 'ts_paint', 02:19:42 INFO - 'tpaint', 02:19:42 INFO - 'sessionrestore', 02:19:42 INFO - 'sessionrestore_no_auto_restore', 02:19:42 INFO - 'tabpaint']}, 02:19:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:42 INFO - 'ts_paint', 02:19:42 INFO - 'tpaint', 02:19:42 INFO - 'sessionrestore', 02:19:42 INFO - 'sessionrestore_no_auto_restore', 02:19:42 INFO - 'tabpaint']}, 02:19:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['a11yr', 02:19:42 INFO - 'ts_paint', 02:19:42 INFO - 'tpaint', 02:19:42 INFO - 'sessionrestore', 02:19:42 INFO - 'sessionrestore_no_auto_restore', 02:19:42 INFO - 'tabpaint']}, 02:19:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['a11yr', 02:19:42 INFO - 'ts_paint', 02:19:42 INFO - 'tpaint', 02:19:42 INFO - 'sessionrestore', 02:19:42 INFO - 'sessionrestore_no_auto_restore', 02:19:42 INFO - 'tabpaint']}, 02:19:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['tsvgx', 02:19:42 INFO - 'tsvgr_opacity', 02:19:42 INFO - 'tart', 02:19:42 INFO - 'tscrollx', 02:19:42 INFO - 'cart']}, 02:19:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:42 INFO - 'tsvgr_opacity', 02:19:42 INFO - 'tart', 02:19:42 INFO - 'tscrollx', 02:19:42 INFO - 'cart']}, 02:19:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'talos_options': ['--disable-e10s'], 02:19:42 INFO - 'tests': ['tp5o']}, 02:19:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'tests': ['tp5o']}, 02:19:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'talos_options': ['--disable-e10s', 02:19:42 INFO - '--xperf_path', 02:19:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:42 INFO - 'tests': ['tp5n']}, 02:19:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:42 INFO - 'talos_options': ['--xperf_path', 02:19:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:42 INFO - 'tests': ['tp5n']}}, 02:19:42 INFO - 'talos.zip': {'path': '', 02:19:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:42 INFO - Running post-action listener: _resource_record_post_action 02:19:42 INFO - ##### 02:19:42 INFO - ##### Finished populate-webroot step (success) 02:19:42 INFO - ##### 02:19:42 INFO - ##### 02:19:42 INFO - ##### Running create-virtualenv step. 02:19:42 INFO - ##### 02:19:42 INFO - Running pre-action listener: _resource_record_pre_action 02:19:42 INFO - Running main action method: create_virtualenv 02:19:42 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:42 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 02:19:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:42 INFO - Using real prefix '/usr' 02:19:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:42 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:44 INFO - Installing pip.................done. 02:19:44 INFO - Return code: 0 02:19:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:44 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')]} 02:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:44 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')]} 02:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:44 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:19:44 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 02:19:44 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 02:19:44 INFO - Using env: {'DISPLAY': ':0', 02:19:44 INFO - 'HOME': '/home/cltbld', 02:19:44 INFO - 'LANG': 'en_US.UTF-8', 02:19:44 INFO - 'LANGUAGE': 'en_US:en', 02:19:44 INFO - 'LOGNAME': 'cltbld', 02:19:44 INFO - 'MAIL': '/var/mail/cltbld', 02:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:44 INFO - 'MOZ_NO_REMOTE': '1', 02:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:44 INFO - 'NO_EM_RESTART': '1', 02:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:44 INFO - 'PWD': '/builds/slave/test', 02:19:44 INFO - 'SHELL': '/bin/bash', 02:19:44 INFO - 'SHLVL': '1', 02:19:44 INFO - 'TERM': 'linux', 02:19:44 INFO - 'TMOUT': '86400', 02:19:44 INFO - 'USER': 'cltbld', 02:19:44 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:44 INFO - '_': '/tools/buildbot/bin/python'} 02:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:45 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 02:19:45 INFO - Cleaning up... 02:19:45 INFO - Return code: 0 02:19:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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')]} 02:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:45 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:19:45 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 02:19:45 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 02:19:45 INFO - Using env: {'DISPLAY': ':0', 02:19:45 INFO - 'HOME': '/home/cltbld', 02:19:45 INFO - 'LANG': 'en_US.UTF-8', 02:19:45 INFO - 'LANGUAGE': 'en_US:en', 02:19:45 INFO - 'LOGNAME': 'cltbld', 02:19:45 INFO - 'MAIL': '/var/mail/cltbld', 02:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:45 INFO - 'MOZ_NO_REMOTE': '1', 02:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:45 INFO - 'NO_EM_RESTART': '1', 02:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:45 INFO - 'PWD': '/builds/slave/test', 02:19:45 INFO - 'SHELL': '/bin/bash', 02:19:45 INFO - 'SHLVL': '1', 02:19:45 INFO - 'TERM': 'linux', 02:19:45 INFO - 'TMOUT': '86400', 02:19:45 INFO - 'USER': 'cltbld', 02:19:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:45 INFO - '_': '/tools/buildbot/bin/python'} 02:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:45 INFO - Downloading/unpacking psutil>=3.1.1 02:19:45 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 02:19:45 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 02:19:45 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 02:19:45 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 02:19:45 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 02:19:45 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 02:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:47 INFO - Installing collected packages: psutil 02:19:47 INFO - Running setup.py install for psutil 02:19:47 INFO - building 'psutil._psutil_linux' extension 02:19:47 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 02:19:47 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 02:19:47 INFO - building 'psutil._psutil_posix' extension 02:19:47 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 02:19:47 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 02:19:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:47 INFO - Successfully installed psutil 02:19:47 INFO - Cleaning up... 02:19:47 INFO - Return code: 0 02:19:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19:47 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')]} 02:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:47 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')]} 02:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:47 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:19:47 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 02:19:47 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 02:19:47 INFO - Using env: {'DISPLAY': ':0', 02:19:47 INFO - 'HOME': '/home/cltbld', 02:19:47 INFO - 'LANG': 'en_US.UTF-8', 02:19:47 INFO - 'LANGUAGE': 'en_US:en', 02:19:47 INFO - 'LOGNAME': 'cltbld', 02:19:47 INFO - 'MAIL': '/var/mail/cltbld', 02:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:47 INFO - 'MOZ_NO_REMOTE': '1', 02:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:47 INFO - 'NO_EM_RESTART': '1', 02:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:47 INFO - 'PWD': '/builds/slave/test', 02:19:47 INFO - 'SHELL': '/bin/bash', 02:19:47 INFO - 'SHLVL': '1', 02:19:47 INFO - 'TERM': 'linux', 02:19:47 INFO - 'TMOUT': '86400', 02:19:47 INFO - 'USER': 'cltbld', 02:19:47 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:47 INFO - '_': '/tools/buildbot/bin/python'} 02:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:48 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 02:19:48 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 02:19:48 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 02:19:48 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 02:19:48 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 02:19:48 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 02:19:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:50 INFO - Installing collected packages: mozsystemmonitor 02:19:50 INFO - Running setup.py install for mozsystemmonitor 02:19:50 INFO - Successfully installed mozsystemmonitor 02:19:50 INFO - Cleaning up... 02:19:50 INFO - Return code: 0 02:19:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:50 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')]} 02:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:50 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')]} 02:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:50 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:19:50 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 02:19:50 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 02:19:50 INFO - Using env: {'DISPLAY': ':0', 02:19:50 INFO - 'HOME': '/home/cltbld', 02:19:50 INFO - 'LANG': 'en_US.UTF-8', 02:19:50 INFO - 'LANGUAGE': 'en_US:en', 02:19:50 INFO - 'LOGNAME': 'cltbld', 02:19:50 INFO - 'MAIL': '/var/mail/cltbld', 02:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:50 INFO - 'MOZ_NO_REMOTE': '1', 02:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:50 INFO - 'NO_EM_RESTART': '1', 02:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:50 INFO - 'PWD': '/builds/slave/test', 02:19:50 INFO - 'SHELL': '/bin/bash', 02:19:50 INFO - 'SHLVL': '1', 02:19:50 INFO - 'TERM': 'linux', 02:19:50 INFO - 'TMOUT': '86400', 02:19:50 INFO - 'USER': 'cltbld', 02:19:50 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:50 INFO - '_': '/tools/buildbot/bin/python'} 02:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:50 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:50 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 02:19:50 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 02:19:50 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 02:19:50 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 02:19:50 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 02:19:50 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 02:19:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:52 INFO - warning: no files found matching '*.txt' 02:19:52 INFO - no previously-included directories found matching 'build' 02:19:52 INFO - no previously-included directories found matching 'dist' 02:19:52 INFO - no previously-included directories found matching '.git*' 02:19:52 INFO - Installing collected packages: jsonschema, functools32 02:19:52 INFO - Running setup.py install for functools32 02:19:52 INFO - warning: no files found matching '*.txt' 02:19:52 INFO - no previously-included directories found matching 'build' 02:19:52 INFO - no previously-included directories found matching 'dist' 02:19:52 INFO - no previously-included directories found matching '.git*' 02:19:52 INFO - Successfully installed jsonschema functools32 02:19:52 INFO - Cleaning up... 02:19:52 INFO - Return code: 0 02:19:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19:52 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')]} 02:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:52 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')]} 02:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:52 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:19:52 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 02:19:52 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 02:19:52 INFO - Using env: {'DISPLAY': ':0', 02:19:52 INFO - 'HOME': '/home/cltbld', 02:19:52 INFO - 'LANG': 'en_US.UTF-8', 02:19:52 INFO - 'LANGUAGE': 'en_US:en', 02:19:52 INFO - 'LOGNAME': 'cltbld', 02:19:52 INFO - 'MAIL': '/var/mail/cltbld', 02:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:52 INFO - 'MOZ_NO_REMOTE': '1', 02:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:52 INFO - 'NO_EM_RESTART': '1', 02:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:52 INFO - 'PWD': '/builds/slave/test', 02:19:52 INFO - 'SHELL': '/bin/bash', 02:19:52 INFO - 'SHLVL': '1', 02:19:52 INFO - 'TERM': 'linux', 02:19:52 INFO - 'TMOUT': '86400', 02:19:52 INFO - 'USER': 'cltbld', 02:19:52 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:52 INFO - '_': '/tools/buildbot/bin/python'} 02:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:52 INFO - Downloading/unpacking blobuploader==1.2.4 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:52 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 02:19:54 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19:54 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 02:19:54 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 02:19:54 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 02:19:54 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 02:19:54 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 02:19:54 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 02:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:55 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 02:19:55 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 02:19:55 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 02:19:55 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 02:19:55 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 02:19:55 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 02:19:55 INFO - Downloading docopt-0.6.1.tar.gz 02:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:55 INFO - Running setup.py install for blobuploader 02:19:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:55 INFO - Running setup.py install for requests 02:19:56 INFO - Running setup.py install for docopt 02:19:56 INFO - Successfully installed blobuploader requests docopt 02:19:56 INFO - Cleaning up... 02:19:56 INFO - Return code: 0 02:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:56 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')]} 02:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:56 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')]} 02:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:56 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:19:56 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 02:19:56 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 02:19:56 INFO - Using env: {'DISPLAY': ':0', 02:19:56 INFO - 'HOME': '/home/cltbld', 02:19:56 INFO - 'LANG': 'en_US.UTF-8', 02:19:56 INFO - 'LANGUAGE': 'en_US:en', 02:19:56 INFO - 'LOGNAME': 'cltbld', 02:19:56 INFO - 'MAIL': '/var/mail/cltbld', 02:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:56 INFO - 'MOZ_NO_REMOTE': '1', 02:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:56 INFO - 'NO_EM_RESTART': '1', 02:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:56 INFO - 'PWD': '/builds/slave/test', 02:19:56 INFO - 'SHELL': '/bin/bash', 02:19:56 INFO - 'SHLVL': '1', 02:19:56 INFO - 'TERM': 'linux', 02:19:56 INFO - 'TMOUT': '86400', 02:19:56 INFO - 'USER': 'cltbld', 02:19:56 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:56 INFO - '_': '/tools/buildbot/bin/python'} 02:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:56 INFO - Running setup.py (path:/tmp/pip-M0iC6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:56 INFO - Running setup.py (path:/tmp/pip-2NxTJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:56 INFO - Running setup.py (path:/tmp/pip-YFQgId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:56 INFO - Running setup.py (path:/tmp/pip-Kh2HEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:56 INFO - Running setup.py (path:/tmp/pip-Js3TKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:56 INFO - Running setup.py (path:/tmp/pip-Waw13f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:56 INFO - Running setup.py (path:/tmp/pip-rdgXwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:56 INFO - Running setup.py (path:/tmp/pip-IGcDbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:56 INFO - Running setup.py (path:/tmp/pip-Zfk3VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:57 INFO - Running setup.py (path:/tmp/pip-C8_3CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:57 INFO - Running setup.py (path:/tmp/pip-_pGUFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:57 INFO - Running setup.py (path:/tmp/pip-ZFZWrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:57 INFO - Running setup.py (path:/tmp/pip-qoQPn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:57 INFO - Running setup.py (path:/tmp/pip-fA9Zgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:57 INFO - Running setup.py (path:/tmp/pip-IwK0_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:57 INFO - Running setup.py (path:/tmp/pip-sViXvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:57 INFO - Running setup.py (path:/tmp/pip-WxZOe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:57 INFO - Running setup.py install for manifestparser 02:19:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:57 INFO - Running setup.py install for mozcrash 02:19:57 INFO - Running setup.py install for mozdebug 02:19:57 INFO - Running setup.py install for mozdevice 02:19:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Running setup.py install for mozfile 02:19:58 INFO - Running setup.py install for mozhttpd 02:19:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Running setup.py install for mozinfo 02:19:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Running setup.py install for mozInstall 02:19:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Running setup.py install for mozleak 02:19:58 INFO - Running setup.py install for mozlog 02:19:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Running setup.py install for moznetwork 02:19:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Running setup.py install for mozprocess 02:19:58 INFO - Running setup.py install for mozprofile 02:19:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:58 INFO - Running setup.py install for mozrunner 02:19:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:59 INFO - Running setup.py install for mozscreenshot 02:19:59 INFO - Running setup.py install for moztest 02:19:59 INFO - Running setup.py install for mozversion 02:19:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:59 INFO - Cleaning up... 02:19:59 INFO - Return code: 0 02:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:59 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')]} 02:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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')]} 02:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:59 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:19:59 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 02:19:59 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 02:19:59 INFO - Using env: {'DISPLAY': ':0', 02:19:59 INFO - 'HOME': '/home/cltbld', 02:19:59 INFO - 'LANG': 'en_US.UTF-8', 02:19:59 INFO - 'LANGUAGE': 'en_US:en', 02:19:59 INFO - 'LOGNAME': 'cltbld', 02:19:59 INFO - 'MAIL': '/var/mail/cltbld', 02:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:59 INFO - 'MOZ_NO_REMOTE': '1', 02:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:59 INFO - 'NO_EM_RESTART': '1', 02:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:59 INFO - 'PWD': '/builds/slave/test', 02:19:59 INFO - 'SHELL': '/bin/bash', 02:19:59 INFO - 'SHLVL': '1', 02:19:59 INFO - 'TERM': 'linux', 02:19:59 INFO - 'TMOUT': '86400', 02:19:59 INFO - 'USER': 'cltbld', 02:19:59 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:59 INFO - '_': '/tools/buildbot/bin/python'} 02:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:59 INFO - Running setup.py (path:/tmp/pip-nEm_t_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:59 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)) 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:59 INFO - Running setup.py (path:/tmp/pip-bzAZ2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:59 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)) 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:59 INFO - Running setup.py (path:/tmp/pip-R51qZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:59 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)) 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:59 INFO - Running setup.py (path:/tmp/pip-LpoGRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:59 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)) 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:59 INFO - Running setup.py (path:/tmp/pip-NJ3Gnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:59 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)) 02:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:59 INFO - Running setup.py (path:/tmp/pip-ps7_HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:00 INFO - Running setup.py (path:/tmp/pip-mtlUDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:00 INFO - Running setup.py (path:/tmp/pip-D3sTuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:00 INFO - Running setup.py (path:/tmp/pip-ciIh_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:00 INFO - Running setup.py (path:/tmp/pip-NG3ncN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:00 INFO - Running setup.py (path:/tmp/pip-ey014T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:00 INFO - Running setup.py (path:/tmp/pip-morSas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:00 INFO - Running setup.py (path:/tmp/pip-w2xUUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:00 INFO - Running setup.py (path:/tmp/pip-Gdhvah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:00 INFO - Running setup.py (path:/tmp/pip-uQmLJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:00 INFO - Running setup.py (path:/tmp/pip-o2ZIfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:00 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)) 02:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:00 INFO - Running setup.py (path:/tmp/pip-wUeV0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:00 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)) 02:20:00 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)) 02:20:00 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)) 02:20:00 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)) 02:20:00 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)) 02:20:00 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)) 02:20:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:00 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 02:20:00 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 02:20:00 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 02:20:00 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 02:20:00 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 02:20:00 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 02:20:02 INFO - Downloading blessings-1.6.tar.gz 02:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:02 INFO - Installing collected packages: blessings 02:20:02 INFO - Running setup.py install for blessings 02:20:02 INFO - Successfully installed blessings 02:20:02 INFO - Cleaning up... 02:20:03 INFO - Return code: 0 02:20:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:03 INFO - Reading from file tmpfile_stdout 02:20:03 INFO - Current package versions: 02:20:03 INFO - argparse == 1.2.1 02:20:03 INFO - blessings == 1.6 02:20:03 INFO - blobuploader == 1.2.4 02:20:03 INFO - docopt == 0.6.1 02:20:03 INFO - functools32 == 3.2.3-2 02:20:03 INFO - jsonschema == 2.5.1 02:20:03 INFO - manifestparser == 1.1 02:20:03 INFO - mozInstall == 1.12 02:20:03 INFO - mozcrash == 0.17 02:20:03 INFO - mozdebug == 0.1 02:20:03 INFO - mozdevice == 0.48 02:20:03 INFO - mozfile == 1.2 02:20:03 INFO - mozhttpd == 0.7 02:20:03 INFO - mozinfo == 0.9 02:20:03 INFO - mozleak == 0.1 02:20:03 INFO - mozlog == 3.2 02:20:03 INFO - moznetwork == 0.27 02:20:03 INFO - mozprocess == 0.22 02:20:03 INFO - mozprofile == 0.28 02:20:03 INFO - mozrunner == 6.11 02:20:03 INFO - mozscreenshot == 0.1 02:20:03 INFO - mozsystemmonitor == 0.3 02:20:03 INFO - moztest == 0.7 02:20:03 INFO - mozversion == 1.4 02:20:03 INFO - psutil == 3.1.1 02:20:03 INFO - requests == 1.2.3 02:20:03 INFO - wsgiref == 0.1.2 02:20:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:03 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')]} 02:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:03 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')]} 02:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:03 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:20:03 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 02:20:03 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 02:20:03 INFO - Using env: {'DISPLAY': ':0', 02:20:03 INFO - 'HOME': '/home/cltbld', 02:20:03 INFO - 'LANG': 'en_US.UTF-8', 02:20:03 INFO - 'LANGUAGE': 'en_US:en', 02:20:03 INFO - 'LOGNAME': 'cltbld', 02:20:03 INFO - 'MAIL': '/var/mail/cltbld', 02:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:03 INFO - 'MOZ_NO_REMOTE': '1', 02:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:03 INFO - 'NO_EM_RESTART': '1', 02:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:03 INFO - 'PWD': '/builds/slave/test', 02:20:03 INFO - 'SHELL': '/bin/bash', 02:20:03 INFO - 'SHLVL': '1', 02:20:03 INFO - 'TERM': 'linux', 02:20:03 INFO - 'TMOUT': '86400', 02:20:03 INFO - 'USER': 'cltbld', 02:20:03 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:03 INFO - '_': '/tools/buildbot/bin/python'} 02:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 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)) 02:20:03 INFO - Cleaning up... 02:20:03 INFO - Return code: 0 02:20:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:03 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')]} 02:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:03 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')]} 02:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:03 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 0x1a47030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d08180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', '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 02:20:03 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 02:20:03 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 02:20:03 INFO - Using env: {'DISPLAY': ':0', 02:20:03 INFO - 'HOME': '/home/cltbld', 02:20:03 INFO - 'LANG': 'en_US.UTF-8', 02:20:03 INFO - 'LANGUAGE': 'en_US:en', 02:20:03 INFO - 'LOGNAME': 'cltbld', 02:20:03 INFO - 'MAIL': '/var/mail/cltbld', 02:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:03 INFO - 'MOZ_NO_REMOTE': '1', 02:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:03 INFO - 'NO_EM_RESTART': '1', 02:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:03 INFO - 'PWD': '/builds/slave/test', 02:20:03 INFO - 'SHELL': '/bin/bash', 02:20:03 INFO - 'SHLVL': '1', 02:20:03 INFO - 'TERM': 'linux', 02:20:03 INFO - 'TMOUT': '86400', 02:20:03 INFO - 'USER': 'cltbld', 02:20:03 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:03 INFO - '_': '/tools/buildbot/bin/python'} 02:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:03 INFO - Cleaning up... 02:20:03 INFO - Return code: 0 02:20:03 INFO - Running post-action listener: _resource_record_post_action 02:20:03 INFO - Running post-action listener: _start_resource_monitoring 02:20:03 INFO - Starting resource monitoring. 02:20:03 INFO - ##### 02:20:03 INFO - ##### Finished create-virtualenv step (success) 02:20:03 INFO - ##### 02:20:03 INFO - ##### 02:20:03 INFO - ##### Running install step. 02:20:03 INFO - ##### 02:20:03 INFO - Running pre-action listener: _resource_record_pre_action 02:20:03 INFO - Running main action method: install 02:20:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:03 INFO - Reading from file tmpfile_stdout 02:20:03 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:03 INFO - Reading from file tmpfile_stdout 02:20:03 INFO - Output received: 02:20:03 INFO - Usage: mozinstall [options] installer 02:20:03 INFO - Options: 02:20:03 INFO - -h, --help show this help message and exit 02:20:03 INFO - -d DEST, --destination=DEST 02:20:03 INFO - Directory to install application into. [default: 02:20:03 INFO - "/builds/slave/test"] 02:20:03 INFO - --app=APP Application being installed. [default: firefox] 02:20:03 INFO - mkdir: /builds/slave/test/build/application 02:20:03 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'] 02:20:03 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 02:20:21 INFO - Reading from file tmpfile_stdout 02:20:21 INFO - Output received: 02:20:21 INFO - /builds/slave/test/build/application/firefox/firefox 02:20:21 INFO - Running post-action listener: _resource_record_post_action 02:20:21 INFO - ##### 02:20:21 INFO - ##### Finished install step (success) 02:20:21 INFO - ##### 02:20:21 INFO - ##### 02:20:21 INFO - ##### Running run-tests step. 02:20:21 INFO - ##### 02:20:21 INFO - Running pre-action listener: _resource_record_pre_action 02:20:21 INFO - Running main action method: run_tests 02:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:21 INFO - Python 2.7.3 02:20:21 INFO - Return code: 0 02:20:21 INFO - grabbing minidump binary from tooltool 02:20:21 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')]} 02:20:21 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 0x1d063b0>, '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 0x1d072b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d07740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:21 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 02:20:21 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 02:20:21 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 02:20:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:21 INFO - Return code: 0 02:20:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:20:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:20:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:21 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/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 02:20:21 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/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 02:20:21 INFO - Using env: {'DISPLAY': ':0', 02:20:21 INFO - 'HOME': '/home/cltbld', 02:20:21 INFO - 'LANG': 'en_US.UTF-8', 02:20:21 INFO - 'LANGUAGE': 'en_US:en', 02:20:21 INFO - 'LOGNAME': 'cltbld', 02:20:21 INFO - 'MAIL': '/var/mail/cltbld', 02:20:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:21 INFO - 'MOZ_NO_REMOTE': '1', 02:20:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:21 INFO - 'NO_EM_RESTART': '1', 02:20:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:21 INFO - 'PWD': '/builds/slave/test', 02:20:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:21 INFO - 'SHELL': '/bin/bash', 02:20:21 INFO - 'SHLVL': '1', 02:20:21 INFO - 'TERM': 'linux', 02:20:21 INFO - 'TMOUT': '86400', 02:20:21 INFO - 'USER': 'cltbld', 02:20:21 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306', 02:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:21 INFO - '_': '/tools/buildbot/bin/python'} 02:20:21 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/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 02:20:21 INFO - mozversion application_buildid: 20160628233029 02:20:21 INFO - mozversion application_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 02:20:21 INFO - mozversion application_display_name: Nightly 02:20:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:21 INFO - mozversion application_name: Firefox 02:20:21 INFO - mozversion application_remotingname: firefox 02:20:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:20:21 INFO - mozversion application_vendor: Mozilla 02:20:21 INFO - mozversion application_version: 50.0a1 02:20:21 INFO - mozversion platform_buildid: 20160628233029 02:20:21 INFO - mozversion platform_changeset: e1af8a633527ae1c95bf0e630a75f9810be3995d 02:20:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:20:21 INFO - mozversion platform_version: 50.0a1 02:20:21 INFO - using testdate: 1467192021 02:20:21 INFO - actual date: 1467192021 02:20:21 INFO - starting webserver on 'localhost:33543' 02:20:21 INFO - SUITE-START | Running 2 tests 02:20:21 INFO - TEST-START | dromaeo_css 02:20:21 INFO - operating with platform_type : linux_ 02:20:21 INFO - Initialising browser for dromaeo_css test... 02:20:21 INFO - TEST-INFO | started process 17819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzwlft/profile http://localhost:33543/getInfo.html) 02:20:25 INFO - PROCESS | 17819 | __metrics Screen width/height:1600/1200 02:20:25 INFO - PROCESS | 17819 | colorDepth:24 02:20:25 INFO - PROCESS | 17819 | Browser inner width/height: 1024/697 02:20:25 INFO - PROCESS | 17819 | __metrics 02:20:26 INFO - PROCESS | 17819 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:27 INFO - TEST-INFO | 17819: exit 0 02:20:27 INFO - Browser initialized. 02:20:27 INFO - Running cycle 1/1 for dromaeo_css test... 02:20:27 INFO - TEST-INFO | started process 17901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzwlft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:39 INFO - PROCESS | 17901 | RSS: Main: 156577792 02:20:39 INFO - PROCESS | 17901 | 02:21:30 INFO - PROCESS | 17901 | 1467192090726 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] 02:23:38 INFO - PROCESS | 17901 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33543/tests/dromaeo/cssquery-ext.html) 02:23:39 INFO - PROCESS | 17901 | RSS: Main: 286851072 02:23:39 INFO - PROCESS | 17901 | 02:26:42 INFO - PROCESS | 17901 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-ext.html (next: http://localhost:33543/tests/dromaeo/cssquery-jquery.html) 02:26:42 INFO - PROCESS | 17901 | RSS: Main: 240754688 02:26:42 INFO - PROCESS | 17901 | 02:29:44 INFO - PROCESS | 17901 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33543/tests/dromaeo/cssquery-mootools.html) 02:29:45 INFO - PROCESS | 17901 | RSS: Main: 246239232 02:29:45 INFO - PROCESS | 17901 | 02:32:47 INFO - PROCESS | 17901 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33543/tests/dromaeo/cssquery-prototype.html) 02:32:48 INFO - PROCESS | 17901 | RSS: Main: 246075392 02:32:48 INFO - PROCESS | 17901 | 02:35:50 INFO - PROCESS | 17901 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33543/tests/dromaeo/cssquery-yui.html) 02:35:51 INFO - PROCESS | 17901 | RSS: Main: 213716992 02:35:51 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | Cycle 1(1): loaded http://localhost:33543/tests/dromaeo/cssquery-yui.html (next: http://localhost:33543/tests/dromaeo/cssquery-dojo.html) 02:38:54 INFO - PROCESS | 17901 | RSS: Main: 293445632 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | __start_tp_report 02:38:54 INFO - PROCESS | 17901 | _x_x_mozilla_page_load 02:38:54 INFO - PROCESS | 17901 | _x_x_mozilla_page_load_details 02:38:54 INFO - PROCESS | 17901 | |i|pagename|runs| 02:38:54 INFO - PROCESS | 17901 | |0;dojo.html;3049.130997665667;3050.481418158913;3065.5708200851886;3084.537319402091;3109.4092122496736;5098.643094983353;5160.045391602552;5174.767135478903;5232.502912223342;5262.131748261537;5203.167493201088;5231.110711179099;5235.293235413218;5253.264542963988;5306.124489459245;4687.953120468803;4760.047990401916;4776;4791.712497250159;4931.013797240548;4838.733869637169;4840.806367745286;4868.19674753667;4889.095517329288;4900.877478063041;4615.376924115252;4645.744484053375;4658.138244424776;4670.556297151765;4687.390639216897;4638.1187574360765;4659.673822832403;4724.196886529264;4731.905361892743;4766.142094423002;4687.554682305175;4701.271302948048;4724.314974328738;4729.125111854318;4750.762461876927;5053.444121146671;5085.567726743194;5110.182370820651;5178.197379406198;5196.740162991835;5515.669059856422;5609.046462101412;5612.466815652507;5613.4386561343945;5615.634983726045;5585.357683866367;5609.270794796691;5642.971785141048;5654.519365853907;5655.462731040545;5123.308353372285;5148.124818780816;5243.187305967543;5243.685378877241;5315.468453154731;5723.627964182315;5733.111367738007;5734.340550836624;5742.0238559445;5748.6838223898085;5383.542398896059;5520.1167813149705;5531.6957567333375;5536.695481748462;5537.8061767837935;5480.26016487777;5545.140503222007;5553.639013464192;5556.333240011225;5608.96234196675;5538.529225015838;5559.416261292506;5565.554755619541;5572.637778544382;5578.860528486739;5386.111291636915;5492.093804522209;5575.637583557056;5579;5624.943750562524;4212.19968206046;4218.240716671029;4269.082147338338;4285.46431696038;4321.719088259253;3827.5789663137034;3842.1739326044476;3847.480590120354;3869.1487872667967;3888.2612303662213;5399.865003374947;5402.081646120169;5404.8108316208745;5406;5411.540019098421;5440.075187218183;5502.889942201134;5566.610337276352;5573.108302671634;5585.162225666101;5294.867628309246;5296.1261391870685;5299.549538289211;5300.867478313073;5313.760880760375;4752.928706069411;4827.986122914227;4831.057943701015;4832.420109586872;4866.878328041827;5730.7421166047625;5753.33836608787;5754;5807.216025836543;5835.795747148744;5626.409227031267;5626.578006649435;5629.521490673339;5631.408702086222;5634.718264086861;5572.331320241597;5782.277215348082;5819.098039803837;5837.6497410155525;5839.883202336015;5501.697406642513;5534.806281780118;5548.611597188158;5548.916766248591;5587.413321601173;5631.549476041825;5639.210510528611;5649.378568357395;5651.858703532444;5654.180143879197;5333.359996800409;5371.946280537301;5383.0579648562125;5440.836774896759;5552.167174923632;5410.78356865721;5417.485338892799;5417.729113544386;5421.295231619864;5455.727213639381;5320.840374788762;5351.678899266057;5354.651947623392;5355.089634762177;5402.864928376822;5302.5227729502985;5302.522772950453;5434.891302174014;5442.265294185234;5487;5235.869103272296;5254.3169387979315;5269.683818970874;5278.920816187683;5279 02:38:54 INFO - PROCESS | 17901 | |1;ext.html;577.2380457795708;619.3589634728056;624.2041397218549;632.2570979099556;638.9936100638998;29844.25389365267;41257.17485650289;42975.35536966944;43401.565984340225;43673.78163109188;40730.59269407312;44656;44672;44792.3281150783;44936;8036.236557527026;8863.246624036949;9017.36878418511;9025.729228123135;10534.420606866619;10400.947995260012;10535.789284214312;10773.62292319769;10813.621523246688;10819.242653014293;10907.509162087725;10969;10972.177086718488;10984;10984.06635435985;10808.135349172047;10833.891661083368;10883.292585981964;10886.0746836519;10896.455177241185;10506.527206275736;10566.418846963414;10572.312799667998;10573.048425641653;10575.153987680967;43350.56649433528;43520.782396088136;43718.12563748707;43774.34338484925;43807.561924380985;3436.621971583124;3618.3125206210734;3730.9253814923823;3763.604821493731;4236.364545318227;33684;33739;33851.4922276166;33995.830020849986;34406.31187376239;4430.158269928703;4451.132029254297;4476.574725401082;4497.460304763449;4603.723776573416;372104;374063;374154;375016.99999999726;375299;62368.634195605875;62478.687606561674;62864.685676571324;63028.36971630225;63036;66691.33308666851;66833.33166668368;67370.32629673739;67379.3262067373;67484;17190.054546999785;17667.911660441616;17690.469285921445;17699.292028318723;17719.557011074827;13422.127561708458;13439.664008399868;13449.462021519226;13481.865181348061;13487.730245395038;19772.11025503856;20611.69082463764;20627.79372206289;20647.380578582666;20654.380368588965;7297.16082650502;7543.283388078234;7553.622318884144;7774.162430712862;7809.657102869231;1020.9081182693593;1097.2045267181388;1143.1940481960198;1144.5707859552667;1150.7800339166818;31093.53359699606;31228.219294517363;31272.821597462047;31273.530897036562;31397.52903706446;1141.303804679145;1142.725745820997;1148.3798748675622;1154.9826752598717;1215.3133479584008;16617.3353065876;16761.7485737714;16838.49484515442;16955.814719115773;17071.573210669583;117531;117561.41219293849;119251;119854.4007279958;120091;58974.70512647495;59436.40563594309;59502.70248648729;59507.40492595105;59681.40318596758;1245.2964075297427;1338.6318762340434;1377.8415482219473;1379.1035826712516;1390.6731917999464;31970.68029319677;33256.33487330288;33430.16134112647;33633.327333453686;33832.49251261282;50681.49318506915;51160.48839511557;51164.48835511597;51205.231921521954;51225.487745122075;371364;371710;371722;371988;372553;34379;38002.429963550014;38036;41071.1785764289;42394.550484922845;47911.520884790705;48311.275330869365;49265.50734492609;49839.75080124721;50454;38725.80637096796;40562;40690.59309406987;40846.59153408428;41089.79455102705;40911.38632920449;41433.37849932193;41509.37735933903;41861.79069104635;42097.579024210594;40826;41094.794526028374;41757.37363939604;42106.789466052476;42367.78816106023;33629.3274134511;37102.44346334861;38129;39489.2102157961;40530.39204411877;27549.449011020068;28324.575131372632;28378.148655539542;28579.428411432073;28644 02:38:54 INFO - PROCESS | 17901 | |2;jquery.html;383.80349261178293;386.5573917864046;388.66186417816493;398.30893399951077;414.09520198366573;14460.349284282207;16564.75152872708;17946.19242134104;19631.705524417146;19652;18705.625887482278;18846.71729924052;19037.904810475964;19041.904790476063;19077.42767716967;5590.8602284943;5631.380548139691;5661.150827375906;5686.09022556391;5692.459216374458;4078.449409329732;5618.820047789969;5687.402822703619;5703.944770217502;6127.908081378783;6363.649999250039;6448.097266382711;6478.287388387297;6478.870422591545;6480.351964803529;6213.658248796314;6380.138681278015;6398.040293955897;6408.58344207625;6450.225972883237;5600.411956744524;5644;5652.519535839418;5658.603897727161;5668.716564171775;13204.60386188416;15706.057636541844;20253.29113481036;21571.784282157136;21585.67621485679;2340.6957095577636;2354.646802979567;2864.5130327844317;2892.363679990399;2924.956125658117;9037.954810225972;9444.622215111387;9464.905350946472;9525.952370238174;10074.194064474825;1765.6733504301744;1840.5700599278496;1856.5265857206462;1945.7567804024497;1999.7900220476786;77713.61143194305;77902;78898.60550697267;79478;83551;9870.851937220947;10239.129673977795;10402.739931501774;10456.477176141163;10634.30876992993;12784;12825.94784834422;13694.589162325146;14557.85442145565;14569.41722331116;6369.71336289868;6477.287498375175;7573.545587264672;8099.06860711014;8146.75559733209;7742.806429839299;7816.140224575292;7900.091489478668;7934.761957141295;7981.521108733495;4484.663650226246;4526.728396296233;4550.726956382561;4698.788554515055;4709.481956984729;1909.6371689378973;1913.1964574878584;1919.8464122870137;1921.6156768646326;1952.7070939358925;934.3926447808842;1006.8489726541078;1009.5507499162802;1033.963811266602;1053.3048188195753;17597.208125634377;18762.061896905372;18878.905605471886;18983.52541186454;20063.498412539804;940.6942743608355;981.2003217377815;1030.2324768047852;1033.8552602635637;1075.8870318616432;10134.391936483687;10294.639687610897;10359.533820978075;10474;10579.153667706565;179131;179573;179620;349262;486343;57400.997887356134;71145.93281100788;87305;88434;90186;1017.3946501831399;1026.7279171019686;1043.2644985285356;1047.4029803012363;1060.1359891688248;15946.202689865693;15958.202089895227;16249.593760155618;16264;16288.837111628733;38705.806470967465;39894.80052599718;41779.37330940099;42172.36741448942;42459.93850153771;58908;59433.702831487295;59589.40410595838;60412.09381859188;61279;7087.362137407658;7607.771766847003;7773.339266162439;7789.688412463438;7873.566953817595;9545.713628591153;12364.690882728004;12971.935140324238;13215.801762973371;13337.933310333387;11428.657140285804;11583.942080289544;11607.76784464323;11629.302241865515;11852.34812085309;11149.944250278697;11167.274127181707;11283.435828208721;11413.086953043903;12307.56923507673;11732;11769.764604707687;11892.227005244631;11966.521339146337;12026.579069732517;7687.11598166218;7740.225977402215;7767.1067827200595;7819.124349524636;7871.370290376871;10232.283740138118;11810.468528916048;11855.407229638657;11888.821667675165;12070.879291206975 02:38:54 INFO - PROCESS | 17901 | |3;mootools.html;1351.7364113997762;1451.1220711469562;1475.4983305676071;1555.2301610702705;1747.7116275814492;7914.445988780788;8196.13940536244;8220.75337739868;8498.660053597849;8504.064552899192;8203.30271926887;8377.246047855691;8379.539125348103;8387.245147936685;8395.370347223952;1937.331620590901;2145.731783527059;2196.1983875885267;2214.059024914413;2224.110355857662;2159.341400872733;2168.0677308757226;2168.3169801512554;2168.533765240473;2170.6201414752436;2205.4155648753094;2216.34617787753;2254.289898681918;2255.4474153832252;2256.277991042867;1883.4349695091487;2085.176355339632;2134.935951921445;2138.101997161196;2163.9026243819067;2149.5915776002666;2155.084089262057;2176.031665908671;2179.073893595216;2180.3349978256624;8517.57412129391;8546.70086546974;8574.571271436465;8576.528290943996;8605.526696031715;5088.643794934356;5273.314469119028;5275.498827611371;5276.34045744282;5281.445448227919;3108.2850944282713;3131.7964332318325;3170.936581268385;3185.7769956103084;3301.4552598821165;1075.7687097274124;1102.2174256278051;2184.2573525001417;2239.2050821958132;2262.490939538607;12123.515059397614;12213.572524961672;12229.388530573524;12246.571370002008;12252.203606765532;4233.894152646147;4294.6993710439965;4312.525622181557;4361.2367835629275;4373.956260437419;9082.273418126533;9116.1339672731;9119.316051296179;9139.63441462334;9140.085991400807;5117.667351622133;5120.92318615221;5122.538971492509;5127.897442051138;5127.948720512747;4280.935785963213;4717.528247175255;4847.079054979543;4859.125357435695;4933.038057578738;3613.6928361089076;3680.282344942764;3707.073231692077;3754.699624030071;3782.3759079752085;1071.2287153249647;1072.4262519552003;1073.7476692977143;1097.1990446973755;1101.4107452512867;912.5391677203103;919.2370332623906;960.188640598693;973.2214228617078;1024.5184763161303;5939.46544810969;5979.4917432018765;6042.456178943916;6139.171211886427;6240.375962403723;900.5542256583034;923.0769230769231;943.9669611563562;949.1979277510493;985.8915519292872;4048.919021619551;4207.969047583361;4344.522102568715;4344.522102568715;4379.737215767064;10643.41461219625;11116.61091861781;11168.832467512993;11194.10447164225;11212.383318917375;9669.274804389559;10995.615153469591;11019.614313498989;11046.668599942015;11056.11551075912;7540.509866858637;7986.361091112697;7992.440529162903;8014.519128852171;8063.072746634095;5967.164596956342;5971.731272092679;6180.783672571439;6300.747970081329;6408.423241908251;9643.421394716339;9957.850632240377;10183.18534517222;10186.236032297458;10295.691129266133;10246.436445995541;10262.538185781508;10272.178225741773;10285;10355.326903751233;7723.266289702694;7751.496152750054;8017.759467215993;8042.235987581171;8063.072746634212;8375.078741338326;8388.119247479171;8450.19723126302;8452.32381409498;8500.36247281444;7599;7743.186965368781;7774.378049756119;7942.960285198537;7966.123726389977;7419.888701669372;7476.028116344841;7560.319571238615;7626.313631773167;7824.4131690124605;6582.0785090086465;6931.965340173267;7030.086088808423;7076.575405475688;7081.681324340314;4900.215965445512;4999;5052.444231134646;5093.23601459784;5233.241180028951;5086.54221120101;5184;5350.892982140414;5362.731863406736;5473.397926228191 02:38:54 INFO - PROCESS | 17901 | |4;prototype.html;288.858459354916;291.1048525783217;295.7825997891551;310.967348428415;317.1342235696549;5288.338957630296;5294.338207724035;5302.284191634133;5316.697409134763;5319.574434045277;5157.74211289435;5202.791888324472;5208;5213.661112027716;5215.4523775003645;3816.580176180611;3877.3602355611292;4022.637962583367;4048.1701251243426;4075.470188875442;4035.9798201009103;4038.1923615276914;4053.43251944728;4057.84351459834;4080.510338759353;3875.457435958968;4019.376996565537;4025.7117722328867;4034.700220874103;4040.5757395473347;3864.091938394475;4040.676745860324;4058.4115303281155;4086.3041837637343;4098.446709694183;3575.713942884563;3585.8386372613295;3591.3535563598543;3593.7484376093685;3608.2963822054708;5046.6719663221775;5074;5079.933214025059;5080.8221712240265;5086.949130508685;4488.932666010012;4632.25883858581;4653.534646535353;4660.790264438108;4669.859904202879;5361.222622719683;5376.623636345457;5437.673739575638;5443.945560544384;5444.292242008553;3912.217556488685;3930.194310166409;3933.7443066200603;3950.1236912466634;3961.851063191671;5319.787208511655;5624.0439125348785;5625.915611265793;5626.521745651625;5671.149327600893;3952.8616498422416;3968.7420317679835;3969.4839670842607;3983.466365449323;3993.2612466693754;4009.699272554512;4015.819288132041;4021.3163762159916;4041.6766658667234;4042.2723909696538;4409.647228221735;4586.6789324747615;4595.9080818383445;4603.769811509478;4625.722456652545;5480.945190548044;5485.862853428616;5491.615586908878;5494.835154945358;5497.752601132958;1353.824002879639;1365.6176270644235;1367.911085779441;1369.2263870912902;1374.5670113914084;881.1320848963894;897.4615230861561;902.869083982832;903.46695449685;903.6896500074918;4820.783064762094;5236.24074509194;5306.548943339782;5329.840104796862;5344.839654810362;5577.414371491016;5593.972030139905;5598.552115830724;5631.070873305859;5639.125935480007;5085.771140298695;5305.283786688748;5330.600204984642;5344.6258761887075;5345.492178243061;2985.731064297665;3006.383691343269;3025.515917453241;3034.332446861731;3034.4234595426797;5872.7357268923;5885.352611212763;5897.970510147507;5915.881682366328;5954;5524.392316845144;5730;5731.254936858265;5794.652320860761;5845.444682755132;5774.133879918046;5782.132680098019;5814.499765100963;5844;5855.414458554195;5358.892822143614;5587.262241501716;5591.832245032656;5595.300587426572;5631.802886898939;5582.888342233051;5604.551635869202;5605.299337582802;5632.380438151882;5634.4365563443325;5815.680137592473;5841.386654401226;5859.0372225305;5865.354810970875;5869.207656966426;3885.9222815544094;4065.9593404066763;4094.877153685394;4122.711410201257;4127.9174416512105;5597.272354593877;5597.860053498695;5608.270924779753;5634.211210430625;5639.6334238274385;5283.286756287852;5328.4671532846405;5427.782888684408;5439.782408703766;5476.91784623223;5514.558835293247;5531.336239651107;5553.416891226525;5559.944400555943;5562.749676264659;5487.725613719218;5488.4785945335125;5492.91760623583;5494.725263736877;5496.80761173357;5345.65253258537;5485.35439368196;5507.807226747044;5508.173773933942;5583.190437386637;5374.596905232045;5393.1370980642905;5437.429069947599;5460.563154947674;5477.562484694273 02:38:54 INFO - PROCESS | 17901 | |5;yui.html;740.4853626729422;748.2255865179541;769.6459628570857;776.4293244465317;800.5876973358719;15038.47365342212;15879.761803572941;16659.750103748454;16664.58338541537;16685.33258669655;13953.162810231393;14097.788533171984;14125.364358603862;14153.646158846033;14159.858401415982;666.5534092158266;779.6024027745862;791.8653828849081;795.558465051896;801.410962942237;793.1790596732383;797.1112209885964;800.3757069485781;800.5596921693075;800.6837299266787;841.9368547358941;842.418731075559;844.0546587821618;845.2097289034772;845.526505157114;699.8705239530677;806.1253539909205;829.0258945738793;833.2251006563893;833.5248908122372;610.1671218786369;611.5810669691276;615.8398816307747;615.984600384994;616.4544378225258;14647.267636618233;14679.70640587193;14760.704785904329;14777.408903643842;14792.926035369863;13950.51173208943;14391.280435978158;14438.49465268721;14480.637984050378;14542.27288635564;12939.48242070316;12941.805872911913;12967.610971670865;13089.47642094315;13531.932340338333;4317.330813723878;4352.347147927804;4506.369108324837;4613.354130421743;4620.422447194101;65558.67220663914;72545.27454725438;73752;73867.26132738711;73935.26064739391;11276.154288428237;11475.94197108552;11815;11836.822447663291;11905.166638335406;20957.371278861658;21187.68218476724;21192.576148477252;21255.0435230415;21258.893705531373;8745.693900713444;8812.471251724917;8826.646934122691;8986.640534378552;9058.32062595308;4710.458297295786;4742.487986760524;4771.6898401603785;4801.95198048015;4864.610831133501;3492.633273506296;3627.183883626216;3631.3100510902846;3634.164142247245;3635.7273204509765;629.5058379172327;630.7004173017872;633.7369991453587;639.9360063993656;647.3817504283398;609.4971648390095;648.8734696734186;687.9577440178134;758.4614923404334;767.2519293688721;9402.764930876783;9727.65953191635;9863.260255480867;9939.254555908336;10371.325863818827;743.7880204141794;748.9775306740806;765.6478020110811;782.1865260129401;790.8853216283607;4675.836345727951;4895.461499235082;4969.726665033386;4976.651634385631;5019.548240658358;113053;113919;113967;114906.42546787212;118352;97292.51353743327;97555;97705.51147244219;97885.51057244668;100377.49811250897;52708.20937685861;82394;86004.13995860086;86260.56869715611;88006.55996720103;8881.73354799357;9240.537973101453;9423.764405889633;9466.574004169966;9627.159987803474;39656.40515392329;45813;49766.751166243936;50967.49032509776;51868.96262074662;76952.61523692346;77236.2276377229;77262.50112487734;79255.20744792478;80329.59835200786;11637.592684256011;11688.415579220835;11790.174687771774;12069.155159138776;12248.87751122513;13387.263700496565;13570.253636050113;13600.86399135996;13792.586222413343;14308.49920252786;11278.210525263154;11674.94162529182;11923.165378423428;12169.513219471122;12470.563530276397;11799.17405781587;12517.624471265877;12808.359582020676;12931.482740690268;12952.8057079142;11606.825897611712;12006.75986480248;12442.564510242099;12486.625401237978;12551.435185416862;10242.436665983443;10249.180065594883;10709.625163119254;10787.67636970892;11170.664880053611;10142.695719128438;10396.74008149772;10683;10823.134149268197;10866.684862169257 02:38:54 INFO - PROCESS | 17901 | __end_tp_report 02:38:54 INFO - PROCESS | 17901 | __start_cc_report 02:38:54 INFO - PROCESS | 17901 | _x_x_mozilla_cycle_collect,1053 02:38:54 INFO - PROCESS | 17901 | __end_cc_report 02:38:54 INFO - PROCESS | 17901 | __startTimestamp1467193134392__endTimestamp 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | ------- Summary: start ------- 02:38:54 INFO - PROCESS | 17901 | Number of tests: 6 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | [#0] dojo.html Cycles:165 Average:5184.28 Median:5371.95 stddev:580.49 (10.8%) stddev-sans-first:557.58 02:38:54 INFO - PROCESS | 17901 | Values: 3049.1 3050.5 3065.6 3084.5 3109.4 5098.6 5160.0 5174.8 5232.5 5262.1 5203.2 5231.1 5235.3 5253.3 5306.1 4688.0 4760.0 4776.0 4791.7 4931.0 4838.7 4840.8 4868.2 4889.1 4900.9 4615.4 4645.7 4658.1 4670.6 4687.4 4638.1 4659.7 4724.2 4731.9 4766.1 4687.6 4701.3 4724.3 4729.1 4750.8 5053.4 5085.6 5110.2 5178.2 5196.7 5515.7 5609.0 5612.5 5613.4 5615.6 5585.4 5609.3 5643.0 5654.5 5655.5 5123.3 5148.1 5243.2 5243.7 5315.5 5723.6 5733.1 5734.3 5742.0 5748.7 5383.5 5520.1 5531.7 5536.7 5537.8 5480.3 5545.1 5553.6 5556.3 5609.0 5538.5 5559.4 5565.6 5572.6 5578.9 5386.1 5492.1 5575.6 5579.0 5624.9 4212.2 4218.2 4269.1 4285.5 4321.7 3827.6 3842.2 3847.5 3869.1 3888.3 5399.9 5402.1 5404.8 5406.0 5411.5 5440.1 5502.9 5566.6 5573.1 5585.2 5294.9 5296.1 5299.5 5300.9 5313.8 4752.9 4828.0 4831.1 4832.4 4866.9 5730.7 5753.3 5754.0 5807.2 5835.8 5626.4 5626.6 5629.5 5631.4 5634.7 5572.3 5782.3 5819.1 5837.6 5839.9 5501.7 5534.8 5548.6 5548.9 5587.4 5631.5 5639.2 5649.4 5651.9 5654.2 5333.4 5371.9 5383.1 5440.8 5552.2 5410.8 5417.5 5417.7 5421.3 5455.7 5320.8 5351.7 5354.7 5355.1 5402.9 5302.5 5302.5 5434.9 5442.3 5487.0 5235.9 5254.3 5269.7 5278.9 5279.0 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | [#1] ext.html Cycles:180 Average:48602.03 Median:372046.00 stddev:82514.08 (22.2%) stddev-sans-first:82666.77 02:38:54 INFO - PROCESS | 17901 | Values: 577.2 619.4 624.2 632.3 639.0 29844.3 41257.2 42975.4 43401.6 43673.8 40730.6 44656.0 44672.0 44792.3 44936.0 8036.2 8863.2 9017.4 9025.7 10534.4 10400.9 10535.8 10773.6 10813.6 10819.2 10907.5 10969.0 10972.2 10984.0 10984.1 10808.1 10833.9 10883.3 10886.1 10896.5 10506.5 10566.4 10572.3 10573.0 10575.2 43350.6 43520.8 43718.1 43774.3 43807.6 3436.6 3618.3 3730.9 3763.6 4236.4 33684.0 33739.0 33851.5 33995.8 34406.3 4430.2 4451.1 4476.6 4497.5 4603.7 372104.0 374063.0 374154.0 375017.0 375299.0 62368.6 62478.7 62864.7 63028.4 63036.0 66691.3 66833.3 67370.3 67379.3 67484.0 17190.1 17667.9 17690.5 17699.3 17719.6 13422.1 13439.7 13449.5 13481.9 13487.7 19772.1 20611.7 20627.8 20647.4 20654.4 7297.2 7543.3 7553.6 7774.2 7809.7 1020.9 1097.2 1143.2 1144.6 1150.8 31093.5 31228.2 31272.8 31273.5 31397.5 1141.3 1142.7 1148.4 1155.0 1215.3 16617.3 16761.7 16838.5 16955.8 17071.6 117531.0 117561.4 119251.0 119854.4 120091.0 58974.7 59436.4 59502.7 59507.4 59681.4 1245.3 1338.6 1377.8 1379.1 1390.7 31970.7 33256.3 33430.2 33633.3 33832.5 50681.5 51160.5 51164.5 51205.2 51225.5 371364.0 371710.0 371722.0 371988.0 372553.0 34379.0 38002.4 38036.0 41071.2 42394.6 47911.5 48311.3 49265.5 49839.8 50454.0 38725.8 40562.0 40690.6 40846.6 41089.8 40911.4 41433.4 41509.4 41861.8 42097.6 40826.0 41094.8 41757.4 42106.8 42367.8 33629.3 37102.4 38129.0 39489.2 40530.4 27549.4 28324.6 28378.1 28579.4 28644.0 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | [#2] jquery.html Cycles:180 Average:22266.03 Median:2609.58 stddev:51362.24 (1968.2%) stddev-sans-first:51480.05 02:38:54 INFO - PROCESS | 17901 | Values: 383.8 386.6 388.7 398.3 414.1 14460.3 16564.8 17946.2 19631.7 19652.0 18705.6 18846.7 19037.9 19041.9 19077.4 5590.9 5631.4 5661.2 5686.1 5692.5 4078.4 5618.8 5687.4 5703.9 6127.9 6363.6 6448.1 6478.3 6478.9 6480.4 6213.7 6380.1 6398.0 6408.6 6450.2 5600.4 5644.0 5652.5 5658.6 5668.7 13204.6 15706.1 20253.3 21571.8 21585.7 2340.7 2354.6 2864.5 2892.4 2925.0 9038.0 9444.6 9464.9 9526.0 10074.2 1765.7 1840.6 1856.5 1945.8 1999.8 77713.6 77902.0 78898.6 79478.0 83551.0 9870.9 10239.1 10402.7 10456.5 10634.3 12784.0 12825.9 13694.6 14557.9 14569.4 6369.7 6477.3 7573.5 8099.1 8146.8 7742.8 7816.1 7900.1 7934.8 7981.5 4484.7 4526.7 4550.7 4698.8 4709.5 1909.6 1913.2 1919.8 1921.6 1952.7 934.4 1006.8 1009.6 1034.0 1053.3 17597.2 18762.1 18878.9 18983.5 20063.5 940.7 981.2 1030.2 1033.9 1075.9 10134.4 10294.6 10359.5 10474.0 10579.2 179131.0 179573.0 179620.0 349262.0 486343.0 57401.0 71145.9 87305.0 88434.0 90186.0 1017.4 1026.7 1043.3 1047.4 1060.1 15946.2 15958.2 16249.6 16264.0 16288.8 38705.8 39894.8 41779.4 42172.4 42459.9 58908.0 59433.7 59589.4 60412.1 61279.0 7087.4 7607.8 7773.3 7789.7 7873.6 9545.7 12364.7 12971.9 13215.8 13337.9 11428.7 11583.9 11607.8 11629.3 11852.3 11149.9 11167.3 11283.4 11413.1 12307.6 11732.0 11769.8 11892.2 11966.5 12026.6 7687.1 7740.2 7767.1 7819.1 7871.4 10232.3 11810.5 11855.4 11888.8 12070.9 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | [#3] mootools.html Cycles:180 Average:5707.78 Median:5069.49 stddev:3245.11 (64.0%) stddev-sans-first:3237.70 02:38:54 INFO - PROCESS | 17901 | Values: 1351.7 1451.1 1475.5 1555.2 1747.7 7914.4 8196.1 8220.8 8498.7 8504.1 8203.3 8377.2 8379.5 8387.2 8395.4 1937.3 2145.7 2196.2 2214.1 2224.1 2159.3 2168.1 2168.3 2168.5 2170.6 2205.4 2216.3 2254.3 2255.4 2256.3 1883.4 2085.2 2134.9 2138.1 2163.9 2149.6 2155.1 2176.0 2179.1 2180.3 8517.6 8546.7 8574.6 8576.5 8605.5 5088.6 5273.3 5275.5 5276.3 5281.4 3108.3 3131.8 3170.9 3185.8 3301.5 1075.8 1102.2 2184.3 2239.2 2262.5 12123.5 12213.6 12229.4 12246.6 12252.2 4233.9 4294.7 4312.5 4361.2 4374.0 9082.3 9116.1 9119.3 9139.6 9140.1 5117.7 5120.9 5122.5 5127.9 5127.9 4280.9 4717.5 4847.1 4859.1 4933.0 3613.7 3680.3 3707.1 3754.7 3782.4 1071.2 1072.4 1073.7 1097.2 1101.4 912.5 919.2 960.2 973.2 1024.5 5939.5 5979.5 6042.5 6139.2 6240.4 900.6 923.1 944.0 949.2 985.9 4048.9 4208.0 4344.5 4344.5 4379.7 10643.4 11116.6 11168.8 11194.1 11212.4 9669.3 10995.6 11019.6 11046.7 11056.1 7540.5 7986.4 7992.4 8014.5 8063.1 5967.2 5971.7 6180.8 6300.7 6408.4 9643.4 9957.9 10183.2 10186.2 10295.7 10246.4 10262.5 10272.2 10285.0 10355.3 7723.3 7751.5 8017.8 8042.2 8063.1 8375.1 8388.1 8450.2 8452.3 8500.4 7599.0 7743.2 7774.4 7943.0 7966.1 7419.9 7476.0 7560.3 7626.3 7824.4 6582.1 6932.0 7030.1 7076.6 7081.7 4900.2 4999.0 5052.4 5093.2 5233.2 5086.5 5184.0 5350.9 5362.7 5473.4 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | [#4] prototype.html Cycles:180 Average:4610.40 Median:5319.68 stddev:1370.48 (25.8%) stddev-sans-first:1335.38 02:38:54 INFO - PROCESS | 17901 | Values: 288.9 291.1 295.8 311.0 317.1 5288.3 5294.3 5302.3 5316.7 5319.6 5157.7 5202.8 5208.0 5213.7 5215.5 3816.6 3877.4 4022.6 4048.2 4075.5 4036.0 4038.2 4053.4 4057.8 4080.5 3875.5 4019.4 4025.7 4034.7 4040.6 3864.1 4040.7 4058.4 4086.3 4098.4 3575.7 3585.8 3591.4 3593.7 3608.3 5046.7 5074.0 5079.9 5080.8 5086.9 4488.9 4632.3 4653.5 4660.8 4669.9 5361.2 5376.6 5437.7 5443.9 5444.3 3912.2 3930.2 3933.7 3950.1 3961.9 5319.8 5624.0 5625.9 5626.5 5671.1 3952.9 3968.7 3969.5 3983.5 3993.3 4009.7 4015.8 4021.3 4041.7 4042.3 4409.6 4586.7 4595.9 4603.8 4625.7 5480.9 5485.9 5491.6 5494.8 5497.8 1353.8 1365.6 1367.9 1369.2 1374.6 881.1 897.5 902.9 903.5 903.7 4820.8 5236.2 5306.5 5329.8 5344.8 5577.4 5594.0 5598.6 5631.1 5639.1 5085.8 5305.3 5330.6 5344.6 5345.5 2985.7 3006.4 3025.5 3034.3 3034.4 5872.7 5885.4 5898.0 5915.9 5954.0 5524.4 5730.0 5731.3 5794.7 5845.4 5774.1 5782.1 5814.5 5844.0 5855.4 5358.9 5587.3 5591.8 5595.3 5631.8 5582.9 5604.6 5605.3 5632.4 5634.4 5815.7 5841.4 5859.0 5865.4 5869.2 3885.9 4066.0 4094.9 4122.7 4127.9 5597.3 5597.9 5608.3 5634.2 5639.6 5283.3 5328.5 5427.8 5439.8 5476.9 5514.6 5531.3 5553.4 5559.9 5562.7 5487.7 5488.5 5492.9 5494.7 5496.8 5345.7 5485.4 5507.8 5508.2 5583.2 5374.6 5393.1 5437.4 5460.6 5477.6 02:38:54 INFO - PROCESS | 17901 | 02:38:54 INFO - PROCESS | 17901 | [#5] yui.html Cycles:180 Average:20311.78 Median:4726.47 stddev:29422.02 (622.5%) stddev-sans-first:29467.86 02:38:54 INFO - PROCESS | 17901 | Values: 740.5 748.2 769.6 776.4 800.6 15038.5 15879.8 16659.8 16664.6 16685.3 13953.2 14097.8 14125.4 14153.6 14159.9 666.6 779.6 791.9 795.6 801.4 793.2 797.1 800.4 800.6 800.7 841.9 842.4 844.1 845.2 845.5 699.9 806.1 829.0 833.2 833.5 610.2 611.6 615.8 616.0 616.5 14647.3 14679.7 14760.7 14777.4 14792.9 13950.5 14391.3 14438.5 14480.6 14542.3 12939.5 12941.8 12967.6 13089.5 13531.9 4317.3 4352.3 4506.4 4613.4 4620.4 65558.7 72545.3 73752.0 73867.3 73935.3 11276.2 11475.9 11815.0 11836.8 11905.2 20957.4 21187.7 21192.6 21255.0 21258.9 8745.7 8812.5 8826.6 8986.6 9058.3 4710.5 4742.5 4771.7 4802.0 4864.6 3492.6 3627.2 3631.3 3634.2 3635.7 629.5 630.7 633.7 639.9 647.4 609.5 648.9 688.0 758.5 767.3 9402.8 9727.7 9863.3 9939.3 10371.3 743.8 749.0 765.6 782.2 790.9 4675.8 4895.5 4969.7 4976.7 5019.5 113053.0 113919.0 113967.0 114906.4 118352.0 97292.5 97555.0 97705.5 97885.5 100377.5 52708.2 82394.0 86004.1 86260.6 88006.6 8881.7 9240.5 9423.8 9466.6 9627.2 39656.4 45813.0 49766.8 50967.5 51869.0 76952.6 77236.2 77262.5 79255.2 80329.6 11637.6 11688.4 11790.2 12069.2 12248.9 13387.3 13570.3 13600.9 13792.6 14308.5 11278.2 11674.9 11923.2 12169.5 12470.6 11799.2 12517.6 12808.4 12931.5 12952.8 11606.8 12006.8 12442.6 12486.6 12551.4 10242.4 10249.2 10709.6 10787.7 11170.7 10142.7 10396.7 10683.0 10823.1 10866.7 02:38:54 INFO - PROCESS | 17901 | -------- Summary: end -------- 02:38:54 INFO - PROCESS | 17901 | 02:38:55 INFO - TEST-INFO | 17901: exit 0 02:38:55 INFO - TEST-OK | dromaeo_css | took 1113714ms 02:38:55 INFO - TEST-START | kraken 02:38:55 INFO - operating with platform_type : linux_ 02:38:55 INFO - Initialising browser for kraken test... 02:38:55 INFO - TEST-INFO | started process 18083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf_6KWj/profile http://localhost:33543/getInfo.html) 02:38:59 INFO - PROCESS | 18083 | __metrics Screen width/height:1600/1200 02:38:59 INFO - PROCESS | 18083 | colorDepth:24 02:38:59 INFO - PROCESS | 18083 | Browser inner width/height: 1024/697 02:38:59 INFO - PROCESS | 18083 | __metrics 02:39:00 INFO - PROCESS | 18083 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:01 INFO - TEST-INFO | 18083: exit 0 02:39:01 INFO - Browser initialized. 02:39:01 INFO - Running cycle 1/1 for kraken test... 02:39:01 INFO - TEST-INFO | started process 18164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf_6KWj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:12 INFO - PROCESS | 18164 | RSS: Main: 156934144 02:39:12 INFO - PROCESS | 18164 | 02:39:15 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:16 INFO - PROCESS | 18164 | RSS: Main: 214786048 02:39:16 INFO - PROCESS | 18164 | 02:39:18 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-dft) 02:39:19 INFO - PROCESS | 18164 | RSS: Main: 202317824 02:39:19 INFO - PROCESS | 18164 | 02:39:22 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-fft) 02:39:23 INFO - PROCESS | 18164 | RSS: Main: 268308480 02:39:23 INFO - PROCESS | 18164 | 02:39:25 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33543/tests/kraken/driver.html?testName=audio-oscillator) 02:39:25 INFO - PROCESS | 18164 | RSS: Main: 179466240 02:39:25 INFO - PROCESS | 18164 | 02:39:28 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:39:28 INFO - PROCESS | 18164 | RSS: Main: 183185408 02:39:28 INFO - PROCESS | 18164 | 02:39:31 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33543/tests/kraken/driver.html?testName=imaging-darkroom) 02:39:32 INFO - PROCESS | 18164 | RSS: Main: 218058752 02:39:32 INFO - PROCESS | 18164 | 02:39:35 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33543/tests/kraken/driver.html?testName=imaging-desaturate) 02:39:36 INFO - PROCESS | 18164 | RSS: Main: 219738112 02:39:36 INFO - PROCESS | 18164 | 02:39:38 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33543/tests/kraken/driver.html?testName=json-parse-financial) 02:39:39 INFO - PROCESS | 18164 | RSS: Main: 220393472 02:39:39 INFO - PROCESS | 18164 | 02:39:41 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:39:41 INFO - PROCESS | 18164 | RSS: Main: 207015936 02:39:41 INFO - PROCESS | 18164 | 02:39:43 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:44 INFO - PROCESS | 18164 | RSS: Main: 210391040 02:39:44 INFO - PROCESS | 18164 | 02:39:46 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:46 INFO - PROCESS | 18164 | RSS: Main: 219164672 02:39:46 INFO - PROCESS | 18164 | 02:39:49 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:49 INFO - PROCESS | 18164 | RSS: Main: 221335552 02:39:49 INFO - PROCESS | 18164 | 02:39:52 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:53 INFO - PROCESS | 18164 | RSS: Main: 223281152 02:39:53 INFO - PROCESS | 18164 | 02:39:54 INFO - PROCESS | 18164 | Cycle 1(1): loaded http://localhost:33543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33543/tests/kraken/driver.html?testName=ai-astar) 02:39:55 INFO - PROCESS | 18164 | RSS: Main: 264880128 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | __start_tp_report 02:39:55 INFO - PROCESS | 18164 | _x_x_mozilla_page_load 02:39:55 INFO - PROCESS | 18164 | _x_x_mozilla_page_load_details 02:39:55 INFO - PROCESS | 18164 | |i|pagename|runs| 02:39:55 INFO - PROCESS | 18164 | |0;ai-astar;101;112;109;110;110;111;111;110;110;109 02:39:55 INFO - PROCESS | 18164 | |1;audio-beat-detection;149;124;126;172;125;125;146;128;155;124 02:39:55 INFO - PROCESS | 18164 | |2;audio-dft;161;161;161;161;160;160;162;160;162;162 02:39:55 INFO - PROCESS | 18164 | |3;audio-fft;76;75;77;111;76;75;75;75;97;75 02:39:55 INFO - PROCESS | 18164 | |4;audio-oscillator;86;85;116;85;85;85;115;85;85;127 02:39:55 INFO - PROCESS | 18164 | |5;imaging-gaussian-blur;117;117;116;117;117;116;116;117;117;116 02:39:55 INFO - PROCESS | 18164 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;146 02:39:55 INFO - PROCESS | 18164 | |7;imaging-desaturate;94;95;94;95;95;94;94;95;94;94 02:39:55 INFO - PROCESS | 18164 | |8;json-parse-financial;53;53;52;53;52;54;54;54;53;53 02:39:55 INFO - PROCESS | 18164 | |9;json-stringify-tinderbox;62;61;62;61;62;63;61;61;64;62 02:39:55 INFO - PROCESS | 18164 | |10;stanford-crypto-aes;80;78;80;79;80;79;82;81;92;81 02:39:55 INFO - PROCESS | 18164 | |11;stanford-crypto-ccm;129;126;123;119;120;119;121;121;139;132 02:39:55 INFO - PROCESS | 18164 | |12;stanford-crypto-pbkdf2;156;159;156;156;156;155;158;157;156;156 02:39:55 INFO - PROCESS | 18164 | |13;stanford-crypto-sha256-iterative;63;64;65;66;70;62;63;63;63;61 02:39:55 INFO - PROCESS | 18164 | __end_tp_report 02:39:55 INFO - PROCESS | 18164 | __start_cc_report 02:39:55 INFO - PROCESS | 18164 | _x_x_mozilla_cycle_collect,1660 02:39:55 INFO - PROCESS | 18164 | __end_cc_report 02:39:55 INFO - PROCESS | 18164 | __startTimestamp1467193195147__endTimestamp 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | ------- Summary: start ------- 02:39:55 INFO - PROCESS | 18164 | Number of tests: 14 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.97 02:39:55 INFO - PROCESS | 18164 | Values: 101.0 112.0 109.0 110.0 110.0 111.0 111.0 110.0 110.0 109.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:137.00 stddev:17.00 (12.4%) stddev-sans-first:17.50 02:39:55 INFO - PROCESS | 18164 | Values: 149.0 124.0 126.0 172.0 125.0 125.0 146.0 128.0 155.0 124.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 02:39:55 INFO - PROCESS | 18164 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 162.0 160.0 162.0 162.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:12.48 (16.5%) stddev-sans-first:13.09 02:39:55 INFO - PROCESS | 18164 | Values: 76.0 75.0 77.0 111.0 76.0 75.0 75.0 75.0 97.0 75.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:16.81 (19.8%) stddev-sans-first:17.49 02:39:55 INFO - PROCESS | 18164 | Values: 86.0 85.0 116.0 85.0 85.0 85.0 115.0 85.0 85.0 127.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:39:55 INFO - PROCESS | 18164 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:39:55 INFO - PROCESS | 18164 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:39:55 INFO - PROCESS | 18164 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 02:39:55 INFO - PROCESS | 18164 | Values: 53.0 53.0 52.0 53.0 52.0 54.0 54.0 54.0 53.0 53.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 02:39:55 INFO - PROCESS | 18164 | Values: 62.0 61.0 62.0 61.0 62.0 63.0 61.0 61.0 64.0 62.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:3.97 (4.9%) stddev-sans-first:4.18 02:39:55 INFO - PROCESS | 18164 | Values: 80.0 78.0 80.0 79.0 80.0 79.0 82.0 81.0 92.0 81.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:124.50 stddev:6.62 (5.3%) stddev-sans-first:6.86 02:39:55 INFO - PROCESS | 18164 | Values: 129.0 126.0 123.0 119.0 120.0 119.0 121.0 121.0 139.0 132.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.00 stddev:1.18 (0.8%) stddev-sans-first:1.24 02:39:55 INFO - PROCESS | 18164 | Values: 156.0 159.0 156.0 156.0 156.0 155.0 158.0 157.0 156.0 156.0 02:39:55 INFO - PROCESS | 18164 | 02:39:55 INFO - PROCESS | 18164 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.50 stddev:2.54 (4.0%) stddev-sans-first:2.67 02:39:55 INFO - PROCESS | 18164 | Values: 63.0 64.0 65.0 66.0 70.0 62.0 63.0 63.0 63.0 61.0 02:39:55 INFO - PROCESS | 18164 | -------- Summary: end -------- 02:39:55 INFO - PROCESS | 18164 | 02:39:56 INFO - TEST-INFO | 18164: exit 0 02:39:56 INFO - TEST-OK | kraken | took 60957ms 02:39:56 INFO - SUITE-END | took 1174s 02:39:56 INFO - Completed test suite (00:19:34) 02:39:56 INFO - javascript benchmark 02:39:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.130997665667, 3050.481418158913, 3065.5708200851886, 3084.537319402091, 3109.4092122496736, 5098.643094983353, 5160.045391602552, 5174.767135478903, 5232.502912223342, 5262.131748261537, 5203.167493201088, 5231.110711179099, 5235.293235413218, 5253.264542963988, 5306.124489459245, 4687.953120468803, 4760.047990401916, 4776.0, 4791.712497250159, 4931.013797240548, 4838.733869637169, 4840.806367745286, 4868.19674753667, 4889.095517329288, 4900.877478063041, 4615.376924115252, 4645.744484053375, 4658.138244424776, 4670.556297151765, 4687.390639216897, 4638.1187574360765, 4659.673822832403, 4724.196886529264, 4731.905361892743, 4766.142094423002, 4687.554682305175, 4701.271302948048, 4724.314974328738, 4729.125111854318, 4750.762461876927, 5053.444121146671, 5085.567726743194, 5110.182370820651, 5178.197379406198, 5196.740162991835, 5515.669059856422, 5609.046462101412, 5612.466815652507, 5613.4386561343945, 5615.634983726045, 5585.357683866367, 5609.270794796691, 5642.971785141048, 5654.519365853907, 5655.462731040545, 5123.308353372285, 5148.124818780816, 5243.187305967543, 5243.685378877241, 5315.468453154731, 5723.627964182315, 5733.111367738007, 5734.340550836624, 5742.0238559445, 5748.6838223898085, 5383.542398896059, 5520.1167813149705, 5531.6957567333375, 5536.695481748462, 5537.8061767837935, 5480.26016487777, 5545.140503222007, 5553.639013464192, 5556.333240011225, 5608.96234196675, 5538.529225015838, 5559.416261292506, 5565.554755619541, 5572.637778544382, 5578.860528486739, 5386.111291636915, 5492.093804522209, 5575.637583557056, 5579.0, 5624.943750562524, 4212.19968206046, 4218.240716671029, 4269.082147338338, 4285.46431696038, 4321.719088259253, 3827.5789663137034, 3842.1739326044476, 3847.480590120354, 3869.1487872667967, 3888.2612303662213, 5399.865003374947, 5402.081646120169, 5404.8108316208745, 5406.0, 5411.540019098421, 5440.075187218183, 5502.889942201134, 5566.610337276352, 5573.108302671634, 5585.162225666101, 5294.867628309246, 5296.1261391870685, 5299.549538289211, 5300.867478313073, 5313.760880760375, 4752.928706069411, 4827.986122914227, 4831.057943701015, 4832.420109586872, 4866.878328041827, 5730.7421166047625, 5753.33836608787, 5754.0, 5807.216025836543, 5835.795747148744, 5626.409227031267, 5626.578006649435, 5629.521490673339, 5631.408702086222, 5634.718264086861, 5572.331320241597, 5782.277215348082, 5819.098039803837, 5837.6497410155525, 5839.883202336015, 5501.697406642513, 5534.806281780118, 5548.611597188158, 5548.916766248591, 5587.413321601173, 5631.549476041825, 5639.210510528611, 5649.378568357395, 5651.858703532444, 5654.180143879197, 5333.359996800409, 5371.946280537301, 5383.0579648562125, 5440.836774896759, 5552.167174923632, 5410.78356865721, 5417.485338892799, 5417.729113544386, 5421.295231619864, 5455.727213639381, 5320.840374788762, 5351.678899266057, 5354.651947623392, 5355.089634762177, 5402.864928376822, 5302.5227729502985, 5302.522772950453, 5434.891302174014, 5442.265294185234, 5487.0, 5235.869103272296, 5254.3169387979315, 5269.683818970874, 5278.920816187683, 5279.0], "value": 5145.967416399688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2380457795708, 619.3589634728056, 624.2041397218549, 632.2570979099556, 638.9936100638998, 29844.25389365267, 41257.17485650289, 42975.35536966944, 43401.565984340225, 43673.78163109188, 40730.59269407312, 44656.0, 44672.0, 44792.3281150783, 44936.0, 8036.236557527026, 8863.246624036949, 9017.36878418511, 9025.729228123135, 10534.420606866619, 10400.947995260012, 10535.789284214312, 10773.62292319769, 10813.621523246688, 10819.242653014293, 10907.509162087725, 10969.0, 10972.177086718488, 10984.0, 10984.06635435985, 10808.135349172047, 10833.891661083368, 10883.292585981964, 10886.0746836519, 10896.455177241185, 10506.527206275736, 10566.418846963414, 10572.312799667998, 10573.048425641653, 10575.153987680967, 43350.56649433528, 43520.782396088136, 43718.12563748707, 43774.34338484925, 43807.561924380985, 3436.621971583124, 3618.3125206210734, 3730.9253814923823, 3763.604821493731, 4236.364545318227, 33684.0, 33739.0, 33851.4922276166, 33995.830020849986, 34406.31187376239, 4430.158269928703, 4451.132029254297, 4476.574725401082, 4497.460304763449, 4603.723776573416, 372104.0, 374063.0, 374154.0, 375016.99999999726, 375299.0, 62368.634195605875, 62478.687606561674, 62864.685676571324, 63028.36971630225, 63036.0, 66691.33308666851, 66833.33166668368, 67370.32629673739, 67379.3262067373, 67484.0, 17190.054546999785, 17667.911660441616, 17690.469285921445, 17699.292028318723, 17719.557011074827, 13422.127561708458, 13439.664008399868, 13449.462021519226, 13481.865181348061, 13487.730245395038, 19772.11025503856, 20611.69082463764, 20627.79372206289, 20647.380578582666, 20654.380368588965, 7297.16082650502, 7543.283388078234, 7553.622318884144, 7774.162430712862, 7809.657102869231, 1020.9081182693593, 1097.2045267181388, 1143.1940481960198, 1144.5707859552667, 1150.7800339166818, 31093.53359699606, 31228.219294517363, 31272.821597462047, 31273.530897036562, 31397.52903706446, 1141.303804679145, 1142.725745820997, 1148.3798748675622, 1154.9826752598717, 1215.3133479584008, 16617.3353065876, 16761.7485737714, 16838.49484515442, 16955.814719115773, 17071.573210669583, 117531.0, 117561.41219293849, 119251.0, 119854.4007279958, 120091.0, 58974.70512647495, 59436.40563594309, 59502.70248648729, 59507.40492595105, 59681.40318596758, 1245.2964075297427, 1338.6318762340434, 1377.8415482219473, 1379.1035826712516, 1390.6731917999464, 31970.68029319677, 33256.33487330288, 33430.16134112647, 33633.327333453686, 33832.49251261282, 50681.49318506915, 51160.48839511557, 51164.48835511597, 51205.231921521954, 51225.487745122075, 371364.0, 371710.0, 371722.0, 371988.0, 372553.0, 34379.0, 38002.429963550014, 38036.0, 41071.1785764289, 42394.550484922845, 47911.520884790705, 48311.275330869365, 49265.50734492609, 49839.75080124721, 50454.0, 38725.80637096796, 40562.0, 40690.59309406987, 40846.59153408428, 41089.79455102705, 40911.38632920449, 41433.37849932193, 41509.37735933903, 41861.79069104635, 42097.579024210594, 40826.0, 41094.794526028374, 41757.37363939604, 42106.789466052476, 42367.78816106023, 33629.3274134511, 37102.44346334861, 38129.0, 39489.2102157961, 40530.39204411877, 27549.449011020068, 28324.575131372632, 28378.148655539542, 28579.428411432073, 28644.0], "value": 20276.75418878361, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.80349261178293, 386.5573917864046, 388.66186417816493, 398.30893399951077, 414.09520198366573, 14460.349284282207, 16564.75152872708, 17946.19242134104, 19631.705524417146, 19652.0, 18705.625887482278, 18846.71729924052, 19037.904810475964, 19041.904790476063, 19077.42767716967, 5590.8602284943, 5631.380548139691, 5661.150827375906, 5686.09022556391, 5692.459216374458, 4078.449409329732, 5618.820047789969, 5687.402822703619, 5703.944770217502, 6127.908081378783, 6363.649999250039, 6448.097266382711, 6478.287388387297, 6478.870422591545, 6480.351964803529, 6213.658248796314, 6380.138681278015, 6398.040293955897, 6408.58344207625, 6450.225972883237, 5600.411956744524, 5644.0, 5652.519535839418, 5658.603897727161, 5668.716564171775, 13204.60386188416, 15706.057636541844, 20253.29113481036, 21571.784282157136, 21585.67621485679, 2340.6957095577636, 2354.646802979567, 2864.5130327844317, 2892.363679990399, 2924.956125658117, 9037.954810225972, 9444.622215111387, 9464.905350946472, 9525.952370238174, 10074.194064474825, 1765.6733504301744, 1840.5700599278496, 1856.5265857206462, 1945.7567804024497, 1999.7900220476786, 77713.61143194305, 77902.0, 78898.60550697267, 79478.0, 83551.0, 9870.851937220947, 10239.129673977795, 10402.739931501774, 10456.477176141163, 10634.30876992993, 12784.0, 12825.94784834422, 13694.589162325146, 14557.85442145565, 14569.41722331116, 6369.71336289868, 6477.287498375175, 7573.545587264672, 8099.06860711014, 8146.75559733209, 7742.806429839299, 7816.140224575292, 7900.091489478668, 7934.761957141295, 7981.521108733495, 4484.663650226246, 4526.728396296233, 4550.726956382561, 4698.788554515055, 4709.481956984729, 1909.6371689378973, 1913.1964574878584, 1919.8464122870137, 1921.6156768646326, 1952.7070939358925, 934.3926447808842, 1006.8489726541078, 1009.5507499162802, 1033.963811266602, 1053.3048188195753, 17597.208125634377, 18762.061896905372, 18878.905605471886, 18983.52541186454, 20063.498412539804, 940.6942743608355, 981.2003217377815, 1030.2324768047852, 1033.8552602635637, 1075.8870318616432, 10134.391936483687, 10294.639687610897, 10359.533820978075, 10474.0, 10579.153667706565, 179131.0, 179573.0, 179620.0, 349262.0, 486343.0, 57400.997887356134, 71145.93281100788, 87305.0, 88434.0, 90186.0, 1017.3946501831399, 1026.7279171019686, 1043.2644985285356, 1047.4029803012363, 1060.1359891688248, 15946.202689865693, 15958.202089895227, 16249.593760155618, 16264.0, 16288.837111628733, 38705.806470967465, 39894.80052599718, 41779.37330940099, 42172.36741448942, 42459.93850153771, 58908.0, 59433.702831487295, 59589.40410595838, 60412.09381859188, 61279.0, 7087.362137407658, 7607.771766847003, 7773.339266162439, 7789.688412463438, 7873.566953817595, 9545.713628591153, 12364.690882728004, 12971.935140324238, 13215.801762973371, 13337.933310333387, 11428.657140285804, 11583.942080289544, 11607.76784464323, 11629.302241865515, 11852.34812085309, 11149.944250278697, 11167.274127181707, 11283.435828208721, 11413.086953043903, 12307.56923507673, 11732.0, 11769.764604707687, 11892.227005244631, 11966.521339146337, 12026.579069732517, 7687.11598166218, 7740.225977402215, 7767.1067827200595, 7819.124349524636, 7871.370290376871, 10232.283740138118, 11810.468528916048, 11855.407229638657, 11888.821667675165, 12070.879291206975], "value": 8831.141670878627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.7364113997762, 1451.1220711469562, 1475.4983305676071, 1555.2301610702705, 1747.7116275814492, 7914.445988780788, 8196.13940536244, 8220.75337739868, 8498.660053597849, 8504.064552899192, 8203.30271926887, 8377.246047855691, 8379.539125348103, 8387.245147936685, 8395.370347223952, 1937.331620590901, 2145.731783527059, 2196.1983875885267, 2214.059024914413, 2224.110355857662, 2159.341400872733, 2168.0677308757226, 2168.3169801512554, 2168.533765240473, 2170.6201414752436, 2205.4155648753094, 2216.34617787753, 2254.289898681918, 2255.4474153832252, 2256.277991042867, 1883.4349695091487, 2085.176355339632, 2134.935951921445, 2138.101997161196, 2163.9026243819067, 2149.5915776002666, 2155.084089262057, 2176.031665908671, 2179.073893595216, 2180.3349978256624, 8517.57412129391, 8546.70086546974, 8574.571271436465, 8576.528290943996, 8605.526696031715, 5088.643794934356, 5273.314469119028, 5275.498827611371, 5276.34045744282, 5281.445448227919, 3108.2850944282713, 3131.7964332318325, 3170.936581268385, 3185.7769956103084, 3301.4552598821165, 1075.7687097274124, 1102.2174256278051, 2184.2573525001417, 2239.2050821958132, 2262.490939538607, 12123.515059397614, 12213.572524961672, 12229.388530573524, 12246.571370002008, 12252.203606765532, 4233.894152646147, 4294.6993710439965, 4312.525622181557, 4361.2367835629275, 4373.956260437419, 9082.273418126533, 9116.1339672731, 9119.316051296179, 9139.63441462334, 9140.085991400807, 5117.667351622133, 5120.92318615221, 5122.538971492509, 5127.897442051138, 5127.948720512747, 4280.935785963213, 4717.528247175255, 4847.079054979543, 4859.125357435695, 4933.038057578738, 3613.6928361089076, 3680.282344942764, 3707.073231692077, 3754.699624030071, 3782.3759079752085, 1071.2287153249647, 1072.4262519552003, 1073.7476692977143, 1097.1990446973755, 1101.4107452512867, 912.5391677203103, 919.2370332623906, 960.188640598693, 973.2214228617078, 1024.5184763161303, 5939.46544810969, 5979.4917432018765, 6042.456178943916, 6139.171211886427, 6240.375962403723, 900.5542256583034, 923.0769230769231, 943.9669611563562, 949.1979277510493, 985.8915519292872, 4048.919021619551, 4207.969047583361, 4344.522102568715, 4344.522102568715, 4379.737215767064, 10643.41461219625, 11116.61091861781, 11168.832467512993, 11194.10447164225, 11212.383318917375, 9669.274804389559, 10995.615153469591, 11019.614313498989, 11046.668599942015, 11056.11551075912, 7540.509866858637, 7986.361091112697, 7992.440529162903, 8014.519128852171, 8063.072746634095, 5967.164596956342, 5971.731272092679, 6180.783672571439, 6300.747970081329, 6408.423241908251, 9643.421394716339, 9957.850632240377, 10183.18534517222, 10186.236032297458, 10295.691129266133, 10246.436445995541, 10262.538185781508, 10272.178225741773, 10285.0, 10355.326903751233, 7723.266289702694, 7751.496152750054, 8017.759467215993, 8042.235987581171, 8063.072746634212, 8375.078741338326, 8388.119247479171, 8450.19723126302, 8452.32381409498, 8500.36247281444, 7599.0, 7743.186965368781, 7774.378049756119, 7942.960285198537, 7966.123726389977, 7419.888701669372, 7476.028116344841, 7560.319571238615, 7626.313631773167, 7824.4131690124605, 6582.0785090086465, 6931.965340173267, 7030.086088808423, 7076.575405475688, 7081.681324340314, 4900.215965445512, 4999.0, 5052.444231134646, 5093.23601459784, 5233.241180028951, 5086.54221120101, 5184.0, 5350.892982140414, 5362.731863406736, 5473.397926228191], "value": 4575.850108495135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.858459354916, 291.1048525783217, 295.7825997891551, 310.967348428415, 317.1342235696549, 5288.338957630296, 5294.338207724035, 5302.284191634133, 5316.697409134763, 5319.574434045277, 5157.74211289435, 5202.791888324472, 5208.0, 5213.661112027716, 5215.4523775003645, 3816.580176180611, 3877.3602355611292, 4022.637962583367, 4048.1701251243426, 4075.470188875442, 4035.9798201009103, 4038.1923615276914, 4053.43251944728, 4057.84351459834, 4080.510338759353, 3875.457435958968, 4019.376996565537, 4025.7117722328867, 4034.700220874103, 4040.5757395473347, 3864.091938394475, 4040.676745860324, 4058.4115303281155, 4086.3041837637343, 4098.446709694183, 3575.713942884563, 3585.8386372613295, 3591.3535563598543, 3593.7484376093685, 3608.2963822054708, 5046.6719663221775, 5074.0, 5079.933214025059, 5080.8221712240265, 5086.949130508685, 4488.932666010012, 4632.25883858581, 4653.534646535353, 4660.790264438108, 4669.859904202879, 5361.222622719683, 5376.623636345457, 5437.673739575638, 5443.945560544384, 5444.292242008553, 3912.217556488685, 3930.194310166409, 3933.7443066200603, 3950.1236912466634, 3961.851063191671, 5319.787208511655, 5624.0439125348785, 5625.915611265793, 5626.521745651625, 5671.149327600893, 3952.8616498422416, 3968.7420317679835, 3969.4839670842607, 3983.466365449323, 3993.2612466693754, 4009.699272554512, 4015.819288132041, 4021.3163762159916, 4041.6766658667234, 4042.2723909696538, 4409.647228221735, 4586.6789324747615, 4595.9080818383445, 4603.769811509478, 4625.722456652545, 5480.945190548044, 5485.862853428616, 5491.615586908878, 5494.835154945358, 5497.752601132958, 1353.824002879639, 1365.6176270644235, 1367.911085779441, 1369.2263870912902, 1374.5670113914084, 881.1320848963894, 897.4615230861561, 902.869083982832, 903.46695449685, 903.6896500074918, 4820.783064762094, 5236.24074509194, 5306.548943339782, 5329.840104796862, 5344.839654810362, 5577.414371491016, 5593.972030139905, 5598.552115830724, 5631.070873305859, 5639.125935480007, 5085.771140298695, 5305.283786688748, 5330.600204984642, 5344.6258761887075, 5345.492178243061, 2985.731064297665, 3006.383691343269, 3025.515917453241, 3034.332446861731, 3034.4234595426797, 5872.7357268923, 5885.352611212763, 5897.970510147507, 5915.881682366328, 5954.0, 5524.392316845144, 5730.0, 5731.254936858265, 5794.652320860761, 5845.444682755132, 5774.133879918046, 5782.132680098019, 5814.499765100963, 5844.0, 5855.414458554195, 5358.892822143614, 5587.262241501716, 5591.832245032656, 5595.300587426572, 5631.802886898939, 5582.888342233051, 5604.551635869202, 5605.299337582802, 5632.380438151882, 5634.4365563443325, 5815.680137592473, 5841.386654401226, 5859.0372225305, 5865.354810970875, 5869.207656966426, 3885.9222815544094, 4065.9593404066763, 4094.877153685394, 4122.711410201257, 4127.9174416512105, 5597.272354593877, 5597.860053498695, 5608.270924779753, 5634.211210430625, 5639.6334238274385, 5283.286756287852, 5328.4671532846405, 5427.782888684408, 5439.782408703766, 5476.91784623223, 5514.558835293247, 5531.336239651107, 5553.416891226525, 5559.944400555943, 5562.749676264659, 5487.725613719218, 5488.4785945335125, 5492.91760623583, 5494.725263736877, 5496.80761173357, 5345.65253258537, 5485.35439368196, 5507.807226747044, 5508.173773933942, 5583.190437386637, 5374.596905232045, 5393.1370980642905, 5437.429069947599, 5460.563154947674, 5477.562484694273], "value": 4162.018654454108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4853626729422, 748.2255865179541, 769.6459628570857, 776.4293244465317, 800.5876973358719, 15038.47365342212, 15879.761803572941, 16659.750103748454, 16664.58338541537, 16685.33258669655, 13953.162810231393, 14097.788533171984, 14125.364358603862, 14153.646158846033, 14159.858401415982, 666.5534092158266, 779.6024027745862, 791.8653828849081, 795.558465051896, 801.410962942237, 793.1790596732383, 797.1112209885964, 800.3757069485781, 800.5596921693075, 800.6837299266787, 841.9368547358941, 842.418731075559, 844.0546587821618, 845.2097289034772, 845.526505157114, 699.8705239530677, 806.1253539909205, 829.0258945738793, 833.2251006563893, 833.5248908122372, 610.1671218786369, 611.5810669691276, 615.8398816307747, 615.984600384994, 616.4544378225258, 14647.267636618233, 14679.70640587193, 14760.704785904329, 14777.408903643842, 14792.926035369863, 13950.51173208943, 14391.280435978158, 14438.49465268721, 14480.637984050378, 14542.27288635564, 12939.48242070316, 12941.805872911913, 12967.610971670865, 13089.47642094315, 13531.932340338333, 4317.330813723878, 4352.347147927804, 4506.369108324837, 4613.354130421743, 4620.422447194101, 65558.67220663914, 72545.27454725438, 73752.0, 73867.26132738711, 73935.26064739391, 11276.154288428237, 11475.94197108552, 11815.0, 11836.822447663291, 11905.166638335406, 20957.371278861658, 21187.68218476724, 21192.576148477252, 21255.0435230415, 21258.893705531373, 8745.693900713444, 8812.471251724917, 8826.646934122691, 8986.640534378552, 9058.32062595308, 4710.458297295786, 4742.487986760524, 4771.6898401603785, 4801.95198048015, 4864.610831133501, 3492.633273506296, 3627.183883626216, 3631.3100510902846, 3634.164142247245, 3635.7273204509765, 629.5058379172327, 630.7004173017872, 633.7369991453587, 639.9360063993656, 647.3817504283398, 609.4971648390095, 648.8734696734186, 687.9577440178134, 758.4614923404334, 767.2519293688721, 9402.764930876783, 9727.65953191635, 9863.260255480867, 9939.254555908336, 10371.325863818827, 743.7880204141794, 748.9775306740806, 765.6478020110811, 782.1865260129401, 790.8853216283607, 4675.836345727951, 4895.461499235082, 4969.726665033386, 4976.651634385631, 5019.548240658358, 113053.0, 113919.0, 113967.0, 114906.42546787212, 118352.0, 97292.51353743327, 97555.0, 97705.51147244219, 97885.51057244668, 100377.49811250897, 52708.20937685861, 82394.0, 86004.13995860086, 86260.56869715611, 88006.55996720103, 8881.73354799357, 9240.537973101453, 9423.764405889633, 9466.574004169966, 9627.159987803474, 39656.40515392329, 45813.0, 49766.751166243936, 50967.49032509776, 51868.96262074662, 76952.61523692346, 77236.2276377229, 77262.50112487734, 79255.20744792478, 80329.59835200786, 11637.592684256011, 11688.415579220835, 11790.174687771774, 12069.155159138776, 12248.87751122513, 13387.263700496565, 13570.253636050113, 13600.86399135996, 13792.586222413343, 14308.49920252786, 11278.210525263154, 11674.94162529182, 11923.165378423428, 12169.513219471122, 12470.563530276397, 11799.17405781587, 12517.624471265877, 12808.359582020676, 12931.482740690268, 12952.8057079142, 11606.825897611712, 12006.75986480248, 12442.564510242099, 12486.625401237978, 12551.435185416862, 10242.436665983443, 10249.180065594883, 10709.625163119254, 10787.67636970892, 11170.664880053611, 10142.695719128438, 10396.74008149772, 10683.0, 10823.134149268197, 10866.684862169257], "value": 7457.156801371742, "unit": "score"}], "name": "dromaeo_css", "value": 7125.462037502166, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 109.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 126.0, 172.0, 125.0, 125.0, 146.0, 128.0, 155.0, 124.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 160.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 111.0, 76.0, 75.0, 75.0, 75.0, 97.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 116.0, 85.0, 85.0, 85.0, 115.0, 85.0, 85.0, 127.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 52.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 62.0, 63.0, 61.0, 61.0, 64.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 80.0, 79.0, 80.0, 79.0, 82.0, 81.0, 92.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 123.0, 119.0, 120.0, 119.0, 121.0, 121.0, 139.0, 132.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 156.0, 156.0, 156.0, 155.0, 158.0, 157.0, 156.0, 156.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 66.0, 70.0, 62.0, 63.0, 63.0, 63.0, 61.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1482.7000000000003, "alertThreshold": 2.0}]} 02:39:56 INFO - Return code: 0 02:39:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:56 INFO - # TBPL SUCCESS # 02:39:56 INFO - Running post-action listener: _resource_record_post_action 02:39:56 INFO - ##### 02:39:56 INFO - ##### Finished run-tests step (success) 02:39:56 INFO - ##### 02:39:56 INFO - Running post-run listener: _resource_record_post_run 02:39:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 551976960; Read time: 0; Write time: 586684 02:39:56 INFO - TinderboxPrint: CPU usage
13.1% 02:39:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:39:56 INFO - TinderboxPrint: I/O write bytes / time
551,976,960 / 586,684 02:39:56 INFO - TinderboxPrint: CPU idle
8,263.4 (86.9%) 02:39:56 INFO - TinderboxPrint: CPU user
1,204.0 (12.7%) 02:39:56 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255950848; Read time: 0; Write time: 327624 02:39:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296026112; Read time: 0; Write time: 259060 02:39:57 INFO - Running post-run listener: _upload_blobber_files 02:39:57 INFO - Blob upload gear active. 02:39:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:57 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 02:39:57 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'] 02:39:57 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 02:39:57 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:01 INFO - (blobuploader) - INFO - Done attempting. 02:40:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:02 INFO - (blobuploader) - INFO - Done attempting. 02:40:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:03 INFO - (blobuploader) - INFO - Done attempting. 02:40:03 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:03 INFO - Return code: 0 02:40:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1cc8109279c3ab295682debac7dd76c65556e370a3145997975df39482aa1f4f3e2eff99c8017e360ae3213273dacbd9e260ff42b71855f54e21e02dbd2512d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7358647b7eb18ff33b593b376c55e6e7c0bd307b8ed7d965dd62937bac06c99855689978934c47b7bf2e6d153a4056bfb856b4578d24557dd5526d3f08a494b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa6a035c8f8d09f093014f1bea0ab8ab401c8ec89c9608440426ecc63848e65942078a86548413fa6ae1139c4288f5374f681cba8bfe9fa42e6b3abc8fdce01"} 02:40:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:03 INFO - Contents: 02:40:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1cc8109279c3ab295682debac7dd76c65556e370a3145997975df39482aa1f4f3e2eff99c8017e360ae3213273dacbd9e260ff42b71855f54e21e02dbd2512d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7358647b7eb18ff33b593b376c55e6e7c0bd307b8ed7d965dd62937bac06c99855689978934c47b7bf2e6d153a4056bfb856b4578d24557dd5526d3f08a494b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa6a035c8f8d09f093014f1bea0ab8ab401c8ec89c9608440426ecc63848e65942078a86548413fa6ae1139c4288f5374f681cba8bfe9fa42e6b3abc8fdce01"} 02:40:03 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:03 INFO - Copying logs to upload dir... 02:40:03 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.751707 ========= master_lag: 219.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 21 secs) (at 2016-06-29 02:43:42.682469) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-06-29 02:43:42.685705) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306 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/c1cc8109279c3ab295682debac7dd76c65556e370a3145997975df39482aa1f4f3e2eff99c8017e360ae3213273dacbd9e260ff42b71855f54e21e02dbd2512d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7358647b7eb18ff33b593b376c55e6e7c0bd307b8ed7d965dd62937bac06c99855689978934c47b7bf2e6d153a4056bfb856b4578d24557dd5526d3f08a494b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa6a035c8f8d09f093014f1bea0ab8ab401c8ec89c9608440426ecc63848e65942078a86548413fa6ae1139c4288f5374f681cba8bfe9fa42e6b3abc8fdce01"} build_url:https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/Kxw9gqoNQ0-8LGU--XFS9g/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/c1cc8109279c3ab295682debac7dd76c65556e370a3145997975df39482aa1f4f3e2eff99c8017e360ae3213273dacbd9e260ff42b71855f54e21e02dbd2512d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7358647b7eb18ff33b593b376c55e6e7c0bd307b8ed7d965dd62937bac06c99855689978934c47b7bf2e6d153a4056bfb856b4578d24557dd5526d3f08a494b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fa6a035c8f8d09f093014f1bea0ab8ab401c8ec89c9608440426ecc63848e65942078a86548413fa6ae1139c4288f5374f681cba8bfe9fa42e6b3abc8fdce01"}' ========= master_lag: 1.92 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-06-29 02:43:44.613979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:43:44.614312) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1467190955.401886-1599118306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:43:44.820999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:43:44.821383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 02:43:44.847105) ========= ========= Total master_lag: 221.85 =========