builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-079 starttime: 1506106650.42 results: success (0) revision: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.424443) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.424989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.425286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.445789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.446208) ========= 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=1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 11:57:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.7M=0s 2017-09-22 11:57:30 (28.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.541044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.541397) ========= 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=1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.591815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:30.592179) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 --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 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 --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=1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 11:57:30,641 truncating revision to first 12 chars 2017-09-22 11:57:30,641 Setting DEBUG logging. 2017-09-22 11:57:30,641 attempt 1/10 2017-09-22 11:57:30,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/14db7c0bcf9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 11:57:30,884 unpacking tar archive at: mozilla-central-14db7c0bcf9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:31.156042) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:31.156374) ========= script_repo_revision: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:31.156938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:31.157212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 11:57:31.171885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-22 11:57:31.172301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:57:31 INFO - MultiFileLogger online at 20170922 11:57:31 in /builds/slave/test 11:57:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:57:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:31 INFO - {'append_to_log': False, 11:57:31 INFO - 'base_work_dir': '/builds/slave/test', 11:57:31 INFO - 'blob_upload_branch': 'Firefox', 11:57:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:31 INFO - 'branch': 'Firefox', 11:57:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:31 INFO - 'code_coverage': False, 11:57:31 INFO - 'config_files': ('talos/linux_config.py',), 11:57:31 INFO - 'default_actions': ('clobber', 11:57:31 INFO - 'read-buildbot-config', 11:57:31 INFO - 'download-and-extract', 11:57:31 INFO - 'populate-webroot', 11:57:31 INFO - 'create-virtualenv', 11:57:31 INFO - 'install', 11:57:31 INFO - 'setup-mitmproxy', 11:57:31 INFO - 'run-tests'), 11:57:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:31 INFO - 'disable_ccov_upload': False, 11:57:31 INFO - 'disable_stylo': False, 11:57:31 INFO - 'download_minidump_stackwalk': True, 11:57:31 INFO - 'download_symbols': 'ondemand', 11:57:31 INFO - 'enable_stylo': False, 11:57:31 INFO - 'enable_webrender': False, 11:57:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:57:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:31 INFO - 'gecko_profile': False, 11:57:31 INFO - 'gecko_profile_interval': 0, 11:57:31 INFO - 'installer_path': 'installer.exe', 11:57:31 INFO - 'log_level': 'info', 11:57:31 INFO - 'log_name': 'talos', 11:57:31 INFO - 'log_to_console': True, 11:57:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:57:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:57:31 INFO - 'opt_config_files': (), 11:57:31 INFO - 'pip_index': False, 11:57:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:57:31 INFO - 'system_bits': '32', 11:57:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:31 INFO - 'title': 'talos-linux64-ix-079', 11:57:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:31 INFO - 'use_talos_json': True, 11:57:31 INFO - 'verify': 'False', 11:57:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:31 INFO - 'work_dir': 'build'} 11:57:31 INFO - [mozharness: 2017-09-22 18:57:31.362746Z] Running clobber step. 11:57:31 INFO - Running pre-action listener: _resource_record_pre_action 11:57:31 INFO - Running main action method: clobber 11:57:31 INFO - rmtree: /builds/slave/test/build 11:57:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:32 INFO - Running post-action listener: _resource_record_post_action 11:57:32 INFO - [mozharness: 2017-09-22 18:57:32.344076Z] Finished clobber step (success) 11:57:32 INFO - [mozharness: 2017-09-22 18:57:32.344174Z] Running read-buildbot-config step. 11:57:32 INFO - Running pre-action listener: _resource_record_pre_action 11:57:32 INFO - Running main action method: read_buildbot_config 11:57:32 INFO - Using buildbot properties: 11:57:32 INFO - { 11:57:32 INFO - "project": "", 11:57:32 INFO - "product": "firefox", 11:57:32 INFO - "who": "ffxbld@noreply.mozilla.org", 11:57:32 INFO - "installer_path": "public/build/target.tar.bz2", 11:57:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:57:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:57:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:57:32 INFO - "stage_platform": "linux64-pgo", 11:57:32 INFO - "basedir": "/builds/slave/test", 11:57:32 INFO - "buildnumber": 34, 11:57:32 INFO - "platform": "ubuntu64_hw", 11:57:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:57:32 INFO - "slavebuilddir": "test", 11:57:32 INFO - "taskId": "Xf8U-5nCQPGBCaVTXZCnrA", 11:57:32 INFO - "branch": "mozilla-central", 11:57:32 INFO - "script_repo_revision": "production", 11:57:32 INFO - "revision": "14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9", 11:57:32 INFO - "slavename": "talos-linux64-ix-079", 11:57:32 INFO - "repo_path": "mozilla-central" 11:57:32 INFO - } 11:57:32 INFO - Finding installer, test and symbols from parent task. 11:57:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xf8U-5nCQPGBCaVTXZCnrA'}, attempt #1 11:57:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xf8U-5nCQPGBCaVTXZCnrA'}, attempt #1 11:57:33 INFO - Task dependencies: eHaD7yk7Raabj2tPqEg75A 11:57:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A'}, attempt #1 11:57:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json 11:57:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip 11:57:33 INFO - Running post-action listener: _resource_record_post_action 11:57:33 INFO - [mozharness: 2017-09-22 18:57:33.737641Z] Finished read-buildbot-config step (success) 11:57:33 INFO - [mozharness: 2017-09-22 18:57:33.737857Z] Running download-and-extract step. 11:57:33 INFO - Running pre-action listener: _resource_record_pre_action 11:57:33 INFO - Running main action method: download_and_extract 11:57:33 INFO - mkdir: /builds/slave/test/build/tests 11:57:33 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:57:33 INFO - trying https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json 11:57:33 INFO - Downloading https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:57:34 INFO - Downloaded 989 bytes. 11:57:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:57:34 INFO - Using the following test package requirements: 11:57:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:57:34 INFO - u'common': [u'target.common.tests.zip'], 11:57:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:57:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:57:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:57:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:57:34 INFO - u'mozbase': [u'target.common.tests.zip'], 11:57:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:57:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:57:34 INFO - u'web-platform': [u'target.common.tests.zip', 11:57:34 INFO - u'target.web-platform.tests.tar.gz'], 11:57:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:57:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.common.tests.zip 11:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.common.tests.zip into memory 11:57:35 INFO - Content-Length response header: 55280041 11:57:35 INFO - Bytes received: 55280041 11:57:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.talos.tests.zip 11:57:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:57:46 INFO - Fetch https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.talos.tests.zip into memory 11:57:47 INFO - Content-Length response header: 14513414 11:57:47 INFO - Bytes received: 14513414 11:57: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:57:47 INFO - trying https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:47 INFO - Downloading https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:57:48 INFO - Downloaded 62319854 bytes. 11:57:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:48 INFO - mkdir: /builds/slave/test/properties 11:57:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:48 INFO - Contents: 11:57:48 INFO - build_url:https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 11:57:48 INFO - Running post-action listener: _resource_record_post_action 11:57:48 INFO - Running post-action listener: find_tests_for_verification 11:57:48 INFO - Running post-action listener: set_extra_try_arguments 11:57:48 INFO - [mozharness: 2017-09-22 18:57:48.623650Z] Finished download-and-extract step (success) 11:57:48 INFO - [mozharness: 2017-09-22 18:57:48.623747Z] Running populate-webroot step. 11:57:48 INFO - Running pre-action listener: _resource_record_pre_action 11:57:48 INFO - Running main action method: populate_webroot 11:57:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tresize', 11:57:48 INFO - 'tcanvasmark']}, 11:57:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['dromaeo_css', 11:57:48 INFO - 'kraken']}, 11:57:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'tests': ['damp', 'tps']}, 11:57:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['damp', 'tps']}, 11:57:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['dromaeo_dom']}, 11:57:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:57:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['basic_compositor_video', 11:57:48 INFO - 'glvideo']}, 11:57:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:57:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['ts_paint_webext', 11:57:48 INFO - 'tp5o_webext']}, 11:57:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:48 INFO - 'ts_paint', 11:57:48 INFO - 'tpaint', 11:57:48 INFO - 'sessionrestore', 11:57:48 INFO - 'sessionrestore_many_windows', 11:57:48 INFO - 'sessionrestore_no_auto_restore', 11:57:48 INFO - 'tabpaint']}, 11:57:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['a11yr', 11:57:48 INFO - 'ts_paint', 11:57:48 INFO - 'tpaint', 11:57:48 INFO - 'sessionrestore', 11:57:48 INFO - 'sessionrestore_many_windows', 11:57:48 INFO - 'sessionrestore_no_auto_restore', 11:57:48 INFO - 'tabpaint']}, 11:57:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:57:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:57:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:57:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['perf_reftest']}, 11:57:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:48 INFO - 'tsvgr_opacity', 11:57:48 INFO - 'tart', 11:57:48 INFO - 'tscrollx', 11:57:48 INFO - 'tsvg_static']}, 11:57:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tsvgx', 11:57:48 INFO - 'tsvgr_opacity', 11:57:48 INFO - 'tart', 11:57:48 INFO - 'tscrollx', 11:57:48 INFO - 'tsvg_static']}, 11:57:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:57:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo'], 11:57:48 INFO - 'tests': ['tp5o']}, 11:57:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:48 INFO - 'talos_options': ['--mitmproxy', 11:57:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:48 INFO - '--firstNonBlankPaint'], 11:57:48 INFO - 'tests': ['tp6_google', 11:57:48 INFO - 'tp6_youtube', 11:57:48 INFO - 'tp6_amazon', 11:57:48 INFO - 'tp6_facebook']}, 11:57:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo', 11:57:48 INFO - '--mitmproxy', 11:57:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:48 INFO - '--firstNonBlankPaint'], 11:57:48 INFO - 'tests': ['tp6_google', 11:57:48 INFO - 'tp6_youtube', 11:57:48 INFO - 'tp6_amazon', 11:57:48 INFO - 'tp6_facebook']}, 11:57:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:57:48 INFO - 'talos_options': ['--stylo-threads=1', 11:57:48 INFO - '--mitmproxy', 11:57:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:57:48 INFO - '--firstNonBlankPaint'], 11:57:48 INFO - 'tests': ['tp6_google', 11:57:48 INFO - 'tp6_youtube', 11:57:48 INFO - 'tp6_amazon', 11:57:48 INFO - 'tp6_facebook']}, 11:57:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--xperf_path', 11:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:48 INFO - 'tests': ['tp5n']}, 11:57:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:57:48 INFO - 'talos_options': ['--disable-stylo', 11:57:48 INFO - '--xperf_path', 11:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:48 INFO - 'tests': ['tp5n']}}} 11:57:48 INFO - Running post-action listener: _resource_record_post_action 11:57:48 INFO - [mozharness: 2017-09-22 18:57:48.638609Z] Finished populate-webroot step (success) 11:57:48 INFO - [mozharness: 2017-09-22 18:57:48.638698Z] Running create-virtualenv step. 11:57:48 INFO - Running pre-action listener: _resource_record_pre_action 11:57:48 INFO - Running main action method: create_virtualenv 11:57:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:57:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:57:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:57:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:57:49 INFO - Installing pip...............done. 11:57:49 INFO - Return code: 0 11:57:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:57:49 INFO - Reading from file tmpfile_stdout 11:57:49 INFO - Output received: 11:57:49 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:57:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:57: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:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57: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:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:57: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', 'pip>=1.5'] in /builds/slave/test/build 11:57: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 pip>=1.5 11:57:49 INFO - Using env: {'DISPLAY': ':0', 11:57:49 INFO - 'HOME': '/home/cltbld', 11:57:49 INFO - 'LANG': 'en_US.UTF-8', 11:57:49 INFO - 'LANGUAGE': 'en_US:en', 11:57:49 INFO - 'LOGNAME': 'cltbld', 11:57:49 INFO - 'MAIL': '/var/mail/cltbld', 11:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:49 INFO - 'MOZ_NO_REMOTE': '1', 11:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:49 INFO - 'NO_EM_RESTART': '1', 11:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:49 INFO - 'PWD': '/builds/slave/test', 11:57:49 INFO - 'SHELL': '/bin/bash', 11:57:49 INFO - 'SHLVL': '1', 11:57:49 INFO - 'TERM': 'linux', 11:57:49 INFO - 'TMOUT': '86400', 11:57:49 INFO - 'USER': 'cltbld', 11:57:49 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:49 INFO - '_': '/tools/buildbot/bin/python'} 11:57:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:57:52 INFO - Downloading/unpacking pip>=1.5 11:57:52 INFO - Running setup.py egg_info for package pip 11:57:52 INFO - warning: no files found matching 'pip/cacert.pem' 11:57:52 INFO - warning: no files found matching '*.html' under directory 'docs' 11:57:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:57:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:57:52 INFO - Installing collected packages: pip 11:57:52 INFO - Found existing installation: pip 1.1 11:57:52 INFO - Uninstalling pip: 11:57:52 INFO - Successfully uninstalled pip 11:57:52 INFO - Running setup.py install for pip 11:57:52 INFO - warning: no files found matching 'pip/cacert.pem' 11:57:52 INFO - warning: no files found matching '*.html' under directory 'docs' 11:57:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:57:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:57:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:57:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:57:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:57:52 INFO - Successfully installed pip 11:57:52 INFO - Cleaning up... 11:57:52 INFO - Return code: 0 11:57:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:57:52 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:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:52 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:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:52 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:57:52 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:57:52 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:57:52 INFO - Using env: {'DISPLAY': ':0', 11:57:52 INFO - 'HOME': '/home/cltbld', 11:57:52 INFO - 'LANG': 'en_US.UTF-8', 11:57:52 INFO - 'LANGUAGE': 'en_US:en', 11:57:52 INFO - 'LOGNAME': 'cltbld', 11:57:52 INFO - 'MAIL': '/var/mail/cltbld', 11:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:52 INFO - 'MOZ_NO_REMOTE': '1', 11:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:52 INFO - 'NO_EM_RESTART': '1', 11:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:52 INFO - 'PWD': '/builds/slave/test', 11:57:52 INFO - 'SHELL': '/bin/bash', 11:57:52 INFO - 'SHLVL': '1', 11:57:52 INFO - 'TERM': 'linux', 11:57:52 INFO - 'TMOUT': '86400', 11:57:52 INFO - 'USER': 'cltbld', 11:57:52 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:52 INFO - '_': '/tools/buildbot/bin/python'} 11:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:52 INFO - Downloading/unpacking psutil>=3.1.1 11:57: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:57: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:57: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:57: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:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:57:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:53 INFO - Installing collected packages: psutil 11:57:53 INFO - Running setup.py install for psutil 11:57:53 INFO - building 'psutil._psutil_linux' extension 11:57:53 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:57:53 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:57:53 INFO - building 'psutil._psutil_posix' extension 11:57:53 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:57:53 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:57:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:57:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:57:54 INFO - Successfully installed psutil 11:57:54 INFO - Cleaning up... 11:57:54 INFO - Return code: 0 11:57:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:57: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:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57: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:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:54 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:57:54 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:57:54 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:57:54 INFO - Using env: {'DISPLAY': ':0', 11:57:54 INFO - 'HOME': '/home/cltbld', 11:57:54 INFO - 'LANG': 'en_US.UTF-8', 11:57:54 INFO - 'LANGUAGE': 'en_US:en', 11:57:54 INFO - 'LOGNAME': 'cltbld', 11:57:54 INFO - 'MAIL': '/var/mail/cltbld', 11:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:54 INFO - 'MOZ_NO_REMOTE': '1', 11:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:54 INFO - 'NO_EM_RESTART': '1', 11:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:54 INFO - 'PWD': '/builds/slave/test', 11:57:54 INFO - 'SHELL': '/bin/bash', 11:57:54 INFO - 'SHLVL': '1', 11:57:54 INFO - 'TERM': 'linux', 11:57:54 INFO - 'TMOUT': '86400', 11:57:54 INFO - 'USER': 'cltbld', 11:57:54 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:54 INFO - '_': '/tools/buildbot/bin/python'} 11:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:57: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:57: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:57: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:57: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:57:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:57:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:57:55 INFO - Installing collected packages: mozsystemmonitor 11:57:55 INFO - Running setup.py install for mozsystemmonitor 11:57:55 INFO - Successfully installed mozsystemmonitor 11:57:55 INFO - Cleaning up... 11:57:55 INFO - Return code: 0 11:57:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:57:55 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:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:55 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:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:55 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:57:55 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:57:55 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:57:55 INFO - Using env: {'DISPLAY': ':0', 11:57:55 INFO - 'HOME': '/home/cltbld', 11:57:55 INFO - 'LANG': 'en_US.UTF-8', 11:57:55 INFO - 'LANGUAGE': 'en_US:en', 11:57:55 INFO - 'LOGNAME': 'cltbld', 11:57:55 INFO - 'MAIL': '/var/mail/cltbld', 11:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:55 INFO - 'MOZ_NO_REMOTE': '1', 11:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:55 INFO - 'NO_EM_RESTART': '1', 11:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:55 INFO - 'PWD': '/builds/slave/test', 11:57:55 INFO - 'SHELL': '/bin/bash', 11:57:55 INFO - 'SHLVL': '1', 11:57:55 INFO - 'TERM': 'linux', 11:57:55 INFO - 'TMOUT': '86400', 11:57:55 INFO - 'USER': 'cltbld', 11:57:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:55 INFO - '_': '/tools/buildbot/bin/python'} 11:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:57:55 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:57:55 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:57:55 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:57:55 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:57:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:57:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:57:56 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:57:56 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:57:56 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:57:56 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:57:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:57:57 INFO - warning: no files found matching '*.txt' 11:57:57 INFO - no previously-included directories found matching 'build' 11:57:57 INFO - no previously-included directories found matching 'dist' 11:57:57 INFO - no previously-included directories found matching '.git*' 11:57:57 INFO - Installing collected packages: jsonschema, functools32 11:57:57 INFO - Running setup.py install for functools32 11:57:57 INFO - warning: no files found matching '*.txt' 11:57:57 INFO - no previously-included directories found matching 'build' 11:57:57 INFO - no previously-included directories found matching 'dist' 11:57:57 INFO - no previously-included directories found matching '.git*' 11:57:57 INFO - Successfully installed jsonschema functools32 11:57:57 INFO - Cleaning up... 11:57:57 INFO - Return code: 0 11:57:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:57:57 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:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:57 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:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:57 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:57:57 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:57:57 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:57:57 INFO - Using env: {'DISPLAY': ':0', 11:57:57 INFO - 'HOME': '/home/cltbld', 11:57:57 INFO - 'LANG': 'en_US.UTF-8', 11:57:57 INFO - 'LANGUAGE': 'en_US:en', 11:57:57 INFO - 'LOGNAME': 'cltbld', 11:57:57 INFO - 'MAIL': '/var/mail/cltbld', 11:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:57 INFO - 'MOZ_NO_REMOTE': '1', 11:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:57 INFO - 'NO_EM_RESTART': '1', 11:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:57 INFO - 'PWD': '/builds/slave/test', 11:57:57 INFO - 'SHELL': '/bin/bash', 11:57:57 INFO - 'SHLVL': '1', 11:57:57 INFO - 'TERM': 'linux', 11:57:57 INFO - 'TMOUT': '86400', 11:57:57 INFO - 'USER': 'cltbld', 11:57:57 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:57 INFO - '_': '/tools/buildbot/bin/python'} 11:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:57:57 INFO - Cleaning up... 11:57:57 INFO - Return code: 0 11:57:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:57:57 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:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:57 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:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:57 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:57:57 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:57:57 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:57:57 INFO - Using env: {'DISPLAY': ':0', 11:57:57 INFO - 'HOME': '/home/cltbld', 11:57:57 INFO - 'LANG': 'en_US.UTF-8', 11:57:57 INFO - 'LANGUAGE': 'en_US:en', 11:57:57 INFO - 'LOGNAME': 'cltbld', 11:57:57 INFO - 'MAIL': '/var/mail/cltbld', 11:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:57 INFO - 'MOZ_NO_REMOTE': '1', 11:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:57 INFO - 'NO_EM_RESTART': '1', 11:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:57 INFO - 'PWD': '/builds/slave/test', 11:57:57 INFO - 'SHELL': '/bin/bash', 11:57:57 INFO - 'SHLVL': '1', 11:57:57 INFO - 'TERM': 'linux', 11:57:57 INFO - 'TMOUT': '86400', 11:57:57 INFO - 'USER': 'cltbld', 11:57:57 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:57 INFO - '_': '/tools/buildbot/bin/python'} 11:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:57:57 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:57:57 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:57:57 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:57:57 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:57:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:57:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:57:58 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:57:58 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:57:58 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:57:58 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:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:57:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:57: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:57: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:57: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:57: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:57:59 INFO - Downloading docopt-0.6.1.tar.gz 11:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:57:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:57:59 INFO - Running setup.py install for blobuploader 11:57:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:57:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:57:59 INFO - Running setup.py install for requests 11:57:59 INFO - Running setup.py install for docopt 11:58:00 INFO - Successfully installed blobuploader requests docopt 11:58:00 INFO - Cleaning up... 11:58:00 INFO - Return code: 0 11:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:00 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:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:00 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:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:00 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:58:00 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:58:00 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:58:00 INFO - Using env: {'DISPLAY': ':0', 11:58:00 INFO - 'HOME': '/home/cltbld', 11:58:00 INFO - 'LANG': 'en_US.UTF-8', 11:58:00 INFO - 'LANGUAGE': 'en_US:en', 11:58:00 INFO - 'LOGNAME': 'cltbld', 11:58:00 INFO - 'MAIL': '/var/mail/cltbld', 11:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:00 INFO - 'MOZ_NO_REMOTE': '1', 11:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:00 INFO - 'NO_EM_RESTART': '1', 11:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:00 INFO - 'PWD': '/builds/slave/test', 11:58:00 INFO - 'SHELL': '/bin/bash', 11:58:00 INFO - 'SHLVL': '1', 11:58:00 INFO - 'TERM': 'linux', 11:58:00 INFO - 'TMOUT': '86400', 11:58:00 INFO - 'USER': 'cltbld', 11:58:00 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:00 INFO - '_': '/tools/buildbot/bin/python'} 11:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:00 INFO - Running setup.py (path:/tmp/pip-Qhhp83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:00 INFO - Running setup.py (path:/tmp/pip-AcISGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:00 INFO - Running setup.py (path:/tmp/pip-_md8Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:00 INFO - Running setup.py (path:/tmp/pip-08dtp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:00 INFO - Running setup.py (path:/tmp/pip-D4v6j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:00 INFO - Running setup.py (path:/tmp/pip-irvY4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:00 INFO - Running setup.py (path:/tmp/pip-rTLvxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:00 INFO - Running setup.py (path:/tmp/pip-ESBbTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:00 INFO - Running setup.py (path:/tmp/pip-K9F1hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:00 INFO - Running setup.py (path:/tmp/pip-7nnUh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:01 INFO - Running setup.py (path:/tmp/pip-wCC8Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:01 INFO - Running setup.py (path:/tmp/pip-DPIzVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:01 INFO - Running setup.py (path:/tmp/pip-Oxxua_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:01 INFO - Running setup.py (path:/tmp/pip-e5uR1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:01 INFO - Running setup.py (path:/tmp/pip-C1hSTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:01 INFO - Running setup.py (path:/tmp/pip-9bc3Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:01 INFO - Running setup.py (path:/tmp/pip-Rx87wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:01 INFO - Running setup.py install for manifestparser 11:58:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:01 INFO - Running setup.py install for mozcrash 11:58:01 INFO - Running setup.py install for mozdebug 11:58:01 INFO - Running setup.py install for mozdevice 11:58:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:01 INFO - Running setup.py install for mozfile 11:58:01 INFO - Running setup.py install for mozhttpd 11:58:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozinfo 11:58:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozInstall 11:58:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozleak 11:58:02 INFO - Running setup.py install for mozlog 11:58:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for moznetwork 11:58:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozprocess 11:58:02 INFO - Running setup.py install for mozprofile 11:58:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozrunner 11:58:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:02 INFO - Running setup.py install for mozscreenshot 11:58:03 INFO - Running setup.py install for moztest 11:58:03 INFO - Running setup.py install for mozversion 11:58:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:03 INFO - Cleaning up... 11:58:03 INFO - Return code: 0 11:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58: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:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58: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:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:03 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:58:03 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:58:03 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:58:03 INFO - Using env: {'DISPLAY': ':0', 11:58:03 INFO - 'HOME': '/home/cltbld', 11:58:03 INFO - 'LANG': 'en_US.UTF-8', 11:58:03 INFO - 'LANGUAGE': 'en_US:en', 11:58:03 INFO - 'LOGNAME': 'cltbld', 11:58:03 INFO - 'MAIL': '/var/mail/cltbld', 11:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:03 INFO - 'MOZ_NO_REMOTE': '1', 11:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:03 INFO - 'NO_EM_RESTART': '1', 11:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:03 INFO - 'PWD': '/builds/slave/test', 11:58:03 INFO - 'SHELL': '/bin/bash', 11:58:03 INFO - 'SHLVL': '1', 11:58:03 INFO - 'TERM': 'linux', 11:58:03 INFO - 'TMOUT': '86400', 11:58:03 INFO - 'USER': 'cltbld', 11:58:03 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:03 INFO - '_': '/tools/buildbot/bin/python'} 11:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:03 INFO - Running setup.py (path:/tmp/pip-l0atKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:03 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:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:03 INFO - Running setup.py (path:/tmp/pip-04vS1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:03 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:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:03 INFO - Running setup.py (path:/tmp/pip-Mqgcak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:03 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:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:03 INFO - Running setup.py (path:/tmp/pip-mveJwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:03 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:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:03 INFO - Running setup.py (path:/tmp/pip-VIlDIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:03 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:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:03 INFO - Running setup.py (path:/tmp/pip-x4Nxlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:03 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:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:03 INFO - Running setup.py (path:/tmp/pip-u_v4wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:03 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:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:03 INFO - Running setup.py (path:/tmp/pip-62SuSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:04 INFO - Running setup.py (path:/tmp/pip-xncpYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:04 INFO - Running setup.py (path:/tmp/pip-ZXEOtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:04 INFO - Running setup.py (path:/tmp/pip-kAEuMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:04 INFO - Running setup.py (path:/tmp/pip-EfzYrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:04 INFO - Running setup.py (path:/tmp/pip-xvdkOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:04 INFO - Running setup.py (path:/tmp/pip-UxYYlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:04 INFO - Running setup.py (path:/tmp/pip-mIX0l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:04 INFO - Running setup.py (path:/tmp/pip-f7jBPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:04 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:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:04 INFO - Running setup.py (path:/tmp/pip-93jlIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:04 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:58:04 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:58:04 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:58:04 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:58:04 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:58:04 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:58:04 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:58:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:04 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:58:04 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:58:04 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:58:04 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:58:05 INFO - Downloading blessings-1.6.tar.gz 11:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:05 INFO - Installing collected packages: blessings 11:58:05 INFO - Running setup.py install for blessings 11:58:06 INFO - Successfully installed blessings 11:58:06 INFO - Cleaning up... 11:58:06 INFO - Return code: 0 11:58:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:06 INFO - Reading from file tmpfile_stdout 11:58:06 INFO - Current package versions: 11:58:06 INFO - argparse == 1.2.1 11:58:06 INFO - blessings == 1.6 11:58:06 INFO - blobuploader == 1.2.4 11:58:06 INFO - docopt == 0.6.1 11:58:06 INFO - functools32 == 3.2.3-2 11:58:06 INFO - jsonschema == 2.5.1 11:58:06 INFO - manifestparser == 1.1 11:58:06 INFO - mozInstall == 1.13 11:58:06 INFO - mozcrash == 1.0 11:58:06 INFO - mozdebug == 0.1 11:58:06 INFO - mozdevice == 0.51 11:58:06 INFO - mozfile == 1.2 11:58:06 INFO - mozhttpd == 0.7 11:58:06 INFO - mozinfo == 0.10 11:58:06 INFO - mozleak == 0.1 11:58:06 INFO - mozlog == 3.5 11:58:06 INFO - moznetwork == 0.27 11:58:06 INFO - mozprocess == 0.25 11:58:06 INFO - mozprofile == 0.28 11:58:06 INFO - mozrunner == 6.13 11:58:06 INFO - mozscreenshot == 0.1 11:58:06 INFO - mozsystemmonitor == 0.3 11:58:06 INFO - moztest == 0.8 11:58:06 INFO - mozversion == 1.4 11:58:06 INFO - psutil == 3.1.1 11:58:06 INFO - requests == 1.2.3 11:58:06 INFO - wsgiref == 0.1.2 11:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:06 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:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:06 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:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:06 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:58:06 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:58:06 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:58:06 INFO - Using env: {'DISPLAY': ':0', 11:58:06 INFO - 'HOME': '/home/cltbld', 11:58:06 INFO - 'LANG': 'en_US.UTF-8', 11:58:06 INFO - 'LANGUAGE': 'en_US:en', 11:58:06 INFO - 'LOGNAME': 'cltbld', 11:58:06 INFO - 'MAIL': '/var/mail/cltbld', 11:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:06 INFO - 'MOZ_NO_REMOTE': '1', 11:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:06 INFO - 'NO_EM_RESTART': '1', 11:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:06 INFO - 'PWD': '/builds/slave/test', 11:58:06 INFO - 'SHELL': '/bin/bash', 11:58:06 INFO - 'SHLVL': '1', 11:58:06 INFO - 'TERM': 'linux', 11:58:06 INFO - 'TMOUT': '86400', 11:58:06 INFO - 'USER': 'cltbld', 11:58:06 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:06 INFO - '_': '/tools/buildbot/bin/python'} 11:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:06 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:58:06 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:58:06 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:58:06 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:58:06 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:58:06 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:58:06 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:58:06 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:58:06 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:58:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:58:06 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:58:06 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:58:06 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:58:06 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:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:58:07 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:58:07 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:58:07 INFO - Installing collected packages: simplejson 11:58:07 INFO - Running setup.py install for simplejson 11:58:07 INFO - building 'simplejson._speedups' extension 11:58:07 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:58:08 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:58:08 INFO - Successfully installed simplejson 11:58:08 INFO - Cleaning up... 11:58:08 INFO - Return code: 0 11:58:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58:08 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:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:08 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:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:08 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 0x18e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, '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': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', '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:58:08 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:58:08 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:58:08 INFO - Using env: {'DISPLAY': ':0', 11:58:08 INFO - 'HOME': '/home/cltbld', 11:58:08 INFO - 'LANG': 'en_US.UTF-8', 11:58:08 INFO - 'LANGUAGE': 'en_US:en', 11:58:08 INFO - 'LOGNAME': 'cltbld', 11:58:08 INFO - 'MAIL': '/var/mail/cltbld', 11:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:08 INFO - 'MOZ_NO_REMOTE': '1', 11:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:08 INFO - 'NO_EM_RESTART': '1', 11:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:08 INFO - 'PWD': '/builds/slave/test', 11:58:08 INFO - 'SHELL': '/bin/bash', 11:58:08 INFO - 'SHLVL': '1', 11:58:08 INFO - 'TERM': 'linux', 11:58:08 INFO - 'TMOUT': '86400', 11:58:08 INFO - 'USER': 'cltbld', 11:58:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:08 INFO - '_': '/tools/buildbot/bin/python'} 11:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:08 INFO - Cleaning up... 11:58:08 INFO - Return code: 0 11:58:08 INFO - Running post-action listener: _resource_record_post_action 11:58:08 INFO - Running post-action listener: _start_resource_monitoring 11:58:08 INFO - Starting resource monitoring. 11:58:08 INFO - [mozharness: 2017-09-22 18:58:08.982307Z] Finished create-virtualenv step (success) 11:58:08 INFO - [mozharness: 2017-09-22 18:58:08.982820Z] Running install step. 11:58:08 INFO - Running pre-action listener: _resource_record_pre_action 11:58:08 INFO - Running main action method: install 11:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:09 INFO - Reading from file tmpfile_stdout 11:58:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:09 INFO - Reading from file tmpfile_stdout 11:58:09 INFO - Output received: 11:58:09 INFO - Usage: mozinstall [options] installer 11:58:09 INFO - Options: 11:58:09 INFO - -h, --help show this help message and exit 11:58:09 INFO - -d DEST, --destination=DEST 11:58:09 INFO - Directory to install application into. [default: 11:58:09 INFO - "/builds/slave/test"] 11:58:09 INFO - --app=APP Application being installed. [default: firefox] 11:58:09 INFO - mkdir: /builds/slave/test/build/application 11:58:09 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:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:58:26 INFO - Reading from file tmpfile_stdout 11:58:26 INFO - Output received: 11:58:26 INFO - /builds/slave/test/build/application/firefox/firefox 11:58:26 INFO - Running post-action listener: _resource_record_post_action 11:58:26 INFO - [mozharness: 2017-09-22 18:58:26.905023Z] Finished install step (success) 11:58:26 INFO - [mozharness: 2017-09-22 18:58:26.905273Z] Running setup-mitmproxy step. 11:58:26 INFO - Running pre-action listener: _resource_record_pre_action 11:58:26 INFO - Running main action method: setup_mitmproxy 11:58:26 INFO - Skipping: mitmproxy is not required 11:58:26 INFO - Running post-action listener: _resource_record_post_action 11:58:26 INFO - [mozharness: 2017-09-22 18:58:26.906382Z] Finished setup-mitmproxy step (success) 11:58:26 INFO - [mozharness: 2017-09-22 18:58:26.906598Z] Running run-tests step. 11:58:26 INFO - Running pre-action listener: _resource_record_pre_action 11:58:26 INFO - Running pre-action listener: _set_gcov_prefix 11:58:26 INFO - Running main action method: run_tests 11:58:26 WARNING - Try message not found. 11:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:58:26 INFO - Python 2.7.3 11:58:26 INFO - Return code: 0 11:58:26 INFO - grabbing minidump binary from tooltool 11:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:26 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 0x1c53090>, '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 0x1c53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:58:26 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:58:26 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:58:26 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:58:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:58:27 INFO - Return code: 0 11:58:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:58:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:58:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:58:27 INFO - ENV: RUST_BACKTRACE is now full 11:58:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:58:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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:58:27 INFO - Using env: {'DISPLAY': ':0', 11:58:27 INFO - 'HOME': '/home/cltbld', 11:58:27 INFO - 'LANG': 'en_US.UTF-8', 11:58:27 INFO - 'LANGUAGE': 'en_US:en', 11:58:27 INFO - 'LOGNAME': 'cltbld', 11:58:27 INFO - 'MAIL': '/var/mail/cltbld', 11:58:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:27 INFO - 'MOZ_NO_REMOTE': '1', 11:58:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:27 INFO - 'NO_EM_RESTART': '1', 11:58:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:27 INFO - 'PWD': '/builds/slave/test', 11:58:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:27 INFO - 'RUST_BACKTRACE': 'full', 11:58:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:27 INFO - 'SHELL': '/bin/bash', 11:58:27 INFO - 'SHLVL': '1', 11:58:27 INFO - 'TERM': 'linux', 11:58:27 INFO - 'TMOUT': '86400', 11:58:27 INFO - 'USER': 'cltbld', 11:58:27 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:27 INFO - '_': '/tools/buildbot/bin/python'} 11:58:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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:58:27 INFO - mozversion application_buildid: 20170922173423 11:58:27 INFO - mozversion application_changeset: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 11:58:27 INFO - mozversion application_display_name: Nightly 11:58:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:58:27 INFO - mozversion application_name: Firefox 11:58:27 INFO - mozversion application_remotingname: firefox 11:58:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:58:27 INFO - mozversion application_vendor: Mozilla 11:58:27 INFO - mozversion application_version: 58.0a1 11:58:27 INFO - mozversion platform_buildid: 20170922173423 11:58:27 INFO - mozversion platform_changeset: 14db7c0bcf9ae86c9ec2cc9d3c249a42e459a2a9 11:58:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:58:27 INFO - mozversion platform_version: 58.0a1 11:58:27 INFO - using testdate: 1506106707 11:58:27 INFO - actual date: 1506106707 11:58:27 INFO - starting webserver on 'localhost:34107' 11:58:27 INFO - SUITE-START | Running 2 tests 11:58:27 INFO - TEST-START | dromaeo_css 11:58:27 INFO - Initialising browser for dromaeo_css test... 11:58:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34107/getInfo.html -profile /tmp/tmpyJIahC/profile 11:58:27 INFO - TEST-INFO | started process 5808 (/builds/slave/test/build/application/firefox/firefox http://localhost:34107/getInfo.html) 11:58:32 INFO - TEST-INFO | 5808: exit 0 11:58:32 INFO - Browser initialized. 11:58:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:58:32 INFO - Using env: {'DISPLAY': ':0', 11:58:32 INFO - 'HOME': '/home/cltbld', 11:58:32 INFO - 'JSGC_DISABLE_POISONING': '1', 11:58:32 INFO - 'LANG': 'en_US.UTF-8', 11:58:32 INFO - 'LANGUAGE': 'en_US:en', 11:58:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:58:32 INFO - 'LOGNAME': 'cltbld', 11:58:32 INFO - 'MAIL': '/var/mail/cltbld', 11:58:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:32 INFO - 'MOZ_CRASHREPORTER': '1', 11:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:58:32 INFO - 'MOZ_NO_REMOTE': '1', 11:58:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:32 INFO - 'NO_EM_RESTART': '1', 11:58:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:32 INFO - 'PWD': '/builds/slave/test', 11:58:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:32 INFO - 'RUST_BACKTRACE': 'full', 11:58:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:58:32 INFO - 'SHELL': '/bin/bash', 11:58:32 INFO - 'SHLVL': '1', 11:58:32 INFO - 'STYLO_FORCE_DISABLED': '1', 11:58:32 INFO - 'TERM': 'linux', 11:58:32 INFO - 'TMOUT': '86400', 11:58:32 INFO - 'USER': 'cltbld', 11:58:32 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 11:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:32 INFO - '_': '/tools/buildbot/bin/python'} 11:58:32 INFO - TEST-INFO | started process 6050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyJIahC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:33 INFO - PID 6050 | 11:58:33 INFO - PID 6050 | (/builds/slave/test/build/application/firefox/firefox:6100): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:58:33 INFO - PID 6050 | 11:58:43 INFO - PID 6050 | RSS: Main: 144900096 11:58:43 INFO - PID 6050 | 12:01:41 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:34107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34107/tests/dromaeo/cssquery-ext.html) 12:01:42 INFO - PID 6050 | RSS: Main: 148606976 12:01:42 INFO - PID 6050 | 12:04:44 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:34107/tests/dromaeo/cssquery-ext.html (next: http://localhost:34107/tests/dromaeo/cssquery-jquery.html) 12:04:44 INFO - PID 6050 | RSS: Main: 146374656 12:04:44 INFO - PID 6050 | 12:07:46 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:34107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34107/tests/dromaeo/cssquery-mootools.html) 12:07:46 INFO - PID 6050 | RSS: Main: 146698240 12:07:46 INFO - PID 6050 | 12:10:48 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:34107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34107/tests/dromaeo/cssquery-prototype.html) 12:10:48 INFO - PID 6050 | RSS: Main: 147202048 12:10:48 INFO - PID 6050 | 12:13:51 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:34107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34107/tests/dromaeo/cssquery-yui.html) 12:13:52 INFO - PID 6050 | RSS: Main: 146206720 12:13:52 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:34107/tests/dromaeo/cssquery-yui.html (next: http://localhost:34107/tests/dromaeo/cssquery-dojo.html) 12:16:54 INFO - PID 6050 | RSS: Main: 148750336 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | __start_tp_report 12:16:54 INFO - PID 6050 | _x_x_mozilla_page_load 12:16:54 INFO - PID 6050 | _x_x_mozilla_page_load_details 12:16:54 INFO - PID 6050 | |i|pagename|runs| 12:16:54 INFO - PID 6050 | |0;dojo.html;3800.581935987042;3850.4609354690338;3864.072622570584;3874.089588946595;3877.9418308725376;6133.815985520436;6157.876842463159;6174.320824709278;6189.412005859442;6202.162708034409;6263.561550691442;6265;6267.997120460727;6292.496600271978;6304.842378940529;5549.112142057272;5642.04085305499;5650.124230744221;5662.37713851476;5680.914786278188;5676.687782171979;5689.3172819261745;5701.002324593201;5727.627704199234;5757.136429535562;839.5811894611331;5590.161475778625;5645.266115405012;5763.39484354143;5766.711664416784;5154.561862241714;5608.775648974036;5614.803481878114;5615.382307946164;5675.404082571312;5606.411326810708;5634.323881134249;5673.914891276634;5685.118806584986;5690.857728556778;6205.410486003822;6213.627182369027;6215.471684906788;6231.781887633911;6269.153664255313;6769.4329927705;6804.455643548505;6882.380585747307;6896.999935009396;6908.7236510539515;6678.532502724811;6794.864102717967;6833.453323734089;6930.861382772367;6939.063226464464;6241.563090583661;6246.500279977591;6258.436740693314;6259.280182778994;6316.336784637593;6899.586024838526;7002.544834585736;7011.5091943564485;7012.894806577905;7014.123234595676;6631.171103612049;6640.0703901453835;6659.267480577133;6725.562838415487;6731.562448440835;6689.76585819494;6714.664266786641;6786.558873673195;6800.65996700163;6857.245702972669;6681.465482761368;6745.02197181406;6758.5269031167345;6759.628220447824;6785.626790526469;6727.495437842182;6752.729890804313;6777.457803375718;6846.657667116624;6847.1783385993;4944.035912996931;5005.374328208974;5017.949820501748;5021.899562008739;5023.196288593807;4488.12481566098;4525.389072475174;4531.932021019687;4550.49944506104;4552.817887284537;6258.780942666985;6287;6287.276963149205;6288.717007734663;6297.4647154992335;6595.439387652007;6618.404343609098;6632.469402447792;6710.597364158166;6713.56361836479;6193.6903154842075;6208.565400422018;6275.497960163176;6275.937240627627;6304;5375.19372094189;5522.2544956431175;5555.749991250404;5582.190582365534;5583.218349431083;7177.784666460015;7181.497295189287;7264.237255088246;7272.272772722791;7287.161976372679;6667.066610674607;6758.831029224309;6765.052892594942;6832.487563432763;6854.725810967506;7072.328128827753;7119.252478489684;7144.3927266182955;7148.535345202546;7151.642417879189;6664.333566643297;6673.232578253369;6683.298253683488;6734.898976515258;6764.966175169093;6677.265500795006;6678.49911256648;6750.223724271772;6760.459163266829;6761.425278851156;6458.838529036811;6461.2892581816905;6471.546991710535;6548.8035358939305;6566.770163044271;6568.868622627425;6631.171103612049;6632.270450250565;6634.767783127568;6660.700268488026;6499.122618446639;6506.284308726131;6580.670966451563;6583.30875258091;6593.340665933369;6550.410463058348;6637.402633762985;6692.364225398579;6697.296783837822;6728.259891412039;6236.812895613139;6371.139896113966;6377.330380310001;6377.617342959437;6390.4248617624635 12:16:54 INFO - PID 6050 | |1;ext.html;940.4733349324379;954.9856752148723;979.2117345536842;1006.250343494097;1016.0398423489801;45350.54649453505;46390.53609463913;46408;46472.767636161814;46492;42897.78551107248;43216.78391608038;43301.566984330144;43316.350254746205;43346.56653433465;7775.533467991924;7882.487638303521;7885.8028549286155;7902;7912.683492660315;7821.256980586835;7901.486403383762;7912.129665736793;7913.050433947934;7916.129225785159;8553.914460855374;8730.650773969033;8736.51949142797;8746.956265218665;8748.737537873874;8608.268297194745;8689.739307820711;8695.869561956575;8707.43401678892;8715.084916083815;8395.454295470774;8557.957210213908;8611;8655.394122411433;8657.437266577652;41823.7908810457;42054;42060.78969605163;42091;42117.57882421167;3758.4362345648096;3798.791066491342;3809.847606095753;3813.637704418076;3821.178446633959;33715.325693486;33729.49405758915;33755.49366759501;33802;33997.83001085003;5551.250581171531;5605.243292155588;5641.774329026834;5655.66066036035;5723;219495;219588;219918;220834;220961;54112;54172;54426;54508.18237726437;54562.727186363816;56215.71892140513;56232.718836405555;56518.43481565214;56538;56719.432805671415;17364.65270694579;17484.562885927953;17677.55806104832;17712.557186070193;17740.645187096445;14343;14354.928225358806;14400.855991440161;14468.348924298432;14468.710625787426;16144.273507692182;16161.111138887474;16227.350905963629;16329.428470003493;16364;6130.386961303923;6147.692615369214;6254.312025677172;6274.686265686789;6404.1674582304;1087.276960821061;1094.2067001423904;1100.3562915694408;1100.9284396514201;1111.699841042914;26240.34399140037;26298.86850565773;26346.604800928002;26370.340741481617;26632.60051099235;1179.2688533109526;1201.4653479201672;1204.9457774400173;1208.1060015588578;1228.269179837995;13614.727705446034;13752.174869507862;14023.1586104832;14133.717325653635;14140.858591413955;271656;272795;273563;274128;274934;61329;61380.69309653513;61458.07812882811;61691.383086168564;65754;1479.2603698150924;1522.8578566075444;1541.029151634463;1543.0587341721766;1547.6053606330538;31253.218669533442;31313.530297046018;31838.681613183573;32175.51736723904;32175.67824321727;41943.58056419519;42125;42222.15555688807;42225.78887105545;42245.577544224165;247053;247634;248186;248267;249059;35145.47281790827;36645;37227;37339;37348.81325593355;46041.76979115083;47057.76471117623;47115;47172.292415613105;48098;34993.82503087468;35103;35200.47199292064;35282.470762938065;35345;35022.12444688903;35336.46995295021;35643.46534801928;35715.82142089273;35898;41210.38184427296;41480.37779433371;41593.168136636494;41781.58218417777;42003.57996419997;34261;34323.485147722306;34761.304773904885;34786.82606586951;34859.82570087133;26040.218793436226;26349.077782277527;26432.603510946967;26651.733482664924;26843 12:16:54 INFO - PID 6050 | |2;jquery.html;588.4380416702053;598.6318414175281;606.8877257707321;626.2672672972622;628.1018144054003;23449.76550234497;24393.390165245877;24409.26772196837;24413.145539906105;24451.144209952632;25592.87203563984;27680.861595692044;27913.581296280572;27974.300642483948;27979;6900.413464855494;7066.3993560547415;7086.681099350541;7089.964550177242;7090.822729431754;6548.345165483461;6751.9662401688165;6799.42204912583;6869.072675188861;6919.757808476705;6739.460843132562;6739.764108256212;6744.089547911043;6749.392554670078;6751.8312042199095;6576.76981305652;6658.267590565034;6680.298568650271;6701.798946031602;6817;6348.9365106348805;6351.2060992375955;6363.204599425072;6388.456981156607;6397.296297407282;30954.845225773726;31230;31307;31358.52962205569;31380.21549461259;2321.2107883319754;2350.97649023511;2351.835371523994;2353.599888019041;2354.9058037678474;21386.358409247747;21476.711397316212;21816.89091554548;22038.11847526097;22087.779122208893;2591.896324147032;2634.249238966885;2680.142354446578;2692.7307269272915;2698;141165;146785;155109;157493.21253393774;160742.99999999884;16282.67434651324;16622.667546648998;16761.7485737714;16833.41083062087;16929.746053809202;26618.733812661627;26705.732942670325;26764;26781.866090669813;26792.392456452675;11157.330560166416;11186.664400067848;11224.551017959353;11238.494267757971;11293.265937714023;10394.48027598617;10430.113440357654;10467.528961196764;10494.895051049545;10495.47522623881;9896.505174741234;10118.544665489924;10119.166633342677;10308.793824123626;10409.219308551888;2889.622222333125;2904.3385366486486;2914.8688309026143;2935.618369611937;3112.5486804413235;997.5062344139552;1030.90206430389;1049.968500944973;1050.4905121016302;1050.5167622893402;21936.012879420465;22311.330660080224;22639.094436222367;22640.207592734176;22949.541009179724;1083.4311986207147;1100.3562915694408;1111.7331840358256;1113.0650253786857;1117.3128525956479;12115.39423028845;12371.628851134481;12405.255684658949;12436;12463.813042804366;598775;603248;603863;622231;625675;130586;130760.03859942108;130882.34558827145;131527;133006.33496832455;1113.8496302999154;1204.1089593700774;1209.1113031921532;1234.2101055324779;1254.7929591617462;23279.18522851692;23676;23755.40611484727;23823.285301440985;23850.52298954046;62509.68745156245;62867.6856615714;63114.368856312685;63172.36827631665;65153.348466514726;79358.6032069836;79996.60001699954;80287.59856200915;80606;81381.59309203416;15961;16134.67730645404;16258;16335.67328653444;16355.754663679816;24648.507029858945;24875.502489949737;25065.87467062653;25476.108336208887;25545.489090218463;20373.18507259693;20560.177592896118;20972.37082887516;21067.789322106582;21069.15723371048;17451.3892013784;17645.20596573183;18546.44360669182;18622.813771862107;18732.06339682983;21136.260230891847;21162.365129046153;21553.461163471038;21680.34958951234;21734.130634774432;15964.441244556385;16025.278862450985;16100.436484722979;16100.55095041452;16153.515394538183;18715.344962926232;18799.248030078645;20422.897885510476;20457.079431425325;20513.38459846207 12:16:54 INFO - PID 6050 | |3;mootools.html;1362.6320893358793;1441.6395901024744;1444.0324982261884;1445.7903603977418;1447.72493226287;16312.918435407835;17001.57496062599;17040.23318950647;17097.572560685974;17129.314827406888;16467.58831029225;16587.087710175965;16666.916665416687;16695.83304166958;16706;2790.8046436749437;2870.1676513811076;2872.1240021793346;2872.4685933102337;2875.5111631022673;2830.122661974784;2891.147111602072;2893.9710602894015;2895.493288674484;2897.9420411591755;2892.2913886097936;2910.927226819336;2917.3435976905134;2922.4593450211673;2922.6200593922867;2654.522186006518;2732.4261904999976;2757.6139340492346;2769.5984082308055;2770.7367800059064;2808.9297767555977;2839.943201135966;2842.6020357150014;2847.1173936079676;2847.359344147571;16732.58168545784;16807;16871.91564042172;16886.83113168877;16911.915440422843;8226.42415030948;8374.246317831363;8660.004099528509;8681.348898832613;8754.824903501894;5415.296011518517;5503.944960550383;5605.075162598167;5621;5649.576281778883;1993;2068.9482762931048;2113.17586141405;2127.255460588797;2147.6563749799957;30268.394632107236;30516.237094072603;30549.69450305513;30564.54153187704;30571.388572228654;6907.171139463196;7124.821879452951;7131.144262688511;7306;7321.231270716605;19754.11106500211;19768.20927162926;19788.307409240606;19791;19810.306639267557;8180.386471014698;8267.131951145164;8318.45930014547;8319.8336033279;8321.542315172723;7422.888656670154;7440.218777028443;7597.924020759721;7607.049118860143;7638.961805191049;5754.165645981393;5874.559408044328;5915.881682366415;5948;6148.8770224595255;1718.2267979409316;1739.3129713762992;1751.527087686343;1764.7617571627923;1769.2657547117801;977.1986970684113;994.8457989011715;997.6607953295769;1020.3265844542566;1025.1235193909101;8728.869066964;8803.559822009001;8836;8850.64597416109;8885.733427997171;796.1202870827768;799.6401619271351;807.15652143509;810.6838333050115;811.4603788480712;6084.361142080106;6212.596181248205;6297.4332310091395;6395.424411802867;6419.1334169887405;24992.500149996897;25493.490130197293;25612.231633051037;25659.35851603725;25948.35129121787;24566.877165614416;25073;25492.23523294304;25803.870980644977;25807;11933;12369.567065152856;12426;12452.626421207378;12453;9687.951560242436;9749.415035097916;9803.754906127118;9871.160951319218;9871.309008369346;20666.380008599765;20769.27307544229;20929.58140837205;20933.476663083544;21122.366329010154;21876.343709688736;21888.671669924646;22135.889320553295;22300.330990070324;22669.43326416853;12274.324912129561;12669.74660506803;12683;12684.619461416172;12691.42888570035;15570.532884013497;15669.138197399252;15673.843261567694;15797.684046319238;15802.920985395;11898.821517677068;11933.462994165457;12165;12179.573714919936;12448.128630995743;11690.123240757148;11953.282803031845;12112.75774484523;12259.69350766238;12312.445939932546;10407.68776936693;10543.841842372523;10545.36727796304;10545.841812372973;10657.57369705203;8172.959135204286;8385.664573416994;8452.450590711584;8548.230659240699;8590.441621294596;8503.447275927045;8606.569671516525;8639.740807775777;8772;8861 12:16:54 INFO - PID 6050 | |4;prototype.html;557.6347492392484;573.6816067082768;579.8869220502003;587.7678317064763;593.2436143916506;6181.258249010114;6253.749850006;6275.497960163188;6333.746650133995;6349.555531112813;6113.052476866093;6140.969295153518;6173.938260617392;6187.876242475148;6233.501319894409;5136.820211292606;5136.9469258801855;5148.150555158413;5152.768125434346;5156.613254005946;4816.783244753977;5112.130937740593;5173.810023694534;5173.844784656466;5180.222966555009;4943.30793688882;4970.179920313162;4990.3762029746285;5009.924851127236;5018.046571151488;4963.478834722338;4980.626453016002;4992.6754760940785;5007.849764507034;5010.649254552182;4385.342198670193;4531.818727250906;4542.8864278392975;4548.295014272793;4554.726716397026;6009.909851352233;6089.238845144357;6093.922569102575;6100.145979562864;6121.602095863799;5863.736131874033;5870.236869206976;5872.559558033122;5887.882242355172;5904.76380944766;6650.966745166292;6695.832604184886;6714.227863795629;6725.159355080615;6736.528443008991;5099.4900509949075;5119.948800511985;5122.718250496221;5130.178786530802;5133.153029750124;6659.035584502583;6748.493862960347;6809.795706128824;6864.7940561782725;6884.931150688529;5166.638335316567;5187;5215.400228973641;5228.503292187236;5231.058409486329;5285.524302812765;5291.259223708684;5299.33758280215;5301.3373328333955;5345.9732701337025;5792.333881603585;5820.671731307426;5845.561582881301;5866.1494083357675;5874.882502349929;6615.437687796495;6620.66896655175;6631.403173714389;6689.4982876284475;6710.66446677674;1807.3493542324752;1840.0339821593502;1841.7881943576392;1841.990790046068;1853.5180852978324;1263.9684007899875;1300.0964329790893;1301.3688361144837;1316.6313432238987;1322.0613364511305;6220.533459990519;6275;6281.528885333527;6333.651649159248;6340.587861788969;6644.235912869985;6697.564658297195;6742.921132618855;6754.257031726506;6758.560693554903;6144.723487443076;6176.35148309421;6186.536009799283;6211.596246243979;6290.238733154724;3471.2710330830305;3512.5960514541157;3514.648535146465;3523.94714079289;3540.486629438717;7063.71745130189;7114.679839407239;7118.394936430358;7155.499115062;7187.389071928945;6778.93221067783;6822.795316140425;6874.140732408449;6894.24163342032;6950;7031.999999999897;7104;7128.893066604005;7129.144502659714;7167.677454514559;6556.213254409311;6557.868842623217;6602.240742314503;6626.602403855784;6638.76764313266;6674.499412544175;6692.866142677217;6712.53012289135;6733.764318248838;6767.796966091025;7006.8629068134705;7074.655815395058;7078.929210708033;7104.502684812221;7113.715451381887;5175.757818123548;5197.610179236648;5217.973910130425;5219.843404697714;5225.634205605723;6498.187726534184;6589.0775291460195;6643.30245324234;6716.462682985251;6732;6197.318294987638;6533.346665333429;6540.411362977355;6558.606483610999;6560.40956313934;6525.706343214471;6530.706118224786;6538.869222615426;6567.31043240472;6604.900926486011;6482.54622176462;6484.1894763154605;6492;6516.869662606816;6521.250056243593;6589.4728421725185;6596.350912271932;6628.370304821035;6632.369924857131;6656.267810540933;6431.356864313531;6432.678366081584;6443.838904027437;6457.806265812033;6484.1894763154605 12:16:54 INFO - PID 6050 | |5;yui.html;977.6773664690658;994.8559156969486;997.3766396002499;1015.847622856571;1018.2312354172599;17062.402815901445;17270.740938885912;17556.56108597286;17560.209790559424;17629.91185044073;16953.576160595992;17141.571460713487;17141.91429042856;17586.560335991606;17597.912010439963;1000.2495632642893;1016.6492560066765;1022.8363461846106;1027.1064174168484;1028.059325716972;1031.020530496028;1034.2191645307782;1036.7926414717049;1037.1339931157493;1037.7976294622551;1044.937303761773;1072.6406653770996;1083.0469187115327;1083.3770581915392;1091.328832767846;1080.908122809558;1083.3175099687226;1083.3554035348955;1083.512419411264;1083.7344850511597;767.1293082351515;785.2304741353448;795.5425630262564;797.0156856282487;797.3262593108814;21038.474038149016;21090.156393744233;21366.25218117374;21441.892790536105;21458.570828583343;22962.65556016661;23130.19044333457;23155.3053408398;23519.17682881108;23524;17958.461246162635;18155.27378904842;18420.907895460572;18545.62908741831;18568.721469177974;4056.7971601419813;4088.100617864095;4089.0390758171807;4089.20260549193;4089.9795501022604;137956;159009.20495397566;159435;160454;165062;18244.817551824577;18355.632887342177;18499.537511562317;18736.531586710167;18826.341078062203;34546;34645;34658;34727.826360868035;34963.300733985176;8677.826443471095;8738.781530461662;8759.868601970975;8765.956170219108;8766.693165739296;4246.787660616957;4291.249031419489;4370.8907277317685;4390.648748100144;4406.427164468599;5661.179129026268;5769.394213607511;5778.682172480554;5784.681842498619;5803.738831752581;1064.0689396777818;1085.9728506787235;1104.6851647280487;1105.784372047443;1111.5831563163813;729.7810656802938;751.1136858507015;751.5565816168378;770.8843673448915;772.6252767407802;12898.548550800677;12945.870541294655;13203.867961320457;13399.53101641438;13423.26172060546;724.1201939643358;737.7086051009821;742.265157494077;745.1728581274889;753.1075675324757;5959.165716799652;6137.631742095488;6144.477719393902;6172.475339596095;6243.500519958392;146907;146970.2651486757;147814;147893;148309;128727.35636321758;128955;129783.35108324398;130026;136576;113724;114581.427092864;115951.99999999831;117210.41394792972;119582;11533;11652.184347095623;11769.529218831492;11842.467088980844;11849.703757406134;53759.73120134374;54079.72960135174;54135.18797218124;54686.179707305215;55042.17436738532;69275;69780;71528.64235678788;71709;73426.26573734195;17892.46322610324;18011;18258.26966921308;18261.726074108632;18354.082295884884;17686;17787.19957601885;17821.643567128845;17865.28538858431;18017.909910450362;17233.310667573158;17478.563035924202;17536.473905782335;17604.03177825232;17618.82381176172;18417.723734144267;18439.815601844348;18663.533411664816;18767.34314298993;18918.527036823638;16774.24515896812;16789;16826.242819072926;16834.242459089124;16919.323227070778;11058.281211721212;11084.722881928017;11204.943975280072;11448.713782155513;11455.541778329107;13004.674883127998;13067.477300907858;13115;13123.146995445266;13147.671308216988 12:16:54 INFO - PID 6050 | __end_tp_report 12:16:54 INFO - PID 6050 | __start_cc_report 12:16:54 INFO - PID 6050 | _x_x_mozilla_cycle_collect,261 12:16:54 INFO - PID 6050 | __end_cc_report 12:16:54 INFO - PID 6050 | __startTimestamp1506107814296__endTimestamp 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | ------- Summary: start ------- 12:16:54 INFO - PID 6050 | Number of tests: 6 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | [#0] dojo.html Cycles:165 Average:6218.82 Median:6499.12 stddev:852.45 (13.1%) stddev-sans-first:833.69 12:16:54 INFO - PID 6050 | Values: 3800.6 3850.5 3864.1 3874.1 3877.9 6133.8 6157.9 6174.3 6189.4 6202.2 6263.6 6265.0 6268.0 6292.5 6304.8 5549.1 5642.0 5650.1 5662.4 5680.9 5676.7 5689.3 5701.0 5727.6 5757.1 839.6 5590.2 5645.3 5763.4 5766.7 5154.6 5608.8 5614.8 5615.4 5675.4 5606.4 5634.3 5673.9 5685.1 5690.9 6205.4 6213.6 6215.5 6231.8 6269.2 6769.4 6804.5 6882.4 6897.0 6908.7 6678.5 6794.9 6833.5 6930.9 6939.1 6241.6 6246.5 6258.4 6259.3 6316.3 6899.6 7002.5 7011.5 7012.9 7014.1 6631.2 6640.1 6659.3 6725.6 6731.6 6689.8 6714.7 6786.6 6800.7 6857.2 6681.5 6745.0 6758.5 6759.6 6785.6 6727.5 6752.7 6777.5 6846.7 6847.2 4944.0 5005.4 5017.9 5021.9 5023.2 4488.1 4525.4 4531.9 4550.5 4552.8 6258.8 6287.0 6287.3 6288.7 6297.5 6595.4 6618.4 6632.5 6710.6 6713.6 6193.7 6208.6 6275.5 6275.9 6304.0 5375.2 5522.3 5555.7 5582.2 5583.2 7177.8 7181.5 7264.2 7272.3 7287.2 6667.1 6758.8 6765.1 6832.5 6854.7 7072.3 7119.3 7144.4 7148.5 7151.6 6664.3 6673.2 6683.3 6734.9 6765.0 6677.3 6678.5 6750.2 6760.5 6761.4 6458.8 6461.3 6471.5 6548.8 6566.8 6568.9 6631.2 6632.3 6634.8 6660.7 6499.1 6506.3 6580.7 6583.3 6593.3 6550.4 6637.4 6692.4 6697.3 6728.3 6236.8 6371.1 6377.3 6377.6 6390.4 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | [#1] ext.html Cycles:180 Average:43386.24 Median:37343.91 stddev:64410.19 (172.5%) stddev-sans-first:64512.02 12:16:54 INFO - PID 6050 | Values: 940.5 955.0 979.2 1006.3 1016.0 45350.5 46390.5 46408.0 46472.8 46492.0 42897.8 43216.8 43301.6 43316.4 43346.6 7775.5 7882.5 7885.8 7902.0 7912.7 7821.3 7901.5 7912.1 7913.1 7916.1 8553.9 8730.7 8736.5 8747.0 8748.7 8608.3 8689.7 8695.9 8707.4 8715.1 8395.5 8558.0 8611.0 8655.4 8657.4 41823.8 42054.0 42060.8 42091.0 42117.6 3758.4 3798.8 3809.8 3813.6 3821.2 33715.3 33729.5 33755.5 33802.0 33997.8 5551.3 5605.2 5641.8 5655.7 5723.0 219495.0 219588.0 219918.0 220834.0 220961.0 54112.0 54172.0 54426.0 54508.2 54562.7 56215.7 56232.7 56518.4 56538.0 56719.4 17364.7 17484.6 17677.6 17712.6 17740.6 14343.0 14354.9 14400.9 14468.3 14468.7 16144.3 16161.1 16227.4 16329.4 16364.0 6130.4 6147.7 6254.3 6274.7 6404.2 1087.3 1094.2 1100.4 1100.9 1111.7 26240.3 26298.9 26346.6 26370.3 26632.6 1179.3 1201.5 1204.9 1208.1 1228.3 13614.7 13752.2 14023.2 14133.7 14140.9 271656.0 272795.0 273563.0 274128.0 274934.0 61329.0 61380.7 61458.1 61691.4 65754.0 1479.3 1522.9 1541.0 1543.1 1547.6 31253.2 31313.5 31838.7 32175.5 32175.7 41943.6 42125.0 42222.2 42225.8 42245.6 247053.0 247634.0 248186.0 248267.0 249059.0 35145.5 36645.0 37227.0 37339.0 37348.8 46041.8 47057.8 47115.0 47172.3 48098.0 34993.8 35103.0 35200.5 35282.5 35345.0 35022.1 35336.5 35643.5 35715.8 35898.0 41210.4 41480.4 41593.2 41781.6 42003.6 34261.0 34323.5 34761.3 34786.8 34859.8 26040.2 26349.1 26432.6 26651.7 26843.0 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | [#2] jquery.html Cycles:180 Average:40547.08 Median:12900.37 stddev:102111.75 (791.5%) stddev-sans-first:102354.13 12:16:54 INFO - PID 6050 | Values: 588.4 598.6 606.9 626.3 628.1 23449.8 24393.4 24409.3 24413.1 24451.1 25592.9 27680.9 27913.6 27974.3 27979.0 6900.4 7066.4 7086.7 7090.0 7090.8 6548.3 6752.0 6799.4 6869.1 6919.8 6739.5 6739.8 6744.1 6749.4 6751.8 6576.8 6658.3 6680.3 6701.8 6817.0 6348.9 6351.2 6363.2 6388.5 6397.3 30954.8 31230.0 31307.0 31358.5 31380.2 2321.2 2351.0 2351.8 2353.6 2354.9 21386.4 21476.7 21816.9 22038.1 22087.8 2591.9 2634.2 2680.1 2692.7 2698.0 141165.0 146785.0 155109.0 157493.2 160743.0 16282.7 16622.7 16761.7 16833.4 16929.7 26618.7 26705.7 26764.0 26781.9 26792.4 11157.3 11186.7 11224.6 11238.5 11293.3 10394.5 10430.1 10467.5 10494.9 10495.5 9896.5 10118.5 10119.2 10308.8 10409.2 2889.6 2904.3 2914.9 2935.6 3112.5 997.5 1030.9 1050.0 1050.5 1050.5 21936.0 22311.3 22639.1 22640.2 22949.5 1083.4 1100.4 1111.7 1113.1 1117.3 12115.4 12371.6 12405.3 12436.0 12463.8 598775.0 603248.0 603863.0 622231.0 625675.0 130586.0 130760.0 130882.3 131527.0 133006.3 1113.8 1204.1 1209.1 1234.2 1254.8 23279.2 23676.0 23755.4 23823.3 23850.5 62509.7 62867.7 63114.4 63172.4 65153.3 79358.6 79996.6 80287.6 80606.0 81381.6 15961.0 16134.7 16258.0 16335.7 16355.8 24648.5 24875.5 25065.9 25476.1 25545.5 20373.2 20560.2 20972.4 21067.8 21069.2 17451.4 17645.2 18546.4 18622.8 18732.1 21136.3 21162.4 21553.5 21680.3 21734.1 15964.4 16025.3 16100.4 16100.6 16153.5 18715.3 18799.2 20422.9 20457.1 20513.4 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | [#3] mootools.html Cycles:180 Average:10452.29 Median:2770.17 stddev:7742.19 (279.5%) stddev-sans-first:7733.79 12:16:54 INFO - PID 6050 | Values: 1362.6 1441.6 1444.0 1445.8 1447.7 16312.9 17001.6 17040.2 17097.6 17129.3 16467.6 16587.1 16666.9 16695.8 16706.0 2790.8 2870.2 2872.1 2872.5 2875.5 2830.1 2891.1 2894.0 2895.5 2897.9 2892.3 2910.9 2917.3 2922.5 2922.6 2654.5 2732.4 2757.6 2769.6 2770.7 2808.9 2839.9 2842.6 2847.1 2847.4 16732.6 16807.0 16871.9 16886.8 16911.9 8226.4 8374.2 8660.0 8681.3 8754.8 5415.3 5503.9 5605.1 5621.0 5649.6 1993.0 2068.9 2113.2 2127.3 2147.7 30268.4 30516.2 30549.7 30564.5 30571.4 6907.2 7124.8 7131.1 7306.0 7321.2 19754.1 19768.2 19788.3 19791.0 19810.3 8180.4 8267.1 8318.5 8319.8 8321.5 7422.9 7440.2 7597.9 7607.0 7639.0 5754.2 5874.6 5915.9 5948.0 6148.9 1718.2 1739.3 1751.5 1764.8 1769.3 977.2 994.8 997.7 1020.3 1025.1 8728.9 8803.6 8836.0 8850.6 8885.7 796.1 799.6 807.2 810.7 811.5 6084.4 6212.6 6297.4 6395.4 6419.1 24992.5 25493.5 25612.2 25659.4 25948.4 24566.9 25073.0 25492.2 25803.9 25807.0 11933.0 12369.6 12426.0 12452.6 12453.0 9688.0 9749.4 9803.8 9871.2 9871.3 20666.4 20769.3 20929.6 20933.5 21122.4 21876.3 21888.7 22135.9 22300.3 22669.4 12274.3 12669.7 12683.0 12684.6 12691.4 15570.5 15669.1 15673.8 15797.7 15802.9 11898.8 11933.5 12165.0 12179.6 12448.1 11690.1 11953.3 12112.8 12259.7 12312.4 10407.7 10543.8 10545.4 10545.8 10657.6 8173.0 8385.7 8452.5 8548.2 8590.4 8503.4 8606.6 8639.7 8772.0 8861.0 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | [#4] prototype.html Cycles:180 Average:5642.77 Median:6227.02 stddev:1569.84 (25.2%) stddev-sans-first:1527.14 12:16:54 INFO - PID 6050 | Values: 557.6 573.7 579.9 587.8 593.2 6181.3 6253.7 6275.5 6333.7 6349.6 6113.1 6141.0 6173.9 6187.9 6233.5 5136.8 5136.9 5148.2 5152.8 5156.6 4816.8 5112.1 5173.8 5173.8 5180.2 4943.3 4970.2 4990.4 5009.9 5018.0 4963.5 4980.6 4992.7 5007.8 5010.6 4385.3 4531.8 4542.9 4548.3 4554.7 6009.9 6089.2 6093.9 6100.1 6121.6 5863.7 5870.2 5872.6 5887.9 5904.8 6651.0 6695.8 6714.2 6725.2 6736.5 5099.5 5119.9 5122.7 5130.2 5133.2 6659.0 6748.5 6809.8 6864.8 6884.9 5166.6 5187.0 5215.4 5228.5 5231.1 5285.5 5291.3 5299.3 5301.3 5346.0 5792.3 5820.7 5845.6 5866.1 5874.9 6615.4 6620.7 6631.4 6689.5 6710.7 1807.3 1840.0 1841.8 1842.0 1853.5 1264.0 1300.1 1301.4 1316.6 1322.1 6220.5 6275.0 6281.5 6333.7 6340.6 6644.2 6697.6 6742.9 6754.3 6758.6 6144.7 6176.4 6186.5 6211.6 6290.2 3471.3 3512.6 3514.6 3523.9 3540.5 7063.7 7114.7 7118.4 7155.5 7187.4 6778.9 6822.8 6874.1 6894.2 6950.0 7032.0 7104.0 7128.9 7129.1 7167.7 6556.2 6557.9 6602.2 6626.6 6638.8 6674.5 6692.9 6712.5 6733.8 6767.8 7006.9 7074.7 7078.9 7104.5 7113.7 5175.8 5197.6 5218.0 5219.8 5225.6 6498.2 6589.1 6643.3 6716.5 6732.0 6197.3 6533.3 6540.4 6558.6 6560.4 6525.7 6530.7 6538.9 6567.3 6604.9 6482.5 6484.2 6492.0 6516.9 6521.3 6589.5 6596.4 6628.4 6632.4 6656.3 6431.4 6432.7 6443.8 6457.8 6484.2 12:16:54 INFO - PID 6050 | 12:16:54 INFO - PID 6050 | [#5] yui.html Cycles:180 Average:27864.64 Median:17878.87 stddev:41911.32 (234.4%) stddev-sans-first:41980.27 12:16:54 INFO - PID 6050 | Values: 977.7 994.9 997.4 1015.8 1018.2 17062.4 17270.7 17556.6 17560.2 17629.9 16953.6 17141.6 17141.9 17586.6 17597.9 1000.2 1016.6 1022.8 1027.1 1028.1 1031.0 1034.2 1036.8 1037.1 1037.8 1044.9 1072.6 1083.0 1083.4 1091.3 1080.9 1083.3 1083.4 1083.5 1083.7 767.1 785.2 795.5 797.0 797.3 21038.5 21090.2 21366.3 21441.9 21458.6 22962.7 23130.2 23155.3 23519.2 23524.0 17958.5 18155.3 18420.9 18545.6 18568.7 4056.8 4088.1 4089.0 4089.2 4090.0 137956.0 159009.2 159435.0 160454.0 165062.0 18244.8 18355.6 18499.5 18736.5 18826.3 34546.0 34645.0 34658.0 34727.8 34963.3 8677.8 8738.8 8759.9 8766.0 8766.7 4246.8 4291.2 4370.9 4390.6 4406.4 5661.2 5769.4 5778.7 5784.7 5803.7 1064.1 1086.0 1104.7 1105.8 1111.6 729.8 751.1 751.6 770.9 772.6 12898.5 12945.9 13203.9 13399.5 13423.3 724.1 737.7 742.3 745.2 753.1 5959.2 6137.6 6144.5 6172.5 6243.5 146907.0 146970.3 147814.0 147893.0 148309.0 128727.4 128955.0 129783.4 130026.0 136576.0 113724.0 114581.4 115952.0 117210.4 119582.0 11533.0 11652.2 11769.5 11842.5 11849.7 53759.7 54079.7 54135.2 54686.2 55042.2 69275.0 69780.0 71528.6 71709.0 73426.3 17892.5 18011.0 18258.3 18261.7 18354.1 17686.0 17787.2 17821.6 17865.3 18017.9 17233.3 17478.6 17536.5 17604.0 17618.8 18417.7 18439.8 18663.5 18767.3 18918.5 16774.2 16789.0 16826.2 16834.2 16919.3 11058.3 11084.7 11204.9 11448.7 11455.5 13004.7 13067.5 13115.0 13123.1 13147.7 12:16:54 INFO - PID 6050 | -------- Summary: end -------- 12:16:54 INFO - PID 6050 | 12:16:54 INFO - TEST-INFO | 6050: exit 0 12:16:54 INFO - TEST-OK | dromaeo_css | took 1107712ms 12:16:54 INFO - TEST-START | kraken 12:16:54 INFO - Initialising browser for kraken test... 12:16:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34107/getInfo.html -profile /tmp/tmpiHVzUW/profile 12:16:55 INFO - TEST-INFO | started process 6421 (/builds/slave/test/build/application/firefox/firefox http://localhost:34107/getInfo.html) 12:17:00 INFO - TEST-INFO | 6421: exit 0 12:17:00 INFO - Browser initialized. 12:17:00 INFO - Running cycle 1/1 for kraken test... 12:17:00 INFO - Using env: {'DISPLAY': ':0', 12:17:00 INFO - 'HOME': '/home/cltbld', 12:17:00 INFO - 'JSGC_DISABLE_POISONING': '1', 12:17:00 INFO - 'LANG': 'en_US.UTF-8', 12:17:00 INFO - 'LANGUAGE': 'en_US:en', 12:17:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:17:00 INFO - 'LOGNAME': 'cltbld', 12:17:00 INFO - 'MAIL': '/var/mail/cltbld', 12:17:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:00 INFO - 'MOZ_CRASHREPORTER': '1', 12:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:17:00 INFO - 'MOZ_NO_REMOTE': '1', 12:17:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:00 INFO - 'NO_EM_RESTART': '1', 12:17:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:00 INFO - 'PWD': '/builds/slave/test', 12:17:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:00 INFO - 'RUST_BACKTRACE': 'full', 12:17:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:17:00 INFO - 'SHELL': '/bin/bash', 12:17:00 INFO - 'SHLVL': '1', 12:17:00 INFO - 'STYLO_FORCE_DISABLED': '1', 12:17:00 INFO - 'TERM': 'linux', 12:17:00 INFO - 'TMOUT': '86400', 12:17:00 INFO - 'USER': 'cltbld', 12:17:00 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533', 12:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:00 INFO - '_': '/tools/buildbot/bin/python'} 12:17:00 INFO - TEST-INFO | started process 6659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHVzUW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:01 INFO - PID 6659 | 12:17:01 INFO - PID 6659 | (/builds/slave/test/build/application/firefox/firefox:6709): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:17:01 INFO - PID 6659 | 12:17:11 INFO - PID 6659 | RSS: Main: 144445440 12:17:11 INFO - PID 6659 | 12:17:14 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34107/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:15 INFO - PID 6659 | RSS: Main: 151158784 12:17:15 INFO - PID 6659 | 12:17:17 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34107/tests/kraken/driver.html?testName=audio-dft) 12:17:18 INFO - PID 6659 | RSS: Main: 150859776 12:17:18 INFO - PID 6659 | 12:17:21 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34107/tests/kraken/driver.html?testName=audio-fft) 12:17:21 INFO - PID 6659 | RSS: Main: 147406848 12:17:21 INFO - PID 6659 | 12:17:23 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34107/tests/kraken/driver.html?testName=audio-oscillator) 12:17:24 INFO - PID 6659 | RSS: Main: 149000192 12:17:24 INFO - PID 6659 | 12:17:26 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:27 INFO - PID 6659 | RSS: Main: 148586496 12:17:27 INFO - PID 6659 | 12:17:30 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34107/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:30 INFO - PID 6659 | RSS: Main: 148557824 12:17:30 INFO - PID 6659 | 12:17:34 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34107/tests/kraken/driver.html?testName=imaging-desaturate) 12:17:34 INFO - PID 6659 | RSS: Main: 149770240 12:17:34 INFO - PID 6659 | 12:17:37 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34107/tests/kraken/driver.html?testName=json-parse-financial) 12:17:38 INFO - PID 6659 | RSS: Main: 151834624 12:17:38 INFO - PID 6659 | 12:17:39 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:17:40 INFO - PID 6659 | RSS: Main: 151425024 12:17:40 INFO - PID 6659 | 12:17:42 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:17:42 INFO - PID 6659 | RSS: Main: 151302144 12:17:42 INFO - PID 6659 | 12:17:44 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:17:45 INFO - PID 6659 | RSS: Main: 148393984 12:17:45 INFO - PID 6659 | 12:17:47 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:17:48 INFO - PID 6659 | RSS: Main: 148271104 12:17:48 INFO - PID 6659 | 12:17:51 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:17:51 INFO - PID 6659 | RSS: Main: 148877312 12:17:51 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | Cycle 1(1): loaded http://localhost:34107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34107/tests/kraken/driver.html?testName=ai-astar) 12:17:53 INFO - PID 6659 | RSS: Main: 150355968 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | __start_tp_report 12:17:53 INFO - PID 6659 | _x_x_mozilla_page_load 12:17:53 INFO - PID 6659 | _x_x_mozilla_page_load_details 12:17:53 INFO - PID 6659 | |i|pagename|runs| 12:17:53 INFO - PID 6659 | |0;ai-astar;105;106;106;105;105;107;106;107;107;105 12:17:53 INFO - PID 6659 | |1;audio-beat-detection;117;118;112;111;124;113;114;111;115;112 12:17:53 INFO - PID 6659 | |2;audio-dft;162;162;163;161;161;161;162;163;164;171 12:17:53 INFO - PID 6659 | |3;audio-fft;73;74;75;80;74;73;75;74;83;76 12:17:53 INFO - PID 6659 | |4;audio-oscillator;78;78;79;78;78;77;78;77;78;77 12:17:53 INFO - PID 6659 | |5;imaging-gaussian-blur;114;114;114;114;115;110;113;113;113;114 12:17:53 INFO - PID 6659 | |6;imaging-darkroom;149;148;161;149;150;150;148;151;150;149 12:17:53 INFO - PID 6659 | |7;imaging-desaturate;94;97;93;94;94;96;94;96;94;94 12:17:53 INFO - PID 6659 | |8;json-parse-financial;44;45;45;44;44;45;44;44;43;44 12:17:53 INFO - PID 6659 | |9;json-stringify-tinderbox;36;36;36;37;37;36;36;37;37;36 12:17:53 INFO - PID 6659 | |10;stanford-crypto-aes;72;69;70;73;70;70;71;71;73;69 12:17:53 INFO - PID 6659 | |11;stanford-crypto-ccm;102;107;110;108;111;101;107;106;109;104 12:17:53 INFO - PID 6659 | |12;stanford-crypto-pbkdf2;150;155;154;149;157;154;156;155;152;152 12:17:53 INFO - PID 6659 | |13;stanford-crypto-sha256-iterative;66;61;61;59;58;59;65;63;61;61 12:17:53 INFO - PID 6659 | __end_tp_report 12:17:53 INFO - PID 6659 | __start_cc_report 12:17:53 INFO - PID 6659 | _x_x_mozilla_cycle_collect,676 12:17:53 INFO - PID 6659 | __end_cc_report 12:17:53 INFO - PID 6659 | __startTimestamp1506107873633__endTimestamp 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | ------- Summary: start ------- 12:17:53 INFO - PID 6659 | Number of tests: 14 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 12:17:53 INFO - PID 6659 | Values: 105.0 106.0 106.0 105.0 105.0 107.0 106.0 107.0 107.0 105.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#1] audio-beat-detection Cycles:10 Average:114.70 Median:114.50 stddev:4.06 (3.5%) stddev-sans-first:4.22 12:17:53 INFO - PID 6659 | Values: 117.0 118.0 112.0 111.0 124.0 113.0 114.0 111.0 115.0 112.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.98 (1.8%) stddev-sans-first:3.14 12:17:53 INFO - PID 6659 | Values: 162.0 162.0 163.0 161.0 161.0 161.0 162.0 163.0 164.0 171.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#3] audio-fft Cycles:10 Average:75.70 Median:75.00 stddev:3.27 (4.4%) stddev-sans-first:3.32 12:17:53 INFO - PID 6659 | Values: 73.0 74.0 75.0 80.0 74.0 73.0 75.0 74.0 83.0 76.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 12:17:53 INFO - PID 6659 | Values: 78.0 78.0 79.0 78.0 78.0 77.0 78.0 77.0 78.0 77.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.41 12:17:53 INFO - PID 6659 | Values: 114.0 114.0 114.0 114.0 115.0 110.0 113.0 113.0 113.0 114.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:3.81 (2.5%) stddev-sans-first:4.00 12:17:53 INFO - PID 6659 | Values: 149.0 148.0 161.0 149.0 150.0 150.0 148.0 151.0 150.0 149.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 12:17:53 INFO - PID 6659 | Values: 94.0 97.0 93.0 94.0 94.0 96.0 94.0 96.0 94.0 94.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#8] json-parse-financial Cycles:10 Average:44.20 Median:44.00 stddev:0.63 (1.4%) stddev-sans-first:0.67 12:17:53 INFO - PID 6659 | Values: 44.0 45.0 45.0 44.0 44.0 45.0 44.0 44.0 43.0 44.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#9] json-stringify-tinderbox Cycles:10 Average:36.40 Median:36.50 stddev:0.52 (1.4%) stddev-sans-first:0.53 12:17:53 INFO - PID 6659 | Values: 36.0 36.0 36.0 37.0 37.0 36.0 36.0 37.0 37.0 36.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#10] stanford-crypto-aes Cycles:10 Average:70.80 Median:71.00 stddev:1.48 (2.1%) stddev-sans-first:1.50 12:17:53 INFO - PID 6659 | Values: 72.0 69.0 70.0 73.0 70.0 70.0 71.0 71.0 73.0 69.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:107.50 stddev:3.31 (3.1%) stddev-sans-first:3.08 12:17:53 INFO - PID 6659 | Values: 102.0 107.0 110.0 108.0 111.0 101.0 107.0 106.0 109.0 104.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.50 stddev:2.59 (1.7%) stddev-sans-first:2.44 12:17:53 INFO - PID 6659 | Values: 150.0 155.0 154.0 149.0 157.0 154.0 156.0 155.0 152.0 152.0 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:2.59 (4.2%) stddev-sans-first:2.15 12:17:53 INFO - PID 6659 | Values: 66.0 61.0 61.0 59.0 58.0 59.0 65.0 63.0 61.0 61.0 12:17:53 INFO - PID 6659 | -------- Summary: end -------- 12:17:53 INFO - PID 6659 | 12:17:53 INFO - PID 6659 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:17:54 INFO - TEST-INFO | 6659: exit 0 12:17:54 INFO - TEST-OK | kraken | took 59261ms 12:17:54 INFO - SUITE-END | took 1166s 12:17:54 INFO - Completed test suite (00:19:27) 12:17:54 INFO - javascript benchmark 12:17:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9114.319520788977, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3800.581935987042, 3850.4609354690338, 3864.072622570584, 3874.089588946595, 3877.9418308725376, 6133.815985520436, 6157.876842463159, 6174.320824709278, 6189.412005859442, 6202.162708034409, 6263.561550691442, 6265.0, 6267.997120460727, 6292.496600271978, 6304.842378940529, 5549.112142057272, 5642.04085305499, 5650.124230744221, 5662.37713851476, 5680.914786278188, 5676.687782171979, 5689.3172819261745, 5701.002324593201, 5727.627704199234, 5757.136429535562, 839.5811894611331, 5590.161475778625, 5645.266115405012, 5763.39484354143, 5766.711664416784, 5154.561862241714, 5608.775648974036, 5614.803481878114, 5615.382307946164, 5675.404082571312, 5606.411326810708, 5634.323881134249, 5673.914891276634, 5685.118806584986, 5690.857728556778, 6205.410486003822, 6213.627182369027, 6215.471684906788, 6231.781887633911, 6269.153664255313, 6769.4329927705, 6804.455643548505, 6882.380585747307, 6896.999935009396, 6908.7236510539515, 6678.532502724811, 6794.864102717967, 6833.453323734089, 6930.861382772367, 6939.063226464464, 6241.563090583661, 6246.500279977591, 6258.436740693314, 6259.280182778994, 6316.336784637593, 6899.586024838526, 7002.544834585736, 7011.5091943564485, 7012.894806577905, 7014.123234595676, 6631.171103612049, 6640.0703901453835, 6659.267480577133, 6725.562838415487, 6731.562448440835, 6689.76585819494, 6714.664266786641, 6786.558873673195, 6800.65996700163, 6857.245702972669, 6681.465482761368, 6745.02197181406, 6758.5269031167345, 6759.628220447824, 6785.626790526469, 6727.495437842182, 6752.729890804313, 6777.457803375718, 6846.657667116624, 6847.1783385993, 4944.035912996931, 5005.374328208974, 5017.949820501748, 5021.899562008739, 5023.196288593807, 4488.12481566098, 4525.389072475174, 4531.932021019687, 4550.49944506104, 4552.817887284537, 6258.780942666985, 6287.0, 6287.276963149205, 6288.717007734663, 6297.4647154992335, 6595.439387652007, 6618.404343609098, 6632.469402447792, 6710.597364158166, 6713.56361836479, 6193.6903154842075, 6208.565400422018, 6275.497960163176, 6275.937240627627, 6304.0, 5375.19372094189, 5522.2544956431175, 5555.749991250404, 5582.190582365534, 5583.218349431083, 7177.784666460015, 7181.497295189287, 7264.237255088246, 7272.272772722791, 7287.161976372679, 6667.066610674607, 6758.831029224309, 6765.052892594942, 6832.487563432763, 6854.725810967506, 7072.328128827753, 7119.252478489684, 7144.3927266182955, 7148.535345202546, 7151.642417879189, 6664.333566643297, 6673.232578253369, 6683.298253683488, 6734.898976515258, 6764.966175169093, 6677.265500795006, 6678.49911256648, 6750.223724271772, 6760.459163266829, 6761.425278851156, 6458.838529036811, 6461.2892581816905, 6471.546991710535, 6548.8035358939305, 6566.770163044271, 6568.868622627425, 6631.171103612049, 6632.270450250565, 6634.767783127568, 6660.700268488026, 6499.122618446639, 6506.284308726131, 6580.670966451563, 6583.30875258091, 6593.340665933369, 6550.410463058348, 6637.402633762985, 6692.364225398579, 6697.296783837822, 6728.259891412039, 6236.812895613139, 6371.139896113966, 6377.330380310001, 6377.617342959437, 6390.4248617624635], "value": 6162.98949293938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [940.4733349324379, 954.9856752148723, 979.2117345536842, 1006.250343494097, 1016.0398423489801, 45350.54649453505, 46390.53609463913, 46408.0, 46472.767636161814, 46492.0, 42897.78551107248, 43216.78391608038, 43301.566984330144, 43316.350254746205, 43346.56653433465, 7775.533467991924, 7882.487638303521, 7885.8028549286155, 7902.0, 7912.683492660315, 7821.256980586835, 7901.486403383762, 7912.129665736793, 7913.050433947934, 7916.129225785159, 8553.914460855374, 8730.650773969033, 8736.51949142797, 8746.956265218665, 8748.737537873874, 8608.268297194745, 8689.739307820711, 8695.869561956575, 8707.43401678892, 8715.084916083815, 8395.454295470774, 8557.957210213908, 8611.0, 8655.394122411433, 8657.437266577652, 41823.7908810457, 42054.0, 42060.78969605163, 42091.0, 42117.57882421167, 3758.4362345648096, 3798.791066491342, 3809.847606095753, 3813.637704418076, 3821.178446633959, 33715.325693486, 33729.49405758915, 33755.49366759501, 33802.0, 33997.83001085003, 5551.250581171531, 5605.243292155588, 5641.774329026834, 5655.66066036035, 5723.0, 219495.0, 219588.0, 219918.0, 220834.0, 220961.0, 54112.0, 54172.0, 54426.0, 54508.18237726437, 54562.727186363816, 56215.71892140513, 56232.718836405555, 56518.43481565214, 56538.0, 56719.432805671415, 17364.65270694579, 17484.562885927953, 17677.55806104832, 17712.557186070193, 17740.645187096445, 14343.0, 14354.928225358806, 14400.855991440161, 14468.348924298432, 14468.710625787426, 16144.273507692182, 16161.111138887474, 16227.350905963629, 16329.428470003493, 16364.0, 6130.386961303923, 6147.692615369214, 6254.312025677172, 6274.686265686789, 6404.1674582304, 1087.276960821061, 1094.2067001423904, 1100.3562915694408, 1100.9284396514201, 1111.699841042914, 26240.34399140037, 26298.86850565773, 26346.604800928002, 26370.340741481617, 26632.60051099235, 1179.2688533109526, 1201.4653479201672, 1204.9457774400173, 1208.1060015588578, 1228.269179837995, 13614.727705446034, 13752.174869507862, 14023.1586104832, 14133.717325653635, 14140.858591413955, 271656.0, 272795.0, 273563.0, 274128.0, 274934.0, 61329.0, 61380.69309653513, 61458.07812882811, 61691.383086168564, 65754.0, 1479.2603698150924, 1522.8578566075444, 1541.029151634463, 1543.0587341721766, 1547.6053606330538, 31253.218669533442, 31313.530297046018, 31838.681613183573, 32175.51736723904, 32175.67824321727, 41943.58056419519, 42125.0, 42222.15555688807, 42225.78887105545, 42245.577544224165, 247053.0, 247634.0, 248186.0, 248267.0, 249059.0, 35145.47281790827, 36645.0, 37227.0, 37339.0, 37348.81325593355, 46041.76979115083, 47057.76471117623, 47115.0, 47172.292415613105, 48098.0, 34993.82503087468, 35103.0, 35200.47199292064, 35282.470762938065, 35345.0, 35022.12444688903, 35336.46995295021, 35643.46534801928, 35715.82142089273, 35898.0, 41210.38184427296, 41480.37779433371, 41593.168136636494, 41781.58218417777, 42003.57996419997, 34261.0, 34323.485147722306, 34761.304773904885, 34786.82606586951, 34859.82570087133, 26040.218793436226, 26349.077782277527, 26432.603510946967, 26651.733482664924, 26843.0], "value": 19152.454013337257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.4380416702053, 598.6318414175281, 606.8877257707321, 626.2672672972622, 628.1018144054003, 23449.76550234497, 24393.390165245877, 24409.26772196837, 24413.145539906105, 24451.144209952632, 25592.87203563984, 27680.861595692044, 27913.581296280572, 27974.300642483948, 27979.0, 6900.413464855494, 7066.3993560547415, 7086.681099350541, 7089.964550177242, 7090.822729431754, 6548.345165483461, 6751.9662401688165, 6799.42204912583, 6869.072675188861, 6919.757808476705, 6739.460843132562, 6739.764108256212, 6744.089547911043, 6749.392554670078, 6751.8312042199095, 6576.76981305652, 6658.267590565034, 6680.298568650271, 6701.798946031602, 6817.0, 6348.9365106348805, 6351.2060992375955, 6363.204599425072, 6388.456981156607, 6397.296297407282, 30954.845225773726, 31230.0, 31307.0, 31358.52962205569, 31380.21549461259, 2321.2107883319754, 2350.97649023511, 2351.835371523994, 2353.599888019041, 2354.9058037678474, 21386.358409247747, 21476.711397316212, 21816.89091554548, 22038.11847526097, 22087.779122208893, 2591.896324147032, 2634.249238966885, 2680.142354446578, 2692.7307269272915, 2698.0, 141165.0, 146785.0, 155109.0, 157493.21253393774, 160742.99999999884, 16282.67434651324, 16622.667546648998, 16761.7485737714, 16833.41083062087, 16929.746053809202, 26618.733812661627, 26705.732942670325, 26764.0, 26781.866090669813, 26792.392456452675, 11157.330560166416, 11186.664400067848, 11224.551017959353, 11238.494267757971, 11293.265937714023, 10394.48027598617, 10430.113440357654, 10467.528961196764, 10494.895051049545, 10495.47522623881, 9896.505174741234, 10118.544665489924, 10119.166633342677, 10308.793824123626, 10409.219308551888, 2889.622222333125, 2904.3385366486486, 2914.8688309026143, 2935.618369611937, 3112.5486804413235, 997.5062344139552, 1030.90206430389, 1049.968500944973, 1050.4905121016302, 1050.5167622893402, 21936.012879420465, 22311.330660080224, 22639.094436222367, 22640.207592734176, 22949.541009179724, 1083.4311986207147, 1100.3562915694408, 1111.7331840358256, 1113.0650253786857, 1117.3128525956479, 12115.39423028845, 12371.628851134481, 12405.255684658949, 12436.0, 12463.813042804366, 598775.0, 603248.0, 603863.0, 622231.0, 625675.0, 130586.0, 130760.03859942108, 130882.34558827145, 131527.0, 133006.33496832455, 1113.8496302999154, 1204.1089593700774, 1209.1113031921532, 1234.2101055324779, 1254.7929591617462, 23279.18522851692, 23676.0, 23755.40611484727, 23823.285301440985, 23850.52298954046, 62509.68745156245, 62867.6856615714, 63114.368856312685, 63172.36827631665, 65153.348466514726, 79358.6032069836, 79996.60001699954, 80287.59856200915, 80606.0, 81381.59309203416, 15961.0, 16134.67730645404, 16258.0, 16335.67328653444, 16355.754663679816, 24648.507029858945, 24875.502489949737, 25065.87467062653, 25476.108336208887, 25545.489090218463, 20373.18507259693, 20560.177592896118, 20972.37082887516, 21067.789322106582, 21069.15723371048, 17451.3892013784, 17645.20596573183, 18546.44360669182, 18622.813771862107, 18732.06339682983, 21136.260230891847, 21162.365129046153, 21553.461163471038, 21680.34958951234, 21734.130634774432, 15964.441244556385, 16025.278862450985, 16100.436484722979, 16100.55095041452, 16153.515394538183, 18715.344962926232, 18799.248030078645, 20422.897885510476, 20457.079431425325, 20513.38459846207], "value": 13202.531892844108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.6320893358793, 1441.6395901024744, 1444.0324982261884, 1445.7903603977418, 1447.72493226287, 16312.918435407835, 17001.57496062599, 17040.23318950647, 17097.572560685974, 17129.314827406888, 16467.58831029225, 16587.087710175965, 16666.916665416687, 16695.83304166958, 16706.0, 2790.8046436749437, 2870.1676513811076, 2872.1240021793346, 2872.4685933102337, 2875.5111631022673, 2830.122661974784, 2891.147111602072, 2893.9710602894015, 2895.493288674484, 2897.9420411591755, 2892.2913886097936, 2910.927226819336, 2917.3435976905134, 2922.4593450211673, 2922.6200593922867, 2654.522186006518, 2732.4261904999976, 2757.6139340492346, 2769.5984082308055, 2770.7367800059064, 2808.9297767555977, 2839.943201135966, 2842.6020357150014, 2847.1173936079676, 2847.359344147571, 16732.58168545784, 16807.0, 16871.91564042172, 16886.83113168877, 16911.915440422843, 8226.42415030948, 8374.246317831363, 8660.004099528509, 8681.348898832613, 8754.824903501894, 5415.296011518517, 5503.944960550383, 5605.075162598167, 5621.0, 5649.576281778883, 1993.0, 2068.9482762931048, 2113.17586141405, 2127.255460588797, 2147.6563749799957, 30268.394632107236, 30516.237094072603, 30549.69450305513, 30564.54153187704, 30571.388572228654, 6907.171139463196, 7124.821879452951, 7131.144262688511, 7306.0, 7321.231270716605, 19754.11106500211, 19768.20927162926, 19788.307409240606, 19791.0, 19810.306639267557, 8180.386471014698, 8267.131951145164, 8318.45930014547, 8319.8336033279, 8321.542315172723, 7422.888656670154, 7440.218777028443, 7597.924020759721, 7607.049118860143, 7638.961805191049, 5754.165645981393, 5874.559408044328, 5915.881682366415, 5948.0, 6148.8770224595255, 1718.2267979409316, 1739.3129713762992, 1751.527087686343, 1764.7617571627923, 1769.2657547117801, 977.1986970684113, 994.8457989011715, 997.6607953295769, 1020.3265844542566, 1025.1235193909101, 8728.869066964, 8803.559822009001, 8836.0, 8850.64597416109, 8885.733427997171, 796.1202870827768, 799.6401619271351, 807.15652143509, 810.6838333050115, 811.4603788480712, 6084.361142080106, 6212.596181248205, 6297.4332310091395, 6395.424411802867, 6419.1334169887405, 24992.500149996897, 25493.490130197293, 25612.231633051037, 25659.35851603725, 25948.35129121787, 24566.877165614416, 25073.0, 25492.23523294304, 25803.870980644977, 25807.0, 11933.0, 12369.567065152856, 12426.0, 12452.626421207378, 12453.0, 9687.951560242436, 9749.415035097916, 9803.754906127118, 9871.160951319218, 9871.309008369346, 20666.380008599765, 20769.27307544229, 20929.58140837205, 20933.476663083544, 21122.366329010154, 21876.343709688736, 21888.671669924646, 22135.889320553295, 22300.330990070324, 22669.43326416853, 12274.324912129561, 12669.74660506803, 12683.0, 12684.619461416172, 12691.42888570035, 15570.532884013497, 15669.138197399252, 15673.843261567694, 15797.684046319238, 15802.920985395, 11898.821517677068, 11933.462994165457, 12165.0, 12179.573714919936, 12448.128630995743, 11690.123240757148, 11953.282803031845, 12112.75774484523, 12259.69350766238, 12312.445939932546, 10407.68776936693, 10543.841842372523, 10545.36727796304, 10545.841812372973, 10657.57369705203, 8172.959135204286, 8385.664573416994, 8452.450590711584, 8548.230659240699, 8590.441621294596, 8503.447275927045, 8606.569671516525, 8639.740807775777, 8772.0, 8861.0], "value": 7310.839232887542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6347492392484, 573.6816067082768, 579.8869220502003, 587.7678317064763, 593.2436143916506, 6181.258249010114, 6253.749850006, 6275.497960163188, 6333.746650133995, 6349.555531112813, 6113.052476866093, 6140.969295153518, 6173.938260617392, 6187.876242475148, 6233.501319894409, 5136.820211292606, 5136.9469258801855, 5148.150555158413, 5152.768125434346, 5156.613254005946, 4816.783244753977, 5112.130937740593, 5173.810023694534, 5173.844784656466, 5180.222966555009, 4943.30793688882, 4970.179920313162, 4990.3762029746285, 5009.924851127236, 5018.046571151488, 4963.478834722338, 4980.626453016002, 4992.6754760940785, 5007.849764507034, 5010.649254552182, 4385.342198670193, 4531.818727250906, 4542.8864278392975, 4548.295014272793, 4554.726716397026, 6009.909851352233, 6089.238845144357, 6093.922569102575, 6100.145979562864, 6121.602095863799, 5863.736131874033, 5870.236869206976, 5872.559558033122, 5887.882242355172, 5904.76380944766, 6650.966745166292, 6695.832604184886, 6714.227863795629, 6725.159355080615, 6736.528443008991, 5099.4900509949075, 5119.948800511985, 5122.718250496221, 5130.178786530802, 5133.153029750124, 6659.035584502583, 6748.493862960347, 6809.795706128824, 6864.7940561782725, 6884.931150688529, 5166.638335316567, 5187.0, 5215.400228973641, 5228.503292187236, 5231.058409486329, 5285.524302812765, 5291.259223708684, 5299.33758280215, 5301.3373328333955, 5345.9732701337025, 5792.333881603585, 5820.671731307426, 5845.561582881301, 5866.1494083357675, 5874.882502349929, 6615.437687796495, 6620.66896655175, 6631.403173714389, 6689.4982876284475, 6710.66446677674, 1807.3493542324752, 1840.0339821593502, 1841.7881943576392, 1841.990790046068, 1853.5180852978324, 1263.9684007899875, 1300.0964329790893, 1301.3688361144837, 1316.6313432238987, 1322.0613364511305, 6220.533459990519, 6275.0, 6281.528885333527, 6333.651649159248, 6340.587861788969, 6644.235912869985, 6697.564658297195, 6742.921132618855, 6754.257031726506, 6758.560693554903, 6144.723487443076, 6176.35148309421, 6186.536009799283, 6211.596246243979, 6290.238733154724, 3471.2710330830305, 3512.5960514541157, 3514.648535146465, 3523.94714079289, 3540.486629438717, 7063.71745130189, 7114.679839407239, 7118.394936430358, 7155.499115062, 7187.389071928945, 6778.93221067783, 6822.795316140425, 6874.140732408449, 6894.24163342032, 6950.0, 7031.999999999897, 7104.0, 7128.893066604005, 7129.144502659714, 7167.677454514559, 6556.213254409311, 6557.868842623217, 6602.240742314503, 6626.602403855784, 6638.76764313266, 6674.499412544175, 6692.866142677217, 6712.53012289135, 6733.764318248838, 6767.796966091025, 7006.8629068134705, 7074.655815395058, 7078.929210708033, 7104.502684812221, 7113.715451381887, 5175.757818123548, 5197.610179236648, 5217.973910130425, 5219.843404697714, 5225.634205605723, 6498.187726534184, 6589.0775291460195, 6643.30245324234, 6716.462682985251, 6732.0, 6197.318294987638, 6533.346665333429, 6540.411362977355, 6558.606483610999, 6560.40956313934, 6525.706343214471, 6530.706118224786, 6538.869222615426, 6567.31043240472, 6604.900926486011, 6482.54622176462, 6484.1894763154605, 6492.0, 6516.869662606816, 6521.250056243593, 6589.4728421725185, 6596.350912271932, 6628.370304821035, 6632.369924857131, 6656.267810540933, 6431.356864313531, 6432.678366081584, 6443.838904027437, 6457.806265812033, 6484.1894763154605], "value": 5195.2268567995425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [977.6773664690658, 994.8559156969486, 997.3766396002499, 1015.847622856571, 1018.2312354172599, 17062.402815901445, 17270.740938885912, 17556.56108597286, 17560.209790559424, 17629.91185044073, 16953.576160595992, 17141.571460713487, 17141.91429042856, 17586.560335991606, 17597.912010439963, 1000.2495632642893, 1016.6492560066765, 1022.8363461846106, 1027.1064174168484, 1028.059325716972, 1031.020530496028, 1034.2191645307782, 1036.7926414717049, 1037.1339931157493, 1037.7976294622551, 1044.937303761773, 1072.6406653770996, 1083.0469187115327, 1083.3770581915392, 1091.328832767846, 1080.908122809558, 1083.3175099687226, 1083.3554035348955, 1083.512419411264, 1083.7344850511597, 767.1293082351515, 785.2304741353448, 795.5425630262564, 797.0156856282487, 797.3262593108814, 21038.474038149016, 21090.156393744233, 21366.25218117374, 21441.892790536105, 21458.570828583343, 22962.65556016661, 23130.19044333457, 23155.3053408398, 23519.17682881108, 23524.0, 17958.461246162635, 18155.27378904842, 18420.907895460572, 18545.62908741831, 18568.721469177974, 4056.7971601419813, 4088.100617864095, 4089.0390758171807, 4089.20260549193, 4089.9795501022604, 137956.0, 159009.20495397566, 159435.0, 160454.0, 165062.0, 18244.817551824577, 18355.632887342177, 18499.537511562317, 18736.531586710167, 18826.341078062203, 34546.0, 34645.0, 34658.0, 34727.826360868035, 34963.300733985176, 8677.826443471095, 8738.781530461662, 8759.868601970975, 8765.956170219108, 8766.693165739296, 4246.787660616957, 4291.249031419489, 4370.8907277317685, 4390.648748100144, 4406.427164468599, 5661.179129026268, 5769.394213607511, 5778.682172480554, 5784.681842498619, 5803.738831752581, 1064.0689396777818, 1085.9728506787235, 1104.6851647280487, 1105.784372047443, 1111.5831563163813, 729.7810656802938, 751.1136858507015, 751.5565816168378, 770.8843673448915, 772.6252767407802, 12898.548550800677, 12945.870541294655, 13203.867961320457, 13399.53101641438, 13423.26172060546, 724.1201939643358, 737.7086051009821, 742.265157494077, 745.1728581274889, 753.1075675324757, 5959.165716799652, 6137.631742095488, 6144.477719393902, 6172.475339596095, 6243.500519958392, 146907.0, 146970.2651486757, 147814.0, 147893.0, 148309.0, 128727.35636321758, 128955.0, 129783.35108324398, 130026.0, 136576.0, 113724.0, 114581.427092864, 115951.99999999831, 117210.41394792972, 119582.0, 11533.0, 11652.184347095623, 11769.529218831492, 11842.467088980844, 11849.703757406134, 53759.73120134374, 54079.72960135174, 54135.18797218124, 54686.179707305215, 55042.17436738532, 69275.0, 69780.0, 71528.64235678788, 71709.0, 73426.26573734195, 17892.46322610324, 18011.0, 18258.26966921308, 18261.726074108632, 18354.082295884884, 17686.0, 17787.19957601885, 17821.643567128845, 17865.28538858431, 18017.909910450362, 17233.310667573158, 17478.563035924202, 17536.473905782335, 17604.03177825232, 17618.82381176172, 18417.723734144267, 18439.815601844348, 18663.533411664816, 18767.34314298993, 18918.527036823638, 16774.24515896812, 16789.0, 16826.242819072926, 16834.242459089124, 16919.323227070778, 11058.281211721212, 11084.722881928017, 11204.943975280072, 11448.713782155513, 11455.541778329107, 13004.674883127998, 13067.477300907858, 13115.0, 13123.146995445266, 13147.671308216988], "value": 9684.399318633043, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1368.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 106.0, 105.0, 105.0, 107.0, 106.0, 107.0, 107.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 112.0, 111.0, 124.0, 113.0, 114.0, 111.0, 115.0, 112.0], "value": 114.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0, 163.0, 164.0, 171.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 80.0, 74.0, 73.0, 75.0, 74.0, 83.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 78.0, 78.0, 77.0, 78.0, 77.0, 78.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 110.0, 113.0, 113.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 161.0, 149.0, 150.0, 150.0, 148.0, 151.0, 150.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 93.0, 94.0, 94.0, 96.0, 94.0, 96.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 44.0, 44.0, 45.0, 44.0, 44.0, 43.0, 44.0], "value": 44.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 37.0, 37.0, 36.0, 36.0, 37.0, 37.0, 36.0], "value": 36.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 73.0, 70.0, 70.0, 71.0, 71.0, 73.0, 69.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 107.0, 110.0, 108.0, 111.0, 101.0, 107.0, 106.0, 109.0, 104.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 155.0, 154.0, 149.0, 157.0, 154.0, 156.0, 155.0, 152.0, 152.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 61.0, 61.0, 59.0, 58.0, 59.0, 65.0, 63.0, 61.0, 61.0], "value": 61.4, "unit": "score"}]}]} 12:17:54 INFO - Return code: 0 12:17:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:17:54 INFO - # TBPL SUCCESS # 12:17:54 INFO - Running post-action listener: _package_coverage_data 12:17:54 INFO - Running post-action listener: _resource_record_post_action 12:17:54 INFO - [mozharness: 2017-09-22 19:17:54.430310Z] Finished run-tests step (success) 12:17:54 INFO - Running post-run listener: _resource_record_post_run 12:17:54 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 421888; Write bytes: 421658624; Read time: 52; Write time: 292396 12:17:54 INFO - TinderboxPrint: CPU usage
13.1% 12:17:54 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 52 12:17:54 INFO - TinderboxPrint: I/O write bytes / time
421,658,624 / 292,396 12:17:54 INFO - TinderboxPrint: CPU idle
8,212.0 (86.9%) 12:17:54 INFO - TinderboxPrint: CPU user
1,187.9 (12.6%) 12:17:54 INFO - TinderboxPrint: Swap in / out
0 / 0 12:17:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119701504; Read time: 0; Write time: 120016 12:17:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:17:54 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 421888; Write bytes: 301957120; Read time: 52; Write time: 172380 12:17:55 INFO - Running post-run listener: _upload_blobber_files 12:17:55 INFO - Blob upload gear active. 12:17:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:17:55 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 12:17:55 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:17:55 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:17:55 INFO - (blobuploader) - INFO - Open directory for files ... 12:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:56 INFO - (blobuploader) - INFO - Done attempting. 12:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:57 INFO - (blobuploader) - INFO - Done attempting. 12:17:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:17:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:00 INFO - (blobuploader) - INFO - Done attempting. 12:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:01 INFO - (blobuploader) - INFO - Done attempting. 12:18:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:18:01 INFO - Return code: 0 12:18:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:18:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:18:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3434b9266ae150b0da18f869cfd3dc0d2e6649c5592962ba09af84701426d8df5593e4c825e7c790a87daf50145ba9480c401f61d312b0730b3082a2ebc76ccf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de5fa1f704cb9e00370ce2be2bdc99cad35a2d3adff32786c335ec0eb5f09fa08ad8545df0dde286305f4888ce7ffb36d12c010d11cf36b0360a3d1c0daefa5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8df11b465b3d448c5bad8715cfecc6ea6037777f415e78b27476f36c04eeb93ef7c19e98091ff7cd79922116c114d50950123034069865a8e2fc878436a9f3f2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8b12f3157bcd23929bce54d75a50d3b36f2c527c8faf3045ea054ca65075188577881b8f4dfaea59a3de9bfa9246db6e61a3976bcea463eab1c68c9f329337"} 12:18:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:18:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:18:01 INFO - Contents: 12:18:01 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3434b9266ae150b0da18f869cfd3dc0d2e6649c5592962ba09af84701426d8df5593e4c825e7c790a87daf50145ba9480c401f61d312b0730b3082a2ebc76ccf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de5fa1f704cb9e00370ce2be2bdc99cad35a2d3adff32786c335ec0eb5f09fa08ad8545df0dde286305f4888ce7ffb36d12c010d11cf36b0360a3d1c0daefa5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8df11b465b3d448c5bad8715cfecc6ea6037777f415e78b27476f36c04eeb93ef7c19e98091ff7cd79922116c114d50950123034069865a8e2fc878436a9f3f2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8b12f3157bcd23929bce54d75a50d3b36f2c527c8faf3045ea054ca65075188577881b8f4dfaea59a3de9bfa9246db6e61a3976bcea463eab1c68c9f329337"} 12:18:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:18:01 INFO - Copying logs to upload dir... 12:18:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:18:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.676515 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-22 12:18:01.895328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:01.899234) ========= 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=1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533 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/sha512/3434b9266ae150b0da18f869cfd3dc0d2e6649c5592962ba09af84701426d8df5593e4c825e7c790a87daf50145ba9480c401f61d312b0730b3082a2ebc76ccf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de5fa1f704cb9e00370ce2be2bdc99cad35a2d3adff32786c335ec0eb5f09fa08ad8545df0dde286305f4888ce7ffb36d12c010d11cf36b0360a3d1c0daefa5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8df11b465b3d448c5bad8715cfecc6ea6037777f415e78b27476f36c04eeb93ef7c19e98091ff7cd79922116c114d50950123034069865a8e2fc878436a9f3f2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8b12f3157bcd23929bce54d75a50d3b36f2c527c8faf3045ea054ca65075188577881b8f4dfaea59a3de9bfa9246db6e61a3976bcea463eab1c68c9f329337"} build_url:https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/eHaD7yk7Raabj2tPqEg75A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3434b9266ae150b0da18f869cfd3dc0d2e6649c5592962ba09af84701426d8df5593e4c825e7c790a87daf50145ba9480c401f61d312b0730b3082a2ebc76ccf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5de5fa1f704cb9e00370ce2be2bdc99cad35a2d3adff32786c335ec0eb5f09fa08ad8545df0dde286305f4888ce7ffb36d12c010d11cf36b0360a3d1c0daefa5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8df11b465b3d448c5bad8715cfecc6ea6037777f415e78b27476f36c04eeb93ef7c19e98091ff7cd79922116c114d50950123034069865a8e2fc878436a9f3f2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a8b12f3157bcd23929bce54d75a50d3b36f2c527c8faf3045ea054ca65075188577881b8f4dfaea59a3de9bfa9246db6e61a3976bcea463eab1c68c9f329337"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:01.931919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:01.932656) ========= 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=1258088b6da462a47ba2cd90000001a2-1506101509.934973-1603783533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 12:18:02.014228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 12:18:02.014655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 12:18:02.015074) ========= ========= Total master_lag: 0.21 =========