builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1463238768.88 results: success (0) buildid: 20160514053004 builduid: cda7fbdffbc344b6975807e87f423d69 revision: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:48.878117) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:48.878584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:48.878884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:48.948926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:48.949182) ========= 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=745a4373a2a16df560f216e000000264-1463233347.392406-338550269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 08:12:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.5M=0s 2016-05-14 08:12:49 (33.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.059516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.059826) ========= 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=745a4373a2a16df560f216e000000264-1463233347.392406-338550269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.114451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.114865) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 --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 e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 --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=745a4373a2a16df560f216e000000264-1463233347.392406-338550269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 08:12:49,542 truncating revision to first 12 chars 2016-05-14 08:12:49,542 Setting DEBUG logging. 2016-05-14 08:12:49,542 attempt 1/10 2016-05-14 08:12:49,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e9b22ce9e029?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 08:12:50,122 unpacking tar archive at: fx-team-e9b22ce9e029/testing/mozharness/ program finished with exit code 0 elapsedTime=0.852295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.981283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.981590) ========= script_repo_revision: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.981997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.982266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 08:12:49.993502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-14 08:12:49.993837) ========= /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=745a4373a2a16df560f216e000000264-1463233347.392406-338550269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:12:50 INFO - MultiFileLogger online at 20160514 08:12:50 in /builds/slave/test 08:12:50 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 08:12:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:50 INFO - {'append_to_log': False, 08:12:50 INFO - 'base_work_dir': '/builds/slave/test', 08:12:50 INFO - 'blob_upload_branch': 'Fx-Team', 08:12:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:50 INFO - 'branch': 'Fx-Team', 08:12:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:50 INFO - 'config_files': ('talos/linux_config.py',), 08:12:50 INFO - 'default_actions': ('clobber', 08:12:50 INFO - 'read-buildbot-config', 08:12:50 INFO - 'download-and-extract', 08:12:50 INFO - 'populate-webroot', 08:12:50 INFO - 'create-virtualenv', 08:12:50 INFO - 'install', 08:12:50 INFO - 'run-tests'), 08:12:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:50 INFO - 'download_minidump_stackwalk': True, 08:12:50 INFO - 'download_symbols': 'ondemand', 08:12:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:50 INFO - 'installer_path': 'installer.exe', 08:12:50 INFO - 'log_level': 'info', 08:12:50 INFO - 'log_name': 'talos', 08:12:50 INFO - 'log_to_console': True, 08:12:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:12:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:12:50 INFO - 'opt_config_files': (), 08:12:50 INFO - 'pip_index': False, 08:12:50 INFO - 'sps_profile': False, 08:12:50 INFO - 'sps_profile_interval': 0, 08:12:50 INFO - 'suite': 'dromaeojs', 08:12:50 INFO - 'system_bits': '32', 08:12:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:50 INFO - 'title': 'talos-linux64-ix-032', 08:12:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:50 INFO - 'use_talos_json': True, 08:12:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:50 INFO - 'work_dir': 'build'} 08:12:50 INFO - ##### 08:12:50 INFO - ##### Running clobber step. 08:12:50 INFO - ##### 08:12:50 INFO - Running pre-action listener: _resource_record_pre_action 08:12:50 INFO - Running main action method: clobber 08:12:50 INFO - rmtree: /builds/slave/test/build 08:12:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:51 INFO - Running post-action listener: _resource_record_post_action 08:12:51 INFO - ##### 08:12:51 INFO - ##### Finished clobber step (success) 08:12:51 INFO - ##### 08:12:51 INFO - ##### 08:12:51 INFO - ##### Running read-buildbot-config step. 08:12:51 INFO - ##### 08:12:51 INFO - Running pre-action listener: _resource_record_pre_action 08:12:51 INFO - Running main action method: read_buildbot_config 08:12:51 INFO - Using buildbot properties: 08:12:51 INFO - { 08:12:51 INFO - "project": "", 08:12:51 INFO - "product": "firefox", 08:12:51 INFO - "script_repo_revision": "production", 08:12:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:12:51 INFO - "repository": "", 08:12:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:12:51 INFO - "buildid": "20160514053004", 08:12:51 INFO - "pgo_build": "True", 08:12:51 INFO - "basedir": "/builds/slave/test", 08:12:51 INFO - "buildnumber": 1154, 08:12:51 INFO - "slavename": "talos-linux64-ix-032", 08:12:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:12:51 INFO - "platform": "ubuntu64_hw", 08:12:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:12:51 INFO - "branch": "fx-team", 08:12:51 INFO - "repo_path": "integration/fx-team", 08:12:51 INFO - "revision": "e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5", 08:12:51 INFO - "stage_platform": "linux64-pgo", 08:12:51 INFO - "builduid": "cda7fbdffbc344b6975807e87f423d69", 08:12:51 INFO - "slavebuilddir": "test" 08:12:51 INFO - } 08:12:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:12:51 INFO - Running post-action listener: _resource_record_post_action 08:12:51 INFO - ##### 08:12:51 INFO - ##### Finished read-buildbot-config step (success) 08:12:51 INFO - ##### 08:12:51 INFO - ##### 08:12:51 INFO - ##### Running download-and-extract step. 08:12:51 INFO - ##### 08:12:51 INFO - Running pre-action listener: _resource_record_pre_action 08:12:51 INFO - Running main action method: download_and_extract 08:12:51 INFO - mkdir: /builds/slave/test/build/tests 08:12: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')]} 08:12:51 INFO - https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:12:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:12:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:12:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:12:55 INFO - Downloaded 1361 bytes. 08:12:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:12:55 INFO - Using the following test package requirements: 08:12:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:12:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:12:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'jsshell-linux-x86_64.zip'], 08:12:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:12:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:12:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:12:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:12:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:12:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:12: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')]} 08:12:55 INFO - https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:12:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:12:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:12:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:12:57 INFO - Downloaded 24023122 bytes. 08:12:57 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'] 08:12:57 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 08:12:58 INFO - Return code: 0 08:12:58 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 08:12: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')]} 08:12:58 INFO - https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:12:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:12:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:12:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:12:59 INFO - Downloaded 24023122 bytes. 08:12:59 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'] 08:12:59 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 08:13:01 INFO - Return code: 0 08:13:01 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')]} 08:13:01 INFO - https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:13:02 INFO - Downloaded 10840194 bytes. 08:13:02 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'] 08:13:02 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 08:13:02 INFO - Return code: 0 08:13: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')]} 08:13:02 INFO - https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:13:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:13:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:13:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:13:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1kQm0wnS7GJpD2OXozINA/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 08:13:04 INFO - Downloaded 58383953 bytes. 08:13:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:13:04 INFO - mkdir: /builds/slave/test/properties 08:13:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:04 INFO - Contents: 08:13:04 INFO - build_url:https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:13:04 INFO - Running post-action listener: _resource_record_post_action 08:13:04 INFO - Running post-action listener: set_extra_try_arguments 08:13:04 INFO - ##### 08:13:04 INFO - ##### Finished download-and-extract step (success) 08:13:04 INFO - ##### 08:13:04 INFO - ##### 08:13:04 INFO - ##### Running populate-webroot step. 08:13:04 INFO - ##### 08:13:04 INFO - Running pre-action listener: _resource_record_pre_action 08:13:04 INFO - Running main action method: populate_webroot 08:13:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:04 INFO - '--tppagecycles', 08:13:04 INFO - '7'], 08:13:04 INFO - 'tests': ['tsvgm']}}, 08:13:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['damp', 'tps']}, 08:13:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'tests': ['damp', 'tps']}, 08:13:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['dromaeo_dom']}, 08:13:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['a11yr', 08:13:04 INFO - 'ts_paint', 08:13:04 INFO - 'tpaint', 08:13:04 INFO - 'sessionrestore', 08:13:04 INFO - 'sessionrestore_no_auto_restore', 08:13:04 INFO - 'tabpaint']}, 08:13:04 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:04 INFO - 'ts_paint', 08:13:04 INFO - 'tpaint', 08:13:04 INFO - 'sessionrestore', 08:13:04 INFO - 'sessionrestore_no_auto_restore', 08:13:04 INFO - 'tabpaint']}, 08:13:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:04 INFO - 'ts_paint', 08:13:04 INFO - 'tpaint', 08:13:04 INFO - 'sessionrestore', 08:13:04 INFO - 'sessionrestore_no_auto_restore', 08:13:04 INFO - 'tabpaint']}, 08:13:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:04 INFO - 'ts_paint', 08:13:04 INFO - 'tpaint', 08:13:04 INFO - 'sessionrestore', 08:13:04 INFO - 'sessionrestore_no_auto_restore', 08:13:04 INFO - 'tabpaint']}, 08:13:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['a11yr', 08:13:04 INFO - 'ts_paint', 08:13:04 INFO - 'tpaint', 08:13:04 INFO - 'sessionrestore', 08:13:04 INFO - 'sessionrestore_no_auto_restore', 08:13:04 INFO - 'tabpaint']}, 08:13:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['a11yr', 08:13:04 INFO - 'ts_paint', 08:13:04 INFO - 'tpaint', 08:13:04 INFO - 'sessionrestore', 08:13:04 INFO - 'sessionrestore_no_auto_restore', 08:13:04 INFO - 'tabpaint']}, 08:13:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['tsvgx', 08:13:04 INFO - 'tsvgr_opacity', 08:13:04 INFO - 'tart', 08:13:04 INFO - 'tscrollx', 08:13:04 INFO - 'cart']}, 08:13:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:04 INFO - 'tsvgr_opacity', 08:13:04 INFO - 'tart', 08:13:04 INFO - 'tscrollx', 08:13:04 INFO - 'cart']}, 08:13:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'talos_options': ['--disable-e10s'], 08:13:04 INFO - 'tests': ['tp5o']}, 08:13:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'tests': ['tp5o']}, 08:13:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'talos_options': ['--disable-e10s', 08:13:04 INFO - '--xperf_path', 08:13:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:04 INFO - 'tests': ['tp5n']}, 08:13:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:04 INFO - 'talos_options': ['--xperf_path', 08:13:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:04 INFO - 'tests': ['tp5n']}}, 08:13:04 INFO - 'talos.zip': {'path': '', 08:13:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:04 INFO - Running post-action listener: _resource_record_post_action 08:13:04 INFO - ##### 08:13:04 INFO - ##### Finished populate-webroot step (success) 08:13:04 INFO - ##### 08:13:04 INFO - ##### 08:13:04 INFO - ##### Running create-virtualenv step. 08:13:04 INFO - ##### 08:13:04 INFO - Running pre-action listener: _resource_record_pre_action 08:13:04 INFO - Running main action method: create_virtualenv 08:13:04 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:04 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 08:13:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:04 INFO - Using real prefix '/usr' 08:13:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:07 INFO - Installing pip.................done. 08:13:07 INFO - Return code: 0 08:13:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13:07 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')]} 08:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 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')]} 08:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 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 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:07 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 08:13:07 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 08:13:07 INFO - Using env: {'DISPLAY': ':0', 08:13:07 INFO - 'HOME': '/home/cltbld', 08:13:07 INFO - 'LANG': 'en_US.UTF-8', 08:13:07 INFO - 'LANGUAGE': 'en_US:en', 08:13:07 INFO - 'LOGNAME': 'cltbld', 08:13:07 INFO - 'MAIL': '/var/mail/cltbld', 08:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:07 INFO - 'MOZ_NO_REMOTE': '1', 08:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:07 INFO - 'NO_EM_RESTART': '1', 08:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:07 INFO - 'PWD': '/builds/slave/test', 08:13:07 INFO - 'SHELL': '/bin/bash', 08:13:07 INFO - 'SHLVL': '1', 08:13:07 INFO - 'TERM': 'linux', 08:13:07 INFO - 'TMOUT': '86400', 08:13:07 INFO - 'USER': 'cltbld', 08:13:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:07 INFO - '_': '/tools/buildbot/bin/python'} 08:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:07 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 08:13:07 INFO - Cleaning up... 08:13:07 INFO - Return code: 0 08:13:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:13:07 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')]} 08:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 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')]} 08:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 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 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:07 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 08:13:07 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 08:13:07 INFO - Using env: {'DISPLAY': ':0', 08:13:07 INFO - 'HOME': '/home/cltbld', 08:13:07 INFO - 'LANG': 'en_US.UTF-8', 08:13:07 INFO - 'LANGUAGE': 'en_US:en', 08:13:07 INFO - 'LOGNAME': 'cltbld', 08:13:07 INFO - 'MAIL': '/var/mail/cltbld', 08:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:07 INFO - 'MOZ_NO_REMOTE': '1', 08:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:07 INFO - 'NO_EM_RESTART': '1', 08:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:07 INFO - 'PWD': '/builds/slave/test', 08:13:07 INFO - 'SHELL': '/bin/bash', 08:13:07 INFO - 'SHLVL': '1', 08:13:07 INFO - 'TERM': 'linux', 08:13:07 INFO - 'TMOUT': '86400', 08:13:07 INFO - 'USER': 'cltbld', 08:13:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:07 INFO - '_': '/tools/buildbot/bin/python'} 08:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:07 INFO - Downloading/unpacking psutil>=3.1.1 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:09 INFO - Installing collected packages: psutil 08:13:09 INFO - Running setup.py install for psutil 08:13:09 INFO - building 'psutil._psutil_linux' extension 08:13:09 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 08:13:10 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 08:13:10 INFO - building 'psutil._psutil_posix' extension 08:13:10 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 08:13:10 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 08:13:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:10 INFO - Successfully installed psutil 08:13:10 INFO - Cleaning up... 08:13:10 INFO - Return code: 0 08:13:10 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 08:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 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.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:10 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.1'] in /builds/slave/test/build 08:13:10 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.1 08:13:10 INFO - Using env: {'DISPLAY': ':0', 08:13:10 INFO - 'HOME': '/home/cltbld', 08:13:10 INFO - 'LANG': 'en_US.UTF-8', 08:13:10 INFO - 'LANGUAGE': 'en_US:en', 08:13:10 INFO - 'LOGNAME': 'cltbld', 08:13:10 INFO - 'MAIL': '/var/mail/cltbld', 08:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:10 INFO - 'MOZ_NO_REMOTE': '1', 08:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:10 INFO - 'NO_EM_RESTART': '1', 08:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:10 INFO - 'PWD': '/builds/slave/test', 08:13:10 INFO - 'SHELL': '/bin/bash', 08:13:10 INFO - 'SHLVL': '1', 08:13:10 INFO - 'TERM': 'linux', 08:13:10 INFO - 'TMOUT': '86400', 08:13:10 INFO - 'USER': 'cltbld', 08:13:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:10 INFO - '_': '/tools/buildbot/bin/python'} 08:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:10 INFO - Downloading/unpacking mozsystemmonitor==0.1 08:13:10 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 08:13:10 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 08:13:10 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 08:13:10 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 08:13:10 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 08:13:10 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 08:13:12 INFO - Downloading mozsystemmonitor-0.1.tar.gz 08:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 08:13:12 INFO - Installing collected packages: mozsystemmonitor 08:13:12 INFO - Running setup.py install for mozsystemmonitor 08:13:12 INFO - Successfully installed mozsystemmonitor 08:13:12 INFO - Cleaning up... 08:13:12 INFO - Return code: 0 08:13:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:12 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')]} 08:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:12 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')]} 08:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:12 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 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:12 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 08:13:12 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 08:13:12 INFO - Using env: {'DISPLAY': ':0', 08:13:12 INFO - 'HOME': '/home/cltbld', 08:13:12 INFO - 'LANG': 'en_US.UTF-8', 08:13:12 INFO - 'LANGUAGE': 'en_US:en', 08:13:12 INFO - 'LOGNAME': 'cltbld', 08:13:12 INFO - 'MAIL': '/var/mail/cltbld', 08:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:12 INFO - 'MOZ_NO_REMOTE': '1', 08:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:12 INFO - 'NO_EM_RESTART': '1', 08:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:12 INFO - 'PWD': '/builds/slave/test', 08:13:12 INFO - 'SHELL': '/bin/bash', 08:13:12 INFO - 'SHLVL': '1', 08:13:12 INFO - 'TERM': 'linux', 08:13:12 INFO - 'TMOUT': '86400', 08:13:12 INFO - 'USER': 'cltbld', 08:13:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:12 INFO - '_': '/tools/buildbot/bin/python'} 08:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:13:12 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 08:13:12 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 08:13:12 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 08:13:12 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 08:13:12 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 08:13:12 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 08:13:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13:14 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 08:13:14 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 08:13:14 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 08:13:14 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 08:13:14 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 08:13:14 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 08:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:15 INFO - Downloading docopt-0.6.1.tar.gz 08:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:15 INFO - Running setup.py install for blobuploader 08:13:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:15 INFO - Running setup.py install for requests 08:13:16 INFO - Running setup.py install for docopt 08:13:16 INFO - Successfully installed blobuploader requests docopt 08:13:16 INFO - Cleaning up... 08:13:16 INFO - Return code: 0 08:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:16 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 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:16 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 08:13:16 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 08:13:16 INFO - Using env: {'DISPLAY': ':0', 08:13:16 INFO - 'HOME': '/home/cltbld', 08:13:16 INFO - 'LANG': 'en_US.UTF-8', 08:13:16 INFO - 'LANGUAGE': 'en_US:en', 08:13:16 INFO - 'LOGNAME': 'cltbld', 08:13:16 INFO - 'MAIL': '/var/mail/cltbld', 08:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:16 INFO - 'MOZ_NO_REMOTE': '1', 08:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:16 INFO - 'NO_EM_RESTART': '1', 08:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:16 INFO - 'PWD': '/builds/slave/test', 08:13:16 INFO - 'SHELL': '/bin/bash', 08:13:16 INFO - 'SHLVL': '1', 08:13:16 INFO - 'TERM': 'linux', 08:13:16 INFO - 'TMOUT': '86400', 08:13:16 INFO - 'USER': 'cltbld', 08:13:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:16 INFO - '_': '/tools/buildbot/bin/python'} 08:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:16 INFO - Running setup.py (path:/tmp/pip-g4QUxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:16 INFO - Running setup.py (path:/tmp/pip-QZPrm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:16 INFO - Running setup.py (path:/tmp/pip-BiUevY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:16 INFO - Running setup.py (path:/tmp/pip-3mpE0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:16 INFO - Running setup.py (path:/tmp/pip-VOnfUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:16 INFO - Running setup.py (path:/tmp/pip-Z4SVPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:16 INFO - Running setup.py (path:/tmp/pip-523usg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:16 INFO - Running setup.py (path:/tmp/pip-jWS9rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:16 INFO - Running setup.py (path:/tmp/pip-f61fFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:17 INFO - Running setup.py (path:/tmp/pip-lSzCzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:17 INFO - Running setup.py (path:/tmp/pip-w_WnC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:17 INFO - Running setup.py (path:/tmp/pip-4h6ev0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:17 INFO - Running setup.py (path:/tmp/pip-SC8H6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:17 INFO - Running setup.py (path:/tmp/pip-Xv5miq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:17 INFO - Running setup.py (path:/tmp/pip-htplws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:17 INFO - Running setup.py (path:/tmp/pip-gcw4l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:17 INFO - Running setup.py (path:/tmp/pip-xz6N2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:17 INFO - Running setup.py install for manifestparser 08:13:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:17 INFO - Running setup.py install for mozcrash 08:13:17 INFO - Running setup.py install for mozdebug 08:13:17 INFO - Running setup.py install for mozdevice 08:13:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozfile 08:13:18 INFO - Running setup.py install for mozhttpd 08:13:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozinfo 08:13:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozInstall 08:13:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozleak 08:13:18 INFO - Running setup.py install for mozlog 08:13:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for moznetwork 08:13:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozprocess 08:13:18 INFO - Running setup.py install for mozprofile 08:13:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozrunner 08:13:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Running setup.py install for mozscreenshot 08:13:19 INFO - Running setup.py install for moztest 08:13:19 INFO - Running setup.py install for mozversion 08:13:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:19 INFO - Cleaning up... 08:13:19 INFO - Return code: 0 08:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:19 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 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:19 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 08:13:19 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 08:13:19 INFO - Using env: {'DISPLAY': ':0', 08:13:19 INFO - 'HOME': '/home/cltbld', 08:13:19 INFO - 'LANG': 'en_US.UTF-8', 08:13:19 INFO - 'LANGUAGE': 'en_US:en', 08:13:19 INFO - 'LOGNAME': 'cltbld', 08:13:19 INFO - 'MAIL': '/var/mail/cltbld', 08:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:19 INFO - 'MOZ_NO_REMOTE': '1', 08:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:19 INFO - 'NO_EM_RESTART': '1', 08:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:19 INFO - 'PWD': '/builds/slave/test', 08:13:19 INFO - 'SHELL': '/bin/bash', 08:13:19 INFO - 'SHLVL': '1', 08:13:19 INFO - 'TERM': 'linux', 08:13:19 INFO - 'TMOUT': '86400', 08:13:19 INFO - 'USER': 'cltbld', 08:13:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:19 INFO - '_': '/tools/buildbot/bin/python'} 08:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:19 INFO - Running setup.py (path:/tmp/pip-Rgnpwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:19 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)) 08:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:19 INFO - Running setup.py (path:/tmp/pip-gLmOjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:19 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)) 08:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:19 INFO - Running setup.py (path:/tmp/pip-EVwsMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:19 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)) 08:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:19 INFO - Running setup.py (path:/tmp/pip-OjpN4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:19 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)) 08:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:19 INFO - Running setup.py (path:/tmp/pip-ryciBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:19 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)) 08:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:19 INFO - Running setup.py (path:/tmp/pip-8v_ILH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:20 INFO - Running setup.py (path:/tmp/pip-l1yX3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:20 INFO - Running setup.py (path:/tmp/pip-Iez848-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:20 INFO - Running setup.py (path:/tmp/pip-ME6Fm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:20 INFO - Running setup.py (path:/tmp/pip-fIz6w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:20 INFO - Running setup.py (path:/tmp/pip-EserO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:20 INFO - Running setup.py (path:/tmp/pip-Jcj66K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:20 INFO - Running setup.py (path:/tmp/pip-O_ehbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:20 INFO - Running setup.py (path:/tmp/pip-5pukAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:20 INFO - Running setup.py (path:/tmp/pip-ceCfkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:20 INFO - Running setup.py (path:/tmp/pip-zkQuQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:20 INFO - Running setup.py (path:/tmp/pip-pfhJ29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:20 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)) 08:13:20 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)) 08:13:20 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)) 08:13:20 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)) 08:13:20 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)) 08:13:20 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)) 08:13:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:22 INFO - Downloading blessings-1.6.tar.gz 08:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:22 INFO - Installing collected packages: blessings 08:13:22 INFO - Running setup.py install for blessings 08:13:22 INFO - Successfully installed blessings 08:13:22 INFO - Cleaning up... 08:13:22 INFO - Return code: 0 08:13:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:23 INFO - Reading from file tmpfile_stdout 08:13:23 INFO - Current package versions: 08:13:23 INFO - argparse == 1.2.1 08:13:23 INFO - blessings == 1.6 08:13:23 INFO - blobuploader == 1.2.4 08:13:23 INFO - docopt == 0.6.1 08:13:23 INFO - manifestparser == 1.1 08:13:23 INFO - mozInstall == 1.12 08:13:23 INFO - mozcrash == 0.17 08:13:23 INFO - mozdebug == 0.1 08:13:23 INFO - mozdevice == 0.48 08:13:23 INFO - mozfile == 1.2 08:13:23 INFO - mozhttpd == 0.7 08:13:23 INFO - mozinfo == 0.9 08:13:23 INFO - mozleak == 0.1 08:13:23 INFO - mozlog == 3.2 08:13:23 INFO - moznetwork == 0.27 08:13:23 INFO - mozprocess == 0.22 08:13:23 INFO - mozprofile == 0.28 08:13:23 INFO - mozrunner == 6.11 08:13:23 INFO - mozscreenshot == 0.1 08:13:23 INFO - mozsystemmonitor == 0.1 08:13:23 INFO - moztest == 0.7 08:13:23 INFO - mozversion == 1.4 08:13:23 INFO - psutil == 3.1.1 08:13:23 INFO - requests == 1.2.3 08:13:23 INFO - wsgiref == 0.1.2 08:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 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 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:23 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 08:13:23 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 08:13:23 INFO - Using env: {'DISPLAY': ':0', 08:13:23 INFO - 'HOME': '/home/cltbld', 08:13:23 INFO - 'LANG': 'en_US.UTF-8', 08:13:23 INFO - 'LANGUAGE': 'en_US:en', 08:13:23 INFO - 'LOGNAME': 'cltbld', 08:13:23 INFO - 'MAIL': '/var/mail/cltbld', 08:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:23 INFO - 'MOZ_NO_REMOTE': '1', 08:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:23 INFO - 'NO_EM_RESTART': '1', 08:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:23 INFO - 'PWD': '/builds/slave/test', 08:13:23 INFO - 'SHELL': '/bin/bash', 08:13:23 INFO - 'SHLVL': '1', 08:13:23 INFO - 'TERM': 'linux', 08:13:23 INFO - 'TMOUT': '86400', 08:13:23 INFO - 'USER': 'cltbld', 08:13:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:23 INFO - '_': '/tools/buildbot/bin/python'} 08:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 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)) 08:13:23 INFO - Cleaning up... 08:13:23 INFO - Return code: 0 08:13:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:13:23 INFO - Using env: {'DISPLAY': ':0', 08:13:23 INFO - 'HOME': '/home/cltbld', 08:13:23 INFO - 'LANG': 'en_US.UTF-8', 08:13:23 INFO - 'LANGUAGE': 'en_US:en', 08:13:23 INFO - 'LOGNAME': 'cltbld', 08:13:23 INFO - 'MAIL': '/var/mail/cltbld', 08:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:23 INFO - 'MOZ_NO_REMOTE': '1', 08:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:23 INFO - 'NO_EM_RESTART': '1', 08:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:23 INFO - 'PWD': '/builds/slave/test', 08:13:23 INFO - 'SHELL': '/bin/bash', 08:13:23 INFO - 'SHLVL': '1', 08:13:23 INFO - 'TERM': 'linux', 08:13:23 INFO - 'TMOUT': '86400', 08:13:23 INFO - 'USER': 'cltbld', 08:13:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:23 INFO - '_': '/tools/buildbot/bin/python'} 08:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:23 INFO - Downloading/unpacking jsonschema 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:25 INFO - Downloading/unpacking functools32 (from jsonschema) 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:25 INFO - warning: no files found matching '*.txt' 08:13:25 INFO - no previously-included directories found matching 'build' 08:13:25 INFO - no previously-included directories found matching 'dist' 08:13:25 INFO - no previously-included directories found matching '.git*' 08:13:25 INFO - Installing collected packages: jsonschema, functools32 08:13:25 INFO - Running setup.py install for functools32 08:13:25 INFO - warning: no files found matching '*.txt' 08:13:25 INFO - no previously-included directories found matching 'build' 08:13:25 INFO - no previously-included directories found matching 'dist' 08:13:25 INFO - no previously-included directories found matching '.git*' 08:13:25 INFO - Successfully installed jsonschema functools32 08:13:25 INFO - Cleaning up... 08:13:26 INFO - Return code: 0 08:13:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:26 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 0x7ff4daf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x257e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, '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': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', '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 08:13:26 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 08:13:26 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 08:13:26 INFO - Using env: {'DISPLAY': ':0', 08:13:26 INFO - 'HOME': '/home/cltbld', 08:13:26 INFO - 'LANG': 'en_US.UTF-8', 08:13:26 INFO - 'LANGUAGE': 'en_US:en', 08:13:26 INFO - 'LOGNAME': 'cltbld', 08:13:26 INFO - 'MAIL': '/var/mail/cltbld', 08:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:26 INFO - 'MOZ_NO_REMOTE': '1', 08:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:26 INFO - 'NO_EM_RESTART': '1', 08:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:26 INFO - 'PWD': '/builds/slave/test', 08:13:26 INFO - 'SHELL': '/bin/bash', 08:13:26 INFO - 'SHLVL': '1', 08:13:26 INFO - 'TERM': 'linux', 08:13:26 INFO - 'TMOUT': '86400', 08:13:26 INFO - 'USER': 'cltbld', 08:13:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:26 INFO - '_': '/tools/buildbot/bin/python'} 08:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:26 INFO - Downloading/unpacking flake8 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:13:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:13:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 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 08:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:13:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:13:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:13:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:13:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:13:28 INFO - no previously-included directories found matching 'docs/_build' 08:13:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:13:28 INFO - Running setup.py install for pep8 08:13:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:13:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:13:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:13:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:13:28 INFO - no previously-included directories found matching 'docs/_build' 08:13:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:13:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:13:29 INFO - Cleaning up... 08:13:29 INFO - Return code: 0 08:13:29 INFO - Running post-action listener: _resource_record_post_action 08:13:29 INFO - Running post-action listener: _start_resource_monitoring 08:13:29 INFO - Starting resource monitoring. 08:13:29 INFO - ##### 08:13:29 INFO - ##### Finished create-virtualenv step (success) 08:13:29 INFO - ##### 08:13:29 INFO - ##### 08:13:29 INFO - ##### Running install step. 08:13:29 INFO - ##### 08:13:29 INFO - Running pre-action listener: _resource_record_pre_action 08:13:29 INFO - Running main action method: install 08:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:29 INFO - Reading from file tmpfile_stdout 08:13:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:29 INFO - Reading from file tmpfile_stdout 08:13:29 INFO - Output received: 08:13:29 INFO - Usage: mozinstall [options] installer 08:13:29 INFO - Options: 08:13:29 INFO - -h, --help show this help message and exit 08:13:29 INFO - -d DEST, --destination=DEST 08:13:29 INFO - Directory to install application into. [default: 08:13:29 INFO - "/builds/slave/test"] 08:13:29 INFO - --app=APP Application being installed. [default: firefox] 08:13:29 INFO - mkdir: /builds/slave/test/build/application 08:13:29 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'] 08:13:29 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 08:13:46 INFO - Reading from file tmpfile_stdout 08:13:46 INFO - Output received: 08:13:46 INFO - /builds/slave/test/build/application/firefox/firefox 08:13:46 INFO - Running post-action listener: _resource_record_post_action 08:13:46 INFO - ##### 08:13:46 INFO - ##### Finished install step (success) 08:13:46 INFO - ##### 08:13:46 INFO - ##### 08:13:46 INFO - ##### Running run-tests step. 08:13:46 INFO - ##### 08:13:46 INFO - Running pre-action listener: _resource_record_pre_action 08:13:46 INFO - Running main action method: run_tests 08:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:46 INFO - Python 2.7.3 08:13:46 INFO - Return code: 0 08:13:46 INFO - grabbing minidump binary from tooltool 08:13: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')]} 08:13:46 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 0x260d9c0>, '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 0x260e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:46 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 08:13:46 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 08:13:46 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 08:13:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:46 INFO - Return code: 0 08:13:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:13:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:13:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:13:47 INFO - Return code: 0 08:13:47 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/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:13:47 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/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 08:13:47 INFO - Using env: {'DISPLAY': ':0', 08:13:47 INFO - 'HOME': '/home/cltbld', 08:13:47 INFO - 'LANG': 'en_US.UTF-8', 08:13:47 INFO - 'LANGUAGE': 'en_US:en', 08:13:47 INFO - 'LOGNAME': 'cltbld', 08:13:47 INFO - 'MAIL': '/var/mail/cltbld', 08:13:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:47 INFO - 'MOZ_NO_REMOTE': '1', 08:13:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:47 INFO - 'NO_EM_RESTART': '1', 08:13:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:47 INFO - 'PWD': '/builds/slave/test', 08:13:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:47 INFO - 'SHELL': '/bin/bash', 08:13:47 INFO - 'SHLVL': '1', 08:13:47 INFO - 'TERM': 'linux', 08:13:47 INFO - 'TMOUT': '86400', 08:13:47 INFO - 'USER': 'cltbld', 08:13:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463233347.392406-338550269', 08:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:47 INFO - '_': '/tools/buildbot/bin/python'} 08:13:47 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/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:13:47 INFO - mozversion application_buildid: 20160514053004 08:13:47 INFO - mozversion application_changeset: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 08:13:47 INFO - mozversion application_display_name: Nightly 08:13:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:47 INFO - mozversion application_name: Firefox 08:13:47 INFO - mozversion application_remotingname: firefox 08:13:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:13:47 INFO - mozversion application_vendor: Mozilla 08:13:47 INFO - mozversion application_version: 49.0a1 08:13:47 INFO - mozversion platform_buildid: 20160514053004 08:13:47 INFO - mozversion platform_changeset: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 08:13:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:13:47 INFO - mozversion platform_version: 49.0a1 08:13:47 INFO - using testdate: 1463238827 08:13:47 INFO - actual date: 1463238827 08:13:47 INFO - starting webserver on 'localhost:54883' 08:13:47 INFO - SUITE-START | Running 2 tests 08:13:47 INFO - TEST-START | dromaeo_css 08:13:47 INFO - operating with platform_type : linux_ 08:13:47 INFO - Initialising browser for dromaeo_css test... 08:13:47 INFO - TEST-INFO | started process 11020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKgg8nw/profile http://localhost:54883/getInfo.html) 08:13:52 INFO - PROCESS | 11020 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 08:13:52 INFO - PROCESS | 11020 | __metrics Screen width/height:1600/1200 08:13:52 INFO - PROCESS | 11020 | colorDepth:24 08:13:52 INFO - PROCESS | 11020 | Browser inner width/height: 1024/697 08:13:52 INFO - PROCESS | 11020 | __metrics 08:13:54 ERROR - PROCESS | 11020 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:13:54 INFO - TEST-INFO | 11020: exit 0 08:13:54 INFO - Browser initialized. 08:13:54 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:54 INFO - TEST-INFO | started process 11104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKgg8nw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:06 INFO - PROCESS | 11104 | RSS: Main: 152641536 08:14:06 INFO - PROCESS | 11104 | 08:14:57 INFO - PROCESS | 11104 | 1463238897879 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] 08:17:05 INFO - PROCESS | 11104 | Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54883/tests/dromaeo/cssquery-ext.html) 08:17:06 INFO - PROCESS | 11104 | RSS: Main: 243220480 08:17:06 INFO - PROCESS | 11104 | 08:20:09 INFO - PROCESS | 11104 | Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-ext.html (next: http://localhost:54883/tests/dromaeo/cssquery-jquery.html) 08:20:09 INFO - PROCESS | 11104 | RSS: Main: 235831296 08:20:09 INFO - PROCESS | 11104 | 08:23:11 INFO - PROCESS | 11104 | Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54883/tests/dromaeo/cssquery-mootools.html) 08:23:12 INFO - PROCESS | 11104 | RSS: Main: 249434112 08:23:12 INFO - PROCESS | 11104 | 08:26:14 INFO - PROCESS | 11104 | Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54883/tests/dromaeo/cssquery-prototype.html) 08:26:14 INFO - PROCESS | 11104 | RSS: Main: 242876416 08:26:14 INFO - PROCESS | 11104 | 08:29:17 INFO - PROCESS | 11104 | Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54883/tests/dromaeo/cssquery-yui.html) 08:29:17 INFO - PROCESS | 11104 | RSS: Main: 231555072 08:29:17 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | Cycle 1(1): loaded http://localhost:54883/tests/dromaeo/cssquery-yui.html (next: http://localhost:54883/tests/dromaeo/cssquery-dojo.html) 08:32:20 INFO - PROCESS | 11104 | RSS: Main: 277880832 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | __start_tp_report 08:32:20 INFO - PROCESS | 11104 | _x_x_mozilla_page_load 08:32:20 INFO - PROCESS | 11104 | _x_x_mozilla_page_load_details 08:32:20 INFO - PROCESS | 11104 | |i|pagename|runs| 08:32:20 INFO - PROCESS | 11104 | |0;dojo.html;3213.052149615863;3214.8231847248408;3226.4515032444488;3237.854296556655;3271.8364081795903;5204.32343795307;5288.286081379013;5405.91891121633;5491.588130890184;5521.0614195586795;5394;5397.892042159165;5404.351477822667;5405.594580406466;5454.91817622736;4861.100696371173;4867.610591152717;5044.167712327461;5073.518015788494;5105.234214867781;5041.04220198163;5061.266116413118;5088.236764485338;5100.821471248507;5101.311322971407;4773.498782627827;4891.095147397743;4898.632602554805;4941.308216849644;4968.925466117993;4930.506949305077;4931.65478416511;4936.555709986119;4948.208286674115;4985.800567977277;4778.904421911542;4889.9511004889855;4922.433920099199;4934.08719386911;4975.925361119586;5295.496927791892;5339.5728341732565;5349.331333583302;5431.6740995540395;5439.456054394568;5796.2464879565805;5830.883382332372;5875.148103525008;5882.088276317178;5886.117082437626;5640.633358831704;5771.220885180531;5841.678707671076;5844.707764611752;5893.14549390336;5419.132938729785;5520;5536.307961504852;5539.695316757577;5541.27963364764;6042.969785151134;6050.2437195350585;6051.939480605226;6056.152138700585;6057.182280392179;5543.417941116206;5632.802851900164;5658.321001479849;5800.361960184377;5810.331811841608;5767.971160144172;5790.71046447676;5798.565107616945;5800.709964501758;5841.795537156179;5730.713464326767;5750.108733146369;5763.538916886639;5764.077747560454;5771.797987070432;5534.972325138348;5726.026575482178;5745.109508026263;5780.855478612984;5783.306003279633;4400.801963911632;4444.777761111996;4444.933326000112;4447.399601053817;4478.149151661174;3938.4683067786054;3961.980190099031;3965.8215380307956;3978.6419222269556;4001.6198461146146;5323.414424413311;5363.597730170253;5364.195370694349;5382.273393091882;5394.973025134849;5758.280214973129;5766.798162064308;5769.221155144086;5779.624324418899;5780.624259423124;5361.731913404392;5363;5383.084875571162;5406.513413792777;5409.702466364309;4859.927101093486;4986.351774269394;5021.07110184617;5035.496450354935;5040.84877453677;6090.969545152246;6100.267967843887;6101.481374083252;6108.5418593605655;6108.5723999319625;5571;5843.707814609253;5857.619254748598;5862.355140934408;5863.530917526502;5976.133460648095;6011.849703757441;6033.818985430444;6035.909461358171;6099.66451845135;5653.067243904709;5654.46282603152;5688.089905615082;5690.8577285566535;5717.113847353667;5801.6519008859605;5806.216160818235;5810.1575271586225;5815.273090863642;5816.21481100063;5427.972860135674;5459.590530710292;5478.561715062706;5520.089185284383;5549.805756798492;5532.75102620375;5534.225208470737;5535.612507124462;5537.307836520435;5545.528630066489;5348.893022139613;5430;5435.483629055233;5438.75525601341;5485.917711234414;5627.324721033502;5653.745581448927;5663.801766938137;5731.111677689964;5734.741936612946;5523.530499907552;5544.528715059265;5545.085060964896;5571.3592936811165;5575.888482230252 08:32:20 INFO - PROCESS | 11104 | |1;ext.html;647.9319671434499;651.2673242602073;652.654093330535;666.7732970789932;671.936166064224;42314.57685423148;43686.78156609216;44011;47128.52871471284;47192.29211561829;44943.55056449435;45468.77265613675;45510.31734523985;45553.316700249525;45558.31662525056;8968.372213945026;9111.954440227822;9112.908870911306;9113.225375843062;9115.316351273648;8954.32842536809;9049.049849765779;9052.456852588833;9054.275657947348;9062.275017998578;9110.954445227797;9140.542972851365;9142.085791420872;9149.725508234731;9157.221636160933;9068.047854975232;9107.089291070906;9110.726678199599;9113.453192808453;9114.498702571356;8922.330825188137;8981.371304008722;8989.37074404792;8994.550272486349;8996.235319997808;41439.79280103611;41951.160976780295;41957.790211049054;41960;41979.16041679149;3618.330608837347;3677.9448308275396;3746.7751934883995;3855.6529912307747;4150.709450338478;31763.205919851956;31895.202619934455;32051;32350.514742278883;32656.83671581627;3802.790846503441;3822.5986271441375;3855.235605981851;3976.8210430530694;4035.051762835731;367778;369094;369940;370261.1486942575;370951;52972.735136324074;59089.40910590839;59138;59517;59586.40413595809;59445;60661.69669151714;60820.695896520236;66431.33568664348;66736.33263667398;17284.827151728572;17421.216045277994;17422.47732568025;17429.477115686295;17439.912800435915;11427.542898283975;11901.88098119025;11925;12886.80669789954;12927.482900684055;17256.65486690259;17312.826871731373;17326.65346693059;17334.826651733572;17341.219645116;6778.543931216024;6814.8296292592095;6822.590644561342;6882.518223724392;6898.309404468585;1003.6938733686296;1129.0572372069414;1164.976700466003;1173.7828501727208;1184.6268425445958;31805;31937;32145.678543214737;32261.193470162965;32839.3432131356;1172.355204637446;1178.0340121100787;1185.1940680337452;1251.9061070419755;1263.317808383481;16895.577610559587;17127;17216;17261;17376.131193440277;525411;527019;527029;529158;532693;59996;60111.39888601058;60120;60218.69890650606;60259.397406026255;1389.4789453954768;1395.5673741140279;1416.051245665386;1429.2425014742203;1440.6614445605273;31185;31205.375892482476;31881.36237275195;32074;32233.194170144994;52845.886164554526;53346;53356.46643533515;53363;53379;435587;443188;443686;444032;643073;26682.59976100399;27805.44389112166;27866.44267114687;41271.793641032804;42392.788036059625;48731.83243089188;48959;49187;53571.732141339045;54027.459725403816;39337.40993885037;41981.160376792905;42465.15069698651;42481.57518424776;44661.330080048174;41260.58739412567;41290;41979.58020419757;42207;42323.57676423196;41663;42162.57837421587;42276;42737.358939616555;43199.56800431955;36889.63110368862;37093.258134836615;37156.814215928745;37821;37930.24139517139;28611.856940715163;28761.856190718914;28926;28997.56503652489;29057 08:32:20 INFO - PROCESS | 11104 | |2;jquery.html;412.3363074538481;413.4356603236583;414.85894795769434;421.1114548303081;428.60568277184984;18268.269269229233;18403.723944140816;19395.418137455898;19881.40355789325;19921.900390498064;11492.885071149287;11706.941465292683;14661.853381466182;20011.59976800463;20114.79885201151;4731.313959475874;5114.769835357409;5234.633575649687;5861.1208318752315;5881.14723365114;5710.942890571083;5796.855078623026;5806.7096645167785;5819.33077696064;5851.268591426072;5655.5475561954945;5680.857978550549;5754.769809207627;5762.423757624246;5770.105633626795;5702.600817942745;5713.3750348619515;5758.136279558058;5759.136129580555;5781.53747700183;4935.827246046371;5074.644774865761;5082.745862706887;5083.593312535026;5085.1355269604255;12692.138126445769;12721.045921555828;12771.233725976379;22524.774752252433;23186.42033949148;2346.5541547105995;2444.046821739523;2594.1957993022224;2685.8522781247025;3010.9548356774667;10135.847962280572;10333.483325833753;10677.572897084106;12185.878141218564;14627.902907281996;1931.9613607727767;1975.338261682338;2008.417558907915;2076.885771282579;2139.743230812297;80023.19976800216;84054;85218;90150.54924725334;90800.5459972709;10393.272470927113;10447.79850317208;10708.250422470508;10735.785284294427;10848;14583.197924114063;14594.41622335116;14672.559823205322;14677;14701.779473307908;8152.38857085721;8312.5428101455;8427.620757065946;8456.40805143634;8550.572471376407;8403;8422.620982055822;8480.915190848136;8624.827503449897;8642.740717778477;4274.636655884285;4329.848455304049;4435.645148388186;4458.375827384169;4489.595936365743;1780.7417924400888;1817.409341963867;1849.3712137873188;1897.7817550981813;1900.382375727894;982.9606815727434;986.8125056239292;1011.246621267146;1043.3009883378154;1081.0648788797632;18548.258069677333;19172.328968486036;19467.318643847397;19489;19614.803851961296;990.6978371596588;1001.9398836069859;1027.7790275090892;1053.3521884041259;1094.141099237095;10316.329438586468;10915.890841091647;11012.779744405067;11055.889441105646;11069.612563560237;464906;465547;470556;473597;475770;93328;98118.50940745251;98238.50880745694;98393.50803245937;98454.5077274609;1045.1884430880907;1064.9094826939643;1109.1348747976592;1124.5108377855659;1130.304862509567;17305.480835574952;17375.304987800348;17501.21244543973;17542;17802.5549361267;39789.40315895322;40171.1965760689;40902.59097408988;41227.38158927678;42219.15561688811;56514;58884.411155887894;58891;59009.40990590039;59209;7322.597257150908;7909.841803163789;7968.282854543119;8388.24505794457;8418.87371689413;12324.383780811102;13662.385192666155;13915.304234788422;13917.791233131713;13924.791128133289;11762.58830940913;12086.939565302117;12160.513579456723;12257.080718945936;12289.1397602167;11239.887601123884;11573.13201509907;11933.582324618597;12119.515219391125;12297.508099675913;11615.419229038684;11692.824607630722;11899.167058305835;12035.217710848767;12210.206336588093;7666.578338191453;7958.204179581995;7960.681572737026;8039.316658083894;8069.677212911418;11683.474243659226;11691.649250522498;11831.526738930346;11924.582639607572;12316.815247771112 08:32:20 INFO - PROCESS | 11104 | |3;mootools.html;1391.6173052410593;1550.9844901550985;1579.4708772561194;1769.460314604046;1892.5836316010482;8487.405881588284;8903.732888013354;8913.955430222848;9161.90838091619;9188.954055229715;8852.51311177885;9052;9063.27493800496;9072.818543629124;9075.500847453388;2055.845811564139;2335.754745751697;2372;2395.1138078910826;2410.7950824179966;2450.0567281596536;2471.938201544967;2478.0707234786955;2480.1567467061195;2486.4529803443215;2416.55293770653;2434.257551446808;2436.0742917691255;2437.6587277781123;2440.5851005329137;2049.1291201239414;2303.5392921415782;2361.53949979754;2361.8937147828387;2371.7983971362455;2263.343630347197;2271.6138256496433;2272.0457407888725;2275.1354485295647;2304.8040916522114;8786.341024423195;8829.117088291183;8830;8832;8835.734927952171;5296.92054619181;5428.45715428458;5433.429489903582;5435.537979271767;5439.428859969726;3284.1953721338186;3298.6371499135075;3391.593008838955;3392.423288041039;3415.777974431654;1092.2900114925283;1110.211749657736;1114.8606424196976;1147.770445910813;1168.748719025405;12903.161294515827;12923.806142907864;12936.870631293756;12940.094193406465;12954.546590869368;4656.278276867091;4709.481956984729;4768.332433459318;4806.375171227788;4809.326694262806;10841;10842.403667798348;10850.67447976562;10851.294665846695;10864.239503234856;4855.028994201174;5338.119210330329;5416.404195538487;5417.729113544307;5424.213489044146;4902.7058376497525;5005.949940500621;5021.171506701427;5088.847334579968;5091.41448733393;4154.854580089683;4208.642265407413;4236.406903033578;4384.802683879233;4426.070525189746;1256.2650849253107;1347.8584748601256;1348.9527866524625;1353.9323033848466;1370.56142034548;878.5651102704202;955.5699935029264;956.297121615612;962.3311798300114;976.4287891583504;5633.63381380209;5771.942280577225;5773.913391299134;5981.5214782817275;6028.517718582503;432.37090034000454;443.32171777180963;456.28819042293463;459.42801212489996;469.3054279666113;3999.460072890123;4005.819738111792;4007.3988901664984;4063.1061166543313;4150.958490415118;10354.326968747007;11046.558137674403;11075.224734268684;11079.169062320358;11081.833772493419;10603.363798172135;10809.729756756144;10862.619808306672;10904.018638322588;10997.945010275058;8195.918040819515;8242;8261.8347633047;8272.793180170544;8284.875726864102;5532.391436942014;5535.501804837584;5559;5620.2625254205495;5693.345265294544;10142.797144057226;10157.695269141937;10236.385816851012;10250.743731406774;10252.794944101226;10058.647947321808;10131;10420.010099040579;10497.2127090467;10522.947385263025;7266.818329541804;7898.3681305496575;7965.92034079675;8056.919430805851;8091.271785539329;9095.909040909506;9132.49771262587;9167.404118732262;9216.95391523038;9226.308026898143;7966.243206895336;8096.028476582847;8154.510729356258;8178.672853086048;8357.540335281617;8032.799180020546;8134.186581342055;8167.714130005421;8202.794930126794;8260.380471464785;6980.650967451708;7219;7240.746573869889;7505.3620442260835;7589.1272503662785;4823.589994850477;4860.489648586848;4915.901681966269;4965.280034395065;4980.003999200102;5127.974360128175;5136.897262054813;5141.485851414828;5147.3308469898675;5249.685018898878 08:32:20 INFO - PROCESS | 11104 | |4;prototype.html;328.26632476415193;330.9453940099883;338.1276307127611;338.9864405423783;339.59757687140757;5133.255677926699;5281.181416880385;5319;5322.494363035516;5324.653897496665;5235.162374020158;5247.714309994048;5250.212468129783;5263;5268.262443257947;4142.958570414303;4148.771817550033;4155.859732237893;4165.791710414483;4207.474065741782;3892.824822882963;4093.4269202311702;4102.917941641165;4206.726562773425;4214.093969796493;4021.658159056484;4031.153457773871;4049.7367671101283;4049.898752531181;4066;4052.1895620875794;4063.6545893599077;4064.3945641471455;4074.286999775057;4087.8773636790943;3570.6072332043454;3596.6942809861193;3599.190182209008;3600.873969411058;3610.4584312353095;4877.951220487786;5059.139946209117;5089.41471730752;5096.719680417576;5098.005888851675;4659.394278743775;4685.554872287127;4693.554112359355;4711.646626503026;4757.26262429324;5280.883202805829;5473.480019398151;5495.890082198373;5497.8075767347955;5498.5876059295715;3977.98011009946;3984.820683069269;3994.940075898864;4004.3192657248337;4013.678905687538;5417.295751552273;5581.888362232733;5689.175069614924;5760.971195143998;5773.855653608652;3987.8205480753436;3999.280129576646;4016.8393264269685;4026.852347081068;4045.130296986103;4096.549379568245;4119.588041195916;4121.216968775923;4123.587641235912;4129.359949207877;4477.350784136347;4581;4683.882902927454;4721.858344249678;4723.126221649006;5485.259489968803;5514.6691198527415;5527.889442211133;5549.94551035302;5553.527950124285;1422.025912250112;1427.1793718611839;1434.8206474190727;1441.3946142620125;1441.5170917742464;909.9135582119688;924.5654542365212;940.9200217981548;946.1437399153639;953.8569214617725;4710.976445117821;4738.62579851846;4761.381020467317;4761.976190119027;4806.206975848946;4990.825321113816;5000.62495312853;5007.624428167902;5036.161800942629;5046.870940017213;4643.535646435329;4788.976055119702;4790.616750659939;4794.472608013116;4803.519648035239;2708.404151086758;2714.57924021773;2720.931976700598;2727.8772455239564;2729.2767416634606;5176.611754118456;5227.294315267466;5228.503292187236;5273.789048438096;5275.498827611371;4962.677425967373;5083.491650834887;5097;5104.387473503203;5179.974100129551;5181.974090129525;5257.842264732064;5286.180642000496;5297.966896455231;5299.867503312371;5075.375879718455;5089.236614507853;5090.211017292326;5103.5661968733075;5142.871428214325;4834.3231947528075;5010.273510340907;5038.9010758384065;5062.746862656926;5409;5685.516731077904;5825.79609713658;5836.212111364912;5896.528277737685;5906.852328691817;4047.85832495873;4067.349224124126;4067.3898915162963;4087.407325937663;4105.3020986432975;5454.481824226692;5475.534579560623;5591.720413979366;5638.689872057076;5675.914861277001;5414.350277966511;5442.401335853132;5459.727013649381;5481.890362192814;5483.2323474712775;5483.561315094703;5491.643043202339;5491.752871120889;5493.176023596492;5507.614466987273;5162.915787684478;5352.197170424468;5365.409804921377;5376.327959005124;5410.648307859977;5502.724863756876;5510.9448905510435;5512.834614961557;5522.475364840334;5545.140503222007;5243.292155558951;5378.838634840961;5409.459054094559;5419.214213938878;5468 08:32:20 INFO - PROCESS | 11104 | |5;yui.html;714.2964180282424;719.7948584653375;725.3000854175721;732.2677322677323;748.1732685382656;12855.935720321397;12994.675133121676;13057.934710326459;13324.666883327909;13597.456101755917;12834.422450989705;13201.537946171886;13206.669833254173;13219.6695082623;13239.867601323984;696.568127760789;827.4166712467711;832.6128350317101;834.7746108550688;836.1011912194415;686.7596341280562;689.1041645860387;689.2005273882272;689.6448329110488;691.9584824910496;876.7106854737953;877.368294827723;877.442823806884;879.4547380624022;880.0451510111504;719.7121151539374;857.536930057768;881.9426737262089;882.2456799436486;882.5984177199359;641.7561326695826;641.8555824939351;642.6304874697067;642.8296501427126;643.5591619740493;13176.60470185896;13194.142380745221;13214;13214.141080829715;13261.86738132616;11969.281843089355;12035.759284814254;12304.876951230463;12670.239785612892;12726.17279876805;11182.217244792868;11297.661070167907;11654.242474239147;11763;12221.205621634654;3803.2013277211818;3803.334416477133;3880.961190388088;3896.5713771485116;3934.350832112698;58932;60167.39832601662;60714.696426517585;61267.693661531855;61414.69292653553;9548.665796697082;9870.555824987892;9896.208303335716;9977.25170612207;10016.54925528353;16592;16599.917000415164;16601.750973735405;16619.6676066478;16667.749983750255;7699.692012319444;7818.296353328228;7877.4091943104495;7916.604169791487;7963.203679631991;4290.570942905684;4441.356003379557;4521.457425109008;4532.750698711537;4603.95396046042;3300.339932013607;3508.2632647143873;3516.2440075383915;3560.2167523145386;3566.732495062881;696.7456878239406;704.7568588836843;706.8833642449041;708.9964550177216;718.5760401363116;608.5192697768713;624.7001439309157;637.4836382530166;638.3233772201388;649.5290914087249;8916.37585369031;9434.103760142776;9468.668596599086;9469.526523673789;9526.761830954281;663.8434245164214;709.7338498063226;727.2182403915812;757.5227606607801;762.5920132729075;4296.806991886931;4307.0955099429475;4333.7833108345085;4341.413909122291;4399.162540161642;68709.31290687129;71137.64431177812;72131;73221;73535.63232183912;63352.36647633557;63814.14072970542;64051.039234411524;64570;64928.35071649317;58742.41257587455;58899.11651325234;58923.70538147282;59122.704386478654;59258;8290.626921788413;8320.375971802017;8391.916080839357;8422.986223159985;8588.312934965063;37838.43242351312;37889.2422151561;38082.42876356912;38411.42382864315;39809.60190398059;49224.75387623039;52008.479915201875;52281.47718522766;52338;52467.212991805914;11412.942935285271;11451.427428628702;11508.53965841357;11718.296902185895;11930.880691192977;12332.260064396165;12568.434420450918;12822.743545129231;12932.806007910078;13036.47854085826;12013.63959081229;12037.939810300892;12197.63407097753;12257.387130643254;12538.561150359694;11796;11972.461239244429;12111.939440302742;12197.451114699683;12325;11768.58809941648;11981.221220620631;12065.336406497727;12147.81778273309;12462.875371246171;10108.342957707726;10131.696049118538;10145.34055286404;10170.745731356776;10265.384076955406;9757.609695612096;10092.646757363456;10119;10128.898711012796;10157.288989770941 08:32:20 INFO - PROCESS | 11104 | __end_tp_report 08:32:20 INFO - PROCESS | 11104 | __start_cc_report 08:32:20 INFO - PROCESS | 11104 | _x_x_mozilla_cycle_collect,806 08:32:20 INFO - PROCESS | 11104 | __end_cc_report 08:32:20 INFO - PROCESS | 11104 | __startTimestamp1463239940663__endTimestamp 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | ------- Summary: start ------- 08:32:20 INFO - PROCESS | 11104 | Number of tests: 6 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | [#0] dojo.html Cycles:165 Average:5376.21 Median:5532.75 stddev:597.99 (10.8%) stddev-sans-first:575.24 08:32:20 INFO - PROCESS | 11104 | Values: 3213.1 3214.8 3226.5 3237.9 3271.8 5204.3 5288.3 5405.9 5491.6 5521.1 5394.0 5397.9 5404.4 5405.6 5454.9 4861.1 4867.6 5044.2 5073.5 5105.2 5041.0 5061.3 5088.2 5100.8 5101.3 4773.5 4891.1 4898.6 4941.3 4968.9 4930.5 4931.7 4936.6 4948.2 4985.8 4778.9 4890.0 4922.4 4934.1 4975.9 5295.5 5339.6 5349.3 5431.7 5439.5 5796.2 5830.9 5875.1 5882.1 5886.1 5640.6 5771.2 5841.7 5844.7 5893.1 5419.1 5520.0 5536.3 5539.7 5541.3 6043.0 6050.2 6051.9 6056.2 6057.2 5543.4 5632.8 5658.3 5800.4 5810.3 5768.0 5790.7 5798.6 5800.7 5841.8 5730.7 5750.1 5763.5 5764.1 5771.8 5535.0 5726.0 5745.1 5780.9 5783.3 4400.8 4444.8 4444.9 4447.4 4478.1 3938.5 3962.0 3965.8 3978.6 4001.6 5323.4 5363.6 5364.2 5382.3 5395.0 5758.3 5766.8 5769.2 5779.6 5780.6 5361.7 5363.0 5383.1 5406.5 5409.7 4859.9 4986.4 5021.1 5035.5 5040.8 6091.0 6100.3 6101.5 6108.5 6108.6 5571.0 5843.7 5857.6 5862.4 5863.5 5976.1 6011.8 6033.8 6035.9 6099.7 5653.1 5654.5 5688.1 5690.9 5717.1 5801.7 5806.2 5810.2 5815.3 5816.2 5428.0 5459.6 5478.6 5520.1 5549.8 5532.8 5534.2 5535.6 5537.3 5545.5 5348.9 5430.0 5435.5 5438.8 5485.9 5627.3 5653.7 5663.8 5731.1 5734.7 5523.5 5544.5 5545.1 5571.4 5575.9 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | [#1] ext.html Cycles:180 Average:62427.86 Median:42184.79 stddev:123909.93 (293.7%) stddev-sans-first:124170.71 08:32:20 INFO - PROCESS | 11104 | Values: 647.9 651.3 652.7 666.8 671.9 42314.6 43686.8 44011.0 47128.5 47192.3 44943.6 45468.8 45510.3 45553.3 45558.3 8968.4 9112.0 9112.9 9113.2 9115.3 8954.3 9049.0 9052.5 9054.3 9062.3 9111.0 9140.5 9142.1 9149.7 9157.2 9068.0 9107.1 9110.7 9113.5 9114.5 8922.3 8981.4 8989.4 8994.6 8996.2 41439.8 41951.2 41957.8 41960.0 41979.2 3618.3 3677.9 3746.8 3855.7 4150.7 31763.2 31895.2 32051.0 32350.5 32656.8 3802.8 3822.6 3855.2 3976.8 4035.1 367778.0 369094.0 369940.0 370261.1 370951.0 52972.7 59089.4 59138.0 59517.0 59586.4 59445.0 60661.7 60820.7 66431.3 66736.3 17284.8 17421.2 17422.5 17429.5 17439.9 11427.5 11901.9 11925.0 12886.8 12927.5 17256.7 17312.8 17326.7 17334.8 17341.2 6778.5 6814.8 6822.6 6882.5 6898.3 1003.7 1129.1 1165.0 1173.8 1184.6 31805.0 31937.0 32145.7 32261.2 32839.3 1172.4 1178.0 1185.2 1251.9 1263.3 16895.6 17127.0 17216.0 17261.0 17376.1 525411.0 527019.0 527029.0 529158.0 532693.0 59996.0 60111.4 60120.0 60218.7 60259.4 1389.5 1395.6 1416.1 1429.2 1440.7 31185.0 31205.4 31881.4 32074.0 32233.2 52845.9 53346.0 53356.5 53363.0 53379.0 435587.0 443188.0 443686.0 444032.0 643073.0 26682.6 27805.4 27866.4 41271.8 42392.8 48731.8 48959.0 49187.0 53571.7 54027.5 39337.4 41981.2 42465.2 42481.6 44661.3 41260.6 41290.0 41979.6 42207.0 42323.6 41663.0 42162.6 42276.0 42737.4 43199.6 36889.6 37093.3 37156.8 37821.0 37930.2 28611.9 28761.9 28926.0 28997.6 29057.0 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | [#2] jquery.html Cycles:180 Average:28474.86 Median:22855.60 stddev:77890.15 (340.8%) stddev-sans-first:78080.15 08:32:20 INFO - PROCESS | 11104 | Values: 412.3 413.4 414.9 421.1 428.6 18268.3 18403.7 19395.4 19881.4 19921.9 11492.9 11706.9 14661.9 20011.6 20114.8 4731.3 5114.8 5234.6 5861.1 5881.1 5710.9 5796.9 5806.7 5819.3 5851.3 5655.5 5680.9 5754.8 5762.4 5770.1 5702.6 5713.4 5758.1 5759.1 5781.5 4935.8 5074.6 5082.7 5083.6 5085.1 12692.1 12721.0 12771.2 22524.8 23186.4 2346.6 2444.0 2594.2 2685.9 3011.0 10135.8 10333.5 10677.6 12185.9 14627.9 1932.0 1975.3 2008.4 2076.9 2139.7 80023.2 84054.0 85218.0 90150.5 90800.5 10393.3 10447.8 10708.3 10735.8 10848.0 14583.2 14594.4 14672.6 14677.0 14701.8 8152.4 8312.5 8427.6 8456.4 8550.6 8403.0 8422.6 8480.9 8624.8 8642.7 4274.6 4329.8 4435.6 4458.4 4489.6 1780.7 1817.4 1849.4 1897.8 1900.4 983.0 986.8 1011.2 1043.3 1081.1 18548.3 19172.3 19467.3 19489.0 19614.8 990.7 1001.9 1027.8 1053.4 1094.1 10316.3 10915.9 11012.8 11055.9 11069.6 464906.0 465547.0 470556.0 473597.0 475770.0 93328.0 98118.5 98238.5 98393.5 98454.5 1045.2 1064.9 1109.1 1124.5 1130.3 17305.5 17375.3 17501.2 17542.0 17802.6 39789.4 40171.2 40902.6 41227.4 42219.2 56514.0 58884.4 58891.0 59009.4 59209.0 7322.6 7909.8 7968.3 8388.2 8418.9 12324.4 13662.4 13915.3 13917.8 13924.8 11762.6 12086.9 12160.5 12257.1 12289.1 11239.9 11573.1 11933.6 12119.5 12297.5 11615.4 11692.8 11899.2 12035.2 12210.2 7666.6 7958.2 7960.7 8039.3 8069.7 11683.5 11691.6 11831.5 11924.6 12316.8 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | [#3] mootools.html Cycles:180 Average:5907.81 Median:2589.39 stddev:3415.40 (131.9%) stddev-sans-first:3408.12 08:32:20 INFO - PROCESS | 11104 | Values: 1391.6 1551.0 1579.5 1769.5 1892.6 8487.4 8903.7 8914.0 9161.9 9189.0 8852.5 9052.0 9063.3 9072.8 9075.5 2055.8 2335.8 2372.0 2395.1 2410.8 2450.1 2471.9 2478.1 2480.2 2486.5 2416.6 2434.3 2436.1 2437.7 2440.6 2049.1 2303.5 2361.5 2361.9 2371.8 2263.3 2271.6 2272.0 2275.1 2304.8 8786.3 8829.1 8830.0 8832.0 8835.7 5296.9 5428.5 5433.4 5435.5 5439.4 3284.2 3298.6 3391.6 3392.4 3415.8 1092.3 1110.2 1114.9 1147.8 1168.7 12903.2 12923.8 12936.9 12940.1 12954.5 4656.3 4709.5 4768.3 4806.4 4809.3 10841.0 10842.4 10850.7 10851.3 10864.2 4855.0 5338.1 5416.4 5417.7 5424.2 4902.7 5005.9 5021.2 5088.8 5091.4 4154.9 4208.6 4236.4 4384.8 4426.1 1256.3 1347.9 1349.0 1353.9 1370.6 878.6 955.6 956.3 962.3 976.4 5633.6 5771.9 5773.9 5981.5 6028.5 432.4 443.3 456.3 459.4 469.3 3999.5 4005.8 4007.4 4063.1 4151.0 10354.3 11046.6 11075.2 11079.2 11081.8 10603.4 10809.7 10862.6 10904.0 10997.9 8195.9 8242.0 8261.8 8272.8 8284.9 5532.4 5535.5 5559.0 5620.3 5693.3 10142.8 10157.7 10236.4 10250.7 10252.8 10058.6 10131.0 10420.0 10497.2 10522.9 7266.8 7898.4 7965.9 8056.9 8091.3 9095.9 9132.5 9167.4 9217.0 9226.3 7966.2 8096.0 8154.5 8178.7 8357.5 8032.8 8134.2 8167.7 8202.8 8260.4 6980.7 7219.0 7240.7 7505.4 7589.1 4823.6 4860.5 4915.9 4965.3 4980.0 5128.0 5136.9 5141.5 5147.3 5249.7 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | [#4] prototype.html Cycles:180 Average:4500.32 Median:5060.94 stddev:1291.78 (25.5%) stddev-sans-first:1256.87 08:32:20 INFO - PROCESS | 11104 | Values: 328.3 330.9 338.1 339.0 339.6 5133.3 5281.2 5319.0 5322.5 5324.7 5235.2 5247.7 5250.2 5263.0 5268.3 4143.0 4148.8 4155.9 4165.8 4207.5 3892.8 4093.4 4102.9 4206.7 4214.1 4021.7 4031.2 4049.7 4049.9 4066.0 4052.2 4063.7 4064.4 4074.3 4087.9 3570.6 3596.7 3599.2 3600.9 3610.5 4878.0 5059.1 5089.4 5096.7 5098.0 4659.4 4685.6 4693.6 4711.6 4757.3 5280.9 5473.5 5495.9 5497.8 5498.6 3978.0 3984.8 3994.9 4004.3 4013.7 5417.3 5581.9 5689.2 5761.0 5773.9 3987.8 3999.3 4016.8 4026.9 4045.1 4096.5 4119.6 4121.2 4123.6 4129.4 4477.4 4581.0 4683.9 4721.9 4723.1 5485.3 5514.7 5527.9 5549.9 5553.5 1422.0 1427.2 1434.8 1441.4 1441.5 909.9 924.6 940.9 946.1 953.9 4711.0 4738.6 4761.4 4762.0 4806.2 4990.8 5000.6 5007.6 5036.2 5046.9 4643.5 4789.0 4790.6 4794.5 4803.5 2708.4 2714.6 2720.9 2727.9 2729.3 5176.6 5227.3 5228.5 5273.8 5275.5 4962.7 5083.5 5097.0 5104.4 5180.0 5182.0 5257.8 5286.2 5298.0 5299.9 5075.4 5089.2 5090.2 5103.6 5142.9 4834.3 5010.3 5038.9 5062.7 5409.0 5685.5 5825.8 5836.2 5896.5 5906.9 4047.9 4067.3 4067.4 4087.4 4105.3 5454.5 5475.5 5591.7 5638.7 5675.9 5414.4 5442.4 5459.7 5481.9 5483.2 5483.6 5491.6 5491.8 5493.2 5507.6 5162.9 5352.2 5365.4 5376.3 5410.6 5502.7 5510.9 5512.8 5522.5 5545.1 5243.3 5378.8 5409.5 5419.2 5468.0 08:32:20 INFO - PROCESS | 11104 | 08:32:20 INFO - PROCESS | 11104 | [#5] yui.html Cycles:180 Average:15688.44 Median:50616.62 stddev:19850.70 (39.2%) stddev-sans-first:19874.54 08:32:20 INFO - PROCESS | 11104 | Values: 714.3 719.8 725.3 732.3 748.2 12855.9 12994.7 13057.9 13324.7 13597.5 12834.4 13201.5 13206.7 13219.7 13239.9 696.6 827.4 832.6 834.8 836.1 686.8 689.1 689.2 689.6 692.0 876.7 877.4 877.4 879.5 880.0 719.7 857.5 881.9 882.2 882.6 641.8 641.9 642.6 642.8 643.6 13176.6 13194.1 13214.0 13214.1 13261.9 11969.3 12035.8 12304.9 12670.2 12726.2 11182.2 11297.7 11654.2 11763.0 12221.2 3803.2 3803.3 3881.0 3896.6 3934.4 58932.0 60167.4 60714.7 61267.7 61414.7 9548.7 9870.6 9896.2 9977.3 10016.5 16592.0 16599.9 16601.8 16619.7 16667.7 7699.7 7818.3 7877.4 7916.6 7963.2 4290.6 4441.4 4521.5 4532.8 4604.0 3300.3 3508.3 3516.2 3560.2 3566.7 696.7 704.8 706.9 709.0 718.6 608.5 624.7 637.5 638.3 649.5 8916.4 9434.1 9468.7 9469.5 9526.8 663.8 709.7 727.2 757.5 762.6 4296.8 4307.1 4333.8 4341.4 4399.2 68709.3 71137.6 72131.0 73221.0 73535.6 63352.4 63814.1 64051.0 64570.0 64928.4 58742.4 58899.1 58923.7 59122.7 59258.0 8290.6 8320.4 8391.9 8423.0 8588.3 37838.4 37889.2 38082.4 38411.4 39809.6 49224.8 52008.5 52281.5 52338.0 52467.2 11412.9 11451.4 11508.5 11718.3 11930.9 12332.3 12568.4 12822.7 12932.8 13036.5 12013.6 12037.9 12197.6 12257.4 12538.6 11796.0 11972.5 12111.9 12197.5 12325.0 11768.6 11981.2 12065.3 12147.8 12462.9 10108.3 10131.7 10145.3 10170.7 10265.4 9757.6 10092.6 10119.0 10128.9 10157.3 08:32:20 INFO - PROCESS | 11104 | -------- Summary: end -------- 08:32:20 INFO - PROCESS | 11104 | 08:32:21 INFO - TEST-INFO | 11104: exit 0 08:32:21 INFO - TEST-OK | dromaeo_css | took 1114015ms 08:32:21 INFO - TEST-START | kraken 08:32:21 INFO - operating with platform_type : linux_ 08:32:21 INFO - Initialising browser for kraken test... 08:32:21 INFO - TEST-INFO | started process 11287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNHfotA/profile http://localhost:54883/getInfo.html) 08:32:26 INFO - PROCESS | 11287 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 08:32:26 INFO - PROCESS | 11287 | __metrics Screen width/height:1600/1200 08:32:26 INFO - PROCESS | 11287 | colorDepth:24 08:32:26 INFO - PROCESS | 11287 | Browser inner width/height: 1024/697 08:32:26 INFO - PROCESS | 11287 | __metrics 08:32:27 ERROR - PROCESS | 11287 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:32:27 INFO - PROCESS | 11287 | console.error: PushService: 08:32:27 INFO - PROCESS | 11287 | stateChangeProcessEnqueue: Error transitioning state 08:32:27 INFO - PROCESS | 11287 | UnknownError 08:32:28 INFO - TEST-INFO | 11287: exit 0 08:32:28 INFO - Browser initialized. 08:32:28 INFO - Running cycle 1/1 for kraken test... 08:32:28 INFO - TEST-INFO | started process 11369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNHfotA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:40 INFO - PROCESS | 11369 | RSS: Main: 152481792 08:32:40 INFO - PROCESS | 11369 | 08:32:42 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:43 INFO - PROCESS | 11369 | RSS: Main: 208670720 08:32:43 INFO - PROCESS | 11369 | 08:32:46 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-dft) 08:32:47 INFO - PROCESS | 11369 | RSS: Main: 197615616 08:32:47 INFO - PROCESS | 11369 | 08:32:50 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-fft) 08:32:50 INFO - PROCESS | 11369 | RSS: Main: 265871360 08:32:50 INFO - PROCESS | 11369 | 08:32:52 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54883/tests/kraken/driver.html?testName=audio-oscillator) 08:32:53 INFO - PROCESS | 11369 | RSS: Main: 174698496 08:32:53 INFO - PROCESS | 11369 | 08:32:55 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54883/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:32:56 INFO - PROCESS | 11369 | RSS: Main: 178454528 08:32:56 INFO - PROCESS | 11369 | 08:32:59 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54883/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:00 INFO - PROCESS | 11369 | RSS: Main: 214511616 08:33:00 INFO - PROCESS | 11369 | 08:33:03 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54883/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:04 INFO - PROCESS | 11369 | RSS: Main: 212463616 08:33:04 INFO - PROCESS | 11369 | 08:33:07 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54883/tests/kraken/driver.html?testName=json-parse-financial) 08:33:08 INFO - PROCESS | 11369 | RSS: Main: 214122496 08:33:08 INFO - PROCESS | 11369 | 08:33:09 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54883/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:10 INFO - PROCESS | 11369 | RSS: Main: 203497472 08:33:10 INFO - PROCESS | 11369 | 08:33:12 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:12 INFO - PROCESS | 11369 | RSS: Main: 207101952 08:33:12 INFO - PROCESS | 11369 | 08:33:14 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:15 INFO - PROCESS | 11369 | RSS: Main: 216793088 08:33:15 INFO - PROCESS | 11369 | 08:33:18 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:18 INFO - PROCESS | 11369 | RSS: Main: 223793152 08:33:18 INFO - PROCESS | 11369 | 08:33:21 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:22 INFO - PROCESS | 11369 | RSS: Main: 220827648 08:33:22 INFO - PROCESS | 11369 | 08:33:23 INFO - PROCESS | 11369 | Cycle 1(1): loaded http://localhost:54883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54883/tests/kraken/driver.html?testName=ai-astar) 08:33:24 INFO - PROCESS | 11369 | RSS: Main: 266547200 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | __start_tp_report 08:33:24 INFO - PROCESS | 11369 | _x_x_mozilla_page_load 08:33:24 INFO - PROCESS | 11369 | _x_x_mozilla_page_load_details 08:33:24 INFO - PROCESS | 11369 | |i|pagename|runs| 08:33:24 INFO - PROCESS | 11369 | |0;ai-astar;111;106;109;109;110;110;110;110;108;110 08:33:24 INFO - PROCESS | 11369 | |1;audio-beat-detection;148;124;151;207;130;149;148;128;176;126 08:33:24 INFO - PROCESS | 11369 | |2;audio-dft;159;159;161;160;160;159;160;160;161;160 08:33:24 INFO - PROCESS | 11369 | |3;audio-fft;75;75;76;156;76;75;77;75;127;74 08:33:24 INFO - PROCESS | 11369 | |4;audio-oscillator;90;91;156;90;91;91;127;91;91;120 08:33:24 INFO - PROCESS | 11369 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;116;117 08:33:24 INFO - PROCESS | 11369 | |6;imaging-darkroom;145;145;145;145;145;145;146;146;145;145 08:33:24 INFO - PROCESS | 11369 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 08:33:24 INFO - PROCESS | 11369 | |8;json-parse-financial;56;56;56;57;56;62;57;115;55;54 08:33:24 INFO - PROCESS | 11369 | |9;json-stringify-tinderbox;59;59;59;59;59;60;58;59;60;59 08:33:24 INFO - PROCESS | 11369 | |10;stanford-crypto-aes;78;83;80;77;78;78;78;79;82;80 08:33:24 INFO - PROCESS | 11369 | |11;stanford-crypto-ccm;125;119;126;118;127;118;117;118;192;132 08:33:24 INFO - PROCESS | 11369 | |12;stanford-crypto-pbkdf2;164;169;162;160;164;161;157;164;164;159 08:33:24 INFO - PROCESS | 11369 | |13;stanford-crypto-sha256-iterative;62;62;63;62;63;62;64;62;61;60 08:33:24 INFO - PROCESS | 11369 | __end_tp_report 08:33:24 INFO - PROCESS | 11369 | __start_cc_report 08:33:24 INFO - PROCESS | 11369 | _x_x_mozilla_cycle_collect,1850 08:33:24 INFO - PROCESS | 11369 | __end_cc_report 08:33:24 INFO - PROCESS | 11369 | __startTimestamp1463240004040__endTimestamp 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | ------- Summary: start ------- 08:33:24 INFO - PROCESS | 11369 | Number of tests: 14 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.42 (1.3%) stddev-sans-first:1.36 08:33:24 INFO - PROCESS | 11369 | Values: 111.0 106.0 109.0 109.0 110.0 110.0 110.0 110.0 108.0 110.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:148.50 stddev:25.94 (17.5%) stddev-sans-first:27.51 08:33:24 INFO - PROCESS | 11369 | Values: 148.0 124.0 151.0 207.0 130.0 149.0 148.0 128.0 176.0 126.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 08:33:24 INFO - PROCESS | 11369 | Values: 159.0 159.0 161.0 160.0 160.0 159.0 160.0 160.0 161.0 160.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#3] audio-fft Cycles:10 Average:88.60 Median:75.00 stddev:28.72 (38.3%) stddev-sans-first:30.04 08:33:24 INFO - PROCESS | 11369 | Values: 75.0 75.0 76.0 156.0 76.0 75.0 77.0 75.0 127.0 74.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:91.00 stddev:22.91 (25.2%) stddev-sans-first:23.75 08:33:24 INFO - PROCESS | 11369 | Values: 90.0 91.0 156.0 90.0 91.0 91.0 127.0 91.0 91.0 120.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:33:24 INFO - PROCESS | 11369 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:33:24 INFO - PROCESS | 11369 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:33:24 INFO - PROCESS | 11369 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:56.00 stddev:18.60 (33.2%) stddev-sans-first:19.59 08:33:24 INFO - PROCESS | 11369 | Values: 56.0 56.0 56.0 57.0 56.0 62.0 57.0 115.0 55.0 54.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 08:33:24 INFO - PROCESS | 11369 | Values: 59.0 59.0 59.0 59.0 59.0 60.0 58.0 59.0 60.0 59.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.50 stddev:1.95 (2.4%) stddev-sans-first:2.01 08:33:24 INFO - PROCESS | 11369 | Values: 78.0 83.0 80.0 77.0 78.0 78.0 78.0 79.0 82.0 80.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:125.50 stddev:22.64 (18.0%) stddev-sans-first:23.96 08:33:24 INFO - PROCESS | 11369 | Values: 125.0 119.0 126.0 118.0 127.0 118.0 117.0 118.0 192.0 132.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:164.00 stddev:3.37 (2.1%) stddev-sans-first:3.53 08:33:24 INFO - PROCESS | 11369 | Values: 164.0 169.0 162.0 160.0 164.0 161.0 157.0 164.0 164.0 159.0 08:33:24 INFO - PROCESS | 11369 | 08:33:24 INFO - PROCESS | 11369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 08:33:24 INFO - PROCESS | 11369 | Values: 62.0 62.0 63.0 62.0 63.0 62.0 64.0 62.0 61.0 60.0 08:33:24 INFO - PROCESS | 11369 | -------- Summary: end -------- 08:33:24 INFO - PROCESS | 11369 | 08:33:25 INFO - TEST-INFO | 11369: exit 0 08:33:25 INFO - TEST-OK | kraken | took 63641ms 08:33:25 INFO - SUITE-END | took 1177s 08:33:25 INFO - Completed test suite (00:19:37) 08:33:25 INFO - javascript benchmark 08:33:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.052149615863, 3214.8231847248408, 3226.4515032444488, 3237.854296556655, 3271.8364081795903, 5204.32343795307, 5288.286081379013, 5405.91891121633, 5491.588130890184, 5521.0614195586795, 5394.0, 5397.892042159165, 5404.351477822667, 5405.594580406466, 5454.91817622736, 4861.100696371173, 4867.610591152717, 5044.167712327461, 5073.518015788494, 5105.234214867781, 5041.04220198163, 5061.266116413118, 5088.236764485338, 5100.821471248507, 5101.311322971407, 4773.498782627827, 4891.095147397743, 4898.632602554805, 4941.308216849644, 4968.925466117993, 4930.506949305077, 4931.65478416511, 4936.555709986119, 4948.208286674115, 4985.800567977277, 4778.904421911542, 4889.9511004889855, 4922.433920099199, 4934.08719386911, 4975.925361119586, 5295.496927791892, 5339.5728341732565, 5349.331333583302, 5431.6740995540395, 5439.456054394568, 5796.2464879565805, 5830.883382332372, 5875.148103525008, 5882.088276317178, 5886.117082437626, 5640.633358831704, 5771.220885180531, 5841.678707671076, 5844.707764611752, 5893.14549390336, 5419.132938729785, 5520.0, 5536.307961504852, 5539.695316757577, 5541.27963364764, 6042.969785151134, 6050.2437195350585, 6051.939480605226, 6056.152138700585, 6057.182280392179, 5543.417941116206, 5632.802851900164, 5658.321001479849, 5800.361960184377, 5810.331811841608, 5767.971160144172, 5790.71046447676, 5798.565107616945, 5800.709964501758, 5841.795537156179, 5730.713464326767, 5750.108733146369, 5763.538916886639, 5764.077747560454, 5771.797987070432, 5534.972325138348, 5726.026575482178, 5745.109508026263, 5780.855478612984, 5783.306003279633, 4400.801963911632, 4444.777761111996, 4444.933326000112, 4447.399601053817, 4478.149151661174, 3938.4683067786054, 3961.980190099031, 3965.8215380307956, 3978.6419222269556, 4001.6198461146146, 5323.414424413311, 5363.597730170253, 5364.195370694349, 5382.273393091882, 5394.973025134849, 5758.280214973129, 5766.798162064308, 5769.221155144086, 5779.624324418899, 5780.624259423124, 5361.731913404392, 5363.0, 5383.084875571162, 5406.513413792777, 5409.702466364309, 4859.927101093486, 4986.351774269394, 5021.07110184617, 5035.496450354935, 5040.84877453677, 6090.969545152246, 6100.267967843887, 6101.481374083252, 6108.5418593605655, 6108.5723999319625, 5571.0, 5843.707814609253, 5857.619254748598, 5862.355140934408, 5863.530917526502, 5976.133460648095, 6011.849703757441, 6033.818985430444, 6035.909461358171, 6099.66451845135, 5653.067243904709, 5654.46282603152, 5688.089905615082, 5690.8577285566535, 5717.113847353667, 5801.6519008859605, 5806.216160818235, 5810.1575271586225, 5815.273090863642, 5816.21481100063, 5427.972860135674, 5459.590530710292, 5478.561715062706, 5520.089185284383, 5549.805756798492, 5532.75102620375, 5534.225208470737, 5535.612507124462, 5537.307836520435, 5545.528630066489, 5348.893022139613, 5430.0, 5435.483629055233, 5438.75525601341, 5485.917711234414, 5627.324721033502, 5653.745581448927, 5663.801766938137, 5731.111677689964, 5734.741936612946, 5523.530499907552, 5544.528715059265, 5545.085060964896, 5571.3592936811165, 5575.888482230252], "value": 5337.445665496342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.9319671434499, 651.2673242602073, 652.654093330535, 666.7732970789932, 671.936166064224, 42314.57685423148, 43686.78156609216, 44011.0, 47128.52871471284, 47192.29211561829, 44943.55056449435, 45468.77265613675, 45510.31734523985, 45553.316700249525, 45558.31662525056, 8968.372213945026, 9111.954440227822, 9112.908870911306, 9113.225375843062, 9115.316351273648, 8954.32842536809, 9049.049849765779, 9052.456852588833, 9054.275657947348, 9062.275017998578, 9110.954445227797, 9140.542972851365, 9142.085791420872, 9149.725508234731, 9157.221636160933, 9068.047854975232, 9107.089291070906, 9110.726678199599, 9113.453192808453, 9114.498702571356, 8922.330825188137, 8981.371304008722, 8989.37074404792, 8994.550272486349, 8996.235319997808, 41439.79280103611, 41951.160976780295, 41957.790211049054, 41960.0, 41979.16041679149, 3618.330608837347, 3677.9448308275396, 3746.7751934883995, 3855.6529912307747, 4150.709450338478, 31763.205919851956, 31895.202619934455, 32051.0, 32350.514742278883, 32656.83671581627, 3802.790846503441, 3822.5986271441375, 3855.235605981851, 3976.8210430530694, 4035.051762835731, 367778.0, 369094.0, 369940.0, 370261.1486942575, 370951.0, 52972.735136324074, 59089.40910590839, 59138.0, 59517.0, 59586.40413595809, 59445.0, 60661.69669151714, 60820.695896520236, 66431.33568664348, 66736.33263667398, 17284.827151728572, 17421.216045277994, 17422.47732568025, 17429.477115686295, 17439.912800435915, 11427.542898283975, 11901.88098119025, 11925.0, 12886.80669789954, 12927.482900684055, 17256.65486690259, 17312.826871731373, 17326.65346693059, 17334.826651733572, 17341.219645116, 6778.543931216024, 6814.8296292592095, 6822.590644561342, 6882.518223724392, 6898.309404468585, 1003.6938733686296, 1129.0572372069414, 1164.976700466003, 1173.7828501727208, 1184.6268425445958, 31805.0, 31937.0, 32145.678543214737, 32261.193470162965, 32839.3432131356, 1172.355204637446, 1178.0340121100787, 1185.1940680337452, 1251.9061070419755, 1263.317808383481, 16895.577610559587, 17127.0, 17216.0, 17261.0, 17376.131193440277, 525411.0, 527019.0, 527029.0, 529158.0, 532693.0, 59996.0, 60111.39888601058, 60120.0, 60218.69890650606, 60259.397406026255, 1389.4789453954768, 1395.5673741140279, 1416.051245665386, 1429.2425014742203, 1440.6614445605273, 31185.0, 31205.375892482476, 31881.36237275195, 32074.0, 32233.194170144994, 52845.886164554526, 53346.0, 53356.46643533515, 53363.0, 53379.0, 435587.0, 443188.0, 443686.0, 444032.0, 643073.0, 26682.59976100399, 27805.44389112166, 27866.44267114687, 41271.793641032804, 42392.788036059625, 48731.83243089188, 48959.0, 49187.0, 53571.732141339045, 54027.459725403816, 39337.40993885037, 41981.160376792905, 42465.15069698651, 42481.57518424776, 44661.330080048174, 41260.58739412567, 41290.0, 41979.58020419757, 42207.0, 42323.57676423196, 41663.0, 42162.57837421587, 42276.0, 42737.358939616555, 43199.56800431955, 36889.63110368862, 37093.258134836615, 37156.814215928745, 37821.0, 37930.24139517139, 28611.856940715163, 28761.856190718914, 28926.0, 28997.56503652489, 29057.0], "value": 20633.848255880093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.3363074538481, 413.4356603236583, 414.85894795769434, 421.1114548303081, 428.60568277184984, 18268.269269229233, 18403.723944140816, 19395.418137455898, 19881.40355789325, 19921.900390498064, 11492.885071149287, 11706.941465292683, 14661.853381466182, 20011.59976800463, 20114.79885201151, 4731.313959475874, 5114.769835357409, 5234.633575649687, 5861.1208318752315, 5881.14723365114, 5710.942890571083, 5796.855078623026, 5806.7096645167785, 5819.33077696064, 5851.268591426072, 5655.5475561954945, 5680.857978550549, 5754.769809207627, 5762.423757624246, 5770.105633626795, 5702.600817942745, 5713.3750348619515, 5758.136279558058, 5759.136129580555, 5781.53747700183, 4935.827246046371, 5074.644774865761, 5082.745862706887, 5083.593312535026, 5085.1355269604255, 12692.138126445769, 12721.045921555828, 12771.233725976379, 22524.774752252433, 23186.42033949148, 2346.5541547105995, 2444.046821739523, 2594.1957993022224, 2685.8522781247025, 3010.9548356774667, 10135.847962280572, 10333.483325833753, 10677.572897084106, 12185.878141218564, 14627.902907281996, 1931.9613607727767, 1975.338261682338, 2008.417558907915, 2076.885771282579, 2139.743230812297, 80023.19976800216, 84054.0, 85218.0, 90150.54924725334, 90800.5459972709, 10393.272470927113, 10447.79850317208, 10708.250422470508, 10735.785284294427, 10848.0, 14583.197924114063, 14594.41622335116, 14672.559823205322, 14677.0, 14701.779473307908, 8152.38857085721, 8312.5428101455, 8427.620757065946, 8456.40805143634, 8550.572471376407, 8403.0, 8422.620982055822, 8480.915190848136, 8624.827503449897, 8642.740717778477, 4274.636655884285, 4329.848455304049, 4435.645148388186, 4458.375827384169, 4489.595936365743, 1780.7417924400888, 1817.409341963867, 1849.3712137873188, 1897.7817550981813, 1900.382375727894, 982.9606815727434, 986.8125056239292, 1011.246621267146, 1043.3009883378154, 1081.0648788797632, 18548.258069677333, 19172.328968486036, 19467.318643847397, 19489.0, 19614.803851961296, 990.6978371596588, 1001.9398836069859, 1027.7790275090892, 1053.3521884041259, 1094.141099237095, 10316.329438586468, 10915.890841091647, 11012.779744405067, 11055.889441105646, 11069.612563560237, 464906.0, 465547.0, 470556.0, 473597.0, 475770.0, 93328.0, 98118.50940745251, 98238.50880745694, 98393.50803245937, 98454.5077274609, 1045.1884430880907, 1064.9094826939643, 1109.1348747976592, 1124.5108377855659, 1130.304862509567, 17305.480835574952, 17375.304987800348, 17501.21244543973, 17542.0, 17802.5549361267, 39789.40315895322, 40171.1965760689, 40902.59097408988, 41227.38158927678, 42219.15561688811, 56514.0, 58884.411155887894, 58891.0, 59009.40990590039, 59209.0, 7322.597257150908, 7909.841803163789, 7968.282854543119, 8388.24505794457, 8418.87371689413, 12324.383780811102, 13662.385192666155, 13915.304234788422, 13917.791233131713, 13924.791128133289, 11762.58830940913, 12086.939565302117, 12160.513579456723, 12257.080718945936, 12289.1397602167, 11239.887601123884, 11573.13201509907, 11933.582324618597, 12119.515219391125, 12297.508099675913, 11615.419229038684, 11692.824607630722, 11899.167058305835, 12035.217710848767, 12210.206336588093, 7666.578338191453, 7958.204179581995, 7960.681572737026, 8039.316658083894, 8069.677212911418, 11683.474243659226, 11691.649250522498, 11831.526738930346, 11924.582639607572, 12316.815247771112], "value": 9157.252289107835, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.6173052410593, 1550.9844901550985, 1579.4708772561194, 1769.460314604046, 1892.5836316010482, 8487.405881588284, 8903.732888013354, 8913.955430222848, 9161.90838091619, 9188.954055229715, 8852.51311177885, 9052.0, 9063.27493800496, 9072.818543629124, 9075.500847453388, 2055.845811564139, 2335.754745751697, 2372.0, 2395.1138078910826, 2410.7950824179966, 2450.0567281596536, 2471.938201544967, 2478.0707234786955, 2480.1567467061195, 2486.4529803443215, 2416.55293770653, 2434.257551446808, 2436.0742917691255, 2437.6587277781123, 2440.5851005329137, 2049.1291201239414, 2303.5392921415782, 2361.53949979754, 2361.8937147828387, 2371.7983971362455, 2263.343630347197, 2271.6138256496433, 2272.0457407888725, 2275.1354485295647, 2304.8040916522114, 8786.341024423195, 8829.117088291183, 8830.0, 8832.0, 8835.734927952171, 5296.92054619181, 5428.45715428458, 5433.429489903582, 5435.537979271767, 5439.428859969726, 3284.1953721338186, 3298.6371499135075, 3391.593008838955, 3392.423288041039, 3415.777974431654, 1092.2900114925283, 1110.211749657736, 1114.8606424196976, 1147.770445910813, 1168.748719025405, 12903.161294515827, 12923.806142907864, 12936.870631293756, 12940.094193406465, 12954.546590869368, 4656.278276867091, 4709.481956984729, 4768.332433459318, 4806.375171227788, 4809.326694262806, 10841.0, 10842.403667798348, 10850.67447976562, 10851.294665846695, 10864.239503234856, 4855.028994201174, 5338.119210330329, 5416.404195538487, 5417.729113544307, 5424.213489044146, 4902.7058376497525, 5005.949940500621, 5021.171506701427, 5088.847334579968, 5091.41448733393, 4154.854580089683, 4208.642265407413, 4236.406903033578, 4384.802683879233, 4426.070525189746, 1256.2650849253107, 1347.8584748601256, 1348.9527866524625, 1353.9323033848466, 1370.56142034548, 878.5651102704202, 955.5699935029264, 956.297121615612, 962.3311798300114, 976.4287891583504, 5633.63381380209, 5771.942280577225, 5773.913391299134, 5981.5214782817275, 6028.517718582503, 432.37090034000454, 443.32171777180963, 456.28819042293463, 459.42801212489996, 469.3054279666113, 3999.460072890123, 4005.819738111792, 4007.3988901664984, 4063.1061166543313, 4150.958490415118, 10354.326968747007, 11046.558137674403, 11075.224734268684, 11079.169062320358, 11081.833772493419, 10603.363798172135, 10809.729756756144, 10862.619808306672, 10904.018638322588, 10997.945010275058, 8195.918040819515, 8242.0, 8261.8347633047, 8272.793180170544, 8284.875726864102, 5532.391436942014, 5535.501804837584, 5559.0, 5620.2625254205495, 5693.345265294544, 10142.797144057226, 10157.695269141937, 10236.385816851012, 10250.743731406774, 10252.794944101226, 10058.647947321808, 10131.0, 10420.010099040579, 10497.2127090467, 10522.947385263025, 7266.818329541804, 7898.3681305496575, 7965.92034079675, 8056.919430805851, 8091.271785539329, 9095.909040909506, 9132.49771262587, 9167.404118732262, 9216.95391523038, 9226.308026898143, 7966.243206895336, 8096.028476582847, 8154.510729356258, 8178.672853086048, 8357.540335281617, 8032.799180020546, 8134.186581342055, 8167.714130005421, 8202.794930126794, 8260.380471464785, 6980.650967451708, 7219.0, 7240.746573869889, 7505.3620442260835, 7589.1272503662785, 4823.589994850477, 4860.489648586848, 4915.901681966269, 4965.280034395065, 4980.003999200102, 5127.974360128175, 5136.897262054813, 5141.485851414828, 5147.3308469898675, 5249.685018898878], "value": 4628.750207908885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.26632476415193, 330.9453940099883, 338.1276307127611, 338.9864405423783, 339.59757687140757, 5133.255677926699, 5281.181416880385, 5319.0, 5322.494363035516, 5324.653897496665, 5235.162374020158, 5247.714309994048, 5250.212468129783, 5263.0, 5268.262443257947, 4142.958570414303, 4148.771817550033, 4155.859732237893, 4165.791710414483, 4207.474065741782, 3892.824822882963, 4093.4269202311702, 4102.917941641165, 4206.726562773425, 4214.093969796493, 4021.658159056484, 4031.153457773871, 4049.7367671101283, 4049.898752531181, 4066.0, 4052.1895620875794, 4063.6545893599077, 4064.3945641471455, 4074.286999775057, 4087.8773636790943, 3570.6072332043454, 3596.6942809861193, 3599.190182209008, 3600.873969411058, 3610.4584312353095, 4877.951220487786, 5059.139946209117, 5089.41471730752, 5096.719680417576, 5098.005888851675, 4659.394278743775, 4685.554872287127, 4693.554112359355, 4711.646626503026, 4757.26262429324, 5280.883202805829, 5473.480019398151, 5495.890082198373, 5497.8075767347955, 5498.5876059295715, 3977.98011009946, 3984.820683069269, 3994.940075898864, 4004.3192657248337, 4013.678905687538, 5417.295751552273, 5581.888362232733, 5689.175069614924, 5760.971195143998, 5773.855653608652, 3987.8205480753436, 3999.280129576646, 4016.8393264269685, 4026.852347081068, 4045.130296986103, 4096.549379568245, 4119.588041195916, 4121.216968775923, 4123.587641235912, 4129.359949207877, 4477.350784136347, 4581.0, 4683.882902927454, 4721.858344249678, 4723.126221649006, 5485.259489968803, 5514.6691198527415, 5527.889442211133, 5549.94551035302, 5553.527950124285, 1422.025912250112, 1427.1793718611839, 1434.8206474190727, 1441.3946142620125, 1441.5170917742464, 909.9135582119688, 924.5654542365212, 940.9200217981548, 946.1437399153639, 953.8569214617725, 4710.976445117821, 4738.62579851846, 4761.381020467317, 4761.976190119027, 4806.206975848946, 4990.825321113816, 5000.62495312853, 5007.624428167902, 5036.161800942629, 5046.870940017213, 4643.535646435329, 4788.976055119702, 4790.616750659939, 4794.472608013116, 4803.519648035239, 2708.404151086758, 2714.57924021773, 2720.931976700598, 2727.8772455239564, 2729.2767416634606, 5176.611754118456, 5227.294315267466, 5228.503292187236, 5273.789048438096, 5275.498827611371, 4962.677425967373, 5083.491650834887, 5097.0, 5104.387473503203, 5179.974100129551, 5181.974090129525, 5257.842264732064, 5286.180642000496, 5297.966896455231, 5299.867503312371, 5075.375879718455, 5089.236614507853, 5090.211017292326, 5103.5661968733075, 5142.871428214325, 4834.3231947528075, 5010.273510340907, 5038.9010758384065, 5062.746862656926, 5409.0, 5685.516731077904, 5825.79609713658, 5836.212111364912, 5896.528277737685, 5906.852328691817, 4047.85832495873, 4067.349224124126, 4067.3898915162963, 4087.407325937663, 4105.3020986432975, 5454.481824226692, 5475.534579560623, 5591.720413979366, 5638.689872057076, 5675.914861277001, 5414.350277966511, 5442.401335853132, 5459.727013649381, 5481.890362192814, 5483.2323474712775, 5483.561315094703, 5491.643043202339, 5491.752871120889, 5493.176023596492, 5507.614466987273, 5162.915787684478, 5352.197170424468, 5365.409804921377, 5376.327959005124, 5410.648307859977, 5502.724863756876, 5510.9448905510435, 5512.834614961557, 5522.475364840334, 5545.140503222007, 5243.292155558951, 5378.838634840961, 5409.459054094559, 5419.214213938878, 5468.0], "value": 4094.8200605486904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.2964180282424, 719.7948584653375, 725.3000854175721, 732.2677322677323, 748.1732685382656, 12855.935720321397, 12994.675133121676, 13057.934710326459, 13324.666883327909, 13597.456101755917, 12834.422450989705, 13201.537946171886, 13206.669833254173, 13219.6695082623, 13239.867601323984, 696.568127760789, 827.4166712467711, 832.6128350317101, 834.7746108550688, 836.1011912194415, 686.7596341280562, 689.1041645860387, 689.2005273882272, 689.6448329110488, 691.9584824910496, 876.7106854737953, 877.368294827723, 877.442823806884, 879.4547380624022, 880.0451510111504, 719.7121151539374, 857.536930057768, 881.9426737262089, 882.2456799436486, 882.5984177199359, 641.7561326695826, 641.8555824939351, 642.6304874697067, 642.8296501427126, 643.5591619740493, 13176.60470185896, 13194.142380745221, 13214.0, 13214.141080829715, 13261.86738132616, 11969.281843089355, 12035.759284814254, 12304.876951230463, 12670.239785612892, 12726.17279876805, 11182.217244792868, 11297.661070167907, 11654.242474239147, 11763.0, 12221.205621634654, 3803.2013277211818, 3803.334416477133, 3880.961190388088, 3896.5713771485116, 3934.350832112698, 58932.0, 60167.39832601662, 60714.696426517585, 61267.693661531855, 61414.69292653553, 9548.665796697082, 9870.555824987892, 9896.208303335716, 9977.25170612207, 10016.54925528353, 16592.0, 16599.917000415164, 16601.750973735405, 16619.6676066478, 16667.749983750255, 7699.692012319444, 7818.296353328228, 7877.4091943104495, 7916.604169791487, 7963.203679631991, 4290.570942905684, 4441.356003379557, 4521.457425109008, 4532.750698711537, 4603.95396046042, 3300.339932013607, 3508.2632647143873, 3516.2440075383915, 3560.2167523145386, 3566.732495062881, 696.7456878239406, 704.7568588836843, 706.8833642449041, 708.9964550177216, 718.5760401363116, 608.5192697768713, 624.7001439309157, 637.4836382530166, 638.3233772201388, 649.5290914087249, 8916.37585369031, 9434.103760142776, 9468.668596599086, 9469.526523673789, 9526.761830954281, 663.8434245164214, 709.7338498063226, 727.2182403915812, 757.5227606607801, 762.5920132729075, 4296.806991886931, 4307.0955099429475, 4333.7833108345085, 4341.413909122291, 4399.162540161642, 68709.31290687129, 71137.64431177812, 72131.0, 73221.0, 73535.63232183912, 63352.36647633557, 63814.14072970542, 64051.039234411524, 64570.0, 64928.35071649317, 58742.41257587455, 58899.11651325234, 58923.70538147282, 59122.704386478654, 59258.0, 8290.626921788413, 8320.375971802017, 8391.916080839357, 8422.986223159985, 8588.312934965063, 37838.43242351312, 37889.2422151561, 38082.42876356912, 38411.42382864315, 39809.60190398059, 49224.75387623039, 52008.479915201875, 52281.47718522766, 52338.0, 52467.212991805914, 11412.942935285271, 11451.427428628702, 11508.53965841357, 11718.296902185895, 11930.880691192977, 12332.260064396165, 12568.434420450918, 12822.743545129231, 12932.806007910078, 13036.47854085826, 12013.63959081229, 12037.939810300892, 12197.63407097753, 12257.387130643254, 12538.561150359694, 11796.0, 11972.461239244429, 12111.939440302742, 12197.451114699683, 12325.0, 11768.58809941648, 11981.221220620631, 12065.336406497727, 12147.81778273309, 12462.875371246171, 10108.342957707726, 10131.696049118538, 10145.34055286404, 10170.745731356776, 10265.384076955406, 9757.609695612096, 10092.646757363456, 10119.0, 10128.898711012796, 10157.288989770941], "value": 6675.432792029316, "unit": "score"}], "name": "dromaeo_css", "value": 7095.5173673285035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 108.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 151.0, 207.0, 130.0, 149.0, 148.0, 128.0, 176.0, 126.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 161.0, 160.0, 160.0, 159.0, 160.0, 160.0, 161.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 156.0, 76.0, 75.0, 77.0, 75.0, 127.0, 74.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 156.0, 90.0, 91.0, 91.0, 127.0, 91.0, 91.0, 120.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 62.0, 57.0, 115.0, 55.0, 54.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 59.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 80.0, 77.0, 78.0, 78.0, 78.0, 79.0, 82.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 119.0, 126.0, 118.0, 127.0, 118.0, 117.0, 118.0, 192.0, 132.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 162.0, 160.0, 164.0, 161.0, 157.0, 164.0, 164.0, 159.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 64.0, 62.0, 61.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1521.8, "alertThreshold": 2.0}]} 08:33:25 INFO - Return code: 0 08:33:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:33:25 ERROR - # TBPL SUCCESS # 08:33:25 INFO - Running post-action listener: _resource_record_post_action 08:33:25 INFO - ##### 08:33:25 INFO - ##### Finished run-tests step (success) 08:33:25 INFO - ##### 08:33:25 INFO - Running post-run listener: _resource_record_post_run 08:33:25 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553185280; Read time: 12; Write time: 1040064 08:33:25 INFO - TinderboxPrint: CPU usage
13.2% 08:33:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:33:25 INFO - TinderboxPrint: I/O write bytes / time
553,185,280 / 1,040,064 08:33:25 INFO - TinderboxPrint: CPU idle
8,282.9 (86.8%) 08:33:25 INFO - TinderboxPrint: CPU user
1,206.6 (12.6%) 08:33:25 INFO - TinderboxPrint: Swap in / out
0 / 0 08:33:25 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 246321152; Read time: 0; Write time: 675244 08:33:25 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289632256; Read time: 12; Write time: 341300 08:33:26 INFO - Running post-run listener: _upload_blobber_files 08:33:26 INFO - Blob upload gear active. 08:33:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:26 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 08:33:26 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'] 08:33:26 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 08:33:26 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:33:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:30 INFO - (blobuploader) - INFO - Done attempting. 08:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:30 INFO - (blobuploader) - INFO - Done attempting. 08:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:31 INFO - (blobuploader) - INFO - Done attempting. 08:33:31 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:31 INFO - Return code: 0 08:33:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a4210117e126d56514a0985312e7a15f589c180122b7425a5f843632b9ff2c0cafcee10defdee649544c35a232299c8e108cd0cd9672d8d3f9ae1be1f29c3f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a98ec3cb2363d8a9cb7951045651d82dddfd529ef65b8f437232a32b936b29c9524010f736478712c3fd965c1b7dd5782beb13cee683a545399e906a43a0d5b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b443fdd01cc5a2e22a9e5189fbe9eac9cfc0c98c5802577b08381b37223f8153db44469b5906fe32e22b9ce5d3bff9fbb5a33a1363d0eb874100fc69acc41c4b"} 08:33:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:31 INFO - Contents: 08:33:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a4210117e126d56514a0985312e7a15f589c180122b7425a5f843632b9ff2c0cafcee10defdee649544c35a232299c8e108cd0cd9672d8d3f9ae1be1f29c3f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a98ec3cb2363d8a9cb7951045651d82dddfd529ef65b8f437232a32b936b29c9524010f736478712c3fd965c1b7dd5782beb13cee683a545399e906a43a0d5b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b443fdd01cc5a2e22a9e5189fbe9eac9cfc0c98c5802577b08381b37223f8153db44469b5906fe32e22b9ce5d3bff9fbb5a33a1363d0eb874100fc69acc41c4b"} 08:33:31 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:31 INFO - Copying logs to upload dir... 08:33:31 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.362387 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-14 08:33:31.369527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 08:33:31.373262) ========= 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=745a4373a2a16df560f216e000000264-1463233347.392406-338550269 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/6a4210117e126d56514a0985312e7a15f589c180122b7425a5f843632b9ff2c0cafcee10defdee649544c35a232299c8e108cd0cd9672d8d3f9ae1be1f29c3f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a98ec3cb2363d8a9cb7951045651d82dddfd529ef65b8f437232a32b936b29c9524010f736478712c3fd965c1b7dd5782beb13cee683a545399e906a43a0d5b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b443fdd01cc5a2e22a9e5189fbe9eac9cfc0c98c5802577b08381b37223f8153db44469b5906fe32e22b9ce5d3bff9fbb5a33a1363d0eb874100fc69acc41c4b"} build_url:https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/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/6a4210117e126d56514a0985312e7a15f589c180122b7425a5f843632b9ff2c0cafcee10defdee649544c35a232299c8e108cd0cd9672d8d3f9ae1be1f29c3f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a98ec3cb2363d8a9cb7951045651d82dddfd529ef65b8f437232a32b936b29c9524010f736478712c3fd965c1b7dd5782beb13cee683a545399e906a43a0d5b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b443fdd01cc5a2e22a9e5189fbe9eac9cfc0c98c5802577b08381b37223f8153db44469b5906fe32e22b9ce5d3bff9fbb5a33a1363d0eb874100fc69acc41c4b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 08:33:31.398175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:33:31.398532) ========= 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=745a4373a2a16df560f216e000000264-1463233347.392406-338550269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:33:31.483591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 08:33:31.483912) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 08:33:31.484200) ========= ========= Total master_lag: 0.18 =========