builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1466772132.74 results: success (0) buildid: 20160624023004 builduid: 4cde38562f2748f18a7049080cbb6ee8 revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:12.741974) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:12.742955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:12.743660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:12.761548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:12.761969) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 05:42:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|: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.0M=0s 2016-06-24 05:42:12 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:12.952975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:12.953365) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.092215 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:13.059459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:13.060191) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f27664669366144c1756f0b416277c16ac96ac2 --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 9f27664669366144c1756f0b416277c16ac96ac2 --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=934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 05:42:13,054 truncating revision to first 12 chars 2016-06-24 05:42:13,055 Setting DEBUG logging. 2016-06-24 05:42:13,055 attempt 1/10 2016-06-24 05:42:13,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f2766466936?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 05:42:13,365 unpacking tar archive at: fx-team-9f2766466936/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703192 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:13.778363) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:13.778743) ========= script_repo_revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:13.779218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:13.779558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:42:13.791055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 05:42:13.791534) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:13 INFO - MultiFileLogger online at 20160624 05:42:13 in /builds/slave/test 05:42:13 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 05:42:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:13 INFO - {'append_to_log': False, 05:42:13 INFO - 'base_work_dir': '/builds/slave/test', 05:42:13 INFO - 'blob_upload_branch': 'Fx-Team', 05:42:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:13 INFO - 'branch': 'Fx-Team', 05:42:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:13 INFO - 'config_files': ('talos/linux_config.py',), 05:42:13 INFO - 'default_actions': ('clobber', 05:42:13 INFO - 'read-buildbot-config', 05:42:13 INFO - 'download-and-extract', 05:42:13 INFO - 'populate-webroot', 05:42:13 INFO - 'create-virtualenv', 05:42:13 INFO - 'install', 05:42:13 INFO - 'run-tests'), 05:42:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:13 INFO - 'download_minidump_stackwalk': True, 05:42:13 INFO - 'download_symbols': 'ondemand', 05:42:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:13 INFO - 'installer_path': 'installer.exe', 05:42:13 INFO - 'log_level': 'info', 05:42:13 INFO - 'log_name': 'talos', 05:42:13 INFO - 'log_to_console': True, 05:42:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:13 INFO - 'opt_config_files': (), 05:42:13 INFO - 'pip_index': False, 05:42:13 INFO - 'sps_profile': False, 05:42:13 INFO - 'sps_profile_interval': 0, 05:42:13 INFO - 'suite': 'dromaeojs', 05:42:13 INFO - 'system_bits': '32', 05:42:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:13 INFO - 'title': 'talos-linux64-ix-057', 05:42:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:13 INFO - 'use_talos_json': True, 05:42:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:13 INFO - 'work_dir': 'build'} 05:42:13 INFO - ##### 05:42:13 INFO - ##### Running clobber step. 05:42:13 INFO - ##### 05:42:13 INFO - Running pre-action listener: _resource_record_pre_action 05:42:13 INFO - Running main action method: clobber 05:42:13 INFO - rmtree: /builds/slave/test/build 05:42:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:16 INFO - Running post-action listener: _resource_record_post_action 05:42:16 INFO - ##### 05:42:16 INFO - ##### Finished clobber step (success) 05:42:16 INFO - ##### 05:42:16 INFO - ##### 05:42:16 INFO - ##### Running read-buildbot-config step. 05:42:16 INFO - ##### 05:42:16 INFO - Running pre-action listener: _resource_record_pre_action 05:42:16 INFO - Running main action method: read_buildbot_config 05:42:16 INFO - Using buildbot properties: 05:42:16 INFO - { 05:42:16 INFO - "project": "", 05:42:16 INFO - "product": "firefox", 05:42:16 INFO - "script_repo_revision": "production", 05:42:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:42:16 INFO - "repository": "", 05:42:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:42:16 INFO - "buildid": "20160624023004", 05:42:16 INFO - "pgo_build": "True", 05:42:16 INFO - "basedir": "/builds/slave/test", 05:42:16 INFO - "buildnumber": 826, 05:42:16 INFO - "slavename": "talos-linux64-ix-057", 05:42:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:42:16 INFO - "platform": "ubuntu64_hw", 05:42:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:42:16 INFO - "branch": "fx-team", 05:42:16 INFO - "repo_path": "integration/fx-team", 05:42:16 INFO - "revision": "9f27664669366144c1756f0b416277c16ac96ac2", 05:42:16 INFO - "stage_platform": "linux64-pgo", 05:42:16 INFO - "builduid": "4cde38562f2748f18a7049080cbb6ee8", 05:42:16 INFO - "slavebuilddir": "test" 05:42:16 INFO - } 05:42:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:42:16 INFO - Running post-action listener: _resource_record_post_action 05:42:16 INFO - ##### 05:42:16 INFO - ##### Finished read-buildbot-config step (success) 05:42:16 INFO - ##### 05:42:16 INFO - ##### 05:42:16 INFO - ##### Running download-and-extract step. 05:42:16 INFO - ##### 05:42:16 INFO - Running pre-action listener: _resource_record_pre_action 05:42:16 INFO - Running main action method: download_and_extract 05:42:16 INFO - mkdir: /builds/slave/test/build/tests 05:42:16 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')]} 05:42:16 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:16 INFO - Downloaded 1361 bytes. 05:42:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:42:16 INFO - Using the following test package requirements: 05:42:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:42:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:42:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'jsshell-linux-x86_64.zip'], 05:42:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:42:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:42:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:42:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:42:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:42:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:42:16 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')]} 05:42:16 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:17 INFO - Downloaded 24277318 bytes. 05:42:17 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'] 05:42:17 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 05:42:19 INFO - Return code: 0 05:42:19 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 05:42:19 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')]} 05:42:19 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:20 INFO - Downloaded 24277318 bytes. 05:42:20 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'] 05:42:20 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 05:42:22 INFO - Return code: 0 05:42:22 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')]} 05:42:22 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:23 INFO - Downloaded 14405518 bytes. 05:42:23 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'] 05:42:23 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 05:42:24 INFO - Return code: 0 05:42: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')]} 05:42:24 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:42:25 INFO - Downloaded 60165888 bytes. 05:42:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:25 INFO - mkdir: /builds/slave/test/properties 05:42:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:42:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:42:25 INFO - Contents: 05:42:25 INFO - build_url:https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:42:26 INFO - Running post-action listener: _resource_record_post_action 05:42:26 INFO - Running post-action listener: set_extra_try_arguments 05:42:26 INFO - ##### 05:42:26 INFO - ##### Finished download-and-extract step (success) 05:42:26 INFO - ##### 05:42:26 INFO - ##### 05:42:26 INFO - ##### Running populate-webroot step. 05:42:26 INFO - ##### 05:42:26 INFO - Running pre-action listener: _resource_record_pre_action 05:42:26 INFO - Running main action method: populate_webroot 05:42:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:42:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:42:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:42:26 INFO - '--tppagecycles', 05:42:26 INFO - '7'], 05:42:26 INFO - 'tests': ['tsvgm']}}, 05:42:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:42:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:42:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:42:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:42:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['damp', 'tps']}, 05:42:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'tests': ['damp', 'tps']}, 05:42:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['dromaeo_dom']}, 05:42:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:42:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['basic_compositor_video']}, 05:42:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:42:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['a11yr', 05:42:26 INFO - 'ts_paint', 05:42:26 INFO - 'tpaint', 05:42:26 INFO - 'sessionrestore', 05:42:26 INFO - 'sessionrestore_no_auto_restore', 05:42:26 INFO - 'tabpaint']}, 05:42:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:42:26 INFO - 'ts_paint', 05:42:26 INFO - 'tpaint', 05:42:26 INFO - 'sessionrestore', 05:42:26 INFO - 'sessionrestore_no_auto_restore', 05:42:26 INFO - 'tabpaint']}, 05:42:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:42:26 INFO - 'ts_paint', 05:42:26 INFO - 'tpaint', 05:42:26 INFO - 'sessionrestore', 05:42:26 INFO - 'sessionrestore_no_auto_restore', 05:42:26 INFO - 'tabpaint']}, 05:42:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:42:26 INFO - 'ts_paint', 05:42:26 INFO - 'tpaint', 05:42:26 INFO - 'sessionrestore', 05:42:26 INFO - 'sessionrestore_no_auto_restore', 05:42:26 INFO - 'tabpaint']}, 05:42:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['a11yr', 05:42:26 INFO - 'ts_paint', 05:42:26 INFO - 'tpaint', 05:42:26 INFO - 'sessionrestore', 05:42:26 INFO - 'sessionrestore_no_auto_restore', 05:42:26 INFO - 'tabpaint']}, 05:42:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['a11yr', 05:42:26 INFO - 'ts_paint', 05:42:26 INFO - 'tpaint', 05:42:26 INFO - 'sessionrestore', 05:42:26 INFO - 'sessionrestore_no_auto_restore', 05:42:26 INFO - 'tabpaint']}, 05:42:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['tsvgx', 05:42:26 INFO - 'tsvgr_opacity', 05:42:26 INFO - 'tart', 05:42:26 INFO - 'tscrollx', 05:42:26 INFO - 'cart']}, 05:42:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:42:26 INFO - 'tsvgr_opacity', 05:42:26 INFO - 'tart', 05:42:26 INFO - 'tscrollx', 05:42:26 INFO - 'cart']}, 05:42:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'talos_options': ['--disable-e10s'], 05:42:26 INFO - 'tests': ['tp5o']}, 05:42:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'tests': ['tp5o']}, 05:42:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'talos_options': ['--disable-e10s', 05:42:26 INFO - '--xperf_path', 05:42:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:26 INFO - 'tests': ['tp5n']}, 05:42:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:26 INFO - 'talos_options': ['--xperf_path', 05:42:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:26 INFO - 'tests': ['tp5n']}}, 05:42:26 INFO - 'talos.zip': {'path': '', 05:42:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:42:26 INFO - Running post-action listener: _resource_record_post_action 05:42:26 INFO - ##### 05:42:26 INFO - ##### Finished populate-webroot step (success) 05:42:26 INFO - ##### 05:42:26 INFO - ##### 05:42:26 INFO - ##### Running create-virtualenv step. 05:42:26 INFO - ##### 05:42:26 INFO - Running pre-action listener: _resource_record_pre_action 05:42:26 INFO - Running main action method: create_virtualenv 05:42:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:42:26 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 05:42:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:42:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:42:26 INFO - Using real prefix '/usr' 05:42:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:42:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:42:29 INFO - Installing pip.................done. 05:42:29 INFO - Return code: 0 05:42:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:29 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:29 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 05:42:29 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 05:42:29 INFO - Using env: {'DISPLAY': ':0', 05:42:29 INFO - 'HOME': '/home/cltbld', 05:42:29 INFO - 'LANG': 'en_US.UTF-8', 05:42:29 INFO - 'LANGUAGE': 'en_US:en', 05:42:29 INFO - 'LOGNAME': 'cltbld', 05:42:29 INFO - 'MAIL': '/var/mail/cltbld', 05:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:29 INFO - 'MOZ_NO_REMOTE': '1', 05:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:29 INFO - 'NO_EM_RESTART': '1', 05:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:29 INFO - 'PWD': '/builds/slave/test', 05:42:29 INFO - 'SHELL': '/bin/bash', 05:42:29 INFO - 'SHLVL': '1', 05:42:29 INFO - 'TERM': 'linux', 05:42:29 INFO - 'TMOUT': '86400', 05:42:29 INFO - 'USER': 'cltbld', 05:42:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:29 INFO - '_': '/tools/buildbot/bin/python'} 05:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:29 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 05:42:29 INFO - Cleaning up... 05:42:29 INFO - Return code: 0 05:42:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:29 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:29 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 05:42:29 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 05:42:29 INFO - Using env: {'DISPLAY': ':0', 05:42:29 INFO - 'HOME': '/home/cltbld', 05:42:29 INFO - 'LANG': 'en_US.UTF-8', 05:42:29 INFO - 'LANGUAGE': 'en_US:en', 05:42:29 INFO - 'LOGNAME': 'cltbld', 05:42:29 INFO - 'MAIL': '/var/mail/cltbld', 05:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:29 INFO - 'MOZ_NO_REMOTE': '1', 05:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:29 INFO - 'NO_EM_RESTART': '1', 05:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:29 INFO - 'PWD': '/builds/slave/test', 05:42:29 INFO - 'SHELL': '/bin/bash', 05:42:29 INFO - 'SHLVL': '1', 05:42:29 INFO - 'TERM': 'linux', 05:42:29 INFO - 'TMOUT': '86400', 05:42:29 INFO - 'USER': 'cltbld', 05:42:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:29 INFO - '_': '/tools/buildbot/bin/python'} 05:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:30 INFO - Downloading/unpacking psutil>=3.1.1 05:42:30 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 05:42:30 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 05:42:30 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 05:42:30 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 05:42:30 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 05:42:30 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 05:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:32 INFO - Installing collected packages: psutil 05:42:32 INFO - Running setup.py install for psutil 05:42:32 INFO - building 'psutil._psutil_linux' extension 05:42:32 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 05:42:33 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 05:42:33 INFO - building 'psutil._psutil_posix' extension 05:42:33 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 05:42:33 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 05:42:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:42:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:42:33 INFO - Successfully installed psutil 05:42:33 INFO - Cleaning up... 05:42:33 INFO - Return code: 0 05:42:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:42:33 INFO - Using env: {'DISPLAY': ':0', 05:42:33 INFO - 'HOME': '/home/cltbld', 05:42:33 INFO - 'LANG': 'en_US.UTF-8', 05:42:33 INFO - 'LANGUAGE': 'en_US:en', 05:42:33 INFO - 'LOGNAME': 'cltbld', 05:42:33 INFO - 'MAIL': '/var/mail/cltbld', 05:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:33 INFO - 'MOZ_NO_REMOTE': '1', 05:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:33 INFO - 'NO_EM_RESTART': '1', 05:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:33 INFO - 'PWD': '/builds/slave/test', 05:42:33 INFO - 'SHELL': '/bin/bash', 05:42:33 INFO - 'SHLVL': '1', 05:42:33 INFO - 'TERM': 'linux', 05:42:33 INFO - 'TMOUT': '86400', 05:42:33 INFO - 'USER': 'cltbld', 05:42:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:33 INFO - '_': '/tools/buildbot/bin/python'} 05:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:42:33 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 05:42:33 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 05:42:33 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 05:42:33 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 05:42:33 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 05:42:33 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 05:42:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:42:35 INFO - Installing collected packages: mozsystemmonitor 05:42:35 INFO - Running setup.py install for mozsystemmonitor 05:42:35 INFO - Successfully installed mozsystemmonitor 05:42:35 INFO - Cleaning up... 05:42:35 INFO - Return code: 0 05:42:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:42:35 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')]} 05:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:35 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')]} 05:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:35 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:35 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 05:42:35 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 05:42:36 INFO - Using env: {'DISPLAY': ':0', 05:42:36 INFO - 'HOME': '/home/cltbld', 05:42:36 INFO - 'LANG': 'en_US.UTF-8', 05:42:36 INFO - 'LANGUAGE': 'en_US:en', 05:42:36 INFO - 'LOGNAME': 'cltbld', 05:42:36 INFO - 'MAIL': '/var/mail/cltbld', 05:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:36 INFO - 'MOZ_NO_REMOTE': '1', 05:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:36 INFO - 'NO_EM_RESTART': '1', 05:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:36 INFO - 'PWD': '/builds/slave/test', 05:42:36 INFO - 'SHELL': '/bin/bash', 05:42:36 INFO - 'SHLVL': '1', 05:42:36 INFO - 'TERM': 'linux', 05:42:36 INFO - 'TMOUT': '86400', 05:42:36 INFO - 'USER': 'cltbld', 05:42:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:36 INFO - '_': '/tools/buildbot/bin/python'} 05:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:42:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:42:38 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 05:42:38 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 05:42:38 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 05:42:38 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 05:42:38 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 05:42:38 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 05:42:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:42:38 INFO - warning: no files found matching '*.txt' 05:42:38 INFO - no previously-included directories found matching 'build' 05:42:38 INFO - no previously-included directories found matching 'dist' 05:42:38 INFO - no previously-included directories found matching '.git*' 05:42:38 INFO - Installing collected packages: jsonschema, functools32 05:42:38 INFO - Running setup.py install for functools32 05:42:38 INFO - warning: no files found matching '*.txt' 05:42:38 INFO - no previously-included directories found matching 'build' 05:42:38 INFO - no previously-included directories found matching 'dist' 05:42:38 INFO - no previously-included directories found matching '.git*' 05:42:38 INFO - Successfully installed jsonschema functools32 05:42:38 INFO - Cleaning up... 05:42:38 INFO - Return code: 0 05:42:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:38 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:38 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 05:42:38 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 05:42:38 INFO - Using env: {'DISPLAY': ':0', 05:42:38 INFO - 'HOME': '/home/cltbld', 05:42:38 INFO - 'LANG': 'en_US.UTF-8', 05:42:38 INFO - 'LANGUAGE': 'en_US:en', 05:42:38 INFO - 'LOGNAME': 'cltbld', 05:42:38 INFO - 'MAIL': '/var/mail/cltbld', 05:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:38 INFO - 'MOZ_NO_REMOTE': '1', 05:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:38 INFO - 'NO_EM_RESTART': '1', 05:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:38 INFO - 'PWD': '/builds/slave/test', 05:42:38 INFO - 'SHELL': '/bin/bash', 05:42:38 INFO - 'SHLVL': '1', 05:42:38 INFO - 'TERM': 'linux', 05:42:38 INFO - 'TMOUT': '86400', 05:42:38 INFO - 'USER': 'cltbld', 05:42:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:38 INFO - '_': '/tools/buildbot/bin/python'} 05:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:42:38 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 05:42:38 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 05:42:38 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 05:42:38 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 05:42:38 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 05:42:38 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 05:42:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:42:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:42:40 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 05:42:40 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 05:42:40 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 05:42:40 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 05:42:40 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 05:42:40 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 05:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:42:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:42:41 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 05:42:41 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 05:42:41 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 05:42:41 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 05:42:41 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 05:42:41 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 05:42:41 INFO - Downloading docopt-0.6.1.tar.gz 05:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:42:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:42:41 INFO - Running setup.py install for blobuploader 05:42:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:42:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:42:41 INFO - Running setup.py install for requests 05:42:41 INFO - Running setup.py install for docopt 05:42:41 INFO - Successfully installed blobuploader requests docopt 05:42:41 INFO - Cleaning up... 05:42:42 INFO - Return code: 0 05:42:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:42 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:42 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 05:42:42 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 05:42:42 INFO - Using env: {'DISPLAY': ':0', 05:42:42 INFO - 'HOME': '/home/cltbld', 05:42:42 INFO - 'LANG': 'en_US.UTF-8', 05:42:42 INFO - 'LANGUAGE': 'en_US:en', 05:42:42 INFO - 'LOGNAME': 'cltbld', 05:42:42 INFO - 'MAIL': '/var/mail/cltbld', 05:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:42 INFO - 'MOZ_NO_REMOTE': '1', 05:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:42 INFO - 'NO_EM_RESTART': '1', 05:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:42 INFO - 'PWD': '/builds/slave/test', 05:42:42 INFO - 'SHELL': '/bin/bash', 05:42:42 INFO - 'SHLVL': '1', 05:42:42 INFO - 'TERM': 'linux', 05:42:42 INFO - 'TMOUT': '86400', 05:42:42 INFO - 'USER': 'cltbld', 05:42:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:42 INFO - '_': '/tools/buildbot/bin/python'} 05:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:42 INFO - Running setup.py (path:/tmp/pip-XUw8WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:42 INFO - Running setup.py (path:/tmp/pip-Ue1E7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:42 INFO - Running setup.py (path:/tmp/pip-gT3T2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:42 INFO - Running setup.py (path:/tmp/pip-ae2Lnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:42 INFO - Running setup.py (path:/tmp/pip-gfpWFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:42 INFO - Running setup.py (path:/tmp/pip-5NcQdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:42 INFO - Running setup.py (path:/tmp/pip-BJwo2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:42 INFO - Running setup.py (path:/tmp/pip-aCBEJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:42 INFO - Running setup.py (path:/tmp/pip-53cFC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:42 INFO - Running setup.py (path:/tmp/pip-WzU1kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:42 INFO - Running setup.py (path:/tmp/pip-P8elDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:43 INFO - Running setup.py (path:/tmp/pip-jmAijK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:43 INFO - Running setup.py (path:/tmp/pip-hoqTSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:43 INFO - Running setup.py (path:/tmp/pip-focLhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:43 INFO - Running setup.py (path:/tmp/pip-GszVea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:43 INFO - Running setup.py (path:/tmp/pip-8tMyOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:43 INFO - Running setup.py (path:/tmp/pip-3LZlch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:43 INFO - Running setup.py install for manifestparser 05:42:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:42:43 INFO - Running setup.py install for mozcrash 05:42:43 INFO - Running setup.py install for mozdebug 05:42:43 INFO - Running setup.py install for mozdevice 05:42:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:42:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:42:43 INFO - Running setup.py install for mozfile 05:42:44 INFO - Running setup.py install for mozhttpd 05:42:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Running setup.py install for mozinfo 05:42:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Running setup.py install for mozInstall 05:42:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Running setup.py install for mozleak 05:42:44 INFO - Running setup.py install for mozlog 05:42:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Running setup.py install for moznetwork 05:42:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Running setup.py install for mozprocess 05:42:44 INFO - Running setup.py install for mozprofile 05:42:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Running setup.py install for mozrunner 05:42:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:42:44 INFO - Running setup.py install for mozscreenshot 05:42:45 INFO - Running setup.py install for moztest 05:42:45 INFO - Running setup.py install for mozversion 05:42:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:42:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:45 INFO - Cleaning up... 05:42:45 INFO - Return code: 0 05:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:45 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:45 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 05:42:45 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 05:42:45 INFO - Using env: {'DISPLAY': ':0', 05:42:45 INFO - 'HOME': '/home/cltbld', 05:42:45 INFO - 'LANG': 'en_US.UTF-8', 05:42:45 INFO - 'LANGUAGE': 'en_US:en', 05:42:45 INFO - 'LOGNAME': 'cltbld', 05:42:45 INFO - 'MAIL': '/var/mail/cltbld', 05:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:45 INFO - 'MOZ_NO_REMOTE': '1', 05:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:45 INFO - 'NO_EM_RESTART': '1', 05:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:45 INFO - 'PWD': '/builds/slave/test', 05:42:45 INFO - 'SHELL': '/bin/bash', 05:42:45 INFO - 'SHLVL': '1', 05:42:45 INFO - 'TERM': 'linux', 05:42:45 INFO - 'TMOUT': '86400', 05:42:45 INFO - 'USER': 'cltbld', 05:42:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:45 INFO - '_': '/tools/buildbot/bin/python'} 05:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:45 INFO - Running setup.py (path:/tmp/pip-cx7BMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:45 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)) 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:45 INFO - Running setup.py (path:/tmp/pip-CGSISH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:45 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)) 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:45 INFO - Running setup.py (path:/tmp/pip-HNpI8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:45 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)) 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:45 INFO - Running setup.py (path:/tmp/pip-24mtJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:45 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)) 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:45 INFO - Running setup.py (path:/tmp/pip-Jjzft_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:45 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)) 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:45 INFO - Running setup.py (path:/tmp/pip-rKm6yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:45 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)) 05:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:45 INFO - Running setup.py (path:/tmp/pip-oSc2UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:46 INFO - Running setup.py (path:/tmp/pip-7SKClX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:46 INFO - Running setup.py (path:/tmp/pip-qwAOLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:46 INFO - Running setup.py (path:/tmp/pip-s9sL8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:46 INFO - Running setup.py (path:/tmp/pip-fuFkgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:46 INFO - Running setup.py (path:/tmp/pip-onQwIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:46 INFO - Running setup.py (path:/tmp/pip-ros24j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:46 INFO - Running setup.py (path:/tmp/pip-rnN6_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:46 INFO - Running setup.py (path:/tmp/pip-FmJLy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:46 INFO - Running setup.py (path:/tmp/pip-k76xvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:46 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)) 05:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:46 INFO - Running setup.py (path:/tmp/pip-EL4uxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:46 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)) 05:42:46 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)) 05:42:46 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)) 05:42:46 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)) 05:42:46 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)) 05:42:46 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)) 05:42:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:46 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 05:42:46 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 05:42:46 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 05:42:46 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 05:42:46 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 05:42:46 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 05:42:48 INFO - Downloading blessings-1.6.tar.gz 05:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:48 INFO - Installing collected packages: blessings 05:42:48 INFO - Running setup.py install for blessings 05:42:48 INFO - Successfully installed blessings 05:42:48 INFO - Cleaning up... 05:42:48 INFO - Return code: 0 05:42:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:49 INFO - Reading from file tmpfile_stdout 05:42:49 INFO - Current package versions: 05:42:49 INFO - argparse == 1.2.1 05:42:49 INFO - blessings == 1.6 05:42:49 INFO - blobuploader == 1.2.4 05:42:49 INFO - docopt == 0.6.1 05:42:49 INFO - functools32 == 3.2.3-2 05:42:49 INFO - jsonschema == 2.5.1 05:42:49 INFO - manifestparser == 1.1 05:42:49 INFO - mozInstall == 1.12 05:42:49 INFO - mozcrash == 0.17 05:42:49 INFO - mozdebug == 0.1 05:42:49 INFO - mozdevice == 0.48 05:42:49 INFO - mozfile == 1.2 05:42:49 INFO - mozhttpd == 0.7 05:42:49 INFO - mozinfo == 0.9 05:42:49 INFO - mozleak == 0.1 05:42:49 INFO - mozlog == 3.2 05:42:49 INFO - moznetwork == 0.27 05:42:49 INFO - mozprocess == 0.22 05:42:49 INFO - mozprofile == 0.28 05:42:49 INFO - mozrunner == 6.11 05:42:49 INFO - mozscreenshot == 0.1 05:42:49 INFO - mozsystemmonitor == 0.3 05:42:49 INFO - moztest == 0.7 05:42:49 INFO - mozversion == 1.4 05:42:49 INFO - psutil == 3.1.1 05:42:49 INFO - requests == 1.2.3 05:42:49 INFO - wsgiref == 0.1.2 05:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:49 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')]} 05:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 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')]} 05:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:49 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 05:42:49 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 05:42:49 INFO - Using env: {'DISPLAY': ':0', 05:42:49 INFO - 'HOME': '/home/cltbld', 05:42:49 INFO - 'LANG': 'en_US.UTF-8', 05:42:49 INFO - 'LANGUAGE': 'en_US:en', 05:42:49 INFO - 'LOGNAME': 'cltbld', 05:42:49 INFO - 'MAIL': '/var/mail/cltbld', 05:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:49 INFO - 'MOZ_NO_REMOTE': '1', 05:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:49 INFO - 'NO_EM_RESTART': '1', 05:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:49 INFO - 'PWD': '/builds/slave/test', 05:42:49 INFO - 'SHELL': '/bin/bash', 05:42:49 INFO - 'SHLVL': '1', 05:42:49 INFO - 'TERM': 'linux', 05:42:49 INFO - 'TMOUT': '86400', 05:42:49 INFO - 'USER': 'cltbld', 05:42:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:49 INFO - '_': '/tools/buildbot/bin/python'} 05:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 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)) 05:42:49 INFO - Cleaning up... 05:42:49 INFO - Return code: 0 05:42:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42:49 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')]} 05:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 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')]} 05:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 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 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:49 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 05:42:49 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 05:42:49 INFO - Using env: {'DISPLAY': ':0', 05:42:49 INFO - 'HOME': '/home/cltbld', 05:42:49 INFO - 'LANG': 'en_US.UTF-8', 05:42:49 INFO - 'LANGUAGE': 'en_US:en', 05:42:49 INFO - 'LOGNAME': 'cltbld', 05:42:49 INFO - 'MAIL': '/var/mail/cltbld', 05:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:49 INFO - 'MOZ_NO_REMOTE': '1', 05:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:49 INFO - 'NO_EM_RESTART': '1', 05:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:49 INFO - 'PWD': '/builds/slave/test', 05:42:49 INFO - 'SHELL': '/bin/bash', 05:42:49 INFO - 'SHLVL': '1', 05:42:49 INFO - 'TERM': 'linux', 05:42:49 INFO - 'TMOUT': '86400', 05:42:49 INFO - 'USER': 'cltbld', 05:42:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:49 INFO - '_': '/tools/buildbot/bin/python'} 05:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:42:49 INFO - Cleaning up... 05:42:49 INFO - Return code: 0 05:42:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:42:49 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')]} 05:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 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')]} 05:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c97b2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', '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 05:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:42:49 INFO - Using env: {'DISPLAY': ':0', 05:42:49 INFO - 'HOME': '/home/cltbld', 05:42:49 INFO - 'LANG': 'en_US.UTF-8', 05:42:49 INFO - 'LANGUAGE': 'en_US:en', 05:42:49 INFO - 'LOGNAME': 'cltbld', 05:42:49 INFO - 'MAIL': '/var/mail/cltbld', 05:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:49 INFO - 'MOZ_NO_REMOTE': '1', 05:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:49 INFO - 'NO_EM_RESTART': '1', 05:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:49 INFO - 'PWD': '/builds/slave/test', 05:42:49 INFO - 'SHELL': '/bin/bash', 05:42:49 INFO - 'SHLVL': '1', 05:42:49 INFO - 'TERM': 'linux', 05:42:49 INFO - 'TMOUT': '86400', 05:42:49 INFO - 'USER': 'cltbld', 05:42:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:49 INFO - '_': '/tools/buildbot/bin/python'} 05:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:49 INFO - Downloading/unpacking flake8 05:42:49 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 05:42:49 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 05:42:49 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 05:42:49 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 05:42:49 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 05:42:49 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 05:42:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:42:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:42:51 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 05:42:51 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 05:42:51 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 05:42:51 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 05:42:51 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 05:42:51 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 05:42:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:42:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:42:51 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 05:42:51 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 05:42:51 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 05:42:51 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 05:42:51 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 05:42:51 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 05:42:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:52 INFO - no previously-included directories found matching 'docs/_build' 05:42:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:42:52 INFO - Running setup.py install for pep8 05:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:52 INFO - no previously-included directories found matching 'docs/_build' 05:42:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:42:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:42:52 INFO - Cleaning up... 05:42:52 INFO - Return code: 0 05:42:52 INFO - Running post-action listener: _resource_record_post_action 05:42:52 INFO - Running post-action listener: _start_resource_monitoring 05:42:52 INFO - Starting resource monitoring. 05:42:52 INFO - ##### 05:42:52 INFO - ##### Finished create-virtualenv step (success) 05:42:52 INFO - ##### 05:42:52 INFO - ##### 05:42:52 INFO - ##### Running install step. 05:42:52 INFO - ##### 05:42:52 INFO - Running pre-action listener: _resource_record_pre_action 05:42:52 INFO - Running main action method: install 05:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:52 INFO - Reading from file tmpfile_stdout 05:42:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:53 INFO - Reading from file tmpfile_stdout 05:42:53 INFO - Output received: 05:42:53 INFO - Usage: mozinstall [options] installer 05:42:53 INFO - Options: 05:42:53 INFO - -h, --help show this help message and exit 05:42:53 INFO - -d DEST, --destination=DEST 05:42:53 INFO - Directory to install application into. [default: 05:42:53 INFO - "/builds/slave/test"] 05:42:53 INFO - --app=APP Application being installed. [default: firefox] 05:42:53 INFO - mkdir: /builds/slave/test/build/application 05:42:53 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'] 05:42:53 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 05:43:10 INFO - Reading from file tmpfile_stdout 05:43:10 INFO - Output received: 05:43:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:43:10 INFO - Running post-action listener: _resource_record_post_action 05:43:10 INFO - ##### 05:43:10 INFO - ##### Finished install step (success) 05:43:10 INFO - ##### 05:43:10 INFO - ##### 05:43:10 INFO - ##### Running run-tests step. 05:43:10 INFO - ##### 05:43:10 INFO - Running pre-action listener: _resource_record_pre_action 05:43:10 INFO - Running main action method: run_tests 05:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:43:10 INFO - Python 2.7.3 05:43:10 INFO - Return code: 0 05:43:10 INFO - grabbing minidump binary from tooltool 05:43:10 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')]} 05:43:10 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 0x1066110>, '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 0xfd2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd26c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:43:10 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 05:43:10 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 05:43:10 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 05:43:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:10 INFO - Return code: 0 05:43:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:43:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:43:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:43:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:43:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:43:11 INFO - Return code: 0 05:43:11 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/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 05:43:11 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/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 05:43:11 INFO - Using env: {'DISPLAY': ':0', 05:43:11 INFO - 'HOME': '/home/cltbld', 05:43:11 INFO - 'LANG': 'en_US.UTF-8', 05:43:11 INFO - 'LANGUAGE': 'en_US:en', 05:43:11 INFO - 'LOGNAME': 'cltbld', 05:43:11 INFO - 'MAIL': '/var/mail/cltbld', 05:43:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:43:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:11 INFO - 'MOZ_NO_REMOTE': '1', 05:43:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:11 INFO - 'NO_EM_RESTART': '1', 05:43:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:11 INFO - 'PWD': '/builds/slave/test', 05:43:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:43:11 INFO - 'SHELL': '/bin/bash', 05:43:11 INFO - 'SHLVL': '1', 05:43:11 INFO - 'TERM': 'linux', 05:43:11 INFO - 'TMOUT': '86400', 05:43:11 INFO - 'USER': 'cltbld', 05:43:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605', 05:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:11 INFO - '_': '/tools/buildbot/bin/python'} 05:43:11 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/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 05:43:11 INFO - mozversion application_buildid: 20160624023004 05:43:11 INFO - mozversion application_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 05:43:11 INFO - mozversion application_display_name: Nightly 05:43:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:11 INFO - mozversion application_name: Firefox 05:43:11 INFO - mozversion application_remotingname: firefox 05:43:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:43:11 INFO - mozversion application_vendor: Mozilla 05:43:11 INFO - mozversion application_version: 50.0a1 05:43:11 INFO - mozversion platform_buildid: 20160624023004 05:43:11 INFO - mozversion platform_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 05:43:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:43:11 INFO - mozversion platform_version: 50.0a1 05:43:11 INFO - using testdate: 1466772191 05:43:11 INFO - actual date: 1466772191 05:43:11 INFO - starting webserver on 'localhost:34008' 05:43:11 INFO - SUITE-START | Running 2 tests 05:43:11 INFO - TEST-START | dromaeo_css 05:43:11 INFO - operating with platform_type : linux_ 05:43:11 INFO - Initialising browser for dromaeo_css test... 05:43:11 INFO - TEST-INFO | started process 3317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7A1zB0/profile http://localhost:34008/getInfo.html) 05:43:17 INFO - PROCESS | 3317 | __metrics Screen width/height:1600/1200 05:43:17 INFO - PROCESS | 3317 | colorDepth:24 05:43:17 INFO - PROCESS | 3317 | Browser inner width/height: 1024/697 05:43:17 INFO - PROCESS | 3317 | __metrics 05:43:18 INFO - PROCESS | 3317 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:43:19 INFO - TEST-INFO | 3317: exit 0 05:43:19 INFO - Browser initialized. 05:43:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:43:19 INFO - TEST-INFO | started process 3398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7A1zB0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:31 INFO - PROCESS | 3398 | RSS: Main: 174002176 05:43:31 INFO - PROCESS | 3398 | 05:44:22 INFO - PROCESS | 3398 | 1466772262002 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] 05:46:31 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34008/tests/dromaeo/cssquery-ext.html) 05:46:32 INFO - PROCESS | 3398 | RSS: Main: 279003136 05:46:32 INFO - PROCESS | 3398 | 05:49:34 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-ext.html (next: http://localhost:34008/tests/dromaeo/cssquery-jquery.html) 05:49:34 INFO - PROCESS | 3398 | RSS: Main: 254406656 05:49:34 INFO - PROCESS | 3398 | 05:52:36 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34008/tests/dromaeo/cssquery-mootools.html) 05:52:37 INFO - PROCESS | 3398 | RSS: Main: 256811008 05:52:37 INFO - PROCESS | 3398 | 05:55:39 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34008/tests/dromaeo/cssquery-prototype.html) 05:55:40 INFO - PROCESS | 3398 | RSS: Main: 248893440 05:55:40 INFO - PROCESS | 3398 | 05:58:42 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34008/tests/dromaeo/cssquery-yui.html) 05:58:43 INFO - PROCESS | 3398 | RSS: Main: 222306304 05:58:43 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-yui.html (next: http://localhost:34008/tests/dromaeo/cssquery-dojo.html) 06:01:46 INFO - PROCESS | 3398 | RSS: Main: 339255296 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | __start_tp_report 06:01:46 INFO - PROCESS | 3398 | _x_x_mozilla_page_load 06:01:46 INFO - PROCESS | 3398 | _x_x_mozilla_page_load_details 06:01:46 INFO - PROCESS | 3398 | |i|pagename|runs| 06:01:46 INFO - PROCESS | 3398 | |0;dojo.html;3091.644460886998;3095.6904309569045;3116.6883311668835;3135.9843200783994;3161.162291992621;5164.561012313949;5226.634135610509;5299.28459657946;5414.2420061191415;5423.294971653684;5315.255864179018;5336.30628018358;5338.092524270874;5341.946580534193;5376.650517716345;4819.975900120503;4860.392450943632;4895.632827537931;4908.7300198489065;5034.798608055673;4912.705237685733;4914.262860570907;4981.576565991895;4988.675736077162;4994.77523511441;4707.788149533262;4756.476787553366;4814.9759251203695;4829.903401931977;4882.267659851015;4745.810167593292;4762.071396077767;4775;4816.301636262722;4866.245731911559;4774.331593576902;4786.042791441726;4795.568398844121;4810.302506136591;4836.516348365135;5194.3247377840635;5259.605529585297;5309.8938021239355;5310.230016647564;5398.379186393576;5708.20085188074;5722.656640601535;5748.281464816898;5753.971230143822;5775.451332123442;5470.699111548864;5685.857853553653;5762.135679648044;5797.739101740432;5811.941880581182;5297.894042119136;5382.757775900094;5396.298481197458;5403.5136837684795;5419.403865574784;5882.617629854046;5898.970505147447;5905.379935106838;5909.763609455659;5910.970445147833;5433.185022246695;5550.195221692913;5600.243967064475;5687.573431992617;5704.600677952503;5671.262735844314;5672.914906276409;5733.3406658234;5771;5772.278465191851;5630.887382252332;5649.293838270216;5662.839117980887;5665.575081868877;5668.319801623749;5417.5395091416885;5566;5636.943630563724;5650.491455768918;5673.234113394639;4341.131773645284;4341.522432532419;4342.109867477159;4345.435093437896;4382.167388196232;3864.401017842239;3883.980580097081;3896.103896103912;3917.7845218513257;3918.6081391860585;5232.2674825524455;5273.024490469275;5299.5230429261555;5301.072312345401;5343.492368225013;5667.574931880125;5679.176519404746;5688.658680479184;5706.885862282731;5725.341585717612;5155.097857874857;5343.625946183807;5360.195970604441;5372.247885296062;5387.865303367369;4849.709017458964;4874.53691899269;4898.461169271377;4899.363082799285;4905.8037678492465;5849.415058494202;5858.297004359419;5858.648481091063;5860;5860.970695146497;5536.252605898313;5636.915446268227;5655.943440565542;5667.574931880208;5722.570807189394;5914.58597898143;5947.464728174485;5952.494038006818;5976.163337132718;5990.610610310316;5649.745761440663;5653.491185793134;5661.377248502744;5662.5469962402085;5664.660120392789;5568.693721845338;5638.9436105638415;5712.314522257356;5737.942620573741;5754.165645981393;5513.062779327604;5555.3333599966645;5599.80400685974;5608;5651.039323314964;5536.141898005815;5574.219609254626;5581.190727344593;5594.944050559442;5601.495865372136;5305.283786688748;5377.704226267437;5416.8645783854145;5440.755166017618;5484.287042684426;5622;5645.971770141287;5693.914591281217;5698.715064246854;5709.486146246858;5456.61803673739;5456.863578410572;5487.945120548743;5522;5537.916931246115 06:01:46 INFO - PROCESS | 3398 | |1;ext.html;584.771938943812;611.2481647573485;625.1716475669739;631.2046821005534;636.8153235561688;31799.205019874516;34412.65587344129;34450.65549344506;41370.37944430836;42286;42890.356644650354;43218.783906080425;43306;43347.56652433483;43375;8834.249088827457;9015.864762028576;9019.594118264693;9019.819603607957;9028.32287578431;8720.651173953034;8773.56132193391;8802.735917922473;8820.338474614398;8825.205731484197;8824.955875220616;8845.601947912359;8850.114988501162;8865.778355541132;8866.202041816236;8769.298456123526;8815.515146666994;8828.293736501097;8828.779280517974;8828.779280517974;8829.779255518599;8913.1086891311;8920.643174273022;8922.375433719642;8925.776855578597;41582.168356633;41709.79145104285;41898;41910.58089419097;41989.16021679549;3557.875474358385;3716.1081340478363;3720.553533575961;3727.6645101940953;3766.0773110587807;31390.84304578485;31662;31750.206244843834;31885.840570796998;32080;4434.2905135178535;4481.402873943125;4497.797599108016;4526.592606665383;4567.680262381635;227758;228201;228379;228501;228832;53747;54082.7295863526;54097;54117.1882421764;54157.187642185396;35197.296054079285;36332.63667363345;36402.45396319004;58230.7088464555;58411;15366.539003829903;15531.456399026205;15636.140012299433;15643;15664.295106720225;11153.888461115448;11315.94342028301;11324.263922844988;11340.092792576574;11345.489452974636;19380.4185874424;19403.80596194048;19435.3197638082;19451.416457506297;19471.707924381146;7182.2458641842895;7194.100737407824;7232.74685386009;7516.1585411574515;7552.358049565739;781.4881252779438;851.3742399336483;887.3078998381272;917.6788124156625;923.1230331185401;31525;31890;32201;32514.187145321557;32971.50542741861;1084.614961688605;1111.972200694973;1128.311729844794;1137.7781332640056;1193.8268951002055;16891.23989420479;16954.830451695325;17089.658206835793;17113.657726845395;17149.684792553096;550413;554993;555731;555746;556358;56902.715486422305;57292;57770;57789;57956.71021644865;1272.204871955028;1289.8323217981601;1292.4377895615437;1373.5329987804193;1390.610629023875;24838.627420588346;32424.675753242165;32442.513362300055;32817.50773738443;33101.66898330986;49552;49917.75041124771;50141.49858501368;50219.74890125526;50253.246201306276;378965;379933;380528;381159;381492;27595.44809103847;27719.30701732473;28085;28184.85907570449;28200.29499262535;47319;47836.28245576389;48466.5153348462;49187.50812491829;49365.25952110793;39866.60133398629;40069.59930400659;40191.99040048044;41070.38394424026;41804.790976044926;39385.40921886117;39840.402393964694;40140.1971960565;40370.79814600908;41063.38404923988;32656;40606.59393406028;43983.78008109939;44357.556424435345;44428.33357499705;34112.65887341095;35221.29557408889;35652.64347356597;35706.46440303345;36163.457548137325;27509.86245068762;27728.306792330353;27830.860845695643;28230.15309540717;28383 06:01:46 INFO - PROCESS | 3398 | |2;jquery.html;398.20359281437146;399.41286309125576;399.9540052893917;400.39340399295054;413.9544650088492;13325.163631527448;18231.726524102134;19895.502612434677;19928.40214793555;20509.46179036571;14734.56879614865;18307.90846045768;19157;19327.613447731037;19654.312099076535;5476.479734425223;5642.322921249456;5667.801626943058;5706.686132262724;5718.7426565804635;5547.889042219153;5632.436756324376;5648.548116150698;5649.971750141243;5651.2935883014625;4113.753174809506;5890.64656120632;6213.782517611885;6232.781852635158;6368.649724265187;6107.6946152692635;6328.208973878265;6329.715162817707;6333.714982825761;6355.173827402431;5576.1356989666665;5600.887982240373;5621;5622.0161471742285;5625.1843482695185;22711.43221419461;23082.884585577132;23435.53128937429;24156.39609009771;24286.149984750624;2389.3429306940557;2635.341164708823;2659.8271112377633;2743.7256274372603;2898.2754311422145;14313.212773297464;14352.633124754198;14372.712545749131;14798.926005370013;15356.385744570203;1951.2292644405522;1962.1562728026943;1964.7838737738837;2002.4393169912448;2021.0602070037355;77735;78276.21723782804;80130.79803803006;80185;80959;10471.16230701542;10491.580336786443;10809.35143891369;10825.350478971286;10938.234323597271;14665.706685866224;14733.852661473247;14751.557453276419;14753.704925901422;14781.33483993223;7797.298243158143;8139.38954578409;8217.712380066669;8269.09040005599;8296.170382961776;7900.920990790133;7924.920750792534;7940.61039318117;8033.236842499953;8046.718364857319;5864.32560255576;6019.638821670714;6334.904976425358;6594.241662208811;6597.538172327891;1691.8731095167911;1730.3251731824598;1744.6423483185915;1789.8836575622804;1815.0561707912075;940.83535381308;1044.4360045575456;1051.0435503691604;1051.7423231308226;1086.3970496374588;18788.342408015928;19157;19802.60394792096;19872.90063549702;19952.90023549902;1012.367270455965;1024.2881197567767;1031.5254982707888;1038.2835843268122;1091.3288327678579;10868.836967445495;11479.71300717472;11552.94223528877;11582.189246752814;11600.6519804406;370618;371617;376578;493024;494085;87474.56262718646;94400;98379.50810246046;103985.48007259915;104627.47686261672;1038.5170895533463;1060.125396547851;1061.7345663584103;1066.7439814444479;1073.9033486986052;17331;17570.560735981704;17612.91193544024;17856.821431786037;18121.003344815636;40608.390874137505;41495.377569335884;41723.582764171966;42725.786371067945;43321.78339108284;58435;60401.09398359116;60483.395166047776;61285;61505.69247153735;7225.819354515969;7578.621068946641;7619.238076192337;8506.234438900528;8761.956190219009;9248.306377021885;13179.934100329438;13229.272390018641;13235.205887646773;14221.715565688835;11614;11742.589009384972;11867.169298149392;12013.45939432745;12130.636080917586;5627.493525582553;9746.561404736945;10885.945570272099;11587.246828956091;11872.940635296769;12158.939205303917;12223.144379893321;12252.081093917814;12514.812277816021;12531.248125112523;7630.694772209049;7695.192004839411;7736.1877002916135;7782.571958542108;7807.492512986638;10766.407847568458;12094.334811585448;12163.391830408622;12367.62897113088;12476 06:01:46 INFO - PROCESS | 3398 | |3;mootools.html;1324.2915040453358;1438.5540482450438;1487.680148768015;1594.697007568562;1746.5197070805534;8505.234528892399;8770.517621530822;8780.69267575635;9024.593893274801;9050.502222377767;8754.824903501925;8919.286457083434;8921.910780892189;8925.018247992715;8943.195112439878;2038.286599690104;2274.37454699958;2306.2043594959714;2329.6621989811465;2346.554154710608;2394.5091256292417;2400.9759902401015;2406.3743426709093;2408.662787209792;2408.6868707068056;2282.6233671444193;2310.9884450577806;2346.741858395575;2350.0717216699395;2350.247920665388;1974.5162435203324;2152.698622192894;2221.3224966385246;2226.6882636430914;2264;2283.086765293879;2298.482841360697;2305.101010605865;2313.5257272259146;2314.5370925814905;8942.64229430822;8952.060033696433;9023.187913087853;9025.142611451902;9029.819403611891;5232.633715639907;5401.3248343957;5405.675659460406;5409.513143817036;5410.242566040718;3353.8658453661824;3487.6861082502696;3517.1383011162175;3527.805970671612;3530.8058056806867;1024.4621573673805;1028.0131074168808;1049.3494033699078;1051.1433181956681;1082.4966390628317;12431.502739890393;12494.500219991189;12504.187227830162;12510.18683785551;12511.937440312831;4797.208460603962;4804.303376010529;4862.3922009748785;4872.439669437989;4925.655204135748;10600.522976466078;10608;10617.256792024484;10618.256722029384;10623.787524249627;5464.562834973192;5466.453354664582;5471.835844924579;5472.2338872557875;5476.315460567429;4198.244316023145;4850.345203397566;5018.924716129261;5027.245913113063;5031.0441016206805;4028.194361127786;4050.3321272343846;4131.462909821704;4149.792510374469;4158.189153115113;1239.231676360662;1255.3158528601934;1258.1130303136267;1266.214946733013;1293;951.2627713521938;969.3166317745972;970.1995853420956;974.8342781727123;988.9505524723735;5883.558733095035;5955.7617695292565;6002.849928751816;6032.969835150796;6147.569670123048;922.1239822168832;972.5976837212074;973.1241882305982;983.5721461164417;1001.2040427859869;4050.6151915567975;4065.065035041957;4128.60778226068;4157.397177409319;4194.958050419517;10901.890981090246;11163.609273675545;11226.438678066064;11259.605913792979;11271;10995.945020274847;10999.450027498593;11098.05666518355;11119.44402779874;11149.331040137618;7901.367890568741;8163.918360816316;8193.877091843508;8374.916250837658;8385.706500272583;5841.50347220491;6026.909596356146;6063.72713227897;6077.969610151921;6084.39156084388;9944.204463643036;10033.1973442123;10201.54093065799;10253.74365640865;10268.743281418025;9794.951025244829;10203.591856325664;10365.06714395708;10374.325668831803;10466.842997354894;7022.508424410242;7484.775456736306;7693;8078.798030049061;8260.421770476009;8807.823843522965;8819.29445644334;8846.071162527842;8896.110388961051;8896.421732587361;7590.1650818411035;7725.49784264021;7735.303822655988;7864.4888082274465;7867.9606601966625;7600.581967991813;7670.616469176631;7723.806904827425;7843.764687059397;7854.882176767467;7139.286071392819;7188.28117188277;7225.277472252733;7228.530145540523;7229.710811567478;5052.924206136838;5255.395629502504;5392.137258038695;5419.376771671151;5424;5053.2420136979745;5220.112580861187;5352.330958630171;5453.209284653783;5465.480779325958 06:01:46 INFO - PROCESS | 3398 | |4;prototype.html;312.70918046217025;316.9651338352781;323.31134683124935;326.26915708812254;326.49067454770574;5134.2812006319145;5254.448282930285;5264.184051472023;5336.626436149471;5356.437574054722;5256.684598924057;5286.629935904488;5315.096433606286;5315.760790764415;5319.5478384337375;4144.212599606065;4176.1230141670285;4178.415021896937;4179.414881916534;4189.874303770892;3894.49371581694;3916.5887581803786;4158.293090174678;4166.937495937548;4170.8540201092965;4060.7157498975084;4115.444415003966;4122.979385103085;4125.66994640428;4127.772972486527;4085.7140000199997;4106.589341065899;4107.774072426016;4119.876403707894;4126.401671757609;3427.8174029959623;3644.2893635741043;3649.3066317399876;3658.8902332930056;3668.9816550917076;5133.870548479366;5162.535371816517;5183.481651834824;5184.662996905189;5192.55863251624;4653.255479123324;4673.813047478131;4681.297805329194;4695.506971767949;4698.177818881716;5399.811006614789;5471.808486702986;5508.531774799147;5511.53151982082;5515.7242137893345;3969;3983.880483585497;3985.8405663773415;3987.0829709167056;3987.182627561343;5711.428857114297;5721.513671337942;5749.13762935563;5752.769889204426;5767.692922830859;3870.1872606752336;3961.4652021976663;3964.682825373963;4021.3565829467143;4026.335654617014;4002.2195671844293;4023.376376661622;4023.657989070962;4031.09300407406;4045.130296986162;4586.610138138229;4598.333241679938;4598.471175814824;4616;4621.214393553104;5485.177223416519;5519.944800551943;5528;5543.7782488700805;5552.444755524496;1381.84799672036;1403.677154254527;1437.6334034821055;1446.7540518111946;1449.1015570346453;910.6402970826487;914.8993610702818;916.935814492979;926.6339795780764;957.1337939165066;4722.315264286728;4744.881377965509;4822.879428014257;4833.154198015333;4837.177679794373;4985.45450910219;5036.370453693288;5072.858606813437;5083;5086.516780905808;4704.270838020112;4801.567858892717;4814.446338671028;4831.347768051339;5043.5712964398435;2995.3559984603417;3027.9697203028127;3034.924126896801;3051.2219384056925;3056.9082927511768;5899.5546091207925;5912.9113063304085;5917.31950825652;5920.727043685542;5929.169916211734;5567.860803479945;5785.971070144707;5801.477866991991;5818.08003358899;5842.56857070012;5753.683547404849;5783.450572195718;5817.563682723812;5832.387599302097;5885.352611212763;5349.411564727799;5608.317504748477;5617.831465056055;5634.492895639412;5660.094384898396;5584.218209450599;5611;5633.577481688808;5652.915206271991;5663.688497132697;5854.214464588342;5864.501517371071;5871.324797648325;5894.233749612523;5905.114232865105;3666.7616604920595;3795.1650636859845;3983.143624120828;4013.8996525087105;4049.4735684360844;5595.496405323541;5626.915596266142;5633.887322253614;5677.552224182972;5687.374388817309;5519.199716041232;5520.282363292747;5525.917111243415;5526.972365138148;5543.778248870161;5328.440513746156;5530.6128570999645;5641.294838145232;5648.322201335866;5651.547876169979;5506.697131657637;5511.862203444946;5529.419410961952;5533.972330138324;5549.889002220014;5389.757460914347;5602.803901863415;5608.822147349102;5625.268715067015;5637.633553818989;5483.835484935458;5506.944930550803;5508.586855985737;5518.696471694096;5540.279763630702 06:01:46 INFO - PROCESS | 3398 | |5;yui.html;657.9605223686576;665.5840099937536;737.8266107464748;790.032210542086;808.6078252047756;15224.543263702079;16231.026138431687;16254.51236462908;16295.51113466598;16374.345026198953;14418.783718244209;14771.778423323633;14924.776128358084;15129.848701512981;15160.772588411182;675.0953722012503;803.0082847683107;819.8401311744212;821.0639870547551;827.7682248970268;788.7397158937537;813.3127507256359;818.3453237410077;819.0294501016285;820.0774129104757;850.8596081646521;856.5931182688236;857.9914200858005;858.1547176031604;858.682287553606;707.6744697439184;727.7125535413535;851.7913111287743;851.8466675998318;851.8722191671268;539.5575627985054;606.3996643323078;606.8058221369164;614.0328981853598;616.9105479705462;14573.271336433136;14579.19814410207;14591.270436478133;14619.488317908928;14652.633684157981;13608.727825443435;14441.78337324941;14549.854501454956;14694.632634184123;14807.629809254748;12352.197107188003;12568.622941311774;12622.936885315607;12694.746105077847;13210.141340812816;4394.8242070317465;4395.142947125312;4404.119176164748;4425.137098265807;4425.645948324126;67076.6646166766;69129.65435172842;69245.65377173082;71604.6419767903;77581.99999999943;10791.190660700478;11032.06227470674;11701.414929253504;11754.29474231549;12075;20529.589408211752;20837.68743468849;20870.165193392095;20871;20899.79100209009;8223.301019413297;8402.369822263354;8501.19238672325;8529.701460448978;8654.524001179869;4652.464966528825;4693.694909830919;4719.4100737407825;4830.106430310404;4925.7783399747095;3303.50447432887;3409.2329225924464;3416.24842534642;3417.7778444401033;3424.931501369959;620.2556931682;653.9967300163564;659.970301336441;680.5270337115757;694.3750624438046;600.9038553831454;624.4598422364622;676.972921083161;747.4805010517747;758.6165700973609;9977;10248.948755256177;10287.742806429898;10459.529321180413;10473.738156546147;621.1893479009935;669.8928171492538;701.137600751079;712.2307907459931;762.3710438887829;4811.845157162255;5156.097682905476;5162.5095615916425;5167.4832516748775;5177.637565370388;77200.61399692965;77945;78424.6078769614;125618;125664;33489.330213395595;88505.55747221223;91084;92616;94553;73832;81410.5929470349;83759.5812020936;84846.575767122;86137;9925.702228932854;10041.447720375449;10160.74598135023;10208.030237127461;10309.278350515691;39625.801870991614;47128.764356178;47134.76432617815;48852.5114748848;49138.50861491339;65705;72254;72729.27270727437;72958.63520682363;73242.26757732568;11903.523859045888;12462.563810266598;12843;13197.868021319664;13938.721225575635;14382;14550.927245363706;14826.62933426673;14877.702445950805;14986.775198371815;13524.39140238672;14235.288235588387;14353.497627582985;14674.192919389108;14896;12511.874881251071;12965.805512917503;13300.933495332461;14007.859921401063;14475.92762036183;13944.79082813779;13983.300834958009;14059.578212653636;14307.21310327942;14640.70718585601;11457.369844658624;11555.804397164511;11992.340421276565;12054.276743395425;12410.131290809557;10757;11597.82603260935;11642.53429862796;12032;12049.638510844688 06:01:46 INFO - PROCESS | 3398 | __end_tp_report 06:01:46 INFO - PROCESS | 3398 | __start_cc_report 06:01:46 INFO - PROCESS | 3398 | _x_x_mozilla_cycle_collect,901 06:01:46 INFO - PROCESS | 3398 | __end_cc_report 06:01:46 INFO - PROCESS | 3398 | __startTimestamp1466773306487__endTimestamp 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | ------- Summary: start ------- 06:01:46 INFO - PROCESS | 3398 | Number of tests: 6 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | [#0] dojo.html Cycles:165 Average:5290.33 Median:5456.86 stddev:598.84 (11.0%) stddev-sans-first:575.30 06:01:46 INFO - PROCESS | 3398 | Values: 3091.6 3095.7 3116.7 3136.0 3161.2 5164.6 5226.6 5299.3 5414.2 5423.3 5315.3 5336.3 5338.1 5341.9 5376.7 4820.0 4860.4 4895.6 4908.7 5034.8 4912.7 4914.3 4981.6 4988.7 4994.8 4707.8 4756.5 4815.0 4829.9 4882.3 4745.8 4762.1 4775.0 4816.3 4866.2 4774.3 4786.0 4795.6 4810.3 4836.5 5194.3 5259.6 5309.9 5310.2 5398.4 5708.2 5722.7 5748.3 5754.0 5775.5 5470.7 5685.9 5762.1 5797.7 5811.9 5297.9 5382.8 5396.3 5403.5 5419.4 5882.6 5899.0 5905.4 5909.8 5911.0 5433.2 5550.2 5600.2 5687.6 5704.6 5671.3 5672.9 5733.3 5771.0 5772.3 5630.9 5649.3 5662.8 5665.6 5668.3 5417.5 5566.0 5636.9 5650.5 5673.2 4341.1 4341.5 4342.1 4345.4 4382.2 3864.4 3884.0 3896.1 3917.8 3918.6 5232.3 5273.0 5299.5 5301.1 5343.5 5667.6 5679.2 5688.7 5706.9 5725.3 5155.1 5343.6 5360.2 5372.2 5387.9 4849.7 4874.5 4898.5 4899.4 4905.8 5849.4 5858.3 5858.6 5860.0 5861.0 5536.3 5636.9 5655.9 5667.6 5722.6 5914.6 5947.5 5952.5 5976.2 5990.6 5649.7 5653.5 5661.4 5662.5 5664.7 5568.7 5638.9 5712.3 5737.9 5754.2 5513.1 5555.3 5599.8 5608.0 5651.0 5536.1 5574.2 5581.2 5594.9 5601.5 5305.3 5377.7 5416.9 5440.8 5484.3 5622.0 5646.0 5693.9 5698.7 5709.5 5456.6 5456.9 5487.9 5522.0 5537.9 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | [#1] ext.html Cycles:180 Average:54881.62 Median:41066.88 stddev:109163.22 (265.8%) stddev-sans-first:109393.33 06:01:46 INFO - PROCESS | 3398 | Values: 584.8 611.2 625.2 631.2 636.8 31799.2 34412.7 34450.7 41370.4 42286.0 42890.4 43218.8 43306.0 43347.6 43375.0 8834.2 9015.9 9019.6 9019.8 9028.3 8720.7 8773.6 8802.7 8820.3 8825.2 8825.0 8845.6 8850.1 8865.8 8866.2 8769.3 8815.5 8828.3 8828.8 8828.8 8829.8 8913.1 8920.6 8922.4 8925.8 41582.2 41709.8 41898.0 41910.6 41989.2 3557.9 3716.1 3720.6 3727.7 3766.1 31390.8 31662.0 31750.2 31885.8 32080.0 4434.3 4481.4 4497.8 4526.6 4567.7 227758.0 228201.0 228379.0 228501.0 228832.0 53747.0 54082.7 54097.0 54117.2 54157.2 35197.3 36332.6 36402.5 58230.7 58411.0 15366.5 15531.5 15636.1 15643.0 15664.3 11153.9 11315.9 11324.3 11340.1 11345.5 19380.4 19403.8 19435.3 19451.4 19471.7 7182.2 7194.1 7232.7 7516.2 7552.4 781.5 851.4 887.3 917.7 923.1 31525.0 31890.0 32201.0 32514.2 32971.5 1084.6 1112.0 1128.3 1137.8 1193.8 16891.2 16954.8 17089.7 17113.7 17149.7 550413.0 554993.0 555731.0 555746.0 556358.0 56902.7 57292.0 57770.0 57789.0 57956.7 1272.2 1289.8 1292.4 1373.5 1390.6 24838.6 32424.7 32442.5 32817.5 33101.7 49552.0 49917.8 50141.5 50219.7 50253.2 378965.0 379933.0 380528.0 381159.0 381492.0 27595.4 27719.3 28085.0 28184.9 28200.3 47319.0 47836.3 48466.5 49187.5 49365.3 39866.6 40069.6 40192.0 41070.4 41804.8 39385.4 39840.4 40140.2 40370.8 41063.4 32656.0 40606.6 43983.8 44357.6 44428.3 34112.7 35221.3 35652.6 35706.5 36163.5 27509.9 27728.3 27830.9 28230.2 28383.0 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | [#2] jquery.html Cycles:180 Average:27371.05 Median:12912.44 stddev:70718.53 (547.7%) stddev-sans-first:70887.92 06:01:46 INFO - PROCESS | 3398 | Values: 398.2 399.4 400.0 400.4 414.0 13325.2 18231.7 19895.5 19928.4 20509.5 14734.6 18307.9 19157.0 19327.6 19654.3 5476.5 5642.3 5667.8 5706.7 5718.7 5547.9 5632.4 5648.5 5650.0 5651.3 4113.8 5890.6 6213.8 6232.8 6368.6 6107.7 6328.2 6329.7 6333.7 6355.2 5576.1 5600.9 5621.0 5622.0 5625.2 22711.4 23082.9 23435.5 24156.4 24286.1 2389.3 2635.3 2659.8 2743.7 2898.3 14313.2 14352.6 14372.7 14798.9 15356.4 1951.2 1962.2 1964.8 2002.4 2021.1 77735.0 78276.2 80130.8 80185.0 80959.0 10471.2 10491.6 10809.4 10825.4 10938.2 14665.7 14733.9 14751.6 14753.7 14781.3 7797.3 8139.4 8217.7 8269.1 8296.2 7900.9 7924.9 7940.6 8033.2 8046.7 5864.3 6019.6 6334.9 6594.2 6597.5 1691.9 1730.3 1744.6 1789.9 1815.1 940.8 1044.4 1051.0 1051.7 1086.4 18788.3 19157.0 19802.6 19872.9 19952.9 1012.4 1024.3 1031.5 1038.3 1091.3 10868.8 11479.7 11552.9 11582.2 11600.7 370618.0 371617.0 376578.0 493024.0 494085.0 87474.6 94400.0 98379.5 103985.5 104627.5 1038.5 1060.1 1061.7 1066.7 1073.9 17331.0 17570.6 17612.9 17856.8 18121.0 40608.4 41495.4 41723.6 42725.8 43321.8 58435.0 60401.1 60483.4 61285.0 61505.7 7225.8 7578.6 7619.2 8506.2 8762.0 9248.3 13179.9 13229.3 13235.2 14221.7 11614.0 11742.6 11867.2 12013.5 12130.6 5627.5 9746.6 10885.9 11587.2 11872.9 12158.9 12223.1 12252.1 12514.8 12531.2 7630.7 7695.2 7736.2 7782.6 7807.5 10766.4 12094.3 12163.4 12367.6 12476.0 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | [#3] mootools.html Cycles:180 Average:5888.80 Median:4972.29 stddev:3359.77 (67.6%) stddev-sans-first:3351.68 06:01:46 INFO - PROCESS | 3398 | Values: 1324.3 1438.6 1487.7 1594.7 1746.5 8505.2 8770.5 8780.7 9024.6 9050.5 8754.8 8919.3 8921.9 8925.0 8943.2 2038.3 2274.4 2306.2 2329.7 2346.6 2394.5 2401.0 2406.4 2408.7 2408.7 2282.6 2311.0 2346.7 2350.1 2350.2 1974.5 2152.7 2221.3 2226.7 2264.0 2283.1 2298.5 2305.1 2313.5 2314.5 8942.6 8952.1 9023.2 9025.1 9029.8 5232.6 5401.3 5405.7 5409.5 5410.2 3353.9 3487.7 3517.1 3527.8 3530.8 1024.5 1028.0 1049.3 1051.1 1082.5 12431.5 12494.5 12504.2 12510.2 12511.9 4797.2 4804.3 4862.4 4872.4 4925.7 10600.5 10608.0 10617.3 10618.3 10623.8 5464.6 5466.5 5471.8 5472.2 5476.3 4198.2 4850.3 5018.9 5027.2 5031.0 4028.2 4050.3 4131.5 4149.8 4158.2 1239.2 1255.3 1258.1 1266.2 1293.0 951.3 969.3 970.2 974.8 989.0 5883.6 5955.8 6002.8 6033.0 6147.6 922.1 972.6 973.1 983.6 1001.2 4050.6 4065.1 4128.6 4157.4 4195.0 10901.9 11163.6 11226.4 11259.6 11271.0 10995.9 10999.5 11098.1 11119.4 11149.3 7901.4 8163.9 8193.9 8374.9 8385.7 5841.5 6026.9 6063.7 6078.0 6084.4 9944.2 10033.2 10201.5 10253.7 10268.7 9795.0 10203.6 10365.1 10374.3 10466.8 7022.5 7484.8 7693.0 8078.8 8260.4 8807.8 8819.3 8846.1 8896.1 8896.4 7590.2 7725.5 7735.3 7864.5 7868.0 7600.6 7670.6 7723.8 7843.8 7854.9 7139.3 7188.3 7225.3 7228.5 7229.7 5052.9 5255.4 5392.1 5419.4 5424.0 5053.2 5220.1 5352.3 5453.2 5465.5 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | [#4] prototype.html Cycles:180 Average:4611.64 Median:5223.50 stddev:1360.07 (26.0%) stddev-sans-first:1325.06 06:01:46 INFO - PROCESS | 3398 | Values: 312.7 317.0 323.3 326.3 326.5 5134.3 5254.4 5264.2 5336.6 5356.4 5256.7 5286.6 5315.1 5315.8 5319.5 4144.2 4176.1 4178.4 4179.4 4189.9 3894.5 3916.6 4158.3 4166.9 4170.9 4060.7 4115.4 4123.0 4125.7 4127.8 4085.7 4106.6 4107.8 4119.9 4126.4 3427.8 3644.3 3649.3 3658.9 3669.0 5133.9 5162.5 5183.5 5184.7 5192.6 4653.3 4673.8 4681.3 4695.5 4698.2 5399.8 5471.8 5508.5 5511.5 5515.7 3969.0 3983.9 3985.8 3987.1 3987.2 5711.4 5721.5 5749.1 5752.8 5767.7 3870.2 3961.5 3964.7 4021.4 4026.3 4002.2 4023.4 4023.7 4031.1 4045.1 4586.6 4598.3 4598.5 4616.0 4621.2 5485.2 5519.9 5528.0 5543.8 5552.4 1381.8 1403.7 1437.6 1446.8 1449.1 910.6 914.9 916.9 926.6 957.1 4722.3 4744.9 4822.9 4833.2 4837.2 4985.5 5036.4 5072.9 5083.0 5086.5 4704.3 4801.6 4814.4 4831.3 5043.6 2995.4 3028.0 3034.9 3051.2 3056.9 5899.6 5912.9 5917.3 5920.7 5929.2 5567.9 5786.0 5801.5 5818.1 5842.6 5753.7 5783.5 5817.6 5832.4 5885.4 5349.4 5608.3 5617.8 5634.5 5660.1 5584.2 5611.0 5633.6 5652.9 5663.7 5854.2 5864.5 5871.3 5894.2 5905.1 3666.8 3795.2 3983.1 4013.9 4049.5 5595.5 5626.9 5633.9 5677.6 5687.4 5519.2 5520.3 5525.9 5527.0 5543.8 5328.4 5530.6 5641.3 5648.3 5651.5 5506.7 5511.9 5529.4 5534.0 5549.9 5389.8 5602.8 5608.8 5625.3 5637.6 5483.8 5506.9 5508.6 5518.7 5540.3 06:01:46 INFO - PROCESS | 3398 | 06:01:46 INFO - PROCESS | 3398 | [#5] yui.html Cycles:180 Average:19413.52 Median:4425.39 stddev:26756.62 (604.6%) stddev-sans-first:26794.62 06:01:46 INFO - PROCESS | 3398 | Values: 658.0 665.6 737.8 790.0 808.6 15224.5 16231.0 16254.5 16295.5 16374.3 14418.8 14771.8 14924.8 15129.8 15160.8 675.1 803.0 819.8 821.1 827.8 788.7 813.3 818.3 819.0 820.1 850.9 856.6 858.0 858.2 858.7 707.7 727.7 851.8 851.8 851.9 539.6 606.4 606.8 614.0 616.9 14573.3 14579.2 14591.3 14619.5 14652.6 13608.7 14441.8 14549.9 14694.6 14807.6 12352.2 12568.6 12622.9 12694.7 13210.1 4394.8 4395.1 4404.1 4425.1 4425.6 67076.7 69129.7 69245.7 71604.6 77582.0 10791.2 11032.1 11701.4 11754.3 12075.0 20529.6 20837.7 20870.2 20871.0 20899.8 8223.3 8402.4 8501.2 8529.7 8654.5 4652.5 4693.7 4719.4 4830.1 4925.8 3303.5 3409.2 3416.2 3417.8 3424.9 620.3 654.0 660.0 680.5 694.4 600.9 624.5 677.0 747.5 758.6 9977.0 10248.9 10287.7 10459.5 10473.7 621.2 669.9 701.1 712.2 762.4 4811.8 5156.1 5162.5 5167.5 5177.6 77200.6 77945.0 78424.6 125618.0 125664.0 33489.3 88505.6 91084.0 92616.0 94553.0 73832.0 81410.6 83759.6 84846.6 86137.0 9925.7 10041.4 10160.7 10208.0 10309.3 39625.8 47128.8 47134.8 48852.5 49138.5 65705.0 72254.0 72729.3 72958.6 73242.3 11903.5 12462.6 12843.0 13197.9 13938.7 14382.0 14550.9 14826.6 14877.7 14986.8 13524.4 14235.3 14353.5 14674.2 14896.0 12511.9 12965.8 13300.9 14007.9 14475.9 13944.8 13983.3 14059.6 14307.2 14640.7 11457.4 11555.8 11992.3 12054.3 12410.1 10757.0 11597.8 11642.5 12032.0 12049.6 06:01:46 INFO - PROCESS | 3398 | -------- Summary: end -------- 06:01:46 INFO - PROCESS | 3398 | 06:01:47 INFO - TEST-INFO | 3398: exit 0 06:01:47 INFO - TEST-OK | dromaeo_css | took 1115821ms 06:01:47 INFO - TEST-START | kraken 06:01:47 INFO - operating with platform_type : linux_ 06:01:47 INFO - Initialising browser for kraken test... 06:01:47 INFO - TEST-INFO | started process 3582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcbD1ns/profile http://localhost:34008/getInfo.html) 06:01:51 INFO - PROCESS | 3582 | __metrics Screen width/height:1600/1200 06:01:51 INFO - PROCESS | 3582 | colorDepth:24 06:01:51 INFO - PROCESS | 3582 | Browser inner width/height: 1024/697 06:01:51 INFO - PROCESS | 3582 | __metrics 06:01:52 INFO - PROCESS | 3582 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:53 INFO - TEST-INFO | 3582: exit 0 06:01:53 INFO - Browser initialized. 06:01:53 INFO - Running cycle 1/1 for kraken test... 06:01:53 INFO - TEST-INFO | started process 3667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcbD1ns/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:05 INFO - PROCESS | 3667 | RSS: Main: 173948928 06:02:05 INFO - PROCESS | 3667 | 06:02:07 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:08 INFO - PROCESS | 3667 | RSS: Main: 231870464 06:02:08 INFO - PROCESS | 3667 | 06:02:11 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-dft) 06:02:12 INFO - PROCESS | 3667 | RSS: Main: 220528640 06:02:12 INFO - PROCESS | 3667 | 06:02:15 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-fft) 06:02:15 INFO - PROCESS | 3667 | RSS: Main: 286552064 06:02:15 INFO - PROCESS | 3667 | 06:02:17 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-oscillator) 06:02:18 INFO - PROCESS | 3667 | RSS: Main: 197210112 06:02:18 INFO - PROCESS | 3667 | 06:02:20 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:02:21 INFO - PROCESS | 3667 | RSS: Main: 201830400 06:02:21 INFO - PROCESS | 3667 | 06:02:24 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34008/tests/kraken/driver.html?testName=imaging-darkroom) 06:02:24 INFO - PROCESS | 3667 | RSS: Main: 237457408 06:02:24 INFO - PROCESS | 3667 | 06:02:28 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34008/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:28 INFO - PROCESS | 3667 | RSS: Main: 237842432 06:02:28 INFO - PROCESS | 3667 | 06:02:31 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34008/tests/kraken/driver.html?testName=json-parse-financial) 06:02:32 INFO - PROCESS | 3667 | RSS: Main: 237805568 06:02:32 INFO - PROCESS | 3667 | 06:02:33 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:34 INFO - PROCESS | 3667 | RSS: Main: 226238464 06:02:34 INFO - PROCESS | 3667 | 06:02:36 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:36 INFO - PROCESS | 3667 | RSS: Main: 231116800 06:02:36 INFO - PROCESS | 3667 | 06:02:39 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:39 INFO - PROCESS | 3667 | RSS: Main: 237211648 06:02:39 INFO - PROCESS | 3667 | 06:02:42 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:42 INFO - PROCESS | 3667 | RSS: Main: 241754112 06:02:42 INFO - PROCESS | 3667 | 06:02:45 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:46 INFO - PROCESS | 3667 | RSS: Main: 240373760 06:02:46 INFO - PROCESS | 3667 | 06:02:47 INFO - PROCESS | 3667 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34008/tests/kraken/driver.html?testName=ai-astar) 06:02:48 INFO - PROCESS | 3667 | RSS: Main: 283070464 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | __start_tp_report 06:02:48 INFO - PROCESS | 3667 | _x_x_mozilla_page_load 06:02:48 INFO - PROCESS | 3667 | _x_x_mozilla_page_load_details 06:02:48 INFO - PROCESS | 3667 | |i|pagename|runs| 06:02:48 INFO - PROCESS | 3667 | |0;ai-astar;104;112;112;113;112;112;110;109;111;110 06:02:48 INFO - PROCESS | 3667 | |1;audio-beat-detection;150;125;126;178;127;126;162;125;170;132 06:02:48 INFO - PROCESS | 3667 | |2;audio-dft;160;160;162;162;168;161;162;160;161;161 06:02:48 INFO - PROCESS | 3667 | |3;audio-fft;74;75;76;121;76;75;84;75;96;75 06:02:48 INFO - PROCESS | 3667 | |4;audio-oscillator;86;84;119;86;85;86;122;87;86;125 06:02:48 INFO - PROCESS | 3667 | |5;imaging-gaussian-blur;116;116;117;117;117;116;117;117;117;117 06:02:48 INFO - PROCESS | 3667 | |6;imaging-darkroom;146;146;145;146;145;145;145;146;145;145 06:02:48 INFO - PROCESS | 3667 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;98;98 06:02:48 INFO - PROCESS | 3667 | |8;json-parse-financial;53;53;53;53;53;54;54;54;53;53 06:02:48 INFO - PROCESS | 3667 | |9;json-stringify-tinderbox;62;62;62;62;62;63;63;62;62;61 06:02:48 INFO - PROCESS | 3667 | |10;stanford-crypto-aes;80;84;80;81;85;81;80;81;91;80 06:02:48 INFO - PROCESS | 3667 | |11;stanford-crypto-ccm;135;120;123;129;128;130;117;121;145;129 06:02:48 INFO - PROCESS | 3667 | |12;stanford-crypto-pbkdf2;164;163;167;169;160;165;163;163;165;168 06:02:48 INFO - PROCESS | 3667 | |13;stanford-crypto-sha256-iterative;63;64;63;65;62;64;65;62;62;61 06:02:48 INFO - PROCESS | 3667 | __end_tp_report 06:02:48 INFO - PROCESS | 3667 | __start_cc_report 06:02:48 INFO - PROCESS | 3667 | _x_x_mozilla_cycle_collect,1597 06:02:48 INFO - PROCESS | 3667 | __end_cc_report 06:02:48 INFO - PROCESS | 3667 | __startTimestamp1466773368182__endTimestamp 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | ------- Summary: start ------- 06:02:48 INFO - PROCESS | 3667 | Number of tests: 14 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:2.59 (2.3%) stddev-sans-first:1.30 06:02:48 INFO - PROCESS | 3667 | Values: 104.0 112.0 112.0 113.0 112.0 112.0 110.0 109.0 111.0 110.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:141.00 stddev:20.97 (14.9%) stddev-sans-first:22.05 06:02:48 INFO - PROCESS | 3667 | Values: 150.0 125.0 126.0 178.0 127.0 126.0 162.0 125.0 170.0 132.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:2.36 (1.5%) stddev-sans-first:2.42 06:02:48 INFO - PROCESS | 3667 | Values: 160.0 160.0 162.0 162.0 168.0 161.0 162.0 160.0 161.0 161.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:15.09 (20.0%) stddev-sans-first:15.67 06:02:48 INFO - PROCESS | 3667 | Values: 74.0 75.0 76.0 121.0 76.0 75.0 84.0 75.0 96.0 75.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:86.00 stddev:17.60 (20.5%) stddev-sans-first:18.25 06:02:48 INFO - PROCESS | 3667 | Values: 86.0 84.0 119.0 86.0 85.0 86.0 122.0 87.0 86.0 125.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:02:48 INFO - PROCESS | 3667 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:02:48 INFO - PROCESS | 3667 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 06:02:48 INFO - PROCESS | 3667 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 98.0 98.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 06:02:48 INFO - PROCESS | 3667 | Values: 53.0 53.0 53.0 53.0 53.0 54.0 54.0 54.0 53.0 53.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:02:48 INFO - PROCESS | 3667 | Values: 62.0 62.0 62.0 62.0 62.0 63.0 63.0 62.0 62.0 61.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:3.53 (4.4%) stddev-sans-first:3.64 06:02:48 INFO - PROCESS | 3667 | Values: 80.0 84.0 80.0 81.0 85.0 81.0 80.0 81.0 91.0 80.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:129.00 stddev:8.18 (6.3%) stddev-sans-first:8.24 06:02:48 INFO - PROCESS | 3667 | Values: 135.0 120.0 123.0 129.0 128.0 130.0 117.0 121.0 145.0 129.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:2.71 (1.6%) stddev-sans-first:2.86 06:02:48 INFO - PROCESS | 3667 | Values: 164.0 163.0 167.0 169.0 160.0 165.0 163.0 163.0 165.0 168.0 06:02:48 INFO - PROCESS | 3667 | 06:02:48 INFO - PROCESS | 3667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.37 (2.2%) stddev-sans-first:1.45 06:02:48 INFO - PROCESS | 3667 | Values: 63.0 64.0 63.0 65.0 62.0 64.0 65.0 62.0 62.0 61.0 06:02:48 INFO - PROCESS | 3667 | -------- Summary: end -------- 06:02:48 INFO - PROCESS | 3667 | 06:02:49 INFO - TEST-INFO | 3667: exit 0 06:02:49 INFO - TEST-OK | kraken | took 61987ms 06:02:49 INFO - SUITE-END | took 1177s 06:02:49 INFO - Completed test suite (00:19:37) 06:02:49 INFO - javascript benchmark 06:02:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.644460886998, 3095.6904309569045, 3116.6883311668835, 3135.9843200783994, 3161.162291992621, 5164.561012313949, 5226.634135610509, 5299.28459657946, 5414.2420061191415, 5423.294971653684, 5315.255864179018, 5336.30628018358, 5338.092524270874, 5341.946580534193, 5376.650517716345, 4819.975900120503, 4860.392450943632, 4895.632827537931, 4908.7300198489065, 5034.798608055673, 4912.705237685733, 4914.262860570907, 4981.576565991895, 4988.675736077162, 4994.77523511441, 4707.788149533262, 4756.476787553366, 4814.9759251203695, 4829.903401931977, 4882.267659851015, 4745.810167593292, 4762.071396077767, 4775.0, 4816.301636262722, 4866.245731911559, 4774.331593576902, 4786.042791441726, 4795.568398844121, 4810.302506136591, 4836.516348365135, 5194.3247377840635, 5259.605529585297, 5309.8938021239355, 5310.230016647564, 5398.379186393576, 5708.20085188074, 5722.656640601535, 5748.281464816898, 5753.971230143822, 5775.451332123442, 5470.699111548864, 5685.857853553653, 5762.135679648044, 5797.739101740432, 5811.941880581182, 5297.894042119136, 5382.757775900094, 5396.298481197458, 5403.5136837684795, 5419.403865574784, 5882.617629854046, 5898.970505147447, 5905.379935106838, 5909.763609455659, 5910.970445147833, 5433.185022246695, 5550.195221692913, 5600.243967064475, 5687.573431992617, 5704.600677952503, 5671.262735844314, 5672.914906276409, 5733.3406658234, 5771.0, 5772.278465191851, 5630.887382252332, 5649.293838270216, 5662.839117980887, 5665.575081868877, 5668.319801623749, 5417.5395091416885, 5566.0, 5636.943630563724, 5650.491455768918, 5673.234113394639, 4341.131773645284, 4341.522432532419, 4342.109867477159, 4345.435093437896, 4382.167388196232, 3864.401017842239, 3883.980580097081, 3896.103896103912, 3917.7845218513257, 3918.6081391860585, 5232.2674825524455, 5273.024490469275, 5299.5230429261555, 5301.072312345401, 5343.492368225013, 5667.574931880125, 5679.176519404746, 5688.658680479184, 5706.885862282731, 5725.341585717612, 5155.097857874857, 5343.625946183807, 5360.195970604441, 5372.247885296062, 5387.865303367369, 4849.709017458964, 4874.53691899269, 4898.461169271377, 4899.363082799285, 4905.8037678492465, 5849.415058494202, 5858.297004359419, 5858.648481091063, 5860.0, 5860.970695146497, 5536.252605898313, 5636.915446268227, 5655.943440565542, 5667.574931880208, 5722.570807189394, 5914.58597898143, 5947.464728174485, 5952.494038006818, 5976.163337132718, 5990.610610310316, 5649.745761440663, 5653.491185793134, 5661.377248502744, 5662.5469962402085, 5664.660120392789, 5568.693721845338, 5638.9436105638415, 5712.314522257356, 5737.942620573741, 5754.165645981393, 5513.062779327604, 5555.3333599966645, 5599.80400685974, 5608.0, 5651.039323314964, 5536.141898005815, 5574.219609254626, 5581.190727344593, 5594.944050559442, 5601.495865372136, 5305.283786688748, 5377.704226267437, 5416.8645783854145, 5440.755166017618, 5484.287042684426, 5622.0, 5645.971770141287, 5693.914591281217, 5698.715064246854, 5709.486146246858, 5456.61803673739, 5456.863578410572, 5487.945120548743, 5522.0, 5537.916931246115], "value": 5250.378051716362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.771938943812, 611.2481647573485, 625.1716475669739, 631.2046821005534, 636.8153235561688, 31799.205019874516, 34412.65587344129, 34450.65549344506, 41370.37944430836, 42286.0, 42890.356644650354, 43218.783906080425, 43306.0, 43347.56652433483, 43375.0, 8834.249088827457, 9015.864762028576, 9019.594118264693, 9019.819603607957, 9028.32287578431, 8720.651173953034, 8773.56132193391, 8802.735917922473, 8820.338474614398, 8825.205731484197, 8824.955875220616, 8845.601947912359, 8850.114988501162, 8865.778355541132, 8866.202041816236, 8769.298456123526, 8815.515146666994, 8828.293736501097, 8828.779280517974, 8828.779280517974, 8829.779255518599, 8913.1086891311, 8920.643174273022, 8922.375433719642, 8925.776855578597, 41582.168356633, 41709.79145104285, 41898.0, 41910.58089419097, 41989.16021679549, 3557.875474358385, 3716.1081340478363, 3720.553533575961, 3727.6645101940953, 3766.0773110587807, 31390.84304578485, 31662.0, 31750.206244843834, 31885.840570796998, 32080.0, 4434.2905135178535, 4481.402873943125, 4497.797599108016, 4526.592606665383, 4567.680262381635, 227758.0, 228201.0, 228379.0, 228501.0, 228832.0, 53747.0, 54082.7295863526, 54097.0, 54117.1882421764, 54157.187642185396, 35197.296054079285, 36332.63667363345, 36402.45396319004, 58230.7088464555, 58411.0, 15366.539003829903, 15531.456399026205, 15636.140012299433, 15643.0, 15664.295106720225, 11153.888461115448, 11315.94342028301, 11324.263922844988, 11340.092792576574, 11345.489452974636, 19380.4185874424, 19403.80596194048, 19435.3197638082, 19451.416457506297, 19471.707924381146, 7182.2458641842895, 7194.100737407824, 7232.74685386009, 7516.1585411574515, 7552.358049565739, 781.4881252779438, 851.3742399336483, 887.3078998381272, 917.6788124156625, 923.1230331185401, 31525.0, 31890.0, 32201.0, 32514.187145321557, 32971.50542741861, 1084.614961688605, 1111.972200694973, 1128.311729844794, 1137.7781332640056, 1193.8268951002055, 16891.23989420479, 16954.830451695325, 17089.658206835793, 17113.657726845395, 17149.684792553096, 550413.0, 554993.0, 555731.0, 555746.0, 556358.0, 56902.715486422305, 57292.0, 57770.0, 57789.0, 57956.71021644865, 1272.204871955028, 1289.8323217981601, 1292.4377895615437, 1373.5329987804193, 1390.610629023875, 24838.627420588346, 32424.675753242165, 32442.513362300055, 32817.50773738443, 33101.66898330986, 49552.0, 49917.75041124771, 50141.49858501368, 50219.74890125526, 50253.246201306276, 378965.0, 379933.0, 380528.0, 381159.0, 381492.0, 27595.44809103847, 27719.30701732473, 28085.0, 28184.85907570449, 28200.29499262535, 47319.0, 47836.28245576389, 48466.5153348462, 49187.50812491829, 49365.25952110793, 39866.60133398629, 40069.59930400659, 40191.99040048044, 41070.38394424026, 41804.790976044926, 39385.40921886117, 39840.402393964694, 40140.1971960565, 40370.79814600908, 41063.38404923988, 32656.0, 40606.59393406028, 43983.78008109939, 44357.556424435345, 44428.33357499705, 34112.65887341095, 35221.29557408889, 35652.64347356597, 35706.46440303345, 36163.457548137325, 27509.86245068762, 27728.306792330353, 27830.860845695643, 28230.15309540717, 28383.0], "value": 19333.500865448856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.20359281437146, 399.41286309125576, 399.9540052893917, 400.39340399295054, 413.9544650088492, 13325.163631527448, 18231.726524102134, 19895.502612434677, 19928.40214793555, 20509.46179036571, 14734.56879614865, 18307.90846045768, 19157.0, 19327.613447731037, 19654.312099076535, 5476.479734425223, 5642.322921249456, 5667.801626943058, 5706.686132262724, 5718.7426565804635, 5547.889042219153, 5632.436756324376, 5648.548116150698, 5649.971750141243, 5651.2935883014625, 4113.753174809506, 5890.64656120632, 6213.782517611885, 6232.781852635158, 6368.649724265187, 6107.6946152692635, 6328.208973878265, 6329.715162817707, 6333.714982825761, 6355.173827402431, 5576.1356989666665, 5600.887982240373, 5621.0, 5622.0161471742285, 5625.1843482695185, 22711.43221419461, 23082.884585577132, 23435.53128937429, 24156.39609009771, 24286.149984750624, 2389.3429306940557, 2635.341164708823, 2659.8271112377633, 2743.7256274372603, 2898.2754311422145, 14313.212773297464, 14352.633124754198, 14372.712545749131, 14798.926005370013, 15356.385744570203, 1951.2292644405522, 1962.1562728026943, 1964.7838737738837, 2002.4393169912448, 2021.0602070037355, 77735.0, 78276.21723782804, 80130.79803803006, 80185.0, 80959.0, 10471.16230701542, 10491.580336786443, 10809.35143891369, 10825.350478971286, 10938.234323597271, 14665.706685866224, 14733.852661473247, 14751.557453276419, 14753.704925901422, 14781.33483993223, 7797.298243158143, 8139.38954578409, 8217.712380066669, 8269.09040005599, 8296.170382961776, 7900.920990790133, 7924.920750792534, 7940.61039318117, 8033.236842499953, 8046.718364857319, 5864.32560255576, 6019.638821670714, 6334.904976425358, 6594.241662208811, 6597.538172327891, 1691.8731095167911, 1730.3251731824598, 1744.6423483185915, 1789.8836575622804, 1815.0561707912075, 940.83535381308, 1044.4360045575456, 1051.0435503691604, 1051.7423231308226, 1086.3970496374588, 18788.342408015928, 19157.0, 19802.60394792096, 19872.90063549702, 19952.90023549902, 1012.367270455965, 1024.2881197567767, 1031.5254982707888, 1038.2835843268122, 1091.3288327678579, 10868.836967445495, 11479.71300717472, 11552.94223528877, 11582.189246752814, 11600.6519804406, 370618.0, 371617.0, 376578.0, 493024.0, 494085.0, 87474.56262718646, 94400.0, 98379.50810246046, 103985.48007259915, 104627.47686261672, 1038.5170895533463, 1060.125396547851, 1061.7345663584103, 1066.7439814444479, 1073.9033486986052, 17331.0, 17570.560735981704, 17612.91193544024, 17856.821431786037, 18121.003344815636, 40608.390874137505, 41495.377569335884, 41723.582764171966, 42725.786371067945, 43321.78339108284, 58435.0, 60401.09398359116, 60483.395166047776, 61285.0, 61505.69247153735, 7225.819354515969, 7578.621068946641, 7619.238076192337, 8506.234438900528, 8761.956190219009, 9248.306377021885, 13179.934100329438, 13229.272390018641, 13235.205887646773, 14221.715565688835, 11614.0, 11742.589009384972, 11867.169298149392, 12013.45939432745, 12130.636080917586, 5627.493525582553, 9746.561404736945, 10885.945570272099, 11587.246828956091, 11872.940635296769, 12158.939205303917, 12223.144379893321, 12252.081093917814, 12514.812277816021, 12531.248125112523, 7630.694772209049, 7695.192004839411, 7736.1877002916135, 7782.571958542108, 7807.492512986638, 10766.407847568458, 12094.334811585448, 12163.391830408622, 12367.62897113088, 12476.0], "value": 9354.752607032053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.2915040453358, 1438.5540482450438, 1487.680148768015, 1594.697007568562, 1746.5197070805534, 8505.234528892399, 8770.517621530822, 8780.69267575635, 9024.593893274801, 9050.502222377767, 8754.824903501925, 8919.286457083434, 8921.910780892189, 8925.018247992715, 8943.195112439878, 2038.286599690104, 2274.37454699958, 2306.2043594959714, 2329.6621989811465, 2346.554154710608, 2394.5091256292417, 2400.9759902401015, 2406.3743426709093, 2408.662787209792, 2408.6868707068056, 2282.6233671444193, 2310.9884450577806, 2346.741858395575, 2350.0717216699395, 2350.247920665388, 1974.5162435203324, 2152.698622192894, 2221.3224966385246, 2226.6882636430914, 2264.0, 2283.086765293879, 2298.482841360697, 2305.101010605865, 2313.5257272259146, 2314.5370925814905, 8942.64229430822, 8952.060033696433, 9023.187913087853, 9025.142611451902, 9029.819403611891, 5232.633715639907, 5401.3248343957, 5405.675659460406, 5409.513143817036, 5410.242566040718, 3353.8658453661824, 3487.6861082502696, 3517.1383011162175, 3527.805970671612, 3530.8058056806867, 1024.4621573673805, 1028.0131074168808, 1049.3494033699078, 1051.1433181956681, 1082.4966390628317, 12431.502739890393, 12494.500219991189, 12504.187227830162, 12510.18683785551, 12511.937440312831, 4797.208460603962, 4804.303376010529, 4862.3922009748785, 4872.439669437989, 4925.655204135748, 10600.522976466078, 10608.0, 10617.256792024484, 10618.256722029384, 10623.787524249627, 5464.562834973192, 5466.453354664582, 5471.835844924579, 5472.2338872557875, 5476.315460567429, 4198.244316023145, 4850.345203397566, 5018.924716129261, 5027.245913113063, 5031.0441016206805, 4028.194361127786, 4050.3321272343846, 4131.462909821704, 4149.792510374469, 4158.189153115113, 1239.231676360662, 1255.3158528601934, 1258.1130303136267, 1266.214946733013, 1293.0, 951.2627713521938, 969.3166317745972, 970.1995853420956, 974.8342781727123, 988.9505524723735, 5883.558733095035, 5955.7617695292565, 6002.849928751816, 6032.969835150796, 6147.569670123048, 922.1239822168832, 972.5976837212074, 973.1241882305982, 983.5721461164417, 1001.2040427859869, 4050.6151915567975, 4065.065035041957, 4128.60778226068, 4157.397177409319, 4194.958050419517, 10901.890981090246, 11163.609273675545, 11226.438678066064, 11259.605913792979, 11271.0, 10995.945020274847, 10999.450027498593, 11098.05666518355, 11119.44402779874, 11149.331040137618, 7901.367890568741, 8163.918360816316, 8193.877091843508, 8374.916250837658, 8385.706500272583, 5841.50347220491, 6026.909596356146, 6063.72713227897, 6077.969610151921, 6084.39156084388, 9944.204463643036, 10033.1973442123, 10201.54093065799, 10253.74365640865, 10268.743281418025, 9794.951025244829, 10203.591856325664, 10365.06714395708, 10374.325668831803, 10466.842997354894, 7022.508424410242, 7484.775456736306, 7693.0, 8078.798030049061, 8260.421770476009, 8807.823843522965, 8819.29445644334, 8846.071162527842, 8896.110388961051, 8896.421732587361, 7590.1650818411035, 7725.49784264021, 7735.303822655988, 7864.4888082274465, 7867.9606601966625, 7600.581967991813, 7670.616469176631, 7723.806904827425, 7843.764687059397, 7854.882176767467, 7139.286071392819, 7188.28117188277, 7225.277472252733, 7228.530145540523, 7229.710811567478, 5052.924206136838, 5255.395629502504, 5392.137258038695, 5419.376771671151, 5424.0, 5053.2420136979745, 5220.112580861187, 5352.330958630171, 5453.209284653783, 5465.480779325958], "value": 4688.527151016063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.70918046217025, 316.9651338352781, 323.31134683124935, 326.26915708812254, 326.49067454770574, 5134.2812006319145, 5254.448282930285, 5264.184051472023, 5336.626436149471, 5356.437574054722, 5256.684598924057, 5286.629935904488, 5315.096433606286, 5315.760790764415, 5319.5478384337375, 4144.212599606065, 4176.1230141670285, 4178.415021896937, 4179.414881916534, 4189.874303770892, 3894.49371581694, 3916.5887581803786, 4158.293090174678, 4166.937495937548, 4170.8540201092965, 4060.7157498975084, 4115.444415003966, 4122.979385103085, 4125.66994640428, 4127.772972486527, 4085.7140000199997, 4106.589341065899, 4107.774072426016, 4119.876403707894, 4126.401671757609, 3427.8174029959623, 3644.2893635741043, 3649.3066317399876, 3658.8902332930056, 3668.9816550917076, 5133.870548479366, 5162.535371816517, 5183.481651834824, 5184.662996905189, 5192.55863251624, 4653.255479123324, 4673.813047478131, 4681.297805329194, 4695.506971767949, 4698.177818881716, 5399.811006614789, 5471.808486702986, 5508.531774799147, 5511.53151982082, 5515.7242137893345, 3969.0, 3983.880483585497, 3985.8405663773415, 3987.0829709167056, 3987.182627561343, 5711.428857114297, 5721.513671337942, 5749.13762935563, 5752.769889204426, 5767.692922830859, 3870.1872606752336, 3961.4652021976663, 3964.682825373963, 4021.3565829467143, 4026.335654617014, 4002.2195671844293, 4023.376376661622, 4023.657989070962, 4031.09300407406, 4045.130296986162, 4586.610138138229, 4598.333241679938, 4598.471175814824, 4616.0, 4621.214393553104, 5485.177223416519, 5519.944800551943, 5528.0, 5543.7782488700805, 5552.444755524496, 1381.84799672036, 1403.677154254527, 1437.6334034821055, 1446.7540518111946, 1449.1015570346453, 910.6402970826487, 914.8993610702818, 916.935814492979, 926.6339795780764, 957.1337939165066, 4722.315264286728, 4744.881377965509, 4822.879428014257, 4833.154198015333, 4837.177679794373, 4985.45450910219, 5036.370453693288, 5072.858606813437, 5083.0, 5086.516780905808, 4704.270838020112, 4801.567858892717, 4814.446338671028, 4831.347768051339, 5043.5712964398435, 2995.3559984603417, 3027.9697203028127, 3034.924126896801, 3051.2219384056925, 3056.9082927511768, 5899.5546091207925, 5912.9113063304085, 5917.31950825652, 5920.727043685542, 5929.169916211734, 5567.860803479945, 5785.971070144707, 5801.477866991991, 5818.08003358899, 5842.56857070012, 5753.683547404849, 5783.450572195718, 5817.563682723812, 5832.387599302097, 5885.352611212763, 5349.411564727799, 5608.317504748477, 5617.831465056055, 5634.492895639412, 5660.094384898396, 5584.218209450599, 5611.0, 5633.577481688808, 5652.915206271991, 5663.688497132697, 5854.214464588342, 5864.501517371071, 5871.324797648325, 5894.233749612523, 5905.114232865105, 3666.7616604920595, 3795.1650636859845, 3983.143624120828, 4013.8996525087105, 4049.4735684360844, 5595.496405323541, 5626.915596266142, 5633.887322253614, 5677.552224182972, 5687.374388817309, 5519.199716041232, 5520.282363292747, 5525.917111243415, 5526.972365138148, 5543.778248870161, 5328.440513746156, 5530.6128570999645, 5641.294838145232, 5648.322201335866, 5651.547876169979, 5506.697131657637, 5511.862203444946, 5529.419410961952, 5533.972330138324, 5549.889002220014, 5389.757460914347, 5602.803901863415, 5608.822147349102, 5625.268715067015, 5637.633553818989, 5483.835484935458, 5506.944930550803, 5508.586855985737, 5518.696471694096, 5540.279763630702], "value": 4177.4832975634135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.9605223686576, 665.5840099937536, 737.8266107464748, 790.032210542086, 808.6078252047756, 15224.543263702079, 16231.026138431687, 16254.51236462908, 16295.51113466598, 16374.345026198953, 14418.783718244209, 14771.778423323633, 14924.776128358084, 15129.848701512981, 15160.772588411182, 675.0953722012503, 803.0082847683107, 819.8401311744212, 821.0639870547551, 827.7682248970268, 788.7397158937537, 813.3127507256359, 818.3453237410077, 819.0294501016285, 820.0774129104757, 850.8596081646521, 856.5931182688236, 857.9914200858005, 858.1547176031604, 858.682287553606, 707.6744697439184, 727.7125535413535, 851.7913111287743, 851.8466675998318, 851.8722191671268, 539.5575627985054, 606.3996643323078, 606.8058221369164, 614.0328981853598, 616.9105479705462, 14573.271336433136, 14579.19814410207, 14591.270436478133, 14619.488317908928, 14652.633684157981, 13608.727825443435, 14441.78337324941, 14549.854501454956, 14694.632634184123, 14807.629809254748, 12352.197107188003, 12568.622941311774, 12622.936885315607, 12694.746105077847, 13210.141340812816, 4394.8242070317465, 4395.142947125312, 4404.119176164748, 4425.137098265807, 4425.645948324126, 67076.6646166766, 69129.65435172842, 69245.65377173082, 71604.6419767903, 77581.99999999943, 10791.190660700478, 11032.06227470674, 11701.414929253504, 11754.29474231549, 12075.0, 20529.589408211752, 20837.68743468849, 20870.165193392095, 20871.0, 20899.79100209009, 8223.301019413297, 8402.369822263354, 8501.19238672325, 8529.701460448978, 8654.524001179869, 4652.464966528825, 4693.694909830919, 4719.4100737407825, 4830.106430310404, 4925.7783399747095, 3303.50447432887, 3409.2329225924464, 3416.24842534642, 3417.7778444401033, 3424.931501369959, 620.2556931682, 653.9967300163564, 659.970301336441, 680.5270337115757, 694.3750624438046, 600.9038553831454, 624.4598422364622, 676.972921083161, 747.4805010517747, 758.6165700973609, 9977.0, 10248.948755256177, 10287.742806429898, 10459.529321180413, 10473.738156546147, 621.1893479009935, 669.8928171492538, 701.137600751079, 712.2307907459931, 762.3710438887829, 4811.845157162255, 5156.097682905476, 5162.5095615916425, 5167.4832516748775, 5177.637565370388, 77200.61399692965, 77945.0, 78424.6078769614, 125618.0, 125664.0, 33489.330213395595, 88505.55747221223, 91084.0, 92616.0, 94553.0, 73832.0, 81410.5929470349, 83759.5812020936, 84846.575767122, 86137.0, 9925.702228932854, 10041.447720375449, 10160.74598135023, 10208.030237127461, 10309.278350515691, 39625.801870991614, 47128.764356178, 47134.76432617815, 48852.5114748848, 49138.50861491339, 65705.0, 72254.0, 72729.27270727437, 72958.63520682363, 73242.26757732568, 11903.523859045888, 12462.563810266598, 12843.0, 13197.868021319664, 13938.721225575635, 14382.0, 14550.927245363706, 14826.62933426673, 14877.702445950805, 14986.775198371815, 13524.39140238672, 14235.288235588387, 14353.497627582985, 14674.192919389108, 14896.0, 12511.874881251071, 12965.805512917503, 13300.933495332461, 14007.859921401063, 14475.92762036183, 13944.79082813779, 13983.300834958009, 14059.578212653636, 14307.21310327942, 14640.70718585601, 11457.369844658624, 11555.804397164511, 11992.340421276565, 12054.276743395425, 12410.131290809557, 10757.0, 11597.82603260935, 11642.53429862796, 12032.0, 12049.638510844688], "value": 7499.008447583941, "unit": "score"}], "name": "dromaeo_css", "value": 7201.485778666027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 113.0, 112.0, 112.0, 110.0, 109.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 126.0, 178.0, 127.0, 126.0, 162.0, 125.0, 170.0, 132.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 168.0, 161.0, 162.0, 160.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 121.0, 76.0, 75.0, 84.0, 75.0, 96.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 119.0, 86.0, 85.0, 86.0, 122.0, 87.0, 86.0, 125.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 98.0, 98.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 80.0, 81.0, 85.0, 81.0, 80.0, 81.0, 91.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 120.0, 123.0, 129.0, 128.0, 130.0, 117.0, 121.0, 145.0, 129.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 167.0, 169.0, 160.0, 165.0, 163.0, 163.0, 165.0, 168.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 65.0, 62.0, 64.0, 65.0, 62.0, 62.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1505.1999999999998, "alertThreshold": 2.0}]} 06:02:49 INFO - Return code: 0 06:02:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:02:49 INFO - # TBPL SUCCESS # 06:02:49 INFO - Running post-action listener: _resource_record_post_action 06:02:49 INFO - ##### 06:02:49 INFO - ##### Finished run-tests step (success) 06:02:49 INFO - ##### 06:02:49 INFO - Running post-run listener: _resource_record_post_run 06:02:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7794688; Write bytes: 417718272; Read time: 1488; Write time: 340084 06:02:49 INFO - TinderboxPrint: CPU usage
13.1% 06:02:49 INFO - TinderboxPrint: I/O read bytes / time
7,794,688 / 1,488 06:02:49 INFO - TinderboxPrint: I/O write bytes / time
417,718,272 / 340,084 06:02:49 INFO - TinderboxPrint: CPU idle
8,288.4 (86.8%) 06:02:49 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 06:02:49 INFO - TinderboxPrint: Swap in / out
0 / 0 06:02:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 89575424; Read time: 0; Write time: 76352 06:02:49 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 5898240; Write bytes: 328142848; Read time: 1176; Write time: 263732 06:02:50 INFO - Running post-run listener: _upload_blobber_files 06:02:50 INFO - Blob upload gear active. 06:02:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:02:50 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 06:02:50 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'] 06:02:50 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 06:02:50 INFO - (blobuploader) - INFO - Open directory for files ... 06:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:51 INFO - (blobuploader) - INFO - Done attempting. 06:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:54 INFO - (blobuploader) - INFO - Done attempting. 06:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:55 INFO - (blobuploader) - INFO - Done attempting. 06:02:55 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:55 INFO - Return code: 0 06:02:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d9560e33013ab92d3eb0a4ca3941e19b638bb8041e64edfd9550e2e1644f228bafeed0366bb4d234d90cc5bd7844f35410af56583b165a554a38c35f7025ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecb3ad2b03225146e8b6bfd304fab8dad3d627b035d4514dc05b83fb2ca71732eadb846cb48f35edb7d8897ee1518c6c87dd773b8141130767681d8dcf2282f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b249d311921152fb562c93b474c67e4fcfc134e04e023d7642eb56f807262aedf120c0db42b0d15977b6c7d61cf99176d6e7479938a0d4756080e94cb6af47"} 06:02:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:55 INFO - Contents: 06:02:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d9560e33013ab92d3eb0a4ca3941e19b638bb8041e64edfd9550e2e1644f228bafeed0366bb4d234d90cc5bd7844f35410af56583b165a554a38c35f7025ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecb3ad2b03225146e8b6bfd304fab8dad3d627b035d4514dc05b83fb2ca71732eadb846cb48f35edb7d8897ee1518c6c87dd773b8141130767681d8dcf2282f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b249d311921152fb562c93b474c67e4fcfc134e04e023d7642eb56f807262aedf120c0db42b0d15977b6c7d61cf99176d6e7479938a0d4756080e94cb6af47"} 06:02:55 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:55 INFO - Copying logs to upload dir... 06:02:55 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.770349 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 06:02:55.613521) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:02:55.616890) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605 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/3d9560e33013ab92d3eb0a4ca3941e19b638bb8041e64edfd9550e2e1644f228bafeed0366bb4d234d90cc5bd7844f35410af56583b165a554a38c35f7025ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecb3ad2b03225146e8b6bfd304fab8dad3d627b035d4514dc05b83fb2ca71732eadb846cb48f35edb7d8897ee1518c6c87dd773b8141130767681d8dcf2282f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b249d311921152fb562c93b474c67e4fcfc134e04e023d7642eb56f807262aedf120c0db42b0d15977b6c7d61cf99176d6e7479938a0d4756080e94cb6af47"} build_url:https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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/3d9560e33013ab92d3eb0a4ca3941e19b638bb8041e64edfd9550e2e1644f228bafeed0366bb4d234d90cc5bd7844f35410af56583b165a554a38c35f7025ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecb3ad2b03225146e8b6bfd304fab8dad3d627b035d4514dc05b83fb2ca71732eadb846cb48f35edb7d8897ee1518c6c87dd773b8141130767681d8dcf2282f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8b249d311921152fb562c93b474c67e4fcfc134e04e023d7642eb56f807262aedf120c0db42b0d15977b6c7d61cf99176d6e7479938a0d4756080e94cb6af47"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:02:55.646999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:02:55.647358) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466772131.516928-1540533605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:02:55.697489) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:02:55.697795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:02:55.698074) ========= ========= Total master_lag: 0.16 =========