builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1470090116.3 results: success (0) buildid: 20160801123003 builduid: 46c73c9c14054688b054414b0bcd67c4 revision: 6db7f11e05a65cc53a3e4b102963ec243a8c0fdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.303291) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.303745) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.304033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.328396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.328661) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 15:21:57-- 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% 112M=0s 2016-08-01 15:21:57 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.447158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.447468) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.496529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:56.496850) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6db7f11e05a65cc53a3e4b102963ec243a8c0fdc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6db7f11e05a65cc53a3e4b102963ec243a8c0fdc --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=8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 15:21:57,574 truncating revision to first 12 chars 2016-08-01 15:21:57,574 Setting DEBUG logging. 2016-08-01 15:21:57,574 attempt 1/10 2016-08-01 15:21:57,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6db7f11e05a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 15:21:58,136 unpacking tar archive at: autoland-6db7f11e05a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:57.405157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:57.405469) ========= script_repo_revision: 6db7f11e05a65cc53a3e4b102963ec243a8c0fdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:57.405841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:57.406114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 15:21:57.419425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-01 15:21:57.419706) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:21:58 INFO - MultiFileLogger online at 20160801 15:21:58 in /builds/slave/test 15:21:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:21:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:21:58 INFO - {'append_to_log': False, 15:21:58 INFO - 'base_work_dir': '/builds/slave/test', 15:21:58 INFO - 'blob_upload_branch': 'Autoland', 15:21:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:21:58 INFO - 'branch': 'Autoland', 15:21:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:58 INFO - 'config_files': ('talos/linux_config.py',), 15:21:58 INFO - 'default_actions': ('clobber', 15:21:58 INFO - 'read-buildbot-config', 15:21:58 INFO - 'download-and-extract', 15:21:58 INFO - 'populate-webroot', 15:21:58 INFO - 'create-virtualenv', 15:21:58 INFO - 'install', 15:21:58 INFO - 'run-tests'), 15:21:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:58 INFO - 'download_minidump_stackwalk': True, 15:21:58 INFO - 'download_symbols': 'ondemand', 15:21:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:21:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:21:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:21:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:21:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:58 INFO - 'installer_path': 'installer.exe', 15:21:58 INFO - 'log_level': 'info', 15:21:58 INFO - 'log_name': 'talos', 15:21:58 INFO - 'log_to_console': True, 15:21:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:21:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:21:58 INFO - 'opt_config_files': (), 15:21:58 INFO - 'pip_index': False, 15:21:58 INFO - 'sps_profile': False, 15:21:58 INFO - 'sps_profile_interval': 0, 15:21:58 INFO - 'suite': 'dromaeojs-e10s', 15:21:58 INFO - 'system_bits': '32', 15:21:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:58 INFO - 'title': 'talos-linux64-ix-001', 15:21:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:58 INFO - 'use_talos_json': True, 15:21:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:21:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:58 INFO - 'work_dir': 'build'} 15:21:58 INFO - [mozharness: 2016-08-01 22:21:58.582453Z] Running clobber step. 15:21:58 INFO - Running pre-action listener: _resource_record_pre_action 15:21:58 INFO - Running main action method: clobber 15:21:58 INFO - rmtree: /builds/slave/test/build 15:21:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:21:59 INFO - Running post-action listener: _resource_record_post_action 15:21:59 INFO - [mozharness: 2016-08-01 22:21:59.041349Z] Finished clobber step (success) 15:21:59 INFO - [mozharness: 2016-08-01 22:21:59.041450Z] Running read-buildbot-config step. 15:21:59 INFO - Running pre-action listener: _resource_record_pre_action 15:21:59 INFO - Running main action method: read_buildbot_config 15:21:59 INFO - Using buildbot properties: 15:21:59 INFO - { 15:21:59 INFO - "project": "", 15:21:59 INFO - "product": "firefox", 15:21:59 INFO - "script_repo_revision": "production", 15:21:59 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:21:59 INFO - "repository": "", 15:21:59 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:21:59 INFO - "buildid": "20160801123003", 15:21:59 INFO - "pgo_build": "True", 15:21:59 INFO - "basedir": "/builds/slave/test", 15:21:59 INFO - "buildnumber": 79, 15:21:59 INFO - "slavename": "talos-linux64-ix-001", 15:21:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:21:59 INFO - "platform": "ubuntu64_hw", 15:21:59 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:21:59 INFO - "branch": "autoland", 15:21:59 INFO - "repo_path": "integration/autoland", 15:21:59 INFO - "revision": "6db7f11e05a65cc53a3e4b102963ec243a8c0fdc", 15:21:59 INFO - "stage_platform": "linux64-pgo", 15:21:59 INFO - "builduid": "46c73c9c14054688b054414b0bcd67c4", 15:21:59 INFO - "slavebuilddir": "test" 15:21:59 INFO - } 15:21:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:21:59 INFO - Running post-action listener: _resource_record_post_action 15:21:59 INFO - [mozharness: 2016-08-01 22:21:59.043906Z] Finished read-buildbot-config step (success) 15:21:59 INFO - [mozharness: 2016-08-01 22:21:59.043996Z] Running download-and-extract step. 15:21:59 INFO - Running pre-action listener: _resource_record_pre_action 15:21:59 INFO - Running main action method: download_and_extract 15:21:59 INFO - mkdir: /builds/slave/test/build/tests 15:21: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')]} 15:21:59 INFO - https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:21:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:21:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:21:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:21:59 INFO - Downloaded 1361 bytes. 15:21:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:21:59 INFO - Using the following test package requirements: 15:21:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:21:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:21:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'jsshell-linux-x86_64.zip'], 15:21:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:21:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:21:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:21:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:21:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:21:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:21: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')]} 15:21:59 INFO - https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:21:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:21:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:21:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:00 INFO - Downloaded 21807861 bytes. 15:22:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:22:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:22:01 INFO - Return code: 0 15:22:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:01 INFO - https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:22:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:22:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:22:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:22:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:02 INFO - Downloaded 21807861 bytes. 15:22:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:22:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:22:04 INFO - Return code: 0 15:22:04 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')]} 15:22:04 INFO - https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:22:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:22:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:22:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:22:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:22:04 INFO - Downloaded 14413723 bytes. 15:22:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:22:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:22:05 INFO - Return code: 0 15:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:05 INFO - https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:22:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:22:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:22:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:22:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:22:06 INFO - Downloaded 59383287 bytes. 15:22:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:22:06 INFO - mkdir: /builds/slave/test/properties 15:22:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:06 INFO - Contents: 15:22:06 INFO - build_url:https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:22:07 INFO - Running post-action listener: _resource_record_post_action 15:22:07 INFO - Running post-action listener: set_extra_try_arguments 15:22:07 INFO - [mozharness: 2016-08-01 22:22:07.383571Z] Finished download-and-extract step (success) 15:22:07 INFO - [mozharness: 2016-08-01 22:22:07.383804Z] Running populate-webroot step. 15:22:07 INFO - Running pre-action listener: _resource_record_pre_action 15:22:07 INFO - Running main action method: populate_webroot 15:22:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:22:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:22:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:22:07 INFO - '--tppagecycles', 15:22:07 INFO - '7'], 15:22:07 INFO - 'tests': ['tsvgm']}}, 15:22:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:22:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:22:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['damp', 'tps']}, 15:22:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'tests': ['damp', 'tps']}, 15:22:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['dromaeo_dom']}, 15:22:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['basic_compositor_video']}, 15:22:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:22:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['a11yr', 15:22:07 INFO - 'ts_paint', 15:22:07 INFO - 'tpaint', 15:22:07 INFO - 'sessionrestore', 15:22:07 INFO - 'sessionrestore_no_auto_restore', 15:22:07 INFO - 'tabpaint']}, 15:22:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:07 INFO - 'ts_paint', 15:22:07 INFO - 'tpaint', 15:22:07 INFO - 'sessionrestore', 15:22:07 INFO - 'sessionrestore_no_auto_restore', 15:22:07 INFO - 'tabpaint']}, 15:22:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:22:07 INFO - 'ts_paint', 15:22:07 INFO - 'tpaint', 15:22:07 INFO - 'sessionrestore', 15:22:07 INFO - 'sessionrestore_no_auto_restore', 15:22:07 INFO - 'tabpaint']}, 15:22:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:22:07 INFO - 'ts_paint', 15:22:07 INFO - 'tpaint', 15:22:07 INFO - 'sessionrestore', 15:22:07 INFO - 'sessionrestore_no_auto_restore', 15:22:07 INFO - 'tabpaint']}, 15:22:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['a11yr', 15:22:07 INFO - 'ts_paint', 15:22:07 INFO - 'tpaint', 15:22:07 INFO - 'sessionrestore', 15:22:07 INFO - 'sessionrestore_no_auto_restore', 15:22:07 INFO - 'tabpaint']}, 15:22:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['a11yr', 15:22:07 INFO - 'ts_paint', 15:22:07 INFO - 'tpaint', 15:22:07 INFO - 'sessionrestore', 15:22:07 INFO - 'sessionrestore_no_auto_restore', 15:22:07 INFO - 'tabpaint']}, 15:22:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['tsvgx', 15:22:07 INFO - 'tsvgr_opacity', 15:22:07 INFO - 'tart', 15:22:07 INFO - 'tscrollx', 15:22:07 INFO - 'cart']}, 15:22:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:07 INFO - 'tsvgr_opacity', 15:22:07 INFO - 'tart', 15:22:07 INFO - 'tscrollx', 15:22:07 INFO - 'cart']}, 15:22:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'talos_options': ['--disable-e10s'], 15:22:07 INFO - 'tests': ['tp5o']}, 15:22:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'tests': ['tp5o']}, 15:22:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'talos_options': ['--disable-e10s', 15:22:07 INFO - '--xperf_path', 15:22:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:07 INFO - 'tests': ['tp5n']}, 15:22:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:07 INFO - 'talos_options': ['--xperf_path', 15:22:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:07 INFO - 'tests': ['tp5n']}}, 15:22:07 INFO - 'talos.zip': {'path': '', 15:22:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:22:07 INFO - Running post-action listener: _resource_record_post_action 15:22:07 INFO - [mozharness: 2016-08-01 22:22:07.405693Z] Finished populate-webroot step (success) 15:22:07 INFO - [mozharness: 2016-08-01 22:22:07.405782Z] Running create-virtualenv step. 15:22:07 INFO - Running pre-action listener: _resource_record_pre_action 15:22:07 INFO - Running main action method: create_virtualenv 15:22:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:07 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 15:22:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:22:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:07 INFO - Using real prefix '/usr' 15:22:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:08 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:10 INFO - Installing pip.................done. 15:22:10 INFO - Return code: 0 15:22:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:22:10 INFO - Using env: {'DISPLAY': ':0', 15:22:10 INFO - 'HOME': '/home/cltbld', 15:22:10 INFO - 'LANG': 'en_US.UTF-8', 15:22:10 INFO - 'LANGUAGE': 'en_US:en', 15:22:10 INFO - 'LOGNAME': 'cltbld', 15:22:10 INFO - 'MAIL': '/var/mail/cltbld', 15:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:10 INFO - 'MOZ_NO_REMOTE': '1', 15:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:10 INFO - 'NO_EM_RESTART': '1', 15:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:10 INFO - 'PWD': '/builds/slave/test', 15:22:10 INFO - 'SHELL': '/bin/bash', 15:22:10 INFO - 'SHLVL': '1', 15:22:10 INFO - 'TERM': 'linux', 15:22:10 INFO - 'TMOUT': '86400', 15:22:10 INFO - 'USER': 'cltbld', 15:22:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:10 INFO - '_': '/tools/buildbot/bin/python'} 15:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:10 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 15:22:10 INFO - Cleaning up... 15:22:10 INFO - Return code: 0 15:22:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:22:10 INFO - Using env: {'DISPLAY': ':0', 15:22:10 INFO - 'HOME': '/home/cltbld', 15:22:10 INFO - 'LANG': 'en_US.UTF-8', 15:22:10 INFO - 'LANGUAGE': 'en_US:en', 15:22:10 INFO - 'LOGNAME': 'cltbld', 15:22:10 INFO - 'MAIL': '/var/mail/cltbld', 15:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:10 INFO - 'MOZ_NO_REMOTE': '1', 15:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:10 INFO - 'NO_EM_RESTART': '1', 15:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:10 INFO - 'PWD': '/builds/slave/test', 15:22:10 INFO - 'SHELL': '/bin/bash', 15:22:10 INFO - 'SHLVL': '1', 15:22:10 INFO - 'TERM': 'linux', 15:22:10 INFO - 'TMOUT': '86400', 15:22:10 INFO - 'USER': 'cltbld', 15:22:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:10 INFO - '_': '/tools/buildbot/bin/python'} 15:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:10 INFO - Downloading/unpacking psutil>=3.1.1 15:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:13 INFO - Installing collected packages: psutil 15:22:13 INFO - Running setup.py install for psutil 15:22:13 INFO - building 'psutil._psutil_linux' extension 15:22:13 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 15:22:13 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 15:22:13 INFO - building 'psutil._psutil_posix' extension 15:22:13 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 15:22:13 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 15:22:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:13 INFO - Successfully installed psutil 15:22:13 INFO - Cleaning up... 15:22:13 INFO - Return code: 0 15:22:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:13 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 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:13 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 15:22:13 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 15:22:13 INFO - Using env: {'DISPLAY': ':0', 15:22:13 INFO - 'HOME': '/home/cltbld', 15:22:13 INFO - 'LANG': 'en_US.UTF-8', 15:22:13 INFO - 'LANGUAGE': 'en_US:en', 15:22:13 INFO - 'LOGNAME': 'cltbld', 15:22:13 INFO - 'MAIL': '/var/mail/cltbld', 15:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:13 INFO - 'MOZ_NO_REMOTE': '1', 15:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:13 INFO - 'NO_EM_RESTART': '1', 15:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:13 INFO - 'PWD': '/builds/slave/test', 15:22:13 INFO - 'SHELL': '/bin/bash', 15:22:13 INFO - 'SHLVL': '1', 15:22:13 INFO - 'TERM': 'linux', 15:22:13 INFO - 'TMOUT': '86400', 15:22:13 INFO - 'USER': 'cltbld', 15:22:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:13 INFO - '_': '/tools/buildbot/bin/python'} 15:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:22:16 INFO - Installing collected packages: mozsystemmonitor 15:22:16 INFO - Running setup.py install for mozsystemmonitor 15:22:16 INFO - Successfully installed mozsystemmonitor 15:22:16 INFO - Cleaning up... 15:22:16 INFO - Return code: 0 15:22:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:22:16 INFO - Using env: {'DISPLAY': ':0', 15:22:16 INFO - 'HOME': '/home/cltbld', 15:22:16 INFO - 'LANG': 'en_US.UTF-8', 15:22:16 INFO - 'LANGUAGE': 'en_US:en', 15:22:16 INFO - 'LOGNAME': 'cltbld', 15:22:16 INFO - 'MAIL': '/var/mail/cltbld', 15:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:16 INFO - 'MOZ_NO_REMOTE': '1', 15:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:16 INFO - 'NO_EM_RESTART': '1', 15:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:16 INFO - 'PWD': '/builds/slave/test', 15:22:16 INFO - 'SHELL': '/bin/bash', 15:22:16 INFO - 'SHLVL': '1', 15:22:16 INFO - 'TERM': 'linux', 15:22:16 INFO - 'TMOUT': '86400', 15:22:16 INFO - 'USER': 'cltbld', 15:22:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:16 INFO - '_': '/tools/buildbot/bin/python'} 15:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:16 INFO - Downloading/unpacking jsonschema==2.5.1 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:22:18 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 15:22:18 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 15:22:18 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 15:22:18 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 15:22:18 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 15:22:18 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 15:22:18 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:18 INFO - warning: no files found matching '*.txt' 15:22:18 INFO - no previously-included directories found matching 'build' 15:22:18 INFO - no previously-included directories found matching 'dist' 15:22:18 INFO - no previously-included directories found matching '.git*' 15:22:18 INFO - Installing collected packages: jsonschema, functools32 15:22:18 INFO - Running setup.py install for functools32 15:22:18 INFO - warning: no files found matching '*.txt' 15:22:18 INFO - no previously-included directories found matching 'build' 15:22:18 INFO - no previously-included directories found matching 'dist' 15:22:18 INFO - no previously-included directories found matching '.git*' 15:22:18 INFO - Successfully installed jsonschema functools32 15:22:18 INFO - Cleaning up... 15:22:18 INFO - Return code: 0 15:22:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:22:18 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')]} 15:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:18 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')]} 15:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:18 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:18 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:22:18 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 functools32==3.2.3-2 15:22:18 INFO - Using env: {'DISPLAY': ':0', 15:22:18 INFO - 'HOME': '/home/cltbld', 15:22:18 INFO - 'LANG': 'en_US.UTF-8', 15:22:18 INFO - 'LANGUAGE': 'en_US:en', 15:22:18 INFO - 'LOGNAME': 'cltbld', 15:22:18 INFO - 'MAIL': '/var/mail/cltbld', 15:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:18 INFO - 'MOZ_NO_REMOTE': '1', 15:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:18 INFO - 'NO_EM_RESTART': '1', 15:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:18 INFO - 'PWD': '/builds/slave/test', 15:22:18 INFO - 'SHELL': '/bin/bash', 15:22:18 INFO - 'SHLVL': '1', 15:22:18 INFO - 'TERM': 'linux', 15:22:18 INFO - 'TMOUT': '86400', 15:22:18 INFO - 'USER': 'cltbld', 15:22:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:18 INFO - '_': '/tools/buildbot/bin/python'} 15:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:22:19 INFO - Cleaning up... 15:22:19 INFO - Return code: 0 15:22:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22: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 15:22: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 15:22:19 INFO - Using env: {'DISPLAY': ':0', 15:22:19 INFO - 'HOME': '/home/cltbld', 15:22:19 INFO - 'LANG': 'en_US.UTF-8', 15:22:19 INFO - 'LANGUAGE': 'en_US:en', 15:22:19 INFO - 'LOGNAME': 'cltbld', 15:22:19 INFO - 'MAIL': '/var/mail/cltbld', 15:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:19 INFO - 'MOZ_NO_REMOTE': '1', 15:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:19 INFO - 'NO_EM_RESTART': '1', 15:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:19 INFO - 'PWD': '/builds/slave/test', 15:22:19 INFO - 'SHELL': '/bin/bash', 15:22:19 INFO - 'SHLVL': '1', 15:22:19 INFO - 'TERM': 'linux', 15:22:19 INFO - 'TMOUT': '86400', 15:22:19 INFO - 'USER': 'cltbld', 15:22:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:19 INFO - '_': '/tools/buildbot/bin/python'} 15:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:19 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:19 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 15:22:19 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 15:22:19 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 15:22:19 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 15:22:19 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 15:22:19 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 15:22:21 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 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 15:22:21 INFO - Downloading docopt-0.6.1.tar.gz 15:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:21 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:21 INFO - Running setup.py install for blobuploader 15:22:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:22 INFO - Running setup.py install for requests 15:22:22 INFO - Running setup.py install for docopt 15:22:22 INFO - Successfully installed blobuploader requests docopt 15:22:22 INFO - Cleaning up... 15:22:22 INFO - Return code: 0 15:22:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:22 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 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:22 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 15:22:22 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 15:22:22 INFO - Using env: {'DISPLAY': ':0', 15:22:22 INFO - 'HOME': '/home/cltbld', 15:22:22 INFO - 'LANG': 'en_US.UTF-8', 15:22:22 INFO - 'LANGUAGE': 'en_US:en', 15:22:22 INFO - 'LOGNAME': 'cltbld', 15:22:22 INFO - 'MAIL': '/var/mail/cltbld', 15:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:22 INFO - 'MOZ_NO_REMOTE': '1', 15:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:22 INFO - 'NO_EM_RESTART': '1', 15:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:22 INFO - 'PWD': '/builds/slave/test', 15:22:22 INFO - 'SHELL': '/bin/bash', 15:22:22 INFO - 'SHLVL': '1', 15:22:22 INFO - 'TERM': 'linux', 15:22:22 INFO - 'TMOUT': '86400', 15:22:22 INFO - 'USER': 'cltbld', 15:22:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:22 INFO - '_': '/tools/buildbot/bin/python'} 15:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:22 INFO - Running setup.py (path:/tmp/pip-Zl7QCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:22 INFO - Running setup.py (path:/tmp/pip-6tfjew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:22 INFO - Running setup.py (path:/tmp/pip-ohYJtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:22 INFO - Running setup.py (path:/tmp/pip-DrEZtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:23 INFO - Running setup.py (path:/tmp/pip-KifxQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:23 INFO - Running setup.py (path:/tmp/pip-lK0T8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:23 INFO - Running setup.py (path:/tmp/pip-lGNKJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:23 INFO - Running setup.py (path:/tmp/pip-sX76VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:23 INFO - Running setup.py (path:/tmp/pip-9JLIpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:23 INFO - Running setup.py (path:/tmp/pip-k6WQdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:23 INFO - Running setup.py (path:/tmp/pip-N0HqvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:23 INFO - Running setup.py (path:/tmp/pip-2M4NPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:23 INFO - Running setup.py (path:/tmp/pip-Vo7juq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:23 INFO - Running setup.py (path:/tmp/pip-z6bbZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:23 INFO - Running setup.py (path:/tmp/pip-StvFv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:23 INFO - Running setup.py (path:/tmp/pip-DwEvzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:23 INFO - Running setup.py (path:/tmp/pip-igJH0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:23 INFO - Running setup.py install for manifestparser 15:22:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Running setup.py install for mozcrash 15:22:24 INFO - Running setup.py install for mozdebug 15:22:24 INFO - Running setup.py install for mozdevice 15:22:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Running setup.py install for mozfile 15:22:24 INFO - Running setup.py install for mozhttpd 15:22:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Running setup.py install for mozinfo 15:22:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Running setup.py install for mozInstall 15:22:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:24 INFO - Running setup.py install for mozleak 15:22:24 INFO - Running setup.py install for mozlog 15:22:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:25 INFO - Running setup.py install for moznetwork 15:22:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:25 INFO - Running setup.py install for mozprocess 15:22:25 INFO - Running setup.py install for mozprofile 15:22:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:25 INFO - Running setup.py install for mozrunner 15:22:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:25 INFO - Running setup.py install for mozscreenshot 15:22:25 INFO - Running setup.py install for moztest 15:22:25 INFO - Running setup.py install for mozversion 15:22:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:25 INFO - Cleaning up... 15:22:25 INFO - Return code: 0 15:22:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:25 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 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:25 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 15:22:25 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 15:22:25 INFO - Using env: {'DISPLAY': ':0', 15:22:25 INFO - 'HOME': '/home/cltbld', 15:22:25 INFO - 'LANG': 'en_US.UTF-8', 15:22:25 INFO - 'LANGUAGE': 'en_US:en', 15:22:25 INFO - 'LOGNAME': 'cltbld', 15:22:25 INFO - 'MAIL': '/var/mail/cltbld', 15:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:25 INFO - 'MOZ_NO_REMOTE': '1', 15:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:25 INFO - 'NO_EM_RESTART': '1', 15:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:25 INFO - 'PWD': '/builds/slave/test', 15:22:25 INFO - 'SHELL': '/bin/bash', 15:22:25 INFO - 'SHLVL': '1', 15:22:25 INFO - 'TERM': 'linux', 15:22:25 INFO - 'TMOUT': '86400', 15:22:25 INFO - 'USER': 'cltbld', 15:22:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:25 INFO - '_': '/tools/buildbot/bin/python'} 15:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:26 INFO - Running setup.py (path:/tmp/pip-VPOGau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22: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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:26 INFO - Running setup.py (path:/tmp/pip-UXoR4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22: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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:26 INFO - Running setup.py (path:/tmp/pip-pClQgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22: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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:26 INFO - Running setup.py (path:/tmp/pip-C1ZqSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:26 INFO - Running setup.py (path:/tmp/pip-YxD5al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:26 INFO - Running setup.py (path:/tmp/pip-LIM2Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:26 INFO - Running setup.py (path:/tmp/pip-YXZWBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:26 INFO - Running setup.py (path:/tmp/pip-vq5zfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:26 INFO - Running setup.py (path:/tmp/pip-_JnFpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:26 INFO - Running setup.py (path:/tmp/pip-81vEjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:26 INFO - Running setup.py (path:/tmp/pip-I9KoYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:26 INFO - Running setup.py (path:/tmp/pip-_P59Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:26 INFO - Running setup.py (path:/tmp/pip-XE1R12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:26 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)) 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:26 INFO - Running setup.py (path:/tmp/pip-aG4Izy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:27 INFO - Running setup.py (path:/tmp/pip-5tbOck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22: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)) 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:27 INFO - Running setup.py (path:/tmp/pip-uV_6Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22: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)) 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:27 INFO - Running setup.py (path:/tmp/pip-25jzPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22: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)) 15:22: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)) 15:22: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)) 15:22: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)) 15:22: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)) 15:22: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)) 15:22:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22:29 INFO - Downloading blessings-1.6.tar.gz 15:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:29 INFO - Installing collected packages: blessings 15:22:29 INFO - Running setup.py install for blessings 15:22:29 INFO - Successfully installed blessings 15:22:29 INFO - Cleaning up... 15:22:29 INFO - Return code: 0 15:22:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:29 INFO - Reading from file tmpfile_stdout 15:22:29 INFO - Current package versions: 15:22:29 INFO - argparse == 1.2.1 15:22:29 INFO - blessings == 1.6 15:22:29 INFO - blobuploader == 1.2.4 15:22:29 INFO - docopt == 0.6.1 15:22:29 INFO - functools32 == 3.2.3-2 15:22:29 INFO - jsonschema == 2.5.1 15:22:29 INFO - manifestparser == 1.1 15:22:29 INFO - mozInstall == 1.12 15:22:29 INFO - mozcrash == 0.17 15:22:29 INFO - mozdebug == 0.1 15:22:29 INFO - mozdevice == 0.48 15:22:29 INFO - mozfile == 1.2 15:22:29 INFO - mozhttpd == 0.7 15:22:29 INFO - mozinfo == 0.9 15:22:29 INFO - mozleak == 0.1 15:22:29 INFO - mozlog == 3.3 15:22:29 INFO - moznetwork == 0.27 15:22:29 INFO - mozprocess == 0.23 15:22:29 INFO - mozprofile == 0.28 15:22:29 INFO - mozrunner == 6.12 15:22:29 INFO - mozscreenshot == 0.1 15:22:29 INFO - mozsystemmonitor == 0.3 15:22:29 INFO - moztest == 0.7 15:22:29 INFO - mozversion == 1.4 15:22:29 INFO - psutil == 3.1.1 15:22:29 INFO - requests == 1.2.3 15:22:29 INFO - wsgiref == 0.1.2 15:22:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:29 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 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:29 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 15:22:29 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 15:22:29 INFO - Using env: {'DISPLAY': ':0', 15:22:29 INFO - 'HOME': '/home/cltbld', 15:22:29 INFO - 'LANG': 'en_US.UTF-8', 15:22:29 INFO - 'LANGUAGE': 'en_US:en', 15:22:29 INFO - 'LOGNAME': 'cltbld', 15:22:29 INFO - 'MAIL': '/var/mail/cltbld', 15:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:29 INFO - 'MOZ_NO_REMOTE': '1', 15:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:29 INFO - 'NO_EM_RESTART': '1', 15:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:29 INFO - 'PWD': '/builds/slave/test', 15:22:29 INFO - 'SHELL': '/bin/bash', 15:22:29 INFO - 'SHLVL': '1', 15:22:29 INFO - 'TERM': 'linux', 15:22:29 INFO - 'TMOUT': '86400', 15:22:29 INFO - 'USER': 'cltbld', 15:22:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:29 INFO - '_': '/tools/buildbot/bin/python'} 15:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 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)) 15:22:29 INFO - Cleaning up... 15:22:29 INFO - Return code: 0 15:22:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, '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': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', '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 15:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:22:29 INFO - Using env: {'DISPLAY': ':0', 15:22:29 INFO - 'HOME': '/home/cltbld', 15:22:29 INFO - 'LANG': 'en_US.UTF-8', 15:22:29 INFO - 'LANGUAGE': 'en_US:en', 15:22:29 INFO - 'LOGNAME': 'cltbld', 15:22:29 INFO - 'MAIL': '/var/mail/cltbld', 15:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:29 INFO - 'MOZ_NO_REMOTE': '1', 15:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:29 INFO - 'NO_EM_RESTART': '1', 15:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:29 INFO - 'PWD': '/builds/slave/test', 15:22:29 INFO - 'SHELL': '/bin/bash', 15:22:29 INFO - 'SHLVL': '1', 15:22:29 INFO - 'TERM': 'linux', 15:22:29 INFO - 'TMOUT': '86400', 15:22:29 INFO - 'USER': 'cltbld', 15:22:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:29 INFO - '_': '/tools/buildbot/bin/python'} 15:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:22:30 INFO - Cleaning up... 15:22:30 INFO - Return code: 0 15:22:30 INFO - Running post-action listener: _resource_record_post_action 15:22:30 INFO - Running post-action listener: _start_resource_monitoring 15:22:30 INFO - Starting resource monitoring. 15:22:30 INFO - [mozharness: 2016-08-01 22:22:30.067215Z] Finished create-virtualenv step (success) 15:22:30 INFO - [mozharness: 2016-08-01 22:22:30.067694Z] Running install step. 15:22:30 INFO - Running pre-action listener: _resource_record_pre_action 15:22:30 INFO - Running main action method: install 15:22:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:30 INFO - Reading from file tmpfile_stdout 15:22:30 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:30 INFO - Reading from file tmpfile_stdout 15:22:30 INFO - Output received: 15:22:30 INFO - Usage: mozinstall [options] installer 15:22:30 INFO - Options: 15:22:30 INFO - -h, --help show this help message and exit 15:22:30 INFO - -d DEST, --destination=DEST 15:22:30 INFO - Directory to install application into. [default: 15:22:30 INFO - "/builds/slave/test"] 15:22:30 INFO - --app=APP Application being installed. [default: firefox] 15:22:30 INFO - mkdir: /builds/slave/test/build/application 15:22:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:22:47 INFO - Reading from file tmpfile_stdout 15:22:47 INFO - Output received: 15:22:47 INFO - /builds/slave/test/build/application/firefox/firefox 15:22:47 INFO - Running post-action listener: _resource_record_post_action 15:22:47 INFO - [mozharness: 2016-08-01 22:22:47.814631Z] Finished install step (success) 15:22:47 INFO - [mozharness: 2016-08-01 22:22:47.814907Z] Running run-tests step. 15:22:47 INFO - Running pre-action listener: _resource_record_pre_action 15:22:47 INFO - Running main action method: run_tests 15:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:22:47 INFO - Python 2.7.3 15:22:47 INFO - Return code: 0 15:22:47 INFO - grabbing minidump binary from tooltool 15:22:47 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')]} 15:22:47 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 0x21593b0>, '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 0x215a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:22:47 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 15:22:47 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 15:22:47 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 15:22:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:22:47 INFO - Return code: 0 15:22:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:22:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:22:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:22:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:22:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 15:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 15:22:47 INFO - Using env: {'DISPLAY': ':0', 15:22:47 INFO - 'HOME': '/home/cltbld', 15:22:47 INFO - 'LANG': 'en_US.UTF-8', 15:22:47 INFO - 'LANGUAGE': 'en_US:en', 15:22:47 INFO - 'LOGNAME': 'cltbld', 15:22:47 INFO - 'MAIL': '/var/mail/cltbld', 15:22:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:47 INFO - 'MOZ_NO_REMOTE': '1', 15:22:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:47 INFO - 'NO_EM_RESTART': '1', 15:22:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:47 INFO - 'PWD': '/builds/slave/test', 15:22:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:47 INFO - 'SHELL': '/bin/bash', 15:22:47 INFO - 'SHLVL': '1', 15:22:47 INFO - 'TERM': 'linux', 15:22:47 INFO - 'TMOUT': '86400', 15:22:47 INFO - 'USER': 'cltbld', 15:22:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514', 15:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:47 INFO - '_': '/tools/buildbot/bin/python'} 15:22:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 15:22:48 INFO - mozversion application_buildid: 20160801123003 15:22:48 INFO - mozversion application_changeset: 6db7f11e05a65cc53a3e4b102963ec243a8c0fdc 15:22:48 INFO - mozversion application_display_name: Nightly 15:22:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:22:48 INFO - mozversion application_name: Firefox 15:22:48 INFO - mozversion application_remotingname: firefox 15:22:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:22:48 INFO - mozversion application_vendor: Mozilla 15:22:48 INFO - mozversion application_version: 50.0a1 15:22:48 INFO - mozversion platform_buildid: 20160801123003 15:22:48 INFO - mozversion platform_changeset: 6db7f11e05a65cc53a3e4b102963ec243a8c0fdc 15:22:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:22:48 INFO - mozversion platform_version: 50.0a1 15:22:48 INFO - using testdate: 1470090168 15:22:48 INFO - actual date: 1470090168 15:22:48 INFO - starting webserver on 'localhost:50943' 15:22:48 INFO - SUITE-START | Running 2 tests 15:22:48 INFO - TEST-START | dromaeo_css 15:22:48 INFO - operating with platform_type : linux_ 15:22:48 INFO - Initialising browser for dromaeo_css test... 15:22:48 INFO - TEST-INFO | started process 32756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQe37Yt/profile http://localhost:50943/getInfo.html) 15:22:52 INFO - PROCESS | 32756 | __metrics Screen width/height:1600/1200 15:22:52 INFO - PROCESS | 32756 | colorDepth:24 15:22:52 INFO - PROCESS | 32756 | Browser inner width/height: 1024/697 15:22:52 INFO - PROCESS | 32756 | __metrics 15:22:53 ERROR - PROCESS | 32756 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:22:54 INFO - TEST-INFO | 32756: exit 0 15:22:54 INFO - Browser initialized. 15:22:54 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:54 INFO - TEST-INFO | started process 410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQe37Yt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:05 INFO - PROCESS | 410 | RSS: Main: 163233792 15:23:05 INFO - PROCESS | 410 | 15:23:55 INFO - PROCESS | 410 | 1470090235549 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] 15:26:03 INFO - PROCESS | 410 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50943/tests/dromaeo/cssquery-ext.html) 15:26:04 INFO - PROCESS | 410 | RSS: Main: 168390656 15:26:04 INFO - PROCESS | 410 | 15:29:06 INFO - PROCESS | 410 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-ext.html (next: http://localhost:50943/tests/dromaeo/cssquery-jquery.html) 15:29:07 INFO - PROCESS | 410 | RSS: Main: 164855808 15:29:07 INFO - PROCESS | 410 | 15:32:09 INFO - PROCESS | 410 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50943/tests/dromaeo/cssquery-mootools.html) 15:32:09 INFO - PROCESS | 410 | RSS: Main: 169316352 15:32:09 INFO - PROCESS | 410 | 15:35:11 INFO - PROCESS | 410 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50943/tests/dromaeo/cssquery-prototype.html) 15:35:12 INFO - PROCESS | 410 | RSS: Main: 163409920 15:35:12 INFO - PROCESS | 410 | 15:38:14 INFO - PROCESS | 410 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50943/tests/dromaeo/cssquery-yui.html) 15:38:15 INFO - PROCESS | 410 | RSS: Main: 166187008 15:38:15 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-yui.html (next: http://localhost:50943/tests/dromaeo/cssquery-dojo.html) 15:41:18 INFO - PROCESS | 410 | RSS: Main: 169091072 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | __start_tp_report 15:41:18 INFO - PROCESS | 410 | _x_x_mozilla_page_load 15:41:18 INFO - PROCESS | 410 | _x_x_mozilla_page_load_details 15:41:18 INFO - PROCESS | 410 | |i|pagename|runs| 15:41:18 INFO - PROCESS | 410 | |0;dojo.html;2992.0425463851566;3056.801307914984;3062.6784187660296;3079.615048118985;3088.9845550772243;5271.051210782067;5307.097793375126;5369.409364969855;5379.139337705968;5428.647137936031;5380.515753582177;5385.569154467643;5399.757010934508;5406.135018397057;5409.377921539024;4813.8796530086765;4835.468098509161;4840.903181936359;4872.853814385574;4910.901781964359;4900.338454308659;4926.359573255471;4932.8520144395725;4939.110960027194;4944.653874228806;502.2566036312064;4924.335214745999;4991.875203119915;4992.750362481879;5046.82336118236;4916.385451818523;4951.876203094916;4979.1784355581285;4980.576650984671;4985.576226020793;4887.975560122212;4889.33993910821;4895.388076490439;4907.337509436216;4931.0630980113665;5184.066867963803;5393.325834270716;5394.379646340682;5418.566514678816;5421.701806400646;5643.294588176478;5695.743691533891;5703.116017017369;5740.5981581289325;5751.8562035949435;5766.682832444256;5784.942150578482;5785.334686511021;5785.8553536161935;5792.710364481759;5222.033923724123;5325.733713314319;5352.304200453916;5358.33020872391;5363.517283444508;5727.656340619576;5746.310442746897;5776.537876969833;5828.591998560145;5891.646501209942;5527.309086364205;5567.053600887859;5582.27430434041;5621;5644.604877658525;5533.557315414757;5679.8864022720145;5690.658560486384;5701.914471282934;5709.286339207599;5642;5646.407127251579;5648.322201335866;5745.4541818528005;5746.88506229873;5686.232358631614;5715.885682286331;5728.914066289009;5732.541396688255;5739.741711622987;4328.740275583412;4414.514403415622;4430.490493593214;4433.312836510346;4470.552944705503;3868.941965870514;3928.8821335359985;3943.743656662308;3952.980235098806;3983.42240375144;5456.91814622781;5548.9722551387795;5583.69289689071;5587.720613969285;5589.133684278943;5696.572757043238;5743.684097374685;5837.503812176013;5839.124131380242;5841.269841269841;5521.116621340566;5569.498745112959;5572;5598.692071936082;5623.493885550239;5046.7476626168545;5046.949530504648;5048.545630893237;5052.595792336604;5091.389033315952;5776.3068431787615;5862.296524417012;5992.970035149797;6006.249218847644;6010.4891084258325;5705.486506214461;5795.594308398372;5807.245058142415;5817.301923769175;5841.561882858718;5896.14505896634;5942.6731529766275;5943.554233432596;5953.464188223081;5953.613015154001;5601.29983752031;5616.157576363578;5682.715864206856;5685.204071430086;5686.402927692533;5726.856828579319;5790.783935373619;5832.825015249549;5847.94152058491;5880.14737863016;5661.518770904519;5689.459501347531;5697.202391665253;5700;5703.372629010889;5553.194786755978;5571.164325351229;5664.688442135722;5676.460736230051;5699.886002279848;5580.972095139498;5617.943820561742;5618.044932361427;5647.1529270609735;5684.9431505684415;5641.210230567806;5643.633163844337;5715.714214289185;5722.914156287742;5724.971375143097;5413.350397952271;5483.643563168382;5490.286262785812;5602.411746766531;5603.495685388171 15:41:18 INFO - PROCESS | 410 | |1;ext.html;560.0471013972456;578.4562511239435;598.8622616798134;606.878624275145;636.828056424765;39292.607073929255;43207;43447.131057378836;43517.78241108798;43529.564704352946;44181.55818441814;44713.776431117796;44850.775746121304;44871;45025;8846.292296616288;8979.102089791035;8983.820323593523;8998.100189981014;9022.593983270768;8957.14907083826;9025.864612030824;9056.230220431238;9096.681616143436;9105.408148470362;9116.544172791368;9151.542422878863;9154.404963677373;9161.358704890661;9199.678011269607;9089.454632722058;9097.545122743903;9112.088791120836;9121.771955701128;9133;8963.46219226842;8997.86503202446;9029.54852257391;9032.548372581345;9053.547322633907;42006;42141.78929105335;42384.36423453651;42388.57611423877;42522;3021.743151832097;3508.122969257686;3672.4491326301;3687.225682606656;3737.009692431508;32437;33900.660993389996;34771.13072173216;35286;35526.467102993476;4438.467383913951;4491.550844915482;4549.61328287096;4553.127243026521;4795.784189711471;354588;360005;360856;361819;363276.18361908285;64833;65818;65926;66066.33933660602;66161;36613.81693091518;37357.43963840545;68438.20932534775;68980.6550967252;69357.30642693609;15056.548303550911;15215.695686086216;15374.615634609001;15376.308066137051;15417;10516.211284153718;10588.682339529827;10590.89409105899;10591.682249532527;10635.202359823044;20727.8963605181;20773.169073237204;20866;21012.474688132614;21081.78918210829;7663.885041724378;7729.1884352142215;7964.301062373228;7966;8146.348292136615;967.3905439573165;1014.4471263161595;1123.230587047875;1142.5144313666824;1170.3212136960542;32799.180020499676;33656.1585960348;33730.66269337275;33796.49305260423;33843.830780845936;1066.6959916423782;1084.669175901342;1108.700650824273;1108.9667309980714;1152.0610702277784;16892;17348.13259337028;17415.80265985386;17461.912690436722;17477.38829140974;582732;584315;584554;586834;590664;58817;58868;59581.702091489264;59955.40044599498;60046.099308510406;1312.3569450968957;1313.343328335832;1327.774278372679;1353.5465619017543;1355.4103964775354;30474.695253047186;32522.674773251965;32652.673473265913;33094.83452582722;33210.5018424719;51488;54060.18909716436;55867.441325587846;55877.72061139668;61702.69148654408;524069;529386;530905;531933;532134;45057.549424505334;45547.77226113848;45685.77157114193;45972;46303;49318.75340623274;49562.50437495579;49984.250236247215;50254.246186306504;50956.23565646593;41458.79270603628;41534.79232603818;42557.36163957605;44232;44379;41502.377464338664;41981.37027944644;42173.578264218195;42263.78868105763;43441.565584345015;35251;42517.57482425136;44625.776871115435;45565.31652025288;45669.314960274955;39638.47899551044;45944.31083533817;45959.31061034154;47293.29060064033;47844.521554784005;36072.27855442929;36324;36416;36573.45139822851;36787.08032299214 15:41:18 INFO - PROCESS | 410 | |2;jquery.html;365.7604269203671;374.4918649888912;398.42427691985085;401.544247279338;414.57713132604727;18440.907795461037;19912;20249.291274805386;20298.289559865407;20681.379558613266;18337.358192463267;18887.338943136994;18988.62022759544;19566.510837229078;19968;5133.409657889334;5276.683398996053;5281.788728450877;5316.548093412045;5339.172428273624;5091.490850914897;5225.163973764198;5231.398389185254;5257.36911570612;5267.183586544073;5225.921611175835;5230.1108811501945;5585.692786896719;5706.572007099463;5730.398308177644;5680.9715951420185;5703.17303990919;5728.828135155952;5739.426057394248;5741.684207368593;4894.853154405374;4908;4918.704877707349;4963.081829861487;5025.949740502621;12973.221606703628;13356.799648005288;13386.665333366744;20114.29599964009;23061.423464413358;2280.851744636593;2332.825038122148;2355.587772139869;2489.8132640052067;2616.921492355232;10001.39991600499;10496.580136794519;12619.864212220944;13562.254076025814;14176.794972427357;1899.5251187203198;1926.422073377995;1965.5184479802397;1991.5519008223034;2041.336565616166;79878;82672.58663706643;83766.58116709438;84482.57758711229;86705.56647216724;10461.424621645883;10587.417692027013;10683.358998460117;10800.351978881292;10987;14366.928165359106;14391;14395.42418303277;14407.42370305176;14414.711705765825;7314.195438501761;7473.813154671068;7525.586092764841;7719.421043421766;7749.217679933647;7080.858382832314;7140.214576396592;7300.525465844703;7356.1540422850985;7357.5217610855125;4314.662454639072;4395.582419670126;4401.669874759342;4554.225781617133;4583.129205450954;1869.3083559083227;1875.0093006413808;1980.4454752669276;1998.530345368837;2037.3378651937883;864.8140649760331;986.8125056239292;1025.7589466475372;1040.4485622620023;1082.929609575375;19638.170556741297;20249.29127480531;20297.391078267676;20370.694439583418;20470.692939605917;984.9852252216223;1011.7470632341915;1016.6238491758097;1020.285799940045;1020.9948950255201;10655.467226638637;11191.16066295015;11207.60773372928;11269.66191014271;11303.795759826755;477533;487270;487620;490990;491068;87388;89245;89702.55148724215;89951.55024224837;91009.54495227613;984.9556769945369;1005.607812952949;1020.1787561013456;1033.7415646088477;1040.698197522725;14319.355628996513;17155.31378744886;17834.91082544579;17839.197236124666;17988.640227195643;42169.36745948875;42623.14753704846;42858.357124642534;43107.568924310355;43217.3517397233;59419;59725;60487.69756151191;61224.38775612187;61891;7975.680972761256;8059.959700201462;8261.339092872677;8483.06686264498;8533.317334613092;12594.622161335175;12727.490900364252;13517.526886558922;13677.589672309847;13834.515791947233;11567.71080722955;11725.41372931367;12154.696132596755;12231.082668800054;12540;11634.767304653691;11854.407279636156;11888.34614096233;12304.446299916704;12604.621861344174;12175.939120304341;12250.509979601073;12310.75378492443;12379.93810030944;12560.37198140071;8214.219649133323;8304.418690691593;8314.584270786558;8551.230389264996;8557.058723540282;10988;11548.191626586058;11820.468078936297;11836.70408239801;11925.449691540045 15:41:18 INFO - PROCESS | 410 | |3;mootools.html;1479.319513024009;1484.4952716076534;1614.951551453456;1764.7705798246234;1765.135083808934;7694.30751232389;8000.639971201295;8358.205970432815;8528.104549022348;8556.572171391428;8418.200270974263;8678.956605216981;8682.392232543709;8688.522131282776;8697.652093916251;2277;2283.6460348645987;2290.931272061841;2292.1862738727764;2292.977070229293;2246.4383904023994;2279.9202027929027;2300.66640337151;2315.4211447138214;2317.9072837086496;2239.6864438978555;2243.349428665685;2243.977560224393;2271.647894576335;2282.6005449046434;2200.8569442986313;2201.7908298711595;2214.6788715636144;2226.065052677879;2230.4200907763934;2172.913083476659;2187.0814258011674;2187.9671804922937;2191.5069109450405;2193.6270833958265;8634.78413039679;8691.39160258782;8737.694180703646;8747.956260218658;8768.956155219183;4959.70241785494;5073.898522029539;5077.060743762416;5082.847514574569;5093.898122037538;3111.3466172103886;3285.720713739335;3404.7446441516986;3425.7088147507493;3456.827158642058;1067.6690226029955;1096.3641088168843;1112.2436743014746;1123.8033344164821;1133.3313345126414;11823.763524729544;11939.940300298444;11956.40217989097;11974.760504789856;11983.340916249603;4259.42497762798;4299.935500967488;4483.551644835556;4516.322551617283;4534.410526631516;9890.307678462439;9966.700998969898;9974.202063834875;9987.151092157103;9998.150157236716;5154.381474223117;5158.329417175743;5161.716105614228;5161.896762064737;5172.767225474862;4125.690573207022;4683.110209060335;4729.976350118227;4744.620430365562;4766.809327626856;3850.595687452777;3936.2521120987494;3978.622030907059;4021.678265738734;4042.6159514846045;1192.9463174157183;1211.2671833540758;1220.7009282725612;1223.8190146508662;1242.8073648584302;868.2749903830372;961.8364877970762;991.5835349153373;1002.178213864624;1043.8695163104612;5784.59507834456;6083.148359229712;6196.8760624787255;6209.223847019122;6273.153124328249;383.89826695925603;383.95776464588874;389.50143815915675;392.9332013557702;396.631133046264;4199.853005144805;4215.156968606291;4228.302330115496;4239.1521695660995;4270.402143699885;10341.37951722899;10576.682699519026;10619.84070238947;10628.627998020032;10660.09389201911;10481.895181048245;10546.683599492027;10563.524641391155;10601.787964240671;10624.946875265574;7954.085280192736;8032.879506807402;8292.875606865902;8316.334693224528;8484.684873844688;6108.35862234459;6123.203983482119;6249.093881387083;6283.560150789401;6299.590526615755;9953.104220620178;10081.596736130472;10086.243531735296;10088.243381746252;10117.747056323356;10029.648962286285;10166.390016599027;10311.123554497952;10382.636607718996;10553.736156596147;6980.825479363057;7580.9620951894885;7686.615669216629;7750.263724946121;7795.376369890509;8565.400421970402;8594.699185528476;8630.741077767678;8649.221570058726;8661.307095432225;7529.962350188214;7542.660580273791;7727.381809455343;7779.883301750591;7878.881816772868;7556.055493063367;7567.356774674215;7629.809254768453;7687.231276872268;7858.528488290721;7077.964610176916;7195.532290401107;7196.0285361475535;7197.676104575202;7204.423646108194;5114.360704911886;5129.230615407719;5223.582113430993;5283.524482796567;5476.534494568006;5227.477252274894;5291.365036195682;5339.519443250126;5372.516473517402;5642.492175704207 15:41:18 INFO - PROCESS | 410 | |4;prototype.html;303.9863206155724;317.4587328604729;322.22665602553866;323.01828283480836;325.4126302024846;5358.33020872391;5457.781688732446;5576.302962129734;5619.381867994517;5634.352049514302;5449.373322067963;5531.502164805167;5555.8888822223535;5568.470995255454;5568.7215639217975;4299.247631664454;4303.483581970168;4311.5472875348105;4317.747853122591;4318.589733975267;4157.6695457453625;4239.915201695964;4292.862391466264;4309.762963037032;4311.8789114830215;4248.468941382327;4253.191893540217;4257.638100761439;4283.550227226143;4284.6786491013145;4217.177650358181;4246.384274280227;4256.191323648528;4316.5467625899455;4320.1575692739925;3691.963080369189;3765.4728338032423;3783.659470647655;3795.1271207622126;3795.411711184771;5364.022967253173;5376;5376.623636345457;5378.596605254583;5408;4881.341018962466;4887.218045112765;4889.2910527973245;4903.401197365366;4917.434495033045;5521.4478552144865;5729.169270455803;5731.882282954825;5745.540356771448;5822.097574875901;4061.8375264989363;4072.5316588592395;4082.4896887889013;4088.3850878902963;4103.876883693494;6002.699865006733;6045.637261764308;6071.210742603434;6094.847628809271;6120.418560236771;3880.2239552089695;4072.470578824793;4199.517055538652;4210.473690788652;4216.810243539048;4154.543000269968;4160.167966406731;4174.853880114181;4178.623923846869;4186.979065104716;4808.927866082012;4818.807247710052;4835.298881662139;4856.611471082305;4866.099771542205;5656.606036378223;5811.767529298781;5848.561357898175;5866.6480011199465;5886.675498012998;1427.9928600357139;1444.3861358922416;1445.407382972976;1447;1447.2257342321807;874.7681864305964;899.4827973915025;909.3679892474667;921.3780698028804;929.4330458420358;4889.975550122298;4894.1402267138255;4925.876853078702;4930.605551555867;4931.337077977852;5132.204508301219;5204.531592156724;5241.606879484054;5269.1569348903995;5315.255864179018;4709.3877795887;4892.559669629679;4962.732050436622;4971.726555039508;5012.598992080625;2716.4295497945654;2765.8893644254003;2792.3856751514636;2794.3712664650293;2811.4236581500745;5404.594655400782;5406.269514175096;5468.453154684579;5486.807961721321;5527.098273406494;5128.00003999224;5298.576113910878;5306.575473962073;5318.228856815817;5422.186671999231;5359.490848369476;5451.781928722886;5486.670799752028;5496.615236933456;5500.972495137578;5257;5268.78924843002;5276.788928442819;5345.572354211731;5348.7907255646305;4824.831130910401;5043.722595257296;5082.009008243505;5114;5161.638685291993;5386.114859799039;5397.166487594044;5437.4018857926385;5442.591805614674;5444.156155795858;3880.447820871674;3982.980085099556;4066.6543343816106;4077.510698716173;4092.4066010427728;5845.386234445322;5869.354371019099;5894.852628684145;5904.852378690395;5916.645001299936;5474.397816240131;5738.655680659007;5742.712864356849;5763.740631671669;5820.854478638068;5787.56593255516;5824.592278540462;5860.38465961068;5871.882562348644;5888.293404791452;5769.826905192851;5803.912941305968;5824.5631577631;5835.912461312999;5858.912116318344;5705.62913410627;5802;5855.824325270249;5870.911936321044;5884.440978107073;5734.139879018181;5749.396313387034;5762.711864406679;5803;5808.506276966336 15:41:18 INFO - PROCESS | 410 | |5;yui.html;701.866645337386;743.2456057102039;781.3514782730334;790.0203747353282;860.3676297921031;15755.606109847246;16494.34022639096;16525.50423487296;16541;16573;15191.696166076672;15240.771388429155;15303.846961530382;15310.617234569141;15443.382264709426;662.374056516592;797.3939805747644;805.5207151744717;817.0318172965056;822.8230930349973;808.5310519898475;812.0580127052621;813.0852790610563;813.9064007639138;819.7622689420091;874.8512752832002;883.5405589093667;883.6862913665652;885.0972008551274;886.3751055505853;878.8549889268263;879.5821984557316;880.3045593980779;881.9338549608805;883.3728053082319;640.6636515829181;642.3223499208333;644.1818890009662;644.6422235659207;645.370763505583;15193.544193674208;15238.542843714595;15244.161571113584;15253.466128685553;15270.236488175547;15015.699686006328;15201.239938003055;15255.618609534851;15318.540443786704;15536.378544858193;11917.821232681517;12227.938860305641;12274.570390036306;12468.251904885736;12604.180728252726;3927.6661483773914;3982.2234664240486;4070.5115386153852;4142.606452387018;4144.212599606065;82464;82477;84488.57755711181;84781.57609211977;89491.10508894893;11706.824397633873;12089.576864809866;12093.758124837454;12303.077269204845;12354.07344449152;22789.658155127687;22807.885960570424;22942;23021.309360719206;23093.53812923732;8892.644294228288;8970.147835955573;9025.277977761763;9088.727338179866;9112.271018318519;4946.629002824802;5063.3923929128005;5103.106956282636;5199.168133098686;5230.3985041719925;3460.1003739028033;3580.946285805715;3581.3553560358864;3582.802945837952;3585.6593623606236;605.8606520500309;611.8776244751068;613.6716856481761;616.0543565626741;616.8581226317972;565.2679779685317;738.5900825042046;746.5408773604195;754.6717178027576;758.8167636763833;9617.56720947545;9881.308308418342;9943.403395796275;10076.647317343857;10105.545250463747;657.2211928864216;666.8966310221826;716.9032180655649;733.3986131372224;752.5259086775296;4673.252279635242;4804.495527969582;4842.7336496493035;4877.5366340197625;4877.902441951142;74404;127069;129634;131583;136237;64185;67574.32425675681;68553;103084.48457757663;108477;95021.52489237509;101315.4934225339;101965.49017254866;102842.48578757058;103538;9017;9527.428354298765;9539.141477266801;9542.188913942115;9624.181944534794;56081.71959140178;56464.717676411354;56859;57353.713231433576;57550.42449575618;83021.58489207758;86470;87335;88295.55852220698;88994;12381.195222310522;12897.742045158857;13034.152780069266;13323.66690832737;13937.30313484342;14226.786598200828;14344.641383965485;14373.800157746602;14537.273136343352;15027.849721502645;12519.123661343983;12610.936945315214;12861.742765144832;13757;13852.792208117087;12714.995667719073;12999.480020799063;13075.607731768063;13373.130746501447;13883.375248113656;12355.75288494243;12404.751904962031;12523.311217883103;13316.394638506179;13476.056676032584;10524.36853788775;10550.366977981346;11055;11101.777964440827;11203.15976301797;10130.290879638354;11142.944285278521;11200;11243.494042767932;11388.94305528467 15:41:18 INFO - PROCESS | 410 | __end_tp_report 15:41:18 INFO - PROCESS | 410 | __start_cc_report 15:41:18 INFO - PROCESS | 410 | _x_x_mozilla_cycle_collect,336 15:41:18 INFO - PROCESS | 410 | __end_cc_report 15:41:18 INFO - PROCESS | 410 | __startTimestamp1470091278602__endTimestamp 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | ------- Summary: start ------- 15:41:18 INFO - PROCESS | 410 | Number of tests: 6 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | [#0] dojo.html Cycles:165 Average:5327.13 Median:5589.13 stddev:712.86 (12.8%) stddev-sans-first:691.11 15:41:18 INFO - PROCESS | 410 | Values: 2992.0 3056.8 3062.7 3079.6 3089.0 5271.1 5307.1 5369.4 5379.1 5428.6 5380.5 5385.6 5399.8 5406.1 5409.4 4813.9 4835.5 4840.9 4872.9 4910.9 4900.3 4926.4 4932.9 4939.1 4944.7 502.3 4924.3 4991.9 4992.8 5046.8 4916.4 4951.9 4979.2 4980.6 4985.6 4888.0 4889.3 4895.4 4907.3 4931.1 5184.1 5393.3 5394.4 5418.6 5421.7 5643.3 5695.7 5703.1 5740.6 5751.9 5766.7 5784.9 5785.3 5785.9 5792.7 5222.0 5325.7 5352.3 5358.3 5363.5 5727.7 5746.3 5776.5 5828.6 5891.6 5527.3 5567.1 5582.3 5621.0 5644.6 5533.6 5679.9 5690.7 5701.9 5709.3 5642.0 5646.4 5648.3 5745.5 5746.9 5686.2 5715.9 5728.9 5732.5 5739.7 4328.7 4414.5 4430.5 4433.3 4470.6 3868.9 3928.9 3943.7 3953.0 3983.4 5456.9 5549.0 5583.7 5587.7 5589.1 5696.6 5743.7 5837.5 5839.1 5841.3 5521.1 5569.5 5572.0 5598.7 5623.5 5046.7 5046.9 5048.5 5052.6 5091.4 5776.3 5862.3 5993.0 6006.2 6010.5 5705.5 5795.6 5807.2 5817.3 5841.6 5896.1 5942.7 5943.6 5953.5 5953.6 5601.3 5616.2 5682.7 5685.2 5686.4 5726.9 5790.8 5832.8 5847.9 5880.1 5661.5 5689.5 5697.2 5700.0 5703.4 5553.2 5571.2 5664.7 5676.5 5699.9 5581.0 5617.9 5618.0 5647.2 5684.9 5641.2 5643.6 5715.7 5722.9 5725.0 5413.4 5483.6 5490.3 5602.4 5603.5 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | [#1] ext.html Cycles:180 Average:66042.94 Median:24532.12 stddev:133163.56 (542.8%) stddev-sans-first:133446.36 15:41:18 INFO - PROCESS | 410 | Values: 560.0 578.5 598.9 606.9 636.8 39292.6 43207.0 43447.1 43517.8 43529.6 44181.6 44713.8 44850.8 44871.0 45025.0 8846.3 8979.1 8983.8 8998.1 9022.6 8957.1 9025.9 9056.2 9096.7 9105.4 9116.5 9151.5 9154.4 9161.4 9199.7 9089.5 9097.5 9112.1 9121.8 9133.0 8963.5 8997.9 9029.5 9032.5 9053.5 42006.0 42141.8 42384.4 42388.6 42522.0 3021.7 3508.1 3672.4 3687.2 3737.0 32437.0 33900.7 34771.1 35286.0 35526.5 4438.5 4491.6 4549.6 4553.1 4795.8 354588.0 360005.0 360856.0 361819.0 363276.2 64833.0 65818.0 65926.0 66066.3 66161.0 36613.8 37357.4 68438.2 68980.7 69357.3 15056.5 15215.7 15374.6 15376.3 15417.0 10516.2 10588.7 10590.9 10591.7 10635.2 20727.9 20773.2 20866.0 21012.5 21081.8 7663.9 7729.2 7964.3 7966.0 8146.3 967.4 1014.4 1123.2 1142.5 1170.3 32799.2 33656.2 33730.7 33796.5 33843.8 1066.7 1084.7 1108.7 1109.0 1152.1 16892.0 17348.1 17415.8 17461.9 17477.4 582732.0 584315.0 584554.0 586834.0 590664.0 58817.0 58868.0 59581.7 59955.4 60046.1 1312.4 1313.3 1327.8 1353.5 1355.4 30474.7 32522.7 32652.7 33094.8 33210.5 51488.0 54060.2 55867.4 55877.7 61702.7 524069.0 529386.0 530905.0 531933.0 532134.0 45057.5 45547.8 45685.8 45972.0 46303.0 49318.8 49562.5 49984.3 50254.2 50956.2 41458.8 41534.8 42557.4 44232.0 44379.0 41502.4 41981.4 42173.6 42263.8 43441.6 35251.0 42517.6 44625.8 45565.3 45669.3 39638.5 45944.3 45959.3 47293.3 47844.5 36072.3 36324.0 36416.0 36573.5 36787.1 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | [#2] jquery.html Cycles:180 Average:28836.15 Median:12671.14 stddev:80357.66 (634.2%) stddev-sans-first:80554.65 15:41:18 INFO - PROCESS | 410 | Values: 365.8 374.5 398.4 401.5 414.6 18440.9 19912.0 20249.3 20298.3 20681.4 18337.4 18887.3 18988.6 19566.5 19968.0 5133.4 5276.7 5281.8 5316.5 5339.2 5091.5 5225.2 5231.4 5257.4 5267.2 5225.9 5230.1 5585.7 5706.6 5730.4 5681.0 5703.2 5728.8 5739.4 5741.7 4894.9 4908.0 4918.7 4963.1 5025.9 12973.2 13356.8 13386.7 20114.3 23061.4 2280.9 2332.8 2355.6 2489.8 2616.9 10001.4 10496.6 12619.9 13562.3 14176.8 1899.5 1926.4 1965.5 1991.6 2041.3 79878.0 82672.6 83766.6 84482.6 86705.6 10461.4 10587.4 10683.4 10800.4 10987.0 14366.9 14391.0 14395.4 14407.4 14414.7 7314.2 7473.8 7525.6 7719.4 7749.2 7080.9 7140.2 7300.5 7356.2 7357.5 4314.7 4395.6 4401.7 4554.2 4583.1 1869.3 1875.0 1980.4 1998.5 2037.3 864.8 986.8 1025.8 1040.4 1082.9 19638.2 20249.3 20297.4 20370.7 20470.7 985.0 1011.7 1016.6 1020.3 1021.0 10655.5 11191.2 11207.6 11269.7 11303.8 477533.0 487270.0 487620.0 490990.0 491068.0 87388.0 89245.0 89702.6 89951.6 91009.5 985.0 1005.6 1020.2 1033.7 1040.7 14319.4 17155.3 17834.9 17839.2 17988.6 42169.4 42623.1 42858.4 43107.6 43217.4 59419.0 59725.0 60487.7 61224.4 61891.0 7975.7 8060.0 8261.3 8483.1 8533.3 12594.6 12727.5 13517.5 13677.6 13834.5 11567.7 11725.4 12154.7 12231.1 12540.0 11634.8 11854.4 11888.3 12304.4 12604.6 12175.9 12250.5 12310.8 12379.9 12560.4 8214.2 8304.4 8314.6 8551.2 8557.1 10988.0 11548.2 11820.5 11836.7 11925.4 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | [#3] mootools.html Cycles:180 Average:5726.41 Median:4525.37 stddev:3259.65 (72.0%) stddev-sans-first:3253.17 15:41:18 INFO - PROCESS | 410 | Values: 1479.3 1484.5 1615.0 1764.8 1765.1 7694.3 8000.6 8358.2 8528.1 8556.6 8418.2 8679.0 8682.4 8688.5 8697.7 2277.0 2283.6 2290.9 2292.2 2293.0 2246.4 2279.9 2300.7 2315.4 2317.9 2239.7 2243.3 2244.0 2271.6 2282.6 2200.9 2201.8 2214.7 2226.1 2230.4 2172.9 2187.1 2188.0 2191.5 2193.6 8634.8 8691.4 8737.7 8748.0 8769.0 4959.7 5073.9 5077.1 5082.8 5093.9 3111.3 3285.7 3404.7 3425.7 3456.8 1067.7 1096.4 1112.2 1123.8 1133.3 11823.8 11939.9 11956.4 11974.8 11983.3 4259.4 4299.9 4483.6 4516.3 4534.4 9890.3 9966.7 9974.2 9987.2 9998.2 5154.4 5158.3 5161.7 5161.9 5172.8 4125.7 4683.1 4730.0 4744.6 4766.8 3850.6 3936.3 3978.6 4021.7 4042.6 1192.9 1211.3 1220.7 1223.8 1242.8 868.3 961.8 991.6 1002.2 1043.9 5784.6 6083.1 6196.9 6209.2 6273.2 383.9 384.0 389.5 392.9 396.6 4199.9 4215.2 4228.3 4239.2 4270.4 10341.4 10576.7 10619.8 10628.6 10660.1 10481.9 10546.7 10563.5 10601.8 10624.9 7954.1 8032.9 8292.9 8316.3 8484.7 6108.4 6123.2 6249.1 6283.6 6299.6 9953.1 10081.6 10086.2 10088.2 10117.7 10029.6 10166.4 10311.1 10382.6 10553.7 6980.8 7581.0 7686.6 7750.3 7795.4 8565.4 8594.7 8630.7 8649.2 8661.3 7530.0 7542.7 7727.4 7779.9 7878.9 7556.1 7567.4 7629.8 7687.2 7858.5 7078.0 7195.5 7196.0 7197.7 7204.4 5114.4 5129.2 5223.6 5283.5 5476.5 5227.5 5291.4 5339.5 5372.5 5642.5 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | [#4] prototype.html Cycles:180 Average:4676.86 Median:5268.97 stddev:1371.89 (26.0%) stddev-sans-first:1335.90 15:41:18 INFO - PROCESS | 410 | Values: 304.0 317.5 322.2 323.0 325.4 5358.3 5457.8 5576.3 5619.4 5634.4 5449.4 5531.5 5555.9 5568.5 5568.7 4299.2 4303.5 4311.5 4317.7 4318.6 4157.7 4239.9 4292.9 4309.8 4311.9 4248.5 4253.2 4257.6 4283.6 4284.7 4217.2 4246.4 4256.2 4316.5 4320.2 3692.0 3765.5 3783.7 3795.1 3795.4 5364.0 5376.0 5376.6 5378.6 5408.0 4881.3 4887.2 4889.3 4903.4 4917.4 5521.4 5729.2 5731.9 5745.5 5822.1 4061.8 4072.5 4082.5 4088.4 4103.9 6002.7 6045.6 6071.2 6094.8 6120.4 3880.2 4072.5 4199.5 4210.5 4216.8 4154.5 4160.2 4174.9 4178.6 4187.0 4808.9 4818.8 4835.3 4856.6 4866.1 5656.6 5811.8 5848.6 5866.6 5886.7 1428.0 1444.4 1445.4 1447.0 1447.2 874.8 899.5 909.4 921.4 929.4 4890.0 4894.1 4925.9 4930.6 4931.3 5132.2 5204.5 5241.6 5269.2 5315.3 4709.4 4892.6 4962.7 4971.7 5012.6 2716.4 2765.9 2792.4 2794.4 2811.4 5404.6 5406.3 5468.5 5486.8 5527.1 5128.0 5298.6 5306.6 5318.2 5422.2 5359.5 5451.8 5486.7 5496.6 5501.0 5257.0 5268.8 5276.8 5345.6 5348.8 4824.8 5043.7 5082.0 5114.0 5161.6 5386.1 5397.2 5437.4 5442.6 5444.2 3880.4 3983.0 4066.7 4077.5 4092.4 5845.4 5869.4 5894.9 5904.9 5916.6 5474.4 5738.7 5742.7 5763.7 5820.9 5787.6 5824.6 5860.4 5871.9 5888.3 5769.8 5803.9 5824.6 5835.9 5858.9 5705.6 5802.0 5855.8 5870.9 5884.4 5734.1 5749.4 5762.7 5803.0 5808.5 15:41:18 INFO - PROCESS | 410 | 15:41:18 INFO - PROCESS | 410 | [#5] yui.html Cycles:180 Average:21734.68 Median:4143.41 stddev:31913.86 (770.2%) stddev-sans-first:31964.31 15:41:18 INFO - PROCESS | 410 | Values: 701.9 743.2 781.4 790.0 860.4 15755.6 16494.3 16525.5 16541.0 16573.0 15191.7 15240.8 15303.8 15310.6 15443.4 662.4 797.4 805.5 817.0 822.8 808.5 812.1 813.1 813.9 819.8 874.9 883.5 883.7 885.1 886.4 878.9 879.6 880.3 881.9 883.4 640.7 642.3 644.2 644.6 645.4 15193.5 15238.5 15244.2 15253.5 15270.2 15015.7 15201.2 15255.6 15318.5 15536.4 11917.8 12227.9 12274.6 12468.3 12604.2 3927.7 3982.2 4070.5 4142.6 4144.2 82464.0 82477.0 84488.6 84781.6 89491.1 11706.8 12089.6 12093.8 12303.1 12354.1 22789.7 22807.9 22942.0 23021.3 23093.5 8892.6 8970.1 9025.3 9088.7 9112.3 4946.6 5063.4 5103.1 5199.2 5230.4 3460.1 3580.9 3581.4 3582.8 3585.7 605.9 611.9 613.7 616.1 616.9 565.3 738.6 746.5 754.7 758.8 9617.6 9881.3 9943.4 10076.6 10105.5 657.2 666.9 716.9 733.4 752.5 4673.3 4804.5 4842.7 4877.5 4877.9 74404.0 127069.0 129634.0 131583.0 136237.0 64185.0 67574.3 68553.0 103084.5 108477.0 95021.5 101315.5 101965.5 102842.5 103538.0 9017.0 9527.4 9539.1 9542.2 9624.2 56081.7 56464.7 56859.0 57353.7 57550.4 83021.6 86470.0 87335.0 88295.6 88994.0 12381.2 12897.7 13034.2 13323.7 13937.3 14226.8 14344.6 14373.8 14537.3 15027.8 12519.1 12610.9 12861.7 13757.0 13852.8 12715.0 12999.5 13075.6 13373.1 13883.4 12355.8 12404.8 12523.3 13316.4 13476.1 10524.4 10550.4 11055.0 11101.8 11203.2 10130.3 11142.9 11200.0 11243.5 11388.9 15:41:18 INFO - PROCESS | 410 | -------- Summary: end -------- 15:41:18 INFO - PROCESS | 410 | 15:41:19 INFO - TEST-INFO | 410: exit 0 15:41:19 INFO - TEST-OK | dromaeo_css | took 1111246ms 15:41:19 INFO - TEST-START | kraken 15:41:19 INFO - operating with platform_type : linux_ 15:41:19 INFO - Initialising browser for kraken test... 15:41:19 INFO - TEST-INFO | started process 658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWF7dlg/profile http://localhost:50943/getInfo.html) 15:41:23 INFO - PROCESS | 658 | __metrics Screen width/height:1600/1200 15:41:23 INFO - PROCESS | 658 | colorDepth:24 15:41:23 INFO - PROCESS | 658 | Browser inner width/height: 1024/697 15:41:23 INFO - PROCESS | 658 | __metrics 15:41:24 ERROR - PROCESS | 658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:41:25 INFO - TEST-INFO | 658: exit 0 15:41:25 INFO - Browser initialized. 15:41:25 INFO - Running cycle 1/1 for kraken test... 15:41:25 INFO - TEST-INFO | started process 780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWF7dlg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:37 INFO - PROCESS | 780 | RSS: Main: 163573760 15:41:37 INFO - PROCESS | 780 | 15:41:39 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:40 INFO - PROCESS | 780 | RSS: Main: 169250816 15:41:40 INFO - PROCESS | 780 | 15:41:43 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-dft) 15:41:43 INFO - PROCESS | 780 | RSS: Main: 167485440 15:41:43 INFO - PROCESS | 780 | 15:41:46 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-fft) 15:41:47 INFO - PROCESS | 780 | RSS: Main: 164163584 15:41:47 INFO - PROCESS | 780 | 15:41:49 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-oscillator) 15:41:50 INFO - PROCESS | 780 | RSS: Main: 165195776 15:41:50 INFO - PROCESS | 780 | 15:41:52 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:52 INFO - PROCESS | 780 | RSS: Main: 165687296 15:41:52 INFO - PROCESS | 780 | 15:41:56 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:56 INFO - PROCESS | 780 | RSS: Main: 166477824 15:41:56 INFO - PROCESS | 780 | 15:42:00 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:00 INFO - PROCESS | 780 | RSS: Main: 163569664 15:42:00 INFO - PROCESS | 780 | 15:42:03 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50943/tests/kraken/driver.html?testName=json-parse-financial) 15:42:04 INFO - PROCESS | 780 | RSS: Main: 165019648 15:42:04 INFO - PROCESS | 780 | 15:42:05 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:06 INFO - PROCESS | 780 | RSS: Main: 165330944 15:42:06 INFO - PROCESS | 780 | 15:42:08 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:09 INFO - PROCESS | 780 | RSS: Main: 165134336 15:42:09 INFO - PROCESS | 780 | 15:42:11 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:11 INFO - PROCESS | 780 | RSS: Main: 165122048 15:42:11 INFO - PROCESS | 780 | 15:42:14 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:15 INFO - PROCESS | 780 | RSS: Main: 165928960 15:42:15 INFO - PROCESS | 780 | 15:42:17 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:18 INFO - PROCESS | 780 | RSS: Main: 166064128 15:42:18 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50943/tests/kraken/driver.html?testName=ai-astar) 15:42:20 INFO - PROCESS | 780 | RSS: Main: 166809600 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | __start_tp_report 15:42:20 INFO - PROCESS | 780 | _x_x_mozilla_page_load 15:42:20 INFO - PROCESS | 780 | _x_x_mozilla_page_load_details 15:42:20 INFO - PROCESS | 780 | |i|pagename|runs| 15:42:20 INFO - PROCESS | 780 | |0;ai-astar;103;115;109;113;115;114;119;112;112;111 15:42:20 INFO - PROCESS | 780 | |1;audio-beat-detection;150;123;148;176;119;162;149;120;177;119 15:42:20 INFO - PROCESS | 780 | |2;audio-dft;162;162;163;163;165;171;164;163;162;162 15:42:20 INFO - PROCESS | 780 | |3;audio-fft;76;75;75;180;82;75;76;75;170;77 15:42:20 INFO - PROCESS | 780 | |4;audio-oscillator;87;84;159;85;85;84;134;84;85;148 15:42:20 INFO - PROCESS | 780 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;117;118;118 15:42:20 INFO - PROCESS | 780 | |6;imaging-darkroom;146;148;147;148;146;147;147;147;147;146 15:42:20 INFO - PROCESS | 780 | |7;imaging-desaturate;97;96;95;95;95;98;96;96;95;95 15:42:20 INFO - PROCESS | 780 | |8;json-parse-financial;52;57;54;52;53;61;53;56;52;53 15:42:20 INFO - PROCESS | 780 | |9;json-stringify-tinderbox;61;62;60;61;63;60;62;60;61;62 15:42:20 INFO - PROCESS | 780 | |10;stanford-crypto-aes;77;77;76;87;77;77;77;81;87;76 15:42:20 INFO - PROCESS | 780 | |11;stanford-crypto-ccm;122;125;141;132;152;120;139;126;170;122 15:42:20 INFO - PROCESS | 780 | |12;stanford-crypto-pbkdf2;159;158;162;157;159;167;156;158;161;158 15:42:20 INFO - PROCESS | 780 | |13;stanford-crypto-sha256-iterative;64;64;65;64;65;67;66;66;63;64 15:42:20 INFO - PROCESS | 780 | __end_tp_report 15:42:20 INFO - PROCESS | 780 | __start_cc_report 15:42:20 INFO - PROCESS | 780 | _x_x_mozilla_cycle_collect,900 15:42:20 INFO - PROCESS | 780 | __end_cc_report 15:42:20 INFO - PROCESS | 780 | __startTimestamp1470091340296__endTimestamp 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | ------- Summary: start ------- 15:42:20 INFO - PROCESS | 780 | Number of tests: 14 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:4.24 (3.7%) stddev-sans-first:2.87 15:42:20 INFO - PROCESS | 780 | Values: 103.0 115.0 109.0 113.0 115.0 114.0 119.0 112.0 112.0 111.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:149.50 stddev:23.05 (15.4%) stddev-sans-first:24.35 15:42:20 INFO - PROCESS | 780 | Values: 150.0 123.0 148.0 176.0 119.0 162.0 149.0 120.0 177.0 119.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.75 (1.7%) stddev-sans-first:2.85 15:42:20 INFO - PROCESS | 780 | Values: 162.0 162.0 163.0 163.0 165.0 171.0 164.0 163.0 162.0 162.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#3] audio-fft Cycles:10 Average:96.10 Median:75.50 stddev:41.70 (55.2%) stddev-sans-first:43.59 15:42:20 INFO - PROCESS | 780 | Values: 76.0 75.0 75.0 180.0 82.0 75.0 76.0 75.0 170.0 77.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:84.50 stddev:30.61 (36.2%) stddev-sans-first:31.87 15:42:20 INFO - PROCESS | 780 | Values: 87.0 84.0 159.0 85.0 85.0 84.0 134.0 84.0 85.0 148.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:42:20 INFO - PROCESS | 780 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 15:42:20 INFO - PROCESS | 780 | Values: 146.0 148.0 147.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.00 15:42:20 INFO - PROCESS | 780 | Values: 97.0 96.0 95.0 95.0 95.0 98.0 96.0 96.0 95.0 95.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:2.91 (5.4%) stddev-sans-first:2.96 15:42:20 INFO - PROCESS | 780 | Values: 52.0 57.0 54.0 52.0 53.0 61.0 53.0 56.0 52.0 53.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:1.03 (1.7%) stddev-sans-first:1.09 15:42:20 INFO - PROCESS | 780 | Values: 61.0 62.0 60.0 61.0 63.0 60.0 62.0 60.0 61.0 62.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:77.00 stddev:4.34 (5.6%) stddev-sans-first:4.53 15:42:20 INFO - PROCESS | 780 | Values: 77.0 77.0 76.0 87.0 77.0 77.0 77.0 81.0 87.0 76.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:135.50 stddev:16.05 (11.8%) stddev-sans-first:16.33 15:42:20 INFO - PROCESS | 780 | Values: 122.0 125.0 141.0 132.0 152.0 120.0 139.0 126.0 170.0 122.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.00 stddev:3.17 (2.0%) stddev-sans-first:3.36 15:42:20 INFO - PROCESS | 780 | Values: 159.0 158.0 162.0 157.0 159.0 167.0 156.0 158.0 161.0 158.0 15:42:20 INFO - PROCESS | 780 | 15:42:20 INFO - PROCESS | 780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 15:42:20 INFO - PROCESS | 780 | Values: 64.0 64.0 65.0 64.0 65.0 67.0 66.0 66.0 63.0 64.0 15:42:20 INFO - PROCESS | 780 | -------- Summary: end -------- 15:42:20 INFO - PROCESS | 780 | 15:42:21 INFO - TEST-INFO | 780: exit 0 15:42:21 INFO - TEST-OK | kraken | took 61907ms 15:42:21 INFO - SUITE-END | took 1173s 15:42:21 INFO - Completed test suite (00:19:33) 15:42:21 INFO - javascript benchmark 15:42:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7282.166941001111, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2992.0425463851566, 3056.801307914984, 3062.6784187660296, 3079.615048118985, 3088.9845550772243, 5271.051210782067, 5307.097793375126, 5369.409364969855, 5379.139337705968, 5428.647137936031, 5380.515753582177, 5385.569154467643, 5399.757010934508, 5406.135018397057, 5409.377921539024, 4813.8796530086765, 4835.468098509161, 4840.903181936359, 4872.853814385574, 4910.901781964359, 4900.338454308659, 4926.359573255471, 4932.8520144395725, 4939.110960027194, 4944.653874228806, 502.2566036312064, 4924.335214745999, 4991.875203119915, 4992.750362481879, 5046.82336118236, 4916.385451818523, 4951.876203094916, 4979.1784355581285, 4980.576650984671, 4985.576226020793, 4887.975560122212, 4889.33993910821, 4895.388076490439, 4907.337509436216, 4931.0630980113665, 5184.066867963803, 5393.325834270716, 5394.379646340682, 5418.566514678816, 5421.701806400646, 5643.294588176478, 5695.743691533891, 5703.116017017369, 5740.5981581289325, 5751.8562035949435, 5766.682832444256, 5784.942150578482, 5785.334686511021, 5785.8553536161935, 5792.710364481759, 5222.033923724123, 5325.733713314319, 5352.304200453916, 5358.33020872391, 5363.517283444508, 5727.656340619576, 5746.310442746897, 5776.537876969833, 5828.591998560145, 5891.646501209942, 5527.309086364205, 5567.053600887859, 5582.27430434041, 5621.0, 5644.604877658525, 5533.557315414757, 5679.8864022720145, 5690.658560486384, 5701.914471282934, 5709.286339207599, 5642.0, 5646.407127251579, 5648.322201335866, 5745.4541818528005, 5746.88506229873, 5686.232358631614, 5715.885682286331, 5728.914066289009, 5732.541396688255, 5739.741711622987, 4328.740275583412, 4414.514403415622, 4430.490493593214, 4433.312836510346, 4470.552944705503, 3868.941965870514, 3928.8821335359985, 3943.743656662308, 3952.980235098806, 3983.42240375144, 5456.91814622781, 5548.9722551387795, 5583.69289689071, 5587.720613969285, 5589.133684278943, 5696.572757043238, 5743.684097374685, 5837.503812176013, 5839.124131380242, 5841.269841269841, 5521.116621340566, 5569.498745112959, 5572.0, 5598.692071936082, 5623.493885550239, 5046.7476626168545, 5046.949530504648, 5048.545630893237, 5052.595792336604, 5091.389033315952, 5776.3068431787615, 5862.296524417012, 5992.970035149797, 6006.249218847644, 6010.4891084258325, 5705.486506214461, 5795.594308398372, 5807.245058142415, 5817.301923769175, 5841.561882858718, 5896.14505896634, 5942.6731529766275, 5943.554233432596, 5953.464188223081, 5953.613015154001, 5601.29983752031, 5616.157576363578, 5682.715864206856, 5685.204071430086, 5686.402927692533, 5726.856828579319, 5790.783935373619, 5832.825015249549, 5847.94152058491, 5880.14737863016, 5661.518770904519, 5689.459501347531, 5697.202391665253, 5700.0, 5703.372629010889, 5553.194786755978, 5571.164325351229, 5664.688442135722, 5676.460736230051, 5699.886002279848, 5580.972095139498, 5617.943820561742, 5618.044932361427, 5647.1529270609735, 5684.9431505684415, 5641.210230567806, 5643.633163844337, 5715.714214289185, 5722.914156287742, 5724.971375143097, 5413.350397952271, 5483.643563168382, 5490.286262785812, 5602.411746766531, 5603.495685388171], "value": 5281.107867959034, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.0471013972456, 578.4562511239435, 598.8622616798134, 606.878624275145, 636.828056424765, 39292.607073929255, 43207.0, 43447.131057378836, 43517.78241108798, 43529.564704352946, 44181.55818441814, 44713.776431117796, 44850.775746121304, 44871.0, 45025.0, 8846.292296616288, 8979.102089791035, 8983.820323593523, 8998.100189981014, 9022.593983270768, 8957.14907083826, 9025.864612030824, 9056.230220431238, 9096.681616143436, 9105.408148470362, 9116.544172791368, 9151.542422878863, 9154.404963677373, 9161.358704890661, 9199.678011269607, 9089.454632722058, 9097.545122743903, 9112.088791120836, 9121.771955701128, 9133.0, 8963.46219226842, 8997.86503202446, 9029.54852257391, 9032.548372581345, 9053.547322633907, 42006.0, 42141.78929105335, 42384.36423453651, 42388.57611423877, 42522.0, 3021.743151832097, 3508.122969257686, 3672.4491326301, 3687.225682606656, 3737.009692431508, 32437.0, 33900.660993389996, 34771.13072173216, 35286.0, 35526.467102993476, 4438.467383913951, 4491.550844915482, 4549.61328287096, 4553.127243026521, 4795.784189711471, 354588.0, 360005.0, 360856.0, 361819.0, 363276.18361908285, 64833.0, 65818.0, 65926.0, 66066.33933660602, 66161.0, 36613.81693091518, 37357.43963840545, 68438.20932534775, 68980.6550967252, 69357.30642693609, 15056.548303550911, 15215.695686086216, 15374.615634609001, 15376.308066137051, 15417.0, 10516.211284153718, 10588.682339529827, 10590.89409105899, 10591.682249532527, 10635.202359823044, 20727.8963605181, 20773.169073237204, 20866.0, 21012.474688132614, 21081.78918210829, 7663.885041724378, 7729.1884352142215, 7964.301062373228, 7966.0, 8146.348292136615, 967.3905439573165, 1014.4471263161595, 1123.230587047875, 1142.5144313666824, 1170.3212136960542, 32799.180020499676, 33656.1585960348, 33730.66269337275, 33796.49305260423, 33843.830780845936, 1066.6959916423782, 1084.669175901342, 1108.700650824273, 1108.9667309980714, 1152.0610702277784, 16892.0, 17348.13259337028, 17415.80265985386, 17461.912690436722, 17477.38829140974, 582732.0, 584315.0, 584554.0, 586834.0, 590664.0, 58817.0, 58868.0, 59581.702091489264, 59955.40044599498, 60046.099308510406, 1312.3569450968957, 1313.343328335832, 1327.774278372679, 1353.5465619017543, 1355.4103964775354, 30474.695253047186, 32522.674773251965, 32652.673473265913, 33094.83452582722, 33210.5018424719, 51488.0, 54060.18909716436, 55867.441325587846, 55877.72061139668, 61702.69148654408, 524069.0, 529386.0, 530905.0, 531933.0, 532134.0, 45057.549424505334, 45547.77226113848, 45685.77157114193, 45972.0, 46303.0, 49318.75340623274, 49562.50437495579, 49984.250236247215, 50254.246186306504, 50956.23565646593, 41458.79270603628, 41534.79232603818, 42557.36163957605, 44232.0, 44379.0, 41502.377464338664, 41981.37027944644, 42173.578264218195, 42263.78868105763, 43441.565584345015, 35251.0, 42517.57482425136, 44625.776871115435, 45565.31652025288, 45669.314960274955, 39638.47899551044, 45944.31083533817, 45959.31061034154, 47293.29060064033, 47844.521554784005, 36072.27855442929, 36324.0, 36416.0, 36573.45139822851, 36787.08032299214], "value": 21158.831691046198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7604269203671, 374.4918649888912, 398.42427691985085, 401.544247279338, 414.57713132604727, 18440.907795461037, 19912.0, 20249.291274805386, 20298.289559865407, 20681.379558613266, 18337.358192463267, 18887.338943136994, 18988.62022759544, 19566.510837229078, 19968.0, 5133.409657889334, 5276.683398996053, 5281.788728450877, 5316.548093412045, 5339.172428273624, 5091.490850914897, 5225.163973764198, 5231.398389185254, 5257.36911570612, 5267.183586544073, 5225.921611175835, 5230.1108811501945, 5585.692786896719, 5706.572007099463, 5730.398308177644, 5680.9715951420185, 5703.17303990919, 5728.828135155952, 5739.426057394248, 5741.684207368593, 4894.853154405374, 4908.0, 4918.704877707349, 4963.081829861487, 5025.949740502621, 12973.221606703628, 13356.799648005288, 13386.665333366744, 20114.29599964009, 23061.423464413358, 2280.851744636593, 2332.825038122148, 2355.587772139869, 2489.8132640052067, 2616.921492355232, 10001.39991600499, 10496.580136794519, 12619.864212220944, 13562.254076025814, 14176.794972427357, 1899.5251187203198, 1926.422073377995, 1965.5184479802397, 1991.5519008223034, 2041.336565616166, 79878.0, 82672.58663706643, 83766.58116709438, 84482.57758711229, 86705.56647216724, 10461.424621645883, 10587.417692027013, 10683.358998460117, 10800.351978881292, 10987.0, 14366.928165359106, 14391.0, 14395.42418303277, 14407.42370305176, 14414.711705765825, 7314.195438501761, 7473.813154671068, 7525.586092764841, 7719.421043421766, 7749.217679933647, 7080.858382832314, 7140.214576396592, 7300.525465844703, 7356.1540422850985, 7357.5217610855125, 4314.662454639072, 4395.582419670126, 4401.669874759342, 4554.225781617133, 4583.129205450954, 1869.3083559083227, 1875.0093006413808, 1980.4454752669276, 1998.530345368837, 2037.3378651937883, 864.8140649760331, 986.8125056239292, 1025.7589466475372, 1040.4485622620023, 1082.929609575375, 19638.170556741297, 20249.29127480531, 20297.391078267676, 20370.694439583418, 20470.692939605917, 984.9852252216223, 1011.7470632341915, 1016.6238491758097, 1020.285799940045, 1020.9948950255201, 10655.467226638637, 11191.16066295015, 11207.60773372928, 11269.66191014271, 11303.795759826755, 477533.0, 487270.0, 487620.0, 490990.0, 491068.0, 87388.0, 89245.0, 89702.55148724215, 89951.55024224837, 91009.54495227613, 984.9556769945369, 1005.607812952949, 1020.1787561013456, 1033.7415646088477, 1040.698197522725, 14319.355628996513, 17155.31378744886, 17834.91082544579, 17839.197236124666, 17988.640227195643, 42169.36745948875, 42623.14753704846, 42858.357124642534, 43107.568924310355, 43217.3517397233, 59419.0, 59725.0, 60487.69756151191, 61224.38775612187, 61891.0, 7975.680972761256, 8059.959700201462, 8261.339092872677, 8483.06686264498, 8533.317334613092, 12594.622161335175, 12727.490900364252, 13517.526886558922, 13677.589672309847, 13834.515791947233, 11567.71080722955, 11725.41372931367, 12154.696132596755, 12231.082668800054, 12540.0, 11634.767304653691, 11854.407279636156, 11888.34614096233, 12304.446299916704, 12604.621861344174, 12175.939120304341, 12250.509979601073, 12310.75378492443, 12379.93810030944, 12560.37198140071, 8214.219649133323, 8304.418690691593, 8314.584270786558, 8551.230389264996, 8557.058723540282, 10988.0, 11548.191626586058, 11820.468078936297, 11836.70408239801, 11925.449691540045], "value": 9087.50260155698, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.319513024009, 1484.4952716076534, 1614.951551453456, 1764.7705798246234, 1765.135083808934, 7694.30751232389, 8000.639971201295, 8358.205970432815, 8528.104549022348, 8556.572171391428, 8418.200270974263, 8678.956605216981, 8682.392232543709, 8688.522131282776, 8697.652093916251, 2277.0, 2283.6460348645987, 2290.931272061841, 2292.1862738727764, 2292.977070229293, 2246.4383904023994, 2279.9202027929027, 2300.66640337151, 2315.4211447138214, 2317.9072837086496, 2239.6864438978555, 2243.349428665685, 2243.977560224393, 2271.647894576335, 2282.6005449046434, 2200.8569442986313, 2201.7908298711595, 2214.6788715636144, 2226.065052677879, 2230.4200907763934, 2172.913083476659, 2187.0814258011674, 2187.9671804922937, 2191.5069109450405, 2193.6270833958265, 8634.78413039679, 8691.39160258782, 8737.694180703646, 8747.956260218658, 8768.956155219183, 4959.70241785494, 5073.898522029539, 5077.060743762416, 5082.847514574569, 5093.898122037538, 3111.3466172103886, 3285.720713739335, 3404.7446441516986, 3425.7088147507493, 3456.827158642058, 1067.6690226029955, 1096.3641088168843, 1112.2436743014746, 1123.8033344164821, 1133.3313345126414, 11823.763524729544, 11939.940300298444, 11956.40217989097, 11974.760504789856, 11983.340916249603, 4259.42497762798, 4299.935500967488, 4483.551644835556, 4516.322551617283, 4534.410526631516, 9890.307678462439, 9966.700998969898, 9974.202063834875, 9987.151092157103, 9998.150157236716, 5154.381474223117, 5158.329417175743, 5161.716105614228, 5161.896762064737, 5172.767225474862, 4125.690573207022, 4683.110209060335, 4729.976350118227, 4744.620430365562, 4766.809327626856, 3850.595687452777, 3936.2521120987494, 3978.622030907059, 4021.678265738734, 4042.6159514846045, 1192.9463174157183, 1211.2671833540758, 1220.7009282725612, 1223.8190146508662, 1242.8073648584302, 868.2749903830372, 961.8364877970762, 991.5835349153373, 1002.178213864624, 1043.8695163104612, 5784.59507834456, 6083.148359229712, 6196.8760624787255, 6209.223847019122, 6273.153124328249, 383.89826695925603, 383.95776464588874, 389.50143815915675, 392.9332013557702, 396.631133046264, 4199.853005144805, 4215.156968606291, 4228.302330115496, 4239.1521695660995, 4270.402143699885, 10341.37951722899, 10576.682699519026, 10619.84070238947, 10628.627998020032, 10660.09389201911, 10481.895181048245, 10546.683599492027, 10563.524641391155, 10601.787964240671, 10624.946875265574, 7954.085280192736, 8032.879506807402, 8292.875606865902, 8316.334693224528, 8484.684873844688, 6108.35862234459, 6123.203983482119, 6249.093881387083, 6283.560150789401, 6299.590526615755, 9953.104220620178, 10081.596736130472, 10086.243531735296, 10088.243381746252, 10117.747056323356, 10029.648962286285, 10166.390016599027, 10311.123554497952, 10382.636607718996, 10553.736156596147, 6980.825479363057, 7580.9620951894885, 7686.615669216629, 7750.263724946121, 7795.376369890509, 8565.400421970402, 8594.699185528476, 8630.741077767678, 8649.221570058726, 8661.307095432225, 7529.962350188214, 7542.660580273791, 7727.381809455343, 7779.883301750591, 7878.881816772868, 7556.055493063367, 7567.356774674215, 7629.809254768453, 7687.231276872268, 7858.528488290721, 7077.964610176916, 7195.532290401107, 7196.0285361475535, 7197.676104575202, 7204.423646108194, 5114.360704911886, 5129.230615407719, 5223.582113430993, 5283.524482796567, 5476.534494568006, 5227.477252274894, 5291.365036195682, 5339.519443250126, 5372.516473517402, 5642.492175704207], "value": 4485.77908507806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.9863206155724, 317.4587328604729, 322.22665602553866, 323.01828283480836, 325.4126302024846, 5358.33020872391, 5457.781688732446, 5576.302962129734, 5619.381867994517, 5634.352049514302, 5449.373322067963, 5531.502164805167, 5555.8888822223535, 5568.470995255454, 5568.7215639217975, 4299.247631664454, 4303.483581970168, 4311.5472875348105, 4317.747853122591, 4318.589733975267, 4157.6695457453625, 4239.915201695964, 4292.862391466264, 4309.762963037032, 4311.8789114830215, 4248.468941382327, 4253.191893540217, 4257.638100761439, 4283.550227226143, 4284.6786491013145, 4217.177650358181, 4246.384274280227, 4256.191323648528, 4316.5467625899455, 4320.1575692739925, 3691.963080369189, 3765.4728338032423, 3783.659470647655, 3795.1271207622126, 3795.411711184771, 5364.022967253173, 5376.0, 5376.623636345457, 5378.596605254583, 5408.0, 4881.341018962466, 4887.218045112765, 4889.2910527973245, 4903.401197365366, 4917.434495033045, 5521.4478552144865, 5729.169270455803, 5731.882282954825, 5745.540356771448, 5822.097574875901, 4061.8375264989363, 4072.5316588592395, 4082.4896887889013, 4088.3850878902963, 4103.876883693494, 6002.699865006733, 6045.637261764308, 6071.210742603434, 6094.847628809271, 6120.418560236771, 3880.2239552089695, 4072.470578824793, 4199.517055538652, 4210.473690788652, 4216.810243539048, 4154.543000269968, 4160.167966406731, 4174.853880114181, 4178.623923846869, 4186.979065104716, 4808.927866082012, 4818.807247710052, 4835.298881662139, 4856.611471082305, 4866.099771542205, 5656.606036378223, 5811.767529298781, 5848.561357898175, 5866.6480011199465, 5886.675498012998, 1427.9928600357139, 1444.3861358922416, 1445.407382972976, 1447.0, 1447.2257342321807, 874.7681864305964, 899.4827973915025, 909.3679892474667, 921.3780698028804, 929.4330458420358, 4889.975550122298, 4894.1402267138255, 4925.876853078702, 4930.605551555867, 4931.337077977852, 5132.204508301219, 5204.531592156724, 5241.606879484054, 5269.1569348903995, 5315.255864179018, 4709.3877795887, 4892.559669629679, 4962.732050436622, 4971.726555039508, 5012.598992080625, 2716.4295497945654, 2765.8893644254003, 2792.3856751514636, 2794.3712664650293, 2811.4236581500745, 5404.594655400782, 5406.269514175096, 5468.453154684579, 5486.807961721321, 5527.098273406494, 5128.00003999224, 5298.576113910878, 5306.575473962073, 5318.228856815817, 5422.186671999231, 5359.490848369476, 5451.781928722886, 5486.670799752028, 5496.615236933456, 5500.972495137578, 5257.0, 5268.78924843002, 5276.788928442819, 5345.572354211731, 5348.7907255646305, 4824.831130910401, 5043.722595257296, 5082.009008243505, 5114.0, 5161.638685291993, 5386.114859799039, 5397.166487594044, 5437.4018857926385, 5442.591805614674, 5444.156155795858, 3880.447820871674, 3982.980085099556, 4066.6543343816106, 4077.510698716173, 4092.4066010427728, 5845.386234445322, 5869.354371019099, 5894.852628684145, 5904.852378690395, 5916.645001299936, 5474.397816240131, 5738.655680659007, 5742.712864356849, 5763.740631671669, 5820.854478638068, 5787.56593255516, 5824.592278540462, 5860.38465961068, 5871.882562348644, 5888.293404791452, 5769.826905192851, 5803.912941305968, 5824.5631577631, 5835.912461312999, 5858.912116318344, 5705.62913410627, 5802.0, 5855.824325270249, 5870.911936321044, 5884.440978107073, 5734.139879018181, 5749.396313387034, 5762.711864406679, 5803.0, 5808.506276966336], "value": 4231.826358896977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.866645337386, 743.2456057102039, 781.3514782730334, 790.0203747353282, 860.3676297921031, 15755.606109847246, 16494.34022639096, 16525.50423487296, 16541.0, 16573.0, 15191.696166076672, 15240.771388429155, 15303.846961530382, 15310.617234569141, 15443.382264709426, 662.374056516592, 797.3939805747644, 805.5207151744717, 817.0318172965056, 822.8230930349973, 808.5310519898475, 812.0580127052621, 813.0852790610563, 813.9064007639138, 819.7622689420091, 874.8512752832002, 883.5405589093667, 883.6862913665652, 885.0972008551274, 886.3751055505853, 878.8549889268263, 879.5821984557316, 880.3045593980779, 881.9338549608805, 883.3728053082319, 640.6636515829181, 642.3223499208333, 644.1818890009662, 644.6422235659207, 645.370763505583, 15193.544193674208, 15238.542843714595, 15244.161571113584, 15253.466128685553, 15270.236488175547, 15015.699686006328, 15201.239938003055, 15255.618609534851, 15318.540443786704, 15536.378544858193, 11917.821232681517, 12227.938860305641, 12274.570390036306, 12468.251904885736, 12604.180728252726, 3927.6661483773914, 3982.2234664240486, 4070.5115386153852, 4142.606452387018, 4144.212599606065, 82464.0, 82477.0, 84488.57755711181, 84781.57609211977, 89491.10508894893, 11706.824397633873, 12089.576864809866, 12093.758124837454, 12303.077269204845, 12354.07344449152, 22789.658155127687, 22807.885960570424, 22942.0, 23021.309360719206, 23093.53812923732, 8892.644294228288, 8970.147835955573, 9025.277977761763, 9088.727338179866, 9112.271018318519, 4946.629002824802, 5063.3923929128005, 5103.106956282636, 5199.168133098686, 5230.3985041719925, 3460.1003739028033, 3580.946285805715, 3581.3553560358864, 3582.802945837952, 3585.6593623606236, 605.8606520500309, 611.8776244751068, 613.6716856481761, 616.0543565626741, 616.8581226317972, 565.2679779685317, 738.5900825042046, 746.5408773604195, 754.6717178027576, 758.8167636763833, 9617.56720947545, 9881.308308418342, 9943.403395796275, 10076.647317343857, 10105.545250463747, 657.2211928864216, 666.8966310221826, 716.9032180655649, 733.3986131372224, 752.5259086775296, 4673.252279635242, 4804.495527969582, 4842.7336496493035, 4877.5366340197625, 4877.902441951142, 74404.0, 127069.0, 129634.0, 131583.0, 136237.0, 64185.0, 67574.32425675681, 68553.0, 103084.48457757663, 108477.0, 95021.52489237509, 101315.4934225339, 101965.49017254866, 102842.48578757058, 103538.0, 9017.0, 9527.428354298765, 9539.141477266801, 9542.188913942115, 9624.181944534794, 56081.71959140178, 56464.717676411354, 56859.0, 57353.713231433576, 57550.42449575618, 83021.58489207758, 86470.0, 87335.0, 88295.55852220698, 88994.0, 12381.195222310522, 12897.742045158857, 13034.152780069266, 13323.66690832737, 13937.30313484342, 14226.786598200828, 14344.641383965485, 14373.800157746602, 14537.273136343352, 15027.849721502645, 12519.123661343983, 12610.936945315214, 12861.742765144832, 13757.0, 13852.792208117087, 12714.995667719073, 12999.480020799063, 13075.607731768063, 13373.130746501447, 13883.375248113656, 12355.75288494243, 12404.751904962031, 12523.311217883103, 13316.394638506179, 13476.056676032584, 10524.36853788775, 10550.366977981346, 11055.0, 11101.777964440827, 11203.15976301797, 10130.290879638354, 11142.944285278521, 11200.0, 11243.494042767932, 11388.94305528467], "value": 7735.501927075738, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 109.0, 113.0, 115.0, 114.0, 119.0, 112.0, 112.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 148.0, 176.0, 119.0, 162.0, 149.0, 120.0, 177.0, 119.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 165.0, 171.0, 164.0, 163.0, 162.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 180.0, 82.0, 75.0, 76.0, 75.0, 170.0, 77.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 159.0, 85.0, 85.0, 84.0, 134.0, 84.0, 85.0, 148.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 95.0, 98.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 57.0, 54.0, 52.0, 53.0, 61.0, 53.0, 56.0, 52.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 63.0, 60.0, 62.0, 60.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 87.0, 77.0, 77.0, 77.0, 81.0, 87.0, 76.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 141.0, 132.0, 152.0, 120.0, 139.0, 126.0, 170.0, 122.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 162.0, 157.0, 159.0, 167.0, 156.0, 158.0, 161.0, 158.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 67.0, 66.0, 66.0, 63.0, 64.0], "value": 64.8, "unit": "score"}]}]} 15:42:21 INFO - Return code: 0 15:42:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:21 ERROR - # TBPL SUCCESS # 15:42:21 INFO - Running post-action listener: _resource_record_post_action 15:42:21 INFO - [mozharness: 2016-08-01 22:42:21.595649Z] Finished run-tests step (success) 15:42:21 INFO - Running post-run listener: _resource_record_post_run 15:42:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 550535168; Read time: 0; Write time: 457520 15:42:21 INFO - TinderboxPrint: CPU usage
13.4% 15:42:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:42:21 INFO - TinderboxPrint: I/O write bytes / time
550,535,168 / 457,520 15:42:21 INFO - TinderboxPrint: CPU idle
8,227.3 (86.6%) 15:42:21 INFO - TinderboxPrint: CPU user
1,218.0 (12.8%) 15:42:21 INFO - TinderboxPrint: Swap in / out
0 / 0 15:42:21 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 258367488; Read time: 0; Write time: 267404 15:42:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292098048; Read time: 0; Write time: 190088 15:42:22 INFO - Running post-run listener: _upload_blobber_files 15:42:22 INFO - Blob upload gear active. 15:42:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:22 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 15:42:22 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:22 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:42:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:27 INFO - (blobuploader) - INFO - Done attempting. 15:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:42:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:27 INFO - (blobuploader) - INFO - Done attempting. 15:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:28 INFO - (blobuploader) - INFO - Done attempting. 15:42:28 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:28 INFO - Return code: 0 15:42:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/abfc1c0fdfbea9e48792dc86553b06fc3b761903dcb037da8c6c635dfe1a5c5b97eae121ebb72555ebef4befeea7d4e8c4c45a594ad8ecd6dfae4a392f7bfea8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ceeae3d762c42185a608425c5c0c6eaeab2331ab7b99fbfb003c950e61e6c9e81c10b5d445c7fc94c7ec70b054210d378c17a49bae83af12a941b267d4242c53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42167843b7ea94f32926990c0727c748e5527115b59f2a230e0599783da8194dd1848244b2fb30b2552dd2bdb045372c09765640c491e0890cd8e6b671ce690e"} 15:42:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:28 INFO - Contents: 15:42:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/abfc1c0fdfbea9e48792dc86553b06fc3b761903dcb037da8c6c635dfe1a5c5b97eae121ebb72555ebef4befeea7d4e8c4c45a594ad8ecd6dfae4a392f7bfea8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ceeae3d762c42185a608425c5c0c6eaeab2331ab7b99fbfb003c950e61e6c9e81c10b5d445c7fc94c7ec70b054210d378c17a49bae83af12a941b267d4242c53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42167843b7ea94f32926990c0727c748e5527115b59f2a230e0599783da8194dd1848244b2fb30b2552dd2bdb045372c09765640c491e0890cd8e6b671ce690e"} 15:42:28 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:28 INFO - Copying logs to upload dir... 15:42:28 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.301294 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-01 15:42:27.735468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 15:42:27.740287) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514 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/Autoland/sha512/abfc1c0fdfbea9e48792dc86553b06fc3b761903dcb037da8c6c635dfe1a5c5b97eae121ebb72555ebef4befeea7d4e8c4c45a594ad8ecd6dfae4a392f7bfea8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ceeae3d762c42185a608425c5c0c6eaeab2331ab7b99fbfb003c950e61e6c9e81c10b5d445c7fc94c7ec70b054210d378c17a49bae83af12a941b267d4242c53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42167843b7ea94f32926990c0727c748e5527115b59f2a230e0599783da8194dd1848244b2fb30b2552dd2bdb045372c09765640c491e0890cd8e6b671ce690e"} build_url:https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/ERvNTiZUReiySVWwaAQeEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/abfc1c0fdfbea9e48792dc86553b06fc3b761903dcb037da8c6c635dfe1a5c5b97eae121ebb72555ebef4befeea7d4e8c4c45a594ad8ecd6dfae4a392f7bfea8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ceeae3d762c42185a608425c5c0c6eaeab2331ab7b99fbfb003c950e61e6c9e81c10b5d445c7fc94c7ec70b054210d378c17a49bae83af12a941b267d4242c53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42167843b7ea94f32926990c0727c748e5527115b59f2a230e0599783da8194dd1848244b2fb30b2552dd2bdb045372c09765640c491e0890cd8e6b671ce690e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 15:42:27.764778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:42:27.765074) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470090115.839296-1506074514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:42:27.848385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 15:42:27.848661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 15:42:27.848924) ========= ========= Total master_lag: 0.16 =========