builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1505815629.07 results: success (0) revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.065401) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.065856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.066153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.083339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.083596) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 03:07:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 61.0M=0s 2017-09-19 03:07:09 (61.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.256943) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.257278) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018863 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.308970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:09.309538) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --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=769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 03:07:09,365 truncating revision to first 12 chars 2017-09-19 03:07:09,365 Setting DEBUG logging. 2017-09-19 03:07:09,365 attempt 1/10 2017-09-19 03:07:09,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e4261f5b96eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 03:07:09,729 unpacking tar archive at: mozilla-central-e4261f5b96eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698377 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:10.025348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:10.025665) ========= script_repo_revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:10.026092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:10.026370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:07:10.038893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-19 03:07:10.039186) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:07:10 INFO - MultiFileLogger online at 20170919 03:07:10 in /builds/slave/test 03:07:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:07:10 INFO - {'append_to_log': False, 03:07:10 INFO - 'base_work_dir': '/builds/slave/test', 03:07:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:07:10 INFO - 'branch': 'Firefox-Non-PGO', 03:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:10 INFO - 'code_coverage': False, 03:07:10 INFO - 'config_files': ('talos/linux_config.py',), 03:07:10 INFO - 'default_actions': ('clobber', 03:07:10 INFO - 'read-buildbot-config', 03:07:10 INFO - 'download-and-extract', 03:07:10 INFO - 'populate-webroot', 03:07:10 INFO - 'create-virtualenv', 03:07:10 INFO - 'install', 03:07:10 INFO - 'setup-mitmproxy', 03:07:10 INFO - 'run-tests'), 03:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:10 INFO - 'disable_ccov_upload': False, 03:07:10 INFO - 'disable_stylo': False, 03:07:10 INFO - 'download_minidump_stackwalk': True, 03:07:10 INFO - 'download_symbols': 'ondemand', 03:07:10 INFO - 'enable_stylo': False, 03:07:10 INFO - 'enable_webrender': False, 03:07:10 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:10 INFO - 'gecko_profile': False, 03:07:10 INFO - 'gecko_profile_interval': 0, 03:07:10 INFO - 'installer_path': 'installer.exe', 03:07:10 INFO - 'log_level': 'info', 03:07:10 INFO - 'log_name': 'talos', 03:07:10 INFO - 'log_to_console': True, 03:07:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:07:10 INFO - 'opt_config_files': (), 03:07:10 INFO - 'pip_index': False, 03:07:10 INFO - 'suite': 'dromaeojs-e10s', 03:07:10 INFO - 'system_bits': '32', 03:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:10 INFO - 'title': 'talos-linux64-ix-063', 03:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:10 INFO - 'use_talos_json': True, 03:07:10 INFO - 'verify': 'False', 03:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:10 INFO - 'work_dir': 'build'} 03:07:10 INFO - [mozharness: 2017-09-19 10:07:10.234320Z] Running clobber step. 03:07:10 INFO - Running pre-action listener: _resource_record_pre_action 03:07:10 INFO - Running main action method: clobber 03:07:10 INFO - rmtree: /builds/slave/test/build 03:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:07:11 INFO - Running post-action listener: _resource_record_post_action 03:07:11 INFO - [mozharness: 2017-09-19 10:07:11.344214Z] Finished clobber step (success) 03:07:11 INFO - [mozharness: 2017-09-19 10:07:11.344310Z] Running read-buildbot-config step. 03:07:11 INFO - Running pre-action listener: _resource_record_pre_action 03:07:11 INFO - Running main action method: read_buildbot_config 03:07:11 INFO - Using buildbot properties: 03:07:11 INFO - { 03:07:11 INFO - "project": "", 03:07:11 INFO - "product": "firefox", 03:07:11 INFO - "who": "archaeopteryx@coole-files.de", 03:07:11 INFO - "installer_path": "public/build/target.tar.bz2", 03:07:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:07:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:07:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:07:11 INFO - "stage_platform": "linux64", 03:07:11 INFO - "basedir": "/builds/slave/test", 03:07:11 INFO - "buildnumber": 1158, 03:07:11 INFO - "platform": "ubuntu64_hw", 03:07:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:07:11 INFO - "slavebuilddir": "test", 03:07:11 INFO - "taskId": "OjTFKBqSRWGD4ovq4nlhKw", 03:07:11 INFO - "branch": "mozilla-central", 03:07:11 INFO - "script_repo_revision": "production", 03:07:11 INFO - "revision": "e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5", 03:07:11 INFO - "slavename": "talos-linux64-ix-063", 03:07:11 INFO - "repo_path": "mozilla-central" 03:07:11 INFO - } 03:07:11 INFO - Finding installer, test and symbols from parent task. 03:07:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OjTFKBqSRWGD4ovq4nlhKw'}, attempt #1 03:07:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OjTFKBqSRWGD4ovq4nlhKw'}, attempt #1 03:07:12 INFO - Task dependencies: AgMWzaeiTGuANcVMqKHEPA 03:07:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA'}, attempt #1 03:07:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:07:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json 03:07:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip 03:07:12 INFO - Running post-action listener: _resource_record_post_action 03:07:12 INFO - [mozharness: 2017-09-19 10:07:12.684036Z] Finished read-buildbot-config step (success) 03:07:12 INFO - [mozharness: 2017-09-19 10:07:12.684251Z] Running download-and-extract step. 03:07:12 INFO - Running pre-action listener: _resource_record_pre_action 03:07:12 INFO - Running main action method: download_and_extract 03:07:12 INFO - mkdir: /builds/slave/test/build/tests 03:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:12 INFO - trying https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json 03:07:12 INFO - Downloading https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:07:13 INFO - Downloaded 989 bytes. 03:07:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:07:13 INFO - Using the following test package requirements: 03:07:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:07:13 INFO - u'common': [u'target.common.tests.zip'], 03:07:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:07:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:07:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:07:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:07:13 INFO - u'mozbase': [u'target.common.tests.zip'], 03:07:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:07:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:07:13 INFO - u'web-platform': [u'target.common.tests.zip', 03:07:13 INFO - u'target.web-platform.tests.tar.gz'], 03:07:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:07:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:07:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.common.tests.zip 03:07:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:07:13 INFO - Fetch https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.common.tests.zip into memory 03:07:14 INFO - Content-Length response header: 54731519 03:07:14 INFO - Bytes received: 54731519 03:07:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.talos.tests.zip 03:07:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:07:25 INFO - Fetch https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.talos.tests.zip into memory 03:07:25 INFO - Content-Length response header: 14508787 03:07:25 INFO - Bytes received: 14508787 03:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:26 INFO - trying https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:07:26 INFO - Downloading https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:07:27 INFO - Downloaded 61456923 bytes. 03:07:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:07:27 INFO - mkdir: /builds/slave/test/properties 03:07:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:27 INFO - Contents: 03:07:27 INFO - build_url:https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 03:07:27 INFO - Running post-action listener: _resource_record_post_action 03:07:27 INFO - Running post-action listener: find_tests_for_verification 03:07:27 INFO - Running post-action listener: set_extra_try_arguments 03:07:27 INFO - [mozharness: 2017-09-19 10:07:27.432814Z] Finished download-and-extract step (success) 03:07:27 INFO - [mozharness: 2017-09-19 10:07:27.432909Z] Running populate-webroot step. 03:07:27 INFO - Running pre-action listener: _resource_record_pre_action 03:07:27 INFO - Running main action method: populate_webroot 03:07:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:27 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['tresize', 03:07:27 INFO - 'tcanvasmark']}, 03:07:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:27 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['dromaeo_css', 03:07:27 INFO - 'kraken']}, 03:07:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:27 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'tests': ['damp', 'tps']}, 03:07:27 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['damp', 'tps']}, 03:07:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:27 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['dromaeo_dom']}, 03:07:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:07:27 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['basic_compositor_video', 03:07:27 INFO - 'glvideo']}, 03:07:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:07:27 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['ts_paint_webext', 03:07:27 INFO - 'tp5o_webext']}, 03:07:27 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:27 INFO - 'ts_paint', 03:07:27 INFO - 'tpaint', 03:07:27 INFO - 'sessionrestore', 03:07:27 INFO - 'sessionrestore_many_windows', 03:07:27 INFO - 'sessionrestore_no_auto_restore', 03:07:27 INFO - 'tabpaint']}, 03:07:27 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['a11yr', 03:07:27 INFO - 'ts_paint', 03:07:27 INFO - 'tpaint', 03:07:27 INFO - 'sessionrestore', 03:07:27 INFO - 'sessionrestore_many_windows', 03:07:27 INFO - 'sessionrestore_no_auto_restore', 03:07:27 INFO - 'tabpaint']}, 03:07:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:07:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:07:27 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['perf_reftest_singletons']}, 03:07:27 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['bloom_basic']}, 03:07:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:27 INFO - 'tsvgr_opacity', 03:07:27 INFO - 'tart', 03:07:27 INFO - 'tscrollx', 03:07:27 INFO - 'tsvg_static']}, 03:07:27 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['tsvgx', 03:07:27 INFO - 'tsvgr_opacity', 03:07:27 INFO - 'tart', 03:07:27 INFO - 'tscrollx', 03:07:27 INFO - 'tsvg_static']}, 03:07:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:07:27 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'talos_options': ['--disable-stylo'], 03:07:27 INFO - 'tests': ['tp5o']}, 03:07:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:07:27 INFO - 'talos_options': ['--mitmproxy', 03:07:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:07:27 INFO - '--firstNonBlankPaint'], 03:07:27 INFO - 'tests': ['tp6_google', 03:07:27 INFO - 'tp6_youtube', 03:07:27 INFO - 'tp6_amazon', 03:07:27 INFO - 'tp6_facebook']}, 03:07:27 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:07:27 INFO - 'talos_options': ['--disable-stylo', 03:07:27 INFO - '--mitmproxy', 03:07:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:07:27 INFO - '--firstNonBlankPaint'], 03:07:27 INFO - 'tests': ['tp6_google', 03:07:27 INFO - 'tp6_youtube', 03:07:27 INFO - 'tp6_amazon', 03:07:27 INFO - 'tp6_facebook']}, 03:07:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:07:27 INFO - 'talos_options': ['--stylo-threads=1', 03:07:27 INFO - '--mitmproxy', 03:07:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:07:27 INFO - '--firstNonBlankPaint'], 03:07:27 INFO - 'tests': ['tp6_google', 03:07:27 INFO - 'tp6_youtube', 03:07:27 INFO - 'tp6_amazon', 03:07:27 INFO - 'tp6_facebook']}, 03:07:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'talos_options': ['--xperf_path', 03:07:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:27 INFO - 'tests': ['tp5n']}, 03:07:27 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:07:27 INFO - 'talos_options': ['--disable-stylo', 03:07:27 INFO - '--xperf_path', 03:07:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:27 INFO - 'tests': ['tp5n']}}} 03:07:27 INFO - Running post-action listener: _resource_record_post_action 03:07:27 INFO - [mozharness: 2017-09-19 10:07:27.447800Z] Finished populate-webroot step (success) 03:07:27 INFO - [mozharness: 2017-09-19 10:07:27.447889Z] Running create-virtualenv step. 03:07:27 INFO - Running pre-action listener: _resource_record_pre_action 03:07:27 INFO - Running main action method: create_virtualenv 03:07:27 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:07:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:07:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:07:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:28 INFO - Installing pip...............done. 03:07:28 INFO - Return code: 0 03:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:07:28 INFO - Reading from file tmpfile_stdout 03:07:28 INFO - Output received: 03:07:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:07:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:28 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:07:28 INFO - Using env: {'DISPLAY': ':0', 03:07:28 INFO - 'HOME': '/home/cltbld', 03:07:28 INFO - 'LANG': 'en_US.UTF-8', 03:07:28 INFO - 'LANGUAGE': 'en_US:en', 03:07:28 INFO - 'LOGNAME': 'cltbld', 03:07:28 INFO - 'MAIL': '/var/mail/cltbld', 03:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:28 INFO - 'MOZ_NO_REMOTE': '1', 03:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:28 INFO - 'NO_EM_RESTART': '1', 03:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:28 INFO - 'PWD': '/builds/slave/test', 03:07:28 INFO - 'SHELL': '/bin/bash', 03:07:28 INFO - 'SHLVL': '1', 03:07:28 INFO - 'TERM': 'linux', 03:07:28 INFO - 'TMOUT': '86400', 03:07:28 INFO - 'USER': 'cltbld', 03:07:28 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:28 INFO - '_': '/tools/buildbot/bin/python'} 03:07:29 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:07:29 INFO - Downloading/unpacking pip>=1.5 03:07:29 INFO - Running setup.py egg_info for package pip 03:07:29 INFO - warning: no files found matching 'pip/cacert.pem' 03:07:29 INFO - warning: no files found matching '*.html' under directory 'docs' 03:07:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:07:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:07:29 INFO - Installing collected packages: pip 03:07:29 INFO - Found existing installation: pip 1.1 03:07:29 INFO - Uninstalling pip: 03:07:29 INFO - Successfully uninstalled pip 03:07:29 INFO - Running setup.py install for pip 03:07:29 INFO - warning: no files found matching 'pip/cacert.pem' 03:07:29 INFO - warning: no files found matching '*.html' under directory 'docs' 03:07:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:07:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:07:29 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:07:29 INFO - Successfully installed pip 03:07:29 INFO - Cleaning up... 03:07:29 INFO - Return code: 0 03:07:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07: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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:07:29 INFO - Using env: {'DISPLAY': ':0', 03:07:29 INFO - 'HOME': '/home/cltbld', 03:07:29 INFO - 'LANG': 'en_US.UTF-8', 03:07:29 INFO - 'LANGUAGE': 'en_US:en', 03:07:29 INFO - 'LOGNAME': 'cltbld', 03:07:29 INFO - 'MAIL': '/var/mail/cltbld', 03:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:29 INFO - 'MOZ_NO_REMOTE': '1', 03:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:29 INFO - 'NO_EM_RESTART': '1', 03:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:29 INFO - 'PWD': '/builds/slave/test', 03:07:29 INFO - 'SHELL': '/bin/bash', 03:07:29 INFO - 'SHLVL': '1', 03:07:29 INFO - 'TERM': 'linux', 03:07:29 INFO - 'TMOUT': '86400', 03:07:29 INFO - 'USER': 'cltbld', 03:07:29 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:29 INFO - '_': '/tools/buildbot/bin/python'} 03:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:29 INFO - Downloading/unpacking psutil>=3.1.1 03:07:29 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 03:07:29 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 03:07:29 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 03:07:29 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 03:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:31 INFO - Installing collected packages: psutil 03:07:31 INFO - Running setup.py install for psutil 03:07:31 INFO - building 'psutil._psutil_linux' extension 03:07:31 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 03:07:31 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 03:07:31 INFO - building 'psutil._psutil_posix' extension 03:07:31 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 03:07:32 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 03:07:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:32 INFO - Successfully installed psutil 03:07:32 INFO - Cleaning up... 03:07:32 INFO - Return code: 0 03:07:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:07:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:07:32 INFO - Using env: {'DISPLAY': ':0', 03:07:32 INFO - 'HOME': '/home/cltbld', 03:07:32 INFO - 'LANG': 'en_US.UTF-8', 03:07:32 INFO - 'LANGUAGE': 'en_US:en', 03:07:32 INFO - 'LOGNAME': 'cltbld', 03:07:32 INFO - 'MAIL': '/var/mail/cltbld', 03:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:32 INFO - 'MOZ_NO_REMOTE': '1', 03:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:32 INFO - 'NO_EM_RESTART': '1', 03:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:32 INFO - 'PWD': '/builds/slave/test', 03:07:32 INFO - 'SHELL': '/bin/bash', 03:07:32 INFO - 'SHLVL': '1', 03:07:32 INFO - 'TERM': 'linux', 03:07:32 INFO - 'TMOUT': '86400', 03:07:32 INFO - 'USER': 'cltbld', 03:07:32 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:32 INFO - '_': '/tools/buildbot/bin/python'} 03:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:07:33 INFO - Installing collected packages: mozsystemmonitor 03:07:33 INFO - Running setup.py install for mozsystemmonitor 03:07:33 INFO - Successfully installed mozsystemmonitor 03:07:33 INFO - Cleaning up... 03:07:34 INFO - Return code: 0 03:07:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:34 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:07:34 INFO - Using env: {'DISPLAY': ':0', 03:07:34 INFO - 'HOME': '/home/cltbld', 03:07:34 INFO - 'LANG': 'en_US.UTF-8', 03:07:34 INFO - 'LANGUAGE': 'en_US:en', 03:07:34 INFO - 'LOGNAME': 'cltbld', 03:07:34 INFO - 'MAIL': '/var/mail/cltbld', 03:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:34 INFO - 'MOZ_NO_REMOTE': '1', 03:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:34 INFO - 'NO_EM_RESTART': '1', 03:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:34 INFO - 'PWD': '/builds/slave/test', 03:07:34 INFO - 'SHELL': '/bin/bash', 03:07:34 INFO - 'SHLVL': '1', 03:07:34 INFO - 'TERM': 'linux', 03:07:34 INFO - 'TMOUT': '86400', 03:07:34 INFO - 'USER': 'cltbld', 03:07:34 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:34 INFO - '_': '/tools/buildbot/bin/python'} 03:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:07:34 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 03:07:34 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 03:07:34 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 03:07:34 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 03:07:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:07:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:07:35 INFO - warning: no files found matching '*.txt' 03:07:35 INFO - no previously-included directories found matching 'build' 03:07:35 INFO - no previously-included directories found matching 'dist' 03:07:35 INFO - no previously-included directories found matching '.git*' 03:07:35 INFO - Installing collected packages: jsonschema, functools32 03:07:35 INFO - Running setup.py install for functools32 03:07:35 INFO - warning: no files found matching '*.txt' 03:07:35 INFO - no previously-included directories found matching 'build' 03:07:35 INFO - no previously-included directories found matching 'dist' 03:07:35 INFO - no previously-included directories found matching '.git*' 03:07:35 INFO - Successfully installed jsonschema functools32 03:07:35 INFO - Cleaning up... 03:07:35 INFO - Return code: 0 03:07:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:35 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:07:35 INFO - Using env: {'DISPLAY': ':0', 03:07:35 INFO - 'HOME': '/home/cltbld', 03:07:35 INFO - 'LANG': 'en_US.UTF-8', 03:07:35 INFO - 'LANGUAGE': 'en_US:en', 03:07:35 INFO - 'LOGNAME': 'cltbld', 03:07:35 INFO - 'MAIL': '/var/mail/cltbld', 03:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:35 INFO - 'MOZ_NO_REMOTE': '1', 03:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:35 INFO - 'NO_EM_RESTART': '1', 03:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:35 INFO - 'PWD': '/builds/slave/test', 03:07:35 INFO - 'SHELL': '/bin/bash', 03:07:35 INFO - 'SHLVL': '1', 03:07:35 INFO - 'TERM': 'linux', 03:07:35 INFO - 'TMOUT': '86400', 03:07:35 INFO - 'USER': 'cltbld', 03:07:35 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:35 INFO - '_': '/tools/buildbot/bin/python'} 03:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:07:35 INFO - Cleaning up... 03:07:35 INFO - Return code: 0 03:07:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:35 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:07:35 INFO - Using env: {'DISPLAY': ':0', 03:07:35 INFO - 'HOME': '/home/cltbld', 03:07:35 INFO - 'LANG': 'en_US.UTF-8', 03:07:35 INFO - 'LANGUAGE': 'en_US:en', 03:07:35 INFO - 'LOGNAME': 'cltbld', 03:07:35 INFO - 'MAIL': '/var/mail/cltbld', 03:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:35 INFO - 'MOZ_NO_REMOTE': '1', 03:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:35 INFO - 'NO_EM_RESTART': '1', 03:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:35 INFO - 'PWD': '/builds/slave/test', 03:07:35 INFO - 'SHELL': '/bin/bash', 03:07:35 INFO - 'SHLVL': '1', 03:07:35 INFO - 'TERM': 'linux', 03:07:35 INFO - 'TMOUT': '86400', 03:07:35 INFO - 'USER': 'cltbld', 03:07:35 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:35 INFO - '_': '/tools/buildbot/bin/python'} 03:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:36 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 03:07:36 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 03:07:36 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 03:07:36 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 03:07:37 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:37 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 03:07:37 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 03:07:37 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 03:07:37 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 03:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:37 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 03:07:37 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 03:07:37 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 03:07:37 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 03:07:37 INFO - Downloading docopt-0.6.1.tar.gz 03:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:37 INFO - Running setup.py install for blobuploader 03:07:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:37 INFO - Running setup.py install for requests 03:07:38 INFO - Running setup.py install for docopt 03:07:38 INFO - Successfully installed blobuploader requests docopt 03:07:38 INFO - Cleaning up... 03:07:38 INFO - Return code: 0 03:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:38 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:38 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:07:38 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:38 INFO - Using env: {'DISPLAY': ':0', 03:07:38 INFO - 'HOME': '/home/cltbld', 03:07:38 INFO - 'LANG': 'en_US.UTF-8', 03:07:38 INFO - 'LANGUAGE': 'en_US:en', 03:07:38 INFO - 'LOGNAME': 'cltbld', 03:07:38 INFO - 'MAIL': '/var/mail/cltbld', 03:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:38 INFO - 'MOZ_NO_REMOTE': '1', 03:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:38 INFO - 'NO_EM_RESTART': '1', 03:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:38 INFO - 'PWD': '/builds/slave/test', 03:07:38 INFO - 'SHELL': '/bin/bash', 03:07:38 INFO - 'SHLVL': '1', 03:07:38 INFO - 'TERM': 'linux', 03:07:38 INFO - 'TMOUT': '86400', 03:07:38 INFO - 'USER': 'cltbld', 03:07:38 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:38 INFO - '_': '/tools/buildbot/bin/python'} 03:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:38 INFO - Running setup.py (path:/tmp/pip-eKPUkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:38 INFO - Running setup.py (path:/tmp/pip-iAF73o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:38 INFO - Running setup.py (path:/tmp/pip-6Sseqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:38 INFO - Running setup.py (path:/tmp/pip-I5DVgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:38 INFO - Running setup.py (path:/tmp/pip-x_kTp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:38 INFO - Running setup.py (path:/tmp/pip-RExt12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:39 INFO - Running setup.py (path:/tmp/pip-GdZGIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:39 INFO - Running setup.py (path:/tmp/pip-Hn3fIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:39 INFO - Running setup.py (path:/tmp/pip-OIdwnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:39 INFO - Running setup.py (path:/tmp/pip-PAfGkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:39 INFO - Running setup.py (path:/tmp/pip-RByjF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:39 INFO - Running setup.py (path:/tmp/pip-JmlOnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:39 INFO - Running setup.py (path:/tmp/pip-rsWFu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:39 INFO - Running setup.py (path:/tmp/pip-GxGtsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:39 INFO - Running setup.py (path:/tmp/pip-3E4WcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:39 INFO - Running setup.py (path:/tmp/pip-S88DLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:39 INFO - Running setup.py (path:/tmp/pip-7GAFWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:39 INFO - Running setup.py install for manifestparser 03:07:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:39 INFO - Running setup.py install for mozcrash 03:07:40 INFO - Running setup.py install for mozdebug 03:07:40 INFO - Running setup.py install for mozdevice 03:07:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Running setup.py install for mozfile 03:07:40 INFO - Running setup.py install for mozhttpd 03:07:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Running setup.py install for mozinfo 03:07:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Running setup.py install for mozInstall 03:07:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Running setup.py install for mozleak 03:07:40 INFO - Running setup.py install for mozlog 03:07:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Running setup.py install for moznetwork 03:07:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:40 INFO - Running setup.py install for mozprocess 03:07:41 INFO - Running setup.py install for mozprofile 03:07:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:41 INFO - Running setup.py install for mozrunner 03:07:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:41 INFO - Running setup.py install for mozscreenshot 03:07:41 INFO - Running setup.py install for moztest 03:07:41 INFO - Running setup.py install for mozversion 03:07:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:41 INFO - Cleaning up... 03:07:41 INFO - Return code: 0 03:07:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:41 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:41 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:07:41 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:41 INFO - Using env: {'DISPLAY': ':0', 03:07:41 INFO - 'HOME': '/home/cltbld', 03:07:41 INFO - 'LANG': 'en_US.UTF-8', 03:07:41 INFO - 'LANGUAGE': 'en_US:en', 03:07:41 INFO - 'LOGNAME': 'cltbld', 03:07:41 INFO - 'MAIL': '/var/mail/cltbld', 03:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:41 INFO - 'MOZ_NO_REMOTE': '1', 03:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:41 INFO - 'NO_EM_RESTART': '1', 03:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:41 INFO - 'PWD': '/builds/slave/test', 03:07:41 INFO - 'SHELL': '/bin/bash', 03:07:41 INFO - 'SHLVL': '1', 03:07:41 INFO - 'TERM': 'linux', 03:07:41 INFO - 'TMOUT': '86400', 03:07:41 INFO - 'USER': 'cltbld', 03:07:41 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:41 INFO - '_': '/tools/buildbot/bin/python'} 03:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:41 INFO - Running setup.py (path:/tmp/pip-d9ghjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:41 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)) 03:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:41 INFO - Running setup.py (path:/tmp/pip-Hc9a29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 03:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:41 INFO - Running setup.py (path:/tmp/pip-zllZRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:41 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)) 03:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:41 INFO - Running setup.py (path:/tmp/pip-3lHrDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:42 INFO - Running setup.py (path:/tmp/pip-NOKI0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:42 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:42 INFO - Running setup.py (path:/tmp/pip-HrirrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:42 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:42 INFO - Running setup.py (path:/tmp/pip-ZKIGIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:42 INFO - Running setup.py (path:/tmp/pip-BpjOGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:42 INFO - Running setup.py (path:/tmp/pip-3eryBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:42 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:42 INFO - Running setup.py (path:/tmp/pip-W0FxxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:42 INFO - Running setup.py (path:/tmp/pip-rIuSSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:42 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:42 INFO - Running setup.py (path:/tmp/pip-G6N_Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:42 INFO - Running setup.py (path:/tmp/pip-tXoF47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:42 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:42 INFO - Running setup.py (path:/tmp/pip-wYh2sF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:42 INFO - Running setup.py (path:/tmp/pip-sOEPbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:42 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:42 INFO - Running setup.py (path:/tmp/pip-lAYnbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 03:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:42 INFO - Running setup.py (path:/tmp/pip-3xv1RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:43 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)) 03:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:07:43 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)) 03:07:43 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:43 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:07:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:44 INFO - Downloading blessings-1.6.tar.gz 03:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:44 INFO - Installing collected packages: blessings 03:07:44 INFO - Running setup.py install for blessings 03:07:44 INFO - Successfully installed blessings 03:07:44 INFO - Cleaning up... 03:07:44 INFO - Return code: 0 03:07:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:44 INFO - Reading from file tmpfile_stdout 03:07:44 INFO - Current package versions: 03:07:44 INFO - argparse == 1.2.1 03:07:44 INFO - blessings == 1.6 03:07:44 INFO - blobuploader == 1.2.4 03:07:44 INFO - docopt == 0.6.1 03:07:44 INFO - functools32 == 3.2.3-2 03:07:44 INFO - jsonschema == 2.5.1 03:07:44 INFO - manifestparser == 1.1 03:07:44 INFO - mozInstall == 1.13 03:07:44 INFO - mozcrash == 1.0 03:07:44 INFO - mozdebug == 0.1 03:07:44 INFO - mozdevice == 0.51 03:07:44 INFO - mozfile == 1.2 03:07:44 INFO - mozhttpd == 0.7 03:07:44 INFO - mozinfo == 0.10 03:07:44 INFO - mozleak == 0.1 03:07:44 INFO - mozlog == 3.5 03:07:44 INFO - moznetwork == 0.27 03:07:44 INFO - mozprocess == 0.25 03:07:44 INFO - mozprofile == 0.28 03:07:44 INFO - mozrunner == 6.13 03:07:44 INFO - mozscreenshot == 0.1 03:07:44 INFO - mozsystemmonitor == 0.3 03:07:44 INFO - moztest == 0.8 03:07:44 INFO - mozversion == 1.4 03:07:44 INFO - psutil == 3.1.1 03:07:44 INFO - requests == 1.2.3 03:07:44 INFO - wsgiref == 0.1.2 03:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:44 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:44 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:07:44 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:07:44 INFO - Using env: {'DISPLAY': ':0', 03:07:44 INFO - 'HOME': '/home/cltbld', 03:07:44 INFO - 'LANG': 'en_US.UTF-8', 03:07:44 INFO - 'LANGUAGE': 'en_US:en', 03:07:44 INFO - 'LOGNAME': 'cltbld', 03:07:44 INFO - 'MAIL': '/var/mail/cltbld', 03:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:44 INFO - 'MOZ_NO_REMOTE': '1', 03:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:44 INFO - 'NO_EM_RESTART': '1', 03:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:44 INFO - 'PWD': '/builds/slave/test', 03:07:44 INFO - 'SHELL': '/bin/bash', 03:07:44 INFO - 'SHLVL': '1', 03:07:44 INFO - 'TERM': 'linux', 03:07:44 INFO - 'TMOUT': '86400', 03:07:44 INFO - 'USER': 'cltbld', 03:07:44 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:44 INFO - '_': '/tools/buildbot/bin/python'} 03:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 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)) 03:07:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:07:44 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 03:07:44 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 03:07:44 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 03:07:44 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 03:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:07:45 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)) 03:07:45 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)) 03:07:45 INFO - Installing collected packages: simplejson 03:07:45 INFO - Running setup.py install for simplejson 03:07:46 INFO - building 'simplejson._speedups' extension 03:07:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:07:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:07:46 INFO - Successfully installed simplejson 03:07:46 INFO - Cleaning up... 03:07:47 INFO - Return code: 0 03:07:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:47 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/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 0xb761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', '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 03:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:07:47 INFO - Using env: {'DISPLAY': ':0', 03:07:47 INFO - 'HOME': '/home/cltbld', 03:07:47 INFO - 'LANG': 'en_US.UTF-8', 03:07:47 INFO - 'LANGUAGE': 'en_US:en', 03:07:47 INFO - 'LOGNAME': 'cltbld', 03:07:47 INFO - 'MAIL': '/var/mail/cltbld', 03:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:47 INFO - 'MOZ_NO_REMOTE': '1', 03:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:07:47 INFO - 'NO_EM_RESTART': '1', 03:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:47 INFO - 'PWD': '/builds/slave/test', 03:07:47 INFO - 'SHELL': '/bin/bash', 03:07:47 INFO - 'SHLVL': '1', 03:07:47 INFO - 'TERM': 'linux', 03:07:47 INFO - 'TMOUT': '86400', 03:07:47 INFO - 'USER': 'cltbld', 03:07:47 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:47 INFO - '_': '/tools/buildbot/bin/python'} 03:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:07:47 INFO - Cleaning up... 03:07:47 INFO - Return code: 0 03:07:47 INFO - Running post-action listener: _resource_record_post_action 03:07:47 INFO - Running post-action listener: _start_resource_monitoring 03:07:47 INFO - Starting resource monitoring. 03:07:47 INFO - [mozharness: 2017-09-19 10:07:47.291369Z] Finished create-virtualenv step (success) 03:07:47 INFO - [mozharness: 2017-09-19 10:07:47.291876Z] Running install step. 03:07:47 INFO - Running pre-action listener: _resource_record_pre_action 03:07:47 INFO - Running main action method: install 03:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:07:47 INFO - Reading from file tmpfile_stdout 03:07:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:07:47 INFO - Reading from file tmpfile_stdout 03:07:47 INFO - Output received: 03:07:47 INFO - Usage: mozinstall [options] installer 03:07:47 INFO - Options: 03:07:47 INFO - -h, --help show this help message and exit 03:07:47 INFO - -d DEST, --destination=DEST 03:07:47 INFO - Directory to install application into. [default: 03:07:47 INFO - "/builds/slave/test"] 03:07:47 INFO - --app=APP Application being installed. [default: firefox] 03:07:47 INFO - mkdir: /builds/slave/test/build/application 03:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:08:05 INFO - Reading from file tmpfile_stdout 03:08:05 INFO - Output received: 03:08:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:08:05 INFO - Running post-action listener: _resource_record_post_action 03:08:05 INFO - [mozharness: 2017-09-19 10:08:05.419189Z] Finished install step (success) 03:08:05 INFO - [mozharness: 2017-09-19 10:08:05.419438Z] Running setup-mitmproxy step. 03:08:05 INFO - Running pre-action listener: _resource_record_pre_action 03:08:05 INFO - Running main action method: setup_mitmproxy 03:08:05 INFO - Skipping: mitmproxy is not required 03:08:05 INFO - Running post-action listener: _resource_record_post_action 03:08:05 INFO - [mozharness: 2017-09-19 10:08:05.420691Z] Finished setup-mitmproxy step (success) 03:08:05 INFO - [mozharness: 2017-09-19 10:08:05.420910Z] Running run-tests step. 03:08:05 INFO - Running pre-action listener: _resource_record_pre_action 03:08:05 INFO - Running pre-action listener: _set_gcov_prefix 03:08:05 INFO - Running main action method: run_tests 03:08:05 WARNING - Try message not found. 03:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:08:05 INFO - Python 2.7.3 03:08:05 INFO - Return code: 0 03:08:05 INFO - grabbing minidump binary from tooltool 03:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:08:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0xee6090>, '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 0xee6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:08:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 03:08:05 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:08:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 03:08:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:08:05 INFO - Return code: 0 03:08:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:08:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:08:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:08:05 INFO - ENV: RUST_BACKTRACE is now full 03:08:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:08:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 03:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 03:08:05 INFO - Using env: {'DISPLAY': ':0', 03:08:05 INFO - 'HOME': '/home/cltbld', 03:08:05 INFO - 'LANG': 'en_US.UTF-8', 03:08:05 INFO - 'LANGUAGE': 'en_US:en', 03:08:05 INFO - 'LOGNAME': 'cltbld', 03:08:05 INFO - 'MAIL': '/var/mail/cltbld', 03:08:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:08:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:05 INFO - 'MOZ_NO_REMOTE': '1', 03:08:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:05 INFO - 'NO_EM_RESTART': '1', 03:08:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:05 INFO - 'PWD': '/builds/slave/test', 03:08:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:08:05 INFO - 'RUST_BACKTRACE': 'full', 03:08:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:08:05 INFO - 'SHELL': '/bin/bash', 03:08:05 INFO - 'SHLVL': '1', 03:08:05 INFO - 'TERM': 'linux', 03:08:05 INFO - 'TMOUT': '86400', 03:08:05 INFO - 'USER': 'cltbld', 03:08:05 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:05 INFO - '_': '/tools/buildbot/bin/python'} 03:08:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 03:08:05 INFO - mozversion application_buildid: 20170919091230 03:08:05 INFO - mozversion application_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:08:05 INFO - mozversion application_display_name: Nightly 03:08:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:08:05 INFO - mozversion application_name: Firefox 03:08:05 INFO - mozversion application_remotingname: firefox 03:08:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:08:05 INFO - mozversion application_vendor: Mozilla 03:08:05 INFO - mozversion application_version: 57.0a1 03:08:05 INFO - mozversion platform_buildid: 20170919091230 03:08:05 INFO - mozversion platform_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:08:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:08:05 INFO - mozversion platform_version: 57.0a1 03:08:05 INFO - using testdate: 1505815685 03:08:05 INFO - actual date: 1505815685 03:08:05 INFO - starting webserver on 'localhost:38858' 03:08:05 INFO - SUITE-START | Running 2 tests 03:08:05 INFO - TEST-START | dromaeo_css 03:08:05 INFO - Initialising browser for dromaeo_css test... 03:08:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38858/getInfo.html -profile /tmp/tmpLVAr4K/profile 03:08:05 INFO - TEST-INFO | started process 7858 (/builds/slave/test/build/application/firefox/firefox http://localhost:38858/getInfo.html) 03:08:11 INFO - TEST-INFO | 7858: exit 0 03:08:12 INFO - Browser initialized. 03:08:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:08:12 INFO - Using env: {'DISPLAY': ':0', 03:08:12 INFO - 'HOME': '/home/cltbld', 03:08:12 INFO - 'JSGC_DISABLE_POISONING': '1', 03:08:12 INFO - 'LANG': 'en_US.UTF-8', 03:08:12 INFO - 'LANGUAGE': 'en_US:en', 03:08:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:08:12 INFO - 'LOGNAME': 'cltbld', 03:08:12 INFO - 'MAIL': '/var/mail/cltbld', 03:08:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:08:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:08:12 INFO - 'MOZ_CRASHREPORTER': '1', 03:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:08:12 INFO - 'MOZ_NO_REMOTE': '1', 03:08:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:12 INFO - 'NO_EM_RESTART': '1', 03:08:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:12 INFO - 'PWD': '/builds/slave/test', 03:08:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:08:12 INFO - 'RUST_BACKTRACE': 'full', 03:08:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:08:12 INFO - 'SHELL': '/bin/bash', 03:08:12 INFO - 'SHLVL': '1', 03:08:12 INFO - 'TERM': 'linux', 03:08:12 INFO - 'TMOUT': '86400', 03:08:12 INFO - 'USER': 'cltbld', 03:08:12 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:12 INFO - '_': '/tools/buildbot/bin/python'} 03:08:12 INFO - TEST-INFO | started process 8092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLVAr4K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:12 INFO - PID 8092 | 03:08:12 INFO - PID 8092 | (/builds/slave/test/build/application/firefox/firefox:8141): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:08:12 INFO - PID 8092 | 03:08:23 INFO - PID 8092 | RSS: Main: 153862144 03:08:23 INFO - PID 8092 | 03:11:19 INFO - PID 8092 | Cycle 1(1): loaded http://localhost:38858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38858/tests/dromaeo/cssquery-ext.html) 03:11:20 INFO - PID 8092 | RSS: Main: 155381760 03:11:20 INFO - PID 8092 | 03:14:22 INFO - PID 8092 | Cycle 1(1): loaded http://localhost:38858/tests/dromaeo/cssquery-ext.html (next: http://localhost:38858/tests/dromaeo/cssquery-jquery.html) 03:14:23 INFO - PID 8092 | RSS: Main: 155160576 03:14:23 INFO - PID 8092 | 03:17:24 INFO - PID 8092 | Cycle 1(1): loaded http://localhost:38858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38858/tests/dromaeo/cssquery-mootools.html) 03:17:25 INFO - PID 8092 | RSS: Main: 157057024 03:17:25 INFO - PID 8092 | 03:20:27 INFO - PID 8092 | Cycle 1(1): loaded http://localhost:38858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38858/tests/dromaeo/cssquery-prototype.html) 03:20:27 INFO - PID 8092 | RSS: Main: 155865088 03:20:27 INFO - PID 8092 | 03:23:30 INFO - PID 8092 | Cycle 1(1): loaded http://localhost:38858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38858/tests/dromaeo/cssquery-yui.html) 03:23:31 INFO - PID 8092 | RSS: Main: 157081600 03:23:31 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | Cycle 1(1): loaded http://localhost:38858/tests/dromaeo/cssquery-yui.html (next: http://localhost:38858/tests/dromaeo/cssquery-dojo.html) 03:26:33 INFO - PID 8092 | RSS: Main: 159121408 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | __start_tp_report 03:26:33 INFO - PID 8092 | _x_x_mozilla_page_load 03:26:33 INFO - PID 8092 | _x_x_mozilla_page_load_details 03:26:33 INFO - PID 8092 | |i|pagename|runs| 03:26:33 INFO - PID 8092 | |0;dojo.html;3105.9223519412;3116.5169398743196;3135.263213144911;3138.089953913365;3148.68513148685;6355.936440635593;6411.455026322762;6455.483561315095;6484.935150648492;6496.415322620963;6188.443040126388;6296.5277604179755;6302.968485157579;6307.400796924297;6346.777862774792;5837.562182836283;5853.678047707374;5933.970330148343;5961.910571341434;5967.194428752106;5755.0504166812425;5872.941270587304;5876.0598304271325;5978.22283103196;5986.371430999748;5333;5763.769449222047;5774.624649397797;5917.674527900964;5933.821985340447;5801.291604570293;5801.332846722638;5877.85305367365;5878.676672782995;5907.261592300963;5711.257536520267;5765.798197063083;5787.218725472049;5900.763969441217;5913.76344946206;6339.619622822645;6340.492760579143;6361.141245931786;6379.585326953779;6419.679016049179;6766.391024807791;6819.181698196248;6883.931160688379;6909.619970901598;6916.100906882123;6895.655217239168;6899.758508452231;6968;6972.860542789166;6981.464077902853;6260.812175634738;6324.557280990287;6347.333529979378;6358.618482891041;6373.075903993941;7005;7028.543144695578;7046.260142684944;7056.364927156581;7057.858842823115;6662.43369313604;6703.128593282842;6749.662516874137;6763.086983257295;6766.8646627068165;6783.762568310085;6818.318168183142;6835.213950395669;6898.517103802686;6907.378335949788;6629.138212032405;6640;6647.833804154838;6670.266270710218;6756.087928129639;6687;6763.661816909135;6786.966065169642;6792.117024786746;6794.218664853605;5370.3287089113865;5388.7305634718105;5392.838214853561;5394.3796463406425;5404.648697834628;4661.720296782204;4698.36572062774;4711.128441238382;4712.575868171881;4733.408323959505;5639.887202255932;5807.912881306784;5824.271966004249;5900.232969713996;5902.940970590239;6740.595564266062;6752.155980502437;6754.223264324665;6772.288909664513;6774.593524388552;5769.68266745333;5815.41845815415;5844.532437405082;5859.501942334864;5867.501262392744;5893.528517718572;5919.526437884959;5944.7324870380935;5963.045912654041;5966.075258334965;6469.191351081115;6557.737690492327;6562.146920900348;6567.770128045591;6575.934240657628;6673.132492775908;6773.93226067733;6872.450203983669;6946.756863509753;6947.583145011114;6522.771702990372;6534.771283005072;6581.2102547694585;6592.110065141144;6593.0769692244085;6800.421964132906;6833.93166068333;6838.658067096725;6847.520673553003;6851.07510486078;6893.448524118159;6895.862082758216;6973.895391569029;6980.825479363057;6982.930170698228;6396.136521569715;6635.4359879410795;6636.535442518977;6729.158855143107;6735.5958642479645;6539.509536784855;6546.312637173029;6547.181602299713;6599.076129341992;6608.669566521558;6560.147180866456;6597.3072827352435;6612.5040621952585;6642.568233064835;6658.900116498159;6680.899786503109;6711.765088221889;6719.059331693665;6787.0498130262795;6798.830029249309;6278.121063051085;6417.26201486835;6446.161998940108;6529.118568993125;6532 03:26:33 INFO - PID 8092 | |1;ext.html;822.7243873302447;859.9484030958143;865.4331412924537;873.4584557574304;873.934454915881;39099.413508797355;41057.58942410579;41102.58897411025;41261.58738412615;41434.58565414345;41438.37842432366;42015.78992105035;42068.15863682732;42127.789361053154;42193.156136877245;7619.847603047936;7690.961545192266;7699.422543309246;7712.3444507216955;7732.226777322279;7870.370370370357;7981.401394895377;7988.560629165423;7989;7999.920000799976;7991.520508769492;8095.5142691438405;8106.229908158745;8112.594370281462;8117.837643247131;7959.204079592052;8038.035435747718;8047.919520804776;8055.5166689998205;8062.959685201566;7890.723824666166;7933.444658873881;7944.801379965547;7946.24510671491;7966.362690984707;38218;38281.23437531262;38350.041248969;38472.80763596192;38603.22793544114;3514.9648503514895;3517.4547945068557;3538.8053657048854;3546.2375589248436;3546.733994950389;30959;31201.219969500944;31223.687763122307;31236.531452028237;31238.375232495222;5046.772895219724;5190.506901844356;5203.427622961509;5247.68513889164;5249.527542521191;181671.09164454226;183135;183230.99999999866;184083;184798;46837.531624684;46947.76526117416;47096.7645161772;47131.5286847134;47175.5282447178;48677.26984095242;48778.268325975136;48815.75592122017;49022;49079.26381104286;15816.28826702801;16150.75773863393;16163.272652730655;16168.676626467404;16175.110368929587;13254.73490530184;13303.46786128544;13320.067595268432;13322.134061285986;13337.066405351727;12290;12382;12466.688332791753;12535.686607834694;12634.052446066582;5418.349798024262;5472.890542189134;5498.268045565714;5513.476219759116;5538.889222215533;989.5992123190119;1000.559753708366;1002.3134153105146;1013.4476710192963;1018.5416562546884;22820.543589128123;22861.31416057521;22870;22947.541049178923;23331.300060998197;1096.9890301096887;1102.6361300770727;1106.8284415915546;1107.7507560798756;1115.5816568786704;12005.2196607222;12197.695057623452;12214.923463011131;12289.877101228873;12297.692557686129;206621;208664;208673;209638;210746;44927.775361122985;45757.31364029542;51650.74174629103;51775.48224517707;51981.48018519842;1464.8608382203674;1472.7864459653504;1480.3412481445869;1484.7253258147277;1493.7012597480548;26993.0552430664;27013.729862701908;27022.594661079707;27105;27119.45761084807;36820.263594728494;36856.44715329326;36917.63082369142;36926.26147476982;36973.81513092417;185322;185672;186853;187129;188883;31757.523637145925;32484;32484;32764.836175818968;32831.17922051872;40743.38884916788;40862.18275634411;40881.59118408778;41152.794236028625;41700.79149604232;30718.385632287675;30838.53742193824;30974.845125774227;31058.53412198864;31165;30550.930717424784;30990.760369584965;31108.377832443675;31239.375212495168;31507.68492315139;33889.66110338865;35072.824635876656;35279;35362;35431.11422214465;31178.844105780234;31284.37431251408;31298.21754456066;31386.686133138377;31975.520367194047;22849.31452056441;22925.231691171186;22988.310350689506;23157.88421057884;23324.183653572043 03:26:33 INFO - PID 8092 | |2;jquery.html;565.4882331490003;566.2271000084883;566.6062086849641;575.5065604755661;599.6372194822133;21766;22585;22598.54802903943;22634.66048009281;22689.54620907581;22647.886760566216;23844.8807755961;23847.880760596217;24102.276931692035;24299.75700242997;6325.2409710834645;6518.869622607545;6529.477641788645;6553.672316384185;6555.672216389185;6389.968050159743;6450.741970321182;6453.9354606454035;6484.4164025237715;6493.253275873288;6478.449331806779;6478.676066196671;6480.611163330215;6484.61092334459;6493.642849643268;6138.0792881067755;6467.838304042366;6483.708233129497;6489.286178520359;6489.35106489352;5926;5967.254093238345;5967.49276311514;5997.6701281429505;5999.760009599654;26954;27251.591226131623;27331.590026149624;27366.042188523505;27386;2055.5683306505503;2088.55096154326;2089.2896415218747;2097;2104.5370018595886;18076.36732714362;18096.18567164481;18769.7184542232;19100.33148839798;19130.330438434587;2380.4524959259466;2415.891284892184;2439.0853429963763;2448.0574978633176;2451.4361696809656;116682.41658791737;121128;127091.36454317669;131487;131755.34122329328;13955.930220348833;14272.215028173343;14346.915413186007;14435.2060636666;14533.546645335382;22005.33983980483;22022.33932982013;22043;22061.448463788533;22077;9744.951275243578;10008.649697260707;10037.74528183977;10122;10243.07812296897;9350.95324523373;9435.245180385553;9489.38319009276;9559.856602150974;9563.187129093965;8399.664013439395;8552.187542183483;8607.26838218746;8673.609687564074;8849.4247873888;2588.8576128312748;2735.083746944756;2737.055715778093;2775.4587855368413;2809.7330753578376;985.408754747146;994.2096033653119;1004.4525733475274;1021.4535223655308;1026.7843752811993;18185.363512277272;18945.905270473835;19064.237430502624;19118.617627647647;19288.80711192898;1060.3002018667796;1065.6856227412932;1066.7279843639822;1067.9359238445563;1074.3446497636435;10321.277510574339;10544.367337959748;10620.893791062144;10809.459527023617;10918.781624367468;455642;461489;471397;473233;474869;104805;105558;107996.46001769941;108022;110344.4482777597;1083.7832433513329;1125.1954852280658;1185.1407729396292;1211.1642966353188;1238.0467040378858;19371.128299226286;19449.611007780048;19603.509912252306;19835.60328793445;19854.10656520489;52362.47637523728;54567.45432545624;55137.1729424067;56085;57065.71467142638;62172;65462;65590;65765;66063.33936660764;13710.17738935667;14041.789373159207;14059.718805623626;14087.647808804863;14193.716125677634;21560.67658985085;21989.120435183053;22053;22054.558908822055;22162.66755998629;17536.298548057934;17775.555611109827;17872.642547149244;17965;18097;14852.85147148558;15067;15074.773878391614;15123.546293611209;15212.847871521142;18377.264909403475;18461.16924738417;18525.166367513764;18648.90675546668;18795.90602046981;13135.211887286794;13752.65618359549;13760.724785504033;13856.515021974183;13951.511697090553;17566.297348105934;17592.472225833244;17770.644587108443;17808.3767068152;18053.458396248134 03:26:33 INFO - PID 8092 | |3;mootools.html;1279.7440511897619;1380.2270728392098;1386.9306534673265;1390.131168019987;1394.6095093373858;14268.857311426882;14927.626809329759;14929.477468288613;14933.328000239988;14953.626159346022;14676.559703208894;14756.335964881579;14774.55676329709;14811;14845.257737113128;2695.541757901152;2719.333763228012;2758.5034693755115;2764.2812868654096;2765.3363192833776;2707.44497378037;2712.0914493644555;2723.496153211662;2726.0458839406247;2728.3315587680945;2627.8160528762996;2693.8383696978144;2702.9459410811774;2703.9324016899636;2705.1208357283863;2547.1339744486872;2578.5487539680576;2584.586466165414;2586.702529209146;2591.2873959661056;2459.544984177915;2479.0579579759756;2503.7496250374816;2512.874356282197;2517.144170981875;14062.71874562503;14285.428582856777;14288.142711437347;14298.57104286873;14336;7619.695212191561;7853.332466740277;7874.094479134916;7883.054033515958;7885.605719714049;5084.161113416282;5283.86790330241;5366.838994830161;5406.378266499363;5562.888742225133;1936.8644194906362;1937.3897222374908;1995.3515107590092;2036.6537688592975;2041.5406533529986;21848.12607495698;22773.772262277333;24072.03711851524;24110.758892411028;24557.631635525482;7001.474889383317;7051.435885129177;7207.603581802946;7222.169450513258;7227.349538541556;19110.522236944187;19187.904060479887;19201;19202.51993700141;19232.71150932737;7939.761807145795;8035.116137224901;8036.075851277178;8045.477043992122;8083.474574152779;7009.509334346547;7127.643617819192;7353.264673532711;7373.373263272575;7422.517536360119;5377.381601115843;5525.4474552544425;5551.139573366135;5593.944060559424;5605.439456054362;1774.3612299572144;1780.1366337326385;1782.5008997480727;1784.2773676660972;1788.499220218341;873.2926329672986;885.9766969150642;896.6727144592177;898.1512470715242;903.3902116071625;7836.412269079842;7867.370610351159;7996.200379961957;8046.1551537088935;8057.717979870677;716.5091912040165;717.8205448637841;726.8655298769745;730.3098571849551;738.3059923671732;4450.421445212101;4490.326451032372;4538.818447262139;4584.862454126382;4592.954070459319;19542.804571954097;19831.107600158026;20472.897635511727;20518.17927282892;20524.692129618066;20389;20478.897605511876;20507.794922050885;20520.486987825425;20529.076191571414;9403.623855045858;10675.946620266848;10801.189910756724;10828.512716927757;10848.186386020921;8545.957270213608;8666.913330866611;8685;8715.738527844174;8814.5592720365;17207.483775486755;17472;17684.29262829524;17942;18246.72629910526;18233.179506921955;18254;18463.53841153982;18507.259709611466;18634.06829658539;10918.836217456903;11020.889791101987;11046.392448415414;11083.94458027737;11087.279326843729;13300.733985320432;13464.192148471124;13466.528671496451;13469.528566500125;13493.325333733077;11149.219554631098;11193.776124477628;11324.32054076758;11443.485043173243;11519.19365644397;10838.837417438586;10861.511231994422;10868.51091700891;10886.183536234972;11158.665240042812;9175.678851240174;9297.535123243675;9299.860502092339;9305.674301399418;9308.906910930804;6759.763408280686;6857.862842743018;6858.41703455192;6940.13248343957;7051.682674279772;6700.396964273239;6729.360710732472;6742.123523941857;6797.89803152963;6986.755463558751 03:26:33 INFO - PID 8092 | |4;prototype.html;500.63826392213167;504.3418339067517;529.7377797989994;529.8066205834872;531.2509361799863;6138.475372165054;6157.9999999999945;6173.475254603359;6186.783462578811;6285.7314196617735;6083.300420451649;6114.1745864308305;6120.846978825532;6123.908141377883;6188.597741146834;5097.1844504879045;5131.589472842183;5132.717700526469;5148.2020286855595;5150.896982060356;4823.541763532458;5126.256692779563;5127.897442051157;5181.844544663666;5206.843794686147;4826.227803551433;4884.413870335565;4907.5583197512215;4924.630652701044;4936.925946110811;4860.035378419161;4860.392450943632;4917.3607431033915;4936.185529387647;4968.925466118011;4324.416203812477;4365.192439398721;4399.362092496602;4424.867253982386;4455.955440445587;5938.7624495020145;5992.520598352121;6045.576809623328;6054.72753726079;6076.392360763933;5583.8883222335735;5602.551795856362;5625.8593535161535;5627.409122042209;5664.433556644344;6432.292447830735;6496.719156825773;6500.609963402211;6525.3800888915475;6530.216374035146;4583.427071616048;4808.687435316693;4849.587785038276;4861.003494283698;4864.440589332236;6545.770898018546;6648.800535983928;6674.866502669919;6681.298463661343;6731.798046058577;4896.632752543574;4912.926306105412;4914.950850491521;4942.851714448572;4965.1807451770055;4947.604191664658;4964.652474326835;4984.675996060245;4987.1771157759285;5032.194848824171;5486;5522.144067669517;5595.552355811526;5598.4961353477565;5607.15909601924;6448.258450278278;6541.443977261891;6556.737730490822;6561.737530498726;6562.4578224117295;1712.383541924906;1726.8877522960968;1737.878348515617;1739.7651317072034;1748.5628592851788;1152.7175841918784;1195.9940200298943;1199.7660456210956;1205.6804946689135;1210.661014915825;5520.227168196456;5521.254630624894;5545.833624991256;5572.609917305831;5584.134459158837;6408.455281301141;6503.447206987459;6515.381038801306;6560.540762146699;6579.868402631921;5457.67082079931;5466.562674985991;5541;5575.916361254584;5603;3385.81378024211;3388.678075582816;3418.2225242873565;3451.378751824696;3461.221225224355;6099.786507472217;6175.907361389583;6202.844928876724;6209.280946480707;6229.50163986889;6678.198616166092;6682.431993280626;6813.420859226922;6837;6850.897236541456;6199.690015499297;6276.340984196594;6320.905186422207;6343.238811342669;6389.8722025560155;6045.458408106081;6532.183477065367;6540.345965403421;6550.508711846726;6629.740349333611;6296.905546416899;6336.366363363627;6355.237371515448;6417.39034791694;6490.415862572391;6100.176476175659;6113.419225173601;6180.7527698891545;6195.535334849814;6233.594816336924;4855.417349918032;4867.3915760529935;4869.780859861244;4914.7542622867995;4923.5814955729165;6321.30465648769;6471.644059576768;6506.967465162644;6523.575967562093;6588.967055164693;6366.808995730135;6377.7767778127545;6394.680265986589;6435.51733619971;6447.161868957006;6367.872642547216;6403.455706265019;6404.423601875667;6460.612363258219;6466.385693359123;6225.31521532622;6255.687215639291;6292.276388215414;6340.619562826245;6378.904316435164;6429.646369449725;6431.421172094534;6438.615697625033;6471.482281417381;6496.967515162583;6106;6125.203723515914;6231.470325022243;6234.470070044097;6268.1851359323 03:26:33 INFO - PID 8092 | |5;yui.html;880.0451510111533;894.096962068311;897.138746803069;915.0483497162943;920.4017388697346;16977.2360243789;17531;17561.38535151267;17606.82393176068;22017.559648807055;21230.15079396826;22253.44366390841;22340.21809236673;22427.102915883344;22552.436189095282;963.137991497611;970.9514524273793;971.028971028971;974.7758015656403;975.0103644800533;906.5875026862761;991.5339790298548;993.7962717642865;997.2122023601346;999.3703966501095;1032.9070383665505;1033.1166852341253;1035.1046344911636;1038.096855735511;1038.2887721910479;1030.3766221436074;1031.8400647899587;1040.47976011994;1040.6201736366247;1044.1333693034762;758.525921299188;758.594152128614;759.5974133709143;766.3639179481017;766.3639179481017;19868.90065549663;20550.38348849537;20877.269295574733;20885.164593416244;20921.581568368547;21887.233946811943;21949.561008779896;22255;22304;22448.102075916944;17673.55816104595;17858.19638116275;17948.282068717235;17951.551211219692;17980;3613.1870329175986;3627.2926779277786;3638.872639457633;3639.017465284385;3650.0509867434394;141644;143814;144152;145950.27024864807;146012;16862.494125176265;16912.154392280336;17109.657806843792;17114.229859656345;17359.21883515245;30293.394132117675;30878;31592.36815263682;31760.205994850312;31853.840730796197;7112.110986126734;7214.6031968241205;7266.564006159648;7288.271172882775;7297.635118244173;4165.791710414528;4185.351270553069;4218.282891908383;4261.509926358509;4266.658667306608;4989.451160372356;4996.325496058058;5281.841544753664;5458.317710286215;5579.442055794388;1150.1546363422879;1181.4151994762647;1181.6868529839599;1184.0882520459197;1184.538030168235;667.9933200667931;674.2684187656448;682.5154140560257;685.9211190713032;692.5013989927244;12026.819597706042;12030.157888947864;12507.624771256877;12786.9360653198;12985;682.743971010871;688.2635579929428;697.1251079894801;700.8808502554577;701.9438444924393;5870.899955681864;5918.7928422505;5925.170476133345;5929.169916211734;5991.940080599225;126424.36787816002;126849;127414;128336;129113;104694.47652761688;106119.4694026525;107855.46072269745;107951.46024269829;108667;94345;96937.51531242298;97142.51428742953;98271.50864245633;99441.50279248557;11038.392888391216;11090.833637495283;11129.220954533104;11162.888371116185;11277.943610282224;44584.55415445804;44769.77615111903;46215.22708637492;47225.29162062503;47240;56812;57919.4208057914;59427.40572594219;59562.702186488794;61585.384146157965;14858.108513489226;15177.317020734314;15241;15367.538973830802;15428;17631.20659570348;17753;17812;17871.642567148843;18131.36540221086;15484.690306194037;16534.83465165333;16616.335346586002;16693.582660433585;16699.833001670315;14459.78310325367;14782.926085369505;14788.334524946187;15419.151946643042;15459.91780575394;15901.284442199898;16032.11823349727;16038.198090095682;16122.758158627395;16144.273507691947;11499.54001839917;11518.424078796193;11748.060155187735;11799.587014454453;12015.158938874194;11911.523539058688;11939.52241910314;12060.879391205975;12291.262524248574;12354.567590134302 03:26:33 INFO - PID 8092 | __end_tp_report 03:26:33 INFO - PID 8092 | __start_cc_report 03:26:33 INFO - PID 8092 | _x_x_mozilla_cycle_collect,279 03:26:33 INFO - PID 8092 | __end_cc_report 03:26:33 INFO - PID 8092 | __startTimestamp1505816793409__endTimestamp 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | ------- Summary: start ------- 03:26:33 INFO - PID 8092 | Number of tests: 6 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | [#0] dojo.html Cycles:165 Average:6266.33 Median:6532.00 stddev:764.02 (11.7%) stddev-sans-first:725.02 03:26:33 INFO - PID 8092 | Values: 3105.9 3116.5 3135.3 3138.1 3148.7 6355.9 6411.5 6455.5 6484.9 6496.4 6188.4 6296.5 6303.0 6307.4 6346.8 5837.6 5853.7 5934.0 5961.9 5967.2 5755.1 5872.9 5876.1 5978.2 5986.4 5333.0 5763.8 5774.6 5917.7 5933.8 5801.3 5801.3 5877.9 5878.7 5907.3 5711.3 5765.8 5787.2 5900.8 5913.8 6339.6 6340.5 6361.1 6379.6 6419.7 6766.4 6819.2 6883.9 6909.6 6916.1 6895.7 6899.8 6968.0 6972.9 6981.5 6260.8 6324.6 6347.3 6358.6 6373.1 7005.0 7028.5 7046.3 7056.4 7057.9 6662.4 6703.1 6749.7 6763.1 6766.9 6783.8 6818.3 6835.2 6898.5 6907.4 6629.1 6640.0 6647.8 6670.3 6756.1 6687.0 6763.7 6787.0 6792.1 6794.2 5370.3 5388.7 5392.8 5394.4 5404.6 4661.7 4698.4 4711.1 4712.6 4733.4 5639.9 5807.9 5824.3 5900.2 5902.9 6740.6 6752.2 6754.2 6772.3 6774.6 5769.7 5815.4 5844.5 5859.5 5867.5 5893.5 5919.5 5944.7 5963.0 5966.1 6469.2 6557.7 6562.1 6567.8 6575.9 6673.1 6773.9 6872.5 6946.8 6947.6 6522.8 6534.8 6581.2 6592.1 6593.1 6800.4 6833.9 6838.7 6847.5 6851.1 6893.4 6895.9 6973.9 6980.8 6982.9 6396.1 6635.4 6636.5 6729.2 6735.6 6539.5 6546.3 6547.2 6599.1 6608.7 6560.1 6597.3 6612.5 6642.6 6658.9 6680.9 6711.8 6719.1 6787.0 6798.8 6278.1 6417.3 6446.2 6529.1 6532.0 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | [#1] ext.html Cycles:180 Average:36135.12 Median:19293.89 stddev:49916.90 (258.7%) stddev-sans-first:49986.51 03:26:33 INFO - PID 8092 | Values: 822.7 859.9 865.4 873.5 873.9 39099.4 41057.6 41102.6 41261.6 41434.6 41438.4 42015.8 42068.2 42127.8 42193.2 7619.8 7691.0 7699.4 7712.3 7732.2 7870.4 7981.4 7988.6 7989.0 7999.9 7991.5 8095.5 8106.2 8112.6 8117.8 7959.2 8038.0 8047.9 8055.5 8063.0 7890.7 7933.4 7944.8 7946.2 7966.4 38218.0 38281.2 38350.0 38472.8 38603.2 3515.0 3517.5 3538.8 3546.2 3546.7 30959.0 31201.2 31223.7 31236.5 31238.4 5046.8 5190.5 5203.4 5247.7 5249.5 181671.1 183135.0 183231.0 184083.0 184798.0 46837.5 46947.8 47096.8 47131.5 47175.5 48677.3 48778.3 48815.8 49022.0 49079.3 15816.3 16150.8 16163.3 16168.7 16175.1 13254.7 13303.5 13320.1 13322.1 13337.1 12290.0 12382.0 12466.7 12535.7 12634.1 5418.3 5472.9 5498.3 5513.5 5538.9 989.6 1000.6 1002.3 1013.4 1018.5 22820.5 22861.3 22870.0 22947.5 23331.3 1097.0 1102.6 1106.8 1107.8 1115.6 12005.2 12197.7 12214.9 12289.9 12297.7 206621.0 208664.0 208673.0 209638.0 210746.0 44927.8 45757.3 51650.7 51775.5 51981.5 1464.9 1472.8 1480.3 1484.7 1493.7 26993.1 27013.7 27022.6 27105.0 27119.5 36820.3 36856.4 36917.6 36926.3 36973.8 185322.0 185672.0 186853.0 187129.0 188883.0 31757.5 32484.0 32484.0 32764.8 32831.2 40743.4 40862.2 40881.6 41152.8 41700.8 30718.4 30838.5 30974.8 31058.5 31165.0 30550.9 30990.8 31108.4 31239.4 31507.7 33889.7 35072.8 35279.0 35362.0 35431.1 31178.8 31284.4 31298.2 31386.7 31975.5 22849.3 22925.2 22988.3 23157.9 23324.2 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | [#2] jquery.html Cycles:180 Average:32997.31 Median:22013.84 stddev:78413.81 (356.2%) stddev-sans-first:78595.97 03:26:33 INFO - PID 8092 | Values: 565.5 566.2 566.6 575.5 599.6 21766.0 22585.0 22598.5 22634.7 22689.5 22647.9 23844.9 23847.9 24102.3 24299.8 6325.2 6518.9 6529.5 6553.7 6555.7 6390.0 6450.7 6453.9 6484.4 6493.3 6478.4 6478.7 6480.6 6484.6 6493.6 6138.1 6467.8 6483.7 6489.3 6489.4 5926.0 5967.3 5967.5 5997.7 5999.8 26954.0 27251.6 27331.6 27366.0 27386.0 2055.6 2088.6 2089.3 2097.0 2104.5 18076.4 18096.2 18769.7 19100.3 19130.3 2380.5 2415.9 2439.1 2448.1 2451.4 116682.4 121128.0 127091.4 131487.0 131755.3 13955.9 14272.2 14346.9 14435.2 14533.5 22005.3 22022.3 22043.0 22061.4 22077.0 9745.0 10008.6 10037.7 10122.0 10243.1 9351.0 9435.2 9489.4 9559.9 9563.2 8399.7 8552.2 8607.3 8673.6 8849.4 2588.9 2735.1 2737.1 2775.5 2809.7 985.4 994.2 1004.5 1021.5 1026.8 18185.4 18945.9 19064.2 19118.6 19288.8 1060.3 1065.7 1066.7 1067.9 1074.3 10321.3 10544.4 10620.9 10809.5 10918.8 455642.0 461489.0 471397.0 473233.0 474869.0 104805.0 105558.0 107996.5 108022.0 110344.4 1083.8 1125.2 1185.1 1211.2 1238.0 19371.1 19449.6 19603.5 19835.6 19854.1 52362.5 54567.5 55137.2 56085.0 57065.7 62172.0 65462.0 65590.0 65765.0 66063.3 13710.2 14041.8 14059.7 14087.6 14193.7 21560.7 21989.1 22053.0 22054.6 22162.7 17536.3 17775.6 17872.6 17965.0 18097.0 14852.9 15067.0 15074.8 15123.5 15212.8 18377.3 18461.2 18525.2 18648.9 18795.9 13135.2 13752.7 13760.7 13856.5 13951.5 17566.3 17592.5 17770.6 17808.4 18053.5 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | [#3] mootools.html Cycles:180 Average:9048.55 Median:2581.57 stddev:6313.20 (244.5%) stddev-sans-first:6303.93 03:26:33 INFO - PID 8092 | Values: 1279.7 1380.2 1386.9 1390.1 1394.6 14268.9 14927.6 14929.5 14933.3 14953.6 14676.6 14756.3 14774.6 14811.0 14845.3 2695.5 2719.3 2758.5 2764.3 2765.3 2707.4 2712.1 2723.5 2726.0 2728.3 2627.8 2693.8 2702.9 2703.9 2705.1 2547.1 2578.5 2584.6 2586.7 2591.3 2459.5 2479.1 2503.7 2512.9 2517.1 14062.7 14285.4 14288.1 14298.6 14336.0 7619.7 7853.3 7874.1 7883.1 7885.6 5084.2 5283.9 5366.8 5406.4 5562.9 1936.9 1937.4 1995.4 2036.7 2041.5 21848.1 22773.8 24072.0 24110.8 24557.6 7001.5 7051.4 7207.6 7222.2 7227.3 19110.5 19187.9 19201.0 19202.5 19232.7 7939.8 8035.1 8036.1 8045.5 8083.5 7009.5 7127.6 7353.3 7373.4 7422.5 5377.4 5525.4 5551.1 5593.9 5605.4 1774.4 1780.1 1782.5 1784.3 1788.5 873.3 886.0 896.7 898.2 903.4 7836.4 7867.4 7996.2 8046.2 8057.7 716.5 717.8 726.9 730.3 738.3 4450.4 4490.3 4538.8 4584.9 4593.0 19542.8 19831.1 20472.9 20518.2 20524.7 20389.0 20478.9 20507.8 20520.5 20529.1 9403.6 10675.9 10801.2 10828.5 10848.2 8546.0 8666.9 8685.0 8715.7 8814.6 17207.5 17472.0 17684.3 17942.0 18246.7 18233.2 18254.0 18463.5 18507.3 18634.1 10918.8 11020.9 11046.4 11083.9 11087.3 13300.7 13464.2 13466.5 13469.5 13493.3 11149.2 11193.8 11324.3 11443.5 11519.2 10838.8 10861.5 10868.5 10886.2 11158.7 9175.7 9297.5 9299.9 9305.7 9308.9 6759.8 6857.9 6858.4 6940.1 7051.7 6700.4 6729.4 6742.1 6797.9 6986.8 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | [#4] prototype.html Cycles:180 Average:5394.32 Median:6079.85 stddev:1499.00 (24.7%) stddev-sans-first:1457.51 03:26:33 INFO - PID 8092 | Values: 500.6 504.3 529.7 529.8 531.3 6138.5 6158.0 6173.5 6186.8 6285.7 6083.3 6114.2 6120.8 6123.9 6188.6 5097.2 5131.6 5132.7 5148.2 5150.9 4823.5 5126.3 5127.9 5181.8 5206.8 4826.2 4884.4 4907.6 4924.6 4936.9 4860.0 4860.4 4917.4 4936.2 4968.9 4324.4 4365.2 4399.4 4424.9 4456.0 5938.8 5992.5 6045.6 6054.7 6076.4 5583.9 5602.6 5625.9 5627.4 5664.4 6432.3 6496.7 6500.6 6525.4 6530.2 4583.4 4808.7 4849.6 4861.0 4864.4 6545.8 6648.8 6674.9 6681.3 6731.8 4896.6 4912.9 4915.0 4942.9 4965.2 4947.6 4964.7 4984.7 4987.2 5032.2 5486.0 5522.1 5595.6 5598.5 5607.2 6448.3 6541.4 6556.7 6561.7 6562.5 1712.4 1726.9 1737.9 1739.8 1748.6 1152.7 1196.0 1199.8 1205.7 1210.7 5520.2 5521.3 5545.8 5572.6 5584.1 6408.5 6503.4 6515.4 6560.5 6579.9 5457.7 5466.6 5541.0 5575.9 5603.0 3385.8 3388.7 3418.2 3451.4 3461.2 6099.8 6175.9 6202.8 6209.3 6229.5 6678.2 6682.4 6813.4 6837.0 6850.9 6199.7 6276.3 6320.9 6343.2 6389.9 6045.5 6532.2 6540.3 6550.5 6629.7 6296.9 6336.4 6355.2 6417.4 6490.4 6100.2 6113.4 6180.8 6195.5 6233.6 4855.4 4867.4 4869.8 4914.8 4923.6 6321.3 6471.6 6507.0 6523.6 6589.0 6366.8 6377.8 6394.7 6435.5 6447.2 6367.9 6403.5 6404.4 6460.6 6466.4 6225.3 6255.7 6292.3 6340.6 6378.9 6429.6 6431.4 6438.6 6471.5 6497.0 6106.0 6125.2 6231.5 6234.5 6268.2 03:26:33 INFO - PID 8092 | 03:26:33 INFO - PID 8092 | [#5] yui.html Cycles:180 Average:24812.55 Median:20713.83 stddev:36171.61 (174.6%) stddev-sans-first:36228.44 03:26:33 INFO - PID 8092 | Values: 880.0 894.1 897.1 915.0 920.4 16977.2 17531.0 17561.4 17606.8 22017.6 21230.2 22253.4 22340.2 22427.1 22552.4 963.1 971.0 971.0 974.8 975.0 906.6 991.5 993.8 997.2 999.4 1032.9 1033.1 1035.1 1038.1 1038.3 1030.4 1031.8 1040.5 1040.6 1044.1 758.5 758.6 759.6 766.4 766.4 19868.9 20550.4 20877.3 20885.2 20921.6 21887.2 21949.6 22255.0 22304.0 22448.1 17673.6 17858.2 17948.3 17951.6 17980.0 3613.2 3627.3 3638.9 3639.0 3650.1 141644.0 143814.0 144152.0 145950.3 146012.0 16862.5 16912.2 17109.7 17114.2 17359.2 30293.4 30878.0 31592.4 31760.2 31853.8 7112.1 7214.6 7266.6 7288.3 7297.6 4165.8 4185.4 4218.3 4261.5 4266.7 4989.5 4996.3 5281.8 5458.3 5579.4 1150.2 1181.4 1181.7 1184.1 1184.5 668.0 674.3 682.5 685.9 692.5 12026.8 12030.2 12507.6 12786.9 12985.0 682.7 688.3 697.1 700.9 701.9 5870.9 5918.8 5925.2 5929.2 5991.9 126424.4 126849.0 127414.0 128336.0 129113.0 104694.5 106119.5 107855.5 107951.5 108667.0 94345.0 96937.5 97142.5 98271.5 99441.5 11038.4 11090.8 11129.2 11162.9 11277.9 44584.6 44769.8 46215.2 47225.3 47240.0 56812.0 57919.4 59427.4 59562.7 61585.4 14858.1 15177.3 15241.0 15367.5 15428.0 17631.2 17753.0 17812.0 17871.6 18131.4 15484.7 16534.8 16616.3 16693.6 16699.8 14459.8 14782.9 14788.3 15419.2 15459.9 15901.3 16032.1 16038.2 16122.8 16144.3 11499.5 11518.4 11748.1 11799.6 12015.2 11911.5 11939.5 12060.9 12291.3 12354.6 03:26:33 INFO - PID 8092 | -------- Summary: end -------- 03:26:33 INFO - PID 8092 | 03:26:34 INFO - TEST-INFO | 8092: exit 0 03:26:34 INFO - TEST-OK | dromaeo_css | took 1108246ms 03:26:34 INFO - TEST-START | kraken 03:26:34 INFO - Initialising browser for kraken test... 03:26:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38858/getInfo.html -profile /tmp/tmppCKFF0/profile 03:26:34 INFO - TEST-INFO | started process 8467 (/builds/slave/test/build/application/firefox/firefox http://localhost:38858/getInfo.html) 03:26:39 INFO - TEST-INFO | 8467: exit 0 03:26:39 INFO - Browser initialized. 03:26:39 INFO - Running cycle 1/1 for kraken test... 03:26:39 INFO - Using env: {'DISPLAY': ':0', 03:26:39 INFO - 'HOME': '/home/cltbld', 03:26:39 INFO - 'JSGC_DISABLE_POISONING': '1', 03:26:39 INFO - 'LANG': 'en_US.UTF-8', 03:26:39 INFO - 'LANGUAGE': 'en_US:en', 03:26:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:26:39 INFO - 'LOGNAME': 'cltbld', 03:26:39 INFO - 'MAIL': '/var/mail/cltbld', 03:26:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:39 INFO - 'MOZ_CRASHREPORTER': '1', 03:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:26:39 INFO - 'MOZ_NO_REMOTE': '1', 03:26:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:39 INFO - 'NO_EM_RESTART': '1', 03:26:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:39 INFO - 'PWD': '/builds/slave/test', 03:26:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:39 INFO - 'RUST_BACKTRACE': 'full', 03:26:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:39 INFO - 'SHELL': '/bin/bash', 03:26:39 INFO - 'SHLVL': '1', 03:26:39 INFO - 'TERM': 'linux', 03:26:39 INFO - 'TMOUT': '86400', 03:26:39 INFO - 'USER': 'cltbld', 03:26:39 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559', 03:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:39 INFO - '_': '/tools/buildbot/bin/python'} 03:26:39 INFO - TEST-INFO | started process 8702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCKFF0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:40 INFO - PID 8702 | 03:26:40 INFO - PID 8702 | (/builds/slave/test/build/application/firefox/firefox:8751): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:40 INFO - PID 8702 | 03:26:50 INFO - PID 8702 | RSS: Main: 154365952 03:26:50 INFO - PID 8702 | 03:26:53 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38858/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:54 INFO - PID 8702 | RSS: Main: 159551488 03:26:54 INFO - PID 8702 | 03:26:57 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38858/tests/kraken/driver.html?testName=audio-dft) 03:26:57 INFO - PID 8702 | RSS: Main: 159838208 03:26:57 INFO - PID 8702 | 03:27:00 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38858/tests/kraken/driver.html?testName=audio-fft) 03:27:01 INFO - PID 8702 | RSS: Main: 156729344 03:27:01 INFO - PID 8702 | 03:27:03 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38858/tests/kraken/driver.html?testName=audio-oscillator) 03:27:03 INFO - PID 8702 | RSS: Main: 157040640 03:27:03 INFO - PID 8702 | 03:27:06 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:06 INFO - PID 8702 | RSS: Main: 157614080 03:27:06 INFO - PID 8702 | 03:27:09 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38858/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:10 INFO - PID 8702 | RSS: Main: 159694848 03:27:10 INFO - PID 8702 | 03:27:14 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38858/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:14 INFO - PID 8702 | RSS: Main: 160796672 03:27:14 INFO - PID 8702 | 03:27:17 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38858/tests/kraken/driver.html?testName=json-parse-financial) 03:27:18 INFO - PID 8702 | RSS: Main: 160407552 03:27:18 INFO - PID 8702 | 03:27:20 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:27:20 INFO - PID 8702 | RSS: Main: 160194560 03:27:20 INFO - PID 8702 | 03:27:22 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:27:22 INFO - PID 8702 | RSS: Main: 157937664 03:27:22 INFO - PID 8702 | 03:27:25 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:27:25 INFO - PID 8702 | RSS: Main: 157560832 03:27:25 INFO - PID 8702 | 03:27:28 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:27:28 INFO - PID 8702 | RSS: Main: 157532160 03:27:28 INFO - PID 8702 | 03:27:31 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:27:32 INFO - PID 8702 | RSS: Main: 158175232 03:27:32 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | Cycle 1(1): loaded http://localhost:38858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38858/tests/kraken/driver.html?testName=ai-astar) 03:27:34 INFO - PID 8702 | RSS: Main: 158998528 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | __start_tp_report 03:27:34 INFO - PID 8702 | _x_x_mozilla_page_load 03:27:34 INFO - PID 8702 | _x_x_mozilla_page_load_details 03:27:34 INFO - PID 8702 | |i|pagename|runs| 03:27:34 INFO - PID 8702 | |0;ai-astar;109;109;106;108;106;96;108;110;110;106 03:27:34 INFO - PID 8702 | |1;audio-beat-detection;117;115;117;117;115;116;146;120;116;118 03:27:34 INFO - PID 8702 | |2;audio-dft;164;163;163;163;161;162;163;163;166;168 03:27:34 INFO - PID 8702 | |3;audio-fft;74;75;75;74;76;75;74;73;76;73 03:27:34 INFO - PID 8702 | |4;audio-oscillator;79;79;82;79;78;80;78;80;78;79 03:27:34 INFO - PID 8702 | |5;imaging-gaussian-blur;114;114;110;113;114;113;114;113;115;113 03:27:34 INFO - PID 8702 | |6;imaging-darkroom;148;147;148;147;149;148;149;151;150;158 03:27:34 INFO - PID 8702 | |7;imaging-desaturate;95;94;94;95;95;94;94;95;95;97 03:27:34 INFO - PID 8702 | |8;json-parse-financial;55;55;53;53;53;54;54;52;52;52 03:27:34 INFO - PID 8702 | |9;json-stringify-tinderbox;38;38;39;39;38;39;38;38;38;39 03:27:34 INFO - PID 8702 | |10;stanford-crypto-aes;76;74;74;74;80;73;74;74;77;88 03:27:34 INFO - PID 8702 | |11;stanford-crypto-ccm;116;110;118;120;115;112;111;112;114;115 03:27:34 INFO - PID 8702 | |12;stanford-crypto-pbkdf2;174;170;167;170;173;176;175;169;167;169 03:27:34 INFO - PID 8702 | |13;stanford-crypto-sha256-iterative;66;66;66;65;69;69;66;65;66;66 03:27:34 INFO - PID 8702 | __end_tp_report 03:27:34 INFO - PID 8702 | __start_cc_report 03:27:34 INFO - PID 8702 | _x_x_mozilla_cycle_collect,753 03:27:34 INFO - PID 8702 | __end_cc_report 03:27:34 INFO - PID 8702 | __startTimestamp1505816854495__endTimestamp 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | ------- Summary: start ------- 03:27:34 INFO - PID 8702 | Number of tests: 14 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:4.10 (3.8%) stddev-sans-first:4.28 03:27:34 INFO - PID 8702 | Values: 109.0 109.0 106.0 108.0 106.0 96.0 108.0 110.0 110.0 106.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#1] audio-beat-detection Cycles:10 Average:119.70 Median:117.00 stddev:9.36 (8.0%) stddev-sans-first:9.87 03:27:34 INFO - PID 8702 | Values: 117.0 115.0 117.0 117.0 115.0 116.0 146.0 120.0 116.0 118.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.01 (1.2%) stddev-sans-first:2.13 03:27:34 INFO - PID 8702 | Values: 164.0 163.0 163.0 163.0 161.0 162.0 163.0 163.0 166.0 168.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#3] audio-fft Cycles:10 Average:74.50 Median:75.00 stddev:1.08 (1.4%) stddev-sans-first:1.13 03:27:34 INFO - PID 8702 | Values: 74.0 75.0 75.0 74.0 76.0 75.0 74.0 73.0 76.0 73.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:79.00 stddev:1.23 (1.6%) stddev-sans-first:1.30 03:27:34 INFO - PID 8702 | Values: 79.0 79.0 82.0 79.0 78.0 80.0 78.0 80.0 78.0 79.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 03:27:34 INFO - PID 8702 | Values: 114.0 114.0 110.0 113.0 114.0 113.0 114.0 113.0 115.0 113.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:3.24 (2.2%) stddev-sans-first:3.39 03:27:34 INFO - PID 8702 | Values: 148.0 147.0 148.0 147.0 149.0 148.0 149.0 151.0 150.0 158.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 03:27:34 INFO - PID 8702 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 97.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.16 (2.2%) stddev-sans-first:1.05 03:27:34 INFO - PID 8702 | Values: 55.0 55.0 53.0 53.0 53.0 54.0 54.0 52.0 52.0 52.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.50 stddev:0.52 (1.3%) stddev-sans-first:0.53 03:27:34 INFO - PID 8702 | Values: 38.0 38.0 39.0 39.0 38.0 39.0 38.0 38.0 38.0 39.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:75.00 stddev:4.58 (6.1%) stddev-sans-first:4.85 03:27:34 INFO - PID 8702 | Values: 76.0 74.0 74.0 74.0 80.0 73.0 74.0 74.0 77.0 88.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:115.00 stddev:3.16 (2.8%) stddev-sans-first:3.30 03:27:34 INFO - PID 8702 | Values: 116.0 110.0 118.0 120.0 115.0 112.0 111.0 112.0 114.0 115.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.50 stddev:3.27 (1.9%) stddev-sans-first:3.28 03:27:34 INFO - PID 8702 | Values: 174.0 170.0 167.0 170.0 173.0 176.0 175.0 169.0 167.0 169.0 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 03:27:34 INFO - PID 8702 | Values: 66.0 66.0 66.0 65.0 69.0 69.0 66.0 65.0 66.0 66.0 03:27:34 INFO - PID 8702 | -------- Summary: end -------- 03:27:34 INFO - PID 8702 | 03:27:34 INFO - PID 8702 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:27:35 INFO - TEST-INFO | 8702: exit 0 03:27:35 INFO - TEST-OK | kraken | took 61054ms 03:27:35 INFO - SUITE-END | took 1169s 03:27:35 INFO - Completed test suite (00:19:29) 03:27:35 INFO - javascript benchmark 03:27:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8424.932423229438, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.9223519412, 3116.5169398743196, 3135.263213144911, 3138.089953913365, 3148.68513148685, 6355.936440635593, 6411.455026322762, 6455.483561315095, 6484.935150648492, 6496.415322620963, 6188.443040126388, 6296.5277604179755, 6302.968485157579, 6307.400796924297, 6346.777862774792, 5837.562182836283, 5853.678047707374, 5933.970330148343, 5961.910571341434, 5967.194428752106, 5755.0504166812425, 5872.941270587304, 5876.0598304271325, 5978.22283103196, 5986.371430999748, 5333.0, 5763.769449222047, 5774.624649397797, 5917.674527900964, 5933.821985340447, 5801.291604570293, 5801.332846722638, 5877.85305367365, 5878.676672782995, 5907.261592300963, 5711.257536520267, 5765.798197063083, 5787.218725472049, 5900.763969441217, 5913.76344946206, 6339.619622822645, 6340.492760579143, 6361.141245931786, 6379.585326953779, 6419.679016049179, 6766.391024807791, 6819.181698196248, 6883.931160688379, 6909.619970901598, 6916.100906882123, 6895.655217239168, 6899.758508452231, 6968.0, 6972.860542789166, 6981.464077902853, 6260.812175634738, 6324.557280990287, 6347.333529979378, 6358.618482891041, 6373.075903993941, 7005.0, 7028.543144695578, 7046.260142684944, 7056.364927156581, 7057.858842823115, 6662.43369313604, 6703.128593282842, 6749.662516874137, 6763.086983257295, 6766.8646627068165, 6783.762568310085, 6818.318168183142, 6835.213950395669, 6898.517103802686, 6907.378335949788, 6629.138212032405, 6640.0, 6647.833804154838, 6670.266270710218, 6756.087928129639, 6687.0, 6763.661816909135, 6786.966065169642, 6792.117024786746, 6794.218664853605, 5370.3287089113865, 5388.7305634718105, 5392.838214853561, 5394.3796463406425, 5404.648697834628, 4661.720296782204, 4698.36572062774, 4711.128441238382, 4712.575868171881, 4733.408323959505, 5639.887202255932, 5807.912881306784, 5824.271966004249, 5900.232969713996, 5902.940970590239, 6740.595564266062, 6752.155980502437, 6754.223264324665, 6772.288909664513, 6774.593524388552, 5769.68266745333, 5815.41845815415, 5844.532437405082, 5859.501942334864, 5867.501262392744, 5893.528517718572, 5919.526437884959, 5944.7324870380935, 5963.045912654041, 5966.075258334965, 6469.191351081115, 6557.737690492327, 6562.146920900348, 6567.770128045591, 6575.934240657628, 6673.132492775908, 6773.93226067733, 6872.450203983669, 6946.756863509753, 6947.583145011114, 6522.771702990372, 6534.771283005072, 6581.2102547694585, 6592.110065141144, 6593.0769692244085, 6800.421964132906, 6833.93166068333, 6838.658067096725, 6847.520673553003, 6851.07510486078, 6893.448524118159, 6895.862082758216, 6973.895391569029, 6980.825479363057, 6982.930170698228, 6396.136521569715, 6635.4359879410795, 6636.535442518977, 6729.158855143107, 6735.5958642479645, 6539.509536784855, 6546.312637173029, 6547.181602299713, 6599.076129341992, 6608.669566521558, 6560.147180866456, 6597.3072827352435, 6612.5040621952585, 6642.568233064835, 6658.900116498159, 6680.899786503109, 6711.765088221889, 6719.059331693665, 6787.0498130262795, 6798.830029249309, 6278.121063051085, 6417.26201486835, 6446.161998940108, 6529.118568993125, 6532.0], "value": 6206.71662645574, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.7243873302447, 859.9484030958143, 865.4331412924537, 873.4584557574304, 873.934454915881, 39099.413508797355, 41057.58942410579, 41102.58897411025, 41261.58738412615, 41434.58565414345, 41438.37842432366, 42015.78992105035, 42068.15863682732, 42127.789361053154, 42193.156136877245, 7619.847603047936, 7690.961545192266, 7699.422543309246, 7712.3444507216955, 7732.226777322279, 7870.370370370357, 7981.401394895377, 7988.560629165423, 7989.0, 7999.920000799976, 7991.520508769492, 8095.5142691438405, 8106.229908158745, 8112.594370281462, 8117.837643247131, 7959.204079592052, 8038.035435747718, 8047.919520804776, 8055.5166689998205, 8062.959685201566, 7890.723824666166, 7933.444658873881, 7944.801379965547, 7946.24510671491, 7966.362690984707, 38218.0, 38281.23437531262, 38350.041248969, 38472.80763596192, 38603.22793544114, 3514.9648503514895, 3517.4547945068557, 3538.8053657048854, 3546.2375589248436, 3546.733994950389, 30959.0, 31201.219969500944, 31223.687763122307, 31236.531452028237, 31238.375232495222, 5046.772895219724, 5190.506901844356, 5203.427622961509, 5247.68513889164, 5249.527542521191, 181671.09164454226, 183135.0, 183230.99999999866, 184083.0, 184798.0, 46837.531624684, 46947.76526117416, 47096.7645161772, 47131.5286847134, 47175.5282447178, 48677.26984095242, 48778.268325975136, 48815.75592122017, 49022.0, 49079.26381104286, 15816.28826702801, 16150.75773863393, 16163.272652730655, 16168.676626467404, 16175.110368929587, 13254.73490530184, 13303.46786128544, 13320.067595268432, 13322.134061285986, 13337.066405351727, 12290.0, 12382.0, 12466.688332791753, 12535.686607834694, 12634.052446066582, 5418.349798024262, 5472.890542189134, 5498.268045565714, 5513.476219759116, 5538.889222215533, 989.5992123190119, 1000.559753708366, 1002.3134153105146, 1013.4476710192963, 1018.5416562546884, 22820.543589128123, 22861.31416057521, 22870.0, 22947.541049178923, 23331.300060998197, 1096.9890301096887, 1102.6361300770727, 1106.8284415915546, 1107.7507560798756, 1115.5816568786704, 12005.2196607222, 12197.695057623452, 12214.923463011131, 12289.877101228873, 12297.692557686129, 206621.0, 208664.0, 208673.0, 209638.0, 210746.0, 44927.775361122985, 45757.31364029542, 51650.74174629103, 51775.48224517707, 51981.48018519842, 1464.8608382203674, 1472.7864459653504, 1480.3412481445869, 1484.7253258147277, 1493.7012597480548, 26993.0552430664, 27013.729862701908, 27022.594661079707, 27105.0, 27119.45761084807, 36820.263594728494, 36856.44715329326, 36917.63082369142, 36926.26147476982, 36973.81513092417, 185322.0, 185672.0, 186853.0, 187129.0, 188883.0, 31757.523637145925, 32484.0, 32484.0, 32764.836175818968, 32831.17922051872, 40743.38884916788, 40862.18275634411, 40881.59118408778, 41152.794236028625, 41700.79149604232, 30718.385632287675, 30838.53742193824, 30974.845125774227, 31058.53412198864, 31165.0, 30550.930717424784, 30990.760369584965, 31108.377832443675, 31239.375212495168, 31507.68492315139, 33889.66110338865, 35072.824635876656, 35279.0, 35362.0, 35431.11422214465, 31178.844105780234, 31284.37431251408, 31298.21754456066, 31386.686133138377, 31975.520367194047, 22849.31452056441, 22925.231691171186, 22988.310350689506, 23157.88421057884, 23324.183653572043], "value": 16958.831925200862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4882331490003, 566.2271000084883, 566.6062086849641, 575.5065604755661, 599.6372194822133, 21766.0, 22585.0, 22598.54802903943, 22634.66048009281, 22689.54620907581, 22647.886760566216, 23844.8807755961, 23847.880760596217, 24102.276931692035, 24299.75700242997, 6325.2409710834645, 6518.869622607545, 6529.477641788645, 6553.672316384185, 6555.672216389185, 6389.968050159743, 6450.741970321182, 6453.9354606454035, 6484.4164025237715, 6493.253275873288, 6478.449331806779, 6478.676066196671, 6480.611163330215, 6484.61092334459, 6493.642849643268, 6138.0792881067755, 6467.838304042366, 6483.708233129497, 6489.286178520359, 6489.35106489352, 5926.0, 5967.254093238345, 5967.49276311514, 5997.6701281429505, 5999.760009599654, 26954.0, 27251.591226131623, 27331.590026149624, 27366.042188523505, 27386.0, 2055.5683306505503, 2088.55096154326, 2089.2896415218747, 2097.0, 2104.5370018595886, 18076.36732714362, 18096.18567164481, 18769.7184542232, 19100.33148839798, 19130.330438434587, 2380.4524959259466, 2415.891284892184, 2439.0853429963763, 2448.0574978633176, 2451.4361696809656, 116682.41658791737, 121128.0, 127091.36454317669, 131487.0, 131755.34122329328, 13955.930220348833, 14272.215028173343, 14346.915413186007, 14435.2060636666, 14533.546645335382, 22005.33983980483, 22022.33932982013, 22043.0, 22061.448463788533, 22077.0, 9744.951275243578, 10008.649697260707, 10037.74528183977, 10122.0, 10243.07812296897, 9350.95324523373, 9435.245180385553, 9489.38319009276, 9559.856602150974, 9563.187129093965, 8399.664013439395, 8552.187542183483, 8607.26838218746, 8673.609687564074, 8849.4247873888, 2588.8576128312748, 2735.083746944756, 2737.055715778093, 2775.4587855368413, 2809.7330753578376, 985.408754747146, 994.2096033653119, 1004.4525733475274, 1021.4535223655308, 1026.7843752811993, 18185.363512277272, 18945.905270473835, 19064.237430502624, 19118.617627647647, 19288.80711192898, 1060.3002018667796, 1065.6856227412932, 1066.7279843639822, 1067.9359238445563, 1074.3446497636435, 10321.277510574339, 10544.367337959748, 10620.893791062144, 10809.459527023617, 10918.781624367468, 455642.0, 461489.0, 471397.0, 473233.0, 474869.0, 104805.0, 105558.0, 107996.46001769941, 108022.0, 110344.4482777597, 1083.7832433513329, 1125.1954852280658, 1185.1407729396292, 1211.1642966353188, 1238.0467040378858, 19371.128299226286, 19449.611007780048, 19603.509912252306, 19835.60328793445, 19854.10656520489, 52362.47637523728, 54567.45432545624, 55137.1729424067, 56085.0, 57065.71467142638, 62172.0, 65462.0, 65590.0, 65765.0, 66063.33936660764, 13710.17738935667, 14041.789373159207, 14059.718805623626, 14087.647808804863, 14193.716125677634, 21560.67658985085, 21989.120435183053, 22053.0, 22054.558908822055, 22162.66755998629, 17536.298548057934, 17775.555611109827, 17872.642547149244, 17965.0, 18097.0, 14852.85147148558, 15067.0, 15074.773878391614, 15123.546293611209, 15212.847871521142, 18377.264909403475, 18461.16924738417, 18525.166367513764, 18648.90675546668, 18795.90602046981, 13135.211887286794, 13752.65618359549, 13760.724785504033, 13856.515021974183, 13951.511697090553, 17566.297348105934, 17592.472225833244, 17770.644587108443, 17808.3767068152, 18053.458396248134], "value": 11648.595188355861, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.7440511897619, 1380.2270728392098, 1386.9306534673265, 1390.131168019987, 1394.6095093373858, 14268.857311426882, 14927.626809329759, 14929.477468288613, 14933.328000239988, 14953.626159346022, 14676.559703208894, 14756.335964881579, 14774.55676329709, 14811.0, 14845.257737113128, 2695.541757901152, 2719.333763228012, 2758.5034693755115, 2764.2812868654096, 2765.3363192833776, 2707.44497378037, 2712.0914493644555, 2723.496153211662, 2726.0458839406247, 2728.3315587680945, 2627.8160528762996, 2693.8383696978144, 2702.9459410811774, 2703.9324016899636, 2705.1208357283863, 2547.1339744486872, 2578.5487539680576, 2584.586466165414, 2586.702529209146, 2591.2873959661056, 2459.544984177915, 2479.0579579759756, 2503.7496250374816, 2512.874356282197, 2517.144170981875, 14062.71874562503, 14285.428582856777, 14288.142711437347, 14298.57104286873, 14336.0, 7619.695212191561, 7853.332466740277, 7874.094479134916, 7883.054033515958, 7885.605719714049, 5084.161113416282, 5283.86790330241, 5366.838994830161, 5406.378266499363, 5562.888742225133, 1936.8644194906362, 1937.3897222374908, 1995.3515107590092, 2036.6537688592975, 2041.5406533529986, 21848.12607495698, 22773.772262277333, 24072.03711851524, 24110.758892411028, 24557.631635525482, 7001.474889383317, 7051.435885129177, 7207.603581802946, 7222.169450513258, 7227.349538541556, 19110.522236944187, 19187.904060479887, 19201.0, 19202.51993700141, 19232.71150932737, 7939.761807145795, 8035.116137224901, 8036.075851277178, 8045.477043992122, 8083.474574152779, 7009.509334346547, 7127.643617819192, 7353.264673532711, 7373.373263272575, 7422.517536360119, 5377.381601115843, 5525.4474552544425, 5551.139573366135, 5593.944060559424, 5605.439456054362, 1774.3612299572144, 1780.1366337326385, 1782.5008997480727, 1784.2773676660972, 1788.499220218341, 873.2926329672986, 885.9766969150642, 896.6727144592177, 898.1512470715242, 903.3902116071625, 7836.412269079842, 7867.370610351159, 7996.200379961957, 8046.1551537088935, 8057.717979870677, 716.5091912040165, 717.8205448637841, 726.8655298769745, 730.3098571849551, 738.3059923671732, 4450.421445212101, 4490.326451032372, 4538.818447262139, 4584.862454126382, 4592.954070459319, 19542.804571954097, 19831.107600158026, 20472.897635511727, 20518.17927282892, 20524.692129618066, 20389.0, 20478.897605511876, 20507.794922050885, 20520.486987825425, 20529.076191571414, 9403.623855045858, 10675.946620266848, 10801.189910756724, 10828.512716927757, 10848.186386020921, 8545.957270213608, 8666.913330866611, 8685.0, 8715.738527844174, 8814.5592720365, 17207.483775486755, 17472.0, 17684.29262829524, 17942.0, 18246.72629910526, 18233.179506921955, 18254.0, 18463.53841153982, 18507.259709611466, 18634.06829658539, 10918.836217456903, 11020.889791101987, 11046.392448415414, 11083.94458027737, 11087.279326843729, 13300.733985320432, 13464.192148471124, 13466.528671496451, 13469.528566500125, 13493.325333733077, 11149.219554631098, 11193.776124477628, 11324.32054076758, 11443.485043173243, 11519.19365644397, 10838.837417438586, 10861.511231994422, 10868.51091700891, 10886.183536234972, 11158.665240042812, 9175.678851240174, 9297.535123243675, 9299.860502092339, 9305.674301399418, 9308.906910930804, 6759.763408280686, 6857.862842743018, 6858.41703455192, 6940.13248343957, 7051.682674279772, 6700.396964273239, 6729.360710732472, 6742.123523941857, 6797.89803152963, 6986.755463558751], "value": 6508.963928910026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.63826392213167, 504.3418339067517, 529.7377797989994, 529.8066205834872, 531.2509361799863, 6138.475372165054, 6157.9999999999945, 6173.475254603359, 6186.783462578811, 6285.7314196617735, 6083.300420451649, 6114.1745864308305, 6120.846978825532, 6123.908141377883, 6188.597741146834, 5097.1844504879045, 5131.589472842183, 5132.717700526469, 5148.2020286855595, 5150.896982060356, 4823.541763532458, 5126.256692779563, 5127.897442051157, 5181.844544663666, 5206.843794686147, 4826.227803551433, 4884.413870335565, 4907.5583197512215, 4924.630652701044, 4936.925946110811, 4860.035378419161, 4860.392450943632, 4917.3607431033915, 4936.185529387647, 4968.925466118011, 4324.416203812477, 4365.192439398721, 4399.362092496602, 4424.867253982386, 4455.955440445587, 5938.7624495020145, 5992.520598352121, 6045.576809623328, 6054.72753726079, 6076.392360763933, 5583.8883222335735, 5602.551795856362, 5625.8593535161535, 5627.409122042209, 5664.433556644344, 6432.292447830735, 6496.719156825773, 6500.609963402211, 6525.3800888915475, 6530.216374035146, 4583.427071616048, 4808.687435316693, 4849.587785038276, 4861.003494283698, 4864.440589332236, 6545.770898018546, 6648.800535983928, 6674.866502669919, 6681.298463661343, 6731.798046058577, 4896.632752543574, 4912.926306105412, 4914.950850491521, 4942.851714448572, 4965.1807451770055, 4947.604191664658, 4964.652474326835, 4984.675996060245, 4987.1771157759285, 5032.194848824171, 5486.0, 5522.144067669517, 5595.552355811526, 5598.4961353477565, 5607.15909601924, 6448.258450278278, 6541.443977261891, 6556.737730490822, 6561.737530498726, 6562.4578224117295, 1712.383541924906, 1726.8877522960968, 1737.878348515617, 1739.7651317072034, 1748.5628592851788, 1152.7175841918784, 1195.9940200298943, 1199.7660456210956, 1205.6804946689135, 1210.661014915825, 5520.227168196456, 5521.254630624894, 5545.833624991256, 5572.609917305831, 5584.134459158837, 6408.455281301141, 6503.447206987459, 6515.381038801306, 6560.540762146699, 6579.868402631921, 5457.67082079931, 5466.562674985991, 5541.0, 5575.916361254584, 5603.0, 3385.81378024211, 3388.678075582816, 3418.2225242873565, 3451.378751824696, 3461.221225224355, 6099.786507472217, 6175.907361389583, 6202.844928876724, 6209.280946480707, 6229.50163986889, 6678.198616166092, 6682.431993280626, 6813.420859226922, 6837.0, 6850.897236541456, 6199.690015499297, 6276.340984196594, 6320.905186422207, 6343.238811342669, 6389.8722025560155, 6045.458408106081, 6532.183477065367, 6540.345965403421, 6550.508711846726, 6629.740349333611, 6296.905546416899, 6336.366363363627, 6355.237371515448, 6417.39034791694, 6490.415862572391, 6100.176476175659, 6113.419225173601, 6180.7527698891545, 6195.535334849814, 6233.594816336924, 4855.417349918032, 4867.3915760529935, 4869.780859861244, 4914.7542622867995, 4923.5814955729165, 6321.30465648769, 6471.644059576768, 6506.967465162644, 6523.575967562093, 6588.967055164693, 6366.808995730135, 6377.7767778127545, 6394.680265986589, 6435.51733619971, 6447.161868957006, 6367.872642547216, 6403.455706265019, 6404.423601875667, 6460.612363258219, 6466.385693359123, 6225.31521532622, 6255.687215639291, 6292.276388215414, 6340.619562826245, 6378.904316435164, 6429.646369449725, 6431.421172094534, 6438.615697625033, 6471.482281417381, 6496.967515162583, 6106.0, 6125.203723515914, 6231.470325022243, 6234.470070044097, 6268.1851359323], "value": 4956.093008138493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.0451510111533, 894.096962068311, 897.138746803069, 915.0483497162943, 920.4017388697346, 16977.2360243789, 17531.0, 17561.38535151267, 17606.82393176068, 22017.559648807055, 21230.15079396826, 22253.44366390841, 22340.21809236673, 22427.102915883344, 22552.436189095282, 963.137991497611, 970.9514524273793, 971.028971028971, 974.7758015656403, 975.0103644800533, 906.5875026862761, 991.5339790298548, 993.7962717642865, 997.2122023601346, 999.3703966501095, 1032.9070383665505, 1033.1166852341253, 1035.1046344911636, 1038.096855735511, 1038.2887721910479, 1030.3766221436074, 1031.8400647899587, 1040.47976011994, 1040.6201736366247, 1044.1333693034762, 758.525921299188, 758.594152128614, 759.5974133709143, 766.3639179481017, 766.3639179481017, 19868.90065549663, 20550.38348849537, 20877.269295574733, 20885.164593416244, 20921.581568368547, 21887.233946811943, 21949.561008779896, 22255.0, 22304.0, 22448.102075916944, 17673.55816104595, 17858.19638116275, 17948.282068717235, 17951.551211219692, 17980.0, 3613.1870329175986, 3627.2926779277786, 3638.872639457633, 3639.017465284385, 3650.0509867434394, 141644.0, 143814.0, 144152.0, 145950.27024864807, 146012.0, 16862.494125176265, 16912.154392280336, 17109.657806843792, 17114.229859656345, 17359.21883515245, 30293.394132117675, 30878.0, 31592.36815263682, 31760.205994850312, 31853.840730796197, 7112.110986126734, 7214.6031968241205, 7266.564006159648, 7288.271172882775, 7297.635118244173, 4165.791710414528, 4185.351270553069, 4218.282891908383, 4261.509926358509, 4266.658667306608, 4989.451160372356, 4996.325496058058, 5281.841544753664, 5458.317710286215, 5579.442055794388, 1150.1546363422879, 1181.4151994762647, 1181.6868529839599, 1184.0882520459197, 1184.538030168235, 667.9933200667931, 674.2684187656448, 682.5154140560257, 685.9211190713032, 692.5013989927244, 12026.819597706042, 12030.157888947864, 12507.624771256877, 12786.9360653198, 12985.0, 682.743971010871, 688.2635579929428, 697.1251079894801, 700.8808502554577, 701.9438444924393, 5870.899955681864, 5918.7928422505, 5925.170476133345, 5929.169916211734, 5991.940080599225, 126424.36787816002, 126849.0, 127414.0, 128336.0, 129113.0, 104694.47652761688, 106119.4694026525, 107855.46072269745, 107951.46024269829, 108667.0, 94345.0, 96937.51531242298, 97142.51428742953, 98271.50864245633, 99441.50279248557, 11038.392888391216, 11090.833637495283, 11129.220954533104, 11162.888371116185, 11277.943610282224, 44584.55415445804, 44769.77615111903, 46215.22708637492, 47225.29162062503, 47240.0, 56812.0, 57919.4208057914, 59427.40572594219, 59562.702186488794, 61585.384146157965, 14858.108513489226, 15177.317020734314, 15241.0, 15367.538973830802, 15428.0, 17631.20659570348, 17753.0, 17812.0, 17871.642567148843, 18131.36540221086, 15484.690306194037, 16534.83465165333, 16616.335346586002, 16693.582660433585, 16699.833001670315, 14459.78310325367, 14782.926085369505, 14788.334524946187, 15419.151946643042, 15459.91780575394, 15901.284442199898, 16032.11823349727, 16038.198090095682, 16122.758158627395, 16144.273507691947, 11499.54001839917, 11518.424078796193, 11748.060155187735, 11799.587014454453, 12015.158938874194, 11911.523539058688, 11939.52241910314, 12060.879391205975, 12291.262524248574, 12354.567590134302], "value": 9040.446535462857, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 106.0, 108.0, 106.0, 96.0, 108.0, 110.0, 110.0, 106.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 117.0, 117.0, 115.0, 116.0, 146.0, 120.0, 116.0, 118.0], "value": 119.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 161.0, 162.0, 163.0, 163.0, 166.0, 168.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 74.0, 76.0, 75.0, 74.0, 73.0, 76.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 82.0, 79.0, 78.0, 80.0, 78.0, 80.0, 78.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 113.0, 114.0, 113.0, 114.0, 113.0, 115.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 149.0, 148.0, 149.0, 151.0, 150.0, 158.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 97.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 53.0, 54.0, 54.0, 52.0, 52.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 39.0, 38.0, 39.0, 38.0, 38.0, 38.0, 39.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 74.0, 80.0, 73.0, 74.0, 74.0, 77.0, 88.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 118.0, 120.0, 115.0, 112.0, 111.0, 112.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 167.0, 170.0, 173.0, 176.0, 175.0, 169.0, 167.0, 169.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 69.0, 69.0, 66.0, 65.0, 66.0, 66.0], "value": 66.4, "unit": "score"}]}]} 03:27:35 INFO - Return code: 0 03:27:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:27:35 INFO - # TBPL SUCCESS # 03:27:35 INFO - Running post-action listener: _package_coverage_data 03:27:35 INFO - Running post-action listener: _resource_record_post_action 03:27:35 INFO - [mozharness: 2017-09-19 10:27:35.253867Z] Finished run-tests step (success) 03:27:35 INFO - Running post-run listener: _resource_record_post_run 03:27:35 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 425984; Write bytes: 442920960; Read time: 52; Write time: 254048 03:27:35 INFO - TinderboxPrint: CPU usage
13.1% 03:27:35 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 52 03:27:35 INFO - TinderboxPrint: I/O write bytes / time
442,920,960 / 254,048 03:27:35 INFO - TinderboxPrint: CPU idle
8,223.7 (86.9%) 03:27:35 INFO - TinderboxPrint: CPU user
1,191.1 (12.6%) 03:27:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:27:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109465600; Read time: 0; Write time: 56216 03:27:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:27:35 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 421888; Write bytes: 333455360; Read time: 44; Write time: 197832 03:27:35 INFO - Running post-run listener: _upload_blobber_files 03:27:35 INFO - Blob upload gear active. 03:27:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:27:35 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 03:27:35 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:27:35 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:27:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:27:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:37 INFO - (blobuploader) - INFO - Done attempting. 03:27:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:27:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:38 INFO - (blobuploader) - INFO - Done attempting. 03:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:39 INFO - (blobuploader) - INFO - Done attempting. 03:27:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:27:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:27:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:27:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:27:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:27:46 INFO - (blobuploader) - INFO - Done attempting. 03:27:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:27:46 INFO - Return code: 0 03:27:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:27:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:27:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2004222020a0deb6a0feeb27ebd38ebe9e8b7525243247721d9f9c2156704e7b5476799459649cc46928d0ded266822ed74d93be2f8a947eae2fdf135433f0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3192b1287c6f2c8c177c12e77334e5b250a472d7b1b6b20efc08974abf29239fe3a213e44ad2d0a91f25ef7f595f984756d1329f8a1b029602b3321924ee4e8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c40fea408540ad6f28fe658e3bfb46a300922bb50dc9a7855fdb892337283753a3cec424aebda1e46a66b3a7c1b862d223342bef595ac75f6532a3984093cd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5af5c7c3b31d7dd0a52b2c8f594082181e802464fb76ed42020aea4ab3fe9a4f1e2b81e931affbd81795286f63c484c4808a8463378d85310c8da765b8f2454"} 03:27:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:27:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:27:46 INFO - Contents: 03:27:46 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2004222020a0deb6a0feeb27ebd38ebe9e8b7525243247721d9f9c2156704e7b5476799459649cc46928d0ded266822ed74d93be2f8a947eae2fdf135433f0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3192b1287c6f2c8c177c12e77334e5b250a472d7b1b6b20efc08974abf29239fe3a213e44ad2d0a91f25ef7f595f984756d1329f8a1b029602b3321924ee4e8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c40fea408540ad6f28fe658e3bfb46a300922bb50dc9a7855fdb892337283753a3cec424aebda1e46a66b3a7c1b862d223342bef595ac75f6532a3984093cd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5af5c7c3b31d7dd0a52b2c8f594082181e802464fb76ed42020aea4ab3fe9a4f1e2b81e931affbd81795286f63c484c4808a8463378d85310c8da765b8f2454"} 03:27:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:27:46 INFO - Copying logs to upload dir... 03:27:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:27:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.129574 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-19 03:27:46.199956) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:46.203652) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2004222020a0deb6a0feeb27ebd38ebe9e8b7525243247721d9f9c2156704e7b5476799459649cc46928d0ded266822ed74d93be2f8a947eae2fdf135433f0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3192b1287c6f2c8c177c12e77334e5b250a472d7b1b6b20efc08974abf29239fe3a213e44ad2d0a91f25ef7f595f984756d1329f8a1b029602b3321924ee4e8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c40fea408540ad6f28fe658e3bfb46a300922bb50dc9a7855fdb892337283753a3cec424aebda1e46a66b3a7c1b862d223342bef595ac75f6532a3984093cd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5af5c7c3b31d7dd0a52b2c8f594082181e802464fb76ed42020aea4ab3fe9a4f1e2b81e931affbd81795286f63c484c4808a8463378d85310c8da765b8f2454"} build_url:https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/AgMWzaeiTGuANcVMqKHEPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2004222020a0deb6a0feeb27ebd38ebe9e8b7525243247721d9f9c2156704e7b5476799459649cc46928d0ded266822ed74d93be2f8a947eae2fdf135433f0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3192b1287c6f2c8c177c12e77334e5b250a472d7b1b6b20efc08974abf29239fe3a213e44ad2d0a91f25ef7f595f984756d1329f8a1b029602b3321924ee4e8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c40fea408540ad6f28fe658e3bfb46a300922bb50dc9a7855fdb892337283753a3cec424aebda1e46a66b3a7c1b862d223342bef595ac75f6532a3984093cd1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5af5c7c3b31d7dd0a52b2c8f594082181e802464fb76ed42020aea4ab3fe9a4f1e2b81e931affbd81795286f63c484c4808a8463378d85310c8da765b8f2454"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:46.231256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:46.231612) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1505815628.243810-1216025559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:27:46.316804) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:27:46.317107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:27:46.317397) ========= ========= Total master_lag: 0.20 =========