builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1463800249.13 results: success (0) buildid: 20160520173011 builduid: 28fac613c2754170bc0d7bfc0ae618f5 revision: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.127434) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.128051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.128322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.186992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.187292) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1463797467.265097-801786032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 20:10:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.9M=0s 2016-05-20 20:10:50 (25.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108530 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.322151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.322445) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1463797467.265097-801786032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019659 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:49.382933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 20:10:49.383239) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 911e01d2cbe0f75e5645aa5070e179885a1dbef7 --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 911e01d2cbe0f75e5645aa5070e179885a1dbef7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1463797467.265097-801786032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 20:10:50,230 truncating revision to first 12 chars 2016-05-20 20:10:50,230 Setting DEBUG logging. 2016-05-20 20:10:50,231 attempt 1/10 2016-05-20 20:10:50,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/911e01d2cbe0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 20:10:51,151 unpacking tar archive at: fx-team-911e01d2cbe0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.830631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 20:10:51.229356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:51.229669) ========= script_repo_revision: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:51.230084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:51.230379) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 20:10:51.240788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-20 20:10:51.241051) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1463797467.265097-801786032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:10:52 INFO - MultiFileLogger online at 20160520 20:10:52 in /builds/slave/test 20:10:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:10:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:52 INFO - {'append_to_log': False, 20:10:52 INFO - 'base_work_dir': '/builds/slave/test', 20:10:52 INFO - 'blob_upload_branch': 'Fx-Team', 20:10:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:52 INFO - 'branch': 'Fx-Team', 20:10:52 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:52 INFO - 'config_files': ('talos/linux_config.py',), 20:10:52 INFO - 'default_actions': ('clobber', 20:10:52 INFO - 'read-buildbot-config', 20:10:52 INFO - 'download-and-extract', 20:10:52 INFO - 'populate-webroot', 20:10:52 INFO - 'create-virtualenv', 20:10:52 INFO - 'install', 20:10:52 INFO - 'run-tests'), 20:10:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:52 INFO - 'download_minidump_stackwalk': True, 20:10:52 INFO - 'download_symbols': 'ondemand', 20:10:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:10:52 INFO - 'tooltool.py': '/tools/tooltool.py', 20:10:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:10:52 INFO - '/tools/misc-python/virtualenv.py')}, 20:10:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:52 INFO - 'installer_path': 'installer.exe', 20:10:52 INFO - 'log_level': 'info', 20:10:52 INFO - 'log_name': 'talos', 20:10:52 INFO - 'log_to_console': True, 20:10:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:10:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:10:52 INFO - 'opt_config_files': (), 20:10:52 INFO - 'pip_index': False, 20:10:52 INFO - 'sps_profile': False, 20:10:52 INFO - 'sps_profile_interval': 0, 20:10:52 INFO - 'suite': 'dromaeojs-e10s', 20:10:52 INFO - 'system_bits': '32', 20:10:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:52 INFO - 'title': 'talos-linux64-ix-032', 20:10:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:52 INFO - 'use_talos_json': True, 20:10:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:52 INFO - 'work_dir': 'build'} 20:10:52 INFO - ##### 20:10:52 INFO - ##### Running clobber step. 20:10:52 INFO - ##### 20:10:52 INFO - Running pre-action listener: _resource_record_pre_action 20:10:52 INFO - Running main action method: clobber 20:10:52 INFO - rmtree: /builds/slave/test/build 20:10:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:53 INFO - Running post-action listener: _resource_record_post_action 20:10:53 INFO - ##### 20:10:53 INFO - ##### Finished clobber step (success) 20:10:53 INFO - ##### 20:10:53 INFO - ##### 20:10:53 INFO - ##### Running read-buildbot-config step. 20:10:53 INFO - ##### 20:10:53 INFO - Running pre-action listener: _resource_record_pre_action 20:10:53 INFO - Running main action method: read_buildbot_config 20:10:53 INFO - Using buildbot properties: 20:10:53 INFO - { 20:10:53 INFO - "project": "", 20:10:53 INFO - "product": "firefox", 20:10:53 INFO - "script_repo_revision": "production", 20:10:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:10:53 INFO - "repository": "", 20:10:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:10:53 INFO - "buildid": "20160520173011", 20:10:53 INFO - "pgo_build": "True", 20:10:53 INFO - "basedir": "/builds/slave/test", 20:10:53 INFO - "buildnumber": 764, 20:10:53 INFO - "slavename": "talos-linux64-ix-032", 20:10:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:10:53 INFO - "platform": "ubuntu64_hw", 20:10:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:10:53 INFO - "branch": "fx-team", 20:10:53 INFO - "repo_path": "integration/fx-team", 20:10:53 INFO - "revision": "911e01d2cbe0f75e5645aa5070e179885a1dbef7", 20:10:53 INFO - "stage_platform": "linux64-pgo", 20:10:53 INFO - "builduid": "28fac613c2754170bc0d7bfc0ae618f5", 20:10:53 INFO - "slavebuilddir": "test" 20:10:53 INFO - } 20:10:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:10:53 INFO - Running post-action listener: _resource_record_post_action 20:10:53 INFO - ##### 20:10:53 INFO - ##### Finished read-buildbot-config step (success) 20:10:53 INFO - ##### 20:10:53 INFO - ##### 20:10:53 INFO - ##### Running download-and-extract step. 20:10:53 INFO - ##### 20:10:53 INFO - Running pre-action listener: _resource_record_pre_action 20:10:53 INFO - Running main action method: download_and_extract 20:10:53 INFO - mkdir: /builds/slave/test/build/tests 20:10:53 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')]} 20:10:53 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:10:55 INFO - Downloaded 1361 bytes. 20:10:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:10:55 INFO - Using the following test package requirements: 20:10:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:10:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:10:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'jsshell-linux-x86_64.zip'], 20:10:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:10:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:10:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:10:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:10:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:10:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:55 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:10:57 INFO - Downloaded 24389154 bytes. 20:10:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:10:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:10:59 INFO - Return code: 0 20:10:59 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 20:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:59 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:11:06 INFO - Downloaded 24389154 bytes. 20:11:06 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'] 20:11:06 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 20:11:07 INFO - Return code: 0 20:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:07 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:11:09 INFO - Downloaded 10840359 bytes. 20:11:09 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'] 20:11:09 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 20:11:09 INFO - Return code: 0 20:11:09 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')]} 20:11:09 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:11:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/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 20:11:11 INFO - Downloaded 58577061 bytes. 20:11:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:11 INFO - mkdir: /builds/slave/test/properties 20:11:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:11 INFO - Contents: 20:11:11 INFO - build_url:https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:11 INFO - Running post-action listener: _resource_record_post_action 20:11:11 INFO - Running post-action listener: set_extra_try_arguments 20:11:11 INFO - ##### 20:11:11 INFO - ##### Finished download-and-extract step (success) 20:11:11 INFO - ##### 20:11:11 INFO - ##### 20:11:11 INFO - ##### Running populate-webroot step. 20:11:11 INFO - ##### 20:11:11 INFO - Running pre-action listener: _resource_record_pre_action 20:11:11 INFO - Running main action method: populate_webroot 20:11:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:11 INFO - '--tppagecycles', 20:11:11 INFO - '7'], 20:11:11 INFO - 'tests': ['tsvgm']}}, 20:11:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:11:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:11:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['damp', 'tps']}, 20:11:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'tests': ['damp', 'tps']}, 20:11:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['dromaeo_dom']}, 20:11:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['a11yr', 20:11:11 INFO - 'ts_paint', 20:11:11 INFO - 'tpaint', 20:11:11 INFO - 'sessionrestore', 20:11:11 INFO - 'sessionrestore_no_auto_restore', 20:11:11 INFO - 'tabpaint']}, 20:11:11 INFO - 'other-e10s': {'tests': ['a11yr', 20:11:11 INFO - 'ts_paint', 20:11:11 INFO - 'tpaint', 20:11:11 INFO - 'sessionrestore', 20:11:11 INFO - 'sessionrestore_no_auto_restore', 20:11:11 INFO - 'tabpaint']}, 20:11:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:11:11 INFO - 'ts_paint', 20:11:11 INFO - 'tpaint', 20:11:11 INFO - 'sessionrestore', 20:11:11 INFO - 'sessionrestore_no_auto_restore', 20:11:11 INFO - 'tabpaint']}, 20:11:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:11:11 INFO - 'ts_paint', 20:11:11 INFO - 'tpaint', 20:11:11 INFO - 'sessionrestore', 20:11:11 INFO - 'sessionrestore_no_auto_restore', 20:11:11 INFO - 'tabpaint']}, 20:11:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['a11yr', 20:11:11 INFO - 'ts_paint', 20:11:11 INFO - 'tpaint', 20:11:11 INFO - 'sessionrestore', 20:11:11 INFO - 'sessionrestore_no_auto_restore', 20:11:11 INFO - 'tabpaint']}, 20:11:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['a11yr', 20:11:11 INFO - 'ts_paint', 20:11:11 INFO - 'tpaint', 20:11:11 INFO - 'sessionrestore', 20:11:11 INFO - 'sessionrestore_no_auto_restore', 20:11:11 INFO - 'tabpaint']}, 20:11:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['tsvgx', 20:11:11 INFO - 'tsvgr_opacity', 20:11:11 INFO - 'tart', 20:11:11 INFO - 'tscrollx', 20:11:11 INFO - 'cart']}, 20:11:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:11:11 INFO - 'tsvgr_opacity', 20:11:11 INFO - 'tart', 20:11:11 INFO - 'tscrollx', 20:11:11 INFO - 'cart']}, 20:11:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'talos_options': ['--disable-e10s'], 20:11:11 INFO - 'tests': ['tp5o']}, 20:11:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'tests': ['tp5o']}, 20:11:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'talos_options': ['--disable-e10s', 20:11:11 INFO - '--xperf_path', 20:11:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:11 INFO - 'tests': ['tp5n']}, 20:11:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:11 INFO - 'talos_options': ['--xperf_path', 20:11:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:11 INFO - 'tests': ['tp5n']}}, 20:11:11 INFO - 'talos.zip': {'path': '', 20:11:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:11 INFO - Running post-action listener: _resource_record_post_action 20:11:11 INFO - ##### 20:11:11 INFO - ##### Finished populate-webroot step (success) 20:11:11 INFO - ##### 20:11:11 INFO - ##### 20:11:11 INFO - ##### Running create-virtualenv step. 20:11:11 INFO - ##### 20:11:11 INFO - Running pre-action listener: _resource_record_pre_action 20:11:11 INFO - Running main action method: create_virtualenv 20:11:11 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:11 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 20:11:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:12 INFO - Using real prefix '/usr' 20:11:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:14 INFO - Installing pip.................done. 20:11:14 INFO - Return code: 0 20:11:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11:14 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')]} 20:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:14 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')]} 20:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:14 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 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:14 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 20:11:14 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 20:11:14 INFO - Using env: {'DISPLAY': ':0', 20:11:14 INFO - 'HOME': '/home/cltbld', 20:11:14 INFO - 'LANG': 'en_US.UTF-8', 20:11:14 INFO - 'LANGUAGE': 'en_US:en', 20:11:14 INFO - 'LOGNAME': 'cltbld', 20:11:14 INFO - 'MAIL': '/var/mail/cltbld', 20:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:14 INFO - 'MOZ_NO_REMOTE': '1', 20:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:14 INFO - 'NO_EM_RESTART': '1', 20:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:14 INFO - 'PWD': '/builds/slave/test', 20:11:14 INFO - 'SHELL': '/bin/bash', 20:11:14 INFO - 'SHLVL': '1', 20:11:14 INFO - 'TERM': 'linux', 20:11:14 INFO - 'TMOUT': '86400', 20:11:14 INFO - 'USER': 'cltbld', 20:11:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:14 INFO - '_': '/tools/buildbot/bin/python'} 20:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:14 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 20:11:14 INFO - Cleaning up... 20:11:14 INFO - Return code: 0 20:11:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:11:14 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')]} 20:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:14 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')]} 20:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:14 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 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:14 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 20:11:14 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 20:11:14 INFO - Using env: {'DISPLAY': ':0', 20:11:14 INFO - 'HOME': '/home/cltbld', 20:11:14 INFO - 'LANG': 'en_US.UTF-8', 20:11:14 INFO - 'LANGUAGE': 'en_US:en', 20:11:14 INFO - 'LOGNAME': 'cltbld', 20:11:14 INFO - 'MAIL': '/var/mail/cltbld', 20:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:14 INFO - 'MOZ_NO_REMOTE': '1', 20:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:14 INFO - 'NO_EM_RESTART': '1', 20:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:14 INFO - 'PWD': '/builds/slave/test', 20:11:14 INFO - 'SHELL': '/bin/bash', 20:11:14 INFO - 'SHLVL': '1', 20:11:14 INFO - 'TERM': 'linux', 20:11:14 INFO - 'TMOUT': '86400', 20:11:14 INFO - 'USER': 'cltbld', 20:11:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:14 INFO - '_': '/tools/buildbot/bin/python'} 20:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:15 INFO - Downloading/unpacking psutil>=3.1.1 20:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:17 INFO - Installing collected packages: psutil 20:11:17 INFO - Running setup.py install for psutil 20:11:17 INFO - building 'psutil._psutil_linux' extension 20:11:17 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 20:11:17 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 20:11:17 INFO - building 'psutil._psutil_posix' extension 20:11:17 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 20:11:17 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 20:11:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:17 INFO - Successfully installed psutil 20:11:17 INFO - Cleaning up... 20:11:17 INFO - Return code: 0 20:11:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:11:17 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')]} 20:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:17 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')]} 20:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:11:17 INFO - Using env: {'DISPLAY': ':0', 20:11:17 INFO - 'HOME': '/home/cltbld', 20:11:17 INFO - 'LANG': 'en_US.UTF-8', 20:11:17 INFO - 'LANGUAGE': 'en_US:en', 20:11:17 INFO - 'LOGNAME': 'cltbld', 20:11:17 INFO - 'MAIL': '/var/mail/cltbld', 20:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:17 INFO - 'MOZ_NO_REMOTE': '1', 20:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:17 INFO - 'NO_EM_RESTART': '1', 20:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:17 INFO - 'PWD': '/builds/slave/test', 20:11:17 INFO - 'SHELL': '/bin/bash', 20:11:17 INFO - 'SHLVL': '1', 20:11:17 INFO - 'TERM': 'linux', 20:11:17 INFO - 'TMOUT': '86400', 20:11:17 INFO - 'USER': 'cltbld', 20:11:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:17 INFO - '_': '/tools/buildbot/bin/python'} 20:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:11:17 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 20:11:17 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 20:11:17 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 20:11:17 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 20:11:17 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 20:11:17 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 20:11:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:11:19 INFO - Installing collected packages: mozsystemmonitor 20:11:19 INFO - Running setup.py install for mozsystemmonitor 20:11:19 INFO - Successfully installed mozsystemmonitor 20:11:19 INFO - Cleaning up... 20:11:19 INFO - Return code: 0 20:11:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:19 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 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:19 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 20:11:19 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 20:11:19 INFO - Using env: {'DISPLAY': ':0', 20:11:19 INFO - 'HOME': '/home/cltbld', 20:11:19 INFO - 'LANG': 'en_US.UTF-8', 20:11:19 INFO - 'LANGUAGE': 'en_US:en', 20:11:19 INFO - 'LOGNAME': 'cltbld', 20:11:19 INFO - 'MAIL': '/var/mail/cltbld', 20:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:19 INFO - 'MOZ_NO_REMOTE': '1', 20:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:19 INFO - 'NO_EM_RESTART': '1', 20:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:19 INFO - 'PWD': '/builds/slave/test', 20:11:19 INFO - 'SHELL': '/bin/bash', 20:11:19 INFO - 'SHLVL': '1', 20:11:19 INFO - 'TERM': 'linux', 20:11:19 INFO - 'TMOUT': '86400', 20:11:19 INFO - 'USER': 'cltbld', 20:11:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:19 INFO - '_': '/tools/buildbot/bin/python'} 20:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:20 INFO - Downloading/unpacking blobuploader==1.2.4 20:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:21 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 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 20:11:22 INFO - Downloading docopt-0.6.1.tar.gz 20:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:22 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:22 INFO - Running setup.py install for blobuploader 20:11:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:22 INFO - Running setup.py install for requests 20:11:23 INFO - Running setup.py install for docopt 20:11:23 INFO - Successfully installed blobuploader requests docopt 20:11:23 INFO - Cleaning up... 20:11:23 INFO - Return code: 0 20:11:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:23 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 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:23 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 20:11:23 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 20:11:23 INFO - Using env: {'DISPLAY': ':0', 20:11:23 INFO - 'HOME': '/home/cltbld', 20:11:23 INFO - 'LANG': 'en_US.UTF-8', 20:11:23 INFO - 'LANGUAGE': 'en_US:en', 20:11:23 INFO - 'LOGNAME': 'cltbld', 20:11:23 INFO - 'MAIL': '/var/mail/cltbld', 20:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:23 INFO - 'MOZ_NO_REMOTE': '1', 20:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:23 INFO - 'NO_EM_RESTART': '1', 20:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:23 INFO - 'PWD': '/builds/slave/test', 20:11:23 INFO - 'SHELL': '/bin/bash', 20:11:23 INFO - 'SHLVL': '1', 20:11:23 INFO - 'TERM': 'linux', 20:11:23 INFO - 'TMOUT': '86400', 20:11:23 INFO - 'USER': 'cltbld', 20:11:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:23 INFO - '_': '/tools/buildbot/bin/python'} 20:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:23 INFO - Running setup.py (path:/tmp/pip-xgBgVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:23 INFO - Running setup.py (path:/tmp/pip-uV25re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:23 INFO - Running setup.py (path:/tmp/pip-YBcyhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:23 INFO - Running setup.py (path:/tmp/pip-fgn8Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:23 INFO - Running setup.py (path:/tmp/pip-WrLmZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:23 INFO - Running setup.py (path:/tmp/pip-DsBIv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:23 INFO - Running setup.py (path:/tmp/pip-eG5HSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:24 INFO - Running setup.py (path:/tmp/pip-w9PjI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:24 INFO - Running setup.py (path:/tmp/pip-uUTxCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:24 INFO - Running setup.py (path:/tmp/pip-N5XxaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:24 INFO - Running setup.py (path:/tmp/pip-DuLzQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:24 INFO - Running setup.py (path:/tmp/pip-fg7BVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:24 INFO - Running setup.py (path:/tmp/pip-2pQibc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:24 INFO - Running setup.py (path:/tmp/pip-8mUiHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:24 INFO - Running setup.py (path:/tmp/pip-YAr7_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:24 INFO - Running setup.py (path:/tmp/pip-bqfwtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:24 INFO - Running setup.py (path:/tmp/pip-mdRKjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:24 INFO - Running setup.py install for manifestparser 20:11:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Running setup.py install for mozcrash 20:11:24 INFO - Running setup.py install for mozdebug 20:11:25 INFO - Running setup.py install for mozdevice 20:11:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Running setup.py install for mozfile 20:11:25 INFO - Running setup.py install for mozhttpd 20:11:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Running setup.py install for mozinfo 20:11:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Running setup.py install for mozInstall 20:11:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Running setup.py install for mozleak 20:11:25 INFO - Running setup.py install for mozlog 20:11:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Running setup.py install for moznetwork 20:11:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Running setup.py install for mozprocess 20:11:25 INFO - Running setup.py install for mozprofile 20:11:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:26 INFO - Running setup.py install for mozrunner 20:11:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:26 INFO - Running setup.py install for mozscreenshot 20:11:26 INFO - Running setup.py install for moztest 20:11:26 INFO - Running setup.py install for mozversion 20:11:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:26 INFO - Cleaning up... 20:11:26 INFO - Return code: 0 20:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:26 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 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:26 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 20:11:26 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 20:11:26 INFO - Using env: {'DISPLAY': ':0', 20:11:26 INFO - 'HOME': '/home/cltbld', 20:11:26 INFO - 'LANG': 'en_US.UTF-8', 20:11:26 INFO - 'LANGUAGE': 'en_US:en', 20:11:26 INFO - 'LOGNAME': 'cltbld', 20:11:26 INFO - 'MAIL': '/var/mail/cltbld', 20:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:26 INFO - 'MOZ_NO_REMOTE': '1', 20:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:26 INFO - 'NO_EM_RESTART': '1', 20:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:26 INFO - 'PWD': '/builds/slave/test', 20:11:26 INFO - 'SHELL': '/bin/bash', 20:11:26 INFO - 'SHLVL': '1', 20:11:26 INFO - 'TERM': 'linux', 20:11:26 INFO - 'TMOUT': '86400', 20:11:26 INFO - 'USER': 'cltbld', 20:11:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:26 INFO - '_': '/tools/buildbot/bin/python'} 20:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:26 INFO - Running setup.py (path:/tmp/pip-BEkQSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:26 INFO - Running setup.py (path:/tmp/pip-NXM73W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:26 INFO - Running setup.py (path:/tmp/pip-LkuCip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:26 INFO - Running setup.py (path:/tmp/pip-z22Qta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:27 INFO - Running setup.py (path:/tmp/pip-eceV26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:27 INFO - Running setup.py (path:/tmp/pip-x3CiyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:27 INFO - Running setup.py (path:/tmp/pip-ENaaoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:27 INFO - Running setup.py (path:/tmp/pip-g3c0nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:27 INFO - Running setup.py (path:/tmp/pip-H229Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:27 INFO - Running setup.py (path:/tmp/pip-iZS1td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:27 INFO - Running setup.py (path:/tmp/pip-AtrkF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:27 INFO - Running setup.py (path:/tmp/pip-7U9kLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:27 INFO - Running setup.py (path:/tmp/pip-r64Xvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:27 INFO - Running setup.py (path:/tmp/pip-rvv5MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:27 INFO - Running setup.py (path:/tmp/pip-APAfFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:27 INFO - Running setup.py (path:/tmp/pip-n6dxOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:27 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)) 20:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:27 INFO - Running setup.py (path:/tmp/pip-iluJn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:27 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)) 20:11:27 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)) 20:11:27 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)) 20:11:27 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)) 20:11:27 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)) 20:11:27 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)) 20:11:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:27 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 20:11:27 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 20:11:27 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 20:11:27 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 20:11:27 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 20:11:27 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 20:11:29 INFO - Downloading blessings-1.6.tar.gz 20:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:29 INFO - Installing collected packages: blessings 20:11:29 INFO - Running setup.py install for blessings 20:11:30 INFO - Successfully installed blessings 20:11:30 INFO - Cleaning up... 20:11:30 INFO - Return code: 0 20:11:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:30 INFO - Reading from file tmpfile_stdout 20:11:30 INFO - Current package versions: 20:11:30 INFO - argparse == 1.2.1 20:11:30 INFO - blessings == 1.6 20:11:30 INFO - blobuploader == 1.2.4 20:11:30 INFO - docopt == 0.6.1 20:11:30 INFO - manifestparser == 1.1 20:11:30 INFO - mozInstall == 1.12 20:11:30 INFO - mozcrash == 0.17 20:11:30 INFO - mozdebug == 0.1 20:11:30 INFO - mozdevice == 0.48 20:11:30 INFO - mozfile == 1.2 20:11:30 INFO - mozhttpd == 0.7 20:11:30 INFO - mozinfo == 0.9 20:11:30 INFO - mozleak == 0.1 20:11:30 INFO - mozlog == 3.2 20:11:30 INFO - moznetwork == 0.27 20:11:30 INFO - mozprocess == 0.22 20:11:30 INFO - mozprofile == 0.28 20:11:30 INFO - mozrunner == 6.11 20:11:30 INFO - mozscreenshot == 0.1 20:11:30 INFO - mozsystemmonitor == 0.3 20:11:30 INFO - moztest == 0.7 20:11:30 INFO - mozversion == 1.4 20:11:30 INFO - psutil == 3.1.1 20:11:30 INFO - requests == 1.2.3 20:11:30 INFO - wsgiref == 0.1.2 20:11:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:30 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 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:30 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 20:11:30 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 20:11:30 INFO - Using env: {'DISPLAY': ':0', 20:11:30 INFO - 'HOME': '/home/cltbld', 20:11:30 INFO - 'LANG': 'en_US.UTF-8', 20:11:30 INFO - 'LANGUAGE': 'en_US:en', 20:11:30 INFO - 'LOGNAME': 'cltbld', 20:11:30 INFO - 'MAIL': '/var/mail/cltbld', 20:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:30 INFO - 'MOZ_NO_REMOTE': '1', 20:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:30 INFO - 'NO_EM_RESTART': '1', 20:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:30 INFO - 'PWD': '/builds/slave/test', 20:11:30 INFO - 'SHELL': '/bin/bash', 20:11:30 INFO - 'SHLVL': '1', 20:11:30 INFO - 'TERM': 'linux', 20:11:30 INFO - 'TMOUT': '86400', 20:11:30 INFO - 'USER': 'cltbld', 20:11:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:30 INFO - '_': '/tools/buildbot/bin/python'} 20:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 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)) 20:11:30 INFO - Cleaning up... 20:11:30 INFO - Return code: 0 20:11:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11: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', 'jsonschema'] in /builds/slave/test/build 20:11: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 jsonschema 20:11:30 INFO - Using env: {'DISPLAY': ':0', 20:11:30 INFO - 'HOME': '/home/cltbld', 20:11:30 INFO - 'LANG': 'en_US.UTF-8', 20:11:30 INFO - 'LANGUAGE': 'en_US:en', 20:11:30 INFO - 'LOGNAME': 'cltbld', 20:11:30 INFO - 'MAIL': '/var/mail/cltbld', 20:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:30 INFO - 'MOZ_NO_REMOTE': '1', 20:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:30 INFO - 'NO_EM_RESTART': '1', 20:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:30 INFO - 'PWD': '/builds/slave/test', 20:11:30 INFO - 'SHELL': '/bin/bash', 20:11:30 INFO - 'SHLVL': '1', 20:11:30 INFO - 'TERM': 'linux', 20:11:30 INFO - 'TMOUT': '86400', 20:11:30 INFO - 'USER': 'cltbld', 20:11:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:30 INFO - '_': '/tools/buildbot/bin/python'} 20:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:31 INFO - Downloading/unpacking jsonschema 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 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 20:11:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:11:32 INFO - Downloading/unpacking functools32 (from jsonschema) 20:11:32 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 20:11:32 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 20:11:32 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 20:11:32 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 20:11:32 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 20:11:32 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 20:11:33 INFO - Downloading functools32-3.2.3-2.tar.gz 20:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:11:33 INFO - warning: no files found matching '*.txt' 20:11:33 INFO - no previously-included directories found matching 'build' 20:11:33 INFO - no previously-included directories found matching 'dist' 20:11:33 INFO - no previously-included directories found matching '.git*' 20:11:33 INFO - Installing collected packages: jsonschema, functools32 20:11:33 INFO - Running setup.py install for functools32 20:11:33 INFO - warning: no files found matching '*.txt' 20:11:33 INFO - no previously-included directories found matching 'build' 20:11:33 INFO - no previously-included directories found matching 'dist' 20:11:33 INFO - no previously-included directories found matching '.git*' 20:11:33 INFO - Successfully installed jsonschema functools32 20:11:33 INFO - Cleaning up... 20:11:33 INFO - Return code: 0 20:11:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4fd7cf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', '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 20:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:11:33 INFO - Using env: {'DISPLAY': ':0', 20:11:33 INFO - 'HOME': '/home/cltbld', 20:11:33 INFO - 'LANG': 'en_US.UTF-8', 20:11:33 INFO - 'LANGUAGE': 'en_US:en', 20:11:33 INFO - 'LOGNAME': 'cltbld', 20:11:33 INFO - 'MAIL': '/var/mail/cltbld', 20:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:33 INFO - 'MOZ_NO_REMOTE': '1', 20:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:33 INFO - 'NO_EM_RESTART': '1', 20:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:33 INFO - 'PWD': '/builds/slave/test', 20:11:33 INFO - 'SHELL': '/bin/bash', 20:11:33 INFO - 'SHLVL': '1', 20:11:33 INFO - 'TERM': 'linux', 20:11:33 INFO - 'TMOUT': '86400', 20:11:33 INFO - 'USER': 'cltbld', 20:11:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:33 INFO - '_': '/tools/buildbot/bin/python'} 20:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:33 INFO - Downloading/unpacking flake8 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:11:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:11:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:11:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:11:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:11:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:11:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:11:36 INFO - no previously-included directories found matching 'docs/_build' 20:11:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:11:36 INFO - Running setup.py install for pep8 20:11:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:11:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:11:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:11:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:11:36 INFO - no previously-included directories found matching 'docs/_build' 20:11:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:11:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:11:36 INFO - Cleaning up... 20:11:36 INFO - Return code: 0 20:11:36 INFO - Running post-action listener: _resource_record_post_action 20:11:36 INFO - Running post-action listener: _start_resource_monitoring 20:11:36 INFO - Starting resource monitoring. 20:11:36 INFO - ##### 20:11:36 INFO - ##### Finished create-virtualenv step (success) 20:11:36 INFO - ##### 20:11:36 INFO - ##### 20:11:36 INFO - ##### Running install step. 20:11:36 INFO - ##### 20:11:36 INFO - Running pre-action listener: _resource_record_pre_action 20:11:36 INFO - Running main action method: install 20:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:36 INFO - Reading from file tmpfile_stdout 20:11:36 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:36 INFO - Reading from file tmpfile_stdout 20:11:36 INFO - Output received: 20:11:36 INFO - Usage: mozinstall [options] installer 20:11:36 INFO - Options: 20:11:36 INFO - -h, --help show this help message and exit 20:11:36 INFO - -d DEST, --destination=DEST 20:11:36 INFO - Directory to install application into. [default: 20:11:36 INFO - "/builds/slave/test"] 20:11:36 INFO - --app=APP Application being installed. [default: firefox] 20:11:36 INFO - mkdir: /builds/slave/test/build/application 20:11:36 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'] 20:11:36 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 20:11:54 INFO - Reading from file tmpfile_stdout 20:11:54 INFO - Output received: 20:11:54 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:54 INFO - Running post-action listener: _resource_record_post_action 20:11:54 INFO - ##### 20:11:54 INFO - ##### Finished install step (success) 20:11:54 INFO - ##### 20:11:54 INFO - ##### 20:11:54 INFO - ##### Running run-tests step. 20:11:54 INFO - ##### 20:11:54 INFO - Running pre-action listener: _resource_record_pre_action 20:11:54 INFO - Running main action method: run_tests 20:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:54 INFO - Python 2.7.3 20:11:54 INFO - Return code: 0 20:11:54 INFO - grabbing minidump binary from tooltool 20:11:54 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')]} 20:11:54 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 0x16709c0>, '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 0x16718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1671d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:54 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 20:11:54 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 20:11:54 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 20:11:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:54 INFO - Return code: 0 20:11:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:11:55 INFO - Return code: 0 20:11:55 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:11:55 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:11:55 INFO - Using env: {'DISPLAY': ':0', 20:11:55 INFO - 'HOME': '/home/cltbld', 20:11:55 INFO - 'LANG': 'en_US.UTF-8', 20:11:55 INFO - 'LANGUAGE': 'en_US:en', 20:11:55 INFO - 'LOGNAME': 'cltbld', 20:11:55 INFO - 'MAIL': '/var/mail/cltbld', 20:11:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:55 INFO - 'MOZ_NO_REMOTE': '1', 20:11:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:55 INFO - 'NO_EM_RESTART': '1', 20:11:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:55 INFO - 'PWD': '/builds/slave/test', 20:11:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:55 INFO - 'SHELL': '/bin/bash', 20:11:55 INFO - 'SHLVL': '1', 20:11:55 INFO - 'TERM': 'linux', 20:11:55 INFO - 'TMOUT': '86400', 20:11:55 INFO - 'USER': 'cltbld', 20:11:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463797467.265097-801786032', 20:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:55 INFO - '_': '/tools/buildbot/bin/python'} 20:11:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:11:55 INFO - mozversion application_buildid: 20160520173011 20:11:55 INFO - mozversion application_changeset: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 20:11:55 INFO - mozversion application_display_name: Nightly 20:11:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:55 INFO - mozversion application_name: Firefox 20:11:55 INFO - mozversion application_remotingname: firefox 20:11:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:11:55 INFO - mozversion application_vendor: Mozilla 20:11:55 INFO - mozversion application_version: 49.0a1 20:11:55 INFO - mozversion platform_buildid: 20160520173011 20:11:55 INFO - mozversion platform_changeset: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 20:11:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:11:55 INFO - mozversion platform_version: 49.0a1 20:11:55 INFO - using testdate: 1463800315 20:11:55 INFO - actual date: 1463800315 20:11:55 INFO - starting webserver on 'localhost:59308' 20:11:55 INFO - SUITE-START | Running 2 tests 20:11:55 INFO - TEST-START | dromaeo_css 20:11:55 INFO - operating with platform_type : linux_ 20:11:55 INFO - Initialising browser for dromaeo_css test... 20:11:55 INFO - TEST-INFO | started process 21306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprJsXlo/profile http://localhost:59308/getInfo.html) 20:12:00 INFO - PROCESS | 21306 | 20:12:00 INFO - PROCESS | 21306 | (process:21374): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:12:01 INFO - PROCESS | 21306 | __metrics Screen width/height:1600/1200 20:12:01 INFO - PROCESS | 21306 | colorDepth:24 20:12:01 INFO - PROCESS | 21306 | Browser inner width/height: 1024/697 20:12:01 INFO - PROCESS | 21306 | __metrics 20:12:02 ERROR - PROCESS | 21306 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:12:02 INFO - TEST-INFO | 21306: exit 0 20:12:02 INFO - Browser initialized. 20:12:02 INFO - Running cycle 1/1 for dromaeo_css test... 20:12:02 INFO - TEST-INFO | started process 21425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprJsXlo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:04 INFO - PROCESS | 21425 | 20:12:04 INFO - PROCESS | 21425 | (process:21486): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:12:14 INFO - PROCESS | 21425 | RSS: Main: 164728832 20:12:14 INFO - PROCESS | 21425 | 20:13:04 INFO - PROCESS | 21425 | 1463800384336 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] 20:15:11 INFO - PROCESS | 21425 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59308/tests/dromaeo/cssquery-ext.html) 20:15:12 INFO - PROCESS | 21425 | RSS: Main: 168427520 20:15:12 INFO - PROCESS | 21425 | 20:18:14 INFO - PROCESS | 21425 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-ext.html (next: http://localhost:59308/tests/dromaeo/cssquery-jquery.html) 20:18:15 INFO - PROCESS | 21425 | RSS: Main: 167100416 20:18:15 INFO - PROCESS | 21425 | 20:21:17 INFO - PROCESS | 21425 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59308/tests/dromaeo/cssquery-mootools.html) 20:21:18 INFO - PROCESS | 21425 | RSS: Main: 168169472 20:21:18 INFO - PROCESS | 21425 | 20:24:19 INFO - PROCESS | 21425 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59308/tests/dromaeo/cssquery-prototype.html) 20:24:20 INFO - PROCESS | 21425 | RSS: Main: 166019072 20:24:20 INFO - PROCESS | 21425 | 20:27:22 INFO - PROCESS | 21425 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59308/tests/dromaeo/cssquery-yui.html) 20:27:23 INFO - PROCESS | 21425 | RSS: Main: 166617088 20:27:23 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-yui.html (next: http://localhost:59308/tests/dromaeo/cssquery-dojo.html) 20:30:26 INFO - PROCESS | 21425 | RSS: Main: 169029632 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | __start_tp_report 20:30:26 INFO - PROCESS | 21425 | _x_x_mozilla_page_load 20:30:26 INFO - PROCESS | 21425 | _x_x_mozilla_page_load_details 20:30:26 INFO - PROCESS | 21425 | |i|pagename|runs| 20:30:26 INFO - PROCESS | 21425 | |0;dojo.html;3159.889403870864;3186.6176058872925;3194.4729119695253;3200.919977000574;3232.4666430039047;5442.15646574781;5475.8357249282535;5486;5586.273784408031;5638.323401191852;5447.428020057896;5516.724163791814;5531.889362212753;5568.331800183973;5650.886982260363;4895.241237608177;4987.451380348159;5014.724190169539;5144.0740666679985;5174.042802081608;587.3914491379971;5012.072766538202;5065.848024559269;5092.490750924915;5117.923231151536;5007.824726134604;5045.899082018357;5052.065367906931;5059.316992206061;5100.387953445592;4896.779644915988;5067.822626208065;5086.720230387327;5095.770690318907;5102.285680004802;4916.287138364917;4984.900301993976;4997.400311962551;5005.9499405005845;5033.295338652591;5392.946070539323;5395.406505284415;5426.9185962210595;5428.6742795432;5452.700101494416;5763.971180144114;5833.591648584601;5846.9707651461895;5874.530037596982;5879.412058794129;5988.670623115727;6002.939970600281;6012.699365031731;6016.217891674054;6052.848678783022;5567.526760225385;5590.832275031756;5594.021046316879;5599.4120617335;5601.383847776741;5826.300843898759;6026.065959776154;6064.332923378425;6079.969600151971;6117.418845209698;5834.854128646818;5836.066229403275;5848.444397782204;5851.970740146272;5858.443447872445;5847.912281315784;5854.795082172103;5894.440028197314;5896.292444906639;5929.9110513341475;5678.829635110953;5799;5830.2420685310635;5862.208601838783;5863.5309175265875;5742.253507044057;5847;5861.531077513789;5879.911801322984;5887.558433117533;4474.821007159677;4514.864554063383;4517.728936263835;4524.185646583581;4541.000979784442;3840.0975770693863;3948.6446219840354;3960.128771670228;4004.139110091286;4006.198760247962;5699.059655156935;5712.428757124254;5715.085586306171;5718.170865224519;5732.0255556555485;5838.620489668243;5881.764729410861;6003.219581454383;6004.159417681528;6013.939860601426;5610.298712660918;5654.4062873398525;5688.943110568925;5689.487946084872;5731.770729170787;5074.162763144113;5124.308218390544;5127;5147.871303217449;5161.225816127611;5975.970120149458;6195.31851496335;6221.440070393686;6224.502039836802;6245.531585131133;5924.940750592526;5984.222051133412;6020.578559500793;6037.607555508878;6046.09308603713;6177.2587289525545;6241.626842094732;6244.2819075806865;6247.219097612799;6250.031245157008;5730.598858079894;5844.532437405082;5899.557533185114;5902.409759024235;5945.256842894638;5964.463198312173;6006.669633170218;6027.30685971119;6028.15605815195;6081.179040829431;5781.103928891029;5803.564732644984;5852.502537284208;5876.236089308533;5877.23595932526;5646.265985422033;5745.3105627324985;5762.5389968801555;5821.330546987151;5836.970815145897;5426.647267927572;5472.589555783253;5486.862828429321;5544.667319960815;5548.056830338772;5669.858253543694;5686.573506987075;5687.232223649754;5713.942860571341;5719.027765279996;5585.720713964367;5603.243562119224;5610.859728506657;5647.802326918538;5671.602987790815 20:30:26 INFO - PROCESS | 21425 | |1;ext.html;565.4769338362016;633.4520639646705;637.1271358239215;654.9050387693787;656.4059526128854;39357.80321098394;42595.36106958398;42693.35959960599;42811;42963.57036429635;44123.558764412344;44554.55445445552;44708.55291447085;44762;44891;8737.737867863974;8848.5575721214;8912.420692654956;8912.777180570472;8916.063813299608;8684.60919258635;8738.825223495527;8760.649574017032;8769.824603507926;8804.163604457599;8803.29573634111;8806.163414475615;8848.380613357067;8873.866891996593;8875.334349923782;8684.522351270678;8726.258268047224;8729.607167677437;8756.430831995931;8794.560271986375;8803.559822008874;8898.555072246427;8899.110088991114;8902.465852048834;8907.955460222722;40674.38988415147;40836.591634083576;41004.38493422601;41298.38052429216;41304.38043429351;3478.165240342325;3562.1628917204434;3650.945235821465;4095.4266402703647;4294.634956028742;31057.378852422826;33313.83343083269;33423.6657633423;33474;33584.16039599029;3997.6801855851754;4008.4187792769885;4138.52406973196;4191.1827193697245;4235.25882970479;223232;223382.88308558517;223858;224686;225326.99999999837;64319;64451.67774161099;64565.67717161384;64825.35174648288;65050;59717;59963.700181499684;60158.69920650369;60311.396886031456;60420;17242.655146897243;17300.134993250285;17382;17445.47663570095;17519.47441576755;13087.280199588924;13131.409086591126;13191.40638671262;13270.535531256359;13273.734525309439;18435.790279220102;19797.109130089182;19826.306079287155;19908.203671853254;19959.301424450365;3233;7001.229864714877;7047.788566342915;7177.928220717726;7267.127944646676;971.1987610221454;1085.7882712871071;1119.9832002519968;1141.7316930521322;1179.3159967218992;32622.510662340082;32796.83601581977;32917.50623740646;33333;33392.83303583515;1147.5696613769837;1160.1936654025371;1163.6799880033059;1226.9509569318104;1251.474380760083;16776.496705098867;17425.65148697019;17436.912815436095;17440.5639859002;17486.387976420763;538573;541795;544724;545172;549971;61435.07847382293;62240.688796556635;62316;62350;62400.375996239454;1365.6244532753572;1423.110555902561;1427.5289154578963;1432.8782053525567;1441.0489077209202;31375.529367059054;31916.52125218077;32350.514742279356;32545.674543254263;33044.66955330416;53923.46076539184;54151.18773218326;54653;54767;54898.17652735292;502526;504430;506038;506481;506903;28209.858950705115;28592.999245026323;28946.421071578872;29059.7094029057;29082.709172908;49590.50409495859;49617.751911240215;50272.245916312015;50651.746741266055;50733.23900141427;40180;41305.793471032455;43120.56879431166;44577.331340029275;45302;42500.78749606232;42898.78550607227;43207.78396108125;43239;43621;42728.35907461328;42752.358714618684;43123;43281.783591083105;43504.34743478914;35746.64253357433;37704;37722.81138594399;38527;38899.41650875183;28775.992840250492;28844.134675959755;29207;29214;29258.853705731333 20:30:26 INFO - PROCESS | 21425 | |2;jquery.html;386.6887155839549;388.2080555666441;390.99218015639707;401.6545770637251;417.54279064424446;13931.233782141979;15557.222138893067;17989.37037203698;19309.13108910099;19712.112954917025;13904.930475347634;16128.112953787537;16213.675726485464;17445.389411370605;19470.90264548679;5589.469000444961;5721.485066344028;5774.740136693859;5781.855453613673;5783.306003279591;5646.774129034834;5671;5715.9428405716035;5746.856328591798;5763.250777398953;5531.502164805167;5804.780995990847;5814.302283725938;5893.764249430039;5918.733656985424;5796.942030579704;5834.329052158992;5849.683821140231;5893.616914900518;6462.838429039265;5561.833145005616;5589.496945274904;5653.293338332708;5673.23411339468;5695.231143795576;13155.408006639724;13400.396982135828;13496.93251533746;13711.040227184101;13785.448582056706;2214.324630987548;2329.138218859033;2375.085592047057;2410.0600765701392;2419.2258477287273;9699;10190.796184076351;10265.230107741949;10450.111740502067;10633.840492392621;1927.1821043120717;1942.9319973800991;1961.6174845905055;1976.416956997689;1996.2015193922402;78479.6076019622;82647.9999999994;83429;83514.16485835185;85354.57322713408;10632.68101956927;10838.620648277272;10969.122470202365;11022.724431889266;11039.227254092137;15159;15187.544373668587;15302.158381288913;15323.616909577127;15327.46353877609;7947.602619868983;8239.258466738022;8242.835143297101;8335.791605209919;8360.205780450848;7850.371970242367;7993.720219792395;8033.758987230392;8050.417564183999;8145.185481451926;4616.215243408628;4661.883452913637;4674.205385084476;4706.623470122382;4712.104700106968;1897.2600685732575;1906.447130332216;1942.9514262143277;1967.7146813712218;1975.940721778349;931.5435436636135;1013.6806905824642;1023.5240613114788;1057.746140926172;1089.803835309652;19038.714419283722;19350.516237093903;19501;19741.901290493457;19878;1001.8547310639916;1023.8924912884189;1042.2131290875493;1106.8284415915546;1116.3636727065657;10476.266661333633;10917.945410272898;10922.563097476012;10935.83596246057;11039.282446640942;459178;460680;465255;466161;484195;75286.24713752902;85029.57485212534;94315.52842235746;94500.52749736207;99918.50040749896;978.1148061004802;1007.5818535307765;1009.3641006166068;1015.3451024089421;1018.0379541333517;17436.302547897943;17653.940763554227;17901.10494475245;18112.909435452737;18285.634287313915;39895.60104399035;40954;40976.1804763909;41359.793201033805;43445.56554434415;55732;55832;56965.43034569601;57541.71229143828;57807;8561.657533698832;8578.65685372603;8592.742217733477;8634.827303454022;8744.69393571222;9284.90679734465;12783.93608031954;13482.19106853592;13583.592492225249;13909.58271251864;12070.637880863587;12203.572874949334;12208.633740987785;12305.876941230474;12449.439775209956;9108.679241510077;11101.611443599759;11548.82676759866;11725.296482210753;12119.57581484679;12330.321832299309;12482.812757808459;12501.687457813627;12594.685132871751;12710.682232944251;7618.123915749759;8866.42368246062;8941.687040953535;9085.77285567866;9164.221041211571;11742.765144697229;11831.171817973003;11833.585824496102;11834.644960651194;11983.580574679845 20:30:26 INFO - PROCESS | 21425 | |3;mootools.html;1519.749241375173;1550.8061492313461;1693.6104695919937;1789.8657600679944;1798.5233913013062;7410.70357185712;8052.516848989065;8217.301529369995;8576.957115214424;8587.14128587141;8319.83360332793;8463.873041904377;8489.320854331654;8585.356098292621;8619.525926074064;2289.7939185473306;2341.613633750429;2342.5197834443898;2342.7422983471806;2346.4485845826216;2261.6720575516542;2289;2297.7242730872317;2307.880677871231;2308.665243539686;2282.942926426836;2286.188403116886;2293.71328583927;2307.515421761432;2342.472943587696;2254.28989868191;2271.3980795089315;2275.544891021794;2275.931722048333;2276.408133885185;2229.331200639818;2238.3956331790328;2245.371296037096;2246.70792796937;2251.122062395667;8350.665973361058;8384.496930184208;8392.118827523143;8396.244338009608;8443.240108390213;4930.235813448921;5100.642954993152;5128.5640720538795;5177.37871455424;5185.144451165553;3133.5926329577237;3147.7324427423696;3199.904002879894;3319.3527262183884;3337.1156643489494;1164.4061528620464;1192.6600918738118;1199.6760874563906;1200.147894994555;1211.8666946635863;11627.941860290644;11646.24299420535;11650.941745291304;11674.591389301333;11695.064394848478;4451.3323001550025;4482.1707984022405;4635.072985402933;4643.396358473445;4675.181843177498;9497.762555936019;9586.137247647745;9586.328956972944;9596.712098637052;9620.75948101303;5055.494450554988;5060.089183946851;5065.062963351792;5085.567726743268;5096.261042148942;4249.447571815706;4662.580367766917;4723.952760472352;4758.595519380822;4792.376990991149;3754.8685795997008;3837.5586807517493;3847.5575308839843;3877.0307423144213;3993.1813978134414;1155;1168.64940517846;1180.221054104287;1181.0846593889805;1189.5598628507507;981.6318880419842;986.5166068626465;1005.532427421238;1006.2805094357569;1007.2294694558668;5603.635763675348;5612.045952188138;5652.689102099342;5791;5909.527237820964;1000.5497526113132;1000.6447711062614;1006.9144122749502;1019.6838979916101;1021.9437930913722;3982.482277303932;4005.218982298482;4055.858044968412;4096.959030409657;4121.423000779893;10405.167586593054;10605.151587873106;10742.086922611665;10817.945910270399;10826.079783218514;10397.272190946713;10442.68671939843;10466.63366782159;10478.633247836442;10527.578896844194;7492.7752167435065;7701.268379503938;7878.369730421553;7991.880121798177;8001.1198768135455;5778.017736984807;5909.763609455574;5966.642001479925;5991.550633702403;6031.5777895548645;9402.57688404037;9583;9925.900740992498;9947.801043979225;9960.651377201762;9799.265055120752;9964.750881228027;10042.447665378475;10068.798624027331;10127.240456965905;6848.794536163923;7371.631418429164;7460.328570428687;7519.060117485315;7593.772186834404;8334.166583341617;8344.41589088758;8419.747407577783;8440.788980275542;8441.451305665112;7338.302861228175;7569.924300757142;7599.772006839804;7606.277403646644;7655.272749088827;7299.598522081124;7364.41084713211;7366.852662946818;7429.44279179053;7571.205023472456;6278.717457714322;6325.4939604832425;6339.619622822645;6348.143000694847;6385.297617262005;4763.951500854527;4914.950850491449;4923.310736496965;4935.580475659609;4935.629827763004;4843.733594652187;4932.062908047459;4984.576311013459;5029.76770691183;5055.039542486916 20:30:26 INFO - PROCESS | 21425 | |4;prototype.html;321.5209338086252;328.74193757900053;334.32132770475926;336.57255285787045;339.34337057793186;5395.703236322006;5585.944140558593;5613.494785469307;5648.830535083944;5694.174344720013;5525.198846167304;5530.5299049580735;5550.555955523559;5563.803782186829;5586.748596313166;4375.868723938271;4384.561543845622;4391.451068616423;4403.801828917706;4436.844710435135;4268.274393353122;4335.309229400521;4393.538678438766;4401.581849724271;4452.554744525538;4302.161078589676;4331.545187755288;4334.829596009092;4347.19576878277;4366.170427618758;4342.1532801103795;4348.869533913988;4362.607365337103;4386.561343865604;4397.714148580348;3537.398642230827;3708.2027364116843;3865.16898866745;3891.299566078105;3897.9610203897882;5327.680339179662;5372.194170874361;5381.9461805382225;5393.352797664266;5399.649022813504;4853.320535125085;4874.195757699975;4881.852764600316;4882.218844984785;4882.316475693406;5630.832129630122;5854.297484301868;5866.970665146647;5870.442307980735;5890.263717035371;4060.7360521566;4070.5522392536795;4071.450354202204;4075.6331930126134;4077.2467838829293;5918.970405147989;5937.554683398763;6147.907781383283;6183;6242.781502647385;4173.7078404512;4186.958130418718;4191.7275377100395;4197.664186865043;4198.244316023145;4215.6205941464805;4240.936385954213;4241.512226093977;4250.744955302692;4278.465191851019;4671.252599584118;4903.779329930162;4922.852314430573;4928.408590969035;4931.457539670633;5860.681346697044;5866.911996320058;5943.167956486095;5957.868005079021;5991.370906054802;1457.9708405831825;1466.7506523890963;1476.7784832275029;1477.1727832413883;1487.6578386970841;904.2268860124631;933.6452148183782;937.6108914800418;946.0303189231093;951.4291425144996;5028.340647586288;5047.646664733506;5048.617426324371;5112.233165025202;5163.535281824654;5327.733613319396;5370.543503802221;5370.62405631602;5402.677857713813;5414.512693857571;5084.593232541388;5156.381234251839;5158.819441319536;5348.411674715778;5771.6537007778825;3229.7900636458553;3240.9189770255934;3270.6590297977714;3271.2966712157;3284.392387408337;6199.659018753921;6358.7456501740335;6358.777442789573;6443.7744678936015;6469.805905822833;6177.949748542758;6190.81427557174;6220.351606824195;6221.626702397871;6226.968865155736;6168.25980882297;6302.779402720883;6318.62088274705;6339.5562310637815;6404.359564043559;5797.449242321973;6031.728572214173;6063.211782468251;6100.481459076028;6104.4200800923845;5964.910526342195;5989.490893274121;5989.910151347821;6005.759769609167;6057.485113765203;5966.552508561788;6151.354107818794;6233.407826256498;6268.4671802897265;6314.242290925118;4190.51809041964;4190.790460477025;4192.098698779777;4201.285781417106;4203.243416184993;5900.285868500538;6040.516758659384;6077.60215150509;6111.54163437735;6134.570580059353;5865.501432378295;5888.823335299948;5898.498627616701;5900.380460051632;5908.143319218603;5850.356460789395;5865.794697185578;5898.292204935436;5905.498032667271;5911.231539899785;5581.358143813513;5788.32138679795;5795.768169273182;5802.4197580241635;5826.213461182686;5927.970360148344;5958.374370691015;5982.641041537521;6024.9397506026135;6062.605930614496;5489.913832743532;5761.740721667451;5783.652980821164;5834.2788877282155;5880.617759845596 20:30:26 INFO - PROCESS | 21425 | |5;yui.html;753.2730914667345;759.3773106053037;811.444160749886;812.6789917982394;820.3601191070964;13082.803757943626;13728.656783580416;13807.79288310675;14009.719805603881;14010.439582416691;12970.675733106676;13007.34963251836;13065.346732663376;13091.018173636992;13113;682.3210905149383;804.899387576553;813.5728742410238;821.876718492228;828.7638023163399;816.0574536410455;821.8890449789292;823.0206054794805;823.4565186976597;827.1810907201857;859.4671303791658;865.3726048614735;866.7269810009826;867.397158974513;867.7743786615463;856.8543347630917;857.2327766648846;862.0689655172399;864.7405778266495;868.2055918834259;628.3308276685316;629.968501574924;631.4254028833785;632.0456111271966;632.0708558419117;13262.3368831559;13283;13347.265900375573;13378.93310533441;13386.866131338757;13602.795958060637;13790.379432925542;13898.722025559433;14194;14325;11286.916144494064;11364.829527557093;11478.598249061326;11767.882321176765;12394.56619018339;3900.5904380040256;3916.5887581803786;3926.666233370167;3976.1451287973223;4091.6317531422314;61242.387576124114;61497.38502614961;62186;62903.37096629067;63167.68416157936;10985.945070274598;11038.17213708975;11145;11302.886971130183;11332.773344533229;20298.89850550738;20356.898215508827;20407.28574499915;20495.590088198453;20498.38504844857;8271.462354947029;8338.04112527055;8354.8329033419;8459.49243045407;8602.268807151337;4363.105563359503;4552.453705555355;4619.260918253063;4620.514845941195;4661.743604101739;3214.421404147276;3275.623303320101;3298.2578919742864;3320.4023275810105;3334.033130392159;586.6362855029823;601.227422761749;605.9121427393003;617.1729881958108;619.2352444730753;571.7284289962234;585.6105689716376;658.5258613798057;675.1650624453056;685.3694600967123;9162.450252984841;9258.95370523143;9344.766380840534;9443.338966272295;9461.905380946102;662.9337066293332;665.4244078871741;669.1635455680399;679.3851564334285;684.7945616315086;4148.56440073794;4172.290710579209;4200.537940826506;4372.628326592212;4392.890177745582;72944.63527682328;74854.62572687211;75011;75022.6248868763;75774.62112689401;66598.66700666562;67364.66317668479;68100.6594967022;68141.65929170322;68470;60482.39517604768;61773;62845.37154628486;63059.36940630535;63501;8396.874046889423;8459.873101903353;8540.35947303967;8541.572921354033;8777.648894044167;39648.40527392149;39819.80090099531;39970.200595987335;40248.798756006036;41437.58562414337;47770;52573.211401829765;53019;53429.465705344;53785.19322210248;11478.139139564733;11696;11758.176927615326;11779.705507362041;12080.637580872588;12718.491260349483;13406.932965335502;13527.120737152054;13826.723465530835;14251.643708906946;11814.409279536161;12207.45066471993;12579.685507862378;12959.740805184032;13037.739245215233;11175.398746973711;11226.775464490827;11347.262427942158;11387.0321022714;11687.707807304885;11360.602378916697;11798.882011179778;11878.227915185485;12148.331841748435;12173.452194651085;8936.821263574822;9243.76890577741;9606.711798646053;9606.807863842545;9738.902610973799;9507.809843802946;9774.169195618451;9781.804363912825;9819.459929703935;9855.901440985499 20:30:26 INFO - PROCESS | 21425 | __end_tp_report 20:30:26 INFO - PROCESS | 21425 | __start_cc_report 20:30:26 INFO - PROCESS | 21425 | _x_x_mozilla_cycle_collect,341 20:30:26 INFO - PROCESS | 21425 | __end_cc_report 20:30:26 INFO - PROCESS | 21425 | __startTimestamp1463801426701__endTimestamp 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | ------- Summary: start ------- 20:30:26 INFO - PROCESS | 21425 | Number of tests: 6 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | [#0] dojo.html Cycles:165 Average:5469.14 Median:5689.49 stddev:741.65 (13.0%) stddev-sans-first:721.45 20:30:26 INFO - PROCESS | 21425 | Values: 3159.9 3186.6 3194.5 3200.9 3232.5 5442.2 5475.8 5486.0 5586.3 5638.3 5447.4 5516.7 5531.9 5568.3 5650.9 4895.2 4987.5 5014.7 5144.1 5174.0 587.4 5012.1 5065.8 5092.5 5117.9 5007.8 5045.9 5052.1 5059.3 5100.4 4896.8 5067.8 5086.7 5095.8 5102.3 4916.3 4984.9 4997.4 5005.9 5033.3 5392.9 5395.4 5426.9 5428.7 5452.7 5764.0 5833.6 5847.0 5874.5 5879.4 5988.7 6002.9 6012.7 6016.2 6052.8 5567.5 5590.8 5594.0 5599.4 5601.4 5826.3 6026.1 6064.3 6080.0 6117.4 5834.9 5836.1 5848.4 5852.0 5858.4 5847.9 5854.8 5894.4 5896.3 5929.9 5678.8 5799.0 5830.2 5862.2 5863.5 5742.3 5847.0 5861.5 5879.9 5887.6 4474.8 4514.9 4517.7 4524.2 4541.0 3840.1 3948.6 3960.1 4004.1 4006.2 5699.1 5712.4 5715.1 5718.2 5732.0 5838.6 5881.8 6003.2 6004.2 6013.9 5610.3 5654.4 5688.9 5689.5 5731.8 5074.2 5124.3 5127.0 5147.9 5161.2 5976.0 6195.3 6221.4 6224.5 6245.5 5924.9 5984.2 6020.6 6037.6 6046.1 6177.3 6241.6 6244.3 6247.2 6250.0 5730.6 5844.5 5899.6 5902.4 5945.3 5964.5 6006.7 6027.3 6028.2 6081.2 5781.1 5803.6 5852.5 5876.2 5877.2 5646.3 5745.3 5762.5 5821.3 5837.0 5426.6 5472.6 5486.9 5544.7 5548.1 5669.9 5686.6 5687.2 5713.9 5719.0 5585.7 5603.2 5610.9 5647.8 5671.6 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | [#1] ext.html Cycles:180 Average:59603.01 Median:42740.36 stddev:119323.40 (279.2%) stddev-sans-first:119575.81 20:30:26 INFO - PROCESS | 21425 | Values: 565.5 633.5 637.1 654.9 656.4 39357.8 42595.4 42693.4 42811.0 42963.6 44123.6 44554.6 44708.6 44762.0 44891.0 8737.7 8848.6 8912.4 8912.8 8916.1 8684.6 8738.8 8760.6 8769.8 8804.2 8803.3 8806.2 8848.4 8873.9 8875.3 8684.5 8726.3 8729.6 8756.4 8794.6 8803.6 8898.6 8899.1 8902.5 8908.0 40674.4 40836.6 41004.4 41298.4 41304.4 3478.2 3562.2 3650.9 4095.4 4294.6 31057.4 33313.8 33423.7 33474.0 33584.2 3997.7 4008.4 4138.5 4191.2 4235.3 223232.0 223382.9 223858.0 224686.0 225327.0 64319.0 64451.7 64565.7 64825.4 65050.0 59717.0 59963.7 60158.7 60311.4 60420.0 17242.7 17300.1 17382.0 17445.5 17519.5 13087.3 13131.4 13191.4 13270.5 13273.7 18435.8 19797.1 19826.3 19908.2 19959.3 3233.0 7001.2 7047.8 7177.9 7267.1 971.2 1085.8 1120.0 1141.7 1179.3 32622.5 32796.8 32917.5 33333.0 33392.8 1147.6 1160.2 1163.7 1227.0 1251.5 16776.5 17425.7 17436.9 17440.6 17486.4 538573.0 541795.0 544724.0 545172.0 549971.0 61435.1 62240.7 62316.0 62350.0 62400.4 1365.6 1423.1 1427.5 1432.9 1441.0 31375.5 31916.5 32350.5 32545.7 33044.7 53923.5 54151.2 54653.0 54767.0 54898.2 502526.0 504430.0 506038.0 506481.0 506903.0 28209.9 28593.0 28946.4 29059.7 29082.7 49590.5 49617.8 50272.2 50651.7 50733.2 40180.0 41305.8 43120.6 44577.3 45302.0 42500.8 42898.8 43207.8 43239.0 43621.0 42728.4 42752.4 43123.0 43281.8 43504.3 35746.6 37704.0 37722.8 38527.0 38899.4 28776.0 28844.1 29207.0 29214.0 29258.9 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | [#2] jquery.html Cycles:180 Average:27971.23 Median:2271.73 stddev:77183.45 (3397.6%) stddev-sans-first:77372.18 20:30:26 INFO - PROCESS | 21425 | Values: 386.7 388.2 391.0 401.7 417.5 13931.2 15557.2 17989.4 19309.1 19712.1 13904.9 16128.1 16213.7 17445.4 19470.9 5589.5 5721.5 5774.7 5781.9 5783.3 5646.8 5671.0 5715.9 5746.9 5763.3 5531.5 5804.8 5814.3 5893.8 5918.7 5796.9 5834.3 5849.7 5893.6 6462.8 5561.8 5589.5 5653.3 5673.2 5695.2 13155.4 13400.4 13496.9 13711.0 13785.4 2214.3 2329.1 2375.1 2410.1 2419.2 9699.0 10190.8 10265.2 10450.1 10633.8 1927.2 1942.9 1961.6 1976.4 1996.2 78479.6 82648.0 83429.0 83514.2 85354.6 10632.7 10838.6 10969.1 11022.7 11039.2 15159.0 15187.5 15302.2 15323.6 15327.5 7947.6 8239.3 8242.8 8335.8 8360.2 7850.4 7993.7 8033.8 8050.4 8145.2 4616.2 4661.9 4674.2 4706.6 4712.1 1897.3 1906.4 1943.0 1967.7 1975.9 931.5 1013.7 1023.5 1057.7 1089.8 19038.7 19350.5 19501.0 19741.9 19878.0 1001.9 1023.9 1042.2 1106.8 1116.4 10476.3 10917.9 10922.6 10935.8 11039.3 459178.0 460680.0 465255.0 466161.0 484195.0 75286.2 85029.6 94315.5 94500.5 99918.5 978.1 1007.6 1009.4 1015.3 1018.0 17436.3 17653.9 17901.1 18112.9 18285.6 39895.6 40954.0 40976.2 41359.8 43445.6 55732.0 55832.0 56965.4 57541.7 57807.0 8561.7 8578.7 8592.7 8634.8 8744.7 9284.9 12783.9 13482.2 13583.6 13909.6 12070.6 12203.6 12208.6 12305.9 12449.4 9108.7 11101.6 11548.8 11725.3 12119.6 12330.3 12482.8 12501.7 12594.7 12710.7 7618.1 8866.4 8941.7 9085.8 9164.2 11742.8 11831.2 11833.6 11834.6 11983.6 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | [#3] mootools.html Cycles:180 Average:5599.96 Median:4778.16 stddev:3133.60 (65.6%) stddev-sans-first:3127.39 20:30:26 INFO - PROCESS | 21425 | Values: 1519.7 1550.8 1693.6 1789.9 1798.5 7410.7 8052.5 8217.3 8577.0 8587.1 8319.8 8463.9 8489.3 8585.4 8619.5 2289.8 2341.6 2342.5 2342.7 2346.4 2261.7 2289.0 2297.7 2307.9 2308.7 2282.9 2286.2 2293.7 2307.5 2342.5 2254.3 2271.4 2275.5 2275.9 2276.4 2229.3 2238.4 2245.4 2246.7 2251.1 8350.7 8384.5 8392.1 8396.2 8443.2 4930.2 5100.6 5128.6 5177.4 5185.1 3133.6 3147.7 3199.9 3319.4 3337.1 1164.4 1192.7 1199.7 1200.1 1211.9 11627.9 11646.2 11650.9 11674.6 11695.1 4451.3 4482.2 4635.1 4643.4 4675.2 9497.8 9586.1 9586.3 9596.7 9620.8 5055.5 5060.1 5065.1 5085.6 5096.3 4249.4 4662.6 4724.0 4758.6 4792.4 3754.9 3837.6 3847.6 3877.0 3993.2 1155.0 1168.6 1180.2 1181.1 1189.6 981.6 986.5 1005.5 1006.3 1007.2 5603.6 5612.0 5652.7 5791.0 5909.5 1000.5 1000.6 1006.9 1019.7 1021.9 3982.5 4005.2 4055.9 4097.0 4121.4 10405.2 10605.2 10742.1 10817.9 10826.1 10397.3 10442.7 10466.6 10478.6 10527.6 7492.8 7701.3 7878.4 7991.9 8001.1 5778.0 5909.8 5966.6 5991.6 6031.6 9402.6 9583.0 9925.9 9947.8 9960.7 9799.3 9964.8 10042.4 10068.8 10127.2 6848.8 7371.6 7460.3 7519.1 7593.8 8334.2 8344.4 8419.7 8440.8 8441.5 7338.3 7569.9 7599.8 7606.3 7655.3 7299.6 7364.4 7366.9 7429.4 7571.2 6278.7 6325.5 6339.6 6348.1 6385.3 4764.0 4915.0 4923.3 4935.6 4935.6 4843.7 4932.1 4984.6 5029.8 5055.0 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | [#4] prototype.html Cycles:180 Average:4895.22 Median:5507.56 stddev:1461.84 (26.5%) stddev-sans-first:1425.06 20:30:26 INFO - PROCESS | 21425 | Values: 321.5 328.7 334.3 336.6 339.3 5395.7 5585.9 5613.5 5648.8 5694.2 5525.2 5530.5 5550.6 5563.8 5586.7 4375.9 4384.6 4391.5 4403.8 4436.8 4268.3 4335.3 4393.5 4401.6 4452.6 4302.2 4331.5 4334.8 4347.2 4366.2 4342.2 4348.9 4362.6 4386.6 4397.7 3537.4 3708.2 3865.2 3891.3 3898.0 5327.7 5372.2 5381.9 5393.4 5399.6 4853.3 4874.2 4881.9 4882.2 4882.3 5630.8 5854.3 5867.0 5870.4 5890.3 4060.7 4070.6 4071.5 4075.6 4077.2 5919.0 5937.6 6147.9 6183.0 6242.8 4173.7 4187.0 4191.7 4197.7 4198.2 4215.6 4240.9 4241.5 4250.7 4278.5 4671.3 4903.8 4922.9 4928.4 4931.5 5860.7 5866.9 5943.2 5957.9 5991.4 1458.0 1466.8 1476.8 1477.2 1487.7 904.2 933.6 937.6 946.0 951.4 5028.3 5047.6 5048.6 5112.2 5163.5 5327.7 5370.5 5370.6 5402.7 5414.5 5084.6 5156.4 5158.8 5348.4 5771.7 3229.8 3240.9 3270.7 3271.3 3284.4 6199.7 6358.7 6358.8 6443.8 6469.8 6177.9 6190.8 6220.4 6221.6 6227.0 6168.3 6302.8 6318.6 6339.6 6404.4 5797.4 6031.7 6063.2 6100.5 6104.4 5964.9 5989.5 5989.9 6005.8 6057.5 5966.6 6151.4 6233.4 6268.5 6314.2 4190.5 4190.8 4192.1 4201.3 4203.2 5900.3 6040.5 6077.6 6111.5 6134.6 5865.5 5888.8 5898.5 5900.4 5908.1 5850.4 5865.8 5898.3 5905.5 5911.2 5581.4 5788.3 5795.8 5802.4 5826.2 5928.0 5958.4 5982.6 6024.9 6062.6 5489.9 5761.7 5783.7 5834.3 5880.6 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | [#5] yui.html Cycles:180 Average:16274.90 Median:578.67 stddev:20724.27 (3581.4%) stddev-sans-first:20749.63 20:30:26 INFO - PROCESS | 21425 | Values: 753.3 759.4 811.4 812.7 820.4 13082.8 13728.7 13807.8 14009.7 14010.4 12970.7 13007.3 13065.3 13091.0 13113.0 682.3 804.9 813.6 821.9 828.8 816.1 821.9 823.0 823.5 827.2 859.5 865.4 866.7 867.4 867.8 856.9 857.2 862.1 864.7 868.2 628.3 630.0 631.4 632.0 632.1 13262.3 13283.0 13347.3 13378.9 13386.9 13602.8 13790.4 13898.7 14194.0 14325.0 11286.9 11364.8 11478.6 11767.9 12394.6 3900.6 3916.6 3926.7 3976.1 4091.6 61242.4 61497.4 62186.0 62903.4 63167.7 10985.9 11038.2 11145.0 11302.9 11332.8 20298.9 20356.9 20407.3 20495.6 20498.4 8271.5 8338.0 8354.8 8459.5 8602.3 4363.1 4552.5 4619.3 4620.5 4661.7 3214.4 3275.6 3298.3 3320.4 3334.0 586.6 601.2 605.9 617.2 619.2 571.7 585.6 658.5 675.2 685.4 9162.5 9259.0 9344.8 9443.3 9461.9 662.9 665.4 669.2 679.4 684.8 4148.6 4172.3 4200.5 4372.6 4392.9 72944.6 74854.6 75011.0 75022.6 75774.6 66598.7 67364.7 68100.7 68141.7 68470.0 60482.4 61773.0 62845.4 63059.4 63501.0 8396.9 8459.9 8540.4 8541.6 8777.6 39648.4 39819.8 39970.2 40248.8 41437.6 47770.0 52573.2 53019.0 53429.5 53785.2 11478.1 11696.0 11758.2 11779.7 12080.6 12718.5 13406.9 13527.1 13826.7 14251.6 11814.4 12207.5 12579.7 12959.7 13037.7 11175.4 11226.8 11347.3 11387.0 11687.7 11360.6 11798.9 11878.2 12148.3 12173.5 8936.8 9243.8 9606.7 9606.8 9738.9 9507.8 9774.2 9781.8 9819.5 9855.9 20:30:26 INFO - PROCESS | 21425 | -------- Summary: end -------- 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | 20:30:26 INFO - PROCESS | 21425 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 20:30:26 INFO - PROCESS | 21425 | 20:30:27 INFO - TEST-INFO | 21425: exit 0 20:30:27 INFO - TEST-OK | dromaeo_css | took 1112015ms 20:30:27 INFO - TEST-START | kraken 20:30:27 INFO - operating with platform_type : linux_ 20:30:27 INFO - Initialising browser for kraken test... 20:30:27 INFO - TEST-INFO | started process 21656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTcgIdd/profile http://localhost:59308/getInfo.html) 20:30:31 INFO - PROCESS | 21656 | 20:30:31 INFO - PROCESS | 21656 | (process:21722): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:30:32 INFO - PROCESS | 21656 | __metrics Screen width/height:1600/1200 20:30:32 INFO - PROCESS | 21656 | colorDepth:24 20:30:32 INFO - PROCESS | 21656 | Browser inner width/height: 1024/697 20:30:32 INFO - PROCESS | 21656 | __metrics 20:30:33 ERROR - PROCESS | 21656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:30:34 INFO - TEST-INFO | 21656: exit 0 20:30:34 INFO - Browser initialized. 20:30:34 INFO - Running cycle 1/1 for kraken test... 20:30:34 INFO - TEST-INFO | started process 21773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTcgIdd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:36 INFO - PROCESS | 21773 | 20:30:36 INFO - PROCESS | 21773 | (process:21833): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:30:46 INFO - PROCESS | 21773 | RSS: Main: 164335616 20:30:46 INFO - PROCESS | 21773 | 20:30:48 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:49 INFO - PROCESS | 21773 | RSS: Main: 169418752 20:30:49 INFO - PROCESS | 21773 | 20:30:52 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-dft) 20:30:52 INFO - PROCESS | 21773 | RSS: Main: 169398272 20:30:52 INFO - PROCESS | 21773 | 20:30:55 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-fft) 20:30:56 INFO - PROCESS | 21773 | RSS: Main: 163418112 20:30:56 INFO - PROCESS | 21773 | 20:30:58 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-oscillator) 20:30:59 INFO - PROCESS | 21773 | RSS: Main: 163905536 20:30:59 INFO - PROCESS | 21773 | 20:31:01 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59308/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:02 INFO - PROCESS | 21773 | RSS: Main: 164413440 20:31:02 INFO - PROCESS | 21773 | 20:31:05 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59308/tests/kraken/driver.html?testName=imaging-darkroom) 20:31:06 INFO - PROCESS | 21773 | RSS: Main: 164335616 20:31:06 INFO - PROCESS | 21773 | 20:31:09 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59308/tests/kraken/driver.html?testName=imaging-desaturate) 20:31:10 INFO - PROCESS | 21773 | RSS: Main: 162889728 20:31:10 INFO - PROCESS | 21773 | 20:31:13 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59308/tests/kraken/driver.html?testName=json-parse-financial) 20:31:13 INFO - PROCESS | 21773 | RSS: Main: 163864576 20:31:13 INFO - PROCESS | 21773 | 20:31:15 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59308/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:31:16 INFO - PROCESS | 21773 | RSS: Main: 163946496 20:31:16 INFO - PROCESS | 21773 | 20:31:17 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:31:18 INFO - PROCESS | 21773 | RSS: Main: 164139008 20:31:18 INFO - PROCESS | 21773 | 20:31:20 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:21 INFO - PROCESS | 21773 | RSS: Main: 164220928 20:31:21 INFO - PROCESS | 21773 | 20:31:23 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:24 INFO - PROCESS | 21773 | RSS: Main: 164462592 20:31:24 INFO - PROCESS | 21773 | 20:31:27 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:28 INFO - PROCESS | 21773 | RSS: Main: 164392960 20:31:28 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59308/tests/kraken/driver.html?testName=ai-astar) 20:31:29 INFO - PROCESS | 21773 | RSS: Main: 165847040 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | __start_tp_report 20:31:29 INFO - PROCESS | 21773 | _x_x_mozilla_page_load 20:31:29 INFO - PROCESS | 21773 | _x_x_mozilla_page_load_details 20:31:29 INFO - PROCESS | 21773 | |i|pagename|runs| 20:31:29 INFO - PROCESS | 21773 | |0;ai-astar;113;109;112;113;111;112;113;111;111;111 20:31:29 INFO - PROCESS | 21773 | |1;audio-beat-detection;158;128;150;216;127;162;150;127;176;132 20:31:29 INFO - PROCESS | 21773 | |2;audio-dft;163;163;162;162;163;173;162;163;163;164 20:31:29 INFO - PROCESS | 21773 | |3;audio-fft;75;75;75;157;77;75;74;75;165;76 20:31:29 INFO - PROCESS | 21773 | |4;audio-oscillator;93;94;180;94;94;95;158;92;94;155 20:31:29 INFO - PROCESS | 21773 | |5;imaging-gaussian-blur;117;118;117;118;118;117;118;117;117;118 20:31:29 INFO - PROCESS | 21773 | |6;imaging-darkroom;146;146;148;147;148;148;147;147;148;148 20:31:29 INFO - PROCESS | 21773 | |7;imaging-desaturate;95;95;96;95;95;96;95;95;96;95 20:31:29 INFO - PROCESS | 21773 | |8;json-parse-financial;54;55;56;54;56;55;55;55;55;55 20:31:29 INFO - PROCESS | 21773 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;64;66;65 20:31:29 INFO - PROCESS | 21773 | |10;stanford-crypto-aes;79;81;78;77;78;80;79;81;130;79 20:31:29 INFO - PROCESS | 21773 | |11;stanford-crypto-ccm;124;128;133;118;123;131;132;134;134;120 20:31:29 INFO - PROCESS | 21773 | |12;stanford-crypto-pbkdf2;166;158;158;164;166;160;164;161;159;159 20:31:29 INFO - PROCESS | 21773 | |13;stanford-crypto-sha256-iterative;64;64;63;62;65;62;65;63;62;63 20:31:29 INFO - PROCESS | 21773 | __end_tp_report 20:31:29 INFO - PROCESS | 21773 | __start_cc_report 20:31:29 INFO - PROCESS | 21773 | _x_x_mozilla_cycle_collect,860 20:31:29 INFO - PROCESS | 21773 | __end_cc_report 20:31:29 INFO - PROCESS | 21773 | __startTimestamp1463801489946__endTimestamp 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | ------- Summary: start ------- 20:31:29 INFO - PROCESS | 21773 | Number of tests: 14 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.26 (1.1%) stddev-sans-first:1.24 20:31:29 INFO - PROCESS | 21773 | Values: 113.0 109.0 112.0 113.0 111.0 112.0 113.0 111.0 111.0 111.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:154.00 stddev:27.97 (18.2%) stddev-sans-first:29.59 20:31:29 INFO - PROCESS | 21773 | Values: 158.0 128.0 150.0 216.0 127.0 162.0 150.0 127.0 176.0 132.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.29 (2.0%) stddev-sans-first:3.48 20:31:29 INFO - PROCESS | 21773 | Values: 163.0 163.0 162.0 162.0 163.0 173.0 162.0 163.0 163.0 164.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:36.21 (48.3%) stddev-sans-first:37.86 20:31:29 INFO - PROCESS | 21773 | Values: 75.0 75.0 75.0 157.0 77.0 75.0 74.0 75.0 165.0 76.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#4] audio-oscillator Cycles:10 Average:114.90 Median:94.00 stddev:34.72 (36.9%) stddev-sans-first:35.91 20:31:29 INFO - PROCESS | 21773 | Values: 93.0 94.0 180.0 94.0 94.0 95.0 158.0 92.0 94.0 155.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:31:29 INFO - PROCESS | 21773 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 20:31:29 INFO - PROCESS | 21773 | Values: 146.0 146.0 148.0 147.0 148.0 148.0 147.0 147.0 148.0 148.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:31:29 INFO - PROCESS | 21773 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 20:31:29 INFO - PROCESS | 21773 | Values: 54.0 55.0 56.0 54.0 56.0 55.0 55.0 55.0 55.0 55.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 20:31:29 INFO - PROCESS | 21773 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 66.0 65.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:79.00 stddev:16.14 (20.4%) stddev-sans-first:17.01 20:31:29 INFO - PROCESS | 21773 | Values: 79.0 81.0 78.0 77.0 78.0 80.0 79.0 81.0 130.0 79.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:131.50 stddev:6.02 (4.6%) stddev-sans-first:6.23 20:31:29 INFO - PROCESS | 21773 | Values: 124.0 128.0 133.0 118.0 123.0 131.0 132.0 134.0 134.0 120.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.50 stddev:3.21 (2.0%) stddev-sans-first:2.96 20:31:29 INFO - PROCESS | 21773 | Values: 166.0 158.0 158.0 164.0 166.0 160.0 164.0 161.0 159.0 159.0 20:31:29 INFO - PROCESS | 21773 | 20:31:29 INFO - PROCESS | 21773 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.16 (1.8%) stddev-sans-first:1.20 20:31:29 INFO - PROCESS | 21773 | Values: 64.0 64.0 63.0 62.0 65.0 62.0 65.0 63.0 62.0 63.0 20:31:29 INFO - PROCESS | 21773 | -------- Summary: end -------- 20:31:29 INFO - PROCESS | 21773 | 20:31:30 INFO - TEST-INFO | 21773: exit 0 20:31:30 INFO - TEST-OK | kraken | took 63465ms 20:31:30 INFO - SUITE-END | took 1175s 20:31:31 INFO - Completed test suite (00:19:35) 20:31:31 INFO - javascript benchmark 20:31:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7175.990517037828, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3159.889403870864, 3186.6176058872925, 3194.4729119695253, 3200.919977000574, 3232.4666430039047, 5442.15646574781, 5475.8357249282535, 5486.0, 5586.273784408031, 5638.323401191852, 5447.428020057896, 5516.724163791814, 5531.889362212753, 5568.331800183973, 5650.886982260363, 4895.241237608177, 4987.451380348159, 5014.724190169539, 5144.0740666679985, 5174.042802081608, 587.3914491379971, 5012.072766538202, 5065.848024559269, 5092.490750924915, 5117.923231151536, 5007.824726134604, 5045.899082018357, 5052.065367906931, 5059.316992206061, 5100.387953445592, 4896.779644915988, 5067.822626208065, 5086.720230387327, 5095.770690318907, 5102.285680004802, 4916.287138364917, 4984.900301993976, 4997.400311962551, 5005.9499405005845, 5033.295338652591, 5392.946070539323, 5395.406505284415, 5426.9185962210595, 5428.6742795432, 5452.700101494416, 5763.971180144114, 5833.591648584601, 5846.9707651461895, 5874.530037596982, 5879.412058794129, 5988.670623115727, 6002.939970600281, 6012.699365031731, 6016.217891674054, 6052.848678783022, 5567.526760225385, 5590.832275031756, 5594.021046316879, 5599.4120617335, 5601.383847776741, 5826.300843898759, 6026.065959776154, 6064.332923378425, 6079.969600151971, 6117.418845209698, 5834.854128646818, 5836.066229403275, 5848.444397782204, 5851.970740146272, 5858.443447872445, 5847.912281315784, 5854.795082172103, 5894.440028197314, 5896.292444906639, 5929.9110513341475, 5678.829635110953, 5799.0, 5830.2420685310635, 5862.208601838783, 5863.5309175265875, 5742.253507044057, 5847.0, 5861.531077513789, 5879.911801322984, 5887.558433117533, 4474.821007159677, 4514.864554063383, 4517.728936263835, 4524.185646583581, 4541.000979784442, 3840.0975770693863, 3948.6446219840354, 3960.128771670228, 4004.139110091286, 4006.198760247962, 5699.059655156935, 5712.428757124254, 5715.085586306171, 5718.170865224519, 5732.0255556555485, 5838.620489668243, 5881.764729410861, 6003.219581454383, 6004.159417681528, 6013.939860601426, 5610.298712660918, 5654.4062873398525, 5688.943110568925, 5689.487946084872, 5731.770729170787, 5074.162763144113, 5124.308218390544, 5127.0, 5147.871303217449, 5161.225816127611, 5975.970120149458, 6195.31851496335, 6221.440070393686, 6224.502039836802, 6245.531585131133, 5924.940750592526, 5984.222051133412, 6020.578559500793, 6037.607555508878, 6046.09308603713, 6177.2587289525545, 6241.626842094732, 6244.2819075806865, 6247.219097612799, 6250.031245157008, 5730.598858079894, 5844.532437405082, 5899.557533185114, 5902.409759024235, 5945.256842894638, 5964.463198312173, 6006.669633170218, 6027.30685971119, 6028.15605815195, 6081.179040829431, 5781.103928891029, 5803.564732644984, 5852.502537284208, 5876.236089308533, 5877.23595932526, 5646.265985422033, 5745.3105627324985, 5762.5389968801555, 5821.330546987151, 5836.970815145897, 5426.647267927572, 5472.589555783253, 5486.862828429321, 5544.667319960815, 5548.056830338772, 5669.858253543694, 5686.573506987075, 5687.232223649754, 5713.942860571341, 5719.027765279996, 5585.720713964367, 5603.243562119224, 5610.859728506657, 5647.802326918538, 5671.602987790815], "value": 5420.476870626715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4769338362016, 633.4520639646705, 637.1271358239215, 654.9050387693787, 656.4059526128854, 39357.80321098394, 42595.36106958398, 42693.35959960599, 42811.0, 42963.57036429635, 44123.558764412344, 44554.55445445552, 44708.55291447085, 44762.0, 44891.0, 8737.737867863974, 8848.5575721214, 8912.420692654956, 8912.777180570472, 8916.063813299608, 8684.60919258635, 8738.825223495527, 8760.649574017032, 8769.824603507926, 8804.163604457599, 8803.29573634111, 8806.163414475615, 8848.380613357067, 8873.866891996593, 8875.334349923782, 8684.522351270678, 8726.258268047224, 8729.607167677437, 8756.430831995931, 8794.560271986375, 8803.559822008874, 8898.555072246427, 8899.110088991114, 8902.465852048834, 8907.955460222722, 40674.38988415147, 40836.591634083576, 41004.38493422601, 41298.38052429216, 41304.38043429351, 3478.165240342325, 3562.1628917204434, 3650.945235821465, 4095.4266402703647, 4294.634956028742, 31057.378852422826, 33313.83343083269, 33423.6657633423, 33474.0, 33584.16039599029, 3997.6801855851754, 4008.4187792769885, 4138.52406973196, 4191.1827193697245, 4235.25882970479, 223232.0, 223382.88308558517, 223858.0, 224686.0, 225326.99999999837, 64319.0, 64451.67774161099, 64565.67717161384, 64825.35174648288, 65050.0, 59717.0, 59963.700181499684, 60158.69920650369, 60311.396886031456, 60420.0, 17242.655146897243, 17300.134993250285, 17382.0, 17445.47663570095, 17519.47441576755, 13087.280199588924, 13131.409086591126, 13191.40638671262, 13270.535531256359, 13273.734525309439, 18435.790279220102, 19797.109130089182, 19826.306079287155, 19908.203671853254, 19959.301424450365, 3233.0, 7001.229864714877, 7047.788566342915, 7177.928220717726, 7267.127944646676, 971.1987610221454, 1085.7882712871071, 1119.9832002519968, 1141.7316930521322, 1179.3159967218992, 32622.510662340082, 32796.83601581977, 32917.50623740646, 33333.0, 33392.83303583515, 1147.5696613769837, 1160.1936654025371, 1163.6799880033059, 1226.9509569318104, 1251.474380760083, 16776.496705098867, 17425.65148697019, 17436.912815436095, 17440.5639859002, 17486.387976420763, 538573.0, 541795.0, 544724.0, 545172.0, 549971.0, 61435.07847382293, 62240.688796556635, 62316.0, 62350.0, 62400.375996239454, 1365.6244532753572, 1423.110555902561, 1427.5289154578963, 1432.8782053525567, 1441.0489077209202, 31375.529367059054, 31916.52125218077, 32350.514742279356, 32545.674543254263, 33044.66955330416, 53923.46076539184, 54151.18773218326, 54653.0, 54767.0, 54898.17652735292, 502526.0, 504430.0, 506038.0, 506481.0, 506903.0, 28209.858950705115, 28592.999245026323, 28946.421071578872, 29059.7094029057, 29082.709172908, 49590.50409495859, 49617.751911240215, 50272.245916312015, 50651.746741266055, 50733.23900141427, 40180.0, 41305.793471032455, 43120.56879431166, 44577.331340029275, 45302.0, 42500.78749606232, 42898.78550607227, 43207.78396108125, 43239.0, 43621.0, 42728.35907461328, 42752.358714618684, 43123.0, 43281.783591083105, 43504.34743478914, 35746.64253357433, 37704.0, 37722.81138594399, 38527.0, 38899.41650875183, 28775.992840250492, 28844.134675959755, 29207.0, 29214.0, 29258.853705731333], "value": 20372.48701803088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.6887155839549, 388.2080555666441, 390.99218015639707, 401.6545770637251, 417.54279064424446, 13931.233782141979, 15557.222138893067, 17989.37037203698, 19309.13108910099, 19712.112954917025, 13904.930475347634, 16128.112953787537, 16213.675726485464, 17445.389411370605, 19470.90264548679, 5589.469000444961, 5721.485066344028, 5774.740136693859, 5781.855453613673, 5783.306003279591, 5646.774129034834, 5671.0, 5715.9428405716035, 5746.856328591798, 5763.250777398953, 5531.502164805167, 5804.780995990847, 5814.302283725938, 5893.764249430039, 5918.733656985424, 5796.942030579704, 5834.329052158992, 5849.683821140231, 5893.616914900518, 6462.838429039265, 5561.833145005616, 5589.496945274904, 5653.293338332708, 5673.23411339468, 5695.231143795576, 13155.408006639724, 13400.396982135828, 13496.93251533746, 13711.040227184101, 13785.448582056706, 2214.324630987548, 2329.138218859033, 2375.085592047057, 2410.0600765701392, 2419.2258477287273, 9699.0, 10190.796184076351, 10265.230107741949, 10450.111740502067, 10633.840492392621, 1927.1821043120717, 1942.9319973800991, 1961.6174845905055, 1976.416956997689, 1996.2015193922402, 78479.6076019622, 82647.9999999994, 83429.0, 83514.16485835185, 85354.57322713408, 10632.68101956927, 10838.620648277272, 10969.122470202365, 11022.724431889266, 11039.227254092137, 15159.0, 15187.544373668587, 15302.158381288913, 15323.616909577127, 15327.46353877609, 7947.602619868983, 8239.258466738022, 8242.835143297101, 8335.791605209919, 8360.205780450848, 7850.371970242367, 7993.720219792395, 8033.758987230392, 8050.417564183999, 8145.185481451926, 4616.215243408628, 4661.883452913637, 4674.205385084476, 4706.623470122382, 4712.104700106968, 1897.2600685732575, 1906.447130332216, 1942.9514262143277, 1967.7146813712218, 1975.940721778349, 931.5435436636135, 1013.6806905824642, 1023.5240613114788, 1057.746140926172, 1089.803835309652, 19038.714419283722, 19350.516237093903, 19501.0, 19741.901290493457, 19878.0, 1001.8547310639916, 1023.8924912884189, 1042.2131290875493, 1106.8284415915546, 1116.3636727065657, 10476.266661333633, 10917.945410272898, 10922.563097476012, 10935.83596246057, 11039.282446640942, 459178.0, 460680.0, 465255.0, 466161.0, 484195.0, 75286.24713752902, 85029.57485212534, 94315.52842235746, 94500.52749736207, 99918.50040749896, 978.1148061004802, 1007.5818535307765, 1009.3641006166068, 1015.3451024089421, 1018.0379541333517, 17436.302547897943, 17653.940763554227, 17901.10494475245, 18112.909435452737, 18285.634287313915, 39895.60104399035, 40954.0, 40976.1804763909, 41359.793201033805, 43445.56554434415, 55732.0, 55832.0, 56965.43034569601, 57541.71229143828, 57807.0, 8561.657533698832, 8578.65685372603, 8592.742217733477, 8634.827303454022, 8744.69393571222, 9284.90679734465, 12783.93608031954, 13482.19106853592, 13583.592492225249, 13909.58271251864, 12070.637880863587, 12203.572874949334, 12208.633740987785, 12305.876941230474, 12449.439775209956, 9108.679241510077, 11101.611443599759, 11548.82676759866, 11725.296482210753, 12119.57581484679, 12330.321832299309, 12482.812757808459, 12501.687457813627, 12594.685132871751, 12710.682232944251, 7618.123915749759, 8866.42368246062, 8941.687040953535, 9085.77285567866, 9164.221041211571, 11742.765144697229, 11831.171817973003, 11833.585824496102, 11834.644960651194, 11983.580574679845], "value": 9070.717545574445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.749241375173, 1550.8061492313461, 1693.6104695919937, 1789.8657600679944, 1798.5233913013062, 7410.70357185712, 8052.516848989065, 8217.301529369995, 8576.957115214424, 8587.14128587141, 8319.83360332793, 8463.873041904377, 8489.320854331654, 8585.356098292621, 8619.525926074064, 2289.7939185473306, 2341.613633750429, 2342.5197834443898, 2342.7422983471806, 2346.4485845826216, 2261.6720575516542, 2289.0, 2297.7242730872317, 2307.880677871231, 2308.665243539686, 2282.942926426836, 2286.188403116886, 2293.71328583927, 2307.515421761432, 2342.472943587696, 2254.28989868191, 2271.3980795089315, 2275.544891021794, 2275.931722048333, 2276.408133885185, 2229.331200639818, 2238.3956331790328, 2245.371296037096, 2246.70792796937, 2251.122062395667, 8350.665973361058, 8384.496930184208, 8392.118827523143, 8396.244338009608, 8443.240108390213, 4930.235813448921, 5100.642954993152, 5128.5640720538795, 5177.37871455424, 5185.144451165553, 3133.5926329577237, 3147.7324427423696, 3199.904002879894, 3319.3527262183884, 3337.1156643489494, 1164.4061528620464, 1192.6600918738118, 1199.6760874563906, 1200.147894994555, 1211.8666946635863, 11627.941860290644, 11646.24299420535, 11650.941745291304, 11674.591389301333, 11695.064394848478, 4451.3323001550025, 4482.1707984022405, 4635.072985402933, 4643.396358473445, 4675.181843177498, 9497.762555936019, 9586.137247647745, 9586.328956972944, 9596.712098637052, 9620.75948101303, 5055.494450554988, 5060.089183946851, 5065.062963351792, 5085.567726743268, 5096.261042148942, 4249.447571815706, 4662.580367766917, 4723.952760472352, 4758.595519380822, 4792.376990991149, 3754.8685795997008, 3837.5586807517493, 3847.5575308839843, 3877.0307423144213, 3993.1813978134414, 1155.0, 1168.64940517846, 1180.221054104287, 1181.0846593889805, 1189.5598628507507, 981.6318880419842, 986.5166068626465, 1005.532427421238, 1006.2805094357569, 1007.2294694558668, 5603.635763675348, 5612.045952188138, 5652.689102099342, 5791.0, 5909.527237820964, 1000.5497526113132, 1000.6447711062614, 1006.9144122749502, 1019.6838979916101, 1021.9437930913722, 3982.482277303932, 4005.218982298482, 4055.858044968412, 4096.959030409657, 4121.423000779893, 10405.167586593054, 10605.151587873106, 10742.086922611665, 10817.945910270399, 10826.079783218514, 10397.272190946713, 10442.68671939843, 10466.63366782159, 10478.633247836442, 10527.578896844194, 7492.7752167435065, 7701.268379503938, 7878.369730421553, 7991.880121798177, 8001.1198768135455, 5778.017736984807, 5909.763609455574, 5966.642001479925, 5991.550633702403, 6031.5777895548645, 9402.57688404037, 9583.0, 9925.900740992498, 9947.801043979225, 9960.651377201762, 9799.265055120752, 9964.750881228027, 10042.447665378475, 10068.798624027331, 10127.240456965905, 6848.794536163923, 7371.631418429164, 7460.328570428687, 7519.060117485315, 7593.772186834404, 8334.166583341617, 8344.41589088758, 8419.747407577783, 8440.788980275542, 8441.451305665112, 7338.302861228175, 7569.924300757142, 7599.772006839804, 7606.277403646644, 7655.272749088827, 7299.598522081124, 7364.41084713211, 7366.852662946818, 7429.44279179053, 7571.205023472456, 6278.717457714322, 6325.4939604832425, 6339.619622822645, 6348.143000694847, 6385.297617262005, 4763.951500854527, 4914.950850491449, 4923.310736496965, 4935.580475659609, 4935.629827763004, 4843.733594652187, 4932.062908047459, 4984.576311013459, 5029.76770691183, 5055.039542486916], "value": 4528.838281654162, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.5209338086252, 328.74193757900053, 334.32132770475926, 336.57255285787045, 339.34337057793186, 5395.703236322006, 5585.944140558593, 5613.494785469307, 5648.830535083944, 5694.174344720013, 5525.198846167304, 5530.5299049580735, 5550.555955523559, 5563.803782186829, 5586.748596313166, 4375.868723938271, 4384.561543845622, 4391.451068616423, 4403.801828917706, 4436.844710435135, 4268.274393353122, 4335.309229400521, 4393.538678438766, 4401.581849724271, 4452.554744525538, 4302.161078589676, 4331.545187755288, 4334.829596009092, 4347.19576878277, 4366.170427618758, 4342.1532801103795, 4348.869533913988, 4362.607365337103, 4386.561343865604, 4397.714148580348, 3537.398642230827, 3708.2027364116843, 3865.16898866745, 3891.299566078105, 3897.9610203897882, 5327.680339179662, 5372.194170874361, 5381.9461805382225, 5393.352797664266, 5399.649022813504, 4853.320535125085, 4874.195757699975, 4881.852764600316, 4882.218844984785, 4882.316475693406, 5630.832129630122, 5854.297484301868, 5866.970665146647, 5870.442307980735, 5890.263717035371, 4060.7360521566, 4070.5522392536795, 4071.450354202204, 4075.6331930126134, 4077.2467838829293, 5918.970405147989, 5937.554683398763, 6147.907781383283, 6183.0, 6242.781502647385, 4173.7078404512, 4186.958130418718, 4191.7275377100395, 4197.664186865043, 4198.244316023145, 4215.6205941464805, 4240.936385954213, 4241.512226093977, 4250.744955302692, 4278.465191851019, 4671.252599584118, 4903.779329930162, 4922.852314430573, 4928.408590969035, 4931.457539670633, 5860.681346697044, 5866.911996320058, 5943.167956486095, 5957.868005079021, 5991.370906054802, 1457.9708405831825, 1466.7506523890963, 1476.7784832275029, 1477.1727832413883, 1487.6578386970841, 904.2268860124631, 933.6452148183782, 937.6108914800418, 946.0303189231093, 951.4291425144996, 5028.340647586288, 5047.646664733506, 5048.617426324371, 5112.233165025202, 5163.535281824654, 5327.733613319396, 5370.543503802221, 5370.62405631602, 5402.677857713813, 5414.512693857571, 5084.593232541388, 5156.381234251839, 5158.819441319536, 5348.411674715778, 5771.6537007778825, 3229.7900636458553, 3240.9189770255934, 3270.6590297977714, 3271.2966712157, 3284.392387408337, 6199.659018753921, 6358.7456501740335, 6358.777442789573, 6443.7744678936015, 6469.805905822833, 6177.949748542758, 6190.81427557174, 6220.351606824195, 6221.626702397871, 6226.968865155736, 6168.25980882297, 6302.779402720883, 6318.62088274705, 6339.5562310637815, 6404.359564043559, 5797.449242321973, 6031.728572214173, 6063.211782468251, 6100.481459076028, 6104.4200800923845, 5964.910526342195, 5989.490893274121, 5989.910151347821, 6005.759769609167, 6057.485113765203, 5966.552508561788, 6151.354107818794, 6233.407826256498, 6268.4671802897265, 6314.242290925118, 4190.51809041964, 4190.790460477025, 4192.098698779777, 4201.285781417106, 4203.243416184993, 5900.285868500538, 6040.516758659384, 6077.60215150509, 6111.54163437735, 6134.570580059353, 5865.501432378295, 5888.823335299948, 5898.498627616701, 5900.380460051632, 5908.143319218603, 5850.356460789395, 5865.794697185578, 5898.292204935436, 5905.498032667271, 5911.231539899785, 5581.358143813513, 5788.32138679795, 5795.768169273182, 5802.4197580241635, 5826.213461182686, 5927.970360148344, 5958.374370691015, 5982.641041537521, 6024.9397506026135, 6062.605930614496, 5489.913832743532, 5761.740721667451, 5783.652980821164, 5834.2788877282155, 5880.617759845596], "value": 4421.962792279286, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.2730914667345, 759.3773106053037, 811.444160749886, 812.6789917982394, 820.3601191070964, 13082.803757943626, 13728.656783580416, 13807.79288310675, 14009.719805603881, 14010.439582416691, 12970.675733106676, 13007.34963251836, 13065.346732663376, 13091.018173636992, 13113.0, 682.3210905149383, 804.899387576553, 813.5728742410238, 821.876718492228, 828.7638023163399, 816.0574536410455, 821.8890449789292, 823.0206054794805, 823.4565186976597, 827.1810907201857, 859.4671303791658, 865.3726048614735, 866.7269810009826, 867.397158974513, 867.7743786615463, 856.8543347630917, 857.2327766648846, 862.0689655172399, 864.7405778266495, 868.2055918834259, 628.3308276685316, 629.968501574924, 631.4254028833785, 632.0456111271966, 632.0708558419117, 13262.3368831559, 13283.0, 13347.265900375573, 13378.93310533441, 13386.866131338757, 13602.795958060637, 13790.379432925542, 13898.722025559433, 14194.0, 14325.0, 11286.916144494064, 11364.829527557093, 11478.598249061326, 11767.882321176765, 12394.56619018339, 3900.5904380040256, 3916.5887581803786, 3926.666233370167, 3976.1451287973223, 4091.6317531422314, 61242.387576124114, 61497.38502614961, 62186.0, 62903.37096629067, 63167.68416157936, 10985.945070274598, 11038.17213708975, 11145.0, 11302.886971130183, 11332.773344533229, 20298.89850550738, 20356.898215508827, 20407.28574499915, 20495.590088198453, 20498.38504844857, 8271.462354947029, 8338.04112527055, 8354.8329033419, 8459.49243045407, 8602.268807151337, 4363.105563359503, 4552.453705555355, 4619.260918253063, 4620.514845941195, 4661.743604101739, 3214.421404147276, 3275.623303320101, 3298.2578919742864, 3320.4023275810105, 3334.033130392159, 586.6362855029823, 601.227422761749, 605.9121427393003, 617.1729881958108, 619.2352444730753, 571.7284289962234, 585.6105689716376, 658.5258613798057, 675.1650624453056, 685.3694600967123, 9162.450252984841, 9258.95370523143, 9344.766380840534, 9443.338966272295, 9461.905380946102, 662.9337066293332, 665.4244078871741, 669.1635455680399, 679.3851564334285, 684.7945616315086, 4148.56440073794, 4172.290710579209, 4200.537940826506, 4372.628326592212, 4392.890177745582, 72944.63527682328, 74854.62572687211, 75011.0, 75022.6248868763, 75774.62112689401, 66598.66700666562, 67364.66317668479, 68100.6594967022, 68141.65929170322, 68470.0, 60482.39517604768, 61773.0, 62845.37154628486, 63059.36940630535, 63501.0, 8396.874046889423, 8459.873101903353, 8540.35947303967, 8541.572921354033, 8777.648894044167, 39648.40527392149, 39819.80090099531, 39970.200595987335, 40248.798756006036, 41437.58562414337, 47770.0, 52573.211401829765, 53019.0, 53429.465705344, 53785.19322210248, 11478.139139564733, 11696.0, 11758.176927615326, 11779.705507362041, 12080.637580872588, 12718.491260349483, 13406.932965335502, 13527.120737152054, 13826.723465530835, 14251.643708906946, 11814.409279536161, 12207.45066471993, 12579.685507862378, 12959.740805184032, 13037.739245215233, 11175.398746973711, 11226.775464490827, 11347.262427942158, 11387.0321022714, 11687.707807304885, 11360.602378916697, 11798.882011179778, 11878.227915185485, 12148.331841748435, 12173.452194651085, 8936.821263574822, 9243.76890577741, 9606.711798646053, 9606.807863842545, 9738.902610973799, 9507.809843802946, 9774.169195618451, 9781.804363912825, 9819.459929703935, 9855.901440985499], "value": 6806.470294355338, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 112.0, 113.0, 111.0, 112.0, 113.0, 111.0, 111.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 150.0, 216.0, 127.0, 162.0, 150.0, 127.0, 176.0, 132.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 173.0, 162.0, 163.0, 163.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 157.0, 77.0, 75.0, 74.0, 75.0, 165.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 180.0, 94.0, 94.0, 95.0, 158.0, 92.0, 94.0, 155.0], "value": 114.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 54.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 66.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 78.0, 77.0, 78.0, 80.0, 79.0, 81.0, 130.0, 79.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 133.0, 118.0, 123.0, 131.0, 132.0, 134.0, 134.0, 120.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 158.0, 164.0, 166.0, 160.0, 164.0, 161.0, 159.0, 159.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 62.0, 65.0, 62.0, 65.0, 63.0, 62.0, 63.0], "value": 63.3, "unit": "score"}]}]} 20:31:31 INFO - Return code: 0 20:31:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:31:31 ERROR - # TBPL SUCCESS # 20:31:31 INFO - Running post-action listener: _resource_record_post_action 20:31:31 INFO - ##### 20:31:31 INFO - ##### Finished run-tests step (success) 20:31:31 INFO - ##### 20:31:31 INFO - Running post-run listener: _resource_record_post_run 20:31:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538075136; Read time: 16; Write time: 1248920 20:31:31 INFO - TinderboxPrint: CPU usage
13.5% 20:31:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:31:31 INFO - TinderboxPrint: I/O write bytes / time
538,075,136 / 1,248,920 20:31:31 INFO - TinderboxPrint: CPU idle
8,242.0 (86.5%) 20:31:31 INFO - TinderboxPrint: CPU user
1,222.3 (12.8%) 20:31:31 INFO - TinderboxPrint: Swap in / out
0 / 0 20:31:31 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 247033856; Read time: 0; Write time: 776332 20:31:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291041280; Read time: 16; Write time: 472588 20:31:31 INFO - Running post-run listener: _upload_blobber_files 20:31:31 INFO - Blob upload gear active. 20:31:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:31 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 20:31:31 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'] 20:31:31 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 20:31:32 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:31:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:36 INFO - (blobuploader) - INFO - Done attempting. 20:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:31:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:36 INFO - (blobuploader) - INFO - Done attempting. 20:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:37 INFO - (blobuploader) - INFO - Done attempting. 20:31:37 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:37 INFO - Return code: 0 20:31:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f52955cc21daec50f242906be2dd625653b4ea90d149b8ea5d77b5e25e1f0cf44c5083baabefe0fa4895a53f238cab3292e6b3945fd2f4c48946625ad70d142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0054de7431a8bf88c8bb3d0a2e00edb829bbbe355b71e42b3854a0a03d0f70f30337efa35e5a3f7c43133246164408d0c1bf95bfad668d89db93d8424e55a262", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/122652e7ab187034eb0c9f65c0356675c1831438d592c349cf102d75358d827c1b5d7fcba0ba7fedfab42ed818eb8cd775199f342718cac724455e6ebc195591"} 20:31:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:37 INFO - Contents: 20:31:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f52955cc21daec50f242906be2dd625653b4ea90d149b8ea5d77b5e25e1f0cf44c5083baabefe0fa4895a53f238cab3292e6b3945fd2f4c48946625ad70d142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0054de7431a8bf88c8bb3d0a2e00edb829bbbe355b71e42b3854a0a03d0f70f30337efa35e5a3f7c43133246164408d0c1bf95bfad668d89db93d8424e55a262", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/122652e7ab187034eb0c9f65c0356675c1831438d592c349cf102d75358d827c1b5d7fcba0ba7fedfab42ed818eb8cd775199f342718cac724455e6ebc195591"} 20:31:37 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:37 INFO - Copying logs to upload dir... 20:31:37 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.866476 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-20 20:31:37.121579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 20:31:37.125048) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1463797467.265097-801786032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f52955cc21daec50f242906be2dd625653b4ea90d149b8ea5d77b5e25e1f0cf44c5083baabefe0fa4895a53f238cab3292e6b3945fd2f4c48946625ad70d142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0054de7431a8bf88c8bb3d0a2e00edb829bbbe355b71e42b3854a0a03d0f70f30337efa35e5a3f7c43133246164408d0c1bf95bfad668d89db93d8424e55a262", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/122652e7ab187034eb0c9f65c0356675c1831438d592c349cf102d75358d827c1b5d7fcba0ba7fedfab42ed818eb8cd775199f342718cac724455e6ebc195591"} build_url:https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f52955cc21daec50f242906be2dd625653b4ea90d149b8ea5d77b5e25e1f0cf44c5083baabefe0fa4895a53f238cab3292e6b3945fd2f4c48946625ad70d142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0054de7431a8bf88c8bb3d0a2e00edb829bbbe355b71e42b3854a0a03d0f70f30337efa35e5a3f7c43133246164408d0c1bf95bfad668d89db93d8424e55a262", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/122652e7ab187034eb0c9f65c0356675c1831438d592c349cf102d75358d827c1b5d7fcba0ba7fedfab42ed818eb8cd775199f342718cac724455e6ebc195591"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 20:31:37.149715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:31:37.150009) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1463797467.265097-801786032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:31:37.233271) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 20:31:37.233561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 20:31:37.233843) ========= ========= Total master_lag: 0.19 =========