builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1463271077.97 results: success (0) buildid: 20160514143015 builduid: dd628b5e085c4bd98865cca7e2bec4ec revision: c67242e935ee610b6f6a6e37596a274bc9ed2c9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:17.968703) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:17.969163) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:17.969469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.002474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.002769) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 17:11:19-- 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% 51.2M=0s 2016-05-14 17:11:20 (51.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.097113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.097447) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019596 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.147333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.147677) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c67242e935ee610b6f6a6e37596a274bc9ed2c9f --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 c67242e935ee610b6f6a6e37596a274bc9ed2c9f --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=516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 17:11:20,136 truncating revision to first 12 chars 2016-05-14 17:11:20,136 Setting DEBUG logging. 2016-05-14 17:11:20,136 attempt 1/10 2016-05-14 17:11:20,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c67242e935ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 17:11:20,420 unpacking tar archive at: fx-team-c67242e935ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.754409) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.754738) ========= script_repo_revision: c67242e935ee610b6f6a6e37596a274bc9ed2c9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.755148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.755446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 17:11:18.765205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-14 17:11:18.765474) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:20 INFO - MultiFileLogger online at 20160514 17:11:20 in /builds/slave/test 17:11:20 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 17:11:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:20 INFO - {'append_to_log': False, 17:11:20 INFO - 'base_work_dir': '/builds/slave/test', 17:11:20 INFO - 'blob_upload_branch': 'Fx-Team', 17:11:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:20 INFO - 'branch': 'Fx-Team', 17:11:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:20 INFO - 'config_files': ('talos/linux_config.py',), 17:11:20 INFO - 'default_actions': ('clobber', 17:11:20 INFO - 'read-buildbot-config', 17:11:20 INFO - 'download-and-extract', 17:11:20 INFO - 'populate-webroot', 17:11:20 INFO - 'create-virtualenv', 17:11:20 INFO - 'install', 17:11:20 INFO - 'run-tests'), 17:11:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:20 INFO - 'download_minidump_stackwalk': True, 17:11:20 INFO - 'download_symbols': 'ondemand', 17:11:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:20 INFO - 'installer_path': 'installer.exe', 17:11:20 INFO - 'log_level': 'info', 17:11:20 INFO - 'log_name': 'talos', 17:11:20 INFO - 'log_to_console': True, 17:11:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:20 INFO - 'opt_config_files': (), 17:11:20 INFO - 'pip_index': False, 17:11:20 INFO - 'sps_profile': False, 17:11:20 INFO - 'sps_profile_interval': 0, 17:11:20 INFO - 'suite': 'dromaeojs', 17:11:20 INFO - 'system_bits': '32', 17:11:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:20 INFO - 'title': 'talos-linux64-ix-061', 17:11:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:20 INFO - 'use_talos_json': True, 17:11:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:20 INFO - 'work_dir': 'build'} 17:11:20 INFO - ##### 17:11:20 INFO - ##### Running clobber step. 17:11:20 INFO - ##### 17:11:20 INFO - Running pre-action listener: _resource_record_pre_action 17:11:20 INFO - Running main action method: clobber 17:11:20 INFO - rmtree: /builds/slave/test/build 17:11:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:21 INFO - Running post-action listener: _resource_record_post_action 17:11:21 INFO - ##### 17:11:21 INFO - ##### Finished clobber step (success) 17:11:21 INFO - ##### 17:11:21 INFO - ##### 17:11:21 INFO - ##### Running read-buildbot-config step. 17:11:21 INFO - ##### 17:11:21 INFO - Running pre-action listener: _resource_record_pre_action 17:11:21 INFO - Running main action method: read_buildbot_config 17:11:21 INFO - Using buildbot properties: 17:11:21 INFO - { 17:11:21 INFO - "project": "", 17:11:21 INFO - "product": "firefox", 17:11:21 INFO - "script_repo_revision": "production", 17:11:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:11:21 INFO - "repository": "", 17:11:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:11:21 INFO - "buildid": "20160514143015", 17:11:21 INFO - "pgo_build": "True", 17:11:21 INFO - "basedir": "/builds/slave/test", 17:11:21 INFO - "buildnumber": 88, 17:11:21 INFO - "slavename": "talos-linux64-ix-061", 17:11:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:11:21 INFO - "platform": "ubuntu64_hw", 17:11:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:11:21 INFO - "branch": "fx-team", 17:11:21 INFO - "repo_path": "integration/fx-team", 17:11:21 INFO - "revision": "c67242e935ee610b6f6a6e37596a274bc9ed2c9f", 17:11:21 INFO - "stage_platform": "linux64-pgo", 17:11:21 INFO - "builduid": "dd628b5e085c4bd98865cca7e2bec4ec", 17:11:21 INFO - "slavebuilddir": "test" 17:11:21 INFO - } 17:11:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:11:21 INFO - Running post-action listener: _resource_record_post_action 17:11:21 INFO - ##### 17:11:21 INFO - ##### Finished read-buildbot-config step (success) 17:11:21 INFO - ##### 17:11:21 INFO - ##### 17:11:21 INFO - ##### Running download-and-extract step. 17:11:21 INFO - ##### 17:11:21 INFO - Running pre-action listener: _resource_record_pre_action 17:11:21 INFO - Running main action method: download_and_extract 17:11:21 INFO - mkdir: /builds/slave/test/build/tests 17:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:21 INFO - https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:11:28 INFO - Downloaded 1361 bytes. 17:11:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:28 INFO - Using the following test package requirements: 17:11:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:11:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:11:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'jsshell-linux-x86_64.zip'], 17:11:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:11:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:11:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:11:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:11:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:11:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:11:28 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')]} 17:11:28 INFO - https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:11:33 INFO - Downloaded 24022619 bytes. 17:11:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:11:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:11:34 INFO - Return code: 0 17:11:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:34 INFO - https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:11:36 INFO - Downloaded 24022619 bytes. 17:11:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:11:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:11:37 INFO - Return code: 0 17:11:37 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')]} 17:11:37 INFO - https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:11:38 INFO - Downloaded 10840194 bytes. 17:11:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:11:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:11:39 INFO - Return code: 0 17:11:39 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')]} 17:11:39 INFO - https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:11:43 INFO - Downloaded 58389584 bytes. 17:11:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:43 INFO - mkdir: /builds/slave/test/properties 17:11:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:11:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:11:43 INFO - Contents: 17:11:43 INFO - build_url:https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:44 INFO - Running post-action listener: _resource_record_post_action 17:11:44 INFO - Running post-action listener: set_extra_try_arguments 17:11:44 INFO - ##### 17:11:44 INFO - ##### Finished download-and-extract step (success) 17:11:44 INFO - ##### 17:11:44 INFO - ##### 17:11:44 INFO - ##### Running populate-webroot step. 17:11:44 INFO - ##### 17:11:44 INFO - Running pre-action listener: _resource_record_pre_action 17:11:44 INFO - Running main action method: populate_webroot 17:11:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:11:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:11:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:11:44 INFO - '--tppagecycles', 17:11:44 INFO - '7'], 17:11:44 INFO - 'tests': ['tsvgm']}}, 17:11:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:11:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:11:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['damp', 'tps']}, 17:11:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'tests': ['damp', 'tps']}, 17:11:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['dromaeo_dom']}, 17:11:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['a11yr', 17:11:44 INFO - 'ts_paint', 17:11:44 INFO - 'tpaint', 17:11:44 INFO - 'sessionrestore', 17:11:44 INFO - 'sessionrestore_no_auto_restore', 17:11:44 INFO - 'tabpaint']}, 17:11:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:11:44 INFO - 'ts_paint', 17:11:44 INFO - 'tpaint', 17:11:44 INFO - 'sessionrestore', 17:11:44 INFO - 'sessionrestore_no_auto_restore', 17:11:44 INFO - 'tabpaint']}, 17:11:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:11:44 INFO - 'ts_paint', 17:11:44 INFO - 'tpaint', 17:11:44 INFO - 'sessionrestore', 17:11:44 INFO - 'sessionrestore_no_auto_restore', 17:11:44 INFO - 'tabpaint']}, 17:11:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:11:44 INFO - 'ts_paint', 17:11:44 INFO - 'tpaint', 17:11:44 INFO - 'sessionrestore', 17:11:44 INFO - 'sessionrestore_no_auto_restore', 17:11:44 INFO - 'tabpaint']}, 17:11:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['a11yr', 17:11:44 INFO - 'ts_paint', 17:11:44 INFO - 'tpaint', 17:11:44 INFO - 'sessionrestore', 17:11:44 INFO - 'sessionrestore_no_auto_restore', 17:11:44 INFO - 'tabpaint']}, 17:11:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['a11yr', 17:11:44 INFO - 'ts_paint', 17:11:44 INFO - 'tpaint', 17:11:44 INFO - 'sessionrestore', 17:11:44 INFO - 'sessionrestore_no_auto_restore', 17:11:44 INFO - 'tabpaint']}, 17:11:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['tsvgx', 17:11:44 INFO - 'tsvgr_opacity', 17:11:44 INFO - 'tart', 17:11:44 INFO - 'tscrollx', 17:11:44 INFO - 'cart']}, 17:11:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:11:44 INFO - 'tsvgr_opacity', 17:11:44 INFO - 'tart', 17:11:44 INFO - 'tscrollx', 17:11:44 INFO - 'cart']}, 17:11:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'talos_options': ['--disable-e10s'], 17:11:44 INFO - 'tests': ['tp5o']}, 17:11:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'tests': ['tp5o']}, 17:11:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'talos_options': ['--disable-e10s', 17:11:44 INFO - '--xperf_path', 17:11:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:44 INFO - 'tests': ['tp5n']}, 17:11:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:44 INFO - 'talos_options': ['--xperf_path', 17:11:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:44 INFO - 'tests': ['tp5n']}}, 17:11:44 INFO - 'talos.zip': {'path': '', 17:11:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:11:44 INFO - Running post-action listener: _resource_record_post_action 17:11:44 INFO - ##### 17:11:44 INFO - ##### Finished populate-webroot step (success) 17:11:44 INFO - ##### 17:11:44 INFO - ##### 17:11:44 INFO - ##### Running create-virtualenv step. 17:11:44 INFO - ##### 17:11:44 INFO - Running pre-action listener: _resource_record_pre_action 17:11:44 INFO - Running main action method: create_virtualenv 17:11:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:11:44 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 17:11:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:11:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:11:44 INFO - Using real prefix '/usr' 17:11:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:11:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:11:46 INFO - Installing pip.................done. 17:11:46 INFO - Return code: 0 17:11:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:11:46 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')]} 17:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:46 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')]} 17:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:46 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:11:46 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 17:11:46 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 17:11:46 INFO - Using env: {'DISPLAY': ':0', 17:11:46 INFO - 'HOME': '/home/cltbld', 17:11:46 INFO - 'LANG': 'en_US.UTF-8', 17:11:46 INFO - 'LANGUAGE': 'en_US:en', 17:11:46 INFO - 'LOGNAME': 'cltbld', 17:11:46 INFO - 'MAIL': '/var/mail/cltbld', 17:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:46 INFO - 'MOZ_NO_REMOTE': '1', 17:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:46 INFO - 'NO_EM_RESTART': '1', 17:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:46 INFO - 'PWD': '/builds/slave/test', 17:11:46 INFO - 'SHELL': '/bin/bash', 17:11:46 INFO - 'SHLVL': '1', 17:11:46 INFO - 'TERM': 'linux', 17:11:46 INFO - 'TMOUT': '86400', 17:11:46 INFO - 'USER': 'cltbld', 17:11:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:46 INFO - '_': '/tools/buildbot/bin/python'} 17:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:46 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 17:11:46 INFO - Cleaning up... 17:11:46 INFO - Return code: 0 17:11:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:11:46 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')]} 17:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:46 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')]} 17:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:46 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:11:46 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 17:11:46 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 17:11:46 INFO - Using env: {'DISPLAY': ':0', 17:11:46 INFO - 'HOME': '/home/cltbld', 17:11:46 INFO - 'LANG': 'en_US.UTF-8', 17:11:46 INFO - 'LANGUAGE': 'en_US:en', 17:11:46 INFO - 'LOGNAME': 'cltbld', 17:11:46 INFO - 'MAIL': '/var/mail/cltbld', 17:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:46 INFO - 'MOZ_NO_REMOTE': '1', 17:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:46 INFO - 'NO_EM_RESTART': '1', 17:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:46 INFO - 'PWD': '/builds/slave/test', 17:11:46 INFO - 'SHELL': '/bin/bash', 17:11:46 INFO - 'SHLVL': '1', 17:11:46 INFO - 'TERM': 'linux', 17:11:46 INFO - 'TMOUT': '86400', 17:11:46 INFO - 'USER': 'cltbld', 17:11:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:46 INFO - '_': '/tools/buildbot/bin/python'} 17:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:47 INFO - Downloading/unpacking psutil>=3.1.1 17:11:47 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 17:11:47 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 17:11:47 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 17:11:47 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 17:11:47 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 17:11:47 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 17:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:11:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:49 INFO - Installing collected packages: psutil 17:11:49 INFO - Running setup.py install for psutil 17:11:49 INFO - building 'psutil._psutil_linux' extension 17:11:49 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 17:11:49 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 17:11:49 INFO - building 'psutil._psutil_posix' extension 17:11:49 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 17:11:49 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 17:11:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:49 INFO - Successfully installed psutil 17:11:49 INFO - Cleaning up... 17:11:49 INFO - Return code: 0 17:11:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:11: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:11: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 mozsystemmonitor==0.3 17:11:49 INFO - Using env: {'DISPLAY': ':0', 17:11:49 INFO - 'HOME': '/home/cltbld', 17:11:49 INFO - 'LANG': 'en_US.UTF-8', 17:11:49 INFO - 'LANGUAGE': 'en_US:en', 17:11:49 INFO - 'LOGNAME': 'cltbld', 17:11:49 INFO - 'MAIL': '/var/mail/cltbld', 17:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:49 INFO - 'MOZ_NO_REMOTE': '1', 17:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:49 INFO - 'NO_EM_RESTART': '1', 17:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:49 INFO - 'PWD': '/builds/slave/test', 17:11:49 INFO - 'SHELL': '/bin/bash', 17:11:49 INFO - 'SHLVL': '1', 17:11:49 INFO - 'TERM': 'linux', 17:11:49 INFO - 'TMOUT': '86400', 17:11:49 INFO - 'USER': 'cltbld', 17:11:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:49 INFO - '_': '/tools/buildbot/bin/python'} 17:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:11:51 INFO - Installing collected packages: mozsystemmonitor 17:11:51 INFO - Running setup.py install for mozsystemmonitor 17:11:51 INFO - Successfully installed mozsystemmonitor 17:11:51 INFO - Cleaning up... 17:11:51 INFO - Return code: 0 17:11:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:11:51 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')]} 17:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:51 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')]} 17:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:51 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:11:51 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 17:11:51 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 17:11:51 INFO - Using env: {'DISPLAY': ':0', 17:11:51 INFO - 'HOME': '/home/cltbld', 17:11:51 INFO - 'LANG': 'en_US.UTF-8', 17:11:51 INFO - 'LANGUAGE': 'en_US:en', 17:11:51 INFO - 'LOGNAME': 'cltbld', 17:11:51 INFO - 'MAIL': '/var/mail/cltbld', 17:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:51 INFO - 'MOZ_NO_REMOTE': '1', 17:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:51 INFO - 'NO_EM_RESTART': '1', 17:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:51 INFO - 'PWD': '/builds/slave/test', 17:11:51 INFO - 'SHELL': '/bin/bash', 17:11:51 INFO - 'SHLVL': '1', 17:11:51 INFO - 'TERM': 'linux', 17:11:51 INFO - 'TMOUT': '86400', 17:11:51 INFO - 'USER': 'cltbld', 17:11:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:51 INFO - '_': '/tools/buildbot/bin/python'} 17:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11: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 17:11:54 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:54 INFO - Downloading docopt-0.6.1.tar.gz 17:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:54 INFO - Running setup.py install for blobuploader 17:11:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:54 INFO - Running setup.py install for requests 17:11:55 INFO - Running setup.py install for docopt 17:11:55 INFO - Successfully installed blobuploader requests docopt 17:11:55 INFO - Cleaning up... 17:11:55 INFO - Return code: 0 17:11:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:55 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')]} 17:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:55 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')]} 17:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:55 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:11:55 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 17:11:55 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 17:11:55 INFO - Using env: {'DISPLAY': ':0', 17:11:55 INFO - 'HOME': '/home/cltbld', 17:11:55 INFO - 'LANG': 'en_US.UTF-8', 17:11:55 INFO - 'LANGUAGE': 'en_US:en', 17:11:55 INFO - 'LOGNAME': 'cltbld', 17:11:55 INFO - 'MAIL': '/var/mail/cltbld', 17:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:55 INFO - 'MOZ_NO_REMOTE': '1', 17:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:55 INFO - 'NO_EM_RESTART': '1', 17:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:55 INFO - 'PWD': '/builds/slave/test', 17:11:55 INFO - 'SHELL': '/bin/bash', 17:11:55 INFO - 'SHLVL': '1', 17:11:55 INFO - 'TERM': 'linux', 17:11:55 INFO - 'TMOUT': '86400', 17:11:55 INFO - 'USER': 'cltbld', 17:11:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:55 INFO - '_': '/tools/buildbot/bin/python'} 17:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:55 INFO - Running setup.py (path:/tmp/pip-BYxa6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:55 INFO - Running setup.py (path:/tmp/pip-x7Vu7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:55 INFO - Running setup.py (path:/tmp/pip-0Fq2sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:55 INFO - Running setup.py (path:/tmp/pip-hnvrby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:55 INFO - Running setup.py (path:/tmp/pip-H5jPU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:56 INFO - Running setup.py (path:/tmp/pip-I633En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:56 INFO - Running setup.py (path:/tmp/pip-ElI2V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:56 INFO - Running setup.py (path:/tmp/pip-xZ7SkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:56 INFO - Running setup.py (path:/tmp/pip-5c5mtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:56 INFO - Running setup.py (path:/tmp/pip-fcllbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:56 INFO - Running setup.py (path:/tmp/pip-tlMhWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:56 INFO - Running setup.py (path:/tmp/pip-YEoFXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:56 INFO - Running setup.py (path:/tmp/pip-mNI1sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:56 INFO - Running setup.py (path:/tmp/pip-7PHpvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:56 INFO - Running setup.py (path:/tmp/pip-bNIyP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:56 INFO - Running setup.py (path:/tmp/pip-0OPfyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:56 INFO - Running setup.py (path:/tmp/pip-GoR1pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:56 INFO - Running setup.py install for manifestparser 17:11:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:56 INFO - Running setup.py install for mozcrash 17:11:57 INFO - Running setup.py install for mozdebug 17:11:57 INFO - Running setup.py install for mozdevice 17:11:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Running setup.py install for mozfile 17:11:57 INFO - Running setup.py install for mozhttpd 17:11:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Running setup.py install for mozinfo 17:11:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Running setup.py install for mozInstall 17:11:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Running setup.py install for mozleak 17:11:57 INFO - Running setup.py install for mozlog 17:11:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Running setup.py install for moznetwork 17:11:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:57 INFO - Running setup.py install for mozprocess 17:11:58 INFO - Running setup.py install for mozprofile 17:11:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:58 INFO - Running setup.py install for mozrunner 17:11:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:58 INFO - Running setup.py install for mozscreenshot 17:11:58 INFO - Running setup.py install for moztest 17:11:58 INFO - Running setup.py install for mozversion 17:11:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:58 INFO - Cleaning up... 17:11:58 INFO - Return code: 0 17:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:58 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')]} 17:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:58 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')]} 17:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:58 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:11:58 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 17:11:58 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 17:11:58 INFO - Using env: {'DISPLAY': ':0', 17:11:58 INFO - 'HOME': '/home/cltbld', 17:11:58 INFO - 'LANG': 'en_US.UTF-8', 17:11:58 INFO - 'LANGUAGE': 'en_US:en', 17:11:58 INFO - 'LOGNAME': 'cltbld', 17:11:58 INFO - 'MAIL': '/var/mail/cltbld', 17:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:58 INFO - 'MOZ_NO_REMOTE': '1', 17:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:58 INFO - 'NO_EM_RESTART': '1', 17:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:58 INFO - 'PWD': '/builds/slave/test', 17:11:58 INFO - 'SHELL': '/bin/bash', 17:11:58 INFO - 'SHLVL': '1', 17:11:58 INFO - 'TERM': 'linux', 17:11:58 INFO - 'TMOUT': '86400', 17:11:58 INFO - 'USER': 'cltbld', 17:11:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:58 INFO - '_': '/tools/buildbot/bin/python'} 17:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:58 INFO - Running setup.py (path:/tmp/pip-p8oYCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:58 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)) 17:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:58 INFO - Running setup.py (path:/tmp/pip-2TvLMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:59 INFO - Running setup.py (path:/tmp/pip-ztRZcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:59 INFO - Running setup.py (path:/tmp/pip-sWfcTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:59 INFO - Running setup.py (path:/tmp/pip-bggsZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:59 INFO - Running setup.py (path:/tmp/pip-TPTaK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:59 INFO - Running setup.py (path:/tmp/pip-VME6Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:59 INFO - Running setup.py (path:/tmp/pip-RevDAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:59 INFO - Running setup.py (path:/tmp/pip-lrYi_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:59 INFO - Running setup.py (path:/tmp/pip-o5GC1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:59 INFO - Running setup.py (path:/tmp/pip-F2tOuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:59 INFO - Running setup.py (path:/tmp/pip-sTnVLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:59 INFO - Running setup.py (path:/tmp/pip-020E2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:59 INFO - Running setup.py (path:/tmp/pip-P6mXgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:59 INFO - Running setup.py (path:/tmp/pip-9Z6iAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:59 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)) 17:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:59 INFO - Running setup.py (path:/tmp/pip-qa8rNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:00 INFO - Running setup.py (path:/tmp/pip-F_YKZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:12:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:01 INFO - Downloading blessings-1.6.tar.gz 17:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:02 INFO - Installing collected packages: blessings 17:12:02 INFO - Running setup.py install for blessings 17:12:02 INFO - Successfully installed blessings 17:12:02 INFO - Cleaning up... 17:12:02 INFO - Return code: 0 17:12:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:02 INFO - Reading from file tmpfile_stdout 17:12:02 INFO - Current package versions: 17:12:02 INFO - argparse == 1.2.1 17:12:02 INFO - blessings == 1.6 17:12:02 INFO - blobuploader == 1.2.4 17:12:02 INFO - docopt == 0.6.1 17:12:02 INFO - manifestparser == 1.1 17:12:02 INFO - mozInstall == 1.12 17:12:02 INFO - mozcrash == 0.17 17:12:02 INFO - mozdebug == 0.1 17:12:02 INFO - mozdevice == 0.48 17:12:02 INFO - mozfile == 1.2 17:12:02 INFO - mozhttpd == 0.7 17:12:02 INFO - mozinfo == 0.9 17:12:02 INFO - mozleak == 0.1 17:12:02 INFO - mozlog == 3.2 17:12:02 INFO - moznetwork == 0.27 17:12:02 INFO - mozprocess == 0.22 17:12:02 INFO - mozprofile == 0.28 17:12:02 INFO - mozrunner == 6.11 17:12:02 INFO - mozscreenshot == 0.1 17:12:02 INFO - mozsystemmonitor == 0.3 17:12:02 INFO - moztest == 0.7 17:12:02 INFO - mozversion == 1.4 17:12:02 INFO - psutil == 3.1.1 17:12:02 INFO - requests == 1.2.3 17:12:02 INFO - wsgiref == 0.1.2 17:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:02 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')]} 17:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:02 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')]} 17:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:02 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:12:02 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 17:12:02 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 17:12:02 INFO - Using env: {'DISPLAY': ':0', 17:12:02 INFO - 'HOME': '/home/cltbld', 17:12:02 INFO - 'LANG': 'en_US.UTF-8', 17:12:02 INFO - 'LANGUAGE': 'en_US:en', 17:12:02 INFO - 'LOGNAME': 'cltbld', 17:12:02 INFO - 'MAIL': '/var/mail/cltbld', 17:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:02 INFO - 'MOZ_NO_REMOTE': '1', 17:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:02 INFO - 'NO_EM_RESTART': '1', 17:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:02 INFO - 'PWD': '/builds/slave/test', 17:12:02 INFO - 'SHELL': '/bin/bash', 17:12:02 INFO - 'SHLVL': '1', 17:12:02 INFO - 'TERM': 'linux', 17:12:02 INFO - 'TMOUT': '86400', 17:12:02 INFO - 'USER': 'cltbld', 17:12:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:02 INFO - '_': '/tools/buildbot/bin/python'} 17:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 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)) 17:12:02 INFO - Cleaning up... 17:12:02 INFO - Return code: 0 17:12:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:02 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')]} 17:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:02 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')]} 17:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:02 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:12:02 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 17:12:02 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 17:12:02 INFO - Using env: {'DISPLAY': ':0', 17:12:02 INFO - 'HOME': '/home/cltbld', 17:12:02 INFO - 'LANG': 'en_US.UTF-8', 17:12:02 INFO - 'LANGUAGE': 'en_US:en', 17:12:02 INFO - 'LOGNAME': 'cltbld', 17:12:02 INFO - 'MAIL': '/var/mail/cltbld', 17:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:02 INFO - 'MOZ_NO_REMOTE': '1', 17:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:02 INFO - 'NO_EM_RESTART': '1', 17:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:02 INFO - 'PWD': '/builds/slave/test', 17:12:02 INFO - 'SHELL': '/bin/bash', 17:12:02 INFO - 'SHLVL': '1', 17:12:02 INFO - 'TERM': 'linux', 17:12:02 INFO - 'TMOUT': '86400', 17:12:02 INFO - 'USER': 'cltbld', 17:12:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:02 INFO - '_': '/tools/buildbot/bin/python'} 17:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:02 INFO - Downloading/unpacking jsonschema 17:12:02 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 17:12:02 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 17:12:02 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 17:12:02 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 17:12:02 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 17:12:02 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 17:12:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:04 INFO - Downloading/unpacking functools32 (from jsonschema) 17:12:04 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 17:12:04 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 17:12:04 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 17:12:04 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 17:12:04 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 17:12:04 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 17:12:04 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:05 INFO - warning: no files found matching '*.txt' 17:12:05 INFO - no previously-included directories found matching 'build' 17:12:05 INFO - no previously-included directories found matching 'dist' 17:12:05 INFO - no previously-included directories found matching '.git*' 17:12:05 INFO - Installing collected packages: jsonschema, functools32 17:12:05 INFO - Running setup.py install for functools32 17:12:05 INFO - warning: no files found matching '*.txt' 17:12:05 INFO - no previously-included directories found matching 'build' 17:12:05 INFO - no previously-included directories found matching 'dist' 17:12:05 INFO - no previously-included directories found matching '.git*' 17:12:05 INFO - Successfully installed jsonschema functools32 17:12:05 INFO - Cleaning up... 17:12:05 INFO - Return code: 0 17:12:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:12:05 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')]} 17:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:05 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')]} 17:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:05 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 0x7f7185255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', '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 17:12:05 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 17:12:05 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 17:12:05 INFO - Using env: {'DISPLAY': ':0', 17:12:05 INFO - 'HOME': '/home/cltbld', 17:12:05 INFO - 'LANG': 'en_US.UTF-8', 17:12:05 INFO - 'LANGUAGE': 'en_US:en', 17:12:05 INFO - 'LOGNAME': 'cltbld', 17:12:05 INFO - 'MAIL': '/var/mail/cltbld', 17:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:05 INFO - 'MOZ_NO_REMOTE': '1', 17:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:05 INFO - 'NO_EM_RESTART': '1', 17:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:05 INFO - 'PWD': '/builds/slave/test', 17:12:05 INFO - 'SHELL': '/bin/bash', 17:12:05 INFO - 'SHLVL': '1', 17:12:05 INFO - 'TERM': 'linux', 17:12:05 INFO - 'TMOUT': '86400', 17:12:05 INFO - 'USER': 'cltbld', 17:12:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:05 INFO - '_': '/tools/buildbot/bin/python'} 17:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:05 INFO - Downloading/unpacking flake8 17:12:05 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 17:12:05 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 17:12:05 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 17:12:05 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 17:12:05 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 17:12:05 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 17:12:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:12:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:12:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 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 17:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:08 INFO - no previously-included directories found matching 'docs/_build' 17:12:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:12:08 INFO - Running setup.py install for pep8 17:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:08 INFO - no previously-included directories found matching 'docs/_build' 17:12:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:12:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:12:08 INFO - Cleaning up... 17:12:08 INFO - Return code: 0 17:12:08 INFO - Running post-action listener: _resource_record_post_action 17:12:08 INFO - Running post-action listener: _start_resource_monitoring 17:12:08 INFO - Starting resource monitoring. 17:12:08 INFO - ##### 17:12:08 INFO - ##### Finished create-virtualenv step (success) 17:12:08 INFO - ##### 17:12:08 INFO - ##### 17:12:08 INFO - ##### Running install step. 17:12:08 INFO - ##### 17:12:08 INFO - Running pre-action listener: _resource_record_pre_action 17:12:08 INFO - Running main action method: install 17:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:08 INFO - Reading from file tmpfile_stdout 17:12:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:08 INFO - Reading from file tmpfile_stdout 17:12:08 INFO - Output received: 17:12:08 INFO - Usage: mozinstall [options] installer 17:12:08 INFO - Options: 17:12:08 INFO - -h, --help show this help message and exit 17:12:08 INFO - -d DEST, --destination=DEST 17:12:08 INFO - Directory to install application into. [default: 17:12:08 INFO - "/builds/slave/test"] 17:12:08 INFO - --app=APP Application being installed. [default: firefox] 17:12:08 INFO - mkdir: /builds/slave/test/build/application 17:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:12:25 INFO - Reading from file tmpfile_stdout 17:12:25 INFO - Output received: 17:12:25 INFO - /builds/slave/test/build/application/firefox/firefox 17:12:25 INFO - Running post-action listener: _resource_record_post_action 17:12:25 INFO - ##### 17:12:25 INFO - ##### Finished install step (success) 17:12:25 INFO - ##### 17:12:25 INFO - ##### 17:12:25 INFO - ##### Running run-tests step. 17:12:25 INFO - ##### 17:12:25 INFO - Running pre-action listener: _resource_record_pre_action 17:12:25 INFO - Running main action method: run_tests 17:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:25 INFO - Python 2.7.3 17:12:25 INFO - Return code: 0 17:12:25 INFO - grabbing minidump binary from tooltool 17:12:25 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')]} 17:12:25 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 0x19589c0>, '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 0x19598c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1959d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:25 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 17:12:25 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 17:12:25 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 17:12:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:25 INFO - Return code: 0 17:12:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:12:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:12:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:12:26 INFO - Return code: 0 17:12:26 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/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 17:12:26 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/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 17:12:26 INFO - Using env: {'DISPLAY': ':0', 17:12:26 INFO - 'HOME': '/home/cltbld', 17:12:26 INFO - 'LANG': 'en_US.UTF-8', 17:12:26 INFO - 'LANGUAGE': 'en_US:en', 17:12:26 INFO - 'LOGNAME': 'cltbld', 17:12:26 INFO - 'MAIL': '/var/mail/cltbld', 17:12:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:26 INFO - 'MOZ_NO_REMOTE': '1', 17:12:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:26 INFO - 'NO_EM_RESTART': '1', 17:12:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:26 INFO - 'PWD': '/builds/slave/test', 17:12:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:26 INFO - 'SHELL': '/bin/bash', 17:12:26 INFO - 'SHLVL': '1', 17:12:26 INFO - 'TERM': 'linux', 17:12:26 INFO - 'TMOUT': '86400', 17:12:26 INFO - 'USER': 'cltbld', 17:12:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934', 17:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:26 INFO - '_': '/tools/buildbot/bin/python'} 17:12:26 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/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 17:12:26 INFO - mozversion application_buildid: 20160514143015 17:12:26 INFO - mozversion application_changeset: c67242e935ee610b6f6a6e37596a274bc9ed2c9f 17:12:26 INFO - mozversion application_display_name: Nightly 17:12:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:26 INFO - mozversion application_name: Firefox 17:12:26 INFO - mozversion application_remotingname: firefox 17:12:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:12:26 INFO - mozversion application_vendor: Mozilla 17:12:26 INFO - mozversion application_version: 49.0a1 17:12:26 INFO - mozversion platform_buildid: 20160514143015 17:12:26 INFO - mozversion platform_changeset: c67242e935ee610b6f6a6e37596a274bc9ed2c9f 17:12:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:12:26 INFO - mozversion platform_version: 49.0a1 17:12:26 INFO - using testdate: 1463271146 17:12:26 INFO - actual date: 1463271146 17:12:26 INFO - starting webserver on 'localhost:33213' 17:12:26 INFO - SUITE-START | Running 2 tests 17:12:26 INFO - TEST-START | dromaeo_css 17:12:26 INFO - operating with platform_type : linux_ 17:12:26 INFO - Initialising browser for dromaeo_css test... 17:12:26 INFO - TEST-INFO | started process 32212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Dw7A6/profile http://localhost:33213/getInfo.html) 17:12:30 INFO - PROCESS | 32212 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 17:12:30 INFO - PROCESS | 32212 | __metrics Screen width/height:1600/1200 17:12:30 INFO - PROCESS | 32212 | colorDepth:24 17:12:30 INFO - PROCESS | 32212 | Browser inner width/height: 1024/697 17:12:30 INFO - PROCESS | 32212 | __metrics 17:12:31 ERROR - PROCESS | 32212 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:12:32 INFO - TEST-INFO | 32212: exit 0 17:12:32 INFO - Browser initialized. 17:12:32 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:32 INFO - TEST-INFO | started process 32299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Dw7A6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:44 INFO - PROCESS | 32299 | RSS: Main: 152461312 17:12:44 INFO - PROCESS | 32299 | 17:13:35 INFO - PROCESS | 32299 | 1463271215596 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] 17:15:45 INFO - PROCESS | 32299 | Cycle 1(1): loaded http://localhost:33213/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33213/tests/dromaeo/cssquery-ext.html) 17:15:46 INFO - PROCESS | 32299 | RSS: Main: 256884736 17:15:46 INFO - PROCESS | 32299 | 17:18:49 INFO - PROCESS | 32299 | Cycle 1(1): loaded http://localhost:33213/tests/dromaeo/cssquery-ext.html (next: http://localhost:33213/tests/dromaeo/cssquery-jquery.html) 17:18:49 INFO - PROCESS | 32299 | RSS: Main: 242253824 17:18:49 INFO - PROCESS | 32299 | 17:21:51 INFO - PROCESS | 32299 | Cycle 1(1): loaded http://localhost:33213/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33213/tests/dromaeo/cssquery-mootools.html) 17:21:52 INFO - PROCESS | 32299 | RSS: Main: 241872896 17:21:52 INFO - PROCESS | 32299 | 17:24:54 INFO - PROCESS | 32299 | Cycle 1(1): loaded http://localhost:33213/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33213/tests/dromaeo/cssquery-prototype.html) 17:24:55 INFO - PROCESS | 32299 | RSS: Main: 242286592 17:24:55 INFO - PROCESS | 32299 | 17:27:57 INFO - PROCESS | 32299 | Cycle 1(1): loaded http://localhost:33213/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33213/tests/dromaeo/cssquery-yui.html) 17:27:58 INFO - PROCESS | 32299 | RSS: Main: 225030144 17:27:58 INFO - PROCESS | 32299 | 17:31:00 INFO - PROCESS | 32299 | Cycle 1(1): loaded http://localhost:33213/tests/dromaeo/cssquery-yui.html (next: http://localhost:33213/tests/dromaeo/cssquery-dojo.html) 17:31:00 INFO - PROCESS | 32299 | RSS: Main: 272580608 17:31:00 INFO - PROCESS | 32299 | 17:31:00 INFO - PROCESS | 32299 | __start_tp_report 17:31:00 INFO - PROCESS | 32299 | _x_x_mozilla_page_load 17:31:00 INFO - PROCESS | 32299 | _x_x_mozilla_page_load_details 17:31:00 INFO - PROCESS | 32299 | |i|pagename|runs| 17:31:00 INFO - PROCESS | 32299 | |0;dojo.html;3161.00428365065;3170.968290317096;3203.0711093782797;3208.342289830585;3232.9030129096136;5256.842294731155;5302.390225124112;5354.089804733195;5419.59353048521;5458.508734213915;5371.919421208675;5376.1129413646795;5381.5425688816495;5393.568514518839;5435.701036443004;4806.110869489138;4822.590079843218;4971.328870602477;4988.401391832985;5084.339035925324;4980.228064649967;4981.676191047589;5020.799168033274;5046.21783623539;5052.141136006888;4784.258439941815;4815.470298267188;4888.169011268093;4925.458199598042;4928.531789479994;4909.705417674915;4922.296605811929;4931.408231012266;4955.851324460272;4970.975145124287;4738.857834264943;4781.306710526954;4910.803567857281;4915.45929947709;4985.102681517325;5284.735763211863;5375.946240537583;5403.405625381205;5421.430749771296;5422.810201642924;5894.705264736789;5894.970525147347;5897.3218079920925;5898.292204935392;5900.704964751788;5640.689762063085;5716.371199168088;5823.417658234185;5895.616784908967;5952.404759524056;5452.700101494416;5464.726763661801;5479.808206712746;5501.614886957875;5503.7798488060025;5993.670348130895;6036.215292012098;6049.395060494004;6050.969745151246;6061.6666083365835;5573.693446860461;5716.256886604715;5764.07774756037;5768.538516918637;5790.131480277908;5920.585559010914;5927.051671732588;5930.555208359304;5959.970200149059;5966.19456373384;5837.503812176013;5880.382559831241;5897.115432685132;5899.882002360015;5907.556933230025;5690.061139911868;5769.769209231584;5848.736806843703;5853.180554722342;5917.852053698606;4429.224885645;4436.245838207513;4437.134758722083;4464.933026004613;4465.12929978651;3966.2067586482817;3992.2614316350987;3997.8800635980965;4021.7989100544855;4021.8592349267633;5316.574674026146;5321.6540924839765;5376.811811586654;5487.149491828773;5575.526080283222;5808.854778630568;5809.419058094157;5843;5852.268466441695;5863.970680146572;5467.343918729778;5475.945240547623;5477;5477.767502312027;5479.315085614298;4834.371531700926;4893.779779909913;4922.630802689812;4958.033183529249;4998.125328067574;5998.580099393175;6001.879962400728;6006.639601623917;6008.669523176267;6009;5687.374388817309;5819.883602328015;5882.617629854046;5884.764609415746;5891;6002.3097343804275;6024.0662697282;6073.453389194994;6150.231221097363;6154.446099851035;5748.45389687979;5845.1232315151365;5853.239078919713;5854.824355269348;5860.912086318794;5648.774049037993;5814.854628634318;5944.286685597756;5950.928832810136;5958.433948774859;5681.744321505459;5797.91303130445;5799.2750906136735;5802.506786923159;5831.183634291117;5751.539876809761;5761.769529218785;5763.250777398911;5774.133879918046;5776.104703770922;5487.506124448819;5528.91706624409;5578.0953332668105;5674.546036317167;5681.289838770153;5766.625169363978;5766.913496297475;5815.3603103657715;5821.621594596338;5831.7667293307795;5593.636413633101;5608.523275521627;5645.548356131581;5651.773929042793;5658.349289831722 17:31:00 INFO - PROCESS | 32299 | |1;ext.html;610.3347351386988;639.1786554277754;648.6659370424229;650.3431534150508;660.7026837922934;33124.66875331249;35728;35738.2852342953;35767.64232357676;44620;42546.36180457295;46502;46889;46889.53110468894;46897;8952.776180595489;9099.49858273384;9126;9131.497767622777;9150.86273705895;8200.876986845202;8967.910320896804;9102.63589456421;10566.682999510027;10774.299670521392;10817.783644327108;10859.348439093641;10873.347599144077;10878.510467029002;10890.237683362167;10826.350418974887;10881.292715973515;10884.07485363745;10893.07408870247;10907.727306817314;10662.893371066268;10707.571697132184;10711.892881071246;10723.14214862809;10734;42563.36154957678;42701;42714.57285427137;42763.57236427658;42892;3529.2588556403184;3614.2771445710964;3659.743817932746;3801.4297855321647;4402.691811573191;32656.510152347735;33244.833775830964;33279.833600832084;33282.33435331304;33662.32675346504;3903.180332130256;3930.390789427643;3970.305196590585;4041.353383458662;4054.6535798493655;349262;350752;351898;352533;357402;38060.809695951895;61946.69026654838;62260.377396225456;62303.6884815573;62310;37055.81472092676;37063;37253.627463725556;37333.81333093317;37336;15366.385344586091;15501.069935803887;15514.767278490832;15520.611984700472;15523;11343.773124537463;12596.055295852848;12600.621981340575;12644.494220231089;12644.557440489723;8501.404901656948;8744.91255087441;8791.164839340252;8846.867296990551;8915.108489151162;3294.209389746444;3422.528312825509;3423.7432192585156;3442.6557344265375;3444.810535420576;1062.8458873463305;1086.766345235778;1118.81539545974;1197.1201167142144;1198.532572296805;32772;33181.3363732724;33192.50211246833;33361.810124748255;33727.83136084304;1156.2022204678744;1163.1334655681571;1169.3919162035693;1172.8533933258343;1234.9135560510679;17754.91122544379;17797.822021779877;17799.19903604341;17914.46256612304;17932.462026139237;779352;779750;787397;790343;800449;60933.69533152306;61946.69026654928;62166;62200.37799622036;62252.37747622466;1320.933953302331;1448.920309382994;1472.146155229964;1482.3107255126201;1509.3358922074253;32326.515102273013;34348;34623.82688086644;34686.94078717245;34909;51819.481805181465;52221;52445.47554524406;52469;52556.211656825944;465740;466085;468954;469436;471132;26369.340766480993;28395;29469.852650736608;29552.55671164891;30865.382692346477;48645.756771215914;49677;49984.500154997986;50270.748646256536;50780.492195077575;40977.1804563913;41163.38254926119;41705.79147104245;41867.162656746084;42800;41561.58438415577;41593.79203103965;41816.581834182485;42034.7898260519;42225.155496890504;42863.785681072644;43013.20414173069;43290.56709432865;43951;43962.12075758531;35837.462438062925;36830.263394732494;38270.98128943446;38854.611453885096;39298.41052384274;28983.5652465209;29018;29296;29588.260293492836;29769.702302976693 17:31:01 INFO - PROCESS | 32299 | |2;jquery.html;408.11642793352394;410.57710558125126;411.12840777551594;415.0764548878743;423.2698594923757;14255.3585088671;17937.730934036;19619.11713972873;19679.21283148676;19709.113089910952;14796.6300842479;19011.714824277646;19103.71344429831;20067.698984515206;20871.269505567307;5665.3201615806165;5794.797182098628;5829.795957141501;5832.979228634993;5868.090445980858;5704.1443783432405;5786.363500014995;5796.913046304308;5797.304323481167;5799.043157878966;4117.3206420940505;5948.434898684618;6285.371462853724;6292.433680968712;6398.648074355909;6285.088662143963;6364.809055728312;6393.776217832354;6399.328070552595;6419.261784894704;5517;5653.406392328829;5668.206451096849;5692.260006199209;5693.03218452864;22983;23088.769112308997;23277.21739477625;23787.76212237873;23993.88003059991;2429.5748244057218;2443.3769388805918;2449.020391843259;2657.6545049143488;2896.131160651796;14014.649633759136;14571.344289506998;14669.70660586793;14729.484468043567;15064.774028389584;1960.1571324330532;2036.521417466894;2060.1656329186703;2103.0536258683655;2143.7641859395453;77825;78135.21864781393;78217.60891195564;78542.60728696377;78669.60665196694;10335.896641033643;10351.792964140826;10735.087517560938;10789.676309710721;10843.45782710877;14922.40310387594;15004;15022.24888755558;15046.774298385533;15086.54740357791;7988;8286.627101780434;8289;8395.916040839636;8428.536430496259;7979.72070977513;8063.919360806317;8097.959510202529;8171.79570510742;8185.3042491387705;5969.552283578749;6249;6742.393184613408;6769.763058292936;6874.896876546856;1941.8737782044122;1956.129522362535;1959.5493036601376;1960.2746983616153;1982.1377700699952;956.8134213828237;1074.2158224496006;1126.6620013995769;1141.4749215360862;1175.3183153770792;18694.906525467286;19520.70718939217;19993.200271989248;20360.69458958117;20575.176992920115;1057.513543769859;1093.9398333091597;1098.807708650983;1110.1840147491587;1164.2665120973902;11151.442427878574;11552.59565915189;11598.594049208237;11668.474918628683;11703.2978021319;471364;475287;479852;487137;492371;77753;77985;79224.60387698024;80521.59739201267;81447.59276203699;1020.3061917895753;1037.071820720451;1039.8232300508932;1055.894410558938;1065.8241390170535;17440.127993600523;17594.91202543979;17615.471535853943;17829.46511604654;18199.545011374823;38158;38219;39502;39774.40338394869;40821;51187.232191516414;51889.48110518847;53078.73460632827;59397;60143;8111.148329425326;8311.127331630092;8336.083030866721;8479.2368686816;8680.696175633822;10046.8492972604;13521.121127126706;13549.79675304891;13640.181589104686;13983.230922298964;11448.084153267551;11473.196876218584;11792.056635469313;11956.46195921203;12190.2076365036;11576.47905844256;11620.825687614524;11719.589814356457;11749.177557570887;12003.81994270104;12073;12175;12319.322437266037;12372.938135309267;12517.248965062125;8765.561721913751;8806.339524535813;8980.012198658012;8985.730428087169;12555.246685198917;12183.817242741543;12548.24710517372;12613.432395542406;12658.556950506689;13202.33988300562 17:31:01 INFO - PROCESS | 32299 | |3;mootools.html;1408.1832537128466;1538.7691846223065;1552.6894621075785;1726.4043904852822;1882.3694062489058;8694.521801300934;9092.090790920913;9149.451032938021;9400.153986141246;9453.81092378152;9041.321900857429;9291.814163716721;9293.860592091123;9307.441553506795;9314.673986410477;2070.6997485364614;2285.2572913802996;2360.6223004319313;2406.1217655555683;2442.1452491627965;2409.144753612469;2421.539907417585;2422.648715936188;2424.0303878448585;2424.9515009699794;2332.626779715246;2345.7771511706446;2359.7876191142796;2362.751911049341;2364.2316247219637;2053.702213179088;2253.86476811391;2268.3308424014954;2345.1205797825814;2353.9058437662475;2371.9644205336936;2379.0721618568773;2400.7839294463583;2403.050794936008;2403.242978461779;9503.762405939839;9601.711948641552;9603.615855365777;9612.951935240279;9619.13427791495;5362.2224777407055;5499.450054994469;5503.724813759296;5505.807296744595;5513.448655134494;3332.950005749916;3377.932441351159;3450.6721861423125;3454.9654503454894;3464.826758662057;1127.695522209007;1161.361251311775;1167.7839599674003;1180.6753142885775;1232.0697873105837;13548.45806167752;13567.660808479768;13610.115342502606;13726;13733.176009439365;4513.074819661962;4698.976505117521;4730;4811.422629284508;4823.927641085386;10445.529951152217;10463.424511651932;10477.1094456972;10485.68542943713;10495;5396.676199428047;5400.027994960867;5406.189071639285;5408.242846001563;5409.161579955114;4344.066025804467;4830.4444988826035;4958.057968985953;4961.08219979305;5040.873978150576;3725.776453412804;3844.9231015379537;3853.325668008087;3859.054531639766;3940.9605903941165;1122.0462606784167;1129.0346753525782;1140.9714757131137;1145.8166693329026;1152.3719572832827;866;970.2480577552453;1035.8860525342207;1055.2008824953436;1057.1595581512715;6261.436470717657;6373.012183111625;6541.084248205255;6569.770058047945;6635.568688035262;439.1590104949051;440.5154330236714;444.5199184880386;449.5392222971415;460.794946248916;4248.320268756984;4285.61429471349;4415.624671902924;4481.439820022497;4504.752238626841;11378.31730096197;11688.668729412077;11781.116416268815;11795.115366347387;11811.291322520505;11247.437628118725;11626.651200463999;11805.88194118065;11824.172307938534;11835.28988260707;8695.130486951255;8709.73870783865;8746.956265218632;8810.471371717718;8998.50508222041;6312.652804095819;6369.87260254783;6371.872562548816;6447.258565265054;6464.288928217987;10460.424676642857;10803.135749139892;10840.620578279722;10841.620543280947;10963.561457541928;10930.617428390286;11174.161937854857;11219.66341009771;11296;11315.321080735182;8194.754157375288;8313.085560588452;8422.326213902996;8472.91527084746;8476.957615211884;9213.76965575866;9233.215176709786;9285.535723213678;9303.302252330966;9307.301952353737;8234.135415781497;8398.986499861552;8411.53736544496;8421.452605580618;8589.957050214709;8056.798580035546;8077.434579579373;8188.5905704715715;8210.958945205235;8269.04905935801;7360.411167106511;7433.888491672521;7438.256174382518;7450.254974502506;7454.142773581108;5416.133418652997;5481.780728770805;5537.473939975695;5628.831135065954;5646.774129034792;5501.202325662676;5543.307086614173;5562.5549956002615;5755.395683453177;5825.417458254141 17:31:01 INFO - PROCESS | 32299 | |4;prototype.html;332.9533865258864;334.6736931491796;336.8164350429016;338.62412721878724;340.4518724852986;5419;5423.725424525233;5430.809921652738;5467.371252305986;5491.807786727465;5273.815416460425;5320.467953204688;5413.296271484702;5429.484199001088;5440.972795136028;3954.8022598870084;4002.959970400288;4157.459530261061;4165.208610364036;4210.57894210578;4166.437530933331;4167.791610419482;4172.916541669165;4184.660908509279;4187.539370669224;3965.940510892339;4148.668106551469;4161.564260330181;4176.248275310443;4183.100633363826;4030.476038115041;4140.668746500272;4157.459530261077;4161.271777438967;4172.97913510432;3649.1424515238896;3655.1593133579427;3677.3564626190578;3708.0915175782106;3713.795741234231;5131.717755523445;5162.3030890830005;5162.638615296931;5177.145770947789;5212.609054320941;4650.930236046462;4839.612830973514;4851.442084160296;4871.244957031666;4886.706797592155;5588.944110558883;5649.52554179181;5667.866426714673;5711.7715291388295;5720.971395143039;4153.276390298022;4178.895527611804;4194.832206711728;4197.91604167918;4199.538050814408;5592.5805564582815;5919.526437884959;5921.230240068763;5928.79249226275;5933.4659880610525;4092.9795351023054;4122.175564887035;4129.97935010323;4136.544980052192;4141.233871733739;4159.168166366739;4159.83360665576;4180.205760905418;4196.265653510623;4208.810603522848;4657.790399432034;4799.168490590569;4799.688020278671;4801.447833499123;4815.374001379798;5559.749811258503;5597.648987425291;5683.516901063374;5705.172749951317;5739.253896993364;1468.0017588040234;1487.115166475945;1490.709311684233;1501.6621260216582;1501.6860247283628;931.9394239374419;959.9952000239954;964.7009427077628;974.5030034682363;978.0708327089294;4734.479207287196;4852.660313778002;4859.032092002674;4879.609631229493;4907.7300748458465;5102.035716249271;5134.099233932816;5149.304843846033;5186.974065129651;5200.737679109599;4848.200046992207;4899.461059283476;4913.213885778258;4926.5073492650445;4947.82682606107;2686.033028109879;2744.9588256176175;2749.2164733050986;2754.5179593571447;2780.7636350909993;5271.341082364705;5291.417944026154;5307.310049693515;5316.229146773773;5317.441668624816;5216.400113986864;5222.294990176278;5231.293775340357;5232;5235.947640523622;4896.632752543503;5303.973480132575;5329.733513324319;5370.54995151307;5385.54222891043;5108.61685373591;5129.384473863161;5171.405288391883;5210.697325668583;5268.683878967274;5069.808594980251;5090.287359769562;5107.41264754558;5146.974265128651;5340.252364668871;5967.403259673998;5991.430814072656;6035.969820150871;6041.124037014696;6090.878182436238;4089.7341672792363;4124.319487284564;4130.463039804806;4145.937810932778;4159.085001299709;5510;5655.406182350794;5803.9419605803405;5871.970640146772;5879.794207202727;5620.414609279777;5691.117876729114;5693.3168019837885;5700.600957933071;5710.057840456278;5688;5700.714964251688;5709.429057094258;5718.857028574319;5721.312212897288;5462.20797984298;5548.195511650707;5558.555315574664;5584.385717570983;5617.606767526234;5631.8592035199445;5650.463205995424;5661.320641523043;5673.489385955284;5714.371419143974;5388.676679399248;5558.416366281483;5585.441455854382;5599.8880022400135;5607.243022192115 17:31:01 INFO - PROCESS | 32299 | |5;yui.html;707.3351050012991;725.9637018149092;746.8319628083685;756.1153450462958;766.4213518793308;13445.193288402703;13553.119047261922;13704.52034178804;14538.927305363459;15200.467983620549;14314.141151530916;14470;14507.782383264259;14532.273386330695;14535.709285814277;704.8766465868479;830.5432012393189;852.0286872964825;860.6944534690189;861.418542483824;853.0999795216045;860.3805260212669;862.8360611483829;862.8921384826897;863.1497974495148;888.6667499687617;895.7805337692274;896.8340856941487;897.2687259883174;897.6633762339122;735.474135992765;876.1632640827994;889.7019498467988;890.1543533643032;898.2723993565234;659.2023651381834;660.0594153331531;660.3000819131736;660.8347913021745;660.93390660934;13129.868701313055;13148.802767958488;13155.408006639724;13165.078444508888;13176.209427434289;13053.934730326288;13282.269475178862;13417.194968301934;13493.2578708171;13639.386227619681;12558.937205313914;12821.35893205336;12827.069843026464;12961.611151665466;13117.737645247042;4488.618467430239;4506.391637128979;4517.096580683877;4521.480029796583;4633;59480.405195948355;59597;59636.40363596352;60137.6993115036;60462.186134416035;10077.798444031225;10140.087392134743;10229.641962531425;10409;10633.361998280128;17166.742498862528;17168.39910603148;17209.827901721073;17242.224099915533;17252.223649935782;7940.364770818321;8019.35845132388;8077.636506357228;8387.370947178864;8388.748337549883;4519.706219095814;4609.838655647036;4696.319033740157;4746.1931471649905;4828.5412885776495;3328.56728625282;3422.6577342266073;3427.880024199141;3433.124553238958;3433.896983090511;578.349356973405;680.4590350671228;690.1338819781242;709.3367701199395;710.5559025608994;662.8276648071536;716.330231233798;739.1721272175198;757.5795433534331;781.4451739265072;9932.702018939442;10051.748706282255;10310.587576496857;10352.120069794151;10455.268131230741;647.8542327976168;676.3844901140037;696.9616671083139;719.9244079371696;729.1250499400741;4712.198926182557;4913.287573301923;4940.431850337185;4955.851324460272;5011.303128446395;73013;73528.26471735214;73988.63005684938;74720.62639686766;74872.25127748762;64214.35785642084;64743.35256647468;64749;65097.34902650913;67482.32517674859;55824.441755581924;56036.719816400655;56553.71723141358;56781.43218567844;57075;8939.195472407515;9002.864957025518;9031.232345250728;9069.455832650063;9400.905990940277;38749.225015500095;39376.803115984236;39522.40716389199;39809.80095099506;40589.79705101455;49051.264231037276;52852.735736321076;52888.735556321975;52947.73526132345;53170.73414632902;11735.76528469443;11898.22661526998;11975.101867360157;12015.339156346485;12302;13070.281134537692;13417.731645367234;13568.728625427633;13834;14303.928480357532;12401.62795116148;12621.432035558239;12814.423350949042;12863;13112.737745245233;12039.398030098286;12594.3073130975;12742.745145097231;12829.10196286251;12905.806412903627;12570.560030398892;12582;12655.240685558896;12704.491820327454;12726.490940362282;10215.897841021495;10443.164546836082;10629.787404252027;10724.249302548747;10736.30214036085;10445.582176712845;10550.31422957536;10599.735006624896;10807.729806754895;10815.134789216687 17:31:01 INFO - PROCESS | 32299 | __end_tp_report 17:31:01 INFO - PROCESS | 32299 | __start_cc_report 17:31:01 INFO - PROCESS | 32299 | _x_x_mozilla_cycle_collect,833 17:31:01 INFO - PROCESS | 32299 | __end_cc_report 17:31:01 INFO - PROCESS | 32299 | __startTimestamp1463272260994__endTimestamp 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - PROCESS | 32299 | ------- Summary: start ------- 17:31:01 INFO - PROCESS | 32299 | Number of tests: 6 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - PROCESS | 32299 | [#0] dojo.html Cycles:165 Average:5418.65 Median:5645.55 stddev:629.09 (11.1%) stddev-sans-first:605.58 17:31:01 INFO - PROCESS | 32299 | Values: 3161.0 3171.0 3203.1 3208.3 3232.9 5256.8 5302.4 5354.1 5419.6 5458.5 5371.9 5376.1 5381.5 5393.6 5435.7 4806.1 4822.6 4971.3 4988.4 5084.3 4980.2 4981.7 5020.8 5046.2 5052.1 4784.3 4815.5 4888.2 4925.5 4928.5 4909.7 4922.3 4931.4 4955.9 4971.0 4738.9 4781.3 4910.8 4915.5 4985.1 5284.7 5375.9 5403.4 5421.4 5422.8 5894.7 5895.0 5897.3 5898.3 5900.7 5640.7 5716.4 5823.4 5895.6 5952.4 5452.7 5464.7 5479.8 5501.6 5503.8 5993.7 6036.2 6049.4 6051.0 6061.7 5573.7 5716.3 5764.1 5768.5 5790.1 5920.6 5927.1 5930.6 5960.0 5966.2 5837.5 5880.4 5897.1 5899.9 5907.6 5690.1 5769.8 5848.7 5853.2 5917.9 4429.2 4436.2 4437.1 4464.9 4465.1 3966.2 3992.3 3997.9 4021.8 4021.9 5316.6 5321.7 5376.8 5487.1 5575.5 5808.9 5809.4 5843.0 5852.3 5864.0 5467.3 5475.9 5477.0 5477.8 5479.3 4834.4 4893.8 4922.6 4958.0 4998.1 5998.6 6001.9 6006.6 6008.7 6009.0 5687.4 5819.9 5882.6 5884.8 5891.0 6002.3 6024.1 6073.5 6150.2 6154.4 5748.5 5845.1 5853.2 5854.8 5860.9 5648.8 5814.9 5944.3 5950.9 5958.4 5681.7 5797.9 5799.3 5802.5 5831.2 5751.5 5761.8 5763.3 5774.1 5776.1 5487.5 5528.9 5578.1 5674.5 5681.3 5766.6 5766.9 5815.4 5821.6 5831.8 5593.6 5608.5 5645.5 5651.8 5658.3 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - PROCESS | 32299 | [#1] ext.html Cycles:180 Average:67700.62 Median:36943.04 stddev:152355.50 (412.4%) stddev-sans-first:152699.63 17:31:01 INFO - PROCESS | 32299 | Values: 610.3 639.2 648.7 650.3 660.7 33124.7 35728.0 35738.3 35767.6 44620.0 42546.4 46502.0 46889.0 46889.5 46897.0 8952.8 9099.5 9126.0 9131.5 9150.9 8200.9 8967.9 9102.6 10566.7 10774.3 10817.8 10859.3 10873.3 10878.5 10890.2 10826.4 10881.3 10884.1 10893.1 10907.7 10662.9 10707.6 10711.9 10723.1 10734.0 42563.4 42701.0 42714.6 42763.6 42892.0 3529.3 3614.3 3659.7 3801.4 4402.7 32656.5 33244.8 33279.8 33282.3 33662.3 3903.2 3930.4 3970.3 4041.4 4054.7 349262.0 350752.0 351898.0 352533.0 357402.0 38060.8 61946.7 62260.4 62303.7 62310.0 37055.8 37063.0 37253.6 37333.8 37336.0 15366.4 15501.1 15514.8 15520.6 15523.0 11343.8 12596.1 12600.6 12644.5 12644.6 8501.4 8744.9 8791.2 8846.9 8915.1 3294.2 3422.5 3423.7 3442.7 3444.8 1062.8 1086.8 1118.8 1197.1 1198.5 32772.0 33181.3 33192.5 33361.8 33727.8 1156.2 1163.1 1169.4 1172.9 1234.9 17754.9 17797.8 17799.2 17914.5 17932.5 779352.0 779750.0 787397.0 790343.0 800449.0 60933.7 61946.7 62166.0 62200.4 62252.4 1320.9 1448.9 1472.1 1482.3 1509.3 32326.5 34348.0 34623.8 34686.9 34909.0 51819.5 52221.0 52445.5 52469.0 52556.2 465740.0 466085.0 468954.0 469436.0 471132.0 26369.3 28395.0 29469.9 29552.6 30865.4 48645.8 49677.0 49984.5 50270.7 50780.5 40977.2 41163.4 41705.8 41867.2 42800.0 41561.6 41593.8 41816.6 42034.8 42225.2 42863.8 43013.2 43290.6 43951.0 43962.1 35837.5 36830.3 38271.0 38854.6 39298.4 28983.6 29018.0 29296.0 29588.3 29769.7 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - PROCESS | 32299 | [#2] jquery.html Cycles:180 Average:28472.66 Median:23035.88 stddev:78993.05 (342.9%) stddev-sans-first:79186.54 17:31:01 INFO - PROCESS | 32299 | Values: 408.1 410.6 411.1 415.1 423.3 14255.4 17937.7 19619.1 19679.2 19709.1 14796.6 19011.7 19103.7 20067.7 20871.3 5665.3 5794.8 5829.8 5833.0 5868.1 5704.1 5786.4 5796.9 5797.3 5799.0 4117.3 5948.4 6285.4 6292.4 6398.6 6285.1 6364.8 6393.8 6399.3 6419.3 5517.0 5653.4 5668.2 5692.3 5693.0 22983.0 23088.8 23277.2 23787.8 23993.9 2429.6 2443.4 2449.0 2657.7 2896.1 14014.6 14571.3 14669.7 14729.5 15064.8 1960.2 2036.5 2060.2 2103.1 2143.8 77825.0 78135.2 78217.6 78542.6 78669.6 10335.9 10351.8 10735.1 10789.7 10843.5 14922.4 15004.0 15022.2 15046.8 15086.5 7988.0 8286.6 8289.0 8395.9 8428.5 7979.7 8063.9 8098.0 8171.8 8185.3 5969.6 6249.0 6742.4 6769.8 6874.9 1941.9 1956.1 1959.5 1960.3 1982.1 956.8 1074.2 1126.7 1141.5 1175.3 18694.9 19520.7 19993.2 20360.7 20575.2 1057.5 1093.9 1098.8 1110.2 1164.3 11151.4 11552.6 11598.6 11668.5 11703.3 471364.0 475287.0 479852.0 487137.0 492371.0 77753.0 77985.0 79224.6 80521.6 81447.6 1020.3 1037.1 1039.8 1055.9 1065.8 17440.1 17594.9 17615.5 17829.5 18199.5 38158.0 38219.0 39502.0 39774.4 40821.0 51187.2 51889.5 53078.7 59397.0 60143.0 8111.1 8311.1 8336.1 8479.2 8680.7 10046.8 13521.1 13549.8 13640.2 13983.2 11448.1 11473.2 11792.1 11956.5 12190.2 11576.5 11620.8 11719.6 11749.2 12003.8 12073.0 12175.0 12319.3 12372.9 12517.2 8765.6 8806.3 8980.0 8985.7 12555.2 12183.8 12548.2 12613.4 12658.6 13202.3 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - PROCESS | 32299 | [#3] mootools.html Cycles:180 Average:6141.71 Median:2465.49 stddev:3621.16 (146.9%) stddev-sans-first:3613.85 17:31:01 INFO - PROCESS | 32299 | Values: 1408.2 1538.8 1552.7 1726.4 1882.4 8694.5 9092.1 9149.5 9400.2 9453.8 9041.3 9291.8 9293.9 9307.4 9314.7 2070.7 2285.3 2360.6 2406.1 2442.1 2409.1 2421.5 2422.6 2424.0 2425.0 2332.6 2345.8 2359.8 2362.8 2364.2 2053.7 2253.9 2268.3 2345.1 2353.9 2372.0 2379.1 2400.8 2403.1 2403.2 9503.8 9601.7 9603.6 9613.0 9619.1 5362.2 5499.5 5503.7 5505.8 5513.4 3333.0 3377.9 3450.7 3455.0 3464.8 1127.7 1161.4 1167.8 1180.7 1232.1 13548.5 13567.7 13610.1 13726.0 13733.2 4513.1 4699.0 4730.0 4811.4 4823.9 10445.5 10463.4 10477.1 10485.7 10495.0 5396.7 5400.0 5406.2 5408.2 5409.2 4344.1 4830.4 4958.1 4961.1 5040.9 3725.8 3844.9 3853.3 3859.1 3941.0 1122.0 1129.0 1141.0 1145.8 1152.4 866.0 970.2 1035.9 1055.2 1057.2 6261.4 6373.0 6541.1 6569.8 6635.6 439.2 440.5 444.5 449.5 460.8 4248.3 4285.6 4415.6 4481.4 4504.8 11378.3 11688.7 11781.1 11795.1 11811.3 11247.4 11626.7 11805.9 11824.2 11835.3 8695.1 8709.7 8747.0 8810.5 8998.5 6312.7 6369.9 6371.9 6447.3 6464.3 10460.4 10803.1 10840.6 10841.6 10963.6 10930.6 11174.2 11219.7 11296.0 11315.3 8194.8 8313.1 8422.3 8472.9 8477.0 9213.8 9233.2 9285.5 9303.3 9307.3 8234.1 8399.0 8411.5 8421.5 8590.0 8056.8 8077.4 8188.6 8211.0 8269.0 7360.4 7433.9 7438.3 7450.3 7454.1 5416.1 5481.8 5537.5 5628.8 5646.8 5501.2 5543.3 5562.6 5755.4 5825.4 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - PROCESS | 32299 | [#4] prototype.html Cycles:180 Average:4613.55 Median:5155.80 stddev:1335.58 (25.9%) stddev-sans-first:1300.10 17:31:01 INFO - PROCESS | 32299 | Values: 333.0 334.7 336.8 338.6 340.5 5419.0 5423.7 5430.8 5467.4 5491.8 5273.8 5320.5 5413.3 5429.5 5441.0 3954.8 4003.0 4157.5 4165.2 4210.6 4166.4 4167.8 4172.9 4184.7 4187.5 3965.9 4148.7 4161.6 4176.2 4183.1 4030.5 4140.7 4157.5 4161.3 4173.0 3649.1 3655.2 3677.4 3708.1 3713.8 5131.7 5162.3 5162.6 5177.1 5212.6 4650.9 4839.6 4851.4 4871.2 4886.7 5588.9 5649.5 5667.9 5711.8 5721.0 4153.3 4178.9 4194.8 4197.9 4199.5 5592.6 5919.5 5921.2 5928.8 5933.5 4093.0 4122.2 4130.0 4136.5 4141.2 4159.2 4159.8 4180.2 4196.3 4208.8 4657.8 4799.2 4799.7 4801.4 4815.4 5559.7 5597.6 5683.5 5705.2 5739.3 1468.0 1487.1 1490.7 1501.7 1501.7 931.9 960.0 964.7 974.5 978.1 4734.5 4852.7 4859.0 4879.6 4907.7 5102.0 5134.1 5149.3 5187.0 5200.7 4848.2 4899.5 4913.2 4926.5 4947.8 2686.0 2745.0 2749.2 2754.5 2780.8 5271.3 5291.4 5307.3 5316.2 5317.4 5216.4 5222.3 5231.3 5232.0 5235.9 4896.6 5304.0 5329.7 5370.5 5385.5 5108.6 5129.4 5171.4 5210.7 5268.7 5069.8 5090.3 5107.4 5147.0 5340.3 5967.4 5991.4 6036.0 6041.1 6090.9 4089.7 4124.3 4130.5 4145.9 4159.1 5510.0 5655.4 5803.9 5872.0 5879.8 5620.4 5691.1 5693.3 5700.6 5710.1 5688.0 5700.7 5709.4 5718.9 5721.3 5462.2 5548.2 5558.6 5584.4 5617.6 5631.9 5650.5 5661.3 5673.5 5714.4 5388.7 5558.4 5585.4 5599.9 5607.2 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - PROCESS | 32299 | [#5] yui.html Cycles:180 Average:16100.94 Median:4664.66 stddev:19898.66 (426.6%) stddev-sans-first:19920.90 17:31:01 INFO - PROCESS | 32299 | Values: 707.3 726.0 746.8 756.1 766.4 13445.2 13553.1 13704.5 14538.9 15200.5 14314.1 14470.0 14507.8 14532.3 14535.7 704.9 830.5 852.0 860.7 861.4 853.1 860.4 862.8 862.9 863.1 888.7 895.8 896.8 897.3 897.7 735.5 876.2 889.7 890.2 898.3 659.2 660.1 660.3 660.8 660.9 13129.9 13148.8 13155.4 13165.1 13176.2 13053.9 13282.3 13417.2 13493.3 13639.4 12558.9 12821.4 12827.1 12961.6 13117.7 4488.6 4506.4 4517.1 4521.5 4633.0 59480.4 59597.0 59636.4 60137.7 60462.2 10077.8 10140.1 10229.6 10409.0 10633.4 17166.7 17168.4 17209.8 17242.2 17252.2 7940.4 8019.4 8077.6 8387.4 8388.7 4519.7 4609.8 4696.3 4746.2 4828.5 3328.6 3422.7 3427.9 3433.1 3433.9 578.3 680.5 690.1 709.3 710.6 662.8 716.3 739.2 757.6 781.4 9932.7 10051.7 10310.6 10352.1 10455.3 647.9 676.4 697.0 719.9 729.1 4712.2 4913.3 4940.4 4955.9 5011.3 73013.0 73528.3 73988.6 74720.6 74872.3 64214.4 64743.4 64749.0 65097.3 67482.3 55824.4 56036.7 56553.7 56781.4 57075.0 8939.2 9002.9 9031.2 9069.5 9400.9 38749.2 39376.8 39522.4 39809.8 40589.8 49051.3 52852.7 52888.7 52947.7 53170.7 11735.8 11898.2 11975.1 12015.3 12302.0 13070.3 13417.7 13568.7 13834.0 14303.9 12401.6 12621.4 12814.4 12863.0 13112.7 12039.4 12594.3 12742.7 12829.1 12905.8 12570.6 12582.0 12655.2 12704.5 12726.5 10215.9 10443.2 10629.8 10724.2 10736.3 10445.6 10550.3 10599.7 10807.7 10815.1 17:31:01 INFO - PROCESS | 32299 | -------- Summary: end -------- 17:31:01 INFO - PROCESS | 32299 | 17:31:01 INFO - TEST-INFO | 32299: exit 0 17:31:01 INFO - TEST-OK | dromaeo_css | took 1115275ms 17:31:01 INFO - TEST-START | kraken 17:31:01 INFO - operating with platform_type : linux_ 17:31:01 INFO - Initialising browser for kraken test... 17:31:01 INFO - TEST-INFO | started process 32484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO650OD/profile http://localhost:33213/getInfo.html) 17:31:05 INFO - PROCESS | 32484 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 17:31:05 INFO - PROCESS | 32484 | __metrics Screen width/height:1600/1200 17:31:05 INFO - PROCESS | 32484 | colorDepth:24 17:31:05 INFO - PROCESS | 32484 | Browser inner width/height: 1024/697 17:31:05 INFO - PROCESS | 32484 | __metrics 17:31:06 ERROR - PROCESS | 32484 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:31:07 INFO - TEST-INFO | 32484: exit 0 17:31:07 INFO - Browser initialized. 17:31:07 INFO - Running cycle 1/1 for kraken test... 17:31:07 INFO - TEST-INFO | started process 32565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO650OD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:19 INFO - PROCESS | 32565 | RSS: Main: 152625152 17:31:19 INFO - PROCESS | 32565 | 17:31:22 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33213/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:22 INFO - PROCESS | 32565 | RSS: Main: 208859136 17:31:22 INFO - PROCESS | 32565 | 17:31:25 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33213/tests/kraken/driver.html?testName=audio-dft) 17:31:26 INFO - PROCESS | 32565 | RSS: Main: 197791744 17:31:26 INFO - PROCESS | 32565 | 17:31:29 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33213/tests/kraken/driver.html?testName=audio-fft) 17:31:30 INFO - PROCESS | 32565 | RSS: Main: 265383936 17:31:30 INFO - PROCESS | 32565 | 17:31:32 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33213/tests/kraken/driver.html?testName=audio-oscillator) 17:31:32 INFO - PROCESS | 32565 | RSS: Main: 174616576 17:31:32 INFO - PROCESS | 32565 | 17:31:35 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33213/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:31:35 INFO - PROCESS | 32565 | RSS: Main: 179253248 17:31:35 INFO - PROCESS | 32565 | 17:31:38 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33213/tests/kraken/driver.html?testName=imaging-darkroom) 17:31:39 INFO - PROCESS | 32565 | RSS: Main: 214761472 17:31:39 INFO - PROCESS | 32565 | 17:31:42 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33213/tests/kraken/driver.html?testName=imaging-desaturate) 17:31:43 INFO - PROCESS | 32565 | RSS: Main: 212848640 17:31:43 INFO - PROCESS | 32565 | 17:31:46 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33213/tests/kraken/driver.html?testName=json-parse-financial) 17:31:47 INFO - PROCESS | 32565 | RSS: Main: 214052864 17:31:47 INFO - PROCESS | 32565 | 17:31:48 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33213/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:31:49 INFO - PROCESS | 32565 | RSS: Main: 204738560 17:31:49 INFO - PROCESS | 32565 | 17:31:51 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:31:51 INFO - PROCESS | 32565 | RSS: Main: 208060416 17:31:51 INFO - PROCESS | 32565 | 17:31:53 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:54 INFO - PROCESS | 32565 | RSS: Main: 217219072 17:31:54 INFO - PROCESS | 32565 | 17:31:57 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:31:57 INFO - PROCESS | 32565 | RSS: Main: 223883264 17:31:57 INFO - PROCESS | 32565 | 17:32:00 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:01 INFO - PROCESS | 32565 | RSS: Main: 218689536 17:32:01 INFO - PROCESS | 32565 | 17:32:02 INFO - PROCESS | 32565 | Cycle 1(1): loaded http://localhost:33213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33213/tests/kraken/driver.html?testName=ai-astar) 17:32:03 INFO - PROCESS | 32565 | RSS: Main: 264396800 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | __start_tp_report 17:32:03 INFO - PROCESS | 32565 | _x_x_mozilla_page_load 17:32:03 INFO - PROCESS | 32565 | _x_x_mozilla_page_load_details 17:32:03 INFO - PROCESS | 32565 | |i|pagename|runs| 17:32:03 INFO - PROCESS | 32565 | |0;ai-astar;109;106;111;109;111;111;110;111;109;111 17:32:03 INFO - PROCESS | 32565 | |1;audio-beat-detection;155;123;154;208;126;150;159;125;192;130 17:32:03 INFO - PROCESS | 32565 | |2;audio-dft;162;161;162;163;161;160;162;162;161;160 17:32:03 INFO - PROCESS | 32565 | |3;audio-fft;75;84;76;150;75;75;75;74;136;75 17:32:03 INFO - PROCESS | 32565 | |4;audio-oscillator;92;91;151;91;91;91;134;92;91;113 17:32:03 INFO - PROCESS | 32565 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;119;116;116 17:32:03 INFO - PROCESS | 32565 | |6;imaging-darkroom;144;145;145;145;145;145;145;146;145;145 17:32:03 INFO - PROCESS | 32565 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 17:32:03 INFO - PROCESS | 32565 | |8;json-parse-financial;53;54;54;54;65;62;54;107;52;53 17:32:03 INFO - PROCESS | 32565 | |9;json-stringify-tinderbox;59;61;60;60;61;59;61;59;60;60 17:32:03 INFO - PROCESS | 32565 | |10;stanford-crypto-aes;78;78;78;78;77;80;79;80;78;80 17:32:03 INFO - PROCESS | 32565 | |11;stanford-crypto-ccm;125;130;121;126;119;126;116;125;200;122 17:32:03 INFO - PROCESS | 32565 | |12;stanford-crypto-pbkdf2;160;161;156;158;156;161;166;156;157;162 17:32:03 INFO - PROCESS | 32565 | |13;stanford-crypto-sha256-iterative;61;65;63;62;62;62;63;61;61;62 17:32:03 INFO - PROCESS | 32565 | __end_tp_report 17:32:03 INFO - PROCESS | 32565 | __start_cc_report 17:32:03 INFO - PROCESS | 32565 | _x_x_mozilla_cycle_collect,1853 17:32:03 INFO - PROCESS | 32565 | __end_cc_report 17:32:03 INFO - PROCESS | 32565 | __startTimestamp1463272323248__endTimestamp 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | ------- Summary: start ------- 17:32:03 INFO - PROCESS | 32565 | Number of tests: 14 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:1.62 (1.5%) stddev-sans-first:1.69 17:32:03 INFO - PROCESS | 32565 | Values: 109.0 106.0 111.0 109.0 111.0 111.0 110.0 111.0 109.0 111.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:154.50 stddev:28.93 (18.7%) stddev-sans-first:30.67 17:32:03 INFO - PROCESS | 32565 | Values: 155.0 123.0 154.0 208.0 126.0 150.0 159.0 125.0 192.0 130.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 17:32:03 INFO - PROCESS | 32565 | Values: 162.0 161.0 162.0 163.0 161.0 160.0 162.0 162.0 161.0 160.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#3] audio-fft Cycles:10 Average:89.50 Median:75.00 stddev:28.53 (38.0%) stddev-sans-first:29.78 17:32:03 INFO - PROCESS | 32565 | Values: 75.0 84.0 76.0 150.0 75.0 75.0 75.0 74.0 136.0 75.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:91.00 stddev:21.91 (24.1%) stddev-sans-first:22.83 17:32:03 INFO - PROCESS | 32565 | Values: 92.0 91.0 151.0 91.0 91.0 91.0 134.0 92.0 91.0 113.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 17:32:03 INFO - PROCESS | 32565 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 119.0 116.0 116.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 17:32:03 INFO - PROCESS | 32565 | Values: 144.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:32:03 INFO - PROCESS | 32565 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:54.00 stddev:16.79 (31.1%) stddev-sans-first:17.57 17:32:03 INFO - PROCESS | 32565 | Values: 53.0 54.0 54.0 54.0 65.0 62.0 54.0 107.0 52.0 53.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 17:32:03 INFO - PROCESS | 32565 | Values: 59.0 61.0 60.0 60.0 61.0 59.0 61.0 59.0 60.0 60.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.50 stddev:1.07 (1.4%) stddev-sans-first:1.12 17:32:03 INFO - PROCESS | 32565 | Values: 78.0 78.0 78.0 78.0 77.0 80.0 79.0 80.0 78.0 80.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:125.50 stddev:24.57 (19.6%) stddev-sans-first:25.97 17:32:03 INFO - PROCESS | 32565 | Values: 125.0 130.0 121.0 126.0 119.0 126.0 116.0 125.0 200.0 122.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.50 stddev:3.30 (2.1%) stddev-sans-first:3.49 17:32:03 INFO - PROCESS | 32565 | Values: 160.0 161.0 156.0 158.0 156.0 161.0 166.0 156.0 157.0 162.0 17:32:03 INFO - PROCESS | 32565 | 17:32:03 INFO - PROCESS | 32565 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.22 17:32:03 INFO - PROCESS | 32565 | Values: 61.0 65.0 63.0 62.0 62.0 62.0 63.0 61.0 61.0 62.0 17:32:03 INFO - PROCESS | 32565 | -------- Summary: end -------- 17:32:03 INFO - PROCESS | 32565 | 17:32:04 INFO - TEST-INFO | 32565: exit 0 17:32:04 INFO - TEST-OK | kraken | took 62602ms 17:32:04 INFO - SUITE-END | took 1177s 17:32:04 INFO - Completed test suite (00:19:38) 17:32:04 INFO - javascript benchmark 17:32:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.00428365065, 3170.968290317096, 3203.0711093782797, 3208.342289830585, 3232.9030129096136, 5256.842294731155, 5302.390225124112, 5354.089804733195, 5419.59353048521, 5458.508734213915, 5371.919421208675, 5376.1129413646795, 5381.5425688816495, 5393.568514518839, 5435.701036443004, 4806.110869489138, 4822.590079843218, 4971.328870602477, 4988.401391832985, 5084.339035925324, 4980.228064649967, 4981.676191047589, 5020.799168033274, 5046.21783623539, 5052.141136006888, 4784.258439941815, 4815.470298267188, 4888.169011268093, 4925.458199598042, 4928.531789479994, 4909.705417674915, 4922.296605811929, 4931.408231012266, 4955.851324460272, 4970.975145124287, 4738.857834264943, 4781.306710526954, 4910.803567857281, 4915.45929947709, 4985.102681517325, 5284.735763211863, 5375.946240537583, 5403.405625381205, 5421.430749771296, 5422.810201642924, 5894.705264736789, 5894.970525147347, 5897.3218079920925, 5898.292204935392, 5900.704964751788, 5640.689762063085, 5716.371199168088, 5823.417658234185, 5895.616784908967, 5952.404759524056, 5452.700101494416, 5464.726763661801, 5479.808206712746, 5501.614886957875, 5503.7798488060025, 5993.670348130895, 6036.215292012098, 6049.395060494004, 6050.969745151246, 6061.6666083365835, 5573.693446860461, 5716.256886604715, 5764.07774756037, 5768.538516918637, 5790.131480277908, 5920.585559010914, 5927.051671732588, 5930.555208359304, 5959.970200149059, 5966.19456373384, 5837.503812176013, 5880.382559831241, 5897.115432685132, 5899.882002360015, 5907.556933230025, 5690.061139911868, 5769.769209231584, 5848.736806843703, 5853.180554722342, 5917.852053698606, 4429.224885645, 4436.245838207513, 4437.134758722083, 4464.933026004613, 4465.12929978651, 3966.2067586482817, 3992.2614316350987, 3997.8800635980965, 4021.7989100544855, 4021.8592349267633, 5316.574674026146, 5321.6540924839765, 5376.811811586654, 5487.149491828773, 5575.526080283222, 5808.854778630568, 5809.419058094157, 5843.0, 5852.268466441695, 5863.970680146572, 5467.343918729778, 5475.945240547623, 5477.0, 5477.767502312027, 5479.315085614298, 4834.371531700926, 4893.779779909913, 4922.630802689812, 4958.033183529249, 4998.125328067574, 5998.580099393175, 6001.879962400728, 6006.639601623917, 6008.669523176267, 6009.0, 5687.374388817309, 5819.883602328015, 5882.617629854046, 5884.764609415746, 5891.0, 6002.3097343804275, 6024.0662697282, 6073.453389194994, 6150.231221097363, 6154.446099851035, 5748.45389687979, 5845.1232315151365, 5853.239078919713, 5854.824355269348, 5860.912086318794, 5648.774049037993, 5814.854628634318, 5944.286685597756, 5950.928832810136, 5958.433948774859, 5681.744321505459, 5797.91303130445, 5799.2750906136735, 5802.506786923159, 5831.183634291117, 5751.539876809761, 5761.769529218785, 5763.250777398911, 5774.133879918046, 5776.104703770922, 5487.506124448819, 5528.91706624409, 5578.0953332668105, 5674.546036317167, 5681.289838770153, 5766.625169363978, 5766.913496297475, 5815.3603103657715, 5821.621594596338, 5831.7667293307795, 5593.636413633101, 5608.523275521627, 5645.548356131581, 5651.773929042793, 5658.349289831722], "value": 5375.990337169585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.3347351386988, 639.1786554277754, 648.6659370424229, 650.3431534150508, 660.7026837922934, 33124.66875331249, 35728.0, 35738.2852342953, 35767.64232357676, 44620.0, 42546.36180457295, 46502.0, 46889.0, 46889.53110468894, 46897.0, 8952.776180595489, 9099.49858273384, 9126.0, 9131.497767622777, 9150.86273705895, 8200.876986845202, 8967.910320896804, 9102.63589456421, 10566.682999510027, 10774.299670521392, 10817.783644327108, 10859.348439093641, 10873.347599144077, 10878.510467029002, 10890.237683362167, 10826.350418974887, 10881.292715973515, 10884.07485363745, 10893.07408870247, 10907.727306817314, 10662.893371066268, 10707.571697132184, 10711.892881071246, 10723.14214862809, 10734.0, 42563.36154957678, 42701.0, 42714.57285427137, 42763.57236427658, 42892.0, 3529.2588556403184, 3614.2771445710964, 3659.743817932746, 3801.4297855321647, 4402.691811573191, 32656.510152347735, 33244.833775830964, 33279.833600832084, 33282.33435331304, 33662.32675346504, 3903.180332130256, 3930.390789427643, 3970.305196590585, 4041.353383458662, 4054.6535798493655, 349262.0, 350752.0, 351898.0, 352533.0, 357402.0, 38060.809695951895, 61946.69026654838, 62260.377396225456, 62303.6884815573, 62310.0, 37055.81472092676, 37063.0, 37253.627463725556, 37333.81333093317, 37336.0, 15366.385344586091, 15501.069935803887, 15514.767278490832, 15520.611984700472, 15523.0, 11343.773124537463, 12596.055295852848, 12600.621981340575, 12644.494220231089, 12644.557440489723, 8501.404901656948, 8744.91255087441, 8791.164839340252, 8846.867296990551, 8915.108489151162, 3294.209389746444, 3422.528312825509, 3423.7432192585156, 3442.6557344265375, 3444.810535420576, 1062.8458873463305, 1086.766345235778, 1118.81539545974, 1197.1201167142144, 1198.532572296805, 32772.0, 33181.3363732724, 33192.50211246833, 33361.810124748255, 33727.83136084304, 1156.2022204678744, 1163.1334655681571, 1169.3919162035693, 1172.8533933258343, 1234.9135560510679, 17754.91122544379, 17797.822021779877, 17799.19903604341, 17914.46256612304, 17932.462026139237, 779352.0, 779750.0, 787397.0, 790343.0, 800449.0, 60933.69533152306, 61946.69026654928, 62166.0, 62200.37799622036, 62252.37747622466, 1320.933953302331, 1448.920309382994, 1472.146155229964, 1482.3107255126201, 1509.3358922074253, 32326.515102273013, 34348.0, 34623.82688086644, 34686.94078717245, 34909.0, 51819.481805181465, 52221.0, 52445.47554524406, 52469.0, 52556.211656825944, 465740.0, 466085.0, 468954.0, 469436.0, 471132.0, 26369.340766480993, 28395.0, 29469.852650736608, 29552.55671164891, 30865.382692346477, 48645.756771215914, 49677.0, 49984.500154997986, 50270.748646256536, 50780.492195077575, 40977.1804563913, 41163.38254926119, 41705.79147104245, 41867.162656746084, 42800.0, 41561.58438415577, 41593.79203103965, 41816.581834182485, 42034.7898260519, 42225.155496890504, 42863.785681072644, 43013.20414173069, 43290.56709432865, 43951.0, 43962.12075758531, 35837.462438062925, 36830.263394732494, 38270.98128943446, 38854.611453885096, 39298.41052384274, 28983.5652465209, 29018.0, 29296.0, 29588.260293492836, 29769.702302976693], "value": 19950.38822455549, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.11642793352394, 410.57710558125126, 411.12840777551594, 415.0764548878743, 423.2698594923757, 14255.3585088671, 17937.730934036, 19619.11713972873, 19679.21283148676, 19709.113089910952, 14796.6300842479, 19011.714824277646, 19103.71344429831, 20067.698984515206, 20871.269505567307, 5665.3201615806165, 5794.797182098628, 5829.795957141501, 5832.979228634993, 5868.090445980858, 5704.1443783432405, 5786.363500014995, 5796.913046304308, 5797.304323481167, 5799.043157878966, 4117.3206420940505, 5948.434898684618, 6285.371462853724, 6292.433680968712, 6398.648074355909, 6285.088662143963, 6364.809055728312, 6393.776217832354, 6399.328070552595, 6419.261784894704, 5517.0, 5653.406392328829, 5668.206451096849, 5692.260006199209, 5693.03218452864, 22983.0, 23088.769112308997, 23277.21739477625, 23787.76212237873, 23993.88003059991, 2429.5748244057218, 2443.3769388805918, 2449.020391843259, 2657.6545049143488, 2896.131160651796, 14014.649633759136, 14571.344289506998, 14669.70660586793, 14729.484468043567, 15064.774028389584, 1960.1571324330532, 2036.521417466894, 2060.1656329186703, 2103.0536258683655, 2143.7641859395453, 77825.0, 78135.21864781393, 78217.60891195564, 78542.60728696377, 78669.60665196694, 10335.896641033643, 10351.792964140826, 10735.087517560938, 10789.676309710721, 10843.45782710877, 14922.40310387594, 15004.0, 15022.24888755558, 15046.774298385533, 15086.54740357791, 7988.0, 8286.627101780434, 8289.0, 8395.916040839636, 8428.536430496259, 7979.72070977513, 8063.919360806317, 8097.959510202529, 8171.79570510742, 8185.3042491387705, 5969.552283578749, 6249.0, 6742.393184613408, 6769.763058292936, 6874.896876546856, 1941.8737782044122, 1956.129522362535, 1959.5493036601376, 1960.2746983616153, 1982.1377700699952, 956.8134213828237, 1074.2158224496006, 1126.6620013995769, 1141.4749215360862, 1175.3183153770792, 18694.906525467286, 19520.70718939217, 19993.200271989248, 20360.69458958117, 20575.176992920115, 1057.513543769859, 1093.9398333091597, 1098.807708650983, 1110.1840147491587, 1164.2665120973902, 11151.442427878574, 11552.59565915189, 11598.594049208237, 11668.474918628683, 11703.2978021319, 471364.0, 475287.0, 479852.0, 487137.0, 492371.0, 77753.0, 77985.0, 79224.60387698024, 80521.59739201267, 81447.59276203699, 1020.3061917895753, 1037.071820720451, 1039.8232300508932, 1055.894410558938, 1065.8241390170535, 17440.127993600523, 17594.91202543979, 17615.471535853943, 17829.46511604654, 18199.545011374823, 38158.0, 38219.0, 39502.0, 39774.40338394869, 40821.0, 51187.232191516414, 51889.48110518847, 53078.73460632827, 59397.0, 60143.0, 8111.148329425326, 8311.127331630092, 8336.083030866721, 8479.2368686816, 8680.696175633822, 10046.8492972604, 13521.121127126706, 13549.79675304891, 13640.181589104686, 13983.230922298964, 11448.084153267551, 11473.196876218584, 11792.056635469313, 11956.46195921203, 12190.2076365036, 11576.47905844256, 11620.825687614524, 11719.589814356457, 11749.177557570887, 12003.81994270104, 12073.0, 12175.0, 12319.322437266037, 12372.938135309267, 12517.248965062125, 8765.561721913751, 8806.339524535813, 8980.012198658012, 8985.730428087169, 12555.246685198917, 12183.817242741543, 12548.24710517372, 12613.432395542406, 12658.556950506689, 13202.33988300562], "value": 9540.351308585728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.1832537128466, 1538.7691846223065, 1552.6894621075785, 1726.4043904852822, 1882.3694062489058, 8694.521801300934, 9092.090790920913, 9149.451032938021, 9400.153986141246, 9453.81092378152, 9041.321900857429, 9291.814163716721, 9293.860592091123, 9307.441553506795, 9314.673986410477, 2070.6997485364614, 2285.2572913802996, 2360.6223004319313, 2406.1217655555683, 2442.1452491627965, 2409.144753612469, 2421.539907417585, 2422.648715936188, 2424.0303878448585, 2424.9515009699794, 2332.626779715246, 2345.7771511706446, 2359.7876191142796, 2362.751911049341, 2364.2316247219637, 2053.702213179088, 2253.86476811391, 2268.3308424014954, 2345.1205797825814, 2353.9058437662475, 2371.9644205336936, 2379.0721618568773, 2400.7839294463583, 2403.050794936008, 2403.242978461779, 9503.762405939839, 9601.711948641552, 9603.615855365777, 9612.951935240279, 9619.13427791495, 5362.2224777407055, 5499.450054994469, 5503.724813759296, 5505.807296744595, 5513.448655134494, 3332.950005749916, 3377.932441351159, 3450.6721861423125, 3454.9654503454894, 3464.826758662057, 1127.695522209007, 1161.361251311775, 1167.7839599674003, 1180.6753142885775, 1232.0697873105837, 13548.45806167752, 13567.660808479768, 13610.115342502606, 13726.0, 13733.176009439365, 4513.074819661962, 4698.976505117521, 4730.0, 4811.422629284508, 4823.927641085386, 10445.529951152217, 10463.424511651932, 10477.1094456972, 10485.68542943713, 10495.0, 5396.676199428047, 5400.027994960867, 5406.189071639285, 5408.242846001563, 5409.161579955114, 4344.066025804467, 4830.4444988826035, 4958.057968985953, 4961.08219979305, 5040.873978150576, 3725.776453412804, 3844.9231015379537, 3853.325668008087, 3859.054531639766, 3940.9605903941165, 1122.0462606784167, 1129.0346753525782, 1140.9714757131137, 1145.8166693329026, 1152.3719572832827, 866.0, 970.2480577552453, 1035.8860525342207, 1055.2008824953436, 1057.1595581512715, 6261.436470717657, 6373.012183111625, 6541.084248205255, 6569.770058047945, 6635.568688035262, 439.1590104949051, 440.5154330236714, 444.5199184880386, 449.5392222971415, 460.794946248916, 4248.320268756984, 4285.61429471349, 4415.624671902924, 4481.439820022497, 4504.752238626841, 11378.31730096197, 11688.668729412077, 11781.116416268815, 11795.115366347387, 11811.291322520505, 11247.437628118725, 11626.651200463999, 11805.88194118065, 11824.172307938534, 11835.28988260707, 8695.130486951255, 8709.73870783865, 8746.956265218632, 8810.471371717718, 8998.50508222041, 6312.652804095819, 6369.87260254783, 6371.872562548816, 6447.258565265054, 6464.288928217987, 10460.424676642857, 10803.135749139892, 10840.620578279722, 10841.620543280947, 10963.561457541928, 10930.617428390286, 11174.161937854857, 11219.66341009771, 11296.0, 11315.321080735182, 8194.754157375288, 8313.085560588452, 8422.326213902996, 8472.91527084746, 8476.957615211884, 9213.76965575866, 9233.215176709786, 9285.535723213678, 9303.302252330966, 9307.301952353737, 8234.135415781497, 8398.986499861552, 8411.53736544496, 8421.452605580618, 8589.957050214709, 8056.798580035546, 8077.434579579373, 8188.5905704715715, 8210.958945205235, 8269.04905935801, 7360.411167106511, 7433.888491672521, 7438.256174382518, 7450.254974502506, 7454.142773581108, 5416.133418652997, 5481.780728770805, 5537.473939975695, 5628.831135065954, 5646.774129034792, 5501.202325662676, 5543.307086614173, 5562.5549956002615, 5755.395683453177, 5825.417458254141], "value": 4750.021869407389, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9533865258864, 334.6736931491796, 336.8164350429016, 338.62412721878724, 340.4518724852986, 5419.0, 5423.725424525233, 5430.809921652738, 5467.371252305986, 5491.807786727465, 5273.815416460425, 5320.467953204688, 5413.296271484702, 5429.484199001088, 5440.972795136028, 3954.8022598870084, 4002.959970400288, 4157.459530261061, 4165.208610364036, 4210.57894210578, 4166.437530933331, 4167.791610419482, 4172.916541669165, 4184.660908509279, 4187.539370669224, 3965.940510892339, 4148.668106551469, 4161.564260330181, 4176.248275310443, 4183.100633363826, 4030.476038115041, 4140.668746500272, 4157.459530261077, 4161.271777438967, 4172.97913510432, 3649.1424515238896, 3655.1593133579427, 3677.3564626190578, 3708.0915175782106, 3713.795741234231, 5131.717755523445, 5162.3030890830005, 5162.638615296931, 5177.145770947789, 5212.609054320941, 4650.930236046462, 4839.612830973514, 4851.442084160296, 4871.244957031666, 4886.706797592155, 5588.944110558883, 5649.52554179181, 5667.866426714673, 5711.7715291388295, 5720.971395143039, 4153.276390298022, 4178.895527611804, 4194.832206711728, 4197.91604167918, 4199.538050814408, 5592.5805564582815, 5919.526437884959, 5921.230240068763, 5928.79249226275, 5933.4659880610525, 4092.9795351023054, 4122.175564887035, 4129.97935010323, 4136.544980052192, 4141.233871733739, 4159.168166366739, 4159.83360665576, 4180.205760905418, 4196.265653510623, 4208.810603522848, 4657.790399432034, 4799.168490590569, 4799.688020278671, 4801.447833499123, 4815.374001379798, 5559.749811258503, 5597.648987425291, 5683.516901063374, 5705.172749951317, 5739.253896993364, 1468.0017588040234, 1487.115166475945, 1490.709311684233, 1501.6621260216582, 1501.6860247283628, 931.9394239374419, 959.9952000239954, 964.7009427077628, 974.5030034682363, 978.0708327089294, 4734.479207287196, 4852.660313778002, 4859.032092002674, 4879.609631229493, 4907.7300748458465, 5102.035716249271, 5134.099233932816, 5149.304843846033, 5186.974065129651, 5200.737679109599, 4848.200046992207, 4899.461059283476, 4913.213885778258, 4926.5073492650445, 4947.82682606107, 2686.033028109879, 2744.9588256176175, 2749.2164733050986, 2754.5179593571447, 2780.7636350909993, 5271.341082364705, 5291.417944026154, 5307.310049693515, 5316.229146773773, 5317.441668624816, 5216.400113986864, 5222.294990176278, 5231.293775340357, 5232.0, 5235.947640523622, 4896.632752543503, 5303.973480132575, 5329.733513324319, 5370.54995151307, 5385.54222891043, 5108.61685373591, 5129.384473863161, 5171.405288391883, 5210.697325668583, 5268.683878967274, 5069.808594980251, 5090.287359769562, 5107.41264754558, 5146.974265128651, 5340.252364668871, 5967.403259673998, 5991.430814072656, 6035.969820150871, 6041.124037014696, 6090.878182436238, 4089.7341672792363, 4124.319487284564, 4130.463039804806, 4145.937810932778, 4159.085001299709, 5510.0, 5655.406182350794, 5803.9419605803405, 5871.970640146772, 5879.794207202727, 5620.414609279777, 5691.117876729114, 5693.3168019837885, 5700.600957933071, 5710.057840456278, 5688.0, 5700.714964251688, 5709.429057094258, 5718.857028574319, 5721.312212897288, 5462.20797984298, 5548.195511650707, 5558.555315574664, 5584.385717570983, 5617.606767526234, 5631.8592035199445, 5650.463205995424, 5661.320641523043, 5673.489385955284, 5714.371419143974, 5388.676679399248, 5558.416366281483, 5585.441455854382, 5599.8880022400135, 5607.243022192115], "value": 4193.948859012974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.3351050012991, 725.9637018149092, 746.8319628083685, 756.1153450462958, 766.4213518793308, 13445.193288402703, 13553.119047261922, 13704.52034178804, 14538.927305363459, 15200.467983620549, 14314.141151530916, 14470.0, 14507.782383264259, 14532.273386330695, 14535.709285814277, 704.8766465868479, 830.5432012393189, 852.0286872964825, 860.6944534690189, 861.418542483824, 853.0999795216045, 860.3805260212669, 862.8360611483829, 862.8921384826897, 863.1497974495148, 888.6667499687617, 895.7805337692274, 896.8340856941487, 897.2687259883174, 897.6633762339122, 735.474135992765, 876.1632640827994, 889.7019498467988, 890.1543533643032, 898.2723993565234, 659.2023651381834, 660.0594153331531, 660.3000819131736, 660.8347913021745, 660.93390660934, 13129.868701313055, 13148.802767958488, 13155.408006639724, 13165.078444508888, 13176.209427434289, 13053.934730326288, 13282.269475178862, 13417.194968301934, 13493.2578708171, 13639.386227619681, 12558.937205313914, 12821.35893205336, 12827.069843026464, 12961.611151665466, 13117.737645247042, 4488.618467430239, 4506.391637128979, 4517.096580683877, 4521.480029796583, 4633.0, 59480.405195948355, 59597.0, 59636.40363596352, 60137.6993115036, 60462.186134416035, 10077.798444031225, 10140.087392134743, 10229.641962531425, 10409.0, 10633.361998280128, 17166.742498862528, 17168.39910603148, 17209.827901721073, 17242.224099915533, 17252.223649935782, 7940.364770818321, 8019.35845132388, 8077.636506357228, 8387.370947178864, 8388.748337549883, 4519.706219095814, 4609.838655647036, 4696.319033740157, 4746.1931471649905, 4828.5412885776495, 3328.56728625282, 3422.6577342266073, 3427.880024199141, 3433.124553238958, 3433.896983090511, 578.349356973405, 680.4590350671228, 690.1338819781242, 709.3367701199395, 710.5559025608994, 662.8276648071536, 716.330231233798, 739.1721272175198, 757.5795433534331, 781.4451739265072, 9932.702018939442, 10051.748706282255, 10310.587576496857, 10352.120069794151, 10455.268131230741, 647.8542327976168, 676.3844901140037, 696.9616671083139, 719.9244079371696, 729.1250499400741, 4712.198926182557, 4913.287573301923, 4940.431850337185, 4955.851324460272, 5011.303128446395, 73013.0, 73528.26471735214, 73988.63005684938, 74720.62639686766, 74872.25127748762, 64214.35785642084, 64743.35256647468, 64749.0, 65097.34902650913, 67482.32517674859, 55824.441755581924, 56036.719816400655, 56553.71723141358, 56781.43218567844, 57075.0, 8939.195472407515, 9002.864957025518, 9031.232345250728, 9069.455832650063, 9400.905990940277, 38749.225015500095, 39376.803115984236, 39522.40716389199, 39809.80095099506, 40589.79705101455, 49051.264231037276, 52852.735736321076, 52888.735556321975, 52947.73526132345, 53170.73414632902, 11735.76528469443, 11898.22661526998, 11975.101867360157, 12015.339156346485, 12302.0, 13070.281134537692, 13417.731645367234, 13568.728625427633, 13834.0, 14303.928480357532, 12401.62795116148, 12621.432035558239, 12814.423350949042, 12863.0, 13112.737745245233, 12039.398030098286, 12594.3073130975, 12742.745145097231, 12829.10196286251, 12905.806412903627, 12570.560030398892, 12582.0, 12655.240685558896, 12704.491820327454, 12726.490940362282, 10215.897841021495, 10443.164546836082, 10629.787404252027, 10724.249302548747, 10736.30214036085, 10445.582176712845, 10550.31422957536, 10599.735006624896, 10807.729806754895, 10815.134789216687], "value": 6992.038717201357, "unit": "score"}], "name": "dromaeo_css", "value": 7227.535460441557, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 111.0, 109.0, 111.0, 111.0, 110.0, 111.0, 109.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 154.0, 208.0, 126.0, 150.0, 159.0, 125.0, 192.0, 130.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 161.0, 160.0, 162.0, 162.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 76.0, 150.0, 75.0, 75.0, 75.0, 74.0, 136.0, 75.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 151.0, 91.0, 91.0, 91.0, 134.0, 92.0, 91.0, 113.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 119.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 65.0, 62.0, 54.0, 107.0, 52.0, 53.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 60.0, 61.0, 59.0, 61.0, 59.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 77.0, 80.0, 79.0, 80.0, 78.0, 80.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 121.0, 126.0, 119.0, 126.0, 116.0, 125.0, 200.0, 122.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 156.0, 158.0, 156.0, 161.0, 166.0, 156.0, 157.0, 162.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 63.0, 62.0, 62.0, 62.0, 63.0, 61.0, 61.0, 62.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1525.2, "alertThreshold": 2.0}]} 17:32:04 INFO - Return code: 0 17:32:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:32:04 ERROR - # TBPL SUCCESS # 17:32:04 INFO - Running post-action listener: _resource_record_post_action 17:32:04 INFO - ##### 17:32:04 INFO - ##### Finished run-tests step (success) 17:32:04 INFO - ##### 17:32:04 INFO - Running post-run listener: _resource_record_post_run 17:32:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 536150016; Read time: 0; Write time: 533716 17:32:04 INFO - TinderboxPrint: CPU usage
13.2% 17:32:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:32:04 INFO - TinderboxPrint: I/O write bytes / time
536,150,016 / 533,716 17:32:04 INFO - TinderboxPrint: CPU idle
8,287.4 (86.8%) 17:32:04 INFO - TinderboxPrint: CPU user
1,211.1 (12.7%) 17:32:04 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246247424; Read time: 0; Write time: 237324 17:32:04 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289902592; Read time: 0; Write time: 296392 17:32:05 INFO - Running post-run listener: _upload_blobber_files 17:32:05 INFO - Blob upload gear active. 17:32:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:05 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 17:32:05 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'] 17:32:05 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 17:32:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:06 INFO - (blobuploader) - INFO - Done attempting. 17:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:10 INFO - (blobuploader) - INFO - Done attempting. 17:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:11 INFO - (blobuploader) - INFO - Done attempting. 17:32:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:11 INFO - Return code: 0 17:32:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69b5d92de3c2e9d82a72306db9f4b505bd5618a0516a4b3257a3232b045fca92518964975c429c8376b0014f5fdc946ddb66f5ec77bee081a9a6718b43e22eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0de8b5019839973da86e6f240c040a87b680f476f6148c0b81418e4747889d4019f93fc4d8f97ec80356d2502aafff74377fc92ca07360713c641c107530737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a633656e8470bdeebb17e05c38849b84bc0bfdfc14a78d18665ef7c4a694a97ac7505b92593d7097881b0e4a7a1011933cff6afb1e00248aa05adf13a267d088"} 17:32:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:11 INFO - Contents: 17:32:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69b5d92de3c2e9d82a72306db9f4b505bd5618a0516a4b3257a3232b045fca92518964975c429c8376b0014f5fdc946ddb66f5ec77bee081a9a6718b43e22eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0de8b5019839973da86e6f240c040a87b680f476f6148c0b81418e4747889d4019f93fc4d8f97ec80356d2502aafff74377fc92ca07360713c641c107530737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a633656e8470bdeebb17e05c38849b84bc0bfdfc14a78d18665ef7c4a694a97ac7505b92593d7097881b0e4a7a1011933cff6afb1e00248aa05adf13a267d088"} 17:32:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:11 INFO - Copying logs to upload dir... 17:32:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.012354 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-14 17:32:09.784096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 17:32:09.788029) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934 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/69b5d92de3c2e9d82a72306db9f4b505bd5618a0516a4b3257a3232b045fca92518964975c429c8376b0014f5fdc946ddb66f5ec77bee081a9a6718b43e22eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0de8b5019839973da86e6f240c040a87b680f476f6148c0b81418e4747889d4019f93fc4d8f97ec80356d2502aafff74377fc92ca07360713c641c107530737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a633656e8470bdeebb17e05c38849b84bc0bfdfc14a78d18665ef7c4a694a97ac7505b92593d7097881b0e4a7a1011933cff6afb1e00248aa05adf13a267d088"} build_url:https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/PAr0UOUtTUqYJKHuzT_f9w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69b5d92de3c2e9d82a72306db9f4b505bd5618a0516a4b3257a3232b045fca92518964975c429c8376b0014f5fdc946ddb66f5ec77bee081a9a6718b43e22eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0de8b5019839973da86e6f240c040a87b680f476f6148c0b81418e4747889d4019f93fc4d8f97ec80356d2502aafff74377fc92ca07360713c641c107530737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a633656e8470bdeebb17e05c38849b84bc0bfdfc14a78d18665ef7c4a694a97ac7505b92593d7097881b0e4a7a1011933cff6afb1e00248aa05adf13a267d088"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 17:32:09.813298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:32:09.813698) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463269630.93395-1707299934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 17:32:09.900781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 17:32:09.901400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 17:32:09.901977) ========= ========= Total master_lag: 0.16 =========