builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-031 starttime: 1506450683.74 results: success (0) revision: b30ae5a455367f336ded1052081e4c54a139fa81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.735564) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.735973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.736240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.753667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.753923) ========= 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=db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 11:31:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-09-26 11:31:23 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.856980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.857267) ========= 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=db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016941 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:23.909212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-26 11:31:23.909987) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b30ae5a455367f336ded1052081e4c54a139fa81 --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 b30ae5a455367f336ded1052081e4c54a139fa81 --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=db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 11:31:23,971 truncating revision to first 12 chars 2017-09-26 11:31:23,971 Setting DEBUG logging. 2017-09-26 11:31:23,971 attempt 1/10 2017-09-26 11:31:23,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b30ae5a45536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 11:31:25,330 unpacking tar archive at: mozilla-central-b30ae5a45536/testing/mozharness/ program finished with exit code 0 elapsedTime=1.679000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-26 11:31:25.609058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:25.609433) ========= script_repo_revision: b30ae5a455367f336ded1052081e4c54a139fa81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:25.609886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:25.610195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 11:31:25.625218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 11:31:25.625873) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:25 INFO - MultiFileLogger online at 20170926 11:31:25 in /builds/slave/test 11:31:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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 11:31:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:25 INFO - {'append_to_log': False, 11:31:25 INFO - 'base_work_dir': '/builds/slave/test', 11:31:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:31:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:25 INFO - 'branch': 'Firefox-Non-PGO', 11:31:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:25 INFO - 'code_coverage': False, 11:31:25 INFO - 'config_files': ('talos/linux_config.py',), 11:31:25 INFO - 'default_actions': ('clobber', 11:31:25 INFO - 'read-buildbot-config', 11:31:25 INFO - 'download-and-extract', 11:31:25 INFO - 'populate-webroot', 11:31:25 INFO - 'create-virtualenv', 11:31:25 INFO - 'install', 11:31:25 INFO - 'setup-mitmproxy', 11:31:25 INFO - 'run-tests'), 11:31:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:25 INFO - 'disable_ccov_upload': False, 11:31:25 INFO - 'disable_stylo': False, 11:31:25 INFO - 'download_minidump_stackwalk': True, 11:31:25 INFO - 'download_symbols': 'ondemand', 11:31:25 INFO - 'enable_stylo': False, 11:31:25 INFO - 'enable_webrender': False, 11:31:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:31:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:25 INFO - 'gecko_profile': False, 11:31:25 INFO - 'gecko_profile_interval': 0, 11:31:25 INFO - 'installer_path': 'installer.exe', 11:31:25 INFO - 'log_level': 'info', 11:31:25 INFO - 'log_name': 'talos', 11:31:25 INFO - 'log_to_console': True, 11:31:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:25 INFO - 'opt_config_files': (), 11:31:25 INFO - 'pip_index': False, 11:31:25 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:31:25 INFO - 'system_bits': '32', 11:31:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:25 INFO - 'title': 'talos-linux64-ix-031', 11:31:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:25 INFO - 'use_talos_json': True, 11:31:25 INFO - 'verify': 'False', 11:31:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:25 INFO - 'work_dir': 'build'} 11:31:25 INFO - [mozharness: 2017-09-26 18:31:25.827120Z] Running clobber step. 11:31:25 INFO - Running pre-action listener: _resource_record_pre_action 11:31:25 INFO - Running main action method: clobber 11:31:25 INFO - rmtree: /builds/slave/test/build 11:31:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:26 INFO - Running post-action listener: _resource_record_post_action 11:31:26 INFO - [mozharness: 2017-09-26 18:31:26.823688Z] Finished clobber step (success) 11:31:26 INFO - [mozharness: 2017-09-26 18:31:26.823785Z] Running read-buildbot-config step. 11:31:26 INFO - Running pre-action listener: _resource_record_pre_action 11:31:26 INFO - Running main action method: read_buildbot_config 11:31:26 INFO - Using buildbot properties: 11:31:26 INFO - { 11:31:26 INFO - "project": "", 11:31:26 INFO - "product": "firefox", 11:31:26 INFO - "who": "ffxbld@noreply.mozilla.org", 11:31:26 INFO - "installer_path": "public/build/target.tar.bz2", 11:31:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:31:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:31:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:31:26 INFO - "stage_platform": "linux64", 11:31:26 INFO - "basedir": "/builds/slave/test", 11:31:26 INFO - "buildnumber": 44, 11:31:26 INFO - "platform": "ubuntu64_hw", 11:31:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:31:26 INFO - "slavebuilddir": "test", 11:31:26 INFO - "taskId": "EzPIXZqbQzqY0RFkFz2Odw", 11:31:26 INFO - "branch": "mozilla-central", 11:31:26 INFO - "script_repo_revision": "production", 11:31:26 INFO - "revision": "b30ae5a455367f336ded1052081e4c54a139fa81", 11:31:26 INFO - "slavename": "talos-linux64-ix-031", 11:31:26 INFO - "repo_path": "mozilla-central" 11:31:26 INFO - } 11:31:26 INFO - Finding installer, test and symbols from parent task. 11:31:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EzPIXZqbQzqY0RFkFz2Odw'}, attempt #1 11:31:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EzPIXZqbQzqY0RFkFz2Odw'}, attempt #1 11:31:27 INFO - Task dependencies: OiaXjfiURii_c_az-GohGA 11:31:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA'}, attempt #1 11:31:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json 11:31:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip 11:31:28 INFO - Running post-action listener: _resource_record_post_action 11:31:28 INFO - [mozharness: 2017-09-26 18:31:28.295014Z] Finished read-buildbot-config step (success) 11:31:28 INFO - [mozharness: 2017-09-26 18:31:28.295233Z] Running download-and-extract step. 11:31:28 INFO - Running pre-action listener: _resource_record_pre_action 11:31:28 INFO - Running main action method: download_and_extract 11:31:28 INFO - mkdir: /builds/slave/test/build/tests 11:31: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')]} 11:31:28 INFO - trying https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json 11:31:28 INFO - Downloading https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:31:28 INFO - Downloaded 989 bytes. 11:31:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:31:28 INFO - Using the following test package requirements: 11:31:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:31:28 INFO - u'common': [u'target.common.tests.zip'], 11:31:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:31:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:31:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:31:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:31:28 INFO - u'mozbase': [u'target.common.tests.zip'], 11:31:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:31:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:31:28 INFO - u'web-platform': [u'target.common.tests.zip', 11:31:28 INFO - u'target.web-platform.tests.tar.gz'], 11:31:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:31:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:31:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip 11:31:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:28 INFO - Fetch https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.common.tests.zip into memory 11:31:29 INFO - Content-Length response header: 54943939 11:31:29 INFO - Bytes received: 54943939 11:31:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip 11:31:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:31:40 INFO - Fetch https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.talos.tests.zip into memory 11:31:41 INFO - Content-Length response header: 14513823 11:31:41 INFO - Bytes received: 14513823 11:31: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')]} 11:31:41 INFO - trying https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:41 INFO - Downloading https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:31:42 INFO - Downloaded 61654855 bytes. 11:31:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:42 INFO - mkdir: /builds/slave/test/properties 11:31:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:42 INFO - Contents: 11:31:42 INFO - build_url:https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 11:31:42 INFO - Running post-action listener: _resource_record_post_action 11:31:42 INFO - Running post-action listener: find_tests_for_verification 11:31:42 INFO - Running post-action listener: set_extra_try_arguments 11:31:42 INFO - [mozharness: 2017-09-26 18:31:42.900408Z] Finished download-and-extract step (success) 11:31:42 INFO - [mozharness: 2017-09-26 18:31:42.900506Z] Running populate-webroot step. 11:31:42 INFO - Running pre-action listener: _resource_record_pre_action 11:31:42 INFO - Running main action method: populate_webroot 11:31:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['tresize', 11:31:42 INFO - 'tcanvasmark']}, 11:31:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['dromaeo_css', 11:31:42 INFO - 'kraken']}, 11:31:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'tests': ['damp', 'tps']}, 11:31:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['damp', 'tps']}, 11:31:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['dromaeo_dom']}, 11:31:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:31:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['basic_compositor_video', 11:31:42 INFO - 'glvideo']}, 11:31:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:31:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['ts_paint_webext', 11:31:42 INFO - 'tp5o_webext']}, 11:31:42 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:42 INFO - 'ts_paint', 11:31:42 INFO - 'tpaint', 11:31:42 INFO - 'sessionrestore', 11:31:42 INFO - 'sessionrestore_many_windows', 11:31:42 INFO - 'sessionrestore_no_auto_restore', 11:31:42 INFO - 'tabpaint']}, 11:31:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['a11yr', 11:31:42 INFO - 'ts_paint', 11:31:42 INFO - 'tpaint', 11:31:42 INFO - 'sessionrestore', 11:31:42 INFO - 'sessionrestore_many_windows', 11:31:42 INFO - 'sessionrestore_no_auto_restore', 11:31:42 INFO - 'tabpaint']}, 11:31:42 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:31:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:31:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['perf_reftest_singletons']}, 11:31:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['perf_reftest']}, 11:31:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:42 INFO - 'tsvgr_opacity', 11:31:42 INFO - 'tart', 11:31:42 INFO - 'tscrollx', 11:31:42 INFO - 'tsvg_static']}, 11:31:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['tsvgx', 11:31:42 INFO - 'tsvgr_opacity', 11:31:42 INFO - 'tart', 11:31:42 INFO - 'tscrollx', 11:31:42 INFO - 'tsvg_static']}, 11:31:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:31:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'talos_options': ['--disable-stylo'], 11:31:42 INFO - 'tests': ['tp5o']}, 11:31:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:31:42 INFO - 'talos_options': ['--mitmproxy', 11:31:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:42 INFO - '--firstNonBlankPaint'], 11:31:42 INFO - 'tests': ['tp6_google', 11:31:42 INFO - 'tp6_youtube', 11:31:42 INFO - 'tp6_amazon', 11:31:42 INFO - 'tp6_facebook']}, 11:31:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:31:42 INFO - 'talos_options': ['--disable-stylo', 11:31:42 INFO - '--mitmproxy', 11:31:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:42 INFO - '--firstNonBlankPaint'], 11:31:42 INFO - 'tests': ['tp6_google', 11:31:42 INFO - 'tp6_youtube', 11:31:42 INFO - 'tp6_amazon', 11:31:42 INFO - 'tp6_facebook']}, 11:31:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:42 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:31:42 INFO - 'talos_options': ['--stylo-threads=1', 11:31:42 INFO - '--mitmproxy', 11:31:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:42 INFO - '--firstNonBlankPaint'], 11:31:42 INFO - 'tests': ['tp6_google', 11:31:42 INFO - 'tp6_youtube', 11:31:42 INFO - 'tp6_amazon', 11:31:42 INFO - 'tp6_facebook']}, 11:31:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'talos_options': ['--xperf_path', 11:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:42 INFO - 'tests': ['tp5n']}, 11:31:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:42 INFO - 'talos_options': ['--disable-stylo', 11:31:42 INFO - '--xperf_path', 11:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:42 INFO - 'tests': ['tp5n']}}} 11:31:42 INFO - Running post-action listener: _resource_record_post_action 11:31:42 INFO - [mozharness: 2017-09-26 18:31:42.915894Z] Finished populate-webroot step (success) 11:31:42 INFO - [mozharness: 2017-09-26 18:31:42.915984Z] Running create-virtualenv step. 11:31:42 INFO - Running pre-action listener: _resource_record_pre_action 11:31:42 INFO - Running main action method: create_virtualenv 11:31:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:31:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:31:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:31:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:43 INFO - Installing pip...............done. 11:31:43 INFO - Return code: 0 11:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:31:43 INFO - Reading from file tmpfile_stdout 11:31:43 INFO - Output received: 11:31:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:31:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31:43 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')]} 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:43 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')]} 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31:43 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 11:31:43 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 11:31:43 INFO - Using env: {'DISPLAY': ':0', 11:31:43 INFO - 'HOME': '/home/cltbld', 11:31:43 INFO - 'LANG': 'en_US.UTF-8', 11:31:43 INFO - 'LANGUAGE': 'en_US:en', 11:31:43 INFO - 'LOGNAME': 'cltbld', 11:31:43 INFO - 'MAIL': '/var/mail/cltbld', 11:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:43 INFO - 'MOZ_NO_REMOTE': '1', 11:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:43 INFO - 'NO_EM_RESTART': '1', 11:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:43 INFO - 'PWD': '/builds/slave/test', 11:31:43 INFO - 'SHELL': '/bin/bash', 11:31:43 INFO - 'SHLVL': '1', 11:31:43 INFO - 'TERM': 'linux', 11:31:43 INFO - 'TMOUT': '86400', 11:31:43 INFO - 'USER': 'cltbld', 11:31:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:43 INFO - '_': '/tools/buildbot/bin/python'} 11:31:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:31:45 INFO - Downloading/unpacking pip>=1.5 11:31:45 INFO - Running setup.py egg_info for package pip 11:31:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:45 INFO - Installing collected packages: pip 11:31:45 INFO - Found existing installation: pip 1.1 11:31:45 INFO - Uninstalling pip: 11:31:45 INFO - Successfully uninstalled pip 11:31:45 INFO - Running setup.py install for pip 11:31:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:31:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:31:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:31:45 INFO - Successfully installed pip 11:31:45 INFO - Cleaning up... 11:31:45 INFO - Return code: 0 11:31:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:31:45 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')]} 11:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:45 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')]} 11:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:45 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31:45 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 11:31:45 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 11:31:45 INFO - Using env: {'DISPLAY': ':0', 11:31:45 INFO - 'HOME': '/home/cltbld', 11:31:45 INFO - 'LANG': 'en_US.UTF-8', 11:31:45 INFO - 'LANGUAGE': 'en_US:en', 11:31:45 INFO - 'LOGNAME': 'cltbld', 11:31:45 INFO - 'MAIL': '/var/mail/cltbld', 11:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:45 INFO - 'MOZ_NO_REMOTE': '1', 11:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:45 INFO - 'NO_EM_RESTART': '1', 11:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:45 INFO - 'PWD': '/builds/slave/test', 11:31:45 INFO - 'SHELL': '/bin/bash', 11:31:45 INFO - 'SHLVL': '1', 11:31:45 INFO - 'TERM': 'linux', 11:31:45 INFO - 'TMOUT': '86400', 11:31:45 INFO - 'USER': 'cltbld', 11:31:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:45 INFO - '_': '/tools/buildbot/bin/python'} 11:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:45 INFO - Downloading/unpacking psutil>=3.1.1 11:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:47 INFO - Installing collected packages: psutil 11:31:47 INFO - Running setup.py install for psutil 11:31:47 INFO - building 'psutil._psutil_linux' extension 11:31:47 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 11:31:47 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 11:31:47 INFO - building 'psutil._psutil_posix' extension 11:31:47 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 11:31:47 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 11:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:47 INFO - Successfully installed psutil 11:31:47 INFO - Cleaning up... 11:31:47 INFO - Return code: 0 11:31:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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')]} 11:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:31: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 mozsystemmonitor==0.3 11:31:47 INFO - Using env: {'DISPLAY': ':0', 11:31:47 INFO - 'HOME': '/home/cltbld', 11:31:47 INFO - 'LANG': 'en_US.UTF-8', 11:31:47 INFO - 'LANGUAGE': 'en_US:en', 11:31:47 INFO - 'LOGNAME': 'cltbld', 11:31:47 INFO - 'MAIL': '/var/mail/cltbld', 11:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:47 INFO - 'MOZ_NO_REMOTE': '1', 11:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:47 INFO - 'NO_EM_RESTART': '1', 11:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:47 INFO - 'PWD': '/builds/slave/test', 11:31:47 INFO - 'SHELL': '/bin/bash', 11:31:47 INFO - 'SHLVL': '1', 11:31:47 INFO - 'TERM': 'linux', 11:31:47 INFO - 'TMOUT': '86400', 11:31:47 INFO - 'USER': 'cltbld', 11:31:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:47 INFO - '_': '/tools/buildbot/bin/python'} 11:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:31:47 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 11:31:47 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 11:31:47 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 11:31:47 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 11:31:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:31:49 INFO - Installing collected packages: mozsystemmonitor 11:31:49 INFO - Running setup.py install for mozsystemmonitor 11:31:49 INFO - Successfully installed mozsystemmonitor 11:31:49 INFO - Cleaning up... 11:31:49 INFO - Return code: 0 11:31:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:31:49 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')]} 11:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:49 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')]} 11:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:49 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31:49 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 11:31:49 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 11:31:49 INFO - Using env: {'DISPLAY': ':0', 11:31:49 INFO - 'HOME': '/home/cltbld', 11:31:49 INFO - 'LANG': 'en_US.UTF-8', 11:31:49 INFO - 'LANGUAGE': 'en_US:en', 11:31:49 INFO - 'LOGNAME': 'cltbld', 11:31:49 INFO - 'MAIL': '/var/mail/cltbld', 11:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:49 INFO - 'MOZ_NO_REMOTE': '1', 11:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:49 INFO - 'NO_EM_RESTART': '1', 11:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:49 INFO - 'PWD': '/builds/slave/test', 11:31:49 INFO - 'SHELL': '/bin/bash', 11:31:49 INFO - 'SHLVL': '1', 11:31:49 INFO - 'TERM': 'linux', 11:31:49 INFO - 'TMOUT': '86400', 11:31:49 INFO - 'USER': 'cltbld', 11:31:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:49 INFO - '_': '/tools/buildbot/bin/python'} 11:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:49 INFO - Downloading/unpacking jsonschema==2.5.1 11:31:49 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 11:31:49 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 11:31:49 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 11:31:49 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 11:31:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:31:50 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 11:31:50 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 11:31:50 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 11:31:50 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 11:31:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:51 INFO - warning: no files found matching '*.txt' 11:31:51 INFO - no previously-included directories found matching 'build' 11:31:51 INFO - no previously-included directories found matching 'dist' 11:31:51 INFO - no previously-included directories found matching '.git*' 11:31:51 INFO - Installing collected packages: jsonschema, functools32 11:31:51 INFO - Running setup.py install for functools32 11:31:51 INFO - warning: no files found matching '*.txt' 11:31:51 INFO - no previously-included directories found matching 'build' 11:31:51 INFO - no previously-included directories found matching 'dist' 11:31:51 INFO - no previously-included directories found matching '.git*' 11:31:51 INFO - Successfully installed jsonschema functools32 11:31:51 INFO - Cleaning up... 11:31:51 INFO - Return code: 0 11:31:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:31:51 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')]} 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:51 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')]} 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:51 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31:51 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 11:31:51 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 11:31:51 INFO - Using env: {'DISPLAY': ':0', 11:31:51 INFO - 'HOME': '/home/cltbld', 11:31:51 INFO - 'LANG': 'en_US.UTF-8', 11:31:51 INFO - 'LANGUAGE': 'en_US:en', 11:31:51 INFO - 'LOGNAME': 'cltbld', 11:31:51 INFO - 'MAIL': '/var/mail/cltbld', 11:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:51 INFO - 'MOZ_NO_REMOTE': '1', 11:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:51 INFO - 'NO_EM_RESTART': '1', 11:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:51 INFO - 'PWD': '/builds/slave/test', 11:31:51 INFO - 'SHELL': '/bin/bash', 11:31:51 INFO - 'SHLVL': '1', 11:31:51 INFO - 'TERM': 'linux', 11:31:51 INFO - 'TMOUT': '86400', 11:31:51 INFO - 'USER': 'cltbld', 11:31:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:51 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:31:51 INFO - Cleaning up... 11:31:51 INFO - Return code: 0 11:31:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31:51 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')]} 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:51 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')]} 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:51 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31:51 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 11:31:51 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 11:31:51 INFO - Using env: {'DISPLAY': ':0', 11:31:51 INFO - 'HOME': '/home/cltbld', 11:31:51 INFO - 'LANG': 'en_US.UTF-8', 11:31:51 INFO - 'LANGUAGE': 'en_US:en', 11:31:51 INFO - 'LOGNAME': 'cltbld', 11:31:51 INFO - 'MAIL': '/var/mail/cltbld', 11:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:51 INFO - 'MOZ_NO_REMOTE': '1', 11:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:51 INFO - 'NO_EM_RESTART': '1', 11:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:51 INFO - 'PWD': '/builds/slave/test', 11:31:51 INFO - 'SHELL': '/bin/bash', 11:31:51 INFO - 'SHLVL': '1', 11:31:51 INFO - 'TERM': 'linux', 11:31:51 INFO - 'TMOUT': '86400', 11:31:51 INFO - 'USER': 'cltbld', 11:31:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:51 INFO - '_': '/tools/buildbot/bin/python'} 11:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:31:52 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 11:31:52 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 11:31:52 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 11:31:52 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 11:31:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:53 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 11:31:53 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 11:31:53 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 11:31:53 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 11:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:54 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 11:31:54 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 11:31:54 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 11:31:54 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 11:31:54 INFO - Downloading docopt-0.6.1.tar.gz 11:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:54 INFO - Running setup.py install for blobuploader 11:31:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:54 INFO - Running setup.py install for requests 11:31:54 INFO - Running setup.py install for docopt 11:31:54 INFO - Successfully installed blobuploader requests docopt 11:31:54 INFO - Cleaning up... 11:31:54 INFO - Return code: 0 11:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:54 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')]} 11:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:54 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')]} 11:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:54 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31:54 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 11:31:54 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 11:31:54 INFO - Using env: {'DISPLAY': ':0', 11:31:54 INFO - 'HOME': '/home/cltbld', 11:31:54 INFO - 'LANG': 'en_US.UTF-8', 11:31:54 INFO - 'LANGUAGE': 'en_US:en', 11:31:54 INFO - 'LOGNAME': 'cltbld', 11:31:54 INFO - 'MAIL': '/var/mail/cltbld', 11:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:54 INFO - 'MOZ_NO_REMOTE': '1', 11:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:54 INFO - 'NO_EM_RESTART': '1', 11:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:54 INFO - 'PWD': '/builds/slave/test', 11:31:54 INFO - 'SHELL': '/bin/bash', 11:31:54 INFO - 'SHLVL': '1', 11:31:54 INFO - 'TERM': 'linux', 11:31:54 INFO - 'TMOUT': '86400', 11:31:54 INFO - 'USER': 'cltbld', 11:31:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:55 INFO - '_': '/tools/buildbot/bin/python'} 11:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:55 INFO - Running setup.py (path:/tmp/pip-R74G58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:55 INFO - Running setup.py (path:/tmp/pip-XUg79K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:55 INFO - Running setup.py (path:/tmp/pip-79XVvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:55 INFO - Running setup.py (path:/tmp/pip-sYASh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:55 INFO - Running setup.py (path:/tmp/pip-X5svcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:55 INFO - Running setup.py (path:/tmp/pip-128sPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:55 INFO - Running setup.py (path:/tmp/pip-vvH0QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:55 INFO - Running setup.py (path:/tmp/pip-RJbzIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:55 INFO - Running setup.py (path:/tmp/pip-vhjQ8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:55 INFO - Running setup.py (path:/tmp/pip-kONXZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:55 INFO - Running setup.py (path:/tmp/pip-yYPgLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:55 INFO - Running setup.py (path:/tmp/pip-AmxMD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:56 INFO - Running setup.py (path:/tmp/pip-jc7v0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:56 INFO - Running setup.py (path:/tmp/pip-RA69Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:56 INFO - Running setup.py (path:/tmp/pip-RG27QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:56 INFO - Running setup.py (path:/tmp/pip-aQnoCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:56 INFO - Running setup.py (path:/tmp/pip-SrcsHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:56 INFO - Running setup.py install for manifestparser 11:31:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:56 INFO - Running setup.py install for mozcrash 11:31:56 INFO - Running setup.py install for mozdebug 11:31:56 INFO - Running setup.py install for mozdevice 11:31:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:56 INFO - Running setup.py install for mozfile 11:31:56 INFO - Running setup.py install for mozhttpd 11:31:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:56 INFO - Running setup.py install for mozinfo 11:31:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for mozInstall 11:31:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for mozleak 11:31:57 INFO - Running setup.py install for mozlog 11:31:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for moznetwork 11:31:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for mozprocess 11:31:57 INFO - Running setup.py install for mozprofile 11:31:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for mozrunner 11:31:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for mozscreenshot 11:31:57 INFO - Running setup.py install for moztest 11:31:58 INFO - Running setup.py install for mozversion 11:31:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:58 INFO - Cleaning up... 11:31:58 INFO - Return code: 0 11:31:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:58 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')]} 11:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:58 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')]} 11:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:58 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:31:58 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 11:31:58 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 11:31:58 INFO - Using env: {'DISPLAY': ':0', 11:31:58 INFO - 'HOME': '/home/cltbld', 11:31:58 INFO - 'LANG': 'en_US.UTF-8', 11:31:58 INFO - 'LANGUAGE': 'en_US:en', 11:31:58 INFO - 'LOGNAME': 'cltbld', 11:31:58 INFO - 'MAIL': '/var/mail/cltbld', 11:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:58 INFO - 'MOZ_NO_REMOTE': '1', 11:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:58 INFO - 'NO_EM_RESTART': '1', 11:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:58 INFO - 'PWD': '/builds/slave/test', 11:31:58 INFO - 'SHELL': '/bin/bash', 11:31:58 INFO - 'SHLVL': '1', 11:31:58 INFO - 'TERM': 'linux', 11:31:58 INFO - 'TMOUT': '86400', 11:31:58 INFO - 'USER': 'cltbld', 11:31:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:58 INFO - '_': '/tools/buildbot/bin/python'} 11:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:58 INFO - Running setup.py (path:/tmp/pip-i3Jrze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:58 INFO - Running setup.py (path:/tmp/pip-yvUF4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:58 INFO - Running setup.py (path:/tmp/pip-mLnsgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:58 INFO - Running setup.py (path:/tmp/pip-iFDICe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:58 INFO - Running setup.py (path:/tmp/pip-nZgNPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:58 INFO - Running setup.py (path:/tmp/pip-91DiX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:58 INFO - Running setup.py (path:/tmp/pip-AZF3t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:58 INFO - Running setup.py (path:/tmp/pip-4M3k3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:58 INFO - Running setup.py (path:/tmp/pip-SucBPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:58 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)) 11:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:58 INFO - Running setup.py (path:/tmp/pip-BHv0HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:59 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)) 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:59 INFO - Running setup.py (path:/tmp/pip-Zu0KFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:59 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)) 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:59 INFO - Running setup.py (path:/tmp/pip-YXSN4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:59 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)) 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:59 INFO - Running setup.py (path:/tmp/pip-xjt76c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:59 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)) 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:59 INFO - Running setup.py (path:/tmp/pip-E2mgRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:59 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)) 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:59 INFO - Running setup.py (path:/tmp/pip-AKioLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:59 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)) 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:59 INFO - Running setup.py (path:/tmp/pip-lEGitS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:59 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)) 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:59 INFO - Running setup.py (path:/tmp/pip-SLeg1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:59 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)) 11:31:59 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)) 11:31:59 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)) 11:31:59 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)) 11:31:59 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)) 11:31:59 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)) 11:31:59 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)) 11:31:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:59 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 11:31:59 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 11:31:59 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 11:31:59 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 11:32:00 INFO - Downloading blessings-1.6.tar.gz 11:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:00 INFO - Installing collected packages: blessings 11:32:00 INFO - Running setup.py install for blessings 11:32:00 INFO - Successfully installed blessings 11:32:00 INFO - Cleaning up... 11:32:00 INFO - Return code: 0 11:32:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:01 INFO - Reading from file tmpfile_stdout 11:32:01 INFO - Current package versions: 11:32:01 INFO - argparse == 1.2.1 11:32:01 INFO - blessings == 1.6 11:32:01 INFO - blobuploader == 1.2.4 11:32:01 INFO - docopt == 0.6.1 11:32:01 INFO - functools32 == 3.2.3-2 11:32:01 INFO - jsonschema == 2.5.1 11:32:01 INFO - manifestparser == 1.1 11:32:01 INFO - mozInstall == 1.13 11:32:01 INFO - mozcrash == 1.0 11:32:01 INFO - mozdebug == 0.1 11:32:01 INFO - mozdevice == 0.51 11:32:01 INFO - mozfile == 1.2 11:32:01 INFO - mozhttpd == 0.7 11:32:01 INFO - mozinfo == 0.10 11:32:01 INFO - mozleak == 0.1 11:32:01 INFO - mozlog == 3.5 11:32:01 INFO - moznetwork == 0.27 11:32:01 INFO - mozprocess == 0.25 11:32:01 INFO - mozprofile == 0.28 11:32:01 INFO - mozrunner == 6.13 11:32:01 INFO - mozscreenshot == 0.1 11:32:01 INFO - mozsystemmonitor == 0.3 11:32:01 INFO - moztest == 0.8 11:32:01 INFO - mozversion == 1.4 11:32:01 INFO - psutil == 3.1.1 11:32:01 INFO - requests == 1.2.3 11:32:01 INFO - wsgiref == 0.1.2 11:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:01 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')]} 11:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:01 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')]} 11:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:01 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:32:01 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 11:32:01 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 11:32:01 INFO - Using env: {'DISPLAY': ':0', 11:32:01 INFO - 'HOME': '/home/cltbld', 11:32:01 INFO - 'LANG': 'en_US.UTF-8', 11:32:01 INFO - 'LANGUAGE': 'en_US:en', 11:32:01 INFO - 'LOGNAME': 'cltbld', 11:32:01 INFO - 'MAIL': '/var/mail/cltbld', 11:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:01 INFO - 'MOZ_NO_REMOTE': '1', 11:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:01 INFO - 'NO_EM_RESTART': '1', 11:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:01 INFO - 'PWD': '/builds/slave/test', 11:32:01 INFO - 'SHELL': '/bin/bash', 11:32:01 INFO - 'SHLVL': '1', 11:32:01 INFO - 'TERM': 'linux', 11:32:01 INFO - 'TMOUT': '86400', 11:32:01 INFO - 'USER': 'cltbld', 11:32:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:01 INFO - '_': '/tools/buildbot/bin/python'} 11:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:01 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)) 11:32:01 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)) 11:32:01 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)) 11:32:01 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)) 11:32:01 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)) 11:32:01 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)) 11:32:01 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)) 11:32:01 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)) 11:32:01 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)) 11:32:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:32:01 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 11:32:01 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 11:32:01 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 11:32:01 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 11:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:32:02 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)) 11:32:02 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)) 11:32:02 INFO - Installing collected packages: simplejson 11:32:02 INFO - Running setup.py install for simplejson 11:32:02 INFO - building 'simplejson._speedups' extension 11:32:02 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 11:32:03 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 11:32:03 INFO - Successfully installed simplejson 11:32:03 INFO - Cleaning up... 11:32:03 INFO - Return code: 0 11:32:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:03 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')]} 11:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:03 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')]} 11:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:03 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 0x20a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x240e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, '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': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', '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 11:32:03 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 11:32:03 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 11:32:03 INFO - Using env: {'DISPLAY': ':0', 11:32:03 INFO - 'HOME': '/home/cltbld', 11:32:03 INFO - 'LANG': 'en_US.UTF-8', 11:32:03 INFO - 'LANGUAGE': 'en_US:en', 11:32:03 INFO - 'LOGNAME': 'cltbld', 11:32:03 INFO - 'MAIL': '/var/mail/cltbld', 11:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:03 INFO - 'MOZ_NO_REMOTE': '1', 11:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:03 INFO - 'NO_EM_RESTART': '1', 11:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:03 INFO - 'PWD': '/builds/slave/test', 11:32:03 INFO - 'SHELL': '/bin/bash', 11:32:03 INFO - 'SHLVL': '1', 11:32:03 INFO - 'TERM': 'linux', 11:32:03 INFO - 'TMOUT': '86400', 11:32:03 INFO - 'USER': 'cltbld', 11:32:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:03 INFO - '_': '/tools/buildbot/bin/python'} 11:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:03 INFO - Cleaning up... 11:32:03 INFO - Return code: 0 11:32:03 INFO - Running post-action listener: _resource_record_post_action 11:32:03 INFO - Running post-action listener: _start_resource_monitoring 11:32:03 INFO - Starting resource monitoring. 11:32:03 INFO - [mozharness: 2017-09-26 18:32:03.817226Z] Finished create-virtualenv step (success) 11:32:03 INFO - [mozharness: 2017-09-26 18:32:03.817801Z] Running install step. 11:32:03 INFO - Running pre-action listener: _resource_record_pre_action 11:32:03 INFO - Running main action method: install 11:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:04 INFO - Reading from file tmpfile_stdout 11:32:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:04 INFO - Reading from file tmpfile_stdout 11:32:04 INFO - Output received: 11:32:04 INFO - Usage: mozinstall [options] installer 11:32:04 INFO - Options: 11:32:04 INFO - -h, --help show this help message and exit 11:32:04 INFO - -d DEST, --destination=DEST 11:32:04 INFO - Directory to install application into. [default: 11:32:04 INFO - "/builds/slave/test"] 11:32:04 INFO - --app=APP Application being installed. [default: firefox] 11:32:04 INFO - mkdir: /builds/slave/test/build/application 11:32:04 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'] 11:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:32:21 INFO - Reading from file tmpfile_stdout 11:32:21 INFO - Output received: 11:32:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:21 INFO - Running post-action listener: _resource_record_post_action 11:32:21 INFO - [mozharness: 2017-09-26 18:32:21.957200Z] Finished install step (success) 11:32:21 INFO - [mozharness: 2017-09-26 18:32:21.957555Z] Running setup-mitmproxy step. 11:32:21 INFO - Running pre-action listener: _resource_record_pre_action 11:32:21 INFO - Running main action method: setup_mitmproxy 11:32:21 INFO - Skipping: mitmproxy is not required 11:32:21 INFO - Running post-action listener: _resource_record_post_action 11:32:21 INFO - [mozharness: 2017-09-26 18:32:21.958676Z] Finished setup-mitmproxy step (success) 11:32:21 INFO - [mozharness: 2017-09-26 18:32:21.958909Z] Running run-tests step. 11:32:21 INFO - Running pre-action listener: _resource_record_pre_action 11:32:21 INFO - Running pre-action listener: _set_gcov_prefix 11:32:21 INFO - Running main action method: run_tests 11:32:21 WARNING - Try message not found. 11:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:21 INFO - Python 2.7.3 11:32:21 INFO - Return code: 0 11:32:21 INFO - grabbing minidump binary from tooltool 11:32:21 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')]} 11:32:21 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 0x240bd60>, '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 0x240ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:21 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 11:32:21 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 11:32:21 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 11:32:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:22 INFO - Return code: 0 11:32:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:22 INFO - ENV: RUST_BACKTRACE is now full 11:32:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:22 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:32:22 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:32:22 INFO - Using env: {'DISPLAY': ':0', 11:32:22 INFO - 'HOME': '/home/cltbld', 11:32:22 INFO - 'LANG': 'en_US.UTF-8', 11:32:22 INFO - 'LANGUAGE': 'en_US:en', 11:32:22 INFO - 'LOGNAME': 'cltbld', 11:32:22 INFO - 'MAIL': '/var/mail/cltbld', 11:32:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:22 INFO - 'MOZ_NO_REMOTE': '1', 11:32:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:22 INFO - 'NO_EM_RESTART': '1', 11:32:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:22 INFO - 'PWD': '/builds/slave/test', 11:32:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:22 INFO - 'RUST_BACKTRACE': 'full', 11:32:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:22 INFO - 'SHELL': '/bin/bash', 11:32:22 INFO - 'SHLVL': '1', 11:32:22 INFO - 'TERM': 'linux', 11:32:22 INFO - 'TMOUT': '86400', 11:32:22 INFO - 'USER': 'cltbld', 11:32:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:22 INFO - '_': '/tools/buildbot/bin/python'} 11:32:22 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:32:22 INFO - mozversion application_buildid: 20170926173447 11:32:22 INFO - mozversion application_changeset: b30ae5a455367f336ded1052081e4c54a139fa81 11:32:22 INFO - mozversion application_display_name: Nightly 11:32:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:22 INFO - mozversion application_name: Firefox 11:32:22 INFO - mozversion application_remotingname: firefox 11:32:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:32:22 INFO - mozversion application_vendor: Mozilla 11:32:22 INFO - mozversion application_version: 58.0a1 11:32:22 INFO - mozversion platform_buildid: 20170926173447 11:32:22 INFO - mozversion platform_changeset: b30ae5a455367f336ded1052081e4c54a139fa81 11:32:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:32:22 INFO - mozversion platform_version: 58.0a1 11:32:22 INFO - using testdate: 1506450742 11:32:22 INFO - actual date: 1506450742 11:32:22 INFO - starting webserver on 'localhost:57356' 11:32:22 INFO - SUITE-START | Running 2 tests 11:32:22 INFO - TEST-START | dromaeo_css 11:32:22 INFO - Initialising browser for dromaeo_css test... 11:32:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57356/getInfo.html -profile /tmp/tmpx5C_3M/profile 11:32:22 INFO - TEST-INFO | started process 9549 (/builds/slave/test/build/application/firefox/firefox http://localhost:57356/getInfo.html) 11:32:27 INFO - TEST-INFO | 9549: exit 0 11:32:27 INFO - Browser initialized. 11:32:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:27 INFO - Using env: {'DISPLAY': ':0', 11:32:27 INFO - 'HOME': '/home/cltbld', 11:32:27 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:27 INFO - 'LANG': 'en_US.UTF-8', 11:32:27 INFO - 'LANGUAGE': 'en_US:en', 11:32:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:27 INFO - 'LOGNAME': 'cltbld', 11:32:27 INFO - 'MAIL': '/var/mail/cltbld', 11:32:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:27 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:27 INFO - 'MOZ_NO_REMOTE': '1', 11:32:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:27 INFO - 'NO_EM_RESTART': '1', 11:32:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:27 INFO - 'PWD': '/builds/slave/test', 11:32:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:27 INFO - 'RUST_BACKTRACE': 'full', 11:32:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:27 INFO - 'SHELL': '/bin/bash', 11:32:27 INFO - 'SHLVL': '1', 11:32:27 INFO - 'STYLO_FORCE_DISABLED': '1', 11:32:27 INFO - 'TERM': 'linux', 11:32:27 INFO - 'TMOUT': '86400', 11:32:27 INFO - 'USER': 'cltbld', 11:32:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:27 INFO - '_': '/tools/buildbot/bin/python'} 11:32:27 INFO - TEST-INFO | started process 9784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx5C_3M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:28 INFO - PID 9784 | 11:32:28 INFO - PID 9784 | (/builds/slave/test/build/application/firefox/firefox:9833): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:28 INFO - PID 9784 | 11:32:39 INFO - PID 9784 | RSS: Main: 151625728 11:32:39 INFO - PID 9784 | 11:35:36 INFO - PID 9784 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57356/tests/dromaeo/cssquery-ext.html) 11:35:37 INFO - PID 9784 | RSS: Main: 153296896 11:35:37 INFO - PID 9784 | 11:38:39 INFO - PID 9784 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-ext.html (next: http://localhost:57356/tests/dromaeo/cssquery-jquery.html) 11:38:40 INFO - PID 9784 | RSS: Main: 153190400 11:38:40 INFO - PID 9784 | 11:41:41 INFO - PID 9784 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57356/tests/dromaeo/cssquery-mootools.html) 11:41:42 INFO - PID 9784 | RSS: Main: 154923008 11:41:42 INFO - PID 9784 | 11:44:44 INFO - PID 9784 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57356/tests/dromaeo/cssquery-prototype.html) 11:44:44 INFO - PID 9784 | RSS: Main: 153739264 11:44:44 INFO - PID 9784 | 11:47:47 INFO - PID 9784 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57356/tests/dromaeo/cssquery-yui.html) 11:47:48 INFO - PID 9784 | RSS: Main: 153829376 11:47:48 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-yui.html (next: http://localhost:57356/tests/dromaeo/cssquery-dojo.html) 11:50:50 INFO - PID 9784 | RSS: Main: 157630464 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | __start_tp_report 11:50:50 INFO - PID 9784 | _x_x_mozilla_page_load 11:50:50 INFO - PID 9784 | _x_x_mozilla_page_load_details 11:50:50 INFO - PID 9784 | |i|pagename|runs| 11:50:50 INFO - PID 9784 | |0;dojo.html;3097.922551936201;3145.9842700786494;3157.289609837786;3167.4932010878265;3179.7456203503693;6244.906326405107;6345.619262844232;6348.904766428507;6381.074744162093;6451.645159516224;6269.247690277161;6284.717187726552;6318.778842740505;6321.083442900788;6369.140166077578;5764.538836893049;5888.205092312547;5899.764009439617;5900.498457631085;5922.378150294222;5879.176915231871;5936.228290322252;5939.613925094876;5944.405559444042;5956.374580669032;1287.6315647917374;5498.285222920995;5794.043982742843;5928.822135335947;5935.792247271324;5825.271841019872;5850.151727999459;5916.97041514794;5930.3773103823905;5939.07944268639;5792.362840087587;5816.941830581683;5842.094475356326;5888.470037696585;5891.3814049525035;6191.81424557264;6303.338149494283;6325.051242313643;6400.263969643504;6413.070104834773;6773.051772751819;6778.932210677879;6854.485913556453;6866.725330986805;6878.484113691443;6669;6771.72913083476;6773.593584384904;6786.253512113663;6790.864182716367;6195.876082478325;6261.8747625047245;6275.278342990523;6282.654454005028;6378.425941665272;7020;7115.679794409264;7116.71533138679;7123.43012558994;7137.036500072424;6668.599884006975;6678.933210667831;6697.129373181455;6770.52606317553;6781.6609169541325;6644.534882558271;6773.796786096425;6775.966120169466;6784.864302713918;6869.656517174221;6713.26154123046;6725.798226053226;6733.764318248838;6735.696893639798;6759.628220447824;6858.6570671466225;6880.346367095118;6899.379055884994;6927.480438967098;6930.3762661359715;5287.788488460418;5291.735413229323;5351.946480535223;5359.196120581944;5362.008028514737;4595.655325850575;4628.467726211461;4629.074185162981;4649.744264065509;4661.067786442657;5705.22979397776;5790.42095790426;5793.275840519935;5860.120981852756;5866.472017518444;6826.556273842284;6828.829279267959;6904.654767261617;6914.997325387791;6939.410150137194;5752.798652047159;5873.9412605873395;5880.941190588125;5886.558508111909;5887.941120588825;5686.09022556389;5842.824715258549;5847.912281315784;5895.675737834375;5914.9112763308585;6472.417482426604;6517.902231466532;6551.017347397833;6575.178102737158;6601.2738598754095;6845.247022827485;6857.897131543131;6861.588304701734;6875.862482750417;6900.137482814648;6521.184851893513;6525.119108920235;6526.771562995273;6624.403803657501;6642.070110184482;6652.866942661217;6667.333266673294;6678.198616165897;6769.864602708017;6771.830704232433;6869.0383346330555;6917.688704008432;6921.584704917721;6930.341617546325;6938;6591.077249185214;6595.340465953558;6674.365935236145;6692.631905245258;6695.866082678222;6595;6600.504962127764;6657.667116644246;6685.966570167118;6686.966565167143;6420.775272865428;6499.415052645285;6500.057491663588;6523.771667991788;6599.307072757291;6621.735130594915;6698.698558564779;6731.46148308144;6732.091167692299;6798.93201067983;6305.842353941188;6406.071119687526;6478.352164783484;6498.675066246574;6520.739170433129 11:50:50 INFO - PID 9784 | |1;ext.html;810.4326971120217;837.9832403351929;877.793718476158;896.2650626486284;898.2993265253101;39578.80210598947;40363;40416.59583404165;40544;40563.18873622526;36386.45420318697;36750.26499470009;36791.4481282781;36825.26349473009;36836.63163368365;7074.929250707504;7144.964275178617;7146.606936618484;7168.498205125643;7178.928210717878;7094.11323584552;7161;7161.06906102206;7181.174164971017;7189.640517974107;7845.921540784576;8024.478408903432;8027.197280271985;8028.518288902685;8028.9598552007155;7869.173736757644;7897;7977.4016948728495;7982.521048737065;7992.480488768211;7568.924310756932;7583.658735356867;7723.111842138113;7724.188960159158;7727.613619319068;36642.81678591617;36678;36798;36920.63079369199;36933;3556;3604.4773507841214;3606.2607165531003;3609.5848977367677;3615.5480564929385;30072.69927300721;30154.84922575395;30220.84889575538;30317.848410757804;30423.847880760455;5173.922391164136;5202.453742357074;5224.791008359661;5236.947630523684;5240.266362709223;184999;189514.05242973834;189656;191926;198469;46477.535224647996;46766.5323346769;46783.76608116938;46824.06351872943;46876.7656161717;48052;48557;48654.51345486571;48728.75635621799;48753;14428.350724217225;14557.563273101823;14562.199079050753;14590;14607.488737894335;11936.880631193751;11956.880431195577;11995.700107497383;12017.459214335377;12082.939585302018;13101.148425352321;13202.339883006003;13271.469141234436;13355.799663005062;13380.330983450789;5181.611379146504;5291.656042357235;5314.8937021260135;5383.865403364869;5459.2902922619805;986.7335819328741;993.7962717643011;1004.2016596805557;1007.5566750629846;1012.6202673997251;22611.208607698652;22683.092676293094;22683.432914177276;22815.201467948544;23124.537509250058;1090.3294473898495;1101.6970333158285;1109.9778004440027;1111.0778054214982;1112.783007313566;11857.762844743056;11981.580644677395;11983.400829958468;12157.635270941886;12174.878251217375;226017;226436;227721;227916;228270;50759.23861142086;51101;51396.48603513917;51629.22556161661;51817;1429.1425144913178;1470.073853472327;1471.315838135251;1479.8298195707416;1488.7543555313252;22253.77746222582;22302.10791568319;22573.774262257168;22813.429664257863;22904.198353057564;35854.10364740902;35965.460518092776;35967;36014;36020.819895901404;191229;192303;192909;193013;193130;31289.84355078301;34762.478562822085;35591.28817423689;35596.82201588975;35633.28733425369;44312.55687443084;44452.55547444484;44666.3300050506;44737;44858.327125092495;32041.359172815948;32779.67220327766;32790.180245494055;32791.344173115926;33172.33655326832;32469.35061298808;32553.674463255065;32587.34825303528;32622.34755304833;32722.50916236211;34945.47581786326;36451.635483645885;36717.44923826198;36721.08197295089;37215.813920930224;31480.527792083594;32018.839905800323;32080.03759887207;32261.838690806395;32642.51036234411;22961.770382295963;23852.761472385748;24004.63993040071;24381;24792.87603562043 11:50:50 INFO - PID 9784 | |2;jquery.html;578.9710514474281;583.3087790967703;599.3766482857825;607.3107023528296;614.6742226619891;20753.688694669592;21623.567528649437;21665.783342166575;21679.566408671817;21686.3494095177;23526.058957641715;23823.5235295294;25173.74826251737;25364.619530707056;25373.365665858317;6409.487241020719;6588.703508342136;6597.67011649418;6600.042993765901;6601.3728695773825;6493.675316234193;6509.739610415601;6582.670866456682;6595.307492713244;6819.659017049153;7104.502684812065;7111.893321600181;7115.359617634412;7116.110486189226;7146.964265178667;7151.678174482135;7159.534630249017;7163.391111755507;7164.283571642794;7167;6772.390484856337;6958.130233720785;6958.408535274508;7087.964560177218;7091.858162836766;30825.84587077073;31499;31596.210094747814;31637.52543711846;31660.683393166004;2061.072517367191;2088.7075809386697;2090.5400811821373;2090.9477263068393;2094.476380904774;19956.401307960783;20822.375328740163;21279.468013299793;21653.67519487209;21799.346019619436;2507.2102287779476;2530.582453895105;2549.859757713325;2576.2528866628654;2625.146827281141;130152;136183;143653;150562;150845;20763.79236207649;20936.267230646856;22246.666300005512;22475;22877.771222287563;44788;44813.77593112014;44953;45036;45101;11952.64142075739;12035.157538972364;12088.456019479145;12148.69628259283;12256.632301030982;9925.702228933143;9950.154236889946;10010.099091081838;10029.097381235724;10053.849192262122;11269.436528173559;11485.196036277548;11542.422878856023;11672.83271672843;12201.35281736972;4108;4170.519465589672;4263.289065582549;4590.334401511762;4732.025098916926;922.8892532895961;959.9280053995839;961.5576834655997;964.0407794244771;968.4770224079059;19091.522711932314;19683.507912302306;19718.295779435062;19807.44422805845;20182.09180586877;1021.8569400283966;1028.598846449885;1030.8917563655857;1041.9635312764017;1043.6295115234134;10581.36511809294;10850.67447976562;10926.562937482411;10936.234463587472;10979.396133212591;465661;468370;479484;480903;487798;111222.44388778004;112980;114807;115377;115497.4225128869;1032.1381646325403;1051.395447617623;1151.3897634253858;1165.959191428296;1184.7452797648548;20663.17347306151;20671.79328206699;20777.896110519956;20806.063727132012;20905;58036.709816450646;58480.70759646175;59496.70251648714;59850;60449.093263601964;72659;72664.63667681628;72898;73728.63135684287;73745;19677.704834427208;20235.79764202398;20237.69643455379;20285.98570071461;20416.79583204149;22898.084076637413;23012.07951681914;23158.884205578863;23214;23361.766382335958;18332.358367457076;18375.54061148482;18420.263189472807;18530.258789648804;18695;16292.348306067624;16541.421050263183;16915.492535223962;17221.913890430467;17516.211770470614;17692.203850826485;18526.722099168794;18632;18871.15079821384;18942.715859261847;19926.800731992495;19929;19970.101345439198;19999.700004499653;20046;15975.20123993819;16152.838471615134;16153.111578863276;17850.732239016164;18502.629947400706 11:50:50 INFO - PID 9784 | |3;mootools.html;1287.3048553780957;1392.6866455047611;1395.4139261510165;1404.255744455439;1404.564584978656;15655.982361146533;16191.271392787323;16198.75701864473;16222.756658650129;16231.107289099094;15811.525654230363;15942.282597283122;16042.278097485612;16058.59853503663;16071.437499687514;2816.830990140588;2851.8431486268246;2878.5394336906097;2883.8558072096416;2884.7259510346485;2750.2574304937657;2782.220978126128;2792.497350476913;2792.5531914893622;2795.496810574096;2747.120921305183;2795.888164473429;2892.4070565534016;2893.8408387538675;2895.1314605618336;2758.820676656011;2810.6486689163853;2819.4502072095847;2833.7874659400522;2841.2328671258642;2506.260653107338;2634.4204275059456;2745.574435962429;2748.8900443982216;2758.4207316463567;15339.616509587238;15396.153211573359;15491.457798977095;15553.922230388776;15574.299156537869;8006.399520035962;8371.95814020926;8372.785946037851;8375.916240837574;8385.496870187748;5255.842324730264;5261.158214685632;5386.326709161355;5392.245085688007;5450.264214331054;1994.4515258303938;1996.422825967484;2003.4991252186953;2012.3359291433792;2032.1972820735728;27152.321191970357;27548.586771198246;27577.03480378197;27614.171574852786;27615.44769104627;6763.93236067633;6778.8644227116165;6833.624150671761;6956.756513522002;7017.403520700797;17843.643127137646;17856.46430607084;17878.91060544689;17887.821121788875;17902.373416930346;8071.636776345079;8217.34261259098;8217.753467395987;8219.383546234056;8221.095679475253;7252.601106939063;7379.852402951911;7395.81510462232;7473.028506294147;7516.962415187889;5348.598855085884;5388.838334849961;5442.401335853053;5506.201600767947;5507.807226747044;1585.0727324515058;1591.3793620488018;1597.5926138834523;1614.4026710117332;1626.5608285763014;884.9026607073217;905.2215095018279;906.5195446413411;929.2658799548282;934.2946075712794;7715.691372345155;7755.650995705207;7756.728514501965;7806.843863122705;7843.490173138728;722.7217521254249;724.344468256229;725.2493669052506;738.0405472885335;744.757953665061;4938.358013458227;5353.946460535345;5468.945310546844;5572.136318870582;5607.579431542651;21861.67207491889;22368.105275788785;22463.663045054338;22495.32514024582;22816.20143294977;21296.78703212948;22097.55804883893;22130.893455327492;22236.55526889453;22270.777292227194;11250.718732031764;11854.94072529649;11883.643490695293;11889.821652675217;11902.226355286879;8810.251128654136;9161.35870489086;9175.908240917506;9208.539573021457;9314.767130821783;18757.531061723566;18879.6224075515;19307.613847722685;19631.214751410356;19873.50316242048;19987.400377988684;20078.89960550188;20139;20208;20346.694799577723;12433.191842530206;12583.685407864876;12596.811047834473;12692.36538173106;12771.93614031924;14332.283385830458;14403.78394324107;14407.78388324197;14444.494442694455;14467.204303762974;11554.48004839801;11652.53389864396;11856.70358241051;11879.465424055765;12065.457054432396;11193.888061119285;11374.54501819918;11546.13403994687;11569.6529104127;11791.646250612495;9474.431534107976;9606;9621.663241786784;9623.133917947418;9625.470599116836;7165.104361954755;7288.187063467819;7301.160366557701;7301.4158867289425;7359.190489046094;7744.65149068282;7775;7813.218678132142;7874.21257874208;7913.327367173854 11:50:50 INFO - PID 9784 | |4;prototype.html;480.8552838449071;504.122826282269;509.67890229155637;515.6567142593543;538.6875612144956;6192.2569291685;6217.813465596028;6230.158928544645;6327.49380049596;6357.936420635792;6086.587224262407;6166.3525329840395;6207.28616209135;6239.906401403971;6252.34350393209;5142.228665700138;5145.81989630363;5153.69077855328;5187.325647665798;5189.455107213745;4877.731789734659;5089.567386772129;5136.666116702421;5196.870078248036;5199.168133098705;4945.455999840015;4952.801887924478;4953.554180123788;4979.327790748257;5029.748512574375;4966.304717339575;4976.4774698656665;5015.473375295596;5016.849494515171;5021.9748901255625;4415.403920470728;4486.932696009562;4518.638508919312;4523.660725445605;4536.8865778355475;6106.328303886569;6122.204113465265;6127.172831667757;6142.011538749728;6168.506519478476;5658.179563963244;5731.770729170828;5766.356588372336;5769.1923130761725;5791.5656325775735;6492.610443373413;6501.707423165922;6563.638999855054;6576.506761992822;6589.868202635968;4677.976610116962;4919.163742163805;4928.975355123237;4930.482299358551;4974.751262436864;6706.83232919176;6812.863742725167;6817.625030623314;6878.828029299258;6881.965590172017;4995.450500444948;5014.874628134326;5024.145895197825;5034.924476132861;5057.570106540985;5090.821821236313;5100.132977393852;5102.668326558762;5118.413291879529;5120.155174396257;5653.766762128936;5681.971590142023;5684.54523638108;5689;5704.743286552115;6602.7028783704845;6626.56927299724;6628.767993120217;6634.701438435282;6645.405102775396;1748.5104170832187;1751.098184435017;1760.4278609451978;1769.177332540375;1787.9821201787815;1186.5431808753692;1200;1223.3516236394726;1227.6623928419579;1259.987400125987;5630.408807075198;5662.405447427961;5682.829515114553;5691;5706.914396284059;6672.566283191577;6686.665666716742;6740.865182696319;6751.932480675228;6789.762358317435;5494.5054945055135;5512.724363781795;5565.220869078333;5597.768490931989;5636.408177141423;3488.424409972326;3491.94762078569;3519.208178159945;3524.8942531724088;3536.4872093546805;6444.2266927968;6483.805485835433;6517.771877984248;6528.910748560415;6536.215654121535;6457.870842583122;6745.325467453215;6767.729290828312;6850.349216824394;6882.5870447772295;6423.164988551458;6437.2918978912285;6440.355964403616;6464.418202361904;6468.208381199722;6611.768588099393;6661.533692641662;6680.231773346128;6692.564983276072;6695.866082678416;6628.674265146893;6640.933590664032;6649.135612370361;6667.666616669244;6708.228553716385;6402.91905130825;6445.452136568257;6468.8059358219325;6481.837954051187;6511.479081673549;4941.629377796751;4962.652614317108;4970.602351811919;4974.850754477371;5001.224810154432;6357.300696923242;6447.580907241015;6589.868202636017;6677.165354330708;6730.8653826924165;6420.133282006869;6465.090709180981;6476.31998640136;6480.189976252968;6501.44737697301;6363.7772677956045;6395.232572091379;6402.871942561216;6492.415682588589;6494.740210391531;6331.783875643488;6379.298277189413;6382.393672601095;6406.263279722705;6447.161868957006;6485.805425837232;6512.381323774234;6541.378569035934;6560.901586476111;6606.504512161511;6320.841978950563;6325.936740632535;6335.588186767845;6350.174477317919;6415.486761059011 11:50:50 INFO - PID 9784 | |5;yui.html;910.330906783514;914.3096961793844;917.92656587473;934.8457504511754;936.4989730494183;19509.317173898915;20336.38990830274;20341.28805491808;20394.89802550989;20441.488962775937;17479.563010924703;17660.558486037822;17707.29170833165;17708.468745937644;17734.02462864542;964.9035096490347;982.6904525074615;982.9803403931917;986.7039888033597;987.377951890308;975.8926518083006;979.6277414582448;980.3137803537517;981.5730157381527;982.79852630211;1004.1264100232771;1026.635544381745;1044.3838135500052;1049.1868801678684;1049.9947500262488;1024.0271741845202;1035.6012935019996;1038.3354653022072;1042.3016578892161;1042.5412818359935;716.358858821352;740.1155619035255;747.0997448075111;750.7785203365021;759.4152502572988;19932.70100948487;20010.79989200104;20011.59976800456;20040.69938950917;20041.498962525908;20172.29396971099;20484.69272960907;20513.282035128697;20624.793752062436;20758.79241207599;16180.271887765079;16603.584910377216;16762.497125086265;16883.746743798853;17018.659626807395;3726.254749050174;3736.813159342022;3745.232227393378;3747.700183985302;3761.0597350662333;104951.4752426233;130782;132970.33514832365;133433;135949;17854.732179017326;18329.7250541242;18373.7243941341;18411.171497282387;18447.354342597944;31295.53056704151;32541.51187732186;32665.346693066007;32726;32879.178020549196;9065.320100992452;9151.359404841598;9281.39670921388;9296.163345298955;9302.581383837743;4168.645665118438;4211.115665710174;4232.915341693149;4249.383839343278;4250.53244143144;5486;5579.553635709133;5588.21764952907;5615.606907516435;5634.577406694432;995.4674249276602;1022.9232807539315;1037.3101887245048;1040.105509262034;1046.5081411736471;694.5034300475185;702.9332213439715;716.5378330976491;717.4073556704109;740.9222031686595;12042.518299267931;12075.879241207651;12534.561290354794;12741.044421668226;12779;693.6670398208787;703.7536862098225;703.9366457018892;718.7304760714732;722.7831650504828;5696.458836410535;5804.593678442468;5818.156367326798;5831.9708401458565;5874.412558744091;123877;125743.37128314484;126325;127058;130357;104965.47517262517;110796.44601777101;110839.44580277047;114536;114725;89982.55008725045;91581.08418915859;92712.53643731738;93814.0618593819;94752;10729.624463143753;10753.139748820233;10826;10945.01494865466;11030.393328367018;42927;45055.54944450645;45489.317660235785;45674.77162614166;46076;55841;55871;56157.43842561522;57264;57444.71277643585;15970.28133734008;16472.341106355612;16504.75242871382;16527.925684830447;16593.751093733845;17947;18022.098895055457;18266;18399.81600183981;18416.263349466408;15593.922030389775;15675.764863526829;15728.92135539315;15943.282552285407;15987.280572374038;14468.493602723855;14657.780133297796;14686.63283417923;14712.779308310597;14861.851381486047;14369.497067602584;14481.348339324544;14538.273086345429;14603.634909127357;14608.196549189897;12414.565490207799;12444.440000199831;12466.5013399463;12604.810927835906;12639.936800316307;11862.940685296518;11982.520699172284;12146.514139434325;12271.386430678253;12409.813852792397 11:50:50 INFO - PID 9784 | __end_tp_report 11:50:50 INFO - PID 9784 | __start_cc_report 11:50:50 INFO - PID 9784 | _x_x_mozilla_cycle_collect,264 11:50:50 INFO - PID 9784 | __end_cc_report 11:50:50 INFO - PID 9784 | __startTimestamp1506451850364__endTimestamp 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | ------- Summary: start ------- 11:50:50 INFO - PID 9784 | Number of tests: 6 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | [#0] dojo.html Cycles:165 Average:6229.63 Median:6500.06 stddev:856.57 (13.2%) stddev-sans-first:823.21 11:50:50 INFO - PID 9784 | Values: 3097.9 3146.0 3157.3 3167.5 3179.7 6244.9 6345.6 6348.9 6381.1 6451.6 6269.2 6284.7 6318.8 6321.1 6369.1 5764.5 5888.2 5899.8 5900.5 5922.4 5879.2 5936.2 5939.6 5944.4 5956.4 1287.6 5498.3 5794.0 5928.8 5935.8 5825.3 5850.2 5917.0 5930.4 5939.1 5792.4 5816.9 5842.1 5888.5 5891.4 6191.8 6303.3 6325.1 6400.3 6413.1 6773.1 6778.9 6854.5 6866.7 6878.5 6669.0 6771.7 6773.6 6786.3 6790.9 6195.9 6261.9 6275.3 6282.7 6378.4 7020.0 7115.7 7116.7 7123.4 7137.0 6668.6 6678.9 6697.1 6770.5 6781.7 6644.5 6773.8 6776.0 6784.9 6869.7 6713.3 6725.8 6733.8 6735.7 6759.6 6858.7 6880.3 6899.4 6927.5 6930.4 5287.8 5291.7 5351.9 5359.2 5362.0 4595.7 4628.5 4629.1 4649.7 4661.1 5705.2 5790.4 5793.3 5860.1 5866.5 6826.6 6828.8 6904.7 6915.0 6939.4 5752.8 5873.9 5880.9 5886.6 5887.9 5686.1 5842.8 5847.9 5895.7 5914.9 6472.4 6517.9 6551.0 6575.2 6601.3 6845.2 6857.9 6861.6 6875.9 6900.1 6521.2 6525.1 6526.8 6624.4 6642.1 6652.9 6667.3 6678.2 6769.9 6771.8 6869.0 6917.7 6921.6 6930.3 6938.0 6591.1 6595.3 6674.4 6692.6 6695.9 6595.0 6600.5 6657.7 6686.0 6687.0 6420.8 6499.4 6500.1 6523.8 6599.3 6621.7 6698.7 6731.5 6732.1 6798.9 6305.8 6406.1 6478.4 6498.7 6520.7 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | [#1] ext.html Cycles:180 Average:36889.13 Median:35909.78 stddev:52911.39 (147.3%) stddev-sans-first:52990.47 11:50:50 INFO - PID 9784 | Values: 810.4 838.0 877.8 896.3 898.3 39578.8 40363.0 40416.6 40544.0 40563.2 36386.5 36750.3 36791.4 36825.3 36836.6 7074.9 7145.0 7146.6 7168.5 7178.9 7094.1 7161.0 7161.1 7181.2 7189.6 7845.9 8024.5 8027.2 8028.5 8029.0 7869.2 7897.0 7977.4 7982.5 7992.5 7568.9 7583.7 7723.1 7724.2 7727.6 36642.8 36678.0 36798.0 36920.6 36933.0 3556.0 3604.5 3606.3 3609.6 3615.5 30072.7 30154.8 30220.8 30317.8 30423.8 5173.9 5202.5 5224.8 5236.9 5240.3 184999.0 189514.1 189656.0 191926.0 198469.0 46477.5 46766.5 46783.8 46824.1 46876.8 48052.0 48557.0 48654.5 48728.8 48753.0 14428.4 14557.6 14562.2 14590.0 14607.5 11936.9 11956.9 11995.7 12017.5 12082.9 13101.1 13202.3 13271.5 13355.8 13380.3 5181.6 5291.7 5314.9 5383.9 5459.3 986.7 993.8 1004.2 1007.6 1012.6 22611.2 22683.1 22683.4 22815.2 23124.5 1090.3 1101.7 1110.0 1111.1 1112.8 11857.8 11981.6 11983.4 12157.6 12174.9 226017.0 226436.0 227721.0 227916.0 228270.0 50759.2 51101.0 51396.5 51629.2 51817.0 1429.1 1470.1 1471.3 1479.8 1488.8 22253.8 22302.1 22573.8 22813.4 22904.2 35854.1 35965.5 35967.0 36014.0 36020.8 191229.0 192303.0 192909.0 193013.0 193130.0 31289.8 34762.5 35591.3 35596.8 35633.3 44312.6 44452.6 44666.3 44737.0 44858.3 32041.4 32779.7 32790.2 32791.3 33172.3 32469.4 32553.7 32587.3 32622.3 32722.5 34945.5 36451.6 36717.4 36721.1 37215.8 31480.5 32018.8 32080.0 32261.8 32642.5 22961.8 23852.8 24004.6 24381.0 24792.9 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | [#2] jquery.html Cycles:180 Average:36023.71 Median:21659.73 stddev:80449.96 (371.4%) stddev-sans-first:80631.62 11:50:50 INFO - PID 9784 | Values: 579.0 583.3 599.4 607.3 614.7 20753.7 21623.6 21665.8 21679.6 21686.3 23526.1 23823.5 25173.7 25364.6 25373.4 6409.5 6588.7 6597.7 6600.0 6601.4 6493.7 6509.7 6582.7 6595.3 6819.7 7104.5 7111.9 7115.4 7116.1 7147.0 7151.7 7159.5 7163.4 7164.3 7167.0 6772.4 6958.1 6958.4 7088.0 7091.9 30825.8 31499.0 31596.2 31637.5 31660.7 2061.1 2088.7 2090.5 2090.9 2094.5 19956.4 20822.4 21279.5 21653.7 21799.3 2507.2 2530.6 2549.9 2576.3 2625.1 130152.0 136183.0 143653.0 150562.0 150845.0 20763.8 20936.3 22246.7 22475.0 22877.8 44788.0 44813.8 44953.0 45036.0 45101.0 11952.6 12035.2 12088.5 12148.7 12256.6 9925.7 9950.2 10010.1 10029.1 10053.8 11269.4 11485.2 11542.4 11672.8 12201.4 4108.0 4170.5 4263.3 4590.3 4732.0 922.9 959.9 961.6 964.0 968.5 19091.5 19683.5 19718.3 19807.4 20182.1 1021.9 1028.6 1030.9 1042.0 1043.6 10581.4 10850.7 10926.6 10936.2 10979.4 465661.0 468370.0 479484.0 480903.0 487798.0 111222.4 112980.0 114807.0 115377.0 115497.4 1032.1 1051.4 1151.4 1166.0 1184.7 20663.2 20671.8 20777.9 20806.1 20905.0 58036.7 58480.7 59496.7 59850.0 60449.1 72659.0 72664.6 72898.0 73728.6 73745.0 19677.7 20235.8 20237.7 20286.0 20416.8 22898.1 23012.1 23158.9 23214.0 23361.8 18332.4 18375.5 18420.3 18530.3 18695.0 16292.3 16541.4 16915.5 17221.9 17516.2 17692.2 18526.7 18632.0 18871.2 18942.7 19926.8 19929.0 19970.1 19999.7 20046.0 15975.2 16152.8 16153.1 17850.7 18502.6 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | [#3] mootools.html Cycles:180 Average:9667.30 Median:15186.50 stddev:6954.38 (45.8%) stddev-sans-first:6945.38 11:50:50 INFO - PID 9784 | Values: 1287.3 1392.7 1395.4 1404.3 1404.6 15656.0 16191.3 16198.8 16222.8 16231.1 15811.5 15942.3 16042.3 16058.6 16071.4 2816.8 2851.8 2878.5 2883.9 2884.7 2750.3 2782.2 2792.5 2792.6 2795.5 2747.1 2795.9 2892.4 2893.8 2895.1 2758.8 2810.6 2819.5 2833.8 2841.2 2506.3 2634.4 2745.6 2748.9 2758.4 15339.6 15396.2 15491.5 15553.9 15574.3 8006.4 8372.0 8372.8 8375.9 8385.5 5255.8 5261.2 5386.3 5392.2 5450.3 1994.5 1996.4 2003.5 2012.3 2032.2 27152.3 27548.6 27577.0 27614.2 27615.4 6763.9 6778.9 6833.6 6956.8 7017.4 17843.6 17856.5 17878.9 17887.8 17902.4 8071.6 8217.3 8217.8 8219.4 8221.1 7252.6 7379.9 7395.8 7473.0 7517.0 5348.6 5388.8 5442.4 5506.2 5507.8 1585.1 1591.4 1597.6 1614.4 1626.6 884.9 905.2 906.5 929.3 934.3 7715.7 7755.7 7756.7 7806.8 7843.5 722.7 724.3 725.2 738.0 744.8 4938.4 5353.9 5468.9 5572.1 5607.6 21861.7 22368.1 22463.7 22495.3 22816.2 21296.8 22097.6 22130.9 22236.6 22270.8 11250.7 11854.9 11883.6 11889.8 11902.2 8810.3 9161.4 9175.9 9208.5 9314.8 18757.5 18879.6 19307.6 19631.2 19873.5 19987.4 20078.9 20139.0 20208.0 20346.7 12433.2 12583.7 12596.8 12692.4 12771.9 14332.3 14403.8 14407.8 14444.5 14467.2 11554.5 11652.5 11856.7 11879.5 12065.5 11193.9 11374.5 11546.1 11569.7 11791.6 9474.4 9606.0 9621.7 9623.1 9625.5 7165.1 7288.2 7301.2 7301.4 7359.2 7744.7 7775.0 7813.2 7874.2 7913.3 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | [#4] prototype.html Cycles:180 Average:5497.64 Median:6167.43 stddev:1530.83 (24.8%) stddev-sans-first:1488.10 11:50:50 INFO - PID 9784 | Values: 480.9 504.1 509.7 515.7 538.7 6192.3 6217.8 6230.2 6327.5 6357.9 6086.6 6166.4 6207.3 6239.9 6252.3 5142.2 5145.8 5153.7 5187.3 5189.5 4877.7 5089.6 5136.7 5196.9 5199.2 4945.5 4952.8 4953.6 4979.3 5029.7 4966.3 4976.5 5015.5 5016.8 5022.0 4415.4 4486.9 4518.6 4523.7 4536.9 6106.3 6122.2 6127.2 6142.0 6168.5 5658.2 5731.8 5766.4 5769.2 5791.6 6492.6 6501.7 6563.6 6576.5 6589.9 4678.0 4919.2 4929.0 4930.5 4974.8 6706.8 6812.9 6817.6 6878.8 6882.0 4995.5 5014.9 5024.1 5034.9 5057.6 5090.8 5100.1 5102.7 5118.4 5120.2 5653.8 5682.0 5684.5 5689.0 5704.7 6602.7 6626.6 6628.8 6634.7 6645.4 1748.5 1751.1 1760.4 1769.2 1788.0 1186.5 1200.0 1223.4 1227.7 1260.0 5630.4 5662.4 5682.8 5691.0 5706.9 6672.6 6686.7 6740.9 6751.9 6789.8 5494.5 5512.7 5565.2 5597.8 5636.4 3488.4 3491.9 3519.2 3524.9 3536.5 6444.2 6483.8 6517.8 6528.9 6536.2 6457.9 6745.3 6767.7 6850.3 6882.6 6423.2 6437.3 6440.4 6464.4 6468.2 6611.8 6661.5 6680.2 6692.6 6695.9 6628.7 6640.9 6649.1 6667.7 6708.2 6402.9 6445.5 6468.8 6481.8 6511.5 4941.6 4962.7 4970.6 4974.9 5001.2 6357.3 6447.6 6589.9 6677.2 6730.9 6420.1 6465.1 6476.3 6480.2 6501.4 6363.8 6395.2 6402.9 6492.4 6494.7 6331.8 6379.3 6382.4 6406.3 6447.2 6485.8 6512.4 6541.4 6560.9 6606.5 6320.8 6325.9 6335.6 6350.2 6415.5 11:50:50 INFO - PID 9784 | 11:50:50 INFO - PID 9784 | [#5] yui.html Cycles:180 Average:24156.50 Median:19971.75 stddev:34607.37 (173.3%) stddev-sans-first:34660.43 11:50:50 INFO - PID 9784 | Values: 910.3 914.3 917.9 934.8 936.5 19509.3 20336.4 20341.3 20394.9 20441.5 17479.6 17660.6 17707.3 17708.5 17734.0 964.9 982.7 983.0 986.7 987.4 975.9 979.6 980.3 981.6 982.8 1004.1 1026.6 1044.4 1049.2 1050.0 1024.0 1035.6 1038.3 1042.3 1042.5 716.4 740.1 747.1 750.8 759.4 19932.7 20010.8 20011.6 20040.7 20041.5 20172.3 20484.7 20513.3 20624.8 20758.8 16180.3 16603.6 16762.5 16883.7 17018.7 3726.3 3736.8 3745.2 3747.7 3761.1 104951.5 130782.0 132970.3 133433.0 135949.0 17854.7 18329.7 18373.7 18411.2 18447.4 31295.5 32541.5 32665.3 32726.0 32879.2 9065.3 9151.4 9281.4 9296.2 9302.6 4168.6 4211.1 4232.9 4249.4 4250.5 5486.0 5579.6 5588.2 5615.6 5634.6 995.5 1022.9 1037.3 1040.1 1046.5 694.5 702.9 716.5 717.4 740.9 12042.5 12075.9 12534.6 12741.0 12779.0 693.7 703.8 703.9 718.7 722.8 5696.5 5804.6 5818.2 5832.0 5874.4 123877.0 125743.4 126325.0 127058.0 130357.0 104965.5 110796.4 110839.4 114536.0 114725.0 89982.6 91581.1 92712.5 93814.1 94752.0 10729.6 10753.1 10826.0 10945.0 11030.4 42927.0 45055.5 45489.3 45674.8 46076.0 55841.0 55871.0 56157.4 57264.0 57444.7 15970.3 16472.3 16504.8 16527.9 16593.8 17947.0 18022.1 18266.0 18399.8 18416.3 15593.9 15675.8 15728.9 15943.3 15987.3 14468.5 14657.8 14686.6 14712.8 14861.9 14369.5 14481.3 14538.3 14603.6 14608.2 12414.6 12444.4 12466.5 12604.8 12639.9 11862.9 11982.5 12146.5 12271.4 12409.8 11:50:50 INFO - PID 9784 | -------- Summary: end -------- 11:50:50 INFO - PID 9784 | 11:50:50 INFO - TEST-INFO | 9784: exit 0 11:50:50 INFO - TEST-OK | dromaeo_css | took 1108643ms 11:50:50 INFO - TEST-START | kraken 11:50:50 INFO - Initialising browser for kraken test... 11:50:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57356/getInfo.html -profile /tmp/tmpHSVKOx/profile 11:50:51 INFO - TEST-INFO | started process 10157 (/builds/slave/test/build/application/firefox/firefox http://localhost:57356/getInfo.html) 11:50:56 INFO - TEST-INFO | 10157: exit 0 11:50:56 INFO - Browser initialized. 11:50:56 INFO - Running cycle 1/1 for kraken test... 11:50:56 INFO - Using env: {'DISPLAY': ':0', 11:50:56 INFO - 'HOME': '/home/cltbld', 11:50:56 INFO - 'JSGC_DISABLE_POISONING': '1', 11:50:56 INFO - 'LANG': 'en_US.UTF-8', 11:50:56 INFO - 'LANGUAGE': 'en_US:en', 11:50:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:50:56 INFO - 'LOGNAME': 'cltbld', 11:50:56 INFO - 'MAIL': '/var/mail/cltbld', 11:50:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:56 INFO - 'MOZ_CRASHREPORTER': '1', 11:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:50:56 INFO - 'MOZ_NO_REMOTE': '1', 11:50:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:56 INFO - 'NO_EM_RESTART': '1', 11:50:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:56 INFO - 'PWD': '/builds/slave/test', 11:50:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:56 INFO - 'RUST_BACKTRACE': 'full', 11:50:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:50:56 INFO - 'SHELL': '/bin/bash', 11:50:56 INFO - 'SHLVL': '1', 11:50:56 INFO - 'STYLO_FORCE_DISABLED': '1', 11:50:56 INFO - 'TERM': 'linux', 11:50:56 INFO - 'TMOUT': '86400', 11:50:56 INFO - 'USER': 'cltbld', 11:50:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847', 11:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:56 INFO - '_': '/tools/buildbot/bin/python'} 11:50:56 INFO - TEST-INFO | started process 10396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSVKOx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:57 INFO - PID 10396 | 11:50:57 INFO - PID 10396 | (/builds/slave/test/build/application/firefox/firefox:10445): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:50:57 INFO - PID 10396 | 11:51:07 INFO - PID 10396 | RSS: Main: 151392256 11:51:07 INFO - PID 10396 | 11:51:10 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:11 INFO - PID 10396 | RSS: Main: 157335552 11:51:11 INFO - PID 10396 | 11:51:13 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-dft) 11:51:14 INFO - PID 10396 | RSS: Main: 157675520 11:51:14 INFO - PID 10396 | 11:51:17 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-fft) 11:51:17 INFO - PID 10396 | RSS: Main: 154521600 11:51:17 INFO - PID 10396 | 11:51:19 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-oscillator) 11:51:20 INFO - PID 10396 | RSS: Main: 154959872 11:51:20 INFO - PID 10396 | 11:51:22 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:23 INFO - PID 10396 | RSS: Main: 154918912 11:51:23 INFO - PID 10396 | 11:51:26 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:27 INFO - PID 10396 | RSS: Main: 158076928 11:51:27 INFO - PID 10396 | 11:51:30 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:31 INFO - PID 10396 | RSS: Main: 157913088 11:51:31 INFO - PID 10396 | 11:51:34 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57356/tests/kraken/driver.html?testName=json-parse-financial) 11:51:34 INFO - PID 10396 | RSS: Main: 158240768 11:51:34 INFO - PID 10396 | 11:51:36 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:37 INFO - PID 10396 | RSS: Main: 158081024 11:51:37 INFO - PID 10396 | 11:51:38 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:51:39 INFO - PID 10396 | RSS: Main: 158375936 11:51:39 INFO - PID 10396 | 11:51:41 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:42 INFO - PID 10396 | RSS: Main: 154841088 11:51:42 INFO - PID 10396 | 11:51:44 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:45 INFO - PID 10396 | RSS: Main: 155873280 11:51:45 INFO - PID 10396 | 11:51:48 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:48 INFO - PID 10396 | RSS: Main: 155537408 11:51:48 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57356/tests/kraken/driver.html?testName=ai-astar) 11:51:50 INFO - PID 10396 | RSS: Main: 157081600 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | __start_tp_report 11:51:50 INFO - PID 10396 | _x_x_mozilla_page_load 11:51:50 INFO - PID 10396 | _x_x_mozilla_page_load_details 11:51:50 INFO - PID 10396 | |i|pagename|runs| 11:51:50 INFO - PID 10396 | |0;ai-astar;109;108;108;107;107;107;101;108;108;107 11:51:50 INFO - PID 10396 | |1;audio-beat-detection;116;117;115;115;117;120;128;118;117;119 11:51:50 INFO - PID 10396 | |2;audio-dft;164;164;162;165;165;162;164;162;169;169 11:51:50 INFO - PID 10396 | |3;audio-fft;74;74;80;74;73;74;78;74;74;75 11:51:50 INFO - PID 10396 | |4;audio-oscillator;84;80;80;79;78;78;79;79;81;79 11:51:50 INFO - PID 10396 | |5;imaging-gaussian-blur;113;114;111;110;113;115;113;114;114;114 11:51:50 INFO - PID 10396 | |6;imaging-darkroom;155;148;157;148;147;148;148;149;148;148 11:51:50 INFO - PID 10396 | |7;imaging-desaturate;94;94;93;94;94;96;95;94;94;94 11:51:50 INFO - PID 10396 | |8;json-parse-financial;54;54;52;53;54;54;53;55;55;53 11:51:50 INFO - PID 10396 | |9;json-stringify-tinderbox;38;39;38;39;39;39;39;38;39;40 11:51:50 INFO - PID 10396 | |10;stanford-crypto-aes;72;73;73;75;73;73;75;72;74;73 11:51:50 INFO - PID 10396 | |11;stanford-crypto-ccm;113;112;110;113;114;112;115;113;124;113 11:51:50 INFO - PID 10396 | |12;stanford-crypto-pbkdf2;175;173;166;174;182;170;173;166;170;168 11:51:50 INFO - PID 10396 | |13;stanford-crypto-sha256-iterative;66;63;65;78;65;67;64;65;66;68 11:51:50 INFO - PID 10396 | __end_tp_report 11:51:50 INFO - PID 10396 | __start_cc_report 11:51:50 INFO - PID 10396 | _x_x_mozilla_cycle_collect,762 11:51:50 INFO - PID 10396 | __end_cc_report 11:51:50 INFO - PID 10396 | __startTimestamp1506451910870__endTimestamp 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | ------- Summary: start ------- 11:51:50 INFO - PID 10396 | Number of tests: 14 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#0] ai-astar Cycles:10 Average:107.00 Median:108.00 stddev:2.21 (2.0%) stddev-sans-first:2.22 11:51:50 INFO - PID 10396 | Values: 109.0 108.0 108.0 107.0 107.0 107.0 101.0 108.0 108.0 107.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:117.50 stddev:3.79 (3.2%) stddev-sans-first:3.94 11:51:50 INFO - PID 10396 | Values: 116.0 117.0 115.0 115.0 117.0 120.0 128.0 118.0 117.0 119.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.59 (1.6%) stddev-sans-first:2.74 11:51:50 INFO - PID 10396 | Values: 164.0 164.0 162.0 165.0 165.0 162.0 164.0 162.0 169.0 169.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#3] audio-fft Cycles:10 Average:75.00 Median:74.00 stddev:2.21 (3.0%) stddev-sans-first:2.32 11:51:50 INFO - PID 10396 | Values: 74.0 74.0 80.0 74.0 73.0 74.0 78.0 74.0 74.0 75.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:79.50 stddev:1.77 (2.2%) stddev-sans-first:0.97 11:51:50 INFO - PID 10396 | Values: 84.0 80.0 80.0 79.0 78.0 78.0 79.0 79.0 81.0 79.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 11:51:50 INFO - PID 10396 | Values: 113.0 114.0 111.0 110.0 113.0 115.0 113.0 114.0 114.0 114.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:148.00 stddev:3.44 (2.3%) stddev-sans-first:3.04 11:51:50 INFO - PID 10396 | Values: 155.0 148.0 157.0 148.0 147.0 148.0 148.0 149.0 148.0 148.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 11:51:50 INFO - PID 10396 | Values: 94.0 94.0 93.0 94.0 94.0 96.0 95.0 94.0 94.0 94.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.95 (1.8%) stddev-sans-first:1.00 11:51:50 INFO - PID 10396 | Values: 54.0 54.0 52.0 53.0 54.0 54.0 53.0 55.0 55.0 53.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:0.63 (1.6%) stddev-sans-first:0.60 11:51:50 INFO - PID 10396 | Values: 38.0 39.0 38.0 39.0 39.0 39.0 39.0 38.0 39.0 40.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:1.06 (1.5%) stddev-sans-first:1.01 11:51:50 INFO - PID 10396 | Values: 72.0 73.0 73.0 75.0 73.0 73.0 75.0 72.0 74.0 73.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:4.00 11:51:50 INFO - PID 10396 | Values: 113.0 112.0 110.0 113.0 114.0 112.0 115.0 113.0 124.0 113.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:173.00 stddev:4.83 (2.8%) stddev-sans-first:4.97 11:51:50 INFO - PID 10396 | Values: 175.0 173.0 166.0 174.0 182.0 170.0 173.0 166.0 170.0 168.0 11:51:50 INFO - PID 10396 | 11:51:50 INFO - PID 10396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:4.22 (6.4%) stddev-sans-first:4.47 11:51:50 INFO - PID 10396 | Values: 66.0 63.0 65.0 78.0 65.0 67.0 64.0 65.0 66.0 68.0 11:51:50 INFO - PID 10396 | -------- Summary: end -------- 11:51:50 INFO - PID 10396 | 11:51:51 INFO - PID 10396 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:51:51 INFO - TEST-INFO | 10396: exit 0 11:51:51 INFO - TEST-OK | kraken | took 60550ms 11:51:51 INFO - SUITE-END | took 1169s 11:51:52 INFO - Completed test suite (00:19:29) 11:51:52 INFO - javascript benchmark 11:51:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8657.33111881104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.922551936201, 3145.9842700786494, 3157.289609837786, 3167.4932010878265, 3179.7456203503693, 6244.906326405107, 6345.619262844232, 6348.904766428507, 6381.074744162093, 6451.645159516224, 6269.247690277161, 6284.717187726552, 6318.778842740505, 6321.083442900788, 6369.140166077578, 5764.538836893049, 5888.205092312547, 5899.764009439617, 5900.498457631085, 5922.378150294222, 5879.176915231871, 5936.228290322252, 5939.613925094876, 5944.405559444042, 5956.374580669032, 1287.6315647917374, 5498.285222920995, 5794.043982742843, 5928.822135335947, 5935.792247271324, 5825.271841019872, 5850.151727999459, 5916.97041514794, 5930.3773103823905, 5939.07944268639, 5792.362840087587, 5816.941830581683, 5842.094475356326, 5888.470037696585, 5891.3814049525035, 6191.81424557264, 6303.338149494283, 6325.051242313643, 6400.263969643504, 6413.070104834773, 6773.051772751819, 6778.932210677879, 6854.485913556453, 6866.725330986805, 6878.484113691443, 6669.0, 6771.72913083476, 6773.593584384904, 6786.253512113663, 6790.864182716367, 6195.876082478325, 6261.8747625047245, 6275.278342990523, 6282.654454005028, 6378.425941665272, 7020.0, 7115.679794409264, 7116.71533138679, 7123.43012558994, 7137.036500072424, 6668.599884006975, 6678.933210667831, 6697.129373181455, 6770.52606317553, 6781.6609169541325, 6644.534882558271, 6773.796786096425, 6775.966120169466, 6784.864302713918, 6869.656517174221, 6713.26154123046, 6725.798226053226, 6733.764318248838, 6735.696893639798, 6759.628220447824, 6858.6570671466225, 6880.346367095118, 6899.379055884994, 6927.480438967098, 6930.3762661359715, 5287.788488460418, 5291.735413229323, 5351.946480535223, 5359.196120581944, 5362.008028514737, 4595.655325850575, 4628.467726211461, 4629.074185162981, 4649.744264065509, 4661.067786442657, 5705.22979397776, 5790.42095790426, 5793.275840519935, 5860.120981852756, 5866.472017518444, 6826.556273842284, 6828.829279267959, 6904.654767261617, 6914.997325387791, 6939.410150137194, 5752.798652047159, 5873.9412605873395, 5880.941190588125, 5886.558508111909, 5887.941120588825, 5686.09022556389, 5842.824715258549, 5847.912281315784, 5895.675737834375, 5914.9112763308585, 6472.417482426604, 6517.902231466532, 6551.017347397833, 6575.178102737158, 6601.2738598754095, 6845.247022827485, 6857.897131543131, 6861.588304701734, 6875.862482750417, 6900.137482814648, 6521.184851893513, 6525.119108920235, 6526.771562995273, 6624.403803657501, 6642.070110184482, 6652.866942661217, 6667.333266673294, 6678.198616165897, 6769.864602708017, 6771.830704232433, 6869.0383346330555, 6917.688704008432, 6921.584704917721, 6930.341617546325, 6938.0, 6591.077249185214, 6595.340465953558, 6674.365935236145, 6692.631905245258, 6695.866082678222, 6595.0, 6600.504962127764, 6657.667116644246, 6685.966570167118, 6686.966565167143, 6420.775272865428, 6499.415052645285, 6500.057491663588, 6523.771667991788, 6599.307072757291, 6621.735130594915, 6698.698558564779, 6731.46148308144, 6732.091167692299, 6798.93201067983, 6305.842353941188, 6406.071119687526, 6478.352164783484, 6498.675066246574, 6520.739170433129], "value": 6165.602132577957, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.4326971120217, 837.9832403351929, 877.793718476158, 896.2650626486284, 898.2993265253101, 39578.80210598947, 40363.0, 40416.59583404165, 40544.0, 40563.18873622526, 36386.45420318697, 36750.26499470009, 36791.4481282781, 36825.26349473009, 36836.63163368365, 7074.929250707504, 7144.964275178617, 7146.606936618484, 7168.498205125643, 7178.928210717878, 7094.11323584552, 7161.0, 7161.06906102206, 7181.174164971017, 7189.640517974107, 7845.921540784576, 8024.478408903432, 8027.197280271985, 8028.518288902685, 8028.9598552007155, 7869.173736757644, 7897.0, 7977.4016948728495, 7982.521048737065, 7992.480488768211, 7568.924310756932, 7583.658735356867, 7723.111842138113, 7724.188960159158, 7727.613619319068, 36642.81678591617, 36678.0, 36798.0, 36920.63079369199, 36933.0, 3556.0, 3604.4773507841214, 3606.2607165531003, 3609.5848977367677, 3615.5480564929385, 30072.69927300721, 30154.84922575395, 30220.84889575538, 30317.848410757804, 30423.847880760455, 5173.922391164136, 5202.453742357074, 5224.791008359661, 5236.947630523684, 5240.266362709223, 184999.0, 189514.05242973834, 189656.0, 191926.0, 198469.0, 46477.535224647996, 46766.5323346769, 46783.76608116938, 46824.06351872943, 46876.7656161717, 48052.0, 48557.0, 48654.51345486571, 48728.75635621799, 48753.0, 14428.350724217225, 14557.563273101823, 14562.199079050753, 14590.0, 14607.488737894335, 11936.880631193751, 11956.880431195577, 11995.700107497383, 12017.459214335377, 12082.939585302018, 13101.148425352321, 13202.339883006003, 13271.469141234436, 13355.799663005062, 13380.330983450789, 5181.611379146504, 5291.656042357235, 5314.8937021260135, 5383.865403364869, 5459.2902922619805, 986.7335819328741, 993.7962717643011, 1004.2016596805557, 1007.5566750629846, 1012.6202673997251, 22611.208607698652, 22683.092676293094, 22683.432914177276, 22815.201467948544, 23124.537509250058, 1090.3294473898495, 1101.6970333158285, 1109.9778004440027, 1111.0778054214982, 1112.783007313566, 11857.762844743056, 11981.580644677395, 11983.400829958468, 12157.635270941886, 12174.878251217375, 226017.0, 226436.0, 227721.0, 227916.0, 228270.0, 50759.23861142086, 51101.0, 51396.48603513917, 51629.22556161661, 51817.0, 1429.1425144913178, 1470.073853472327, 1471.315838135251, 1479.8298195707416, 1488.7543555313252, 22253.77746222582, 22302.10791568319, 22573.774262257168, 22813.429664257863, 22904.198353057564, 35854.10364740902, 35965.460518092776, 35967.0, 36014.0, 36020.819895901404, 191229.0, 192303.0, 192909.0, 193013.0, 193130.0, 31289.84355078301, 34762.478562822085, 35591.28817423689, 35596.82201588975, 35633.28733425369, 44312.55687443084, 44452.55547444484, 44666.3300050506, 44737.0, 44858.327125092495, 32041.359172815948, 32779.67220327766, 32790.180245494055, 32791.344173115926, 33172.33655326832, 32469.35061298808, 32553.674463255065, 32587.34825303528, 32622.34755304833, 32722.50916236211, 34945.47581786326, 36451.635483645885, 36717.44923826198, 36721.08197295089, 37215.813920930224, 31480.527792083594, 32018.839905800323, 32080.03759887207, 32261.838690806395, 32642.51036234411, 22961.770382295963, 23852.761472385748, 24004.63993040071, 24381.0, 24792.87603562043], "value": 16814.686492605335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9710514474281, 583.3087790967703, 599.3766482857825, 607.3107023528296, 614.6742226619891, 20753.688694669592, 21623.567528649437, 21665.783342166575, 21679.566408671817, 21686.3494095177, 23526.058957641715, 23823.5235295294, 25173.74826251737, 25364.619530707056, 25373.365665858317, 6409.487241020719, 6588.703508342136, 6597.67011649418, 6600.042993765901, 6601.3728695773825, 6493.675316234193, 6509.739610415601, 6582.670866456682, 6595.307492713244, 6819.659017049153, 7104.502684812065, 7111.893321600181, 7115.359617634412, 7116.110486189226, 7146.964265178667, 7151.678174482135, 7159.534630249017, 7163.391111755507, 7164.283571642794, 7167.0, 6772.390484856337, 6958.130233720785, 6958.408535274508, 7087.964560177218, 7091.858162836766, 30825.84587077073, 31499.0, 31596.210094747814, 31637.52543711846, 31660.683393166004, 2061.072517367191, 2088.7075809386697, 2090.5400811821373, 2090.9477263068393, 2094.476380904774, 19956.401307960783, 20822.375328740163, 21279.468013299793, 21653.67519487209, 21799.346019619436, 2507.2102287779476, 2530.582453895105, 2549.859757713325, 2576.2528866628654, 2625.146827281141, 130152.0, 136183.0, 143653.0, 150562.0, 150845.0, 20763.79236207649, 20936.267230646856, 22246.666300005512, 22475.0, 22877.771222287563, 44788.0, 44813.77593112014, 44953.0, 45036.0, 45101.0, 11952.64142075739, 12035.157538972364, 12088.456019479145, 12148.69628259283, 12256.632301030982, 9925.702228933143, 9950.154236889946, 10010.099091081838, 10029.097381235724, 10053.849192262122, 11269.436528173559, 11485.196036277548, 11542.422878856023, 11672.83271672843, 12201.35281736972, 4108.0, 4170.519465589672, 4263.289065582549, 4590.334401511762, 4732.025098916926, 922.8892532895961, 959.9280053995839, 961.5576834655997, 964.0407794244771, 968.4770224079059, 19091.522711932314, 19683.507912302306, 19718.295779435062, 19807.44422805845, 20182.09180586877, 1021.8569400283966, 1028.598846449885, 1030.8917563655857, 1041.9635312764017, 1043.6295115234134, 10581.36511809294, 10850.67447976562, 10926.562937482411, 10936.234463587472, 10979.396133212591, 465661.0, 468370.0, 479484.0, 480903.0, 487798.0, 111222.44388778004, 112980.0, 114807.0, 115377.0, 115497.4225128869, 1032.1381646325403, 1051.395447617623, 1151.3897634253858, 1165.959191428296, 1184.7452797648548, 20663.17347306151, 20671.79328206699, 20777.896110519956, 20806.063727132012, 20905.0, 58036.709816450646, 58480.70759646175, 59496.70251648714, 59850.0, 60449.093263601964, 72659.0, 72664.63667681628, 72898.0, 73728.63135684287, 73745.0, 19677.704834427208, 20235.79764202398, 20237.69643455379, 20285.98570071461, 20416.79583204149, 22898.084076637413, 23012.07951681914, 23158.884205578863, 23214.0, 23361.766382335958, 18332.358367457076, 18375.54061148482, 18420.263189472807, 18530.258789648804, 18695.0, 16292.348306067624, 16541.421050263183, 16915.492535223962, 17221.913890430467, 17516.211770470614, 17692.203850826485, 18526.722099168794, 18632.0, 18871.15079821384, 18942.715859261847, 19926.800731992495, 19929.0, 19970.101345439198, 19999.700004499653, 20046.0, 15975.20123993819, 16152.838471615134, 16153.111578863276, 17850.732239016164, 18502.629947400706], "value": 13076.794801972494, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.3048553780957, 1392.6866455047611, 1395.4139261510165, 1404.255744455439, 1404.564584978656, 15655.982361146533, 16191.271392787323, 16198.75701864473, 16222.756658650129, 16231.107289099094, 15811.525654230363, 15942.282597283122, 16042.278097485612, 16058.59853503663, 16071.437499687514, 2816.830990140588, 2851.8431486268246, 2878.5394336906097, 2883.8558072096416, 2884.7259510346485, 2750.2574304937657, 2782.220978126128, 2792.497350476913, 2792.5531914893622, 2795.496810574096, 2747.120921305183, 2795.888164473429, 2892.4070565534016, 2893.8408387538675, 2895.1314605618336, 2758.820676656011, 2810.6486689163853, 2819.4502072095847, 2833.7874659400522, 2841.2328671258642, 2506.260653107338, 2634.4204275059456, 2745.574435962429, 2748.8900443982216, 2758.4207316463567, 15339.616509587238, 15396.153211573359, 15491.457798977095, 15553.922230388776, 15574.299156537869, 8006.399520035962, 8371.95814020926, 8372.785946037851, 8375.916240837574, 8385.496870187748, 5255.842324730264, 5261.158214685632, 5386.326709161355, 5392.245085688007, 5450.264214331054, 1994.4515258303938, 1996.422825967484, 2003.4991252186953, 2012.3359291433792, 2032.1972820735728, 27152.321191970357, 27548.586771198246, 27577.03480378197, 27614.171574852786, 27615.44769104627, 6763.93236067633, 6778.8644227116165, 6833.624150671761, 6956.756513522002, 7017.403520700797, 17843.643127137646, 17856.46430607084, 17878.91060544689, 17887.821121788875, 17902.373416930346, 8071.636776345079, 8217.34261259098, 8217.753467395987, 8219.383546234056, 8221.095679475253, 7252.601106939063, 7379.852402951911, 7395.81510462232, 7473.028506294147, 7516.962415187889, 5348.598855085884, 5388.838334849961, 5442.401335853053, 5506.201600767947, 5507.807226747044, 1585.0727324515058, 1591.3793620488018, 1597.5926138834523, 1614.4026710117332, 1626.5608285763014, 884.9026607073217, 905.2215095018279, 906.5195446413411, 929.2658799548282, 934.2946075712794, 7715.691372345155, 7755.650995705207, 7756.728514501965, 7806.843863122705, 7843.490173138728, 722.7217521254249, 724.344468256229, 725.2493669052506, 738.0405472885335, 744.757953665061, 4938.358013458227, 5353.946460535345, 5468.945310546844, 5572.136318870582, 5607.579431542651, 21861.67207491889, 22368.105275788785, 22463.663045054338, 22495.32514024582, 22816.20143294977, 21296.78703212948, 22097.55804883893, 22130.893455327492, 22236.55526889453, 22270.777292227194, 11250.718732031764, 11854.94072529649, 11883.643490695293, 11889.821652675217, 11902.226355286879, 8810.251128654136, 9161.35870489086, 9175.908240917506, 9208.539573021457, 9314.767130821783, 18757.531061723566, 18879.6224075515, 19307.613847722685, 19631.214751410356, 19873.50316242048, 19987.400377988684, 20078.89960550188, 20139.0, 20208.0, 20346.694799577723, 12433.191842530206, 12583.685407864876, 12596.811047834473, 12692.36538173106, 12771.93614031924, 14332.283385830458, 14403.78394324107, 14407.78388324197, 14444.494442694455, 14467.204303762974, 11554.48004839801, 11652.53389864396, 11856.70358241051, 11879.465424055765, 12065.457054432396, 11193.888061119285, 11374.54501819918, 11546.13403994687, 11569.6529104127, 11791.646250612495, 9474.431534107976, 9606.0, 9621.663241786784, 9623.133917947418, 9625.470599116836, 7165.104361954755, 7288.187063467819, 7301.160366557701, 7301.4158867289425, 7359.190489046094, 7744.65149068282, 7775.0, 7813.218678132142, 7874.21257874208, 7913.327367173854], "value": 6840.824712658467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.8552838449071, 504.122826282269, 509.67890229155637, 515.6567142593543, 538.6875612144956, 6192.2569291685, 6217.813465596028, 6230.158928544645, 6327.49380049596, 6357.936420635792, 6086.587224262407, 6166.3525329840395, 6207.28616209135, 6239.906401403971, 6252.34350393209, 5142.228665700138, 5145.81989630363, 5153.69077855328, 5187.325647665798, 5189.455107213745, 4877.731789734659, 5089.567386772129, 5136.666116702421, 5196.870078248036, 5199.168133098705, 4945.455999840015, 4952.801887924478, 4953.554180123788, 4979.327790748257, 5029.748512574375, 4966.304717339575, 4976.4774698656665, 5015.473375295596, 5016.849494515171, 5021.9748901255625, 4415.403920470728, 4486.932696009562, 4518.638508919312, 4523.660725445605, 4536.8865778355475, 6106.328303886569, 6122.204113465265, 6127.172831667757, 6142.011538749728, 6168.506519478476, 5658.179563963244, 5731.770729170828, 5766.356588372336, 5769.1923130761725, 5791.5656325775735, 6492.610443373413, 6501.707423165922, 6563.638999855054, 6576.506761992822, 6589.868202635968, 4677.976610116962, 4919.163742163805, 4928.975355123237, 4930.482299358551, 4974.751262436864, 6706.83232919176, 6812.863742725167, 6817.625030623314, 6878.828029299258, 6881.965590172017, 4995.450500444948, 5014.874628134326, 5024.145895197825, 5034.924476132861, 5057.570106540985, 5090.821821236313, 5100.132977393852, 5102.668326558762, 5118.413291879529, 5120.155174396257, 5653.766762128936, 5681.971590142023, 5684.54523638108, 5689.0, 5704.743286552115, 6602.7028783704845, 6626.56927299724, 6628.767993120217, 6634.701438435282, 6645.405102775396, 1748.5104170832187, 1751.098184435017, 1760.4278609451978, 1769.177332540375, 1787.9821201787815, 1186.5431808753692, 1200.0, 1223.3516236394726, 1227.6623928419579, 1259.987400125987, 5630.408807075198, 5662.405447427961, 5682.829515114553, 5691.0, 5706.914396284059, 6672.566283191577, 6686.665666716742, 6740.865182696319, 6751.932480675228, 6789.762358317435, 5494.5054945055135, 5512.724363781795, 5565.220869078333, 5597.768490931989, 5636.408177141423, 3488.424409972326, 3491.94762078569, 3519.208178159945, 3524.8942531724088, 3536.4872093546805, 6444.2266927968, 6483.805485835433, 6517.771877984248, 6528.910748560415, 6536.215654121535, 6457.870842583122, 6745.325467453215, 6767.729290828312, 6850.349216824394, 6882.5870447772295, 6423.164988551458, 6437.2918978912285, 6440.355964403616, 6464.418202361904, 6468.208381199722, 6611.768588099393, 6661.533692641662, 6680.231773346128, 6692.564983276072, 6695.866082678416, 6628.674265146893, 6640.933590664032, 6649.135612370361, 6667.666616669244, 6708.228553716385, 6402.91905130825, 6445.452136568257, 6468.8059358219325, 6481.837954051187, 6511.479081673549, 4941.629377796751, 4962.652614317108, 4970.602351811919, 4974.850754477371, 5001.224810154432, 6357.300696923242, 6447.580907241015, 6589.868202636017, 6677.165354330708, 6730.8653826924165, 6420.133282006869, 6465.090709180981, 6476.31998640136, 6480.189976252968, 6501.44737697301, 6363.7772677956045, 6395.232572091379, 6402.871942561216, 6492.415682588589, 6494.740210391531, 6331.783875643488, 6379.298277189413, 6382.393672601095, 6406.263279722705, 6447.161868957006, 6485.805425837232, 6512.381323774234, 6541.378569035934, 6560.901586476111, 6606.504512161511, 6320.841978950563, 6325.936740632535, 6335.588186767845, 6350.174477317919, 6415.486761059011], "value": 5046.199939033664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.330906783514, 914.3096961793844, 917.92656587473, 934.8457504511754, 936.4989730494183, 19509.317173898915, 20336.38990830274, 20341.28805491808, 20394.89802550989, 20441.488962775937, 17479.563010924703, 17660.558486037822, 17707.29170833165, 17708.468745937644, 17734.02462864542, 964.9035096490347, 982.6904525074615, 982.9803403931917, 986.7039888033597, 987.377951890308, 975.8926518083006, 979.6277414582448, 980.3137803537517, 981.5730157381527, 982.79852630211, 1004.1264100232771, 1026.635544381745, 1044.3838135500052, 1049.1868801678684, 1049.9947500262488, 1024.0271741845202, 1035.6012935019996, 1038.3354653022072, 1042.3016578892161, 1042.5412818359935, 716.358858821352, 740.1155619035255, 747.0997448075111, 750.7785203365021, 759.4152502572988, 19932.70100948487, 20010.79989200104, 20011.59976800456, 20040.69938950917, 20041.498962525908, 20172.29396971099, 20484.69272960907, 20513.282035128697, 20624.793752062436, 20758.79241207599, 16180.271887765079, 16603.584910377216, 16762.497125086265, 16883.746743798853, 17018.659626807395, 3726.254749050174, 3736.813159342022, 3745.232227393378, 3747.700183985302, 3761.0597350662333, 104951.4752426233, 130782.0, 132970.33514832365, 133433.0, 135949.0, 17854.732179017326, 18329.7250541242, 18373.7243941341, 18411.171497282387, 18447.354342597944, 31295.53056704151, 32541.51187732186, 32665.346693066007, 32726.0, 32879.178020549196, 9065.320100992452, 9151.359404841598, 9281.39670921388, 9296.163345298955, 9302.581383837743, 4168.645665118438, 4211.115665710174, 4232.915341693149, 4249.383839343278, 4250.53244143144, 5486.0, 5579.553635709133, 5588.21764952907, 5615.606907516435, 5634.577406694432, 995.4674249276602, 1022.9232807539315, 1037.3101887245048, 1040.105509262034, 1046.5081411736471, 694.5034300475185, 702.9332213439715, 716.5378330976491, 717.4073556704109, 740.9222031686595, 12042.518299267931, 12075.879241207651, 12534.561290354794, 12741.044421668226, 12779.0, 693.6670398208787, 703.7536862098225, 703.9366457018892, 718.7304760714732, 722.7831650504828, 5696.458836410535, 5804.593678442468, 5818.156367326798, 5831.9708401458565, 5874.412558744091, 123877.0, 125743.37128314484, 126325.0, 127058.0, 130357.0, 104965.47517262517, 110796.44601777101, 110839.44580277047, 114536.0, 114725.0, 89982.55008725045, 91581.08418915859, 92712.53643731738, 93814.0618593819, 94752.0, 10729.624463143753, 10753.139748820233, 10826.0, 10945.01494865466, 11030.393328367018, 42927.0, 45055.54944450645, 45489.317660235785, 45674.77162614166, 46076.0, 55841.0, 55871.0, 56157.43842561522, 57264.0, 57444.71277643585, 15970.28133734008, 16472.341106355612, 16504.75242871382, 16527.925684830447, 16593.751093733845, 17947.0, 18022.098895055457, 18266.0, 18399.81600183981, 18416.263349466408, 15593.922030389775, 15675.764863526829, 15728.92135539315, 15943.282552285407, 15987.280572374038, 14468.493602723855, 14657.780133297796, 14686.63283417923, 14712.779308310597, 14861.851381486047, 14369.497067602584, 14481.348339324544, 14538.273086345429, 14603.634909127357, 14608.196549189897, 12414.565490207799, 12444.440000199831, 12466.5013399463, 12604.810927835906, 12639.936800316307, 11862.940685296518, 11982.520699172284, 12146.514139434325, 12271.386430678253, 12409.813852792397], "value": 8995.791184950791, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1419.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 108.0, 107.0, 107.0, 107.0, 101.0, 108.0, 108.0, 107.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 115.0, 115.0, 117.0, 120.0, 128.0, 118.0, 117.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 165.0, 165.0, 162.0, 164.0, 162.0, 169.0, 169.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 80.0, 74.0, 73.0, 74.0, 78.0, 74.0, 74.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 80.0, 79.0, 78.0, 78.0, 79.0, 79.0, 81.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 111.0, 110.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 148.0, 157.0, 148.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 96.0, 95.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 53.0, 54.0, 54.0, 53.0, 55.0, 55.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 39.0, 39.0, 39.0, 39.0, 38.0, 39.0, 40.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 75.0, 73.0, 73.0, 75.0, 72.0, 74.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 110.0, 113.0, 114.0, 112.0, 115.0, 113.0, 124.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 166.0, 174.0, 182.0, 170.0, 173.0, 166.0, 170.0, 168.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 78.0, 65.0, 67.0, 64.0, 65.0, 66.0, 68.0], "value": 66.7, "unit": "score"}]}]} 11:51:52 INFO - Return code: 0 11:51:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:51:52 INFO - # TBPL SUCCESS # 11:51:52 INFO - Running post-action listener: _package_coverage_data 11:51:52 INFO - Running post-action listener: _resource_record_post_action 11:51:52 INFO - [mozharness: 2017-09-26 18:51:52.124014Z] Finished run-tests step (success) 11:51:52 INFO - Running post-run listener: _resource_record_post_run 11:51:52 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 342986752; Read time: 44; Write time: 240900 11:51:52 INFO - TinderboxPrint: CPU usage
13.1% 11:51:52 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 44 11:51:52 INFO - TinderboxPrint: I/O write bytes / time
342,986,752 / 240,900 11:51:52 INFO - TinderboxPrint: CPU idle
8,229.4 (86.9%) 11:51:52 INFO - TinderboxPrint: CPU user
1,193.4 (12.6%) 11:51:52 INFO - TinderboxPrint: Swap in / out
0 / 0 11:51:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 2760704; Read time: 0; Write time: 124 11:51:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:51:52 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 329728000; Read time: 24; Write time: 238240 11:51:52 INFO - Running post-run listener: _upload_blobber_files 11:51:52 INFO - Blob upload gear active. 11:51:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:52 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 11:51:52 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'] 11:51:52 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 11:51:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:00 INFO - (blobuploader) - INFO - Done attempting. 11:52:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:52:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:01 INFO - (blobuploader) - INFO - Done attempting. 11:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:02 INFO - (blobuploader) - INFO - Done attempting. 11:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:52:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:03 INFO - (blobuploader) - INFO - Done attempting. 11:52:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:03 INFO - Return code: 0 11:52:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63e470910ea407641fd8daa5a3b44d4179ac98a7fc808d4f227d289d80a05b959fc6c76f19e442b8eaab6ab8868eb3d865cf8baa498d3483cf5d9d9173dfc6db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588dec0294b14af470f26b439da5b4d9fc10833a482f6b409715656b24f910b311fb21875bcef15afaf6cb2cf2a93eef8edaa181e6ea8bbab7531b09b130182c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352c7a1e1faa8d6eff0497512cb3a040d1e68b724f9592102e0b245c431cee2334ef572fd312955e94c35fe5dacf256449d5a01b7aa36cad73d1c1e0782a30fc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fefe389184513f1d34ad4406b6762d2990d74d81df39faca6f3371d2f36bfb9e4c4bd539cb5d723f0020f707b3d7cad6234d5d7960451ffe0aa9c05d607bb634"} 11:52:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:03 INFO - Contents: 11:52:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63e470910ea407641fd8daa5a3b44d4179ac98a7fc808d4f227d289d80a05b959fc6c76f19e442b8eaab6ab8868eb3d865cf8baa498d3483cf5d9d9173dfc6db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588dec0294b14af470f26b439da5b4d9fc10833a482f6b409715656b24f910b311fb21875bcef15afaf6cb2cf2a93eef8edaa181e6ea8bbab7531b09b130182c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352c7a1e1faa8d6eff0497512cb3a040d1e68b724f9592102e0b245c431cee2334ef572fd312955e94c35fe5dacf256449d5a01b7aa36cad73d1c1e0782a30fc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fefe389184513f1d34ad4406b6762d2990d74d81df39faca6f3371d2f36bfb9e4c4bd539cb5d723f0020f707b3d7cad6234d5d7960451ffe0aa9c05d607bb634"} 11:52:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:03 INFO - Copying logs to upload dir... 11:52:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.259066 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 11:52:03.922530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:03.926015) ========= 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=db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847 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/63e470910ea407641fd8daa5a3b44d4179ac98a7fc808d4f227d289d80a05b959fc6c76f19e442b8eaab6ab8868eb3d865cf8baa498d3483cf5d9d9173dfc6db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588dec0294b14af470f26b439da5b4d9fc10833a482f6b409715656b24f910b311fb21875bcef15afaf6cb2cf2a93eef8edaa181e6ea8bbab7531b09b130182c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352c7a1e1faa8d6eff0497512cb3a040d1e68b724f9592102e0b245c431cee2334ef572fd312955e94c35fe5dacf256449d5a01b7aa36cad73d1c1e0782a30fc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fefe389184513f1d34ad4406b6762d2990d74d81df39faca6f3371d2f36bfb9e4c4bd539cb5d723f0020f707b3d7cad6234d5d7960451ffe0aa9c05d607bb634"} build_url:https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/OiaXjfiURii_c_az-GohGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63e470910ea407641fd8daa5a3b44d4179ac98a7fc808d4f227d289d80a05b959fc6c76f19e442b8eaab6ab8868eb3d865cf8baa498d3483cf5d9d9173dfc6db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588dec0294b14af470f26b439da5b4d9fc10833a482f6b409715656b24f910b311fb21875bcef15afaf6cb2cf2a93eef8edaa181e6ea8bbab7531b09b130182c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/352c7a1e1faa8d6eff0497512cb3a040d1e68b724f9592102e0b245c431cee2334ef572fd312955e94c35fe5dacf256449d5a01b7aa36cad73d1c1e0782a30fc", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fefe389184513f1d34ad4406b6762d2990d74d81df39faca6f3371d2f36bfb9e4c4bd539cb5d723f0020f707b3d7cad6234d5d7960451ffe0aa9c05d607bb634"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:03.954720) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:03.955052) ========= 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=db0483c52d987ecb441a263b000001ad-1506450682.953831-1617708847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 11:52:04.039104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 11:52:04.039429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 11:52:04.039792) ========= ========= Total master_lag: 0.21 =========