builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1463238371.49 results: success (0) buildid: 20160514053004 builduid: cda7fbdffbc344b6975807e87f423d69 revision: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.492812) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.493201) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.493480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.508271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.508547) ========= 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=ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 08:06:11-- 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% 221M=0s 2016-05-14 08:06:11 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.650704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.650994) ========= 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=ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019839 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:11.700324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-14 08:06:11.700687) ========= 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=ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 08:06:12,005 truncating revision to first 12 chars 2016-05-14 08:06:12,005 Setting DEBUG logging. 2016-05-14 08:06:12,005 attempt 1/10 2016-05-14 08:06:12,005 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:06:12,947 unpacking tar archive at: fx-team-e9b22ce9e029/testing/mozharness/ program finished with exit code 0 elapsedTime=1.206032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-14 08:06:12.919473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:12.919792) ========= script_repo_revision: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:12.920185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:12.920451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 08:06:12.928022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-14 08:06:12.928305) ========= /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=ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:13 INFO - MultiFileLogger online at 20160514 08:06:13 in /builds/slave/test 08:06:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:06:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:13 INFO - {'append_to_log': False, 08:06:13 INFO - 'base_work_dir': '/builds/slave/test', 08:06:13 INFO - 'blob_upload_branch': 'Fx-Team', 08:06:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:13 INFO - 'branch': 'Fx-Team', 08:06:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:13 INFO - 'config_files': ('talos/linux_config.py',), 08:06:13 INFO - 'default_actions': ('clobber', 08:06:13 INFO - 'read-buildbot-config', 08:06:13 INFO - 'download-and-extract', 08:06:13 INFO - 'populate-webroot', 08:06:13 INFO - 'create-virtualenv', 08:06:13 INFO - 'install', 08:06:13 INFO - 'run-tests'), 08:06:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:13 INFO - 'download_minidump_stackwalk': True, 08:06:13 INFO - 'download_symbols': 'ondemand', 08:06:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:13 INFO - 'installer_path': 'installer.exe', 08:06:13 INFO - 'log_level': 'info', 08:06:13 INFO - 'log_name': 'talos', 08:06:13 INFO - 'log_to_console': True, 08:06:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:13 INFO - 'opt_config_files': (), 08:06:13 INFO - 'pip_index': False, 08:06:13 INFO - 'sps_profile': False, 08:06:13 INFO - 'sps_profile_interval': 0, 08:06:13 INFO - 'suite': 'dromaeojs', 08:06:13 INFO - 'system_bits': '32', 08:06:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:13 INFO - 'title': 'talos-linux64-ix-035', 08:06:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:13 INFO - 'use_talos_json': True, 08:06:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:13 INFO - 'work_dir': 'build'} 08:06:13 INFO - ##### 08:06:13 INFO - ##### Running clobber step. 08:06:13 INFO - ##### 08:06:13 INFO - Running pre-action listener: _resource_record_pre_action 08:06:13 INFO - Running main action method: clobber 08:06:13 INFO - rmtree: /builds/slave/test/build 08:06:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:13 INFO - Running post-action listener: _resource_record_post_action 08:06:13 INFO - ##### 08:06:13 INFO - ##### Finished clobber step (success) 08:06:13 INFO - ##### 08:06:13 INFO - ##### 08:06:13 INFO - ##### Running read-buildbot-config step. 08:06:13 INFO - ##### 08:06:13 INFO - Running pre-action listener: _resource_record_pre_action 08:06:13 INFO - Running main action method: read_buildbot_config 08:06:13 INFO - Using buildbot properties: 08:06:13 INFO - { 08:06:13 INFO - "project": "", 08:06:13 INFO - "product": "firefox", 08:06:13 INFO - "script_repo_revision": "production", 08:06:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:06:13 INFO - "repository": "", 08:06:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:06:13 INFO - "buildid": "20160514053004", 08:06:13 INFO - "pgo_build": "True", 08:06:13 INFO - "basedir": "/builds/slave/test", 08:06:13 INFO - "buildnumber": 87, 08:06:13 INFO - "slavename": "talos-linux64-ix-035", 08:06:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:06:13 INFO - "platform": "ubuntu64_hw", 08:06:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:06:13 INFO - "branch": "fx-team", 08:06:13 INFO - "repo_path": "integration/fx-team", 08:06:13 INFO - "revision": "e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5", 08:06:13 INFO - "stage_platform": "linux64-pgo", 08:06:13 INFO - "builduid": "cda7fbdffbc344b6975807e87f423d69", 08:06:13 INFO - "slavebuilddir": "test" 08:06:13 INFO - } 08:06:13 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:06:13 INFO - Running post-action listener: _resource_record_post_action 08:06:13 INFO - ##### 08:06:13 INFO - ##### Finished read-buildbot-config step (success) 08:06:13 INFO - ##### 08:06:13 INFO - ##### 08:06:13 INFO - ##### Running download-and-extract step. 08:06:13 INFO - ##### 08:06:13 INFO - Running pre-action listener: _resource_record_pre_action 08:06:13 INFO - Running main action method: download_and_extract 08:06:13 INFO - mkdir: /builds/slave/test/build/tests 08:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:16 INFO - Downloaded 1361 bytes. 08:06:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:06:16 INFO - Using the following test package requirements: 08:06:16 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:16 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:06:16 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:06:16 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'jsshell-linux-x86_64.zip'], 08:06:16 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:06:16 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:16 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:06:16 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:06:16 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:06:16 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:16 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:06:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:06: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:06:16 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:06:16 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:06:16 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:06:16 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:06:16 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:06:18 INFO - Downloaded 24023122 bytes. 08:06:18 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:06:18 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:06:19 INFO - Return code: 0 08:06:19 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:06: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:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:20 INFO - Downloaded 24023122 bytes. 08:06:20 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:06:20 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:06:21 INFO - Return code: 0 08:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:22 INFO - Downloaded 10840194 bytes. 08:06:22 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:06:22 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:06:23 INFO - Return code: 0 08:06: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:06:23 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:06:23 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:06:23 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:06:23 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:06:23 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:06:24 INFO - Downloaded 58383953 bytes. 08:06:24 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:06:24 INFO - mkdir: /builds/slave/test/properties 08:06:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:24 INFO - Contents: 08:06:24 INFO - build_url:https://queue.taskcluster.net/v1/task/f1kQm0wnS7GJpD2OXozINA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:06:25 INFO - Running post-action listener: _resource_record_post_action 08:06:25 INFO - Running post-action listener: set_extra_try_arguments 08:06:25 INFO - ##### 08:06:25 INFO - ##### Finished download-and-extract step (success) 08:06:25 INFO - ##### 08:06:25 INFO - ##### 08:06:25 INFO - ##### Running populate-webroot step. 08:06:25 INFO - ##### 08:06:25 INFO - Running pre-action listener: _resource_record_pre_action 08:06:25 INFO - Running main action method: populate_webroot 08:06:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:25 INFO - '--tppagecycles', 08:06:25 INFO - '7'], 08:06:25 INFO - 'tests': ['tsvgm']}}, 08:06:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:06:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['damp', 'tps']}, 08:06:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'tests': ['damp', 'tps']}, 08:06:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['dromaeo_dom']}, 08:06:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['a11yr', 08:06:25 INFO - 'ts_paint', 08:06:25 INFO - 'tpaint', 08:06:25 INFO - 'sessionrestore', 08:06:25 INFO - 'sessionrestore_no_auto_restore', 08:06:25 INFO - 'tabpaint']}, 08:06:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tsvgx', 08:06:25 INFO - 'tsvgr_opacity', 08:06:25 INFO - 'tart', 08:06:25 INFO - 'tscrollx', 08:06:25 INFO - 'cart']}, 08:06:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:25 INFO - 'tsvgr_opacity', 08:06:25 INFO - 'tart', 08:06:25 INFO - 'tscrollx', 08:06:25 INFO - 'cart']}, 08:06:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s'], 08:06:25 INFO - 'tests': ['tp5o']}, 08:06:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'tests': ['tp5o']}, 08:06:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--disable-e10s', 08:06:25 INFO - '--xperf_path', 08:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:25 INFO - 'tests': ['tp5n']}, 08:06:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:25 INFO - 'talos_options': ['--xperf_path', 08:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:25 INFO - 'tests': ['tp5n']}}, 08:06:25 INFO - 'talos.zip': {'path': '', 08:06:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:25 INFO - Running post-action listener: _resource_record_post_action 08:06:25 INFO - ##### 08:06:25 INFO - ##### Finished populate-webroot step (success) 08:06:25 INFO - ##### 08:06:25 INFO - ##### 08:06:25 INFO - ##### Running create-virtualenv step. 08:06:25 INFO - ##### 08:06:25 INFO - Running pre-action listener: _resource_record_pre_action 08:06:25 INFO - Running main action method: create_virtualenv 08:06:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:25 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:06:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:06:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:25 INFO - Using real prefix '/usr' 08:06:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:06:27 INFO - Installing pip.................done. 08:06:27 INFO - Return code: 0 08:06:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:27 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:27 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:06:27 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:06:27 INFO - Using env: {'DISPLAY': ':0', 08:06:27 INFO - 'HOME': '/home/cltbld', 08:06:27 INFO - 'LANG': 'en_US.UTF-8', 08:06:27 INFO - 'LANGUAGE': 'en_US:en', 08:06:27 INFO - 'LOGNAME': 'cltbld', 08:06:27 INFO - 'MAIL': '/var/mail/cltbld', 08:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:27 INFO - 'MOZ_NO_REMOTE': '1', 08:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:27 INFO - 'NO_EM_RESTART': '1', 08:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:27 INFO - 'PWD': '/builds/slave/test', 08:06:27 INFO - 'SHELL': '/bin/bash', 08:06:27 INFO - 'SHLVL': '1', 08:06:27 INFO - 'TERM': 'linux', 08:06:27 INFO - 'TMOUT': '86400', 08:06:27 INFO - 'USER': 'cltbld', 08:06:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:27 INFO - '_': '/tools/buildbot/bin/python'} 08:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:27 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:06:27 INFO - Cleaning up... 08:06:27 INFO - Return code: 0 08:06:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:27 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:27 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:06:27 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:06:27 INFO - Using env: {'DISPLAY': ':0', 08:06:27 INFO - 'HOME': '/home/cltbld', 08:06:27 INFO - 'LANG': 'en_US.UTF-8', 08:06:27 INFO - 'LANGUAGE': 'en_US:en', 08:06:27 INFO - 'LOGNAME': 'cltbld', 08:06:27 INFO - 'MAIL': '/var/mail/cltbld', 08:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:27 INFO - 'MOZ_NO_REMOTE': '1', 08:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:27 INFO - 'NO_EM_RESTART': '1', 08:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:27 INFO - 'PWD': '/builds/slave/test', 08:06:27 INFO - 'SHELL': '/bin/bash', 08:06:27 INFO - 'SHLVL': '1', 08:06:27 INFO - 'TERM': 'linux', 08:06:27 INFO - 'TMOUT': '86400', 08:06:27 INFO - 'USER': 'cltbld', 08:06:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:27 INFO - '_': '/tools/buildbot/bin/python'} 08:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:28 INFO - Downloading/unpacking psutil>=3.1.1 08:06: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:06: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:06: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:06: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:06: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:06: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:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:30 INFO - Installing collected packages: psutil 08:06:30 INFO - Running setup.py install for psutil 08:06:30 INFO - building 'psutil._psutil_linux' extension 08:06:30 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:06:30 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:06:30 INFO - building 'psutil._psutil_posix' extension 08:06:30 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:06:30 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:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:30 INFO - Successfully installed psutil 08:06:30 INFO - Cleaning up... 08:06:30 INFO - Return code: 0 08:06:30 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 08:06:30 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:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:30 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:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:30 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:30 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:06:30 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:06:30 INFO - Using env: {'DISPLAY': ':0', 08:06:30 INFO - 'HOME': '/home/cltbld', 08:06:30 INFO - 'LANG': 'en_US.UTF-8', 08:06:30 INFO - 'LANGUAGE': 'en_US:en', 08:06:30 INFO - 'LOGNAME': 'cltbld', 08:06:30 INFO - 'MAIL': '/var/mail/cltbld', 08:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:30 INFO - 'MOZ_NO_REMOTE': '1', 08:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:30 INFO - 'NO_EM_RESTART': '1', 08:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:30 INFO - 'PWD': '/builds/slave/test', 08:06:30 INFO - 'SHELL': '/bin/bash', 08:06:30 INFO - 'SHLVL': '1', 08:06:30 INFO - 'TERM': 'linux', 08:06:30 INFO - 'TMOUT': '86400', 08:06:30 INFO - 'USER': 'cltbld', 08:06:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:30 INFO - '_': '/tools/buildbot/bin/python'} 08:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.1 08:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:32 INFO - Downloading mozsystemmonitor-0.1.tar.gz 08:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 08:06:32 INFO - Installing collected packages: mozsystemmonitor 08:06:32 INFO - Running setup.py install for mozsystemmonitor 08:06:32 INFO - Successfully installed mozsystemmonitor 08:06:32 INFO - Cleaning up... 08:06:32 INFO - Return code: 0 08:06:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:06:32 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:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:32 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:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:32 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:32 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:06:32 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:06:32 INFO - Using env: {'DISPLAY': ':0', 08:06:32 INFO - 'HOME': '/home/cltbld', 08:06:32 INFO - 'LANG': 'en_US.UTF-8', 08:06:32 INFO - 'LANGUAGE': 'en_US:en', 08:06:32 INFO - 'LOGNAME': 'cltbld', 08:06:32 INFO - 'MAIL': '/var/mail/cltbld', 08:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:32 INFO - 'MOZ_NO_REMOTE': '1', 08:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:32 INFO - 'NO_EM_RESTART': '1', 08:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:32 INFO - 'PWD': '/builds/slave/test', 08:06:32 INFO - 'SHELL': '/bin/bash', 08:06:32 INFO - 'SHLVL': '1', 08:06:32 INFO - 'TERM': 'linux', 08:06:32 INFO - 'TMOUT': '86400', 08:06:32 INFO - 'USER': 'cltbld', 08:06:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:32 INFO - '_': '/tools/buildbot/bin/python'} 08:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06:35 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:06:35 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:06:35 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:06:35 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:06:35 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:06:35 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:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:06:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06:35 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:06:35 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:06:35 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:06:35 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:06:35 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:06:35 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:06:35 INFO - Downloading docopt-0.6.1.tar.gz 08:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:35 INFO - Running setup.py install for blobuploader 08:06:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:06:35 INFO - Running setup.py install for requests 08:06:36 INFO - Running setup.py install for docopt 08:06:36 INFO - Successfully installed blobuploader requests docopt 08:06:36 INFO - Cleaning up... 08:06:36 INFO - Return code: 0 08:06:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:36 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:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:36 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:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:36 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:36 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:06:36 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:06:36 INFO - Using env: {'DISPLAY': ':0', 08:06:36 INFO - 'HOME': '/home/cltbld', 08:06:36 INFO - 'LANG': 'en_US.UTF-8', 08:06:36 INFO - 'LANGUAGE': 'en_US:en', 08:06:36 INFO - 'LOGNAME': 'cltbld', 08:06:36 INFO - 'MAIL': '/var/mail/cltbld', 08:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:36 INFO - 'MOZ_NO_REMOTE': '1', 08:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:36 INFO - 'NO_EM_RESTART': '1', 08:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:36 INFO - 'PWD': '/builds/slave/test', 08:06:36 INFO - 'SHELL': '/bin/bash', 08:06:36 INFO - 'SHLVL': '1', 08:06:36 INFO - 'TERM': 'linux', 08:06:36 INFO - 'TMOUT': '86400', 08:06:36 INFO - 'USER': 'cltbld', 08:06:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:36 INFO - '_': '/tools/buildbot/bin/python'} 08:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:36 INFO - Running setup.py (path:/tmp/pip-ZwFyg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:36 INFO - Running setup.py (path:/tmp/pip-uklMYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:36 INFO - Running setup.py (path:/tmp/pip-5Ws9ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:36 INFO - Running setup.py (path:/tmp/pip-xVO0f5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:36 INFO - Running setup.py (path:/tmp/pip-_urdno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:36 INFO - Running setup.py (path:/tmp/pip-EHdJMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:36 INFO - Running setup.py (path:/tmp/pip-NykUpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:37 INFO - Running setup.py (path:/tmp/pip-fg_MiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:37 INFO - Running setup.py (path:/tmp/pip-uffLta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:37 INFO - Running setup.py (path:/tmp/pip-Zjm5qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:37 INFO - Running setup.py (path:/tmp/pip-7jdCyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:37 INFO - Running setup.py (path:/tmp/pip-WmWkEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:37 INFO - Running setup.py (path:/tmp/pip-EE2Xzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:37 INFO - Running setup.py (path:/tmp/pip-VaFxCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:37 INFO - Running setup.py (path:/tmp/pip-CPGS2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:37 INFO - Running setup.py (path:/tmp/pip-L2IyvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:37 INFO - Running setup.py (path:/tmp/pip-JUqv4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:06:37 INFO - Running setup.py install for manifestparser 08:06:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:06:37 INFO - Running setup.py install for mozcrash 08:06:37 INFO - Running setup.py install for mozdebug 08:06:38 INFO - Running setup.py install for mozdevice 08:06:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Running setup.py install for mozfile 08:06:38 INFO - Running setup.py install for mozhttpd 08:06:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Running setup.py install for mozinfo 08:06:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Running setup.py install for mozInstall 08:06:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Running setup.py install for mozleak 08:06:38 INFO - Running setup.py install for mozlog 08:06:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Running setup.py install for moznetwork 08:06:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:06:38 INFO - Running setup.py install for mozprocess 08:06:38 INFO - Running setup.py install for mozprofile 08:06:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Running setup.py install for mozrunner 08:06:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Running setup.py install for mozscreenshot 08:06:39 INFO - Running setup.py install for moztest 08:06:39 INFO - Running setup.py install for mozversion 08:06:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:06:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:06:39 INFO - Cleaning up... 08:06:39 INFO - Return code: 0 08:06:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:39 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:39 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:06:39 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:06:39 INFO - Using env: {'DISPLAY': ':0', 08:06:39 INFO - 'HOME': '/home/cltbld', 08:06:39 INFO - 'LANG': 'en_US.UTF-8', 08:06:39 INFO - 'LANGUAGE': 'en_US:en', 08:06:39 INFO - 'LOGNAME': 'cltbld', 08:06:39 INFO - 'MAIL': '/var/mail/cltbld', 08:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:39 INFO - 'MOZ_NO_REMOTE': '1', 08:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:39 INFO - 'NO_EM_RESTART': '1', 08:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:39 INFO - 'PWD': '/builds/slave/test', 08:06:39 INFO - 'SHELL': '/bin/bash', 08:06:39 INFO - 'SHLVL': '1', 08:06:39 INFO - 'TERM': 'linux', 08:06:39 INFO - 'TMOUT': '86400', 08:06:39 INFO - 'USER': 'cltbld', 08:06:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:39 INFO - '_': '/tools/buildbot/bin/python'} 08:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:39 INFO - Running setup.py (path:/tmp/pip-fJHjIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:39 INFO - Running setup.py (path:/tmp/pip-7HnXt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:39 INFO - Running setup.py (path:/tmp/pip-cVLx9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:39 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:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:39 INFO - Running setup.py (path:/tmp/pip-fzhXle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:40 INFO - Running setup.py (path:/tmp/pip-mL51Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:40 INFO - Running setup.py (path:/tmp/pip-BJ41fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:40 INFO - Running setup.py (path:/tmp/pip-IFigk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:40 INFO - Running setup.py (path:/tmp/pip-J2MKgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:40 INFO - Running setup.py (path:/tmp/pip-iJiqRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:40 INFO - Running setup.py (path:/tmp/pip-LHomc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:40 INFO - Running setup.py (path:/tmp/pip-3zYFIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:40 INFO - Running setup.py (path:/tmp/pip-9FQ0IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:40 INFO - Running setup.py (path:/tmp/pip-dBtm7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:40 INFO - Running setup.py (path:/tmp/pip-6e7p5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:40 INFO - Running setup.py (path:/tmp/pip-XBirAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:40 INFO - Running setup.py (path:/tmp/pip-JtWNRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:40 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:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:40 INFO - Running setup.py (path:/tmp/pip-1QXFlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:42 INFO - Downloading blessings-1.6.tar.gz 08:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:42 INFO - Installing collected packages: blessings 08:06:42 INFO - Running setup.py install for blessings 08:06:43 INFO - Successfully installed blessings 08:06:43 INFO - Cleaning up... 08:06:43 INFO - Return code: 0 08:06:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:06:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:43 INFO - Reading from file tmpfile_stdout 08:06:43 INFO - Current package versions: 08:06:43 INFO - argparse == 1.2.1 08:06:43 INFO - blessings == 1.6 08:06:43 INFO - blobuploader == 1.2.4 08:06:43 INFO - docopt == 0.6.1 08:06:43 INFO - manifestparser == 1.1 08:06:43 INFO - mozInstall == 1.12 08:06:43 INFO - mozcrash == 0.17 08:06:43 INFO - mozdebug == 0.1 08:06:43 INFO - mozdevice == 0.48 08:06:43 INFO - mozfile == 1.2 08:06:43 INFO - mozhttpd == 0.7 08:06:43 INFO - mozinfo == 0.9 08:06:43 INFO - mozleak == 0.1 08:06:43 INFO - mozlog == 3.2 08:06:43 INFO - moznetwork == 0.27 08:06:43 INFO - mozprocess == 0.22 08:06:43 INFO - mozprofile == 0.28 08:06:43 INFO - mozrunner == 6.11 08:06:43 INFO - mozscreenshot == 0.1 08:06:43 INFO - mozsystemmonitor == 0.1 08:06:43 INFO - moztest == 0.7 08:06:43 INFO - mozversion == 1.4 08:06:43 INFO - psutil == 3.1.1 08:06:43 INFO - requests == 1.2.3 08:06:43 INFO - wsgiref == 0.1.2 08:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:43 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:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:43 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:06:43 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:06:43 INFO - Using env: {'DISPLAY': ':0', 08:06:43 INFO - 'HOME': '/home/cltbld', 08:06:43 INFO - 'LANG': 'en_US.UTF-8', 08:06:43 INFO - 'LANGUAGE': 'en_US:en', 08:06:43 INFO - 'LOGNAME': 'cltbld', 08:06:43 INFO - 'MAIL': '/var/mail/cltbld', 08:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:43 INFO - 'MOZ_NO_REMOTE': '1', 08:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:43 INFO - 'NO_EM_RESTART': '1', 08:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:43 INFO - 'PWD': '/builds/slave/test', 08:06:43 INFO - 'SHELL': '/bin/bash', 08:06:43 INFO - 'SHLVL': '1', 08:06:43 INFO - 'TERM': 'linux', 08:06:43 INFO - 'TMOUT': '86400', 08:06:43 INFO - 'USER': 'cltbld', 08:06:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:43 INFO - '_': '/tools/buildbot/bin/python'} 08:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 INFO - Cleaning up... 08:06:43 INFO - Return code: 0 08:06:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:06:43 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:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:43 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:06:43 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:06:43 INFO - Using env: {'DISPLAY': ':0', 08:06:43 INFO - 'HOME': '/home/cltbld', 08:06:43 INFO - 'LANG': 'en_US.UTF-8', 08:06:43 INFO - 'LANGUAGE': 'en_US:en', 08:06:43 INFO - 'LOGNAME': 'cltbld', 08:06:43 INFO - 'MAIL': '/var/mail/cltbld', 08:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:43 INFO - 'MOZ_NO_REMOTE': '1', 08:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:43 INFO - 'NO_EM_RESTART': '1', 08:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:43 INFO - 'PWD': '/builds/slave/test', 08:06:43 INFO - 'SHELL': '/bin/bash', 08:06:43 INFO - 'SHLVL': '1', 08:06:43 INFO - 'TERM': 'linux', 08:06:43 INFO - 'TMOUT': '86400', 08:06:43 INFO - 'USER': 'cltbld', 08:06:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:43 INFO - '_': '/tools/buildbot/bin/python'} 08:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:43 INFO - Downloading/unpacking jsonschema 08:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:45 INFO - Downloading/unpacking functools32 (from jsonschema) 08:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:45 INFO - warning: no files found matching '*.txt' 08:06:45 INFO - no previously-included directories found matching 'build' 08:06:45 INFO - no previously-included directories found matching 'dist' 08:06:45 INFO - no previously-included directories found matching '.git*' 08:06:45 INFO - Installing collected packages: jsonschema, functools32 08:06:45 INFO - Running setup.py install for functools32 08:06:46 INFO - warning: no files found matching '*.txt' 08:06:46 INFO - no previously-included directories found matching 'build' 08:06:46 INFO - no previously-included directories found matching 'dist' 08:06:46 INFO - no previously-included directories found matching '.git*' 08:06:46 INFO - Successfully installed jsonschema functools32 08:06:46 INFO - Cleaning up... 08:06:46 INFO - Return code: 0 08:06:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:06: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:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33dea15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0f8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', '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:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:06:46 INFO - Using env: {'DISPLAY': ':0', 08:06:46 INFO - 'HOME': '/home/cltbld', 08:06:46 INFO - 'LANG': 'en_US.UTF-8', 08:06:46 INFO - 'LANGUAGE': 'en_US:en', 08:06:46 INFO - 'LOGNAME': 'cltbld', 08:06:46 INFO - 'MAIL': '/var/mail/cltbld', 08:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:46 INFO - 'MOZ_NO_REMOTE': '1', 08:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:46 INFO - 'NO_EM_RESTART': '1', 08:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:46 INFO - 'PWD': '/builds/slave/test', 08:06:46 INFO - 'SHELL': '/bin/bash', 08:06:46 INFO - 'SHLVL': '1', 08:06:46 INFO - 'TERM': 'linux', 08:06:46 INFO - 'TMOUT': '86400', 08:06:46 INFO - 'USER': 'cltbld', 08:06:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:46 INFO - '_': '/tools/buildbot/bin/python'} 08:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:46 INFO - Downloading/unpacking flake8 08:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:06:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:06:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:48 INFO - no previously-included directories found matching 'docs/_build' 08:06:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:06:48 INFO - Running setup.py install for pep8 08:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:06:49 INFO - no previously-included directories found matching 'docs/_build' 08:06:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:06:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:06:49 INFO - Cleaning up... 08:06:49 INFO - Return code: 0 08:06:49 INFO - Running post-action listener: _resource_record_post_action 08:06:49 INFO - Running post-action listener: _start_resource_monitoring 08:06:49 INFO - Starting resource monitoring. 08:06:49 INFO - ##### 08:06:49 INFO - ##### Finished create-virtualenv step (success) 08:06:49 INFO - ##### 08:06:49 INFO - ##### 08:06:49 INFO - ##### Running install step. 08:06:49 INFO - ##### 08:06:49 INFO - Running pre-action listener: _resource_record_pre_action 08:06:49 INFO - Running main action method: install 08:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:49 INFO - Reading from file tmpfile_stdout 08:06:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:49 INFO - Reading from file tmpfile_stdout 08:06:49 INFO - Output received: 08:06:49 INFO - Usage: mozinstall [options] installer 08:06:49 INFO - Options: 08:06:49 INFO - -h, --help show this help message and exit 08:06:49 INFO - -d DEST, --destination=DEST 08:06:49 INFO - Directory to install application into. [default: 08:06:49 INFO - "/builds/slave/test"] 08:06:49 INFO - --app=APP Application being installed. [default: firefox] 08:06:49 INFO - mkdir: /builds/slave/test/build/application 08:06:49 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:06:49 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:07:06 INFO - Reading from file tmpfile_stdout 08:07:06 INFO - Output received: 08:07:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:07:06 INFO - Running post-action listener: _resource_record_post_action 08:07:06 INFO - ##### 08:07:06 INFO - ##### Finished install step (success) 08:07:06 INFO - ##### 08:07:06 INFO - ##### 08:07:06 INFO - ##### Running run-tests step. 08:07:06 INFO - ##### 08:07:06 INFO - Running pre-action listener: _resource_record_pre_action 08:07:06 INFO - Running main action method: run_tests 08:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:06 INFO - Python 2.7.3 08:07:06 INFO - Return code: 0 08:07:06 INFO - grabbing minidump binary from tooltool 08:07:06 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:07:06 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 0x2a9eb20>, '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 0x2a9fa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9feb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:06 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:07:06 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:07:06 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:07:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:06 INFO - Return code: 0 08:07:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:07:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:07:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:07:07 INFO - Return code: 0 08:07:07 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-035', '--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:07:07 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-035 --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:07:07 INFO - Using env: {'DISPLAY': ':0', 08:07:07 INFO - 'HOME': '/home/cltbld', 08:07:07 INFO - 'LANG': 'en_US.UTF-8', 08:07:07 INFO - 'LANGUAGE': 'en_US:en', 08:07:07 INFO - 'LOGNAME': 'cltbld', 08:07:07 INFO - 'MAIL': '/var/mail/cltbld', 08:07:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:07 INFO - 'MOZ_NO_REMOTE': '1', 08:07:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:07 INFO - 'NO_EM_RESTART': '1', 08:07:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:07 INFO - 'PWD': '/builds/slave/test', 08:07:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:07 INFO - 'SHELL': '/bin/bash', 08:07:07 INFO - 'SHLVL': '1', 08:07:07 INFO - 'TERM': 'linux', 08:07:07 INFO - 'TMOUT': '86400', 08:07:07 INFO - 'USER': 'cltbld', 08:07:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116', 08:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:07 INFO - '_': '/tools/buildbot/bin/python'} 08:07:07 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-035', '--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:07:07 INFO - mozversion application_buildid: 20160514053004 08:07:07 INFO - mozversion application_changeset: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 08:07:07 INFO - mozversion application_display_name: Nightly 08:07:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:07 INFO - mozversion application_name: Firefox 08:07:07 INFO - mozversion application_remotingname: firefox 08:07:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:07:07 INFO - mozversion application_vendor: Mozilla 08:07:07 INFO - mozversion application_version: 49.0a1 08:07:07 INFO - mozversion platform_buildid: 20160514053004 08:07:07 INFO - mozversion platform_changeset: e9b22ce9e0296b451dd3dd84ee7f054ccdc381b5 08:07:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:07:07 INFO - mozversion platform_version: 49.0a1 08:07:07 INFO - using testdate: 1463238427 08:07:07 INFO - actual date: 1463238427 08:07:07 INFO - starting webserver on 'localhost:44132' 08:07:07 INFO - SUITE-START | Running 2 tests 08:07:07 INFO - TEST-START | dromaeo_css 08:07:07 INFO - operating with platform_type : linux_ 08:07:07 INFO - Initialising browser for dromaeo_css test... 08:07:07 INFO - TEST-INFO | started process 7017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp21qdNX/profile http://localhost:44132/getInfo.html) 08:07:10 INFO - PROCESS | 7017 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 08:07:11 INFO - PROCESS | 7017 | __metrics Screen width/height:1600/1200 08:07:11 INFO - PROCESS | 7017 | colorDepth:24 08:07:11 INFO - PROCESS | 7017 | Browser inner width/height: 1024/697 08:07:11 INFO - PROCESS | 7017 | __metrics 08:07:12 ERROR - PROCESS | 7017 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:07:12 INFO - TEST-INFO | 7017: exit 0 08:07:12 INFO - Browser initialized. 08:07:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:12 INFO - TEST-INFO | started process 7099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp21qdNX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:24 INFO - PROCESS | 7099 | RSS: Main: 152076288 08:07:24 INFO - PROCESS | 7099 | 08:08:15 INFO - PROCESS | 7099 | 1463238495700 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:10:23 INFO - PROCESS | 7099 | Cycle 1(1): loaded http://localhost:44132/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44132/tests/dromaeo/cssquery-ext.html) 08:10:24 INFO - PROCESS | 7099 | RSS: Main: 250761216 08:10:24 INFO - PROCESS | 7099 | 08:13:26 INFO - PROCESS | 7099 | Cycle 1(1): loaded http://localhost:44132/tests/dromaeo/cssquery-ext.html (next: http://localhost:44132/tests/dromaeo/cssquery-jquery.html) 08:13:27 INFO - PROCESS | 7099 | RSS: Main: 237002752 08:13:27 INFO - PROCESS | 7099 | 08:16:29 INFO - PROCESS | 7099 | Cycle 1(1): loaded http://localhost:44132/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44132/tests/dromaeo/cssquery-mootools.html) 08:16:29 INFO - PROCESS | 7099 | RSS: Main: 239689728 08:16:29 INFO - PROCESS | 7099 | 08:19:31 INFO - PROCESS | 7099 | Cycle 1(1): loaded http://localhost:44132/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44132/tests/dromaeo/cssquery-prototype.html) 08:19:32 INFO - PROCESS | 7099 | RSS: Main: 237404160 08:19:32 INFO - PROCESS | 7099 | 08:22:35 INFO - PROCESS | 7099 | Cycle 1(1): loaded http://localhost:44132/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44132/tests/dromaeo/cssquery-yui.html) 08:22:35 INFO - PROCESS | 7099 | RSS: Main: 218247168 08:22:35 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | Cycle 1(1): loaded http://localhost:44132/tests/dromaeo/cssquery-yui.html (next: http://localhost:44132/tests/dromaeo/cssquery-dojo.html) 08:25:38 INFO - PROCESS | 7099 | RSS: Main: 267984896 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | __start_tp_report 08:25:38 INFO - PROCESS | 7099 | _x_x_mozilla_page_load 08:25:38 INFO - PROCESS | 7099 | _x_x_mozilla_page_load_details 08:25:38 INFO - PROCESS | 7099 | |i|pagename|runs| 08:25:38 INFO - PROCESS | 7099 | |0;dojo.html;3177.5710279112327;3198.7281081108104;3229.951550726739;3237.643859175492;3270.6729327067283;5258.13240815266;5304.973475132629;5374.7850085996515;5447.155690867917;5492.34091908971;5396.379416367119;5421.864453388667;5437.972810135944;5472.069748142815;5484.287042684446;4876.487968763282;4890.266460030988;4967.205247160455;4977.950220497803;5004.974975125119;4934.506549345073;4954.504549545035;4997.625178111638;5004.84985450437;5010.323606313137;4823.469418363977;4905.681130726492;4968.105740966625;4986.4265609455015;4992.126377883856;4970.030843985424;4992.276119962585;4997.550220480174;5001.774920128603;5046.747662616891;4746.952530474686;4951.529604687549;4976.527229913152;4986.4514903360605;5042.596592272609;5308.442613525563;5364.329458817648;5388.299521062276;5435.402105768362;5463.235147079412;5798.304203495565;5876.206712093898;5877.441643043947;5879.235699359056;5881.617694849821;5686.54507639392;5801.622894511843;5805.854853628651;5823.883522329572;5828.679422631753;5440.319960004999;5523.4200408956485;5546.473085056913;5555.694436806015;5558.166275058774;6046.738362665033;6051.485623722033;6072.362401947732;6106.603070800384;6107.572469927151;5546.473085056913;5631.2397826293745;5638.633488823213;5764.855878602984;5815.2149459822385;5754.510866576305;5767.913481297784;5769.913451298234;5770.6249093808765;5815.098659707752;5721.685307308138;5764.971175144097;5775.826725198251;5783.248177736868;5784.248047753849;5607.8598035048635;5693.914591281134;5747.913781293284;5805;5826.126081087786;4409.382686423904;4421.336799480039;4423.955760442354;4425.225585522585;4454.354118652842;3963.0884896473394;3975.5030621172355;3988.4017397390626;4020.577839326887;4023.8390464381096;5331.493508116722;5372.355317361941;5442.2380866678695;5445.373782015119;5483.122700367922;5819.621724587888;5842.182094506772;5855.151003104526;5857.88284234313;5858.941410585925;5478.096114141202;5505.559555235572;5509.063459211943;5511.283533140746;5516.034693928546;4818.494058123917;4984.7258400788305;5012;5050.924236136461;5065.265536497187;6084.969575152184;6085.148079268906;6085.574009819358;6087.269527656709;6091.756329746849;5555.7499912504845;5798.710064496842;5809.5352371811;5810.912836307543;5814.04068328721;6008.7296071676;6046;6059.969700151471;6094.169091873762;6097.917917222642;5670.376258611467;5686.175504551899;5727.513161381329;5732.140178973187;5780.132980053026;5637.351704553865;5801.1878337033695;5826.126081087871;5829.94170058294;5832.270966129234;5648.435156484319;5668.376478587435;5688.431156884444;5731.111677689964;5744.109663002241;5703.600747947604;5726.713664316684;5726.828195154152;5727.427257274239;5733.226014487991;5308.654937429054;5504.311961004874;5624.240727501735;5630.493255607015;5637.8590535236945;5675.57433192504;5738.913916291175;5753.1945527627;5754.798582049608;5786.363500015079;5557.72211389437;5562.11006239016;5568.610197286151;5571.7492712828835;5603.215549822947 08:25:38 INFO - PROCESS | 7099 | |1;ext.html;622.4366947912141;657.4510283912933;658.7134596450542;664.0139393001392;677.3159109299609;33457.498137527924;36433.453498197516;36463.4530482043;44519.77740111303;45484.317735234;47281.290780638235;47586;47664.76167619157;47723.04553908928;47888.52111478884;9020.864687029683;9160.679376221833;9162.633494660206;9164.908350916505;9168.495732734697;9021.233195178418;9121.270298376114;9123.361364704473;9128.908710912905;9131.086891310882;9156.404833685823;9187.448753074837;9198.494082825442;9199.356045076847;9209.631614735403;9095.818083638324;9112.179903808688;9127.452352858816;9136.132067453582;9146.451212927179;8943.418677785923;8990.41562298455;9008.189262966365;9008.954955225181;9012.414193077495;42850.35724464135;43087.35368969468;43094.353584696255;43140.56859431397;43170.56829431697;3862.7875466849314;3995.62041606047;4394.274944634131;4494.865154045384;4514.45826500822;33018.504722429185;33642.49536256934;34045.489317660256;34189.316213675585;35182.64817351845;4424.579664931826;4452.265376212921;4490.169318676023;4501.054778496519;4515.187266292066;322417;322889;322932;325483;328209.9999999976;61251.69374153101;61575.07637385443;61696.07455888165;61729.691351542955;61741;37520.81239593784;38370.2325953485;38380;40080;40126.59873401287;17856.46430607058;17980.820191797913;18107.45677629673;18130;18163.63672726538;13656.248906310248;13796.517121900886;13796.931015344859;13804.102733322303;13808.309584520734;20016.199352025757;20084.799152008294;20155.899220503805;20266.594668106554;20318.28885988983;7190.8000939582425;7206.207317195104;7320.414366850639;7447.255274472618;7576.24237576238;1042.3849928542197;1060.1306928318704;1083.7236504691411;1152.5101831721486;1216.367488905764;33286.33427331488;34450.483242751376;34545.30909381798;36708;36858;1150.344303746873;1220.3776074202044;1237.1031002523098;1259.9622011339675;1263.8357013588175;17041.914790426217;17408.82591174072;17565.824341756674;17598.38405655796;17617.647647046986;540106;543889;543905;543991;544441;58943.41056589465;60290;60395.67823769735;60438.09342859861;60443.69778151169;1454.978175327371;1466.8239811222722;1477.8152730908637;1488.694817562397;1493.3802471974227;31271.53092703657;32214;32473.67526324801;32923.17692057718;32947.76063567125;53192;53944.73027634837;54282.18576721274;54379;54395.456045440624;358288;359507;359707;359786;359940;26177.73822261753;27265;29352;29811.55282670805;30610.693893060783;48290;48639;48917.755411222715;49424.752876236824;49634.503654964436;40227.3965890506;41391.1721765569;41999.7900010498;42137.789311053246;42407.575924240366;39589.2082158361;39930.80034599808;40255.396169056905;40841;41122.17755644811;34469;42419.7879010603;45586.08827823358;45906.54093459023;46195.076098478516;35490.64509354976;36530.26939461143;36700.816495918414;36793;37255.44116838304;28185.617725872205;28234.152975410772;28402.715972840007;28415.857920710263;28420.57369139423 08:25:38 INFO - PROCESS | 7099 | |2;jquery.html;406.75391388210113;414.8506537646447;417.89134824945506;420.10727204690033;432.16807645282825;18251.178696958636;19679.5080122997;19713.21147154114;19760.209591616334;20729.274475393326;11399.259048161864;11574;15681.607959801011;19405.70891436626;19432.417027489162;4660.440747110335;4942.18453955097;5214.895702085956;5320.654157479771;5450.264214331074;4012.6589239914642;4162.500499940012;4164.167166566699;5395.406505284415;5600.4959553640165;5844.444777746107;5925.73334199962;5956.106584012411;5957.106434034886;5963.761449542013;5809.88380232393;5872.500837428824;5935.080062590306;5955.731992060346;5968.343482216953;3812.4281357796553;5162.657708995688;5759.798407055775;5768.394318596529;5785.045467497858;12878.162919410208;12946.870531294755;12951.287679177642;12952.287624180666;15757.60605984848;2282.0985710644204;2445.5597992361368;2457.606782914725;2503.036331012573;2866.870990805419;9258.861117083248;9638.180754635794;9689.467079310634;9869.605215791431;10085.142762865165;1901.7812951510616;1967.911443985024;1982.2368388170657;1985.3051431998829;2034.7965203479534;78964.99999999943;79143.20856791474;80719;82317.58841205816;83935;10783.892161078445;10908.563657453613;10968.561257549609;11035.337879727082;11129;15092.094474331576;15148.772768408482;15152.166630835189;15172.544823655307;15200.087994720352;8128.39037072222;8289.58552072394;8400.159984001551;8466;8533.74398768038;8114.83770324602;8115.310198633064;8154.5514996674565;8264.338852891755;8279.213474719892;4461.643068554507;4475.932861007088;4490.865274041784;4522.23122069249;4557.316402539645;1729.6540691861678;1774.9713636669917;1873.9718904216447;1885.481492589549;2049.108637742587;912.7170577121113;1042.1298215989582;1062.5059347403494;1078.320657985464;1085.9782804344027;19051.333203337817;19784.60430791376;19809.40571782849;19979;20010.89994550047;1042.6038105519854;1044.6865940217904;1054.1303424674675;1071.994640026795;1103.5806393570392;10739.731506712395;11240.325580465198;11282.887171128184;11322.886771132347;11408.372539510241;472532;498754;499937.00314984104;500211;500840;57071.71464142653;63797;88839;90956;93287.53356233175;1027.445179603021;1032.8140934631688;1057.2757661002393;1059.4279089291697;1075.93544387337;16732;17094.145292735066;17330;17436.389726359517;17639.82360176382;37393.626063739015;37435.81282093681;37637.2472550542;39133.82598522049;39378.60621393749;55892;56061.71969140291;56105.43894561002;56142.43857561372;56564.43435565592;8445.451045682012;8484.91515084866;8524.488530688179;8645.56772161402;8676.522791246542;8664.610092545725;12673.30296833683;13076.673083172996;13110.410031548412;13392.26342551169;6054.273487181566;9123.954380228057;9293.581788819654;9835.557399917165;11886.940565297118;11656;11860.94069529647;11864.881351186723;11893;11944.223625464318;11713.297202167898;12153.756924861276;12271.877281227073;12485.12604117703;12583.182093163916;8403.579821009047;8421.32629389635;8472.83054338922;8537;8693.130686931256;8712.564371781513;11821.231619944676;12276.263424194576;12346;12385.133040687066 08:25:38 INFO - PROCESS | 7099 | |3;mootools.html;1445.4579532675248;1558.8752899768017;1577.9211039448026;1760.0935518208125;1865.5615930256397;8653;9033.638654453822;9089.68186113486;9338.159565639091;9355.111264429885;9070.954645226764;9267.675631352904;9277.118673726001;9281.53592320383;9291.11734385234;2067.0491573876034;2338.205010296499;2399.8440101393353;2426.842255253407;2457.5576396248666;2410.5781488239577;2420.4432980414517;2435.561598912195;2439.9756002440013;2442.1818690738623;2326.5928462519078;2372.6796882420826;2373.4778348763243;2374;2378.54807586558;2051.579426217629;2336.6261398176293;2409.4096946248105;2415.758424157588;2435.111184417675;2324.37241944674;2326.4183954011496;2332.685087513181;2333.1134169015663;2362.8464149830206;9293.767655808591;9334.06659334068;9344.906550934471;9359.157675809141;9368.110029547182;5260.631755777097;5452.645578037414;5461.808836690697;5462.8361149165585;5464.508194262496;3439.7420193485336;3449.5688038995127;3455.06713187438;3547.379208638478;3578.6063533011347;1102.922795404322;1103.1064837481665;1109.5118148014847;1120.4117838135044;1154.5497256070055;13292.069555131146;13308.534201303004;13412.530561430402;13450.93274533631;13454.05821592489;4621.353010578522;4668.5098064702715;4748.050389922029;4765.404324459442;4788.712677239377;10408.5836566538;10440.582376704999;10451.059404653466;10453.268271221094;10456;4839.395075615548;5423;5483.424240454775;5495.642783219078;5504.697241651747;4852.636052296021;5053.898922021539;5078.746062696924;5088;5136.280920671109;4270.167317373144;4304.80628371724;4318.978405107954;4349.739015659071;4522.186006518792;1312.4356526693423;1317.7613043738854;1331.088204579866;1340.443715857908;1357.2738584857054;857.4640849469082;875.868619707049;905.9411138275991;921.8847644044495;928.3269629518545;5452.836414907559;5501.889962200734;5560.666360018331;5591.356993945748;5636.464535869086;950.6577632052456;959.6449313753956;988.8862780780158;1000.9199264058858;1020.9438480883474;3747.550293964687;3795.8102094895144;3799.1262009737916;3815.6756675682877;3838.5393752749846;11345.149113816331;11715.062794976382;11740.412979350998;11756.70608234801;11764.35296058725;11469.197156198987;11520.193586448868;11522.308661480338;11605.76788464226;11633.825492617449;8174.6730130795295;8251.8349633007;8401.831963360699;8418.747437576883;8647.0920553341;5535.474129957647;5571.3592936811165;5611.859703507445;5632.464915832989;5750.13747937796;10472.738181545523;10609.469526523488;10694.358338499715;10709.571617135227;10711.410872402093;10387;10720.517576709222;10748.247622666338;10927.235093543375;10940.56237750481;6763.526553141233;6886.896696549656;7533.096028476618;7655.119661239029;7771.261730135628;8993.460392376479;9019;9131.908680913106;9132.680356187502;9162.908370916206;7853.882191767014;7871.685132594632;7945.284924356835;8174.591270436574;8202.38482113832;7766.844663106819;7841.215878412113;7912.643931023003;7957.681692732226;8022.077461092049;7117.4661900358715;7137.750178743719;7148.249433809375;7194.352508274281;7199.316064973819;4759.9524004759505;4875.366202393666;4887.242477416006;4976.701397916137;5013.24801279811;4796.712197268175;4799.352087468147;4848.539388758062;4852.80588776445;4906.754662266943 08:25:38 INFO - PROCESS | 7099 | |4;prototype.html;330.79656011552885;335.85390355195494;338.86445421831263;339.5857054393639;340.168288534533;5245.711485868275;5292.153255479124;5310.176922576997;5350.625456218067;5358.571314294857;5178.876660569167;5235.319408476902;5264.973675131619;5270;5271.86820329491;3891.8832435026993;3912.5500567434683;3962.960370396288;3981.5023122109737;3989.640932316091;3796.4115562087923;4076.673866090706;4085.44846445729;4092.529359123694;4096.5903409659095;4028.516578010628;4046.069404037073;4065.2276067547073;4073.7352072115364;4079.4492743479545;3921.5490218624936;3995.921101302632;4065.512138543364;4081.571434999327;4084.856240252719;3585.372559802024;3591.1381268495634;3602.865097494307;3605.2789442111684;3607.783532988029;5017.172166592508;5034.949650503485;5044.672096313728;5052.621053420971;5095.770690318945;4438.977805110986;4628.884277893046;4628.981624042705;4638.121560767894;4639.814407423699;5431.21247419122;5462.7268636568015;5465.453454654543;5466.562674985991;5471.644343117724;3920.2159568086213;3936.6260205280737;3941.7138059925173;3945.3687410014545;3947.519680119955;5169.586433085344;5378.704171270579;5641.815218804056;5684.8294551163535;5687.203791469197;3983.1635356574866;4003.3594624860466;4028.4762980812893;4032.8185231664647;4035.3543433050572;4096.73371230869;4098.827621360683;4101.507819061731;4105.835766569364;4105.85629502966;4568.002997377295;4634.72191668501;4639.979204574988;4655.068986202773;4662.650301227422;5510.173473978935;5516.200150978166;5517.951589198039;5518.44815518453;5522.972385138049;1427.357689039936;1442.5672298310465;1448.2975756757965;1452.4553292515307;1452.5061479097158;886.390660469138;914.9954250228707;915.8534634458455;924.2652091587204;935.1583574782615;4703.318018887242;4742.407199100113;4745.952540474551;4780.259059845729;4784.234522476387;5056.82301119459;5062.772175252049;5066.569341605931;5067.4932506749765;5074.995376826133;4609.60818330439;4682.719036857799;4791.592714619227;4801.319538161685;4802.687825291345;2622.396848724804;2625.8555779432313;2649.562822134365;2669.5328317544354;2676.8795404206858;5164.32863727713;5169.793208271627;5179.430262671103;5205.375354957429;5210.47895210476;4805.231163013971;5016.598672106223;5027.99440111979;5070.721110338893;5095.694258344512;5069.6451248413;5091.236314552921;5149.176131818891;5163.7676304566385;5211.270422140903;4889.486603906538;4959.3552838132255;4961.801527938842;4964.815481188266;4992.425871024879;4921.434035085867;4972.726500042388;5207.661502002357;5672.75199456119;5684.232628595087;5681.318241811009;5798;5800.767969281182;5802.738876750641;5972.940270597239;3894.2990261753157;3959.970407693963;4035.596440355941;4038.6163314485075;4044.7977601119237;5665.716714164193;5677.148427735872;5680.545556355564;5681.289838770153;5685.630434021776;5275.419703832652;5402.189671549299;5508.8706815102005;5509.972450137724;5517.36550296705;5468.371137319259;5473.945260547503;5475.767952210721;5478.780848766164;5505.724713764376;5159.831330298309;5328;5352.678839269501;5375.962581141643;5419.295491586068;5554.777808887599;5589.273394458694;5598.552115830806;5599.860003499945;5615.624172077867;5424.3761967372675;5451.890962180655;5466.535344495763;5470.5350045245;5477.02826982294 08:25:38 INFO - PROCESS | 7099 | |5;yui.html;739.2976672161448;757.7840315510077;864.3301441382928;871.4248595926686;883.4566741454006;12738.108332416723;13268.535601253958;13324.40040198191;13361.59915202543;13365.799513007301;12014.339211343373;12447.439865206064;12927.09510334277;12956.15784973976;13306.600801975932;820.6020080261069;825.1954344514081;829.7593697827623;832.5421018439833;834.1950018232404;848.4315508609246;848.9939421785174;850.0861573808181;851.2891735400917;851.4210336970857;898.8292224477361;899.8920129584459;903.7469508537587;905.0406569036842;907.2923119966437;899.8155378147464;900.2033200617435;900.2842740021666;901.4050726520466;902.0753727429371;659.0312241005714;660.145112079853;660.1879687983807;660.6465540935625;660.9438197753196;12378.319192444413;12533.122681412306;12567.93716031414;13138.737225255538;13190.73618527624;12162.148649594532;12170.574029909;12190.57332993341;12221.816672749916;12241.571544995972;10025.89974100257;10053.547590358452;10150.593976240942;10152.543135558917;10245.84631230532;3735.8132093395493;3740.719446041531;3857.1514266861245;3862.1503269280715;3869.1681288522823;53960.73019634877;58439;60046;60451.69774151145;61063.69468152631;10273.9486302568;10413.739656508496;10481.056704896597;10516.211284153565;10597.576096956036;17625.911870440566;17654.735178972325;17658.470245892644;17668.38160664396;17679.469615911545;7016.649167541603;7236.6019868907715;7364.22675619063;7432.368248698813;7566.772996810105;4377.474703035656;4420.8673739787855;4485.977570112129;4506.526814684476;4532.773361331986;3243.189202699325;3354.278830051551;3385.170633194883;3436.862525499002;3436.9484457733156;675.0650349266203;693.2478261086677;701.2706784943601;703.714995426853;706.3148745716646;614.3242433323309;690.2476300832017;703.2861645429892;711.1324184494908;726.556800351785;8770.429922055046;9005.729828105168;9046.366754327266;9495;9650.372725772802;725.9092613423322;732.2128711635014;742.688071010177;753.830388162659;778.0468925566249;4086.734362266443;4161.279533553289;4191.287481128215;4234.491860976641;4236.512801027921;65369;65513.67243163849;69151;69438.3056169442;69784.3021569788;44265.33601995972;57653;58797.99999999914;60115.69942150261;62941;56114.719426402604;57002.42997569971;57072.71463642655;57458.42541574614;57517.424825752045;8841.911580884109;9054.366194366332;9116.08839116083;9200.401973871676;9258.398204116711;36579.817100914326;37020.629793701715;37596;37773.4333984996;37806.24387512289;46592;49512.50487495223;51113.48886511087;51160.23259651183;52217;10885.23803333759;11514.827277590675;11669.824952625548;11818.527258909548;11960.175911307482;12833.871661283267;13306.933465332611;13375.665608359868;13447.260400678057;13477.663058423617;11751.706207344885;11755;12072.75854482888;13205.27370994566;13343.599692009255;12584.433700483683;12787;13094.476220951436;13213.471461141447;13819.101758385672;12663.240205587694;12842.67893302675;12920.935395322964;12929.482820687068;13035.283059431822;10667.413292269;10876.510557024794;10914.345139291669;10938.835917461085;11176.105911526896;10575.153987680813;11079;11126.221164518405;11174.832377514507;11210.159238057342 08:25:38 INFO - PROCESS | 7099 | __end_tp_report 08:25:38 INFO - PROCESS | 7099 | __start_cc_report 08:25:38 INFO - PROCESS | 7099 | _x_x_mozilla_cycle_collect,839 08:25:38 INFO - PROCESS | 7099 | __end_cc_report 08:25:38 INFO - PROCESS | 7099 | __startTimestamp1463239538466__endTimestamp 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | ------- Summary: start ------- 08:25:38 INFO - PROCESS | 7099 | Number of tests: 6 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | [#0] dojo.html Cycles:165 Average:5403.15 Median:5571.75 stddev:606.68 (10.9%) stddev-sans-first:582.88 08:25:38 INFO - PROCESS | 7099 | Values: 3177.6 3198.7 3230.0 3237.6 3270.7 5258.1 5305.0 5374.8 5447.2 5492.3 5396.4 5421.9 5438.0 5472.1 5484.3 4876.5 4890.3 4967.2 4978.0 5005.0 4934.5 4954.5 4997.6 5004.8 5010.3 4823.5 4905.7 4968.1 4986.4 4992.1 4970.0 4992.3 4997.6 5001.8 5046.7 4747.0 4951.5 4976.5 4986.5 5042.6 5308.4 5364.3 5388.3 5435.4 5463.2 5798.3 5876.2 5877.4 5879.2 5881.6 5686.5 5801.6 5805.9 5823.9 5828.7 5440.3 5523.4 5546.5 5555.7 5558.2 6046.7 6051.5 6072.4 6106.6 6107.6 5546.5 5631.2 5638.6 5764.9 5815.2 5754.5 5767.9 5769.9 5770.6 5815.1 5721.7 5765.0 5775.8 5783.2 5784.2 5607.9 5693.9 5747.9 5805.0 5826.1 4409.4 4421.3 4424.0 4425.2 4454.4 3963.1 3975.5 3988.4 4020.6 4023.8 5331.5 5372.4 5442.2 5445.4 5483.1 5819.6 5842.2 5855.2 5857.9 5858.9 5478.1 5505.6 5509.1 5511.3 5516.0 4818.5 4984.7 5012.0 5050.9 5065.3 6085.0 6085.1 6085.6 6087.3 6091.8 5555.7 5798.7 5809.5 5810.9 5814.0 6008.7 6046.0 6060.0 6094.2 6097.9 5670.4 5686.2 5727.5 5732.1 5780.1 5637.4 5801.2 5826.1 5829.9 5832.3 5648.4 5668.4 5688.4 5731.1 5744.1 5703.6 5726.7 5726.8 5727.4 5733.2 5308.7 5504.3 5624.2 5630.5 5637.9 5675.6 5738.9 5753.2 5754.8 5786.4 5557.7 5562.1 5568.6 5571.7 5603.2 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | [#1] ext.html Cycles:180 Average:57671.92 Median:40981.59 stddev:111256.78 (271.5%) stddev-sans-first:111486.43 08:25:38 INFO - PROCESS | 7099 | Values: 622.4 657.5 658.7 664.0 677.3 33457.5 36433.5 36463.5 44519.8 45484.3 47281.3 47586.0 47664.8 47723.0 47888.5 9020.9 9160.7 9162.6 9164.9 9168.5 9021.2 9121.3 9123.4 9128.9 9131.1 9156.4 9187.4 9198.5 9199.4 9209.6 9095.8 9112.2 9127.5 9136.1 9146.5 8943.4 8990.4 9008.2 9009.0 9012.4 42850.4 43087.4 43094.4 43140.6 43170.6 3862.8 3995.6 4394.3 4494.9 4514.5 33018.5 33642.5 34045.5 34189.3 35182.6 4424.6 4452.3 4490.2 4501.1 4515.2 322417.0 322889.0 322932.0 325483.0 328210.0 61251.7 61575.1 61696.1 61729.7 61741.0 37520.8 38370.2 38380.0 40080.0 40126.6 17856.5 17980.8 18107.5 18130.0 18163.6 13656.2 13796.5 13796.9 13804.1 13808.3 20016.2 20084.8 20155.9 20266.6 20318.3 7190.8 7206.2 7320.4 7447.3 7576.2 1042.4 1060.1 1083.7 1152.5 1216.4 33286.3 34450.5 34545.3 36708.0 36858.0 1150.3 1220.4 1237.1 1260.0 1263.8 17041.9 17408.8 17565.8 17598.4 17617.6 540106.0 543889.0 543905.0 543991.0 544441.0 58943.4 60290.0 60395.7 60438.1 60443.7 1455.0 1466.8 1477.8 1488.7 1493.4 31271.5 32214.0 32473.7 32923.2 32947.8 53192.0 53944.7 54282.2 54379.0 54395.5 358288.0 359507.0 359707.0 359786.0 359940.0 26177.7 27265.0 29352.0 29811.6 30610.7 48290.0 48639.0 48917.8 49424.8 49634.5 40227.4 41391.2 41999.8 42137.8 42407.6 39589.2 39930.8 40255.4 40841.0 41122.2 34469.0 42419.8 45586.1 45906.5 46195.1 35490.6 36530.3 36700.8 36793.0 37255.4 28185.6 28234.2 28402.7 28415.9 28420.6 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | [#2] jquery.html Cycles:180 Average:28143.22 Median:37536.53 stddev:81350.74 (216.7%) stddev-sans-first:81552.29 08:25:38 INFO - PROCESS | 7099 | Values: 406.8 414.9 417.9 420.1 432.2 18251.2 19679.5 19713.2 19760.2 20729.3 11399.3 11574.0 15681.6 19405.7 19432.4 4660.4 4942.2 5214.9 5320.7 5450.3 4012.7 4162.5 4164.2 5395.4 5600.5 5844.4 5925.7 5956.1 5957.1 5963.8 5809.9 5872.5 5935.1 5955.7 5968.3 3812.4 5162.7 5759.8 5768.4 5785.0 12878.2 12946.9 12951.3 12952.3 15757.6 2282.1 2445.6 2457.6 2503.0 2866.9 9258.9 9638.2 9689.5 9869.6 10085.1 1901.8 1967.9 1982.2 1985.3 2034.8 78965.0 79143.2 80719.0 82317.6 83935.0 10783.9 10908.6 10968.6 11035.3 11129.0 15092.1 15148.8 15152.2 15172.5 15200.1 8128.4 8289.6 8400.2 8466.0 8533.7 8114.8 8115.3 8154.6 8264.3 8279.2 4461.6 4475.9 4490.9 4522.2 4557.3 1729.7 1775.0 1874.0 1885.5 2049.1 912.7 1042.1 1062.5 1078.3 1086.0 19051.3 19784.6 19809.4 19979.0 20010.9 1042.6 1044.7 1054.1 1072.0 1103.6 10739.7 11240.3 11282.9 11322.9 11408.4 472532.0 498754.0 499937.0 500211.0 500840.0 57071.7 63797.0 88839.0 90956.0 93287.5 1027.4 1032.8 1057.3 1059.4 1075.9 16732.0 17094.1 17330.0 17436.4 17639.8 37393.6 37435.8 37637.2 39133.8 39378.6 55892.0 56061.7 56105.4 56142.4 56564.4 8445.5 8484.9 8524.5 8645.6 8676.5 8664.6 12673.3 13076.7 13110.4 13392.3 6054.3 9124.0 9293.6 9835.6 11886.9 11656.0 11860.9 11864.9 11893.0 11944.2 11713.3 12153.8 12271.9 12485.1 12583.2 8403.6 8421.3 8472.8 8537.0 8693.1 8712.6 11821.2 12276.3 12346.0 12385.1 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | [#3] mootools.html Cycles:180 Average:5967.07 Median:4762.68 stddev:3509.70 (73.7%) stddev-sans-first:3503.09 08:25:38 INFO - PROCESS | 7099 | Values: 1445.5 1558.9 1577.9 1760.1 1865.6 8653.0 9033.6 9089.7 9338.2 9355.1 9071.0 9267.7 9277.1 9281.5 9291.1 2067.0 2338.2 2399.8 2426.8 2457.6 2410.6 2420.4 2435.6 2440.0 2442.2 2326.6 2372.7 2373.5 2374.0 2378.5 2051.6 2336.6 2409.4 2415.8 2435.1 2324.4 2326.4 2332.7 2333.1 2362.8 9293.8 9334.1 9344.9 9359.2 9368.1 5260.6 5452.6 5461.8 5462.8 5464.5 3439.7 3449.6 3455.1 3547.4 3578.6 1102.9 1103.1 1109.5 1120.4 1154.5 13292.1 13308.5 13412.5 13450.9 13454.1 4621.4 4668.5 4748.1 4765.4 4788.7 10408.6 10440.6 10451.1 10453.3 10456.0 4839.4 5423.0 5483.4 5495.6 5504.7 4852.6 5053.9 5078.7 5088.0 5136.3 4270.2 4304.8 4319.0 4349.7 4522.2 1312.4 1317.8 1331.1 1340.4 1357.3 857.5 875.9 905.9 921.9 928.3 5452.8 5501.9 5560.7 5591.4 5636.5 950.7 959.6 988.9 1000.9 1020.9 3747.6 3795.8 3799.1 3815.7 3838.5 11345.1 11715.1 11740.4 11756.7 11764.4 11469.2 11520.2 11522.3 11605.8 11633.8 8174.7 8251.8 8401.8 8418.7 8647.1 5535.5 5571.4 5611.9 5632.5 5750.1 10472.7 10609.5 10694.4 10709.6 10711.4 10387.0 10720.5 10748.2 10927.2 10940.6 6763.5 6886.9 7533.1 7655.1 7771.3 8993.5 9019.0 9131.9 9132.7 9162.9 7853.9 7871.7 7945.3 8174.6 8202.4 7766.8 7841.2 7912.6 7957.7 8022.1 7117.5 7137.8 7148.2 7194.4 7199.3 4760.0 4875.4 4887.2 4976.7 5013.2 4796.7 4799.4 4848.5 4852.8 4906.8 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | [#4] prototype.html Cycles:180 Average:4480.49 Median:5031.47 stddev:1300.56 (25.8%) stddev-sans-first:1266.37 08:25:38 INFO - PROCESS | 7099 | Values: 330.8 335.9 338.9 339.6 340.2 5245.7 5292.2 5310.2 5350.6 5358.6 5178.9 5235.3 5265.0 5270.0 5271.9 3891.9 3912.6 3963.0 3981.5 3989.6 3796.4 4076.7 4085.4 4092.5 4096.6 4028.5 4046.1 4065.2 4073.7 4079.4 3921.5 3995.9 4065.5 4081.6 4084.9 3585.4 3591.1 3602.9 3605.3 3607.8 5017.2 5034.9 5044.7 5052.6 5095.8 4439.0 4628.9 4629.0 4638.1 4639.8 5431.2 5462.7 5465.5 5466.6 5471.6 3920.2 3936.6 3941.7 3945.4 3947.5 5169.6 5378.7 5641.8 5684.8 5687.2 3983.2 4003.4 4028.5 4032.8 4035.4 4096.7 4098.8 4101.5 4105.8 4105.9 4568.0 4634.7 4640.0 4655.1 4662.7 5510.2 5516.2 5518.0 5518.4 5523.0 1427.4 1442.6 1448.3 1452.5 1452.5 886.4 915.0 915.9 924.3 935.2 4703.3 4742.4 4746.0 4780.3 4784.2 5056.8 5062.8 5066.6 5067.5 5075.0 4609.6 4682.7 4791.6 4801.3 4802.7 2622.4 2625.9 2649.6 2669.5 2676.9 5164.3 5169.8 5179.4 5205.4 5210.5 4805.2 5016.6 5028.0 5070.7 5095.7 5069.6 5091.2 5149.2 5163.8 5211.3 4889.5 4959.4 4961.8 4964.8 4992.4 4921.4 4972.7 5207.7 5672.8 5684.2 5681.3 5798.0 5800.8 5802.7 5972.9 3894.3 3960.0 4035.6 4038.6 4044.8 5665.7 5677.1 5680.5 5681.3 5685.6 5275.4 5402.2 5508.9 5510.0 5517.4 5468.4 5473.9 5475.8 5478.8 5505.7 5159.8 5328.0 5352.7 5376.0 5419.3 5554.8 5589.3 5598.6 5599.9 5615.6 5424.4 5451.9 5466.5 5470.5 5477.0 08:25:38 INFO - PROCESS | 7099 | 08:25:38 INFO - PROCESS | 7099 | [#5] yui.html Cycles:180 Average:15299.86 Median:4399.17 stddev:18743.95 (426.1%) stddev-sans-first:18764.64 08:25:38 INFO - PROCESS | 7099 | Values: 739.3 757.8 864.3 871.4 883.5 12738.1 13268.5 13324.4 13361.6 13365.8 12014.3 12447.4 12927.1 12956.2 13306.6 820.6 825.2 829.8 832.5 834.2 848.4 849.0 850.1 851.3 851.4 898.8 899.9 903.7 905.0 907.3 899.8 900.2 900.3 901.4 902.1 659.0 660.1 660.2 660.6 660.9 12378.3 12533.1 12567.9 13138.7 13190.7 12162.1 12170.6 12190.6 12221.8 12241.6 10025.9 10053.5 10150.6 10152.5 10245.8 3735.8 3740.7 3857.2 3862.2 3869.2 53960.7 58439.0 60046.0 60451.7 61063.7 10273.9 10413.7 10481.1 10516.2 10597.6 17625.9 17654.7 17658.5 17668.4 17679.5 7016.6 7236.6 7364.2 7432.4 7566.8 4377.5 4420.9 4486.0 4506.5 4532.8 3243.2 3354.3 3385.2 3436.9 3436.9 675.1 693.2 701.3 703.7 706.3 614.3 690.2 703.3 711.1 726.6 8770.4 9005.7 9046.4 9495.0 9650.4 725.9 732.2 742.7 753.8 778.0 4086.7 4161.3 4191.3 4234.5 4236.5 65369.0 65513.7 69151.0 69438.3 69784.3 44265.3 57653.0 58798.0 60115.7 62941.0 56114.7 57002.4 57072.7 57458.4 57517.4 8841.9 9054.4 9116.1 9200.4 9258.4 36579.8 37020.6 37596.0 37773.4 37806.2 46592.0 49512.5 51113.5 51160.2 52217.0 10885.2 11514.8 11669.8 11818.5 11960.2 12833.9 13306.9 13375.7 13447.3 13477.7 11751.7 11755.0 12072.8 13205.3 13343.6 12584.4 12787.0 13094.5 13213.5 13819.1 12663.2 12842.7 12920.9 12929.5 13035.3 10667.4 10876.5 10914.3 10938.8 11176.1 10575.2 11079.0 11126.2 11174.8 11210.2 08:25:38 INFO - PROCESS | 7099 | -------- Summary: end -------- 08:25:38 INFO - PROCESS | 7099 | 08:25:39 INFO - TEST-INFO | 7099: exit 0 08:25:39 INFO - TEST-OK | dromaeo_css | took 1111909ms 08:25:39 INFO - TEST-START | kraken 08:25:39 INFO - operating with platform_type : linux_ 08:25:39 INFO - Initialising browser for kraken test... 08:25:39 INFO - TEST-INFO | started process 7278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOqRzj4/profile http://localhost:44132/getInfo.html) 08:25:42 INFO - PROCESS | 7278 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 08:25:43 INFO - PROCESS | 7278 | __metrics Screen width/height:1600/1200 08:25:43 INFO - PROCESS | 7278 | colorDepth:24 08:25:43 INFO - PROCESS | 7278 | Browser inner width/height: 1024/697 08:25:43 INFO - PROCESS | 7278 | __metrics 08:25:44 ERROR - PROCESS | 7278 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:25:44 INFO - TEST-INFO | 7278: exit 0 08:25:44 INFO - Browser initialized. 08:25:44 INFO - Running cycle 1/1 for kraken test... 08:25:44 INFO - TEST-INFO | started process 7356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOqRzj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:56 INFO - PROCESS | 7356 | RSS: Main: 152207360 08:25:56 INFO - PROCESS | 7356 | 08:25:59 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44132/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:59 INFO - PROCESS | 7356 | RSS: Main: 208117760 08:25:59 INFO - PROCESS | 7356 | 08:26:02 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44132/tests/kraken/driver.html?testName=audio-dft) 08:26:03 INFO - PROCESS | 7356 | RSS: Main: 197230592 08:26:03 INFO - PROCESS | 7356 | 08:26:06 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44132/tests/kraken/driver.html?testName=audio-fft) 08:26:07 INFO - PROCESS | 7356 | RSS: Main: 265207808 08:26:07 INFO - PROCESS | 7356 | 08:26:09 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44132/tests/kraken/driver.html?testName=audio-oscillator) 08:26:09 INFO - PROCESS | 7356 | RSS: Main: 174862336 08:26:09 INFO - PROCESS | 7356 | 08:26:12 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44132/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:12 INFO - PROCESS | 7356 | RSS: Main: 178982912 08:26:12 INFO - PROCESS | 7356 | 08:26:15 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44132/tests/kraken/driver.html?testName=imaging-darkroom) 08:26:16 INFO - PROCESS | 7356 | RSS: Main: 214454272 08:26:16 INFO - PROCESS | 7356 | 08:26:19 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44132/tests/kraken/driver.html?testName=imaging-desaturate) 08:26:20 INFO - PROCESS | 7356 | RSS: Main: 212553728 08:26:20 INFO - PROCESS | 7356 | 08:26:23 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44132/tests/kraken/driver.html?testName=json-parse-financial) 08:26:24 INFO - PROCESS | 7356 | RSS: Main: 213860352 08:26:24 INFO - PROCESS | 7356 | 08:26:25 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44132/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:26 INFO - PROCESS | 7356 | RSS: Main: 205795328 08:26:26 INFO - PROCESS | 7356 | 08:26:28 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:28 INFO - PROCESS | 7356 | RSS: Main: 209776640 08:26:28 INFO - PROCESS | 7356 | 08:26:30 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:31 INFO - PROCESS | 7356 | RSS: Main: 217690112 08:26:31 INFO - PROCESS | 7356 | 08:26:34 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:34 INFO - PROCESS | 7356 | RSS: Main: 224071680 08:26:34 INFO - PROCESS | 7356 | 08:26:37 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:38 INFO - PROCESS | 7356 | RSS: Main: 220409856 08:26:38 INFO - PROCESS | 7356 | 08:26:39 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:44132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44132/tests/kraken/driver.html?testName=ai-astar) 08:26:40 INFO - PROCESS | 7356 | RSS: Main: 266235904 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | __start_tp_report 08:26:40 INFO - PROCESS | 7356 | _x_x_mozilla_page_load 08:26:40 INFO - PROCESS | 7356 | _x_x_mozilla_page_load_details 08:26:40 INFO - PROCESS | 7356 | |i|pagename|runs| 08:26:40 INFO - PROCESS | 7356 | |0;ai-astar;111;104;111;109;111;109;110;109;110;109 08:26:40 INFO - PROCESS | 7356 | |1;audio-beat-detection;160;124;151;214;125;150;147;125;189;123 08:26:40 INFO - PROCESS | 7356 | |2;audio-dft;161;160;161;159;160;160;161;161;160;163 08:26:40 INFO - PROCESS | 7356 | |3;audio-fft;75;74;74;148;74;74;74;74;141;75 08:26:40 INFO - PROCESS | 7356 | |4;audio-oscillator;91;91;142;92;91;90;120;91;91;127 08:26:40 INFO - PROCESS | 7356 | |5;imaging-gaussian-blur;116;116;116;116;117;116;116;117;117;116 08:26:40 INFO - PROCESS | 7356 | |6;imaging-darkroom;146;145;145;145;145;145;145;145;146;146 08:26:40 INFO - PROCESS | 7356 | |7;imaging-desaturate;96;95;95;95;95;95;94;95;95;95 08:26:40 INFO - PROCESS | 7356 | |8;json-parse-financial;57;55;55;56;56;55;56;109;54;54 08:26:40 INFO - PROCESS | 7356 | |9;json-stringify-tinderbox;59;60;59;59;59;60;59;59;60;59 08:26:40 INFO - PROCESS | 7356 | |10;stanford-crypto-aes;77;77;77;78;79;78;78;79;79;78 08:26:40 INFO - PROCESS | 7356 | |11;stanford-crypto-ccm;128;119;119;116;114;119;122;117;195;120 08:26:40 INFO - PROCESS | 7356 | |12;stanford-crypto-pbkdf2;164;162;160;165;158;159;163;159;158;159 08:26:40 INFO - PROCESS | 7356 | |13;stanford-crypto-sha256-iterative;62;62;64;62;63;63;63;63;62;62 08:26:40 INFO - PROCESS | 7356 | __end_tp_report 08:26:40 INFO - PROCESS | 7356 | __start_cc_report 08:26:40 INFO - PROCESS | 7356 | _x_x_mozilla_cycle_collect,1823 08:26:40 INFO - PROCESS | 7356 | __end_cc_report 08:26:40 INFO - PROCESS | 7356 | __startTimestamp1463239600084__endTimestamp 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | ------- Summary: start ------- 08:26:40 INFO - PROCESS | 7356 | Number of tests: 14 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.06 (1.9%) stddev-sans-first:2.09 08:26:40 INFO - PROCESS | 7356 | Values: 111.0 104.0 111.0 109.0 111.0 109.0 110.0 109.0 110.0 109.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:150.50 stddev:30.51 (20.3%) stddev-sans-first:32.17 08:26:40 INFO - PROCESS | 7356 | Values: 160.0 124.0 151.0 214.0 125.0 150.0 147.0 125.0 189.0 123.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 08:26:40 INFO - PROCESS | 7356 | Values: 161.0 160.0 161.0 159.0 160.0 160.0 161.0 161.0 160.0 163.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#3] audio-fft Cycles:10 Average:88.30 Median:74.00 stddev:29.67 (40.1%) stddev-sans-first:31.08 08:26:40 INFO - PROCESS | 7356 | Values: 75.0 74.0 74.0 148.0 74.0 74.0 74.0 74.0 141.0 75.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:91.00 stddev:19.42 (21.3%) stddev-sans-first:20.14 08:26:40 INFO - PROCESS | 7356 | Values: 91.0 91.0 142.0 92.0 91.0 90.0 120.0 91.0 91.0 127.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:26:40 INFO - PROCESS | 7356 | Values: 116.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:26:40 INFO - PROCESS | 7356 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 08:26:40 INFO - PROCESS | 7356 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:55.50 stddev:17.00 (30.6%) stddev-sans-first:17.98 08:26:40 INFO - PROCESS | 7356 | Values: 57.0 55.0 55.0 56.0 56.0 55.0 56.0 109.0 54.0 54.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 08:26:40 INFO - PROCESS | 7356 | Values: 59.0 60.0 59.0 59.0 59.0 60.0 59.0 59.0 60.0 59.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 08:26:40 INFO - PROCESS | 7356 | Values: 77.0 77.0 77.0 78.0 79.0 78.0 78.0 79.0 79.0 78.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:119.50 stddev:24.22 (20.3%) stddev-sans-first:25.69 08:26:40 INFO - PROCESS | 7356 | Values: 128.0 119.0 119.0 116.0 114.0 119.0 122.0 117.0 195.0 120.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.58 (1.6%) stddev-sans-first:2.45 08:26:40 INFO - PROCESS | 7356 | Values: 164.0 162.0 160.0 165.0 158.0 159.0 163.0 159.0 158.0 159.0 08:26:40 INFO - PROCESS | 7356 | 08:26:40 INFO - PROCESS | 7356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 08:26:40 INFO - PROCESS | 7356 | Values: 62.0 62.0 64.0 62.0 63.0 63.0 63.0 63.0 62.0 62.0 08:26:40 INFO - PROCESS | 7356 | -------- Summary: end -------- 08:26:40 INFO - PROCESS | 7356 | 08:26:41 INFO - TEST-INFO | 7356: exit 0 08:26:41 INFO - TEST-OK | kraken | took 61931ms 08:26:41 INFO - SUITE-END | took 1173s 08:26:41 INFO - Completed test suite (00:19:33) 08:26:41 INFO - javascript benchmark 08:26:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3177.5710279112327, 3198.7281081108104, 3229.951550726739, 3237.643859175492, 3270.6729327067283, 5258.13240815266, 5304.973475132629, 5374.7850085996515, 5447.155690867917, 5492.34091908971, 5396.379416367119, 5421.864453388667, 5437.972810135944, 5472.069748142815, 5484.287042684446, 4876.487968763282, 4890.266460030988, 4967.205247160455, 4977.950220497803, 5004.974975125119, 4934.506549345073, 4954.504549545035, 4997.625178111638, 5004.84985450437, 5010.323606313137, 4823.469418363977, 4905.681130726492, 4968.105740966625, 4986.4265609455015, 4992.126377883856, 4970.030843985424, 4992.276119962585, 4997.550220480174, 5001.774920128603, 5046.747662616891, 4746.952530474686, 4951.529604687549, 4976.527229913152, 4986.4514903360605, 5042.596592272609, 5308.442613525563, 5364.329458817648, 5388.299521062276, 5435.402105768362, 5463.235147079412, 5798.304203495565, 5876.206712093898, 5877.441643043947, 5879.235699359056, 5881.617694849821, 5686.54507639392, 5801.622894511843, 5805.854853628651, 5823.883522329572, 5828.679422631753, 5440.319960004999, 5523.4200408956485, 5546.473085056913, 5555.694436806015, 5558.166275058774, 6046.738362665033, 6051.485623722033, 6072.362401947732, 6106.603070800384, 6107.572469927151, 5546.473085056913, 5631.2397826293745, 5638.633488823213, 5764.855878602984, 5815.2149459822385, 5754.510866576305, 5767.913481297784, 5769.913451298234, 5770.6249093808765, 5815.098659707752, 5721.685307308138, 5764.971175144097, 5775.826725198251, 5783.248177736868, 5784.248047753849, 5607.8598035048635, 5693.914591281134, 5747.913781293284, 5805.0, 5826.126081087786, 4409.382686423904, 4421.336799480039, 4423.955760442354, 4425.225585522585, 4454.354118652842, 3963.0884896473394, 3975.5030621172355, 3988.4017397390626, 4020.577839326887, 4023.8390464381096, 5331.493508116722, 5372.355317361941, 5442.2380866678695, 5445.373782015119, 5483.122700367922, 5819.621724587888, 5842.182094506772, 5855.151003104526, 5857.88284234313, 5858.941410585925, 5478.096114141202, 5505.559555235572, 5509.063459211943, 5511.283533140746, 5516.034693928546, 4818.494058123917, 4984.7258400788305, 5012.0, 5050.924236136461, 5065.265536497187, 6084.969575152184, 6085.148079268906, 6085.574009819358, 6087.269527656709, 6091.756329746849, 5555.7499912504845, 5798.710064496842, 5809.5352371811, 5810.912836307543, 5814.04068328721, 6008.7296071676, 6046.0, 6059.969700151471, 6094.169091873762, 6097.917917222642, 5670.376258611467, 5686.175504551899, 5727.513161381329, 5732.140178973187, 5780.132980053026, 5637.351704553865, 5801.1878337033695, 5826.126081087871, 5829.94170058294, 5832.270966129234, 5648.435156484319, 5668.376478587435, 5688.431156884444, 5731.111677689964, 5744.109663002241, 5703.600747947604, 5726.713664316684, 5726.828195154152, 5727.427257274239, 5733.226014487991, 5308.654937429054, 5504.311961004874, 5624.240727501735, 5630.493255607015, 5637.8590535236945, 5675.57433192504, 5738.913916291175, 5753.1945527627, 5754.798582049608, 5786.363500015079, 5557.72211389437, 5562.11006239016, 5568.610197286151, 5571.7492712828835, 5603.215549822947], "value": 5363.271726615289, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.4366947912141, 657.4510283912933, 658.7134596450542, 664.0139393001392, 677.3159109299609, 33457.498137527924, 36433.453498197516, 36463.4530482043, 44519.77740111303, 45484.317735234, 47281.290780638235, 47586.0, 47664.76167619157, 47723.04553908928, 47888.52111478884, 9020.864687029683, 9160.679376221833, 9162.633494660206, 9164.908350916505, 9168.495732734697, 9021.233195178418, 9121.270298376114, 9123.361364704473, 9128.908710912905, 9131.086891310882, 9156.404833685823, 9187.448753074837, 9198.494082825442, 9199.356045076847, 9209.631614735403, 9095.818083638324, 9112.179903808688, 9127.452352858816, 9136.132067453582, 9146.451212927179, 8943.418677785923, 8990.41562298455, 9008.189262966365, 9008.954955225181, 9012.414193077495, 42850.35724464135, 43087.35368969468, 43094.353584696255, 43140.56859431397, 43170.56829431697, 3862.7875466849314, 3995.62041606047, 4394.274944634131, 4494.865154045384, 4514.45826500822, 33018.504722429185, 33642.49536256934, 34045.489317660256, 34189.316213675585, 35182.64817351845, 4424.579664931826, 4452.265376212921, 4490.169318676023, 4501.054778496519, 4515.187266292066, 322417.0, 322889.0, 322932.0, 325483.0, 328209.9999999976, 61251.69374153101, 61575.07637385443, 61696.07455888165, 61729.691351542955, 61741.0, 37520.81239593784, 38370.2325953485, 38380.0, 40080.0, 40126.59873401287, 17856.46430607058, 17980.820191797913, 18107.45677629673, 18130.0, 18163.63672726538, 13656.248906310248, 13796.517121900886, 13796.931015344859, 13804.102733322303, 13808.309584520734, 20016.199352025757, 20084.799152008294, 20155.899220503805, 20266.594668106554, 20318.28885988983, 7190.8000939582425, 7206.207317195104, 7320.414366850639, 7447.255274472618, 7576.24237576238, 1042.3849928542197, 1060.1306928318704, 1083.7236504691411, 1152.5101831721486, 1216.367488905764, 33286.33427331488, 34450.483242751376, 34545.30909381798, 36708.0, 36858.0, 1150.344303746873, 1220.3776074202044, 1237.1031002523098, 1259.9622011339675, 1263.8357013588175, 17041.914790426217, 17408.82591174072, 17565.824341756674, 17598.38405655796, 17617.647647046986, 540106.0, 543889.0, 543905.0, 543991.0, 544441.0, 58943.41056589465, 60290.0, 60395.67823769735, 60438.09342859861, 60443.69778151169, 1454.978175327371, 1466.8239811222722, 1477.8152730908637, 1488.694817562397, 1493.3802471974227, 31271.53092703657, 32214.0, 32473.67526324801, 32923.17692057718, 32947.76063567125, 53192.0, 53944.73027634837, 54282.18576721274, 54379.0, 54395.456045440624, 358288.0, 359507.0, 359707.0, 359786.0, 359940.0, 26177.73822261753, 27265.0, 29352.0, 29811.55282670805, 30610.693893060783, 48290.0, 48639.0, 48917.755411222715, 49424.752876236824, 49634.503654964436, 40227.3965890506, 41391.1721765569, 41999.7900010498, 42137.789311053246, 42407.575924240366, 39589.2082158361, 39930.80034599808, 40255.396169056905, 40841.0, 41122.17755644811, 34469.0, 42419.7879010603, 45586.08827823358, 45906.54093459023, 46195.076098478516, 35490.64509354976, 36530.26939461143, 36700.816495918414, 36793.0, 37255.44116838304, 28185.617725872205, 28234.152975410772, 28402.715972840007, 28415.857920710263, 28420.57369139423], "value": 20488.108168227925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.75391388210113, 414.8506537646447, 417.89134824945506, 420.10727204690033, 432.16807645282825, 18251.178696958636, 19679.5080122997, 19713.21147154114, 19760.209591616334, 20729.274475393326, 11399.259048161864, 11574.0, 15681.607959801011, 19405.70891436626, 19432.417027489162, 4660.440747110335, 4942.18453955097, 5214.895702085956, 5320.654157479771, 5450.264214331074, 4012.6589239914642, 4162.500499940012, 4164.167166566699, 5395.406505284415, 5600.4959553640165, 5844.444777746107, 5925.73334199962, 5956.106584012411, 5957.106434034886, 5963.761449542013, 5809.88380232393, 5872.500837428824, 5935.080062590306, 5955.731992060346, 5968.343482216953, 3812.4281357796553, 5162.657708995688, 5759.798407055775, 5768.394318596529, 5785.045467497858, 12878.162919410208, 12946.870531294755, 12951.287679177642, 12952.287624180666, 15757.60605984848, 2282.0985710644204, 2445.5597992361368, 2457.606782914725, 2503.036331012573, 2866.870990805419, 9258.861117083248, 9638.180754635794, 9689.467079310634, 9869.605215791431, 10085.142762865165, 1901.7812951510616, 1967.911443985024, 1982.2368388170657, 1985.3051431998829, 2034.7965203479534, 78964.99999999943, 79143.20856791474, 80719.0, 82317.58841205816, 83935.0, 10783.892161078445, 10908.563657453613, 10968.561257549609, 11035.337879727082, 11129.0, 15092.094474331576, 15148.772768408482, 15152.166630835189, 15172.544823655307, 15200.087994720352, 8128.39037072222, 8289.58552072394, 8400.159984001551, 8466.0, 8533.74398768038, 8114.83770324602, 8115.310198633064, 8154.5514996674565, 8264.338852891755, 8279.213474719892, 4461.643068554507, 4475.932861007088, 4490.865274041784, 4522.23122069249, 4557.316402539645, 1729.6540691861678, 1774.9713636669917, 1873.9718904216447, 1885.481492589549, 2049.108637742587, 912.7170577121113, 1042.1298215989582, 1062.5059347403494, 1078.320657985464, 1085.9782804344027, 19051.333203337817, 19784.60430791376, 19809.40571782849, 19979.0, 20010.89994550047, 1042.6038105519854, 1044.6865940217904, 1054.1303424674675, 1071.994640026795, 1103.5806393570392, 10739.731506712395, 11240.325580465198, 11282.887171128184, 11322.886771132347, 11408.372539510241, 472532.0, 498754.0, 499937.00314984104, 500211.0, 500840.0, 57071.71464142653, 63797.0, 88839.0, 90956.0, 93287.53356233175, 1027.445179603021, 1032.8140934631688, 1057.2757661002393, 1059.4279089291697, 1075.93544387337, 16732.0, 17094.145292735066, 17330.0, 17436.389726359517, 17639.82360176382, 37393.626063739015, 37435.81282093681, 37637.2472550542, 39133.82598522049, 39378.60621393749, 55892.0, 56061.71969140291, 56105.43894561002, 56142.43857561372, 56564.43435565592, 8445.451045682012, 8484.91515084866, 8524.488530688179, 8645.56772161402, 8676.522791246542, 8664.610092545725, 12673.30296833683, 13076.673083172996, 13110.410031548412, 13392.26342551169, 6054.273487181566, 9123.954380228057, 9293.581788819654, 9835.557399917165, 11886.940565297118, 11656.0, 11860.94069529647, 11864.881351186723, 11893.0, 11944.223625464318, 11713.297202167898, 12153.756924861276, 12271.877281227073, 12485.12604117703, 12583.182093163916, 8403.579821009047, 8421.32629389635, 8472.83054338922, 8537.0, 8693.130686931256, 8712.564371781513, 11821.231619944676, 12276.263424194576, 12346.0, 12385.133040687066], "value": 8885.95092956516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.4579532675248, 1558.8752899768017, 1577.9211039448026, 1760.0935518208125, 1865.5615930256397, 8653.0, 9033.638654453822, 9089.68186113486, 9338.159565639091, 9355.111264429885, 9070.954645226764, 9267.675631352904, 9277.118673726001, 9281.53592320383, 9291.11734385234, 2067.0491573876034, 2338.205010296499, 2399.8440101393353, 2426.842255253407, 2457.5576396248666, 2410.5781488239577, 2420.4432980414517, 2435.561598912195, 2439.9756002440013, 2442.1818690738623, 2326.5928462519078, 2372.6796882420826, 2373.4778348763243, 2374.0, 2378.54807586558, 2051.579426217629, 2336.6261398176293, 2409.4096946248105, 2415.758424157588, 2435.111184417675, 2324.37241944674, 2326.4183954011496, 2332.685087513181, 2333.1134169015663, 2362.8464149830206, 9293.767655808591, 9334.06659334068, 9344.906550934471, 9359.157675809141, 9368.110029547182, 5260.631755777097, 5452.645578037414, 5461.808836690697, 5462.8361149165585, 5464.508194262496, 3439.7420193485336, 3449.5688038995127, 3455.06713187438, 3547.379208638478, 3578.6063533011347, 1102.922795404322, 1103.1064837481665, 1109.5118148014847, 1120.4117838135044, 1154.5497256070055, 13292.069555131146, 13308.534201303004, 13412.530561430402, 13450.93274533631, 13454.05821592489, 4621.353010578522, 4668.5098064702715, 4748.050389922029, 4765.404324459442, 4788.712677239377, 10408.5836566538, 10440.582376704999, 10451.059404653466, 10453.268271221094, 10456.0, 4839.395075615548, 5423.0, 5483.424240454775, 5495.642783219078, 5504.697241651747, 4852.636052296021, 5053.898922021539, 5078.746062696924, 5088.0, 5136.280920671109, 4270.167317373144, 4304.80628371724, 4318.978405107954, 4349.739015659071, 4522.186006518792, 1312.4356526693423, 1317.7613043738854, 1331.088204579866, 1340.443715857908, 1357.2738584857054, 857.4640849469082, 875.868619707049, 905.9411138275991, 921.8847644044495, 928.3269629518545, 5452.836414907559, 5501.889962200734, 5560.666360018331, 5591.356993945748, 5636.464535869086, 950.6577632052456, 959.6449313753956, 988.8862780780158, 1000.9199264058858, 1020.9438480883474, 3747.550293964687, 3795.8102094895144, 3799.1262009737916, 3815.6756675682877, 3838.5393752749846, 11345.149113816331, 11715.062794976382, 11740.412979350998, 11756.70608234801, 11764.35296058725, 11469.197156198987, 11520.193586448868, 11522.308661480338, 11605.76788464226, 11633.825492617449, 8174.6730130795295, 8251.8349633007, 8401.831963360699, 8418.747437576883, 8647.0920553341, 5535.474129957647, 5571.3592936811165, 5611.859703507445, 5632.464915832989, 5750.13747937796, 10472.738181545523, 10609.469526523488, 10694.358338499715, 10709.571617135227, 10711.410872402093, 10387.0, 10720.517576709222, 10748.247622666338, 10927.235093543375, 10940.56237750481, 6763.526553141233, 6886.896696549656, 7533.096028476618, 7655.119661239029, 7771.261730135628, 8993.460392376479, 9019.0, 9131.908680913106, 9132.680356187502, 9162.908370916206, 7853.882191767014, 7871.685132594632, 7945.284924356835, 8174.591270436574, 8202.38482113832, 7766.844663106819, 7841.215878412113, 7912.643931023003, 7957.681692732226, 8022.077461092049, 7117.4661900358715, 7137.750178743719, 7148.249433809375, 7194.352508274281, 7199.316064973819, 4759.9524004759505, 4875.366202393666, 4887.242477416006, 4976.701397916137, 5013.24801279811, 4796.712197268175, 4799.352087468147, 4848.539388758062, 4852.80588776445, 4906.754662266943], "value": 4731.372834980229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.79656011552885, 335.85390355195494, 338.86445421831263, 339.5857054393639, 340.168288534533, 5245.711485868275, 5292.153255479124, 5310.176922576997, 5350.625456218067, 5358.571314294857, 5178.876660569167, 5235.319408476902, 5264.973675131619, 5270.0, 5271.86820329491, 3891.8832435026993, 3912.5500567434683, 3962.960370396288, 3981.5023122109737, 3989.640932316091, 3796.4115562087923, 4076.673866090706, 4085.44846445729, 4092.529359123694, 4096.5903409659095, 4028.516578010628, 4046.069404037073, 4065.2276067547073, 4073.7352072115364, 4079.4492743479545, 3921.5490218624936, 3995.921101302632, 4065.512138543364, 4081.571434999327, 4084.856240252719, 3585.372559802024, 3591.1381268495634, 3602.865097494307, 3605.2789442111684, 3607.783532988029, 5017.172166592508, 5034.949650503485, 5044.672096313728, 5052.621053420971, 5095.770690318945, 4438.977805110986, 4628.884277893046, 4628.981624042705, 4638.121560767894, 4639.814407423699, 5431.21247419122, 5462.7268636568015, 5465.453454654543, 5466.562674985991, 5471.644343117724, 3920.2159568086213, 3936.6260205280737, 3941.7138059925173, 3945.3687410014545, 3947.519680119955, 5169.586433085344, 5378.704171270579, 5641.815218804056, 5684.8294551163535, 5687.203791469197, 3983.1635356574866, 4003.3594624860466, 4028.4762980812893, 4032.8185231664647, 4035.3543433050572, 4096.73371230869, 4098.827621360683, 4101.507819061731, 4105.835766569364, 4105.85629502966, 4568.002997377295, 4634.72191668501, 4639.979204574988, 4655.068986202773, 4662.650301227422, 5510.173473978935, 5516.200150978166, 5517.951589198039, 5518.44815518453, 5522.972385138049, 1427.357689039936, 1442.5672298310465, 1448.2975756757965, 1452.4553292515307, 1452.5061479097158, 886.390660469138, 914.9954250228707, 915.8534634458455, 924.2652091587204, 935.1583574782615, 4703.318018887242, 4742.407199100113, 4745.952540474551, 4780.259059845729, 4784.234522476387, 5056.82301119459, 5062.772175252049, 5066.569341605931, 5067.4932506749765, 5074.995376826133, 4609.60818330439, 4682.719036857799, 4791.592714619227, 4801.319538161685, 4802.687825291345, 2622.396848724804, 2625.8555779432313, 2649.562822134365, 2669.5328317544354, 2676.8795404206858, 5164.32863727713, 5169.793208271627, 5179.430262671103, 5205.375354957429, 5210.47895210476, 4805.231163013971, 5016.598672106223, 5027.99440111979, 5070.721110338893, 5095.694258344512, 5069.6451248413, 5091.236314552921, 5149.176131818891, 5163.7676304566385, 5211.270422140903, 4889.486603906538, 4959.3552838132255, 4961.801527938842, 4964.815481188266, 4992.425871024879, 4921.434035085867, 4972.726500042388, 5207.661502002357, 5672.75199456119, 5684.232628595087, 5681.318241811009, 5798.0, 5800.767969281182, 5802.738876750641, 5972.940270597239, 3894.2990261753157, 3959.970407693963, 4035.596440355941, 4038.6163314485075, 4044.7977601119237, 5665.716714164193, 5677.148427735872, 5680.545556355564, 5681.289838770153, 5685.630434021776, 5275.419703832652, 5402.189671549299, 5508.8706815102005, 5509.972450137724, 5517.36550296705, 5468.371137319259, 5473.945260547503, 5475.767952210721, 5478.780848766164, 5505.724713764376, 5159.831330298309, 5328.0, 5352.678839269501, 5375.962581141643, 5419.295491586068, 5554.777808887599, 5589.273394458694, 5598.552115830806, 5599.860003499945, 5615.624172077867, 5424.3761967372675, 5451.890962180655, 5466.535344495763, 5470.5350045245, 5477.02826982294], "value": 4073.607366649967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.2976672161448, 757.7840315510077, 864.3301441382928, 871.4248595926686, 883.4566741454006, 12738.108332416723, 13268.535601253958, 13324.40040198191, 13361.59915202543, 13365.799513007301, 12014.339211343373, 12447.439865206064, 12927.09510334277, 12956.15784973976, 13306.600801975932, 820.6020080261069, 825.1954344514081, 829.7593697827623, 832.5421018439833, 834.1950018232404, 848.4315508609246, 848.9939421785174, 850.0861573808181, 851.2891735400917, 851.4210336970857, 898.8292224477361, 899.8920129584459, 903.7469508537587, 905.0406569036842, 907.2923119966437, 899.8155378147464, 900.2033200617435, 900.2842740021666, 901.4050726520466, 902.0753727429371, 659.0312241005714, 660.145112079853, 660.1879687983807, 660.6465540935625, 660.9438197753196, 12378.319192444413, 12533.122681412306, 12567.93716031414, 13138.737225255538, 13190.73618527624, 12162.148649594532, 12170.574029909, 12190.57332993341, 12221.816672749916, 12241.571544995972, 10025.89974100257, 10053.547590358452, 10150.593976240942, 10152.543135558917, 10245.84631230532, 3735.8132093395493, 3740.719446041531, 3857.1514266861245, 3862.1503269280715, 3869.1681288522823, 53960.73019634877, 58439.0, 60046.0, 60451.69774151145, 61063.69468152631, 10273.9486302568, 10413.739656508496, 10481.056704896597, 10516.211284153565, 10597.576096956036, 17625.911870440566, 17654.735178972325, 17658.470245892644, 17668.38160664396, 17679.469615911545, 7016.649167541603, 7236.6019868907715, 7364.22675619063, 7432.368248698813, 7566.772996810105, 4377.474703035656, 4420.8673739787855, 4485.977570112129, 4506.526814684476, 4532.773361331986, 3243.189202699325, 3354.278830051551, 3385.170633194883, 3436.862525499002, 3436.9484457733156, 675.0650349266203, 693.2478261086677, 701.2706784943601, 703.714995426853, 706.3148745716646, 614.3242433323309, 690.2476300832017, 703.2861645429892, 711.1324184494908, 726.556800351785, 8770.429922055046, 9005.729828105168, 9046.366754327266, 9495.0, 9650.372725772802, 725.9092613423322, 732.2128711635014, 742.688071010177, 753.830388162659, 778.0468925566249, 4086.734362266443, 4161.279533553289, 4191.287481128215, 4234.491860976641, 4236.512801027921, 65369.0, 65513.67243163849, 69151.0, 69438.3056169442, 69784.3021569788, 44265.33601995972, 57653.0, 58797.99999999914, 60115.69942150261, 62941.0, 56114.719426402604, 57002.42997569971, 57072.71463642655, 57458.42541574614, 57517.424825752045, 8841.911580884109, 9054.366194366332, 9116.08839116083, 9200.401973871676, 9258.398204116711, 36579.817100914326, 37020.629793701715, 37596.0, 37773.4333984996, 37806.24387512289, 46592.0, 49512.50487495223, 51113.48886511087, 51160.23259651183, 52217.0, 10885.23803333759, 11514.827277590675, 11669.824952625548, 11818.527258909548, 11960.175911307482, 12833.871661283267, 13306.933465332611, 13375.665608359868, 13447.260400678057, 13477.663058423617, 11751.706207344885, 11755.0, 12072.75854482888, 13205.27370994566, 13343.599692009255, 12584.433700483683, 12787.0, 13094.476220951436, 13213.471461141447, 13819.101758385672, 12663.240205587694, 12842.67893302675, 12920.935395322964, 12929.482820687068, 13035.283059431822, 10667.413292269, 10876.510557024794, 10914.345139291669, 10938.835917461085, 11176.105911526896, 10575.153987680813, 11079.0, 11126.221164518405, 11174.832377514507, 11210.159238057342], "value": 6760.899053794804, "unit": "score"}], "name": "dromaeo_css", "value": 7092.109560142699, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 109.0, 111.0, 109.0, 110.0, 109.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 151.0, 214.0, 125.0, 150.0, 147.0, 125.0, 189.0, 123.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 160.0, 160.0, 161.0, 161.0, 160.0, 163.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 148.0, 74.0, 74.0, 74.0, 74.0, 141.0, 75.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 142.0, 92.0, 91.0, 90.0, 120.0, 91.0, 91.0, 127.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 109.0, 54.0, 54.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 78.0, 79.0, 78.0, 78.0, 79.0, 79.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 119.0, 116.0, 114.0, 119.0, 122.0, 117.0, 195.0, 120.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 160.0, 165.0, 158.0, 159.0, 163.0, 159.0, 158.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1516.4, "alertThreshold": 2.0}]} 08:26:41 INFO - Return code: 0 08:26:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:26:41 ERROR - # TBPL SUCCESS # 08:26:41 INFO - Running post-action listener: _resource_record_post_action 08:26:41 INFO - ##### 08:26:41 INFO - ##### Finished run-tests step (success) 08:26:41 INFO - ##### 08:26:41 INFO - Running post-run listener: _resource_record_post_run 08:26:41 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545542144; Read time: 12; Write time: 385192 08:26:41 INFO - TinderboxPrint: CPU usage
13.1% 08:26:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:26:41 INFO - TinderboxPrint: I/O write bytes / time
545,542,144 / 385,192 08:26:41 INFO - TinderboxPrint: CPU idle
8,265.7 (86.9%) 08:26:41 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 08:26:41 INFO - TinderboxPrint: Swap in / out
0 / 0 08:26:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255123456; Read time: 0; Write time: 201220 08:26:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290418688; Read time: 12; Write time: 183972 08:26:42 INFO - Running post-run listener: _upload_blobber_files 08:26:42 INFO - Blob upload gear active. 08:26:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:42 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:26:42 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:26:42 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:26:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:43 INFO - (blobuploader) - INFO - Done attempting. 08:26:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:48 INFO - (blobuploader) - INFO - Done attempting. 08:26:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:26:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:26:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:49 INFO - (blobuploader) - INFO - Done attempting. 08:26:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:49 INFO - Return code: 0 08:26:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71a3a60d70e16653bf3cbdc62df4b21ec6657fbae2d8b0324f8f9e1537d9ee4cb8b8c43a6fa0e50cd7a9e9b72754d903e3def954a075a45109df05b4fcf6b438", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e647095c1672174c2d290dd5ba76b6649543ba2697660b5495dfb5276252cb01b2523daeaa0cbc44c29fb6ffa77d4ea50e890ee9ea4edf21e0fdc96542a838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0d73ad9c3a2d0751b5c91af122db906181ed9c2d07585e0ec8570bfdd1ad69818426807226ba103d5ff6d3eace4b13d0cc5b9d4288448a91cc98cb265403131"} 08:26:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:49 INFO - Contents: 08:26:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71a3a60d70e16653bf3cbdc62df4b21ec6657fbae2d8b0324f8f9e1537d9ee4cb8b8c43a6fa0e50cd7a9e9b72754d903e3def954a075a45109df05b4fcf6b438", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e647095c1672174c2d290dd5ba76b6649543ba2697660b5495dfb5276252cb01b2523daeaa0cbc44c29fb6ffa77d4ea50e890ee9ea4edf21e0fdc96542a838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0d73ad9c3a2d0751b5c91af122db906181ed9c2d07585e0ec8570bfdd1ad69818426807226ba103d5ff6d3eace4b13d0cc5b9d4288448a91cc98cb265403131"} 08:26:49 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:49 INFO - Copying logs to upload dir... 08:26:49 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.387712 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-14 08:26:49.323881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 08:26:49.326923) ========= 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=ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116 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/71a3a60d70e16653bf3cbdc62df4b21ec6657fbae2d8b0324f8f9e1537d9ee4cb8b8c43a6fa0e50cd7a9e9b72754d903e3def954a075a45109df05b4fcf6b438", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e647095c1672174c2d290dd5ba76b6649543ba2697660b5495dfb5276252cb01b2523daeaa0cbc44c29fb6ffa77d4ea50e890ee9ea4edf21e0fdc96542a838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0d73ad9c3a2d0751b5c91af122db906181ed9c2d07585e0ec8570bfdd1ad69818426807226ba103d5ff6d3eace4b13d0cc5b9d4288448a91cc98cb265403131"} 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.011147 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/71a3a60d70e16653bf3cbdc62df4b21ec6657fbae2d8b0324f8f9e1537d9ee4cb8b8c43a6fa0e50cd7a9e9b72754d903e3def954a075a45109df05b4fcf6b438", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e647095c1672174c2d290dd5ba76b6649543ba2697660b5495dfb5276252cb01b2523daeaa0cbc44c29fb6ffa77d4ea50e890ee9ea4edf21e0fdc96542a838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0d73ad9c3a2d0751b5c91af122db906181ed9c2d07585e0ec8570bfdd1ad69818426807226ba103d5ff6d3eace4b13d0cc5b9d4288448a91cc98cb265403131"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 08:26:49.350617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:26:49.350907) ========= 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=ed14279e38b05397cf4aa391000001a4-1463233485.136989-3556116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 08:26:49.433045) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 08:26:49.433351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 08:26:49.433633) ========= ========= Total master_lag: 0.15 =========